Connection Problems/Potential Proxy Server Issues?

[BRNKoINSANITY]

I have been having a very specific connection problem, which I believe I share with a few other people. Going to post things I have observed and know, logs follow.

When I am playing a game, on occasion (sometimes 2-3 games in a row, sometimes a week or two with no problem) I will suddenly disconnect to between 2 and 5 people. It is an instantaneous disconnect to all at the same time, with no chance of ever reconnecting to any of them. There is no warning, no lag, no dropped packets showing in NetStats, just the abrupt disconnect.

- This never happens in ladder games, to my knowledge has only happened in 4v4 or greater. I can not remember the last time I disconnected from a ladder game.
- I don't think I have ever had this disconnect with anyone in North America, since I have started checking, it seems to only be an issue with European players.
- I have triple checked that my ports are forwarded, my modem is fine with zero stability problems, tested multiple times, and my firewall is properly set up to allow for FAF
- I did not have this problem before the server change. It happened pretty frequently after the server change, then stopped or occured so rarely for a few months that I didn't care about it, and in the last month has haunted me in a lot of games.
- I have a very good internet connection that is extremely stable. I don't think it is my connection.

My theory is that the proxy server is dumping my connection periodically, and anyone I am connected to throught the proxy just instantly drops, never to reconnect. Someone PLEASE help me with this, it is killing my ability to stream or play FAF!

game.log

Spoiler: show

info: Popup.OnClosed
info: Error popping escape handler, stack is empty
info: "stack traceback:\
info: ...rever\\gamedata\\lua.nx2\\lua\\ui\\dialogs\\eschandler.lua(48): in function `PopEscapeHandler'\
info: ...er\\gamedata\\lua.nx2\\lua\\ui\\controls\\popups\\popup.lua(80): in function `OnClosed'\
info: ...er\\gamedata\\lua.nx2\\lua\\ui\\controls\\popups\\popup.lua(63): in function `Close'\
info: ...ramdata\\faforever\\gamedata\\lua.nx2\\lua\\ui\\uiutil.lua(860): in function `OnClick'\
info: ...mdata\\faforever\\gamedata\\lua.nx2\\lua\\maui\\button.lua(85): in function <...mdata\\faforever\\gamedata\\lua.nx2\\lua\\maui\\button.lua:78>"
info: GPGNET: setting nat handler to 0x00000000
info: CNetTCPBuf::Read(): recv() failed: WSAEINTR
info: Run time: 0h21m50s

forever.log

Spoiler: show

