Forged Alliance Forever Forged Alliance Forever Forums 2017-01-31T18:33:30+02:00 /feed.php?f=3&t=13946 2017-01-31T18:30:40+02:00 2017-01-31T18:30:40+02:00 /viewtopic.php?t=13946&p=142810#p142810 <![CDATA[Re: Connection issues]]>
http://pastebin.com/q3bs5RuX

Code:
2017-01-31 17:09:27,681 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["Ended"], "command": "GameState", "target": "game"}
2017-01-31 17:09:31,331 INFO     fa.check                       Checking FA for: faf and map None
2017-01-31 17:09:31,331 INFO     fa.check                       Version unknown, assuming latest
2017-01-31 17:09:31,331 INFO     fa.check                       Updating FA for mod: faf, version None
2017-01-31 17:09:31,332 INFO     fa.check                       Writing fa_path.lua config file.
2017-01-31 17:09:32,049 INFO     client._clientwindow           Outgoing JSON Message: {"title": "2v2 700-1300 good cpu", "visibility": "public", "is_rehost": false, "mapname": "2v2 sand box.v0001", "command": "game_host", "password": null, "mod": "faf"}
2017-01-31 17:09:32,142 ERROR    client._clientwindow           Not ready for game launch
2017-01-31 17:09:32,148 INFO     client._clientwindow           Handling game_launch via JSON {u'args': [u'/numgames 416'], u'command': u'game_launch', u'uid': 5740408, u'mod': u'faf'}
2017-01-31 17:09:32,148 INFO     fa.upnp                        UPnP mapping 192.168.1.176:7002
2017-01-31 17:09:32,163 INFO     fa.upnp                        -> UDP mapping of 192.168.1.176:7002 to 85.191.88.165:7002
2017-01-31 17:09:32,176 INFO     fa.play                        Play received arguments: ['/mean', '1257.59116852', '/deviation', '83.6137800862', '/country ', u'NL']
2017-01-31 17:09:32,176 INFO     fa.game_process                Running FA with info: {'recorder': u'Blackwaters', 'featured_mod': u'faf', 'uid': 5740408, 'launched_at': 1485878972.176}
2017-01-31 17:09:32,176 INFO     fa.game_process                Running FA via command: "C:\ProgramData\FAForever\bin\ForgedAlliance.exe" /mean 1257.59116852 /deviation 83.6137800862 /country  NL /init init_faf.lua /numgames 416 /nobugreport /savereplay "gpgnet://localhost/5740408/Blackwaters.SCFAreplay" /gpgnet 127.0.0.1:49279
2017-01-31 17:09:32,176 INFO     fa.game_process                Running FA via executable: C:\ProgramData\FAForever\bin\ForgedAlliance.exe
2017-01-31 17:09:32,197 INFO     client._clientwindow           FA has launched in an attached process.
2017-01-31 17:09:32,197 INFO     fa.game_session.GameSession    Game has started
2017-01-31 17:09:36,131 INFO     fa.game_session.GameSession    Game connected through GPGNet
2017-01-31 17:09:36,134 INFO     fa.game_connection.GPGNetConnection GC >> : GameState : [u'Idle']
2017-01-31 17:09:36,134 INFO     fa.game_session.GameSession    Incoming GPGNet: GameState [u'Idle']
2017-01-31 17:09:36,134 INFO     fa.game_connection.GPGNetConnection GC<<: CreateLobby:(0, 7003, u'Blackwaters', 98561, 1)
2017-01-31 17:09:36,134 INFO     fa.game_session.GameSession    Outgoing relay message GameState [u'Idle']
2017-01-31 17:09:36,134 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["Idle"], "command": "GameState", "target": "game"}
2017-01-31 17:09:36,298 INFO     fa.game_connection.GPGNetConnection GC >> : GameState : [u'Lobby']
2017-01-31 17:09:36,298 INFO     fa.game_session.GameSession    Incoming GPGNet: GameState [u'Lobby']
2017-01-31 17:09:36,298 INFO     fa.game_session.GameSession    Outgoing relay message GameState [u'Lobby']
2017-01-31 17:09:36,298 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["Lobby"], "command": "GameState", "target": "game"}
2017-01-31 17:09:36,335 INFO     fa.game_connection.GPGNetConnection GC<<: HostGame:(u'2v2 sand box.v0001',)
2017-01-31 17:09:36,630 INFO     fa.game_connection.GPGNetConnection GC >> : GameOption : [u'UnitCap', u'1000']
2017-01-31 17:09:36,631 INFO     fa.game_session.GameSession    Incoming GPGNet: GameOption [u'UnitCap', u'1000']
2017-01-31 17:09:36,631 INFO     fa.game_session.GameSession    Outgoing relay message GameOption [u'UnitCap', u'1000']
2017-01-31 17:09:36,631 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["UnitCap", "1000"], "command": "GameOption", "target": "game"}
2017-01-31 17:09:36,631 INFO     fa.game_connection.GPGNetConnection GC >> : GameOption : [u'ShareUnitCap', u'none']
2017-01-31 17:09:36,631 INFO     fa.game_session.GameSession    Incoming GPGNet: GameOption [u'ShareUnitCap', u'none']
2017-01-31 17:09:36,631 INFO     fa.game_session.GameSession    Outgoing relay message GameOption [u'ShareUnitCap', u'none']
2017-01-31 17:09:36,631 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["ShareUnitCap", "none"], "command": "GameOption", "target": "game"}
2017-01-31 17:09:36,631 INFO     fa.game_connection.GPGNetConnection GC >> : GameOption : [u'FogOfWar', u'explored']
2017-01-31 17:09:36,631 INFO     fa.game_session.GameSession    Incoming GPGNet: GameOption [u'FogOfWar', u'explored']
2017-01-31 17:09:36,631 INFO     fa.game_session.GameSession    Outgoing relay message GameOption [u'FogOfWar', u'explored']
2017-01-31 17:09:36,631 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["FogOfWar", "explored"], "command": "GameOption", "target": "game"}
2017-01-31 17:09:36,631 INFO     fa.game_connection.GPGNetConnection GC >> : GameOption : [u'Victory', u'demoralization']
2017-01-31 17:09:36,631 INFO     fa.game_session.GameSession    Incoming GPGNet: GameOption [u'Victory', u'demoralization']
2017-01-31 17:09:36,631 INFO     fa.game_session.GameSession    Outgoing relay message GameOption [u'Victory', u'demoralization']
2017-01-31 17:09:36,631 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["Victory", "demoralization"], "command": "GameOption", "target": "game"}
2017-01-31 17:09:36,631 INFO     fa.game_connection.GPGNetConnection GC >> : GameOption : [u'Timeouts', u'3']
2017-01-31 17:09:36,631 INFO     fa.game_session.GameSession    Incoming GPGNet: GameOption [u'Timeouts', u'3']
2017-01-31 17:09:36,631 INFO     fa.game_session.GameSession    Outgoing relay message GameOption [u'Timeouts', u'3']
2017-01-31 17:09:36,631 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["Timeouts", "3"], "command": "GameOption", "target": "game"}
2017-01-31 17:09:36,631 INFO     fa.game_connection.GPGNetConnection GC >> : GameOption : [u'GameSpeed', u'normal']
2017-01-31 17:09:36,632 INFO     fa.game_session.GameSession    Incoming GPGNet: GameOption [u'GameSpeed', u'normal']
2017-01-31 17:09:36,632 INFO     fa.game_session.GameSession    Outgoing relay message GameOption [u'GameSpeed', u'normal']
2017-01-31 17:09:36,632 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["GameSpeed", "normal"], "command": "GameOption", "target": "game"}
2017-01-31 17:09:36,632 INFO     fa.game_connection.GPGNetConnection GC >> : GameOption : [u'AllowObservers', 0]
2017-01-31 17:09:36,632 INFO     fa.game_session.GameSession    Incoming GPGNet: GameOption [u'AllowObservers', 0]
2017-01-31 17:09:36,632 INFO     fa.game_session.GameSession    Outgoing relay message GameOption [u'AllowObservers', 0]
2017-01-31 17:09:36,632 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["AllowObservers", 0], "command": "GameOption", "target": "game"}
2017-01-31 17:09:36,632 INFO     fa.game_connection.GPGNetConnection GC >> : GameOption : [u'CheatsEnabled', u'false']
2017-01-31 17:09:36,632 INFO     fa.game_session.GameSession    Incoming GPGNet: GameOption [u'CheatsEnabled', u'false']
2017-01-31 17:09:36,632 INFO     fa.game_session.GameSession    Outgoing relay message GameOption [u'CheatsEnabled', u'false']
2017-01-31 17:09:36,632 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["CheatsEnabled", "false"], "command": "GameOption", "target": "game"}
2017-01-31 17:09:36,634 INFO     fa.game_connection.GPGNetConnection GC >> : GameOption : [u'CivilianAlliance', u'enemy']
2017-01-31 17:09:36,634 INFO     fa.game_session.GameSession    Incoming GPGNet: GameOption [u'CivilianAlliance', u'enemy']
2017-01-31 17:09:36,634 INFO     fa.game_session.GameSession    Outgoing relay message GameOption [u'CivilianAlliance', u'enemy']
2017-01-31 17:09:36,634 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["CivilianAlliance", "enemy"], "command": "GameOption", "target": "game"}
2017-01-31 17:09:36,634 INFO     fa.game_connection.GPGNetConnection GC >> : GameOption : [u'RevealCivilians', u'Yes']
2017-01-31 17:09:36,634 INFO     fa.game_session.GameSession    Incoming GPGNet: GameOption [u'RevealCivilians', u'Yes']
2017-01-31 17:09:36,634 INFO     fa.game_session.GameSession    Outgoing relay message GameOption [u'RevealCivilians', u'Yes']
2017-01-31 17:09:36,634 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["RevealCivilians", "Yes"], "command": "GameOption", "target": "game"}
2017-01-31 17:09:36,634 INFO     fa.game_connection.GPGNetConnection GC >> : GameOption : [u'PrebuiltUnits', u'Off']
2017-01-31 17:09:36,634 INFO     fa.game_session.GameSession    Incoming GPGNet: GameOption [u'PrebuiltUnits', u'Off']
2017-01-31 17:09:36,634 INFO     fa.game_session.GameSession    Outgoing relay message GameOption [u'PrebuiltUnits', u'Off']
2017-01-31 17:09:36,634 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["PrebuiltUnits", "Off"], "command": "GameOption", "target": "game"}
2017-01-31 17:09:36,634 INFO     fa.game_connection.GPGNetConnection GC >> : GameOption : [u'NoRushOption', u'Off']
2017-01-31 17:09:36,634 INFO     fa.game_session.GameSession    Incoming GPGNet: GameOption [u'NoRushOption', u'Off']
2017-01-31 17:09:36,635 INFO     fa.game_session.GameSession    Outgoing relay message GameOption [u'NoRushOption', u'Off']
2017-01-31 17:09:36,635 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["NoRushOption", "Off"], "command": "GameOption", "target": "game"}
2017-01-31 17:09:36,635 INFO     fa.game_connection.GPGNetConnection GC >> : GameOption : [u'RandomMap', u'Off']
2017-01-31 17:09:36,635 INFO     fa.game_session.GameSession    Incoming GPGNet: GameOption [u'RandomMap', u'Off']
2017-01-31 17:09:36,635 INFO     fa.game_session.GameSession    Outgoing relay message GameOption [u'RandomMap', u'Off']
2017-01-31 17:09:36,635 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["RandomMap", "Off"], "command": "GameOption", "target": "game"}
2017-01-31 17:09:36,635 INFO     fa.game_connection.GPGNetConnection GC >> : GameOption : [u'Score', u'yes']
2017-01-31 17:09:36,635 INFO     fa.game_session.GameSession    Incoming GPGNet: GameOption [u'Score', u'yes']
2017-01-31 17:09:36,635 INFO     fa.game_session.GameSession    Outgoing relay message GameOption [u'Score', u'yes']
2017-01-31 17:09:36,635 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["Score", "yes"], "command": "GameOption", "target": "game"}
2017-01-31 17:09:36,637 INFO     fa.game_connection.GPGNetConnection GC >> : GameOption : [u'Share', u'ShareUntilDeath']
2017-01-31 17:09:36,637 INFO     fa.game_session.GameSession    Incoming GPGNet: GameOption [u'Share', u'ShareUntilDeath']
2017-01-31 17:09:36,637 INFO     fa.game_session.GameSession    Outgoing relay message GameOption [u'Share', u'ShareUntilDeath']
2017-01-31 17:09:36,637 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["Share", "ShareUntilDeath"], "command": "GameOption", "target": "game"}
2017-01-31 17:09:36,637 INFO     fa.game_connection.GPGNetConnection GC >> : GameOption : [u'TeamSpawn', u'fixed']
2017-01-31 17:09:36,637 INFO     fa.game_session.GameSession    Incoming GPGNet: GameOption [u'TeamSpawn', u'fixed']
2017-01-31 17:09:36,637 INFO     fa.game_session.GameSession    Outgoing relay message GameOption [u'TeamSpawn', u'fixed']
2017-01-31 17:09:36,637 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["TeamSpawn", "fixed"], "command": "GameOption", "target": "game"}
2017-01-31 17:09:36,637 INFO     fa.game_connection.GPGNetConnection GC >> : GameOption : [u'TeamLock', u'locked']
2017-01-31 17:09:36,637 INFO     fa.game_session.GameSession    Incoming GPGNet: GameOption [u'TeamLock', u'locked']
2017-01-31 17:09:36,638 INFO     fa.game_session.GameSession    Outgoing relay message GameOption [u'TeamLock', u'locked']
2017-01-31 17:09:36,638 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["TeamLock", "locked"], "command": "GameOption", "target": "game"}
2017-01-31 17:09:36,638 INFO     fa.game_connection.GPGNetConnection GC >> : GameOption : [u'AutoTeams', u'tvsb']
2017-01-31 17:09:36,638 INFO     fa.game_session.GameSession    Incoming GPGNet: GameOption [u'AutoTeams', u'tvsb']
2017-01-31 17:09:36,638 INFO     fa.game_session.GameSession    Outgoing relay message GameOption [u'AutoTeams', u'tvsb']
2017-01-31 17:09:36,638 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["AutoTeams", "tvsb"], "command": "GameOption", "target": "game"}
2017-01-31 17:09:36,638 INFO     fa.game_connection.GPGNetConnection GC >> : GameOption : [u'CheatMult', u'2.0']
2017-01-31 17:09:36,638 INFO     fa.game_session.GameSession    Incoming GPGNet: GameOption [u'CheatMult', u'2.0']
2017-01-31 17:09:36,638 INFO     fa.game_session.GameSession    Outgoing relay message GameOption [u'CheatMult', u'2.0']
2017-01-31 17:09:36,638 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["CheatMult", "2.0"], "command": "GameOption", "target": "game"}
2017-01-31 17:09:36,638 INFO     fa.game_connection.GPGNetConnection GC >> : GameOption : [u'BuildMult', u'2.0']
2017-01-31 17:09:36,638 INFO     fa.game_session.GameSession    Incoming GPGNet: GameOption [u'BuildMult', u'2.0']
2017-01-31 17:09:36,638 INFO     fa.game_session.GameSession    Outgoing relay message GameOption [u'BuildMult', u'2.0']
2017-01-31 17:09:36,638 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["BuildMult", "2.0"], "command": "GameOption", "target": "game"}
2017-01-31 17:09:36,638 INFO     fa.game_connection.GPGNetConnection GC >> : GameOption : [u'TMLRandom', u'0']
2017-01-31 17:09:36,638 INFO     fa.game_session.GameSession    Incoming GPGNet: GameOption [u'TMLRandom', u'0']
2017-01-31 17:09:36,638 INFO     fa.game_session.GameSession    Outgoing relay message GameOption [u'TMLRandom', u'0']
2017-01-31 17:09:36,638 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["TMLRandom", "0"], "command": "GameOption", "target": "game"}
2017-01-31 17:09:36,638 INFO     fa.game_connection.GPGNetConnection GC >> : GameOption : [u'LandExpansionsAllowed', u'5']
2017-01-31 17:09:36,638 INFO     fa.game_session.GameSession    Incoming GPGNet: GameOption [u'LandExpansionsAllowed', u'5']
2017-01-31 17:09:36,640 INFO     fa.game_session.GameSession    Outgoing relay message GameOption [u'LandExpansionsAllowed', u'5']
2017-01-31 17:09:36,640 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["LandExpansionsAllowed", "5"], "command": "GameOption", "target": "game"}
2017-01-31 17:09:36,640 INFO     fa.game_connection.GPGNetConnection GC >> : GameOption : [u'NavalExpansionsAllowed', u'4']
2017-01-31 17:09:36,640 INFO     fa.game_session.GameSession    Incoming GPGNet: GameOption [u'NavalExpansionsAllowed', u'4']
2017-01-31 17:09:36,640 INFO     fa.game_session.GameSession    Outgoing relay message GameOption [u'NavalExpansionsAllowed', u'4']
2017-01-31 17:09:36,640 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["NavalExpansionsAllowed", "4"], "command": "GameOption", "target": "game"}
2017-01-31 17:09:36,640 INFO     fa.game_connection.GPGNetConnection GC >> : GameOption : [u'OmniCheat', u'on']
2017-01-31 17:09:36,640 INFO     fa.game_session.GameSession    Incoming GPGNet: GameOption [u'OmniCheat', u'on']
2017-01-31 17:09:36,640 INFO     fa.game_session.GameSession    Outgoing relay message GameOption [u'OmniCheat', u'on']
2017-01-31 17:09:36,640 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["OmniCheat", "on"], "command": "GameOption", "target": "game"}
2017-01-31 17:09:36,641 INFO     fa.game_connection.GPGNetConnection GC >> : GameOption : [u'ScenarioFile', u'/maps/2v2 sand box.v0001/2v2 sand box_scenario.lua']
2017-01-31 17:09:36,641 INFO     fa.game_session.GameSession    Incoming GPGNet: GameOption [u'ScenarioFile', u'/maps/2v2 sand box.v0001/2v2 sand box_scenario.lua']
2017-01-31 17:09:36,641 INFO     fa.game_session.GameSession    Outgoing relay message GameOption [u'ScenarioFile', u'/maps/2v2 sand box.v0001/2v2 sand box_scenario.lua']
2017-01-31 17:09:36,641 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["ScenarioFile", "/maps/2v2 sand box.v0001/2v2 sand box_scenario.lua"], "command": "GameOption", "target": "game"}
2017-01-31 17:09:36,641 INFO     fa.game_connection.GPGNetConnection GC >> : GameOption : [u'Slots', 4]
2017-01-31 17:09:36,641 INFO     fa.game_session.GameSession    Incoming GPGNet: GameOption [u'Slots', 4]
2017-01-31 17:09:36,641 INFO     fa.game_session.GameSession    Outgoing relay message GameOption [u'Slots', 4]
2017-01-31 17:09:36,641 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["Slots", 4], "command": "GameOption", "target": "game"}
2017-01-31 17:09:36,894 INFO     fa.game_connection.GPGNetConnection GC >> : PlayerOption : [u'98561', u'Faction', 2]
2017-01-31 17:09:36,894 INFO     fa.game_session.GameSession    Incoming GPGNet: PlayerOption [u'98561', u'Faction', 2]
2017-01-31 17:09:36,894 INFO     fa.game_session.GameSession    Outgoing relay message PlayerOption [u'98561', u'Faction', 2]
2017-01-31 17:09:36,894 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["98561", "Faction", 2], "command": "PlayerOption", "target": "game"}
2017-01-31 17:09:36,894 INFO     fa.game_connection.GPGNetConnection GC >> : PlayerOption : [u'98561', u'Color', 8]
2017-01-31 17:09:36,894 INFO     fa.game_session.GameSession    Incoming GPGNet: PlayerOption [u'98561', u'Color', 8]
2017-01-31 17:09:36,894 INFO     fa.game_session.GameSession    Outgoing relay message PlayerOption [u'98561', u'Color', 8]
2017-01-31 17:09:36,894 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["98561", "Color", 8], "command": "PlayerOption", "target": "game"}
2017-01-31 17:09:36,894 INFO     fa.game_connection.GPGNetConnection GC >> : PlayerOption : [u'98561', u'Team', 1]
2017-01-31 17:09:36,894 INFO     fa.game_session.GameSession    Incoming GPGNet: PlayerOption [u'98561', u'Team', 1]
2017-01-31 17:09:36,894 INFO     fa.game_session.GameSession    Outgoing relay message PlayerOption [u'98561', u'Team', 1]
2017-01-31 17:09:36,894 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["98561", "Team", 1], "command": "PlayerOption", "target": "game"}
2017-01-31 17:09:36,894 INFO     fa.game_connection.GPGNetConnection GC >> : PlayerOption : [u'98561', u'StartSpot', 1]
2017-01-31 17:09:36,894 INFO     fa.game_session.GameSession    Incoming GPGNet: PlayerOption [u'98561', u'StartSpot', 1]
2017-01-31 17:09:36,894 INFO     fa.game_session.GameSession    Outgoing relay message PlayerOption [u'98561', u'StartSpot', 1]
2017-01-31 17:09:36,894 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["98561", "StartSpot", 1], "command": "PlayerOption", "target": "game"}
2017-01-31 17:09:36,897 INFO     fa.game_connection.GPGNetConnection GC >> : ClearSlot : [2]
2017-01-31 17:09:36,897 INFO     fa.game_session.GameSession    Incoming GPGNet: ClearSlot [2]
2017-01-31 17:09:36,897 INFO     fa.game_session.GameSession    Outgoing relay message ClearSlot [2]
2017-01-31 17:09:36,897 INFO     client._clientwindow           Outgoing JSON Message: {"args": [2], "command": "ClearSlot", "target": "game"}
2017-01-31 17:09:36,927 INFO     fa.game_connection.GPGNetConnection GC >> : ClearSlot : [3]
2017-01-31 17:09:36,927 INFO     fa.game_session.GameSession    Incoming GPGNet: ClearSlot [3]
2017-01-31 17:09:36,927 INFO     fa.game_session.GameSession    Outgoing relay message ClearSlot [3]
2017-01-31 17:09:36,927 INFO     client._clientwindow           Outgoing JSON Message: {"args": [3], "command": "ClearSlot", "target": "game"}
2017-01-31 17:09:36,927 INFO     fa.game_connection.GPGNetConnection GC >> : ClearSlot : [4]
2017-01-31 17:09:36,927 INFO     fa.game_session.GameSession    Incoming GPGNet: ClearSlot [4]
2017-01-31 17:09:36,927 INFO     fa.game_session.GameSession    Outgoing relay message ClearSlot [4]
2017-01-31 17:09:36,927 INFO     client._clientwindow           Outgoing JSON Message: {"args": [4], "command": "ClearSlot", "target": "game"}
2017-01-31 17:09:38,994 INFO     fa.game_connection.GPGNetConnection GC >> : ClearSlot : [1]
2017-01-31 17:09:38,994 INFO     fa.game_session.GameSession    Incoming GPGNet: ClearSlot [1]
2017-01-31 17:09:38,994 INFO     fa.game_session.GameSession    Outgoing relay message ClearSlot [1]
2017-01-31 17:09:38,994 INFO     client._clientwindow           Outgoing JSON Message: {"args": [1], "command": "ClearSlot", "target": "game"}
2017-01-31 17:09:38,997 INFO     fa.game_connection.GPGNetConnection GC >> : PlayerOption : [u'98561', u'Faction', 2]
2017-01-31 17:09:38,997 INFO     fa.game_session.GameSession    Incoming GPGNet: PlayerOption [u'98561', u'Faction', 2]
2017-01-31 17:09:38,997 INFO     fa.game_session.GameSession    Outgoing relay message PlayerOption [u'98561', u'Faction', 2]
2017-01-31 17:09:38,999 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["98561", "Faction", 2], "command": "PlayerOption", "target": "game"}
2017-01-31 17:09:38,999 INFO     fa.game_connection.GPGNetConnection GC >> : PlayerOption : [u'98561', u'Color', 8]
2017-01-31 17:09:38,999 INFO     fa.game_session.GameSession    Incoming GPGNet: PlayerOption [u'98561', u'Color', 8]
2017-01-31 17:09:38,999 INFO     fa.game_session.GameSession    Outgoing relay message PlayerOption [u'98561', u'Color', 8]
2017-01-31 17:09:38,999 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["98561", "Color", 8], "command": "PlayerOption", "target": "game"}
2017-01-31 17:09:38,999 INFO     fa.game_connection.GPGNetConnection GC >> : PlayerOption : [u'98561', u'Team', 1]
2017-01-31 17:09:38,999 INFO     fa.game_session.GameSession    Incoming GPGNet: PlayerOption [u'98561', u'Team', 1]
2017-01-31 17:09:38,999 INFO     fa.game_session.GameSession    Outgoing relay message PlayerOption [u'98561', u'Team', 1]
2017-01-31 17:09:38,999 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["98561", "Team", 1], "command": "PlayerOption", "target": "game"}
2017-01-31 17:09:38,999 INFO     fa.game_connection.GPGNetConnection GC >> : PlayerOption : [u'98561', u'StartSpot', 3]
2017-01-31 17:09:38,999 INFO     fa.game_session.GameSession    Incoming GPGNet: PlayerOption [u'98561', u'StartSpot', 3]
2017-01-31 17:09:38,999 INFO     fa.game_session.GameSession    Outgoing relay message PlayerOption [u'98561', u'StartSpot', 3]
2017-01-31 17:09:38,999 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["98561", "StartSpot", 3], "command": "PlayerOption", "target": "game"}
2017-01-31 17:09:39,002 INFO     fa.game_connection.GPGNetConnection GC >> : PlayerOption : [u'98561', u'Faction', 2]
2017-01-31 17:09:39,002 INFO     fa.game_session.GameSession    Incoming GPGNet: PlayerOption [u'98561', u'Faction', 2]
2017-01-31 17:09:39,002 INFO     fa.game_session.GameSession    Outgoing relay message PlayerOption [u'98561', u'Faction', 2]
2017-01-31 17:09:39,002 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["98561", "Faction", 2], "command": "PlayerOption", "target": "game"}
2017-01-31 17:09:39,002 INFO     fa.game_connection.GPGNetConnection GC >> : PlayerOption : [u'98561', u'Color', 8]
2017-01-31 17:09:39,002 INFO     fa.game_session.GameSession    Incoming GPGNet: PlayerOption [u'98561', u'Color', 8]
2017-01-31 17:09:39,002 INFO     fa.game_session.GameSession    Outgoing relay message PlayerOption [u'98561', u'Color', 8]
2017-01-31 17:09:39,002 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["98561", "Color", 8], "command": "PlayerOption", "target": "game"}
2017-01-31 17:09:39,002 INFO     fa.game_connection.GPGNetConnection GC >> : PlayerOption : [u'98561', u'Team', 2]
2017-01-31 17:09:39,002 INFO     fa.game_session.GameSession    Incoming GPGNet: PlayerOption [u'98561', u'Team', 2]
2017-01-31 17:09:39,002 INFO     fa.game_session.GameSession    Outgoing relay message PlayerOption [u'98561', u'Team', 2]
2017-01-31 17:09:39,002 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["98561", "Team", 2], "command": "PlayerOption", "target": "game"}
2017-01-31 17:09:39,002 INFO     fa.game_connection.GPGNetConnection GC >> : PlayerOption : [u'98561', u'StartSpot', 3]
2017-01-31 17:09:39,002 INFO     fa.game_session.GameSession    Incoming GPGNet: PlayerOption [u'98561', u'StartSpot', 3]
2017-01-31 17:09:39,002 INFO     fa.game_session.GameSession    Outgoing relay message PlayerOption [u'98561', u'StartSpot', 3]
2017-01-31 17:09:39,002 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["98561", "StartSpot", 3], "command": "PlayerOption", "target": "game"}
2017-01-31 17:09:39,596 INFO     fa.game_connection.GPGNetConnection GC >> : ClearSlot : [3]
2017-01-31 17:09:39,596 INFO     fa.game_session.GameSession    Incoming GPGNet: ClearSlot [3]
2017-01-31 17:09:39,596 INFO     fa.game_session.GameSession    Outgoing relay message ClearSlot [3]
2017-01-31 17:09:39,596 INFO     client._clientwindow           Outgoing JSON Message: {"args": [3], "command": "ClearSlot", "target": "game"}
2017-01-31 17:09:39,599 INFO     fa.game_connection.GPGNetConnection GC >> : PlayerOption : [u'98561', u'Faction', 2]
2017-01-31 17:09:39,599 INFO     fa.game_session.GameSession    Incoming GPGNet: PlayerOption [u'98561', u'Faction', 2]
2017-01-31 17:09:39,599 INFO     fa.game_session.GameSession    Outgoing relay message PlayerOption [u'98561', u'Faction', 2]
2017-01-31 17:09:39,599 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["98561", "Faction", 2], "command": "PlayerOption", "target": "game"}
2017-01-31 17:09:39,599 INFO     fa.game_connection.GPGNetConnection GC >> : PlayerOption : [u'98561', u'Color', 8]
2017-01-31 17:09:39,599 INFO     fa.game_session.GameSession    Incoming GPGNet: PlayerOption [u'98561', u'Color', 8]
2017-01-31 17:09:39,599 INFO     fa.game_session.GameSession    Outgoing relay message PlayerOption [u'98561', u'Color', 8]
2017-01-31 17:09:39,599 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["98561", "Color", 8], "command": "PlayerOption", "target": "game"}
2017-01-31 17:09:39,599 INFO     fa.game_connection.GPGNetConnection GC >> : PlayerOption : [u'98561', u'Team', 2]
2017-01-31 17:09:39,599 INFO     fa.game_session.GameSession    Incoming GPGNet: PlayerOption [u'98561', u'Team', 2]
2017-01-31 17:09:39,599 INFO     fa.game_session.GameSession    Outgoing relay message PlayerOption [u'98561', u'Team', 2]
2017-01-31 17:09:39,599 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["98561", "Team", 2], "command": "PlayerOption", "target": "game"}
2017-01-31 17:09:39,599 INFO     fa.game_connection.GPGNetConnection GC >> : PlayerOption : [u'98561', u'StartSpot', 1]
2017-01-31 17:09:39,599 INFO     fa.game_session.GameSession    Incoming GPGNet: PlayerOption [u'98561', u'StartSpot', 1]
2017-01-31 17:09:39,599 INFO     fa.game_session.GameSession    Outgoing relay message PlayerOption [u'98561', u'StartSpot', 1]
2017-01-31 17:09:39,599 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["98561", "StartSpot", 1], "command": "PlayerOption", "target": "game"}
2017-01-31 17:10:16,701 INFO     connectivity.relay.Relay       Allocating local relay for BesMarcell, 38518
2017-01-31 17:10:16,701 INFO     fa.game_session.GameSession    Bound peer BesMarcell/38518 to 62631
2017-01-31 17:10:16,701 INFO     fa.game_connection.GPGNetConnection GC<<: ConnectToPeer:('127.0.0.1:62631', u'BesMarcell', 38518)
2017-01-31 17:10:16,703 INFO     fa.game_connection.GPGNetConnection GC >> : Disconnected : [u'38518']
2017-01-31 17:10:16,703 INFO     fa.game_session.GameSession    Incoming GPGNet: Disconnected [u'38518']
2017-01-31 17:10:16,703 INFO     fa.game_session.GameSession    Outgoing relay message Disconnected [u'38518']
2017-01-31 17:10:16,703 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["38518"], "command": "Disconnected", "target": "game"}
2017-01-31 17:10:27,684 INFO     downloadManager                Searching map preview for: zero point5.v0001 from http://content.faforever.com/faf/vault/map_previews/small/zero point5.v0001.png
2017-01-31 17:10:27,796 INFO     downloadManager                Finished download from http://content.faforever.com/faf/vault/map_previews/small/zero point5.v0001.png
2017-01-31 17:10:38,240 INFO     fa.game_connection.GPGNetConnection GC<<: DisconnectFromPeer:(38518,)
2017-01-31 17:10:38,240 INFO     fa.game_connection.GPGNetConnection GC >> : Disconnected : [u'38518']
2017-01-31 17:10:38,240 INFO     fa.game_session.GameSession    Incoming GPGNet: Disconnected [u'38518']
2017-01-31 17:10:38,240 INFO     fa.game_session.GameSession    Outgoing relay message Disconnected [u'38518']
2017-01-31 17:10:38,240 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["38518"], "command": "Disconnected", "target": "game"}
2017-01-31 17:10:44,461 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["67.168.226.166:58069", "Hello from 137948"], "command": "ProcessNatPacket", "target": "connectivity"}
2017-01-31 17:10:44,461 INFO     connectivity.helper.ConnectivityHelper Unknown natpacket
2017-01-31 17:10:44,467 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["67.168.226.166:58069", "Hello from 137948"], "command": "ProcessNatPacket", "target": "connectivity"}
2017-01-31 17:10:44,467 INFO     connectivity.helper.ConnectivityHelper Unknown natpacket
2017-01-31 17:10:44,467 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["67.168.226.166:58069", "Hello from 137948"], "command": "ProcessNatPacket", "target": "connectivity"}
2017-01-31 17:10:44,467 INFO     connectivity.helper.ConnectivityHelper Unknown natpacket
2017-01-31 17:10:48,503 INFO     fa.game_connection.GPGNetConnection GC<<: DisconnectFromPeer:(137948,)
2017-01-31 17:10:48,503 INFO     fa.game_connection.GPGNetConnection GC >> : Disconnected : [u'137948']
2017-01-31 17:10:48,503 INFO     fa.game_session.GameSession    Incoming GPGNet: Disconnected [u'137948']
2017-01-31 17:10:48,503 INFO     fa.game_session.GameSession    Outgoing relay message Disconnected [u'137948']
2017-01-31 17:10:48,503 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["137948"], "command": "Disconnected", "target": "game"}
2017-01-31 17:10:57,473 INFO     connectivity.relay.Relay       Allocating local relay for BesMarcell, 38518
2017-01-31 17:10:57,473 INFO     fa.game_session.GameSession    Bound peer BesMarcell/38518 to 52944
2017-01-31 17:10:57,473 INFO     fa.game_connection.GPGNetConnection GC<<: ConnectToPeer:('127.0.0.1:52944', u'BesMarcell', 38518)
2017-01-31 17:10:57,474 INFO     fa.game_connection.GPGNetConnection GC >> : Disconnected : [u'38518']
2017-01-31 17:10:57,474 INFO     fa.game_session.GameSession    Incoming GPGNet: Disconnected [u'38518']
2017-01-31 17:10:57,474 INFO     fa.game_session.GameSession    Outgoing relay message Disconnected [u'38518']
2017-01-31 17:10:57,474 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["38518"], "command": "Disconnected", "target": "game"}
2017-01-31 17:11:13,460 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["67.168.226.166:58069", "Hello from 137948"], "command": "ProcessNatPacket", "target": "connectivity"}
2017-01-31 17:11:13,461 INFO     connectivity.helper.ConnectivityHelper Unknown natpacket
2017-01-31 17:11:13,466 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["67.168.226.166:58069", "Hello from 137948"], "command": "ProcessNatPacket", "target": "connectivity"}
2017-01-31 17:11:13,466 INFO     connectivity.helper.ConnectivityHelper Unknown natpacket
2017-01-31 17:11:13,466 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["67.168.226.166:58069", "Hello from 137948"], "command": "ProcessNatPacket", "target": "connectivity"}
2017-01-31 17:11:13,466 INFO     connectivity.helper.ConnectivityHelper Unknown natpacket
2017-01-31 17:11:17,502 INFO     fa.game_connection.GPGNetConnection GC<<: DisconnectFromPeer:(137948,)
2017-01-31 17:11:17,502 INFO     fa.game_connection.GPGNetConnection GC >> : Disconnected : [u'137948']
2017-01-31 17:11:17,502 INFO     fa.game_session.GameSession    Incoming GPGNet: Disconnected [u'137948']
2017-01-31 17:11:17,502 INFO     fa.game_session.GameSession    Outgoing relay message Disconnected [u'137948']
2017-01-31 17:11:17,502 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["137948"], "command": "Disconnected", "target": "game"}
2017-01-31 17:12:36,704 INFO     fa.game_connection.GPGNetConnection GC<<: DisconnectFromPeer:(38518,)
2017-01-31 17:12:36,706 INFO     fa.game_connection.GPGNetConnection GC >> : Disconnected : [u'38518']
2017-01-31 17:12:36,706 INFO     fa.game_session.GameSession    Incoming GPGNet: Disconnected [u'38518']
2017-01-31 17:12:36,706 INFO     fa.game_session.GameSession    Outgoing relay message Disconnected [u'38518']
2017-01-31 17:12:36,706 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["38518"], "command": "Disconnected", "target": "game"}
2017-01-31 17:13:45,038 INFO     client._clientwindow           FA has finished with exit code: 0
2017-01-31 17:13:45,038 INFO     fa.game_session.GameSession    Game has exited with status code: 0
2017-01-31 17:13:45,038 INFO     fa.game_session.GameSession    Outgoing relay message GameState ['Ended']
2017-01-31 17:13:45,038 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["Ended"], "command": "GameState", "target": "game"}
2017-01-31 17:13:49,323 INFO     client._clientwindow           Close Event for Application Main Window
2017-01-31 17:13:49,335 WARNING  client._clientwindow           Disconnected from lobby server.
2017-01-31 17:13:49,335 INFO     fa.upnp                        Removing UPnP port mapping.
2017-01-31 17:13:49,362 INFO     fa.upnp                        -> UDP mapping of 192.168.1.176:7002 to 85.191.88.165:7002
2017-01-31 17:13:49,387 INFO     __main__                       <<< --------------------------- Application Shutdown
2017-01-31 17:13:51,210 INFO     root                           FAF version: 0.12.0-pre2  + 1174 Environment: production
2017-01-31 17:13:51,213 INFO     util                           PERSONAL_DIR initial: C:\Users\Anders\Documents
2017-01-31 17:13:51,213 INFO     util                           PERSONAL_DIR final: C:\Users\Anders\Documents
2017-01-31 17:13:51,279 INFO     __main__                       >>> --------------------------- Application Launch
2017-01-31 17:13:51,434 INFO     faf.secondaryServer.Statistic  Instantiating secondary server.
2017-01-31 17:13:51,443 INFO     util                           Read common stylesheet: client/client.css
2017-01-31 17:13:51,499 INFO     util                           Read common stylesheet: stats/formatters/style.css
2017-01-31 17:13:51,507 INFO     faf.secondaryServer.Tournament Instantiating secondary server.
2017-01-31 17:13:51,509 INFO     util                           Read common stylesheet: tournaments/formatters/style.css
2017-01-31 17:13:52,257 INFO     replays._replayswidget         Replays Widget instantiated.
2017-01-31 17:13:52,259 INFO     tutorials._tutorialswidget     Tutorials instantiated.
2017-01-31 17:13:52,265 INFO     util                           Read common stylesheet: coop/formatters/style.css
2017-01-31 17:13:52,278 INFO     fa.replayserver                listening on address 127.0.0.1:15000
2017-01-31 17:13:52,348 INFO     client._clientwindow           Outgoing JSON Message: {"version": "0.12.0-pre2  + 1174", "command": "ask_session", "user_agent": "faf-client"}
2017-01-31 17:13:54,802 INFO     client._clientwindow           Logging in with {'login': u'Blackwaters', 'session': '4151037644', 'command': 'hello', 'unique_id': [b] *REMOVED by myself*[/b]

2017-01-31 17:13:54,934 INFO     fa.upnp                        UPnP mapping 192.168.1.176:7002
2017-01-31 17:13:55,052 INFO     fa.upnp                        -> UDP mapping of 192.168.1.176:7002 to 85.191.88.165:7002
2017-01-31 17:13:55,065 INFO     chat._chatwidget               Connecting to IRC at: irc.faforever.com:6667. TLS: False
2017-01-31 17:13:55,118 INFO     connectivity.qturnsocket.QTurnSocket Turn socket initialized: faforever.com
2017-01-31 17:13:55,118 INFO     client._clientwindow           Outgoing JSON Message: {"args": [7002], "command": "InitiateTest", "target": "connectivity"}
2017-01-31 17:13:55,243 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["37.58.123.3:3535", "Are you public? 98561"], "command": "ProcessNatPacket", "target": "connectivity"}
2017-01-31 17:13:55,243 INFO     connectivity.helper.ConnectivityHelper Unknown natpacket
2017-01-31 17:13:55,243 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["37.58.123.3:3535", "Are you public? 98561"], "command": "ProcessNatPacket", "target": "connectivity"}
2017-01-31 17:13:55,243 INFO     connectivity.helper.ConnectivityHelper Unknown natpacket
2017-01-31 17:13:55,243 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["37.58.123.3:3535", "Are you public? 98561"], "command": "ProcessNatPacket", "target": "connectivity"}
2017-01-31 17:13:55,243 INFO     connectivity.helper.ConnectivityHelper Unknown natpacket
2017-01-31 17:13:55,457 INFO     downloadManager                Searching map preview for: operation (yath-aez) from http://content.faforever.com/faf/vault/map_previews/small/operation %28yath-aez%29.png
2017-01-31 17:13:55,569 INFO     connectivity.helper.ConnectivityHelper Connectivity state is PUBLIC, mapped address: 85.191.88.165:7002
2017-01-31 17:13:55,588 INFO     downloadManager                Finished download from http://content.faforever.com/faf/vault/map_previews/small/operation %28yath-aez%29.png
2017-01-31 17:14:04,076 INFO     fa.check                       Checking FA for: faf and map None
2017-01-31 17:14:04,076 INFO     fa.check                       Version unknown, assuming latest
2017-01-31 17:14:04,076 INFO     fa.check                       Updating FA for mod: faf, version None
2017-01-31 17:14:04,076 INFO     fa.check                       Writing fa_path.lua config file.
2017-01-31 17:14:04,775 INFO     client._clientwindow           Outgoing JSON Message: {"title": "2v2 700-1300 good cpu", "visibility": "public", "is_rehost": false, "mapname": "2v2 sand box.v0001", "command": "game_host", "password": null, "mod": "faf"}
2017-01-31 17:14:04,859 ERROR    client._clientwindow           Not ready for game launch


