Problem with Timeout-disconnect!

Good day, devs!

We using yours solution for multiplayer.

From yesterday's evening our users have a lot of connection issues. In middle of match both clients disconnects with ClientTimeout reason.

We reseached all out logs on client and we don’t see any problems from our side.

Did you have any problems on yours side?

Our logs from both clients:

First client:
11:59:26:278/Log/ [Photon] RaiseEvent(10, 48) RTT=87, reliable=False.
11:59:26:462/Log/ queueIncomingCommand() CMD(7 ch#/sq#/usq#: 0/59/130 r#/st/tt:0/0/0) channel seq# r/u: 59/129
11:59:26:470/Log/ [Photon] OnEvent(Event 10., 39).
11:59:26:512/Log/ [Photon] Stats: Rtt(variance): 48(18). Since receive: 62ms. Longest send: 2ms. Stats elapsed: 150sec.
Longest delta between Send: 444ms Dispatch: 444ms. Longest callback OnEv: 10=7ms OnResp: 0=4ms. Calls of Send: 17872 Dispatch: 18060.
Ping min/max: 18/200 RRC: 8
11:59:26:914/Log/ Resending: CMD(5 ch#/sq#/usq#: 255/124/0 r#/st/tt:1/150294/160294). times out after: 120 sent: 150294 now: 150428 rtt/var: 48/18 last recv: 464
11:59:27:050/Log/ Resending: CMD(5 ch#/sq#/usq#: 255/124/0 r#/st/tt:2/150429/160294). times out after: 120 sent: 150429 now: 150563 rtt/var: 48/18 last recv: 599
11:59:27:181/Log/ Resending: CMD(5 ch#/sq#/usq#: 255/124/0 r#/st/tt:3/150565/160294). times out after: 120 sent: 150565 now: 150695 rtt/var: 48/18 last recv: 731
11:59:27:283/Log/ [Photon] RaiseEvent(10, 48) RTT=87, reliable=False.
11:59:27:317/Log/ Resending: CMD(5 ch#/sq#/usq#: 255/124/0 r#/st/tt:4/150696/160294). times out after: 120 sent: 150696 now: 150831 rtt/var: 48/18 last recv: 867
11:59:27:567/Log/ Resending: CMD(5 ch#/sq#/usq#: 255/124/0 r#/st/tt:5/150832/160294). times out after: 240 sent: 150832 now: 151081 rtt/var: 48/18 last recv: 1117
11:59:28:052/Log/ Resending: CMD(5 ch#/sq#/usq#: 255/124/0 r#/st/tt:6/151082/160294). times out after: 480 sent: 151082 now: 151566 rtt/var: 48/18 last recv: 1602
11:59:28:284/Log/ [Photon] RaiseEvent(10, 48) RTT=87, reliable=False.
11:59:29:022/Log/ Resending: CMD(5 ch#/sq#/usq#: 255/124/0 r#/st/tt:7/151567/160294). times out after: 960 sent: 151567 now: 152536 rtt/var: 48/18 last recv: 2572
11:59:29:292/Log/ [Photon] RaiseEvent(10, 48) RTT=87, reliable=False.
11:59:30:295/Log/ [Photon] RaiseEvent(10, 48) RTT=87, reliable=False.
11:59:30:951/War/ Timeout-disconnect! Command: CMD(5 ch#/sq#/usq#: 255/124/0 r#/st/tt:8/152536/160294) now: 154465 challenge: 4e7f0d18
11:59:30:955/Log/ SocketUdp.Disconnect()
11:59:30:956/Log/ [Photon] OnLeftRoom().
11:59:30:957/Log/ [Photon] OnDisconnected(ClientTimeout).
11:59:30:958/Log/ [Photon] Info:
AppID: "<<<<DELETED>>>>" AppVersion: "6.0" UserId: 674b7281-0c89-4f6a-a9a2-ba6bb93df36e PeerID: 9560 NameServer: ns.exitgames.com Server: 5.188.170.6:5056 IP: 5.188.170.6:5056 Region: ru/*
11:59:30:969/Log/ started True => False wait False => False inReconnect False => False waitRestart False => False
11:59:31:969/Log/ SocketUdp, .Net, Unity.
11:59:31:970/Log/ IPhotonSocket.Connect() 5.188.170.6:5056 this.Protocol: Udp
11:59:32:228/Log/ Resending: CMD(2 ch#/sq#/usq#: 255/1/0 r#/st/tt:1/14/10014). times out after: 220 sent: 14 now: 251 rtt/var: 200/5 last recv: 5769
11:59:32:454/Log/ Resending: CMD(2 ch#/sq#/usq#: 255/1/0 r#/st/tt:2/261/10014). times out after: 220 sent: 261 now: 485 rtt/var: 200/5 last recv: 6003
11:59:32:688/Log/ Resending: CMD(2 ch#/sq#/usq#: 255/1/0 r#/st/tt:3/487/10014). times out after: 220 sent: 487 now: 719 rtt/var: 200/5 last recv: 6237
11:59:32:920/Log/ Resending: CMD(2 ch#/sq#/usq#: 255/1/0 r#/st/tt:4/721/10014). times out after: 220 sent: 721 now: 952 rtt/var: 200/5 last recv: 6470
11:59:33:373/Log/ Resending: CMD(2 ch#/sq#/usq#: 255/1/0 r#/st/tt:5/953/10014). times out after: 440 sent: 953 now: 1405 rtt/var: 200/5 last recv: 6923
11:59:34:261/Log/ Resending: CMD(2 ch#/sq#/usq#: 255/1/0 r#/st/tt:6/1406/10014). times out after: 880 sent: 1406 now: 2293 rtt/var: 200/5 last recv: 7811
11:59:36:039/Log/ Resending: CMD(2 ch#/sq#/usq#: 255/1/0 r#/st/tt:7/2294/10014). times out after: 1760 sent: 2294 now: 4070 rtt/var: 200/5 last recv: 9588
11:59:39:567/War/ Timeout-disconnect! Command: CMD(2 ch#/sq#/usq#: 255/1/0 r#/st/tt:8/4072/10014) now: 7599 challenge: 129f744
11:59:39:583/Log/ SocketUdp.Disconnect()
11:59:39:584/Log/ [Photon] OnDisconnected(ClientTimeout).
11:59:39:586/Log/ [Photon] Info:
AppID: "<<<<DELETED>>>>" AppVersion: "6.0" UserId: 674b7281-0c89-4f6a-a9a2-ba6bb93df36e PeerID: 65535 NameServer: ns.exitgames.com Server: 5.188.170.6:5056 IP: 5.188.170.6:5056 Region: ru/*
11:59:40:588/Log/ SocketUdp, .Net, Unity.
11:59:40:589/Log/ IPhotonSocket.Connect() 5.188.170.6:5056 this.Protocol: Udp
11:59:40:686/Log/ queueIncomingCommand() CMD(6 ch#/sq#/usq#: 0/1/0 r#/st/tt:0/0/0) channel seq# r/u: 0/0
11:59:40:688/Log/ Connected to gameserver.
11:59:40:755/Log/ queueIncomingCommand() CMD(6 ch#/sq#/usq#: 0/2/0 r#/st/tt:0/0/0) channel seq# r/u: 1/0
11:59:40:760/Log/ OpAuthenticate()
11:59:40:788/Log/ queueIncomingCommand() CMD(6 ch#/sq#/usq#: 0/3/0 r#/st/tt:0/0/0) channel seq# r/u: 2/0
11:59:40:789/Log/ OpJoinRoom()
11:59:40:823/Log/ queueIncomingCommand() CMD(6 ch#/sq#/usq#: 0/4/0 r#/st/tt:0/0/0) channel seq# r/u: 3/0
11:59:40:825/Log/ SocketUdp.Disconnect()
11:59:40:827/Log/ SocketUdp, .Net, Unity.
11:59:40:828/Log/ IPhotonSocket.Connect() 5.188.170.5:5055 this.Protocol: Udp
11:59:40:972/Log/ queueIncomingCommand() CMD(6 ch#/sq#/usq#: 0/1/0 r#/st/tt:0/0/0) channel seq# r/u: 0/0
11:59:40:973/Log/ Connected to masterserver.
11:59:40:974/Log/ [Photon] OnConnected().
11:59:40:975/Log/ [Photon] Info:
AppID: "<<<<DELETED>>>>" AppVersion: "6.0" UserId: 674b7281-0c89-4f6a-a9a2-ba6bb93df36e PeerID: 49554 NameServer: ns.exitgames.com Server: 5.188.170.5:5055 IP: 5.188.170.5:5055 Region: ru/*
11:59:40:987/Log/ [Photon] Stats: Rtt(variance): 28(50). Since receive: 18ms. Longest send: 2ms. Stats elapsed: 0sec.
Longest delta between Send: 26ms Dispatch: 21ms. Longest callback OnEv: 0=0ms OnResp: 0=0ms. Calls of Send: 10 Dispatch: 10.
Ping min/max: 28/28 RRC: 0
11:59:41:004/Log/ queueIncomingCommand() CMD(6 ch#/sq#/usq#: 0/2/0 r#/st/tt:0/0/0) channel seq# r/u: 1/0
11:59:41:010/Log/ OpAuthenticate()
11:59:41:039/Log/ queueIncomingCommand() CMD(7 ch#/sq#/usq#: 0/2/1 r#/st/tt:0/0/0) channel seq# r/u: 2/0
11:59:41:040/Log/ queueIncomingCommand() CMD(6 ch#/sq#/usq#: 0/3/0 r#/st/tt:0/0/0) channel seq# r/u: 2/0
11:59:41:042/Log/ [Photon] OnEvent(Event 226., ).
11:59:41:043/Log/ [Photon] OnJoinRoomFailed(32758,Game does not exist).
11:59:41:045/Log/ [Photon] Release

Second client:


11:59:24:227/Log/ [Photon] RaiseEvent(10, 39) RTT=88, reliable=False.
11:59:24:245/Log/ queueIncomingCommand() CMD(7 ch#/sq#/usq#: 0/60/130 r#/st/tt:0/0/0) channel seq# r/u: 60/129
11:59:24:246/Log/ [Photon] OnEvent(Event 10., 49).
11:59:25:095/Log/ [Photon] Stats: Rtt(variance): 39(7). Since receive: 444ms. Longest send: 1ms. Stats elapsed: 150sec.
Longest delta between Send: 777ms Dispatch: 777ms. Longest callback OnEv: 10=10ms OnResp: 0=8ms. Calls of Send: 17833 Dispatch: 18021.
Ping min/max: 21/200 RRC: 6
11:59:25:244/Log/ [Photon] RaiseEvent(10, 39) RTT=88, reliable=False.
11:59:25:263/Log/ queueIncomingCommand() CMD(7 ch#/sq#/usq#: 0/60/131 r#/st/tt:0/0/0) channel seq# r/u: 60/130
11:59:25:264/Log/ [Photon] OnEvent(Event 10., 48).
11:59:25:743/Log/ Resending: CMD(5 ch#/sq#/usq#: 255/127/0 r#/st/tt:1/150569/160569). times out after: 67 sent: 150569 now: 150654 rtt/var: 39/7 last recv: 480
11:59:25:825/Log/ Resending: CMD(5 ch#/sq#/usq#: 255/127/0 r#/st/tt:2/150656/160569). times out after: 67 sent: 150656 now: 150737 rtt/var: 39/7 last recv: 563
11:59:25:906/Log/ Resending: CMD(5 ch#/sq#/usq#: 255/127/0 r#/st/tt:3/150738/160569). times out after: 67 sent: 150738 now: 150818 rtt/var: 39/7 last recv: 644
11:59:25:990/Log/ Resending: CMD(5 ch#/sq#/usq#: 255/127/0 r#/st/tt:4/150819/160569). times out after: 67 sent: 150819 now: 150902 rtt/var: 39/7 last recv: 728
11:59:26:141/Log/ Resending: CMD(5 ch#/sq#/usq#: 255/127/0 r#/st/tt:5/150903/160569). times out after: 134 sent: 150903 now: 151053 rtt/var: 39/7 last recv: 879
11:59:26:256/Log/ [Photon] RaiseEvent(10, 39) RTT=87, reliable=False.
11:59:26:422/Log/ Resending: CMD(5 ch#/sq#/usq#: 255/127/0 r#/st/tt:6/151054/160569). times out after: 268 sent: 151054 now: 151334 rtt/var: 39/7 last recv: 1160
11:59:26:971/Log/ Resending: CMD(5 ch#/sq#/usq#: 255/127/0 r#/st/tt:7/151336/160569). times out after: 536 sent: 151336 now: 151883 rtt/var: 39/7 last recv: 1709
11:59:27:270/Log/ [Photon] RaiseEvent(10, 39) RTT=87, reliable=False.
11:59:28:052/War/ Timeout-disconnect! Command: CMD(5 ch#/sq#/usq#: 255/127/0 r#/st/tt:8/151884/160569) now: 152964 challenge: 3e5cddd5
11:59:28:057/Log/ SocketUdp.Disconnect()
11:59:28:059/Log/ [Photon] OnLeftRoom().
11:59:28:060/Log/ [Photon] OnDisconnected(ClientTimeout).
11:59:28:062/Log/ [Photon] Info:
AppID: "<<<<DELETED>>>>" AppVersion: "6.0" UserId: 03c90581-7880-4e25-b8b3-6cc2bd38a156 PeerID: 9551 NameServer: ns.exitgames.com Server: 5.188.170.6:5056 IP: 5.188.170.6:5056 Region: ru/*
11:59:28:079/Log/ started True => False wait False => False inReconnect False => False waitRestart False => False
11:59:29:069/Log/ SocketUdp, .Net, Unity.
11:59:29:071/Log/ IPhotonSocket.Connect() 5.188.170.6:5056 this.Protocol: Udp
11:59:29:322/Log/ Resending: CMD(2 ch#/sq#/usq#: 255/1/0 r#/st/tt:1/18/10018). times out after: 220 sent: 18 now: 249 rtt/var: 200/5 last recv: 4054
11:59:29:550/Log/ Resending: CMD(2 ch#/sq#/usq#: 255/1/0 r#/st/tt:2/256/10018). times out after: 220 sent: 256 now: 483 rtt/var: 200/5 last recv: 4288
11:59:29:789/Log/ Resending: CMD(2 ch#/sq#/usq#: 255/1/0 r#/st/tt:3/485/10018). times out after: 220 sent: 485 now: 715 rtt/var: 200/5 last recv: 4520
11:59:30:016/Log/ Resending: CMD(2 ch#/sq#/usq#: 255/1/0 r#/st/tt:4/723/10018). times out after: 220 sent: 723 now: 948 rtt/var: 200/5 last recv: 4753
11:59:30:470/Log/ Resending: CMD(2 ch#/sq#/usq#: 255/1/0 r#/st/tt:5/950/10018). times out after: 440 sent: 950 now: 1397 rtt/var: 200/5 last recv: 5202
11:59:31:363/Log/ Resending: CMD(2 ch#/sq#/usq#: 255/1/0 r#/st/tt:6/1404/10018). times out after: 880 sent: 1404 now: 2295 rtt/var: 200/5 last recv: 6100
11:59:33:140/Log/ Resending: CMD(2 ch#/sq#/usq#: 255/1/0 r#/st/tt:7/2297/10018). times out after: 1760 sent: 2297 now: 4073 rtt/var: 200/5 last recv: 7878
11:59:36:666/War/ Timeout-disconnect! Command: CMD(2 ch#/sq#/usq#: 255/1/0 r#/st/tt:8/4074/10018) now: 7599 challenge: 13310c28
11:59:36:684/Log/ SocketUdp.Disconnect()
11:59:36:686/Log/ [Photon] OnDisconnected(ClientTimeout).
11:59:36:688/Log/ [Photon] Info:
AppID: "<<<<DELETED>>>>" AppVersion: "6.0" UserId: 03c90581-7880-4e25-b8b3-6cc2bd38a156 PeerID: 65535 NameServer: ns.exitgames.com Server: 5.188.170.6:5056 IP: 5.188.170.6:5056 Region: ru/*
11:59:37:696/Log/ SocketUdp, .Net, Unity.
11:59:37:698/Log/ IPhotonSocket.Connect() 5.188.170.6:5056 this.Protocol: Udp
11:59:37:945/Log/ Resending: CMD(2 ch#/sq#/usq#: 255/1/0 r#/st/tt:1/16/10016). times out after: 220 sent: 16 now: 250 rtt/var: 200/5 last recv: 12683
11:59:38:180/Log/ Resending: CMD(2 ch#/sq#/usq#: 255/1/0 r#/st/tt:2/252/10016). times out after: 220 sent: 252 now: 485 rtt/var: 200/5 last recv: 12918
11:59:38:412/Log/ Resending: CMD(2 ch#/sq#/usq#: 255/1/0 r#/st/tt:3/487/10016). times out after: 220 sent: 487 now: 716 rtt/var: 200/5 last recv: 13149
11:59:38:647/Log/ queueIncomingCommand() CMD(6 ch#/sq#/usq#: 0/1/0 r#/st/tt:0/0/0) channel seq# r/u: 0/0
11:59:38:657/Log/ Connected to gameserver.
11:59:38:727/Log/ queueIncomingCommand() CMD(6 ch#/sq#/usq#: 0/2/0 r#/st/tt:0/0/0) channel seq# r/u: 1/0
11:59:38:738/Log/ OpAuthenticate()
11:59:39:115/Log/ queueIncomingCommand() CMD(6 ch#/sq#/usq#: 0/3/0 r#/st/tt:0/0/0) channel seq# r/u: 2/0
11:59:39:117/Log/ OpJoinRoom()
11:59:39:526/Log/ queueIncomingCommand() CMD(6 ch#/sq#/usq#: 0/4/0 r#/st/tt:0/0/0) channel seq# r/u: 3/0
11:59:39:531/Log/ SocketUdp.Disconnect()
11:59:39:534/Log/ SocketUdp, .Net, Unity.
11:59:39:536/Log/ IPhotonSocket.Connect() 5.188.170.5:5055 this.Protocol: Udp
11:59:39:624/Log/ queueIncomingCommand() CMD(6 ch#/sq#/usq#: 0/1/0 r#/st/tt:0/0/0) channel seq# r/u: 0/0
11:59:39:627/Log/ Connected to masterserver.
11:59:39:629/Log/ [Photon] OnConnected().
11:59:39:631/Log/ [Photon] Info:
AppID: "<<<<DELETED>>>>" AppVersion: "6.0" UserId: 03c90581-7880-4e25-b8b3-6cc2bd38a156 PeerID: 49129 NameServer: ns.exitgames.com Server: 5.188.170.5:5055 IP: 5.188.170.5:5055 Region: ru/*
11:59:39:656/Log/ [Photon] Stats: Rtt(variance): 18(33). Since receive: 43ms. Longest send: 1ms. Stats elapsed: 0sec.
Longest delta between Send: 50ms Dispatch: 31ms. Longest callback OnEv: 0=0ms OnResp: 0=0ms. Calls of Send: 5 Dispatch: 5.
Ping min/max: 18/18 RRC: 0
11:59:39:686/Log/ queueIncomingCommand() CMD(6 ch#/sq#/usq#: 0/2/0 r#/st/tt:0/0/0) channel seq# r/u: 1/0
11:59:39:695/Log/ OpAuthenticate()
11:59:39:757/Log/ queueIncomingCommand() CMD(7 ch#/sq#/usq#: 0/2/1 r#/st/tt:0/0/0) channel seq# r/u: 2/0
11:59:39:758/Log/ queueIncomingCommand() CMD(6 ch#/sq#/usq#: 0/3/0 r#/st/tt:0/0/0) channel seq# r/u: 2/0
11:59:39:759/Log/ [Photon] OnEvent(Event 226., ).
11:59:39:761/Log/ [Photon] OnJoinRoomFailed(32758,Game does not exist).
11:59:39:765/Log/ [Photon] Release

PS:
I'm creating a discussion for the second time, first one, apparently, was accidentally deleted. I can't find it.

Comments

  • cNoNim
    cNoNim
    edited July 24
    Can someone help?
    We looked at the statistics and the issue is on the RU server
    Maybe I was wrong with the section?