2016-07-08 17:25:52,302 INFO fa.game_session.GameSession Outgoing relay message Bottleneck [u'ack', u'9029', u'173482', u'10727.5']
2016-07-08 17:25:52,303 INFO client._clientwindow Outgoing JSON Message: {"args": ["ack", "9029", "173482", "10727.5"], "command": "Bottleneck", "target": "game"}
2016-07-08 17:25:57,625 INFO fa.game_connection.GPGNetConnection GC >> : Bottleneck : [u'ack', u'9029', u'173482', u'16050.9']
2016-07-08 17:25:57,625 INFO fa.game_session.GameSession Incoming GPGNet: Bottleneck [u'ack', u'9029', u'173482', u'16050.9']
2016-07-08 17:25:57,625 INFO fa.game_session.GameSession Outgoing relay message Bottleneck [u'ack', u'9029', u'173482', u'16050.9']
2016-07-08 17:25:57,625 INFO client._clientwindow Outgoing JSON Message: {"args": ["ack", "9029", "173482", "16050.9"], "command": "Bottleneck", "target": "game"}
2016-07-08 17:26:03,022 INFO fa.game_connection.GPGNetConnection GC >> : Bottleneck : [u'ack', u'9029', u'173482', u'21446.6']
2016-07-08 17:26:03,022 INFO fa.game_session.GameSession Incoming GPGNet: Bottleneck [u'ack', u'9029', u'173482', u'21446.6']
2016-07-08 17:26:03,022 INFO fa.game_session.GameSession Outgoing relay message Bottleneck [u'ack', u'9029', u'173482', u'21446.6']
2016-07-08 17:26:03,022 INFO client._clientwindow Outgoing JSON Message: {"args": ["ack", "9029", "173482", "21446.6"], "command": "Bottleneck", "target": "game"}
2016-07-08 17:26:08,266 INFO fa.game_connection.GPGNetConnection GC >> : Bottleneck : [u'ack', u'9029', u'173482', u'26687.4']
2016-07-08 17:26:08,266 INFO fa.game_session.GameSession Incoming GPGNet: Bottleneck [u'ack', u'9029', u'173482', u'26687.4']
2016-07-08 17:26:08,266 INFO fa.game_session.GameSession Outgoing relay message Bottleneck [u'ack', u'9029', u'173482', u'26687.4']
2016-07-08 17:26:08,266 INFO client._clientwindow Outgoing JSON Message: {"args": ["ack", "9029", "173482", "26687.4"], "command": "Bottleneck", "target": "game"}
2016-07-08 17:26:14,201 INFO fa.game_connection.GPGNetConnection GC >> : Bottleneck : [u'ack', u'9029', u'173482', u'32626.4']
2016-07-08 17:26:14,201 INFO fa.game_session.GameSession Incoming GPGNet: Bottleneck [u'ack', u'9029', u'173482', u'32626.4']
2016-07-08 17:26:14,201 INFO fa.game_session.GameSession Outgoing relay message Bottleneck [u'ack', u'9029', u'173482', u'32626.4']
2016-07-08 17:26:14,201 INFO client._clientwindow Outgoing JSON Message: {"args": ["ack", "9029", "173482", "32626.4"], "command": "Bottleneck", "target": "game"}
2016-07-08 17:26:20,117 INFO fa.game_connection.GPGNetConnection GC >> : Bottleneck : [u'ack', u'9029', u'173482', u'38541.4']
2016-07-08 17:26:20,117 INFO fa.game_session.GameSession Incoming GPGNet: Bottleneck [u'ack', u'9029', u'173482', u'38541.4']
2016-07-08 17:26:20,117 INFO fa.game_session.GameSession Outgoing relay message Bottleneck [u'ack', u'9029', u'173482', u'38541.4']
2016-07-08 17:26:20,117 INFO client._clientwindow Outgoing JSON Message: {"args": ["ack", "9029", "173482", "38541.4"], "command": "Bottleneck", "target": "game"}
2016-07-08 17:26:23,242 INFO fa.game_connection.GPGNetConnection GC >> : BottleneckCleared : []
2016-07-08 17:26:23,242 INFO fa.game_session.GameSession Incoming GPGNet: BottleneckCleared []
2016-07-08 17:26:23,242 INFO fa.game_session.GameSession Outgoing relay message BottleneckCleared []
2016-07-08 17:26:23,242 INFO client._clientwindow Outgoing JSON Message: {"args": [], "command": "BottleneckCleared", "target": "game"}
2016-07-08 17:26:24,589 INFO fa.replayserver FA disconnected locally.
2016-07-08 17:26:24,589 INFO fa.replayserver Found Complete Replay Info
2016-07-08 17:26:24,589 INFO fa.replayserver Writing local replay as C:\ProgramData\FAForever\replays\4918478-BRNKoINSANITY.fafreplay, containing 937905 bytes of replay data.
2016-07-08 17:26:24,618 INFO fa.replayserver closing replay file
2016-07-08 17:26:24,940 INFO client._clientwindow FA has finished with exit code: 0
2016-07-08 17:26:24,940 INFO fa.game_session.GameSession Game has exited with status code: 0
2016-07-08 17:26:24,940 INFO fa.game_session.GameSession Outgoing relay message GameState ['Ended']
2016-07-08 17:26:24,940 INFO client._clientwindow Outgoing JSON Message: {"args": ["Ended"], "command": "GameState", "target": "game"}
2016-07-08 17:34:08,880 INFO faf.secondaryServer.Tournament Pending requests: 3
2016-07-08 17:34:08,880 INFO faf.secondaryServer.Tournament Connecting to Tournament
2016-07-08 17:38:24,888 ERROR fa.maps Web preview download failed for scca_coop_e01.v0008

For some reason, a second log with the same time stamp, throwing it in as well.

Spoiler: show