Friends FAforever log trying to join my game:

http://pastebin.com/VxhKst43

Code:
2017-01-31 08:14:59,157 INFO     fa.check                       Map is available.
2017-01-31 08:14:59,157 INFO     connectivity.turn              Requesting relay allocation
2017-01-31 08:14:59,345 INFO     connectivity.turn              Relay allocated: ('37.58.123.3', 58202L)
2017-01-31 08:14:59,345 INFO     connectivity.qturnsocket.QTurnSocket TURN state changed: TURNState.BOUND
2017-01-31 08:14:59,345 INFO     client._clientwindow           Outgoing JSON Message: {"relay_address": ["37.58.123.3", 58202], "command": "game_join", "uid": 5740423, "gameport": 6112}
2017-01-31 08:14:59,345 INFO     connectivity.turn              Permitting sends from ('67.168.226.166', 57597L)
2017-01-31 08:14:59,345 INFO     connectivity.turn              Permitting sends from ('37.58.123.2', 6112)
2017-01-31 08:14:59,346 INFO     connectivity.turn              Permitting sends from ('37.58.123.3', 6112)
2017-01-31 08:14:59,532 INFO     client._clientwindow           Handling game_launch via JSON {u'args': [u'/numgames 155'], u'command': u'game_launch', u'uid': 5740423, u'mod': u'faf'}
2017-01-31 08:14:59,532 INFO     fa.upnp                        UPnP mapping 10.0.0.241:6112
2017-01-31 08:14:59,538 ERROR    fa.upnp                        Couldn't get StaticPortMappingCollection

Statistics: Posted by Blackwaters — 31 Jan 2017, 18:30


]]>
2017-01-31T18:33:30+02:00 2017-01-31T18:28:54+02:00 /viewtopic.php?t=13946&p=142809#p142809 <![CDATA[Connection issues]]>
Recently we got our connection upgraded from a 65/65mbit connection to a 300/300. The ISP did setup a new box with us when they did this upgrade. After calling them they enabled UPnP in the router which I was unable to do myself. This does not seem to be better though. The old connection used a modem and my own router behind it where the new system the ISP put up is a router in it self that I am directly connected to.

I have since the upgrade had connection issues in many games, but FAF is the only one where port forwarding does not work. I tried changing it from 6112 to 7002 and opening UDP to both. I also tried TCP and UDP for both ports. Nothing here has worked so far. Joining others I will often see "connecting" to a player name for most players inside a lobby, yet everyone else connects fine.

I should say the ports to report as open using portforwardings tool.

When we do get a game up and running I often disconnect after 10-20 minutes of playtime from everyone in the game, yet when I quit the game will continue as I am the problem. Any help would be appreciated as there is nothing better than the end a long day with some good games of FAF.

Statistics: Posted by Blackwaters — 31 Jan 2017, 18:28


]]>