2016-07-08 17:04:19,994 INFO connectivity.helper.ConnectivityHelper Connectivity state is STUN, mapped address: 66.190.145.54:64934
2016-07-08 17:04:32,874 INFO fa.check Checking FA for: faf and map duel gap 5v5.v0014
2016-07-08 17:04:32,874 INFO fa.check Version unknown, assuming latest
2016-07-08 17:04:32,874 INFO fa.check Updating FA for mod: faf, version None
2016-07-08 17:04:32,874 INFO fa.check Writing fa_path.lua config file.
2016-07-08 17:04:34,026 INFO fa.check Updating FA for map: duel gap 5v5.v0014
2016-07-08 17:04:34,026 INFO fa.check Map is available.
2016-07-08 17:04:34,026 INFO connectivity.turn Requesting relay allocation
2016-07-08 17:04:34,142 INFO connectivity.turn Relay allocated: ('37.58.123.3', 56887L)
2016-07-08 17:04:34,142 INFO connectivity.qturnsocket.QTurnSocket TURN state changed: TURNState.BOUND
2016-07-08 17:04:34,142 INFO client._clientwindow Outgoing JSON Message: {"relay_address": ["37.58.123.3", 56887], "command": "game_join", "uid": 4918478, "gameport": 6112}
2016-07-08 17:04:34,144 INFO connectivity.turn Permitting sends from ('66.190.145.54', 64934L)
2016-07-08 17:04:34,144 INFO connectivity.turn Permitting sends from ('37.58.123.2', 6112)
2016-07-08 17:04:34,144 INFO connectivity.turn Permitting sends from ('37.58.123.3', 6112)
2016-07-08 17:04:34,403 INFO client._clientwindow Handling game_launch via JSON {u'args': [u'/numgames 2509'], u'command': u'game_launch', u'uid': 4918478, u'mod': u'faf'}
2016-07-08 17:04:34,403 INFO fa.play Play received arguments: ['/mean', '1526.64', '/deviation', '62.132', '/country ', u'US', '/clan', u'VoR']
2016-07-08 17:04:34,403 INFO fa.game_process Running FA with info: {'recorder': u'BRNKoINSANITY', 'featured_mod': u'faf', 'uid': 4918478, 'launched_at': 1468011874.403}
2016-07-08 17:04:34,403 INFO fa.game_process Running FA via command: "C:\ProgramData\FAForever\bin\ForgedAlliance.exe" /mean 1526.64 /deviation 62.132 /country US /clan VoR /init init_faf.lua /numgames 2509 /log "C:\ProgramData\FAForever\logs\game.log" /nobugreport /savereplay "gpgnet://localhost/4918478/BRNKoINSANITY.SCFAreplay" /gpgnet 127.0.0.1:55120
2016-07-08 17:04:34,403 INFO fa.game_process Running FA via executable: C:\ProgramData\FAForever\bin\ForgedAlliance.exe
2016-07-08 17:04:34,427 INFO client._clientwindow FA has launched in an attached process.
2016-07-08 17:04:34,427 INFO fa.game_session.GameSession Game has started
2016-07-08 17:04:39,282 INFO fa.game_session.GameSession Game connected through GPGNet
2016-07-08 17:04:39,286 INFO fa.game_connection.GPGNetConnection GC >> : GameState : [u'Idle']
2016-07-08 17:04:39,286 INFO fa.game_session.GameSession Incoming GPGNet: GameState [u'Idle']
2016-07-08 17:04:39,286 INFO fa.game_connection.GPGNetConnection GC<<: CreateLobby:(0, 6113, u'BRNKoINSANITY', 30361, 1)
2016-07-08 17:04:39,286 INFO fa.game_session.GameSession Outgoing relay message GameState [u'Idle']
2016-07-08 17:04:39,286 INFO client._clientwindow Outgoing JSON Message: {"args": ["Idle"], "command": "GameState", "target": "game"}
2016-07-08 17:04:39,453 INFO fa.game_connection.GPGNetConnection GC >> : GameState : [u'Lobby']
2016-07-08 17:04:39,453 INFO fa.game_session.GameSession Incoming GPGNet: GameState [u'Lobby']
2016-07-08 17:04:39,454 INFO fa.game_session.GameSession Outgoing relay message GameState [u'Lobby']
2016-07-08 17:04:39,454 INFO client._clientwindow Outgoing JSON Message: {"args": ["Lobby"], "command": "GameState", "target": "game"}
2016-07-08 17:04:39,867 INFO client._clientwindow Outgoing JSON Message: {"args": ["109.252.67.124:24527", "Hello from 139480"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:39,868 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:39,868 INFO client._clientwindow Outgoing JSON Message: {"args": ["109.252.67.124:24527", "Hello from 139480"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:39,868 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:39,868 INFO client._clientwindow Outgoing JSON Message: {"args": ["109.252.67.124:24527", "Hello from 139480"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:39,868 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,022 INFO connectivity.relay.Relay Allocating local relay for Swastika, 139480
2016-07-08 17:04:40,023 INFO fa.game_session.GameSession Bound peer Swastika/139480 to 58173
2016-07-08 17:04:40,023 INFO fa.game_connection.GPGNetConnection GC<<: JoinGame:('127.0.0.1:58173', u'Swastika', 139480)
2016-07-08 17:04:40,052 INFO client._clientwindow Outgoing JSON Message: {"args": ["86.146.41.230:55400", "Hello from 63338"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,052 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,056 INFO client._clientwindow Outgoing JSON Message: {"args": ["91.190.10.246:61154", "Hello from 39737"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,056 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,056 INFO client._clientwindow Outgoing JSON Message: {"args": ["91.51.63.58:49272", "Hello from 173482"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,056 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,072 INFO client._clientwindow Outgoing JSON Message: {"args": ["84.202.224.240:61873", "Hello from 28041"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,072 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,092 INFO client._clientwindow Outgoing JSON Message: {"args": ["41.107.189.78:6288", "Hello from 177975"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,092 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,131 INFO client._clientwindow Outgoing JSON Message: {"args": ["86.146.41.230:55400", "Hello from 63338"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,131 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,131 INFO client._clientwindow Outgoing JSON Message: {"args": ["86.146.41.230:55400", "Hello from 63338"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,131 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,131 INFO client._clientwindow Outgoing JSON Message: {"args": ["91.190.10.246:61154", "Hello from 39737"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,131 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,137 INFO client._clientwindow Outgoing JSON Message: {"args": ["91.190.10.246:61154", "Hello from 39737"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,137 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,153 INFO client._clientwindow Outgoing JSON Message: {"args": ["84.202.224.240:61873", "Hello from 28041"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,153 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,153 INFO client._clientwindow Outgoing JSON Message: {"args": ["84.202.224.240:61873", "Hello from 28041"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,153 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,164 INFO client._clientwindow Outgoing JSON Message: {"args": ["216.104.102.154:6112", "Hello from 1304"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,165 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,165 INFO client._clientwindow Outgoing JSON Message: {"args": ["216.104.102.154:6112", "Hello from 1304"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,165 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,165 INFO client._clientwindow Outgoing JSON Message: {"args": ["216.104.102.154:6112", "Hello from 1304"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,165 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,178 INFO client._clientwindow Outgoing JSON Message: {"args": ["86.146.41.230:55400", "Hello from 63338"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,178 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,187 INFO connectivity.relay.Relay Allocating local relay for m_wylie85, 63338
2016-07-08 17:04:40,187 INFO fa.game_session.GameSession Bound peer m_wylie85/63338 to 58174
2016-07-08 17:04:40,187 INFO fa.game_connection.GPGNetConnection GC<<: ConnectToPeer:('127.0.0.1:58174', u'm_wylie85', 63338)
2016-07-08 17:04:40,201 INFO client._clientwindow Outgoing JSON Message: {"args": ["91.190.10.246:61154", "Hello from 39737"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,201 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,204 INFO fa.game_connection.GPGNetConnection GC >> : Disconnected : [u'63338']
2016-07-08 17:04:40,204 INFO fa.game_session.GameSession Incoming GPGNet: Disconnected [u'63338']
2016-07-08 17:04:40,204 INFO fa.game_session.GameSession Outgoing relay message Disconnected [u'63338']
2016-07-08 17:04:40,204 INFO client._clientwindow Outgoing JSON Message: {"args": ["63338"], "command": "Disconnected", "target": "game"}
2016-07-08 17:04:40,206 INFO client._clientwindow Outgoing JSON Message: {"args": ["91.51.63.58:49272", "Hello from 173482"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,206 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,206 INFO client._clientwindow Outgoing JSON Message: {"args": ["91.51.63.58:49272", "Hello from 173482"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,206 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,234 INFO client._clientwindow Outgoing JSON Message: {"args": ["84.202.224.240:61873", "Hello from 28041"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,236 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,255 INFO client._clientwindow Outgoing JSON Message: {"args": ["86.146.41.230:55400", "Hello from 63338"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,255 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,255 INFO client._clientwindow Outgoing JSON Message: {"args": ["86.146.41.230:55400", "Hello from 63338"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,255 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,263 INFO client._clientwindow Outgoing JSON Message: {"args": ["68.103.227.162:6112", "Hello from 1193"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,263 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,263 INFO client._clientwindow Outgoing JSON Message: {"args": ["68.103.227.162:6112", "Hello from 1193"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,263 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,263 INFO client._clientwindow Outgoing JSON Message: {"args": ["68.103.227.162:6112", "Hello from 1193"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,263 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,273 INFO client._clientwindow Outgoing JSON Message: {"args": ["216.104.102.154:6112", "Hello from 1304"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,273 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,273 INFO client._clientwindow Outgoing JSON Message: {"args": ["216.104.102.154:6112", "Hello from 1304"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,273 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,273 INFO client._clientwindow Outgoing JSON Message: {"args": ["216.104.102.154:6112", "Hello from 1304"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,273 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,278 INFO client._clientwindow Outgoing JSON Message: {"args": ["91.190.10.246:61154", "Hello from 39737"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,278 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,278 INFO client._clientwindow Outgoing JSON Message: {"args": ["91.190.10.246:61154", "Hello from 39737"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,278 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,292 INFO connectivity.relay.Relay Allocating local relay for SecondGladiator, 39737
2016-07-08 17:04:40,292 INFO fa.game_session.GameSession Bound peer SecondGladiator/39737 to 58175
2016-07-08 17:04:40,292 INFO fa.game_connection.GPGNetConnection GC<<: ConnectToPeer:('127.0.0.1:58175', u'SecondGladiator', 39737)
2016-07-08 17:04:40,292 INFO connectivity.relay.Relay Allocating local relay for Jobeki, 173482
2016-07-08 17:04:40,292 INFO fa.game_session.GameSession Bound peer Jobeki/173482 to 58176
2016-07-08 17:04:40,292 INFO fa.game_connection.GPGNetConnection GC<<: ConnectToPeer:('127.0.0.1:58176', u'Jobeki', 173482)
2016-07-08 17:04:40,292 INFO connectivity.relay.Relay Allocating local relay for Aldo, 177975
2016-07-08 17:04:40,292 INFO fa.game_session.GameSession Bound peer Aldo/177975 to 58177
2016-07-08 17:04:40,292 INFO fa.game_connection.GPGNetConnection GC<<: ConnectToPeer:('127.0.0.1:58177', u'Aldo', 177975)
2016-07-08 17:04:40,292 INFO connectivity.relay.Relay Allocating local relay for Dvergkaster, 28041
2016-07-08 17:04:40,292 INFO fa.game_session.GameSession Bound peer Dvergkaster/28041 to 58178
2016-07-08 17:04:40,292 INFO fa.game_connection.GPGNetConnection GC<<: ConnectToPeer:('127.0.0.1:58178', u'Dvergkaster', 28041)
2016-07-08 17:04:40,296 INFO client._clientwindow Outgoing JSON Message: {"args": ["41.107.189.78:6288", "Hello from 177975"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,296 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,296 INFO client._clientwindow Outgoing JSON Message: {"args": ["41.107.189.78:6288", "Hello from 177975"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,296 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,305 INFO fa.game_connection.GPGNetConnection GC >> : Disconnected : [u'39737']
2016-07-08 17:04:40,305 INFO fa.game_session.GameSession Incoming GPGNet: Disconnected [u'39737']
2016-07-08 17:04:40,305 INFO fa.game_session.GameSession Outgoing relay message Disconnected [u'39737']
2016-07-08 17:04:40,305 INFO client._clientwindow Outgoing JSON Message: {"args": ["39737"], "command": "Disconnected", "target": "game"}
2016-07-08 17:04:40,305 INFO fa.game_connection.GPGNetConnection GC >> : Disconnected : [u'173482']
2016-07-08 17:04:40,305 INFO fa.game_session.GameSession Incoming GPGNet: Disconnected [u'173482']
2016-07-08 17:04:40,305 INFO fa.game_session.GameSession Outgoing relay message Disconnected [u'173482']
2016-07-08 17:04:40,305 INFO client._clientwindow Outgoing JSON Message: {"args": ["173482"], "command": "Disconnected", "target": "game"}
2016-07-08 17:04:40,305 INFO fa.game_connection.GPGNetConnection GC >> : Disconnected : [u'177975']
2016-07-08 17:04:40,305 INFO fa.game_session.GameSession Incoming GPGNet: Disconnected [u'177975']
2016-07-08 17:04:40,305 INFO fa.game_session.GameSession Outgoing relay message Disconnected [u'177975']
2016-07-08 17:04:40,305 INFO client._clientwindow Outgoing JSON Message: {"args": ["177975"], "command": "Disconnected", "target": "game"}
2016-07-08 17:04:40,306 INFO fa.game_connection.GPGNetConnection GC >> : Disconnected : [u'28041']
2016-07-08 17:04:40,306 INFO fa.game_session.GameSession Incoming GPGNet: Disconnected [u'28041']
2016-07-08 17:04:40,306 INFO fa.game_session.GameSession Outgoing relay message Disconnected [u'28041']
2016-07-08 17:04:40,306 INFO client._clientwindow Outgoing JSON Message: {"args": ["28041"], "command": "Disconnected", "target": "game"}
2016-07-08 17:04:40,312 INFO client._clientwindow Outgoing JSON Message: {"args": ["84.202.224.240:61873", "Hello from 28041"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,312 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,315 INFO client._clientwindow Outgoing JSON Message: {"args": ["84.202.224.240:61873", "Hello from 28041"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,315 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,403 INFO client._clientwindow Outgoing JSON Message: {"args": ["68.103.227.162:6112", "Hello from 1193"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,403 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,405 INFO client._clientwindow Outgoing JSON Message: {"args": ["68.103.227.162:6112", "Hello from 1193"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,405 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,405 INFO client._clientwindow Outgoing JSON Message: {"args": ["68.103.227.162:6112", "Hello from 1193"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,405 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,427 INFO connectivity.relay.Relay Allocating local relay for Tackuto, 1304
2016-07-08 17:04:40,427 INFO fa.game_session.GameSession Bound peer Tackuto/1304 to 58179
2016-07-08 17:04:40,427 INFO fa.game_connection.GPGNetConnection GC<<: ConnectToPeer:('127.0.0.1:58179', u'Tackuto', 1304)
2016-07-08 17:04:40,427 INFO connectivity.relay.Relay Allocating local relay for Typo91, 1193
2016-07-08 17:04:40,427 INFO fa.game_session.GameSession Bound peer Typo91/1193 to 58180
2016-07-08 17:04:40,427 INFO fa.game_connection.GPGNetConnection GC<<: ConnectToPeer:('127.0.0.1:58180', u'Typo91', 1193)
2016-07-08 17:04:40,433 INFO client._clientwindow Outgoing JSON Message: {"args": ["91.51.63.58:49272", "Hello from 173482"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,434 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,434 INFO client._clientwindow Outgoing JSON Message: {"args": ["91.51.63.58:49272", "Hello from 173482"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,434 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,434 INFO client._clientwindow Outgoing JSON Message: {"args": ["91.51.63.58:49272", "Hello from 173482"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,434 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,568 INFO client._clientwindow Outgoing JSON Message: {"args": ["41.107.189.78:6288", "Hello from 177975"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,568 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,568 INFO client._clientwindow Outgoing JSON Message: {"args": ["41.107.189.78:6288", "Hello from 177975"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,569 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,571 INFO client._clientwindow Outgoing JSON Message: {"args": ["41.107.189.78:6288", "Hello from 177975"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:04:40,571 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:04:40,693 INFO fa.game_connection.GPGNetConnection GC >> : Disconnected : [u'1304']
2016-07-08 17:04:40,693 INFO fa.game_session.GameSession Incoming GPGNet: Disconnected [u'1304']
2016-07-08 17:04:40,693 INFO fa.game_session.GameSession Outgoing relay message Disconnected [u'1304']
2016-07-08 17:04:40,693 INFO client._clientwindow Outgoing JSON Message: {"args": ["1304"], "command": "Disconnected", "target": "game"}
2016-07-08 17:04:40,694 INFO fa.game_connection.GPGNetConnection GC >> : Disconnected : [u'1193']
2016-07-08 17:04:40,694 INFO fa.game_session.GameSession Incoming GPGNet: Disconnected [u'1193']
2016-07-08 17:04:40,694 INFO fa.game_session.GameSession Outgoing relay message Disconnected [u'1193']
2016-07-08 17:04:40,694 INFO client._clientwindow Outgoing JSON Message: {"args": ["1193"], "command": "Disconnected", "target": "game"}
2016-07-08 17:04:44,095 INFO connectivity.turn Permitting sends from [u'109.252.15.8', 5604]
2016-07-08 17:05:13,802 INFO fa.game_connection.GPGNetConnection GC<<: DisconnectFromPeer:(116335,)
2016-07-08 17:05:13,805 INFO fa.game_connection.GPGNetConnection GC >> : Disconnected : [u'116335']
2016-07-08 17:05:13,805 INFO fa.game_session.GameSession Incoming GPGNet: Disconnected [u'116335']
2016-07-08 17:05:13,805 INFO fa.game_session.GameSession Outgoing relay message Disconnected [u'116335']
2016-07-08 17:05:13,805 INFO client._clientwindow Outgoing JSON Message: {"args": ["116335"], "command": "Disconnected", "target": "game"}
2016-07-08 17:05:15,306 INFO fa.game_connection.GPGNetConnection GC >> : Chat : [u'I completely refaffed']
2016-07-08 17:05:15,306 INFO fa.game_session.GameSession Incoming GPGNet: Chat [u'I completely refaffed']
2016-07-08 17:05:15,306 INFO fa.game_session.GameSession Outgoing relay message Chat [u'I completely refaffed']
2016-07-08 17:05:15,306 INFO client._clientwindow Outgoing JSON Message: {"args": ["I completely refaffed"], "command": "Chat", "target": "game"}
2016-07-08 17:05:32,736 INFO fa.game_connection.GPGNetConnection GC >> : Chat : [u"no I don't"]
2016-07-08 17:05:32,736 INFO fa.game_session.GameSession Incoming GPGNet: Chat [u"no I don't"]
2016-07-08 17:05:32,736 INFO fa.game_session.GameSession Outgoing relay message Chat [u"no I don't"]
2016-07-08 17:05:32,736 INFO client._clientwindow Outgoing JSON Message: {"args": ["no I don't"], "command": "Chat", "target": "game"}
2016-07-08 17:05:47,230 INFO client._clientwindow Outgoing JSON Message: {"args": ["73.216.169.191:6112", "Hello from 2469"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:05:47,230 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:05:47,230 INFO client._clientwindow Outgoing JSON Message: {"args": ["73.216.169.191:6112", "Hello from 2469"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:05:47,230 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:05:47,230 INFO client._clientwindow Outgoing JSON Message: {"args": ["73.216.169.191:6112", "Hello from 2469"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:05:47,230 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:05:47,456 INFO connectivity.relay.Relay Allocating local relay for pathfinder, 2469
2016-07-08 17:05:47,456 INFO fa.game_session.GameSession Bound peer pathfinder/2469 to 63448
2016-07-08 17:05:47,456 INFO fa.game_connection.GPGNetConnection GC<<: ConnectToPeer:('127.0.0.1:63448', u'pathfinder', 2469)
2016-07-08 17:05:47,489 INFO fa.game_connection.GPGNetConnection GC >> : Disconnected : [u'2469']
2016-07-08 17:05:47,489 INFO fa.game_session.GameSession Incoming GPGNet: Disconnected [u'2469']
2016-07-08 17:05:47,489 INFO fa.game_session.GameSession Outgoing relay message Disconnected [u'2469']
2016-07-08 17:05:47,489 INFO client._clientwindow Outgoing JSON Message: {"args": ["2469"], "command": "Disconnected", "target": "game"}
2016-07-08 17:05:52,582 INFO client._clientwindow Outgoing JSON Message: {"args": ["109.252.15.8:21977", "Hello from 116335"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-07-08 17:05:52,582 INFO connectivity.helper.ConnectivityHelper Unknown natpacket
2016-07-08 17:05:52,903 INFO connectivity.relay.Relay Allocating local relay for Luthor-Huss, 116335
2016-07-08 17:05:52,903 INFO fa.game_session.GameSession Bound peer Luthor-Huss/116335 to 51245
2016-07-08 17:05:52,903 INFO fa.game_connection.GPGNetConnection GC<<: ConnectToPeer:('127.0.0.1:51245', u'Luthor-Huss', 116335)
2016-07-08 17:05:52,904 INFO fa.game_connection.GPGNetConnection GC >> : Disconnected : [u'116335']
2016-07-08 17:05:52,905 INFO fa.game_session.GameSession Incoming GPGNet: Disconnected [u'116335']
2016-07-08 17:05:52,905 INFO fa.game_session.GameSession Outgoing relay message Disconnected [u'116335']
2016-07-08 17:05:52,905 INFO client._clientwindow Outgoing JSON Message: {"args": ["116335"], "command": "Disconnected", "target": "game"}
2016-07-08 17:05:55,842 INFO connectivity.turn Permitting sends from [u'109.252.14.170', 4710]
2016-07-08 17:06:07,232 INFO fa.game_connection.GPGNetConnection GC<<: DisconnectFromPeer:(133087,)
2016-07-08 17:06:07,239 INFO fa.game_connection.GPGNetConnection GC >> : Disconnected : [u'133087']
2016-07-08 17:06:07,239 INFO fa.game_session.GameSession Incoming GPGNet: Disconnected [u'133087']
2016-07-08 17:06:07,239 INFO fa.game_session.GameSession Outgoing relay message Disconnected [u'133087']
2016-07-08 17:06:07,239 INFO client._clientwindow Outgoing JSON Message: {"args": ["133087"], "command": "Disconnected", "target": "game"}
2016-07-08 17:06:11,017 INFO fa.game_connection.GPGNetConnection GC >> : GameState : [u'Launching']
2016-07-08 17:06:11,019 INFO fa.game_session.GameSession Incoming GPGNet: GameState [u'Launching']
2016-07-08 17:06:11,019 INFO fa.game_session.GameSession Outgoing relay message GameState [u'Launching']
2016-07-08 17:06:11,019 INFO client._clientwindow Outgoing JSON Message: {"args": ["Launching"], "command": "GameState", "target": "game"}
2016-07-08 17:06:11,990 INFO fa.game_process Game Info Complete: {u'featured_mod_versions': {u'11': 3654, u'13': 3654, u'12': 3654, u'15': 3654, u'14': 3654, u'17': 3654, u'19': 3654, u'18': 3654, u'22': 3654, u'20': 3654, u'1': 3654, u'3': 3634, u'2': 3640, u'5': 1, u'4': 1, u'6': 1, u'9': 1, u'8': 1, u'21': 3654}, u'num_players': 10, 'uid': 4918478, u'title': u'800-1400 | &lt;300 cpu', u'max_players': 10, u'password_protected': False, u'sim_mods': {}, u'game_type': 0, u'state': u'playing', u'map_file_path': u'maps/duel gap 5v5.v0014.zip', u'teams': {u'3': [u'Jobeki', u'Typo91', u'm_wylie85', u'Tackuto', u'SecondGladiator'], u'2': [u'Dvergkaster', u'Luthor-Huss', u'Aldo', u'BRNKoINSANITY', u'Swastika']}, u'mapname': u'duel gap 5v5.v0014', u'host': u'Swastika', u'command': u'game_info', u'visibility': u'public', 'featured_mod': u'faf', 'recorder': u'BRNKoINSANITY', 'launched_at': 1468011972.9355416, 'complete': True}
2016-07-08 17:06:15,372 INFO fa.replayserver FA connected locally.
2016-07-08 17:06:15,505 INFO fa.replayserver Stripping prefix 'P/4918478/BRNKoINSANITY.SCFAreplay ' from replay.
2016-07-08 17:06:25,622 INFO fa.game_connection.GPGNetConnection GC >> : Bottleneck : [u'readiness', u'1', u'139480,116335', u'5740.4']
2016-07-08 17:06:25,622 INFO fa.game_session.GameSession Incoming GPGNet: Bottleneck [u'readiness', u'1', u'139480,116335', u'5740.4']
2016-07-08 17:06:25,622 INFO fa.game_session.GameSession Outgoing relay message Bottleneck [u'readiness', u'1', u'139480,116335', u'5740.4']
2016-07-08 17:06:25,622 INFO client._clientwindow Outgoing JSON Message: {"args": ["readiness", "1", "139480,116335", "5740.4"], "command": "Bottleneck", "target": "game"}
2016-07-08 17:06:30,799 INFO fa.game_connection.GPGNetConnection GC >> : Bottleneck : [u'readiness', u'1', u'139480', u'10916.2']
2016-07-08 17:06:30,799 INFO fa.game_session.GameSession Incoming GPGNet: Bottleneck [u'readiness', u'1', u'139480', u'10916.2']
2016-07-08 17:06:30,799 INFO fa.game_session.GameSession Outgoing relay message Bottleneck [u'readiness', u'1', u'139480', u'10916.2']
2016-07-08 17:06:30,799 INFO client._clientwindow Outgoing JSON Message: {"args": ["readiness", "1", "139480", "10916.2"], "command": "Bottleneck", "target": "game"}
2016-07-08 17:06:35,125 INFO fa.game_connection.GPGNetConnection GC >> : BottleneckCleared : []
2016-07-08 17:06:35,125 INFO fa.game_session.GameSession Incoming GPGNet: BottleneckCleared []
2016-07-08 17:06:35,125 INFO fa.game_session.GameSession Outgoing relay message BottleneckCleared []
2016-07-08 17:06:35,125 INFO client._clientwindow Outgoing JSON Message: {"args": [], "command": "BottleneckCleared", "target": "game"}
2016-07-08 17:07:14,648 ERROR fa.maps Web preview download failed for x1ca_coop_001.v0012
2016-07-08 17:07:14,654 ERROR fa.maps Web Preview not found for: x1ca_coop_001.v0012
2016-07-08 17:14:08,878 INFO faf.secondaryServer.Tournament Pending requests: 1
2016-07-08 17:14:08,878 INFO faf.secondaryServer.Tournament Connecting to Tournament
2016-07-08 17:14:32,947 ERROR fa.maps Web preview download failed for x1ca_coop_001.v0012
2016-07-08 17:14:32,947 ERROR fa.maps Web Preview not found for: x1ca_coop_001.v0012
2016-07-08 17:15:02,002 ERROR fa.maps Web preview download failed for x1ca_coop_001.v0012
2016-07-08 17:15:02,002 ERROR fa.maps Web Preview not found for: x1ca_coop_001.v0012
2016-07-08 17:15:02,236 ERROR fa.maps Web preview download failed for x1ca_coop_001.v0012
2016-07-08 17:15:02,236 ERROR fa.maps Web Preview not found for: x1ca_coop_001.v0012
2016-07-08 17:17:08,693 ERROR fa.maps Web preview download failed for x1ca_coop_001.v0012
2016-07-08 17:17:08,693 ERROR fa.maps Web Preview not found for: x1ca_coop_001.v0012
2016-07-08 17:18:53,207 ERROR fa.maps Web preview download failed for scca_coop_e01.v0008
2016-07-08 17:18:53,207 ERROR fa.maps Web Preview not found for: scca_coop_e01.v0008
2016-07-08 17:18:53,450 ERROR fa.maps Web preview download failed for scca_coop_e01.v0008
2016-07-08 17:18:53,450 ERROR fa.maps Web Preview not found for: scca_coop_e01.v0008
2016-07-08 17:21:38,667 ERROR fa.maps Web preview download failed for scca_coop_e01.v0008
2016-07-08 17:21:38,667 ERROR fa.maps Web Preview not found for: scca_coop_e01.v0008
2016-07-08 17:24:08,880 INFO faf.secondaryServer.Tournament Pending requests: 2
2016-07-08 17:24:08,880 INFO faf.secondaryServer.Tournament Connecting to Tournament
2016-07-08 17:25:47,321 INFO fa.game_connection.GPGNetConnection GC >> : Bottleneck : [u'ack', u'9029', u'173482', u'5726.0']
2016-07-08 17:25:47,322 INFO fa.game_session.GameSession Incoming GPGNet: Bottleneck [u'ack', u'9029', u'173482', u'5726.0']
2016-07-08 17:25:47,322 INFO fa.game_session.GameSession Outgoing relay message Bottleneck [u'ack', u'9029', u'173482', u'5726.0']
2016-07-08 17:25:47,322 INFO client._clientwindow Outgoing JSON Message: {"args": ["ack", "9029", "173482", "5726.0"], "command": "Bottleneck", "target": "game"}
2016-07-08 17:25:52,302 INFO fa.game_connection.GPGNetConnection GC >> : Bottleneck : [u'ack', u'9029', u'173482', u'10727.5']
2016-07-08 17:25:52,302 INFO fa.game_session.GameSession Incoming GPGNet: Bottleneck [u'ack', u'9029', u'173482', u'10727.5']

[E8400-CV]

When was the proxy server changed anyway? How do you even see if you are using it?

Either way; I've seen the same lately with a few players; they randomly lose connection to like 3 players (in 6v6). I've been on the side of the 3, but not the one who loses to three.

Also seen a certain player drop to one other, then 10m later to another, then 10 later to yet another...

[visionik]

BRNKoINSANITY - thank you for the report. We suspect something is wrong as we've heard this a few times now; we just don't know what it is. The more reports and log file we can get, just like you did, from the widest variety of people experience the problem as possible, the faster we can figure out what it is. Thank you!

E8400-CV - the proxy server was changed Feb 2 2016 when we did the server upgrade. The post about it is here:


http://www.faforever.com/2016/02/ch-ch- ... he-server/