Forged Alliance Forever Forged Alliance Forever Forums 2013-09-26T17:49:45+02:00 /feed.php?f=26&t=5272 2013-09-26T17:49:45+02:00 2013-09-26T17:49:45+02:00 /viewtopic.php?t=5272&p=54549#p54549 <![CDATA[Re: Connection issues]]>
It's hard to say it's your fault or his fault as I've only one side of the logs, but let's assume it's a problem on your side.

You probably should check your firewall settings.

Statistics: Posted by Ze_PilOt — 26 Sep 2013, 17:49


]]>
2013-09-26T17:38:26+02:00 2013-09-26T17:38:26+02:00 /viewtopic.php?t=5272&p=54547#p54547 <![CDATA[Re: Connection issues]]>
Code:
2013-09-26 17:03:59,908 INFO     faf.main             >>> --------------------------- Application Launch
2013-09-26 17:04:00,765 DEBUG    faf.fa.relayserver   initializing...
2013-09-26 17:04:00,766 INFO     faf.fa.proxies       binding socket 0 on port 12001
2013-09-26 17:04:00,766 INFO     faf.fa.proxies       binding socket 1 on port 12002
2013-09-26 17:04:00,766 INFO     faf.fa.proxies       binding socket 2 on port 12003
2013-09-26 17:04:00,766 INFO     faf.fa.proxies       binding socket 3 on port 12004
2013-09-26 17:04:00,766 INFO     faf.fa.proxies       binding socket 4 on port 12005
2013-09-26 17:04:00,767 INFO     faf.fa.proxies       binding socket 5 on port 12006
2013-09-26 17:04:00,767 INFO     faf.fa.proxies       binding socket 6 on port 12007
2013-09-26 17:04:00,767 INFO     faf.fa.proxies       binding socket 7 on port 12008
2013-09-26 17:04:00,767 INFO     faf.fa.proxies       binding socket 8 on port 12009
2013-09-26 17:04:00,767 INFO     faf.fa.proxies       binding socket 9 on port 12010
2013-09-26 17:04:00,769 INFO     faf.fa.proxies       binding socket 10 on port 12011
2013-09-26 17:04:00,786 INFO     faf.util             Read common stylesheet: client/client.css
2013-09-26 17:04:00,953 INFO     faf.util             Read common stylesheet: stats/formatters/style.css
2013-09-26 17:04:00,974 INFO     faf.util             Read common stylesheet: tournaments/formatters/style.css
2013-09-26 17:04:00,976 DEBUG    faf.vault            Map Vault tab instantiating
2013-09-26 17:04:02,096 DEBUG    faf.modvault         Mod Vault tab instantiating
2013-09-26 17:04:02,138 DEBUG    faf.modvault         getting installed mods. Count: 18
2013-09-26 17:04:02,157 INFO     faf.replays          Replays Widget instantiated.
2013-09-26 17:04:02,163 INFO     faf.tutorials        Tutorials instantiated.
2013-09-26 17:04:02,164 DEBUG    faf.galacticWar      Lobby instantiating.
2013-09-26 17:04:02,165 DEBUG    faf.galacticWar      GW options instantiating.
2013-09-26 17:04:02,194 INFO     faf.fa.replayserver  listening on address 127.0.0.1:15000
2013-09-26 17:04:02,194 INFO     faf.fa.relayserver   relay listening on address 127.0.0.1:53146
2013-09-26 17:04:03,309 INFO     faf.client           Outgoing JSON Message: {"command": "ask_session"}
2013-09-26 17:04:07,614 INFO     faf.client           Attempting to login as: Lame
2013-09-26 17:04:07,615 INFO     faf.client           Outgoing JSON Message: login.
2013-09-26 17:04:08,150 INFO     faf.client           Login accepted.
2013-09-26 17:04:08,154 INFO     faf.fa.upnp          Creating UPnP port mappings...
2013-09-26 17:04:08,436 ERROR    faf.fa.upnp          Couldn't get StaticPortMappingCollection
2013-09-26 17:04:08,437 INFO     faf.client           The game port is now set to 6112
2013-09-26 17:04:08,437 INFO     faf.client           sending packet to direct.faforever.com
2013-09-26 17:04:20,036 INFO     faf.client           Outgoing JSON Message: {"command": "coop_list"}
2013-09-26 17:10:48,453 INFO     faf.main             >>> --------------------------- Application Launch
2013-09-26 17:10:48,470 INFO     faf.fa               fa.exe.replay(C:\Users\f***\AppData\Local\Temp\1175508.fafreplay, detach = True
2013-09-26 17:10:48,470 INFO     faf.fa               Extracted 0 bytes of binary data from .fafreplay.
2013-09-26 17:10:48,470 ERROR    faf.main             Uncaught exception
Traceback (most recent call last):
  File "main.py", line 122, in <module>
  File "fa\exe.pyc", line 164, in replay
  File "fa\replayparser.pyc", line 50, in getVersion
  File "fa\replayparser.pyc", line 33, in __readLine
error: unpack requires a string argument of length 1
2013-09-26 17:19:20,467 INFO     faf.client           Close Event for Application Main Window
2013-09-26 17:19:20,480 WARNING  faf.client           Disconnected from lobby server.
2013-09-26 17:19:20,480 INFO     faf.tourneys         Disconnected from server
2013-09-26 17:19:20,480 INFO     faf.fa.upnp          Removing UPnP port mappings...
2013-09-26 17:19:20,484 ERROR    faf.fa.upnp          Couldn't get StaticPortMappingCollection
2013-09-26 17:19:20,494 INFO     faf.main             <<< --------------------------- Application Shutdown
2013-09-26 17:20:11,101 INFO     faf.main             >>> --------------------------- Application Launch
2013-09-26 17:20:11,934 DEBUG    faf.fa.relayserver   initializing...
2013-09-26 17:20:11,936 INFO     faf.fa.proxies       binding socket 0 on port 12001
2013-09-26 17:20:11,936 INFO     faf.fa.proxies       binding socket 1 on port 12002
2013-09-26 17:20:11,936 INFO     faf.fa.proxies       binding socket 2 on port 12003
2013-09-26 17:20:11,937 INFO     faf.fa.proxies       binding socket 3 on port 12004
2013-09-26 17:20:11,937 INFO     faf.fa.proxies       binding socket 4 on port 12005
2013-09-26 17:20:11,937 INFO     faf.fa.proxies       binding socket 5 on port 12006
2013-09-26 17:20:11,937 INFO     faf.fa.proxies       binding socket 6 on port 12007
2013-09-26 17:20:11,937 INFO     faf.fa.proxies       binding socket 7 on port 12008
2013-09-26 17:20:11,937 INFO     faf.fa.proxies       binding socket 8 on port 12009
2013-09-26 17:20:11,937 INFO     faf.fa.proxies       binding socket 9 on port 12010
2013-09-26 17:20:11,937 INFO     faf.fa.proxies       binding socket 10 on port 12011
2013-09-26 17:20:11,953 INFO     faf.util             Read common stylesheet: client/client.css
2013-09-26 17:20:12,102 INFO     faf.util             Read common stylesheet: stats/formatters/style.css
2013-09-26 17:20:12,118 INFO     faf.util             Read common stylesheet: tournaments/formatters/style.css
2013-09-26 17:20:12,118 DEBUG    faf.vault            Map Vault tab instantiating
2013-09-26 17:20:13,171 DEBUG    faf.modvault         Mod Vault tab instantiating
2013-09-26 17:20:13,210 DEBUG    faf.modvault         getting installed mods. Count: 18
2013-09-26 17:20:13,227 INFO     faf.replays          Replays Widget instantiated.
2013-09-26 17:20:13,232 INFO     faf.tutorials        Tutorials instantiated.
2013-09-26 17:20:13,232 DEBUG    faf.galacticWar      Lobby instantiating.
2013-09-26 17:20:13,233 DEBUG    faf.galacticWar      GW options instantiating.
2013-09-26 17:20:13,262 INFO     faf.fa.replayserver  listening on address 127.0.0.1:15000
2013-09-26 17:20:13,263 INFO     faf.fa.relayserver   relay listening on address 127.0.0.1:53400
2013-09-26 17:20:14,368 INFO     faf.client           Outgoing JSON Message: {"command": "ask_session"}
2013-09-26 17:20:16,838 INFO     faf.client           Attempting to login as: Lame
2013-09-26 17:20:16,839 INFO     faf.client           Outgoing JSON Message: login.
2013-09-26 17:20:17,130 INFO     faf.client           Login accepted.
2013-09-26 17:20:17,131 INFO     faf.fa.upnp          Creating UPnP port mappings...
2013-09-26 17:20:17,148 ERROR    faf.fa.upnp          Couldn't get StaticPortMappingCollection
2013-09-26 17:20:17,148 INFO     faf.client           The game port is now set to 6112
2013-09-26 17:20:17,148 INFO     faf.client           sending packet to direct.faforever.com
2013-09-26 17:20:41,828 INFO     faf.client           Outgoing JSON Message: {"command": "coop_list"}
2013-09-26 17:20:56,931 INFO     faf.fa               Checking FA for: ladder1v1 and map None
2013-09-26 17:20:56,931 INFO     faf.fa               Updating FA for mod: ladder1v1, version None
2013-09-26 17:20:56,933 DEBUG    faf.updater          Update started at 2013-09-26 17:20:56
2013-09-26 17:20:56,934 DEBUG    faf.updater          Using game path: Z:\Program Files (x86)\THQ\Supreme Commander Forged Alliance
2013-09-26 17:20:56,934 DEBUG    faf.updater          Using appdata: C:\ProgramData\FAForever
2013-09-26 17:20:57,078 DEBUG    faf.updater          Connected to update server at 2013-09-26 17:20:57
2013-09-26 17:20:57,084 DEBUG    faf.updater          writeToServer(GET_FILES_TO_UPDATE, [FAF])
2013-09-26 17:20:57,115 DEBUG    faf.updater          handleAction(LIST_FILES_TO_UP) - 324 bytes
2013-09-26 17:20:57,115 DEBUG    faf.updater          Files to update: [ForgedAlliance.exe, init_faf.lua, init_ladder1v1.lua, GDFBinary.dll, SupComDataPath.lua, SupComDataPathFAF.lua, init_nonxt.lua]
2013-09-26 17:20:57,117 DEBUG    faf.updater          writeToServer(UPDATE, [bin, init_nonxt.lua, 46d9008f6b77d2c60f96272a816e4227])
2013-09-26 17:20:57,118 DEBUG    faf.updater          writeToServer(UPDATE, [bin, GDFBinary.dll, 3fc9e7684d150da5c51db71d2399f316])
2013-09-26 17:20:57,119 DEBUG    faf.updater          writeToServer(UPDATE, [bin, init_faf.lua, 7d5cebd90024c4c5dc44ae8f5c9fa35b])
2013-09-26 17:20:57,155 DEBUG    faf.updater          writeToServer(UPDATE, [bin, ForgedAlliance.exe, b779d298a8ac4412dfbcc7667cf5578f])
2013-09-26 17:20:57,157 DEBUG    faf.updater          writeToServer(UPDATE, [bin, SupComDataPath.lua, 55ac1ef97845f2291da64b830299331e])
2013-09-26 17:20:57,158 DEBUG    faf.updater          writeToServer(UPDATE, [bin, SupComDataPathFAF.lua, 962c9d1327657d77184adcf358c628f1])
2013-09-26 17:20:57,161 DEBUG    faf.updater          writeToServer(UPDATE, [bin, init_ladder1v1.lua, ea96ac9cec88af29c08556c96465acfe])
2013-09-26 17:20:57,197 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 56 bytes
2013-09-26 17:20:57,198 DEBUG    faf.updater          file : init_nonxt.lua
2013-09-26 17:20:57,198 DEBUG    faf.updater          init_nonxt.lua is up to date.
2013-09-26 17:20:57,431 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 54 bytes
2013-09-26 17:20:57,431 DEBUG    faf.updater          file : GDFBinary.dll
2013-09-26 17:20:57,433 DEBUG    faf.updater          GDFBinary.dll is up to date.
2013-09-26 17:20:57,433 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 52 bytes
2013-09-26 17:20:57,434 DEBUG    faf.updater          file : init_faf.lua
2013-09-26 17:20:57,434 DEBUG    faf.updater          init_faf.lua is up to date.
2013-09-26 17:20:57,434 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 64 bytes
2013-09-26 17:20:57,434 DEBUG    faf.updater          file : ForgedAlliance.exe
2013-09-26 17:20:57,434 DEBUG    faf.updater          ForgedAlliance.exe is up to date.
2013-09-26 17:20:57,436 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 64 bytes
2013-09-26 17:20:57,436 DEBUG    faf.updater          file : SupComDataPath.lua
2013-09-26 17:20:57,436 DEBUG    faf.updater          SupComDataPath.lua is up to date.
2013-09-26 17:20:57,437 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 70 bytes
2013-09-26 17:20:57,437 DEBUG    faf.updater          file : SupComDataPathFAF.lua
2013-09-26 17:20:57,437 DEBUG    faf.updater          SupComDataPathFAF.lua is up to date.
2013-09-26 17:20:57,440 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 64 bytes
2013-09-26 17:20:57,440 DEBUG    faf.updater          file : init_ladder1v1.lua
2013-09-26 17:20:57,440 DEBUG    faf.updater          init_ladder1v1.lua is up to date.
2013-09-26 17:20:57,440 DEBUG    faf.updater          Updates applied successfully.
2013-09-26 17:20:57,440 DEBUG    faf.updater          writeToServer(GET_FILES_TO_UPDATE, [FAFGAMEDATA])
2013-09-26 17:20:57,470 DEBUG    faf.updater          handleAction(LIST_FILES_TO_UP) - 134 bytes
2013-09-26 17:20:57,471 DEBUG    faf.updater          Files to update: [faforever.faf, faforever.nxt, lobby.nxt]
2013-09-26 17:20:57,483 DEBUG    faf.updater          writeToServer(UPDATE, [gamedata, faforever.faf, 01918c842de543150cfc20cd511986ac])
2013-09-26 17:20:57,696 DEBUG    faf.updater          writeToServer(UPDATE, [gamedata, faforever.nxt, e046d2c5af04f78aca023941c1abd949])
2013-09-26 17:20:57,723 DEBUG    faf.updater          writeToServer(UPDATE, [gamedata, lobby.nxt, 9e6521423cc955e2cfb821839d482226])
2013-09-26 17:20:57,757 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 54 bytes
2013-09-26 17:20:57,759 DEBUG    faf.updater          file : faforever.faf
2013-09-26 17:20:57,759 DEBUG    faf.updater          faforever.faf is up to date.
2013-09-26 17:20:58,069 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 54 bytes
2013-09-26 17:20:58,069 DEBUG    faf.updater          file : faforever.nxt
2013-09-26 17:20:58,069 DEBUG    faf.updater          faforever.nxt is up to date.
2013-09-26 17:20:58,069 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 46 bytes
2013-09-26 17:20:58,071 DEBUG    faf.updater          file : lobby.nxt
2013-09-26 17:20:58,071 DEBUG    faf.updater          lobby.nxt is up to date.
2013-09-26 17:20:58,071 DEBUG    faf.updater          Updates applied successfully.
2013-09-26 17:20:58,071 DEBUG    faf.updater          Disconnected from server at 2013-09-26 17:20:58
2013-09-26 17:20:58,115 DEBUG    faf.updater          Update finished at 2013-09-26 17:20:58
2013-09-26 17:20:58,115 INFO     faf.fa               Writing fa_path.lua config file.
2013-09-26 17:20:58,127 INFO     faf.fa.upnp          Creating UPnP port mappings...
2013-09-26 17:20:58,128 ERROR    faf.fa.upnp          Couldn't get StaticPortMappingCollection
2013-09-26 17:20:58,130 INFO     faf.games            Starting Ranked Search as /seraphim, port: 6112
2013-09-26 17:20:58,131 INFO     faf.client           Outgoing JSON Message: {"state": "start", "mod": "ladder1v1", "command": "game_matchmaking", "faction": "/seraphim", "gameport": 6112}
2013-09-26 17:20:58,236 INFO     faf.client           Handling game_launch via JSON {u'uid': 1337075, u'args': [u'/players 2', u'/team 1'], u'mapname': u'twin rivers.v0001', u'reason': u'ranked', u'command': u'game_launch', u'mod': u'ladder1v1'}
2013-09-26 17:20:58,237 INFO     faf.fa               Updating FA for map: twin rivers.v0001
2013-09-26 17:20:58,237 INFO     faf.fa               Map is available.
2013-09-26 17:20:58,239 INFO     faf.fa.upnp          Creating UPnP port mappings...
2013-09-26 17:20:58,242 ERROR    faf.fa.upnp          Couldn't get StaticPortMappingCollection
2013-09-26 17:20:58,242 INFO     faf.fa               Running FA with info: {'recorder': u'Lame', 'game_time': 1380208858.242, 'uid': 1337075, 'version_info': {'lobby': '0.8.80'}, 'featured_mod': u'ladder1v1'}
2013-09-26 17:20:58,242 INFO     faf.fa               Running FA via command: "C:\ProgramData\FAForever\bin\ForgedAlliance.exe" /players 2 /team 1 /seraphim /mean 1255.17 /deviation 47.1683 /init init_ladder1v1.lua /log "C:\ProgramData\FAForever\logs\game.log" /savereplay gpgnet://localhost/1337075/Lame.SCFAreplay /nobugreport /gpgnet 127.0.0.1:53400
2013-09-26 17:20:58,263 INFO     faf.client           FA has launched in an attached process.
2013-09-26 17:20:58,263 INFO     faf.client           Outgoing JSON Message: {"state": "on", "command": "fa_state"}
2013-09-26 17:20:58,263 DEBUG    faf.games            Stopping Ranked Search
2013-09-26 17:20:58,263 INFO     faf.client           Outgoing JSON Message: {"state": "stop", "command": "game_matchmaking", "mod": "ladder1v1"}
2013-09-26 17:21:05,858 DEBUG    faf.fa.relayserver   incoming connection to relay server...
2013-09-26 17:21:05,859 INFO     faf.fa.relayer       FA connected locally.
2013-09-26 17:21:05,888 DEBUG    faf.fa.relayer       faf server direct.faforever.com:8000
2013-09-26 17:21:05,888 DEBUG    faf.fa.relayer       Initializing ping timer
2013-09-26 17:21:05,888 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "GameState", "chuncks": ["Idle"]}
2013-09-26 17:21:05,920 INFO     faf.fa.relayer       Command received from server : {"commands": [1, 6112, "Lame", 63192, 1], "key": "CreateLobby"}
2013-09-26 17:21:05,921 INFO     faf.fa.relayer       Command received from server : {"commands": ["91.121.153.175:30351", "/PLAYERID 63192 Lame"], "key": "SendNatPacket"}
2013-09-26 17:21:06,118 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "GameState", "chuncks": ["Lobby"]}
2013-09-26 17:21:06,147 INFO     faf.fa.relayer       Command received from server : {"commands": ["91.121.153.175:30351", "/PLAYERID 63192 Lame"], "key": "SendNatPacket"}
2013-09-26 17:21:06,329 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "ProcessNatPacket", "chuncks": ["91.121.153.175:30351", "PACKET_RECEIVED 6117"]}
2013-09-26 17:21:06,359 INFO     faf.fa.relayer       Command received from server : {"commands": ["twin rivers.v0001"], "key": "HostGame"}
2013-09-26 17:21:06,361 INFO     faf.fa.relayer       Command received from server : {"commands": ["91.121.153.175:30351", "/PLAYERID 63192 Lame"], "key": "SendNatPacket"}
2013-09-26 17:21:06,361 INFO     faf.client           port used : 6117
2013-09-26 17:21:36,924 INFO     faf.fa.relayer       Command received from server : {"commands": [], "key": "ping"}
2013-09-26 17:22:07,926 INFO     faf.fa.relayer       Command received from server : {"commands": [], "key": "ping"}
2013-09-26 17:22:38,927 INFO     faf.fa.relayer       Command received from server : {"commands": [], "key": "ping"}
2013-09-26 17:22:51,887 INFO     faf.fa.relayer       FA disconnected locally.
2013-09-26 17:22:51,887 INFO     faf.fa.relayer       remove relay
2013-09-26 17:22:51,887 DEBUG    faf.fa.relayer       destructor called
2013-09-26 17:22:53,970 INFO     faf.client           FA has finished with exit code: 0
2013-09-26 17:22:53,970 INFO     faf.client           Outgoing JSON Message: {"state": "off", "command": "fa_state"}
2013-09-26 17:22:53,970 INFO     faf.chat             autopostjoin: true
2013-09-26 17:33:17,724 INFO     faf.fa               Checking FA for: ladder1v1 and map None
2013-09-26 17:33:17,726 INFO     faf.fa               Updating FA for mod: ladder1v1, version None
2013-09-26 17:33:17,726 DEBUG    faf.updater          Update started at 2013-09-26 17:33:17
2013-09-26 17:33:17,726 DEBUG    faf.updater          Using game path: Z:\Program Files (x86)\THQ\Supreme Commander Forged Alliance
2013-09-26 17:33:17,726 DEBUG    faf.updater          Using appdata: C:\ProgramData\FAForever
2013-09-26 17:33:20,729 DEBUG    faf.updater          Connected to update server at 2013-09-26 17:33:20
2013-09-26 17:33:20,733 DEBUG    faf.updater          writeToServer(GET_FILES_TO_UPDATE, [FAF])
2013-09-26 17:33:20,780 DEBUG    faf.updater          handleAction(LIST_FILES_TO_UP) - 324 bytes
2013-09-26 17:33:20,782 DEBUG    faf.updater          Files to update: [ForgedAlliance.exe, init_faf.lua, init_ladder1v1.lua, GDFBinary.dll, SupComDataPath.lua, SupComDataPathFAF.lua, init_nonxt.lua]
2013-09-26 17:33:20,782 DEBUG    faf.updater          writeToServer(UPDATE, [bin, init_nonxt.lua, 46d9008f6b77d2c60f96272a816e4227])
2013-09-26 17:33:20,785 DEBUG    faf.updater          writeToServer(UPDATE, [bin, GDFBinary.dll, 3fc9e7684d150da5c51db71d2399f316])
2013-09-26 17:33:20,786 DEBUG    faf.updater          writeToServer(UPDATE, [bin, init_faf.lua, 7d5cebd90024c4c5dc44ae8f5c9fa35b])
2013-09-26 17:33:20,821 DEBUG    faf.updater          writeToServer(UPDATE, [bin, ForgedAlliance.exe, b779d298a8ac4412dfbcc7667cf5578f])
2013-09-26 17:33:20,822 DEBUG    faf.updater          writeToServer(UPDATE, [bin, SupComDataPath.lua, 55ac1ef97845f2291da64b830299331e])
2013-09-26 17:33:20,822 DEBUG    faf.updater          writeToServer(UPDATE, [bin, SupComDataPathFAF.lua, 962c9d1327657d77184adcf358c628f1])
2013-09-26 17:33:20,825 DEBUG    faf.updater          writeToServer(UPDATE, [bin, init_ladder1v1.lua, ea96ac9cec88af29c08556c96465acfe])
2013-09-26 17:33:20,881 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 56 bytes
2013-09-26 17:33:20,881 DEBUG    faf.updater          file : init_nonxt.lua
2013-09-26 17:33:20,881 DEBUG    faf.updater          init_nonxt.lua is up to date.
2013-09-26 17:33:21,127 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 54 bytes
2013-09-26 17:33:21,127 DEBUG    faf.updater          file : GDFBinary.dll
2013-09-26 17:33:21,128 DEBUG    faf.updater          GDFBinary.dll is up to date.
2013-09-26 17:33:21,128 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 52 bytes
2013-09-26 17:33:21,128 DEBUG    faf.updater          file : init_faf.lua
2013-09-26 17:33:21,128 DEBUG    faf.updater          init_faf.lua is up to date.
2013-09-26 17:33:21,130 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 64 bytes
2013-09-26 17:33:21,130 DEBUG    faf.updater          file : ForgedAlliance.exe
2013-09-26 17:33:21,130 DEBUG    faf.updater          ForgedAlliance.exe is up to date.
2013-09-26 17:33:21,131 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 64 bytes
2013-09-26 17:33:21,131 DEBUG    faf.updater          file : SupComDataPath.lua
2013-09-26 17:33:21,131 DEBUG    faf.updater          SupComDataPath.lua is up to date.
2013-09-26 17:33:21,131 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 70 bytes
2013-09-26 17:33:21,131 DEBUG    faf.updater          file : SupComDataPathFAF.lua
2013-09-26 17:33:21,131 DEBUG    faf.updater          SupComDataPathFAF.lua is up to date.
2013-09-26 17:33:21,132 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 64 bytes
2013-09-26 17:33:21,132 DEBUG    faf.updater          file : init_ladder1v1.lua
2013-09-26 17:33:21,132 DEBUG    faf.updater          init_ladder1v1.lua is up to date.
2013-09-26 17:33:21,132 DEBUG    faf.updater          Updates applied successfully.
2013-09-26 17:33:21,132 DEBUG    faf.updater          writeToServer(GET_FILES_TO_UPDATE, [FAFGAMEDATA])
2013-09-26 17:33:21,181 DEBUG    faf.updater          handleAction(LIST_FILES_TO_UP) - 134 bytes
2013-09-26 17:33:21,183 DEBUG    faf.updater          Files to update: [faforever.faf, faforever.nxt, lobby.nxt]
2013-09-26 17:33:21,191 DEBUG    faf.updater          writeToServer(UPDATE, [gamedata, faforever.faf, 01918c842de543150cfc20cd511986ac])
2013-09-26 17:33:21,365 DEBUG    faf.updater          writeToServer(UPDATE, [gamedata, faforever.nxt, e046d2c5af04f78aca023941c1abd949])
2013-09-26 17:33:21,387 DEBUG    faf.updater          writeToServer(UPDATE, [gamedata, lobby.nxt, 9e6521423cc955e2cfb821839d482226])
2013-09-26 17:33:21,438 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 54 bytes
2013-09-26 17:33:21,438 DEBUG    faf.updater          file : faforever.faf
2013-09-26 17:33:21,438 DEBUG    faf.updater          faforever.faf is up to date.
2013-09-26 17:33:21,684 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 54 bytes
2013-09-26 17:33:21,684 DEBUG    faf.updater          file : faforever.nxt
2013-09-26 17:33:21,684 DEBUG    faf.updater          faforever.nxt is up to date.
2013-09-26 17:33:21,684 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 46 bytes
2013-09-26 17:33:21,684 DEBUG    faf.updater          file : lobby.nxt
2013-09-26 17:33:21,686 DEBUG    faf.updater          lobby.nxt is up to date.
2013-09-26 17:33:21,686 DEBUG    faf.updater          Updates applied successfully.
2013-09-26 17:33:21,686 DEBUG    faf.updater          Disconnected from server at 2013-09-26 17:33:21
2013-09-26 17:33:21,720 DEBUG    faf.updater          Update finished at 2013-09-26 17:33:21
2013-09-26 17:33:21,721 INFO     faf.fa               Writing fa_path.lua config file.
2013-09-26 17:33:21,732 INFO     faf.fa.upnp          Creating UPnP port mappings...
2013-09-26 17:33:21,734 ERROR    faf.fa.upnp          Couldn't get StaticPortMappingCollection
2013-09-26 17:33:21,734 INFO     faf.games            Starting Ranked Search as /seraphim, port: 6112
2013-09-26 17:33:21,736 INFO     faf.client           Outgoing JSON Message: {"state": "start", "mod": "ladder1v1", "command": "game_matchmaking", "faction": "/seraphim", "gameport": 6112}
2013-09-26 17:33:21,844 INFO     faf.client           Handling game_launch via JSON {u'uid': 1337112, u'args': [u'/players 2', u'/team 1'], u'mapname': u'white firev2', u'reason': u'ranked', u'command': u'game_launch', u'mod': u'ladder1v1'}
2013-09-26 17:33:21,844 INFO     faf.fa               Updating FA for map: white firev2
2013-09-26 17:33:21,845 INFO     faf.fa               Map is available.
2013-09-26 17:33:21,846 INFO     faf.fa.upnp          Creating UPnP port mappings...
2013-09-26 17:33:21,851 ERROR    faf.fa.upnp          Couldn't get StaticPortMappingCollection
2013-09-26 17:33:21,851 INFO     faf.fa               Running FA with info: {'recorder': u'Lame', 'game_time': 1380209601.852, 'uid': 1337112, 'version_info': {'lobby': '0.8.80'}, 'featured_mod': u'ladder1v1'}
2013-09-26 17:33:21,852 INFO     faf.fa               Running FA via command: "C:\ProgramData\FAForever\bin\ForgedAlliance.exe" /players 2 /team 1 /seraphim /mean 1255.17 /deviation 47.1683 /init init_ladder1v1.lua /log "C:\ProgramData\FAForever\logs\game.log" /savereplay gpgnet://localhost/1337112/Lame.SCFAreplay /nobugreport /gpgnet 127.0.0.1:53400
2013-09-26 17:33:21,877 INFO     faf.client           FA has launched in an attached process.
2013-09-26 17:33:21,877 INFO     faf.client           Outgoing JSON Message: {"state": "on", "command": "fa_state"}
2013-09-26 17:33:21,878 DEBUG    faf.games            Stopping Ranked Search
2013-09-26 17:33:21,878 INFO     faf.client           Outgoing JSON Message: {"state": "stop", "command": "game_matchmaking", "mod": "ladder1v1"}
2013-09-26 17:33:29,332 DEBUG    faf.fa.relayserver   incoming connection to relay server...
2013-09-26 17:33:29,332 INFO     faf.fa.relayer       FA connected locally.
2013-09-26 17:33:32,227 DEBUG    faf.fa.relayer       faf server direct.faforever.com:8000
2013-09-26 17:33:32,227 DEBUG    faf.fa.relayer       Initializing ping timer
2013-09-26 17:33:32,227 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "GameState", "chuncks": ["Idle"]}
2013-09-26 17:33:32,299 INFO     faf.fa.relayer       Command received from server : {"commands": [1, 6112, "Lame", 63192, 1], "key": "CreateLobby"}
2013-09-26 17:33:32,299 INFO     faf.fa.relayer       Command received from server : {"commands": ["91.121.153.175:30351", "/PLAYERID 63192 Lame"], "key": "SendNatPacket"}
2013-09-26 17:33:32,354 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "GameState", "chuncks": ["Lobby"]}
2013-09-26 17:33:32,401 INFO     faf.fa.relayer       Command received from server : {"commands": ["white firev2"], "key": "HostGame"}
2013-09-26 17:33:32,477 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "ProcessNatPacket", "chuncks": ["91.121.153.175:30351", "PACKET_RECEIVED 6117"]}
2013-09-26 17:33:32,523 INFO     faf.fa.relayer       Command received from server : {"commands": ["91.121.153.175:30351", "/PLAYERID 63192 Lame"], "key": "SendNatPacket"}
2013-09-26 17:33:32,542 INFO     faf.client           port used : 6117
2013-09-26 17:33:39,895 INFO     faf.fa.relayer       Command received from server : {"commands": ["186.170.174.24:1024", "/PLAYERID 63192 Lame"], "key": "SendNatPacket"}
2013-09-26 17:33:39,897 INFO     faf.fa.relayer       Command received from server : {"commands": ["186.170.174.24:1024", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 17:33:40,140 INFO     faf.fa.relayer       Command received from server : {"commands": ["186.170.174.24:1024", "/PLAYERID 63192 Lame"], "key": "SendNatPacket"}
2013-09-26 17:33:40,140 INFO     faf.fa.relayer       Command received from server : {"commands": ["186.170.174.24:1024", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 17:33:40,390 INFO     faf.fa.relayer       Command received from server : {"commands": ["186.170.174.24:1024", "/PLAYERID 63192 Lame"], "key": "SendNatPacket"}
2013-09-26 17:33:40,390 INFO     faf.fa.relayer       Command received from server : {"commands": ["186.170.174.24:1024", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 17:33:40,638 INFO     faf.fa.relayer       Command received from server : {"commands": ["186.170.174.24:1024", "/PLAYERID 63192 Lame"], "key": "SendNatPacket"}
2013-09-26 17:33:40,640 INFO     faf.fa.relayer       Command received from server : {"commands": ["186.170.174.24:1024", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 17:33:40,890 INFO     faf.fa.relayer       Command received from server : {"commands": ["186.170.174.24:1024", "/PLAYERID 63192 Lame"], "key": "SendNatPacket"}
2013-09-26 17:33:40,890 INFO     faf.fa.relayer       Command received from server : {"commands": ["186.170.174.24:1024", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 17:33:41,134 INFO     faf.fa.relayer       Command received from server : {"commands": ["186.170.174.24:1024", "/PLAYERID 63192 Lame"], "key": "SendNatPacket"}
2013-09-26 17:33:41,134 INFO     faf.fa.relayer       Command received from server : {"commands": ["186.170.174.24:1024", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 17:33:41,134 INFO     faf.fa.relayer       Command received from server : {"commands": ["186.170.174.24:1024", "/PLAYERID 63192 Lame"], "key": "SendNatPacket"}
2013-09-26 17:33:41,134 INFO     faf.fa.relayer       Command received from server : {"commands": ["186.170.174.24:1024", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 17:33:41,372 INFO     faf.fa.relayer       Command received from server : {"commands": ["186.170.174.24:1024", "/PLAYERID 63192 Lame"], "key": "SendNatPacket"}
2013-09-26 17:33:41,372 INFO     faf.fa.relayer       Command received from server : {"commands": ["186.170.174.24:1024", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 17:33:41,611 INFO     faf.fa.relayer       Command received from server : {"commands": ["186.170.174.24:1024", "/PLAYERID 63192 Lame"], "key": "SendNatPacket"}
2013-09-26 17:33:41,611 INFO     faf.fa.relayer       Command received from server : {"commands": ["186.170.174.24:1024", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 17:33:41,855 INFO     faf.fa.relayer       Command received from server : {"commands": ["186.170.174.24:1024", "/PLAYERID 63192 Lame"], "key": "SendNatPacket"}
2013-09-26 17:33:41,855 INFO     faf.fa.relayer       Command received from server : {"commands": ["186.170.174.24:1024", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 17:33:42,098 INFO     faf.fa.relayer       Command received from server : {"commands": ["186.170.174.24:1024", "/PLAYERID 63192 Lame"], "key": "SendNatPacket"}
2013-09-26 17:33:42,098 INFO     faf.fa.relayer       Command received from server : {"commands": ["186.170.174.24:1024", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 17:33:42,348 INFO     faf.fa.relayer       Command received from server : {"commands": ["186.170.174.24:1024", "/PLAYERID 63192 Lame"], "key": "SendNatPacket"}
2013-09-26 17:33:42,348 INFO     faf.fa.relayer       Command received from server : {"commands": ["186.170.174.24:1024", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 17:33:42,348 INFO     faf.fa.relayer       Command received from server : {"commands": ["186.170.174.24:1024", "/PLAYERID 63192 Lame"], "key": "SendNatPacket"}
2013-09-26 17:33:42,349 INFO     faf.fa.relayer       Command received from server : {"commands": ["186.170.174.24:1024", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 17:33:42,598 INFO     faf.fa.relayer       Command received from server : {"commands": ["186.170.174.24:1024", "/PLAYERID 63192 Lame"], "key": "SendNatPacket"}
2013-09-26 17:33:42,598 INFO     faf.fa.relayer       Command received from server : {"commands": ["186.170.174.24:1024", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 17:33:42,848 INFO     faf.fa.relayer       Command received from server : {"commands": ["186.170.174.24:1024", "/PLAYERID 63192 Lame"], "key": "SendNatPacket"}
2013-09-26 17:33:42,848 INFO     faf.fa.relayer       Command received from server : {"commands": ["186.170.174.24:1024", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 17:33:43,091 INFO     faf.fa.relayer       Command received from server : {"commands": ["186.170.174.24:1024", "Hixtory", 58012], "key": "ConnectToPeer"}
2013-09-26 17:33:52,915 INFO     faf.fa.relayer       Command received from server : {"commands": [58012], "key": "DisconnectFromPeer"}
2013-09-26 17:33:52,915 INFO     faf.fa.relayer       Command received from server : {"commands": [0, "186.170.174.24", "Hixtory", 58012], "key": "ConnectToProxy"}
2013-09-26 17:33:52,961 DEBUG    faf.fa.proxies       Setting low delay on socket.
2013-09-26 17:33:52,961 INFO     faf.fa.proxies       Connected to proxy server direct.faforever.com:9123
2013-09-26 17:34:03,299 INFO     faf.fa.relayer       Command received from server : {"commands": [], "key": "ping"}
2013-09-26 17:34:15,312 INFO     faf.fa.relayer       Command received from server : {"commands": [58012], "key": "DisconnectFromPeer"}
2013-09-26 17:34:34,302 INFO     faf.fa.relayer       Command received from server : {"commands": [], "key": "ping"}
2013-09-26 17:35:05,305 INFO     faf.fa.relayer       Command received from server : {"commands": [], "key": "ping"}
2013-09-26 17:35:11,355 INFO     faf.fa.relayer       FA disconnected locally.
2013-09-26 17:35:11,355 INFO     faf.fa.proxies       disconnecting from proxy server
2013-09-26 17:35:11,355 INFO     faf.fa.relayer       remove relay
2013-09-26 17:35:11,355 DEBUG    faf.fa.relayer       destructor called
2013-09-26 17:35:14,134 INFO     faf.client           FA has finished with exit code: 0
2013-09-26 17:35:14,134 INFO     faf.client           Outgoing JSON Message: {"state": "off", "command": "fa_state"}
2013-09-26 17:35:14,135 INFO     faf.chat             autopostjoin: true

Statistics: Posted by Lame — 26 Sep 2013, 17:38


]]>
2013-09-26T17:37:42+02:00 2013-09-26T17:37:42+02:00 /viewtopic.php?t=5272&p=54546#p54546 <![CDATA[Re: Connection issues]]>
must split this post in 2

Code:
info: Hooked /lua/userInit.lua with /schook/lua/userInit.lua
info: Hooked /lua/globalInit.lua with /schook/lua/globalInit.lua
info: MD5 of global settings: d2a23d6464d3fd77956e7648c43b5077
info: IsStreamingWaveBank("/sounds/aeonselect.xwb") => false
debug: Wavebank prepared: 314c0c8
debug: SND: Loaded WaveBank 'aeonselect' at 314c0c8
info: IsStreamingWaveBank("/sounds/ambienttest.xwb") => false
debug: Wavebank prepared: 314c1f8
debug: SND: Loaded WaveBank 'ambienttest' at 314c1f8
info: IsStreamingWaveBank("/sounds/cybranselect.xwb") => false
debug: Wavebank prepared: 314c328
debug: SND: Loaded WaveBank 'cybranselect' at 314c328
info: IsStreamingWaveBank("/sounds/explosions.xwb") => false
debug: Wavebank prepared: 314c458
debug: SND: Loaded WaveBank 'explosions' at 314c458
info: IsStreamingWaveBank("/sounds/explosionsstream.xwb") => true
debug: SND: Loaded WaveBank 'explosionsstream' at 314c588
info: IsStreamingWaveBank("/sounds/fmv_bg.xwb") => true
debug: SND: Loaded WaveBank 'fmv_bg' at 314d728
info: IsStreamingWaveBank("/sounds/impacts.xwb") => false
debug: Wavebank prepared: 314e8c8
debug: SND: Loaded WaveBank 'impacts' at 314e8c8
info: IsStreamingWaveBank("/sounds/interface.xwb") => false
debug: Wavebank prepared: 314e9f8
debug: SND: Loaded WaveBank 'interface' at 314e9f8
info: IsStreamingWaveBank("/sounds/music.xwb") => true
debug: SND: Loaded WaveBank 'music' at 314eb28
info: IsStreamingWaveBank("/sounds/op_briefing.xwb") => true
debug: SND: Loaded WaveBank 'op_briefing' at 314fcc8
info: IsStreamingWaveBank("/sounds/seraphimselect.xwb") => false
debug: Wavebank prepared: 3150e68
debug: SND: Loaded WaveBank 'seraphimselect' at 3150e68
info: IsStreamingWaveBank("/sounds/uaa.xwb") => false
debug: Wavebank prepared: 3150f98
debug: SND: Loaded WaveBank 'uaa' at 3150f98
info: IsStreamingWaveBank("/sounds/uaadestroy.xwb") => false
debug: Wavebank prepared: 31510c8
debug: SND: Loaded WaveBank 'uaadestroy' at 31510c8
info: IsStreamingWaveBank("/sounds/uaaweapon.xwb") => false
debug: Wavebank prepared: 31511f8
debug: SND: Loaded WaveBank 'uaaweapon' at 31511f8
info: IsStreamingWaveBank("/sounds/uab.xwb") => false
debug: Wavebank prepared: 3151328
debug: SND: Loaded WaveBank 'uab' at 3151328
info: IsStreamingWaveBank("/sounds/ual.xwb") => false
debug: Wavebank prepared: 3151458
debug: SND: Loaded WaveBank 'ual' at 3151458
info: IsStreamingWaveBank("/sounds/ualdestroy.xwb") => false
debug: Wavebank prepared: 3151588
debug: SND: Loaded WaveBank 'ualdestroy' at 3151588
info: IsStreamingWaveBank("/sounds/ualweapon.xwb") => false
debug: Wavebank prepared: 31516b8
debug: SND: Loaded WaveBank 'ualweapon' at 31516b8
info: IsStreamingWaveBank("/sounds/uas.xwb") => false
debug: Wavebank prepared: 31517e8
debug: SND: Loaded WaveBank 'uas' at 31517e8
info: IsStreamingWaveBank("/sounds/uasdestroy.xwb") => true
debug: SND: Loaded WaveBank 'uasdestroy' at 3151918
info: IsStreamingWaveBank("/sounds/uasweapon.xwb") => false
debug: Wavebank prepared: 3152ab8
debug: SND: Loaded WaveBank 'uasweapon' at 3152ab8
info: IsStreamingWaveBank("/sounds/uea.xwb") => false
debug: Wavebank prepared: 3152be8
debug: SND: Loaded WaveBank 'uea' at 3152be8
info: IsStreamingWaveBank("/sounds/ueadestroy.xwb") => false
debug: Wavebank prepared: 3152d30
debug: SND: Loaded WaveBank 'ueadestroy' at 3152d30
info: IsStreamingWaveBank("/sounds/ueaweapon.xwb") => false
debug: Wavebank prepared: 3152e68
debug: SND: Loaded WaveBank 'ueaweapon' at 3152e68
info: IsStreamingWaveBank("/sounds/ueb.xwb") => false
debug: Wavebank prepared: 3152fa0
debug: SND: Loaded WaveBank 'ueb' at 3152fa0
info: IsStreamingWaveBank("/sounds/uefselect.xwb") => false
debug: Wavebank prepared: 31530d8
debug: SND: Loaded WaveBank 'uefselect' at 31530d8
info: IsStreamingWaveBank("/sounds/uel.xwb") => false
debug: Wavebank prepared: 3153210
debug: SND: Loaded WaveBank 'uel' at 3153210
info: IsStreamingWaveBank("/sounds/ueldestroy.xwb") => false
debug: Wavebank prepared: 3153348
debug: SND: Loaded WaveBank 'ueldestroy' at 3153348
info: IsStreamingWaveBank("/sounds/uelweapon.xwb") => false
debug: Wavebank prepared: 3153480
debug: SND: Loaded WaveBank 'uelweapon' at 3153480
info: IsStreamingWaveBank("/sounds/ues.xwb") => false
debug: Wavebank prepared: 31535b8
debug: SND: Loaded WaveBank 'ues' at 31535b8
info: IsStreamingWaveBank("/sounds/uesdestroy.xwb") => true
debug: SND: Loaded WaveBank 'uesdestroy' at 3154d18
info: IsStreamingWaveBank("/sounds/uesweapon.xwb") => false
debug: Wavebank prepared: 31536f0
debug: SND: Loaded WaveBank 'uesweapon' at 31536f0
info: IsStreamingWaveBank("/sounds/unitrumble.xwb") => false
debug: Wavebank prepared: 3153828
debug: SND: Loaded WaveBank 'unitrumble' at 3153828
info: IsStreamingWaveBank("/sounds/unitsglobal.xwb") => false
debug: Wavebank prepared: 3153960
debug: SND: Loaded WaveBank 'unitsglobal' at 3153960
info: IsStreamingWaveBank("/sounds/ura.xwb") => false
debug: Wavebank prepared: 3153a98
debug: SND: Loaded WaveBank 'ura' at 3153a98
info: IsStreamingWaveBank("/sounds/uradestroy.xwb") => false
debug: Wavebank prepared: 3153bd0
debug: SND: Loaded WaveBank 'uradestroy' at 3153bd0
info: IsStreamingWaveBank("/sounds/uraweapon.xwb") => false
debug: Wavebank prepared: 3153d08
debug: SND: Loaded WaveBank 'uraweapon' at 3153d08
info: IsStreamingWaveBank("/sounds/urb.xwb") => false
debug: Wavebank prepared: 3153e40
debug: SND: Loaded WaveBank 'urb' at 3153e40
info: IsStreamingWaveBank("/sounds/url.xwb") => false
debug: Wavebank prepared: 3153f78
debug: SND: Loaded WaveBank 'url' at 3153f78
info: IsStreamingWaveBank("/sounds/urldestroy.xwb") => false
debug: Wavebank prepared: 31540b0
debug: SND: Loaded WaveBank 'urldestroy' at 31540b0
info: IsStreamingWaveBank("/sounds/urlweapon.xwb") => false
debug: Wavebank prepared: 31541e8
debug: SND: Loaded WaveBank 'urlweapon' at 31541e8
info: IsStreamingWaveBank("/sounds/urs.xwb") => false
debug: Wavebank prepared: 3154320
debug: SND: Loaded WaveBank 'urs' at 3154320
info: IsStreamingWaveBank("/sounds/ursdestroy.xwb") => true
debug: SND: Loaded WaveBank 'ursdestroy' at 3155eb8
info: IsStreamingWaveBank("/sounds/ursstream.xwb") => true
debug: SND: Loaded WaveBank 'ursstream' at 3157058
info: IsStreamingWaveBank("/sounds/ursweapon.xwb") => false
debug: Wavebank prepared: 3154458
debug: SND: Loaded WaveBank 'ursweapon' at 3154458
info: IsStreamingWaveBank("/sounds/xaa_weapon.xwb") => false
debug: Wavebank prepared: 3154590
debug: SND: Loaded WaveBank 'xaa_weapon' at 3154590
info: IsStreamingWaveBank("/sounds/xab.xwb") => false
debug: Wavebank prepared: 31546c8
debug: SND: Loaded WaveBank 'xab' at 31546c8
info: IsStreamingWaveBank("/sounds/xal.xwb") => false
debug: Wavebank prepared: 3154800
debug: SND: Loaded WaveBank 'xal' at 3154800
info: IsStreamingWaveBank("/sounds/xal_weapon.xwb") => false
debug: Wavebank prepared: 3154938
debug: SND: Loaded WaveBank 'xal_weapon' at 3154938
info: IsStreamingWaveBank("/sounds/xas.xwb") => false
debug: Wavebank prepared: 3154a70
debug: SND: Loaded WaveBank 'xas' at 3154a70
info: IsStreamingWaveBank("/sounds/xas_weapons.xwb") => false
debug: Wavebank prepared: 3154ba8
debug: SND: Loaded WaveBank 'xas_weapons' at 3154ba8
info: IsStreamingWaveBank("/sounds/xea.xwb") => false
debug: Wavebank prepared: 3158210
debug: SND: Loaded WaveBank 'xea' at 3158210
info: IsStreamingWaveBank("/sounds/xea_weapons.xwb") => false
debug: Wavebank prepared: 3158348
debug: SND: Loaded WaveBank 'xea_weapons' at 3158348
info: IsStreamingWaveBank("/sounds/xeb.xwb") => false
debug: Wavebank prepared: 3158480
debug: SND: Loaded WaveBank 'xeb' at 3158480
info: IsStreamingWaveBank("/sounds/xel.xwb") => false
debug: Wavebank prepared: 31585b8
debug: SND: Loaded WaveBank 'xel' at 31585b8
info: IsStreamingWaveBank("/sounds/xel_weapons.xwb") => false
debug: Wavebank prepared: 31586f0
debug: SND: Loaded WaveBank 'xel_weapons' at 31586f0
info: IsStreamingWaveBank("/sounds/xes.xwb") => false
debug: Wavebank prepared: 3158828
debug: SND: Loaded WaveBank 'xes' at 3158828
info: IsStreamingWaveBank("/sounds/xes_destroy.xwb") => true
debug: SND: Loaded WaveBank 'xes_destroy' at 315a1f8
info: IsStreamingWaveBank("/sounds/xes_weapons.xwb") => false
debug: Wavebank prepared: 3158960
debug: SND: Loaded WaveBank 'xes_weapons' at 3158960
info: IsStreamingWaveBank("/sounds/xra.xwb") => false
debug: Wavebank prepared: 3158a98
debug: SND: Loaded WaveBank 'xra' at 3158a98
info: IsStreamingWaveBank("/sounds/xra_weapon.xwb") => false
debug: Wavebank prepared: 3158bd0
debug: SND: Loaded WaveBank 'xra_weapon' at 3158bd0
info: IsStreamingWaveBank("/sounds/xrb.xwb") => false
debug: Wavebank prepared: 3158d08
debug: SND: Loaded WaveBank 'xrb' at 3158d08
info: IsStreamingWaveBank("/sounds/xrl.xwb") => false
debug: Wavebank prepared: 3158e40
debug: SND: Loaded WaveBank 'xrl' at 3158e40
info: IsStreamingWaveBank("/sounds/xrl_stream.xwb") => true
debug: SND: Loaded WaveBank 'xrl_stream' at 315b398
info: IsStreamingWaveBank("/sounds/xrl_weapon.xwb") => false
debug: Wavebank prepared: 3158f78
debug: SND: Loaded WaveBank 'xrl_weapon' at 3158f78
info: IsStreamingWaveBank("/sounds/xrs.xwb") => false
debug: Wavebank prepared: 31590b0
debug: SND: Loaded WaveBank 'xrs' at 31590b0
info: IsStreamingWaveBank("/sounds/xrs_weapon.xwb") => false
debug: Wavebank prepared: 31591e8
debug: SND: Loaded WaveBank 'xrs_weapon' at 31591e8
info: IsStreamingWaveBank("/sounds/xsa.xwb") => false
debug: Wavebank prepared: 3159320
debug: SND: Loaded WaveBank 'xsa' at 3159320
info: IsStreamingWaveBank("/sounds/xsa_destroy.xwb") => false
debug: Wavebank prepared: 3159458
debug: SND: Loaded WaveBank 'xsa_destroy' at 3159458
info: IsStreamingWaveBank("/sounds/xsa_weapon.xwb") => false
debug: Wavebank prepared: 3159590
debug: SND: Loaded WaveBank 'xsa_weapon' at 3159590
info: IsStreamingWaveBank("/sounds/xsb.xwb") => false
debug: Wavebank prepared: 31596c8
debug: SND: Loaded WaveBank 'xsb' at 31596c8
info: IsStreamingWaveBank("/sounds/xsb_weapon.xwb") => false
debug: Wavebank prepared: 3159800
debug: SND: Loaded WaveBank 'xsb_weapon' at 3159800
info: IsStreamingWaveBank("/sounds/xsl.xwb") => false
debug: Wavebank prepared: 3159938
debug: SND: Loaded WaveBank 'xsl' at 3159938
info: IsStreamingWaveBank("/sounds/xsl_destroy.xwb") => false
debug: Wavebank prepared: 3159a70
debug: SND: Loaded WaveBank 'xsl_destroy' at 3159a70
info: IsStreamingWaveBank("/sounds/xsl_weapon.xwb") => false
debug: Wavebank prepared: 3159ba8
debug: SND: Loaded WaveBank 'xsl_weapon' at 3159ba8
info: IsStreamingWaveBank("/sounds/xss.xwb") => false
debug: Wavebank prepared: 3159ce0
debug: SND: Loaded WaveBank 'xss' at 3159ce0
info: IsStreamingWaveBank("/sounds/xss_destroy.xwb") => true
debug: SND: Loaded WaveBank 'xss_destroy' at 315c538
info: IsStreamingWaveBank("/sounds/xss_weapon.xwb") => false
debug: Wavebank prepared: 3159e18
debug: SND: Loaded WaveBank 'xss_weapon' at 3159e18
debug: SND: Loaded SoundBank 'ambienttest'
debug: SND: Loaded SoundBank 'explosions'
debug: SND: Loaded SoundBank 'fmv_bg'
debug: SND: Loaded SoundBank 'impacts'
debug: SND: Loaded SoundBank 'interface'
debug: SND: Loaded SoundBank 'music'
debug: SND: Loaded SoundBank 'op_briefing'
debug: SND: Loaded SoundBank 'seraphimselect'
debug: SND: Loaded SoundBank 'uaa'
debug: SND: Loaded SoundBank 'uaadestroy'
debug: SND: Loaded SoundBank 'uaaweapon'
debug: SND: Loaded SoundBank 'uab'
debug: SND: Loaded SoundBank 'ual'
debug: SND: Loaded SoundBank 'ualdestroy'
debug: SND: Loaded SoundBank 'ualweapon'
debug: SND: Loaded SoundBank 'uas'
debug: SND: Loaded SoundBank 'uasdestroy'
debug: SND: Loaded SoundBank 'uasweapon'
debug: SND: Loaded SoundBank 'uea'
debug: SND: Loaded SoundBank 'ueadestroy'
debug: SND: Loaded SoundBank 'ueaweapon'
debug: SND: Loaded SoundBank 'ueb'
debug: SND: Loaded SoundBank 'uel'
debug: SND: Loaded SoundBank 'ueldestroy'
debug: SND: Loaded SoundBank 'uelweapon'
debug: SND: Loaded SoundBank 'ues'
debug: SND: Loaded SoundBank 'uesdestroy'
debug: SND: Loaded SoundBank 'uesweapon'
debug: SND: Loaded SoundBank 'unitrumble'
debug: SND: Loaded SoundBank 'unitsglobal'
debug: SND: Loaded SoundBank 'ura'
debug: SND: Loaded SoundBank 'uradestroy'
debug: SND: Loaded SoundBank 'uraweapon'
debug: SND: Loaded SoundBank 'urb'
debug: SND: Loaded SoundBank 'url'
debug: SND: Loaded SoundBank 'urldestroy'
debug: SND: Loaded SoundBank 'urlweapon'
debug: SND: Loaded SoundBank 'urs'
debug: SND: Loaded SoundBank 'ursdestroy'
debug: SND: Loaded SoundBank 'ursstream'
debug: SND: Loaded SoundBank 'ursweapon'
debug: SND: Loaded SoundBank 'xaa'
debug: SND: Loaded SoundBank 'xaa_weapon'
debug: SND: Loaded SoundBank 'xab'
debug: SND: Loaded SoundBank 'xal'
debug: SND: Loaded SoundBank 'xal_weapon'
debug: SND: Loaded SoundBank 'xas'
debug: SND: Loaded SoundBank 'xas_weapon'
debug: SND: Loaded SoundBank 'xca'
debug: SND: Loaded SoundBank 'xcb'
debug: SND: Loaded SoundBank 'xcl'
debug: SND: Loaded SoundBank 'xcs'
debug: SND: Loaded SoundBank 'xea'
debug: SND: Loaded SoundBank 'xea_weapon'
debug: SND: Loaded SoundBank 'xeb'
debug: SND: Loaded SoundBank 'xel'
debug: SND: Loaded SoundBank 'xel_weapons'
debug: SND: Loaded SoundBank 'xes'
debug: SND: Loaded SoundBank 'xes_destroy'
debug: SND: Loaded SoundBank 'xes_weapons'
debug: SND: Loaded SoundBank 'xra'
debug: SND: Loaded SoundBank 'xra_weapon'
debug: SND: Loaded SoundBank 'xrb'
debug: SND: Loaded SoundBank 'xrl'
debug: SND: Loaded SoundBank 'xrl_destroy'
debug: SND: Loaded SoundBank 'xrl_stream'
debug: SND: Loaded SoundBank 'xrl_weapon'
debug: SND: Loaded SoundBank 'xrs'
debug: SND: Loaded SoundBank 'xrs_weapon'
debug: SND: Loaded SoundBank 'xsa'
debug: SND: Loaded SoundBank 'xsa_destroy'
debug: SND: Loaded SoundBank 'xsa_weapon'
debug: SND: Loaded SoundBank 'xsb'
debug: SND: Loaded SoundBank 'xsb_weapon'
debug: SND: Loaded SoundBank 'xsl'
debug: SND: Loaded SoundBank 'xsl_destroy'
debug: SND: Loaded SoundBank 'xsl_weapon'
debug: SND: Loaded SoundBank 'xss'
debug: SND: Loaded SoundBank 'xss_destroy'
debug: SND: Loaded SoundBank 'xss_weapon'
debug: MEM: -55576832 bytes SND
info: MD5 of global settings: d2a23d6464d3fd77956e7648c43b5077
info: IsStreamingWaveBank("/sounds/voice/us/briefings.xwb") => true
debug: SND: Loaded WaveBank 'briefings' at 3188db8
info: IsStreamingWaveBank("/sounds/voice/us/seraphim_language.xwb") => true
debug: SND: Loaded WaveBank 'seraphim_language' at 3189f20
info: IsStreamingWaveBank("/sounds/voice/us/x01_vo.xwb") => true
debug: SND: Loaded WaveBank 'x01_vo' at 318b0a0
info: IsStreamingWaveBank("/sounds/voice/us/x02_vo.xwb") => true
debug: SND: Loaded WaveBank 'x02_vo' at 318b208
info: IsStreamingWaveBank("/sounds/voice/us/x03_vo.xwb") => true
debug: SND: Loaded WaveBank 'x03_vo' at 318b370
info: IsStreamingWaveBank("/sounds/voice/us/x04_vo.xwb") => true
debug: SND: Loaded WaveBank 'x04_vo' at 318b4d8
info: IsStreamingWaveBank("/sounds/voice/us/x05_vo.xwb") => true
debug: SND: Loaded WaveBank 'x05_vo' at 318b640
info: IsStreamingWaveBank("/sounds/voice/us/x06_vo.xwb") => true
debug: SND: Loaded WaveBank 'x06_vo' at 318b7a8
info: IsStreamingWaveBank("/sounds/voice/us/x1t_vo.xwb") => true
debug: SND: Loaded WaveBank 'x1t_vo' at 318b910
info: IsStreamingWaveBank("/sounds/voice/us/x_fmv.xwb") => true
debug: SND: Loaded WaveBank 'x_fmv' at 318ba78
info: IsStreamingWaveBank("/sounds/voice/us/xgg.xwb") => true
debug: SND: Loaded WaveBank 'xgg' at 318bbe0
debug: SND: Loaded SoundBank 'briefings'
debug: SND: Loaded SoundBank 'x01_vo'
debug: SND: Loaded SoundBank 'x02_vo'
debug: SND: Loaded SoundBank 'x03_vo'
debug: SND: Loaded SoundBank 'x04_vo'
debug: SND: Loaded SoundBank 'x05_vo'
debug: SND: Loaded SoundBank 'x06_vo'
debug: SND: Loaded SoundBank 'x1t_vo'
debug: SND: Loaded SoundBank 'x_fmv'
debug: SND: Loaded SoundBank 'xgg'
debug: MEM: -796091502 bytes SND
info: MD5 of global settings: d2a23d6464d3fd77956e7648c43b5077
debug: MEM: -796091502 bytes SND
debug: Loading module '\000/lua/sim/buffdefinitions.lua\000'
debug: Loading module '\000/lua/sim/adjacencybuffs.lua\000'
debug: Loading module '\000/lua/sim/adjacencybufffunctions.lua\000'
debug: Loading module '\000/lua/sim/cheatbuffs.lua\000'
debug: Loading module '\000/lua/keymap/keymapper.lua\000'
debug: Loading module '\000/lua/user/prefs.lua\000'
debug: Loading module '\000/lua/options/optionslogic.lua\000'
debug: Loading module '\000/lua/keymap/keyactions.lua\000'
info: Clearing cheats from added keymap.
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Alt
info: adding font file /fonts/arial.ttf
info: adding font file /fonts/arialbd.ttf
info: adding font file /fonts/arialbi.ttf
info: adding font file /fonts/ariali.ttf
info: adding font file /fonts/arialn.ttf
info: adding font file /fonts/arialnb.ttf
info: adding font file /fonts/arialnbi.ttf
info: adding font file /fonts/arialni.ttf
info: adding font file /fonts/ariblk.ttf
info: adding font file /fonts/arlrdbd.ttf
info: adding font file /fonts/butterbe.ttf
info: adding font file /fonts/vdub.ttf
info: adding font file /fonts/wintermu.ttf
info: adding font file /fonts/zeroes_3.ttf
debug: Loading module '\000/lua/keymap/keynames.lua\000'
info: Compiled shader: /effects/cartographic.fx
info: Compiled shader: /effects/frame.fx
info: Compiled shader: /effects/mesh.fx
info: Compiled shader: /effects/particle.fx
info: Compiled shader: /effects/primbatcher.fx
info: Compiled shader: /effects/range.fx
info: Compiled shader: /effects/sky.fx
info: Compiled shader: /effects/terrain.fx
info: Compiled shader: /effects/ui.fx
info: Compiled shader: /effects/vision.fx
info: Compiled shader: /effects/water2.fx
info: SHADERS COMPILED
debug: Loading module '\000/lua/options/options.lua\000'
debug: Loading module '\000/lua/ui/uiutil.lua\000'
debug: Loading module '\000/lua/lazyvar.lua\000'
debug: Loading module '\000/lua/maui/layouthelpers.lua\000'
debug: Loading module '\000/lua/maui/group.lua\000'
debug: Loading module '\000/lua/maui/control.lua\000'
debug: Loading module '\000/lua/maui/text.lua\000'
debug: Loading module '\000/lua/maui/multilinetext.lua\000'
debug: Loading module '\000/lua/maui/button.lua\000'
debug: Loading module '\000/lua/maui/bitmap.lua\000'
debug: Loading module '\000/lua/maui/dragger.lua\000'
debug: Loading module '\000/lua/maui/edit.lua\000'
debug: Loading module '\000/lua/maui/checkbox.lua\000'
debug: Loading module '\000/lua/maui/scrollbar.lua\000'
debug: Loading module '\000/lua/maui/cursor.lua\000'
debug: Loading module '\000/lua/maui/border.lua\000'
debug: Loading module '\000/lua/maui/itemlist.lua\000'
debug: Loading module '\000/lua/skins/layouts.lua\000'
debug: Wavebank prepared: 314c588
debug: Wavebank prepared: 314d728
debug: Wavebank prepared: 314eb28
debug: Wavebank prepared: 314fcc8
debug: Wavebank prepared: 3151918
debug: Wavebank prepared: 3154d18
debug: Wavebank prepared: 3155eb8
debug: Wavebank prepared: 3157058
debug: Wavebank prepared: 315a1f8
debug: Wavebank prepared: 315b398
debug: Wavebank prepared: 315c538
debug: Wavebank prepared: 3188db8
debug: Wavebank prepared: 3189f20
debug: Wavebank prepared: 318b208
debug: Wavebank prepared: 318b370
debug: Wavebank prepared: 318b4d8
debug: Wavebank prepared: 318b640
debug: Wavebank prepared: 318b7a8
debug: Wavebank prepared: 318b910
debug: Wavebank prepared: 318ba78
debug: Loading module '\000/lua/maui/frame.lua\000'
debug: Loading module '\000/lua/ui/uimain.lua\000'
debug: Loading module '\000/lua/multiplayer/onlineprovider.lua\000'
debug: Loading module '\000/lua/ui/campaign/campaignmanager.lua\000'
debug: Loading module '\000/lua/skins/skins.lua\000'
debug: Loading module '\000/lua/multiplayer/gpgnet.lua\000'
info: GPGNET: entering idle state.
debug: Wavebank prepared: 318b0a0
debug: Wavebank prepared: 318bbe0
debug: Loading module '\000/lua/ui/lobby/autolobby.lua\000'
debug: Loading module '\000/lua/ui/menus/menucommon.lua\000'
debug: Loading module '\000/lua/ui/game/tooltip.lua\000'
debug: Loading module '\000/lua/ui/help/tooltips.lua\000'
debug: Loading module '\000/lua/keymap/defaultkeymap.lua\000'
debug: Loading module '\000/lua/ui/lobby/lobbycomm.lua\000'
debug: Loading module '\000/lua/gamecolors.lua\000'
info: Warning: Unable to find file \000/menus02/background-paint_black_bmp.dds
info: Unable to load texture from file: /menus02/background-paint_black_bmp.dds
info: GPGNET: setting nat handler to 0x11469004
info: LOBBY: Game port 6112[UDP] opened.
info: LOBBY: starting with local uid of 63192 [Lame]
info: GPGNET: entering lobby state.
info: GPGNET: sending nat packet to 91.121.153.175:30351
info: Warning: Unable to find file \000/menus02/background-paint_black_bmp.dds
info: Unable to load texture from file: /menus02/background-paint_black_bmp.dds
info: /players
debug: Loading module '\000/lua/factions.lua\000'
info: /team
info: /deviation
info: /mean
info: /numgames
info: Local player info: {
info:   AIPersonality="",
info:   ArmyColor=1,
info:   Civilian=false,
info:   DEV=47.168300628662,
info:   Faction=4,
info:   Human=true,
info:   MEAN=1255.1700439453,
info:   NG="",
info:   PL=1113,
info:   PlayerColor=1,
info:   PlayerName="Lame",
info:   Ready=false,
info:   StartSpot=1,
info:   Team=1
info: }
info: GPGNET: received nat packet from 91.121.153.175:30351
info: GPGNET: sending nat packet to 91.121.153.175:30351
info: GPGNET: sending nat packet to 186.170.174.24:1024
info: GPGNET: sending nat packet to 186.170.174.24:1024
info: GPGNET: sending nat packet to 186.170.174.24:1024
info: GPGNET: sending nat packet to 186.170.174.24:1024
info: GPGNET: sending nat packet to 186.170.174.24:1024
info: GPGNET: sending nat packet to 186.170.174.24:1024
info: GPGNET: sending nat packet to 186.170.174.24:1024
info: GPGNET: sending nat packet to 186.170.174.24:1024
info: GPGNET: sending nat packet to 186.170.174.24:1024
info: GPGNET: sending nat packet to 186.170.174.24:1024
info: GPGNET: sending nat packet to 186.170.174.24:1024
info: GPGNET: sending nat packet to 186.170.174.24:1024
info: GPGNET: sending nat packet to 186.170.174.24:1024
info: GPGNET: sending nat packet to 186.170.174.24:1024
info: GPGNET: sending nat packet to 186.170.174.24:1024
info: GPGNET: sending nat packet to 186.170.174.24:1024
info: GPGNET: sending nat packet to 186.170.174.24:1024
info: GPGNET: sending nat packet to 186.170.174.24:1024
info: GPGNET: sending nat packet to 186.170.174.24:1024
info: GPGNET: sending nat packet to 186.170.174.24:1024
info: GPGNET: sending nat packet to 186.170.174.24:1024
info: GPGNET: sending nat packet to 186.170.174.24:1024
info: GPGNET: sending nat packet to 186.170.174.24:1024
info: GPGNET: sending nat packet to 186.170.174.24:1024
info: GPGNET: sending nat packet to 186.170.174.24:1024
info: GPGNET: sending nat packet to 186.170.174.24:1024
info: GPGNET: sending nat packet to 186.170.174.24:1024
info: GPGNET: sending nat packet to 186.170.174.24:1024
info: GPGNET: sending nat packet to 186.170.174.24:1024
info: GPGNET: sending nat packet to 186.170.174.24:1024
info: NET: using deflate compression for sends to 186.170.174.24:1024.
info: LOBBY: Adding peer "Hixtory" [186.170.174.24:1024, uid=58012]
info: System: \000Connecting to Hixtory...
info: Peer Disconnected : (name=Hixtory, uid=58012)
info: NET: using deflate compression for sends to static3.cdn.ubi.com:12001.
info: LOBBY: Adding peer "Hixtory" [static3.cdn.ubi.com:12001, uid=58012]
info: System: \000Connecting to Hixtory...
info: Minimized true
info: Peer Disconnected : (name=Hixtory, uid=58012)
info: Minimized false
info: Minimized true
info: Minimized false
info: Minimized true
info: Minimized false
info: CNetTCPBuf::Read(): recv() failed: WSAEINTR
info: Run time: 0h01m52s

Statistics: Posted by Lame — 26 Sep 2013, 17:37


]]>
2013-09-26T17:29:28+02:00 2013-09-26T17:29:28+02:00 /viewtopic.php?t=5272&p=54545#p54545 <![CDATA[Re: Connection issues]]>
Ze_PilOt wrote:
I need game.log and a full faforever.log.

I also need that from the players you are trouble connecting to. (same test session).

Statistics: Posted by Ze_PilOt — 26 Sep 2013, 17:29


]]>
2013-09-26T17:28:18+02:00 2013-09-26T17:28:18+02:00 /viewtopic.php?t=5272&p=54544#p54544 <![CDATA[Re: Connection issues]]>
Code:
2013-09-26 17:03:59,908 INFO     faf.main             >>> --------------------------- Application Launch
2013-09-26 17:04:00,765 DEBUG    faf.fa.relayserver   initializing...
2013-09-26 17:04:00,766 INFO     faf.fa.proxies       binding socket 0 on port 12001
2013-09-26 17:04:00,766 INFO     faf.fa.proxies       binding socket 1 on port 12002
2013-09-26 17:04:00,766 INFO     faf.fa.proxies       binding socket 2 on port 12003
2013-09-26 17:04:00,766 INFO     faf.fa.proxies       binding socket 3 on port 12004
2013-09-26 17:04:00,766 INFO     faf.fa.proxies       binding socket 4 on port 12005
2013-09-26 17:04:00,767 INFO     faf.fa.proxies       binding socket 5 on port 12006
2013-09-26 17:04:00,767 INFO     faf.fa.proxies       binding socket 6 on port 12007
2013-09-26 17:04:00,767 INFO     faf.fa.proxies       binding socket 7 on port 12008
2013-09-26 17:04:00,767 INFO     faf.fa.proxies       binding socket 8 on port 12009
2013-09-26 17:04:00,767 INFO     faf.fa.proxies       binding socket 9 on port 12010
2013-09-26 17:04:00,769 INFO     faf.fa.proxies       binding socket 10 on port 12011
2013-09-26 17:04:00,786 INFO     faf.util             Read common stylesheet: client/client.css
2013-09-26 17:04:00,953 INFO     faf.util             Read common stylesheet: stats/formatters/style.css
2013-09-26 17:04:00,974 INFO     faf.util             Read common stylesheet: tournaments/formatters/style.css
2013-09-26 17:04:00,976 DEBUG    faf.vault            Map Vault tab instantiating
2013-09-26 17:04:02,096 DEBUG    faf.modvault         Mod Vault tab instantiating
2013-09-26 17:04:02,138 DEBUG    faf.modvault         getting installed mods. Count: 18
2013-09-26 17:04:02,157 INFO     faf.replays          Replays Widget instantiated.
2013-09-26 17:04:02,163 INFO     faf.tutorials        Tutorials instantiated.
2013-09-26 17:04:02,164 DEBUG    faf.galacticWar      Lobby instantiating.
2013-09-26 17:04:02,165 DEBUG    faf.galacticWar      GW options instantiating.
2013-09-26 17:04:02,194 INFO     faf.fa.replayserver  listening on address 127.0.0.1:15000
2013-09-26 17:04:02,194 INFO     faf.fa.relayserver   relay listening on address 127.0.0.1:53146
2013-09-26 17:04:03,309 INFO     faf.client           Outgoing JSON Message: {"command": "ask_session"}
2013-09-26 17:04:07,614 INFO     faf.client           Attempting to login as: Lame
2013-09-26 17:04:07,615 INFO     faf.client           Outgoing JSON Message: login.
2013-09-26 17:04:08,150 INFO     faf.client           Login accepted.
2013-09-26 17:04:08,154 INFO     faf.fa.upnp          Creating UPnP port mappings...
2013-09-26 17:04:08,436 ERROR    faf.fa.upnp          Couldn't get StaticPortMappingCollection
2013-09-26 17:04:08,437 INFO     faf.client           The game port is now set to 6112
2013-09-26 17:04:08,437 INFO     faf.client           sending packet to direct.faforever.com
2013-09-26 17:04:20,036 INFO     faf.client           Outgoing JSON Message: {"command": "coop_list"}
2013-09-26 17:10:48,453 INFO     faf.main             >>> --------------------------- Application Launch
2013-09-26 17:10:48,470 INFO     faf.fa               fa.exe.replay(C:\Users\f***\AppData\Local\Temp\1175508.fafreplay, detach = True
2013-09-26 17:10:48,470 INFO     faf.fa               Extracted 0 bytes of binary data from .fafreplay.
2013-09-26 17:10:48,470 ERROR    faf.main             Uncaught exception
Traceback (most recent call last):
  File "main.py", line 122, in <module>
  File "fa\exe.pyc", line 164, in replay
  File "fa\replayparser.pyc", line 50, in getVersion
  File "fa\replayparser.pyc", line 33, in __readLine
error: unpack requires a string argument of length 1
2013-09-26 17:19:20,467 INFO     faf.client           Close Event for Application Main Window
2013-09-26 17:19:20,480 WARNING  faf.client           Disconnected from lobby server.
2013-09-26 17:19:20,480 INFO     faf.tourneys         Disconnected from server
2013-09-26 17:19:20,480 INFO     faf.fa.upnp          Removing UPnP port mappings...
2013-09-26 17:19:20,484 ERROR    faf.fa.upnp          Couldn't get StaticPortMappingCollection
2013-09-26 17:19:20,494 INFO     faf.main             <<< --------------------------- Application Shutdown
2013-09-26 17:20:11,101 INFO     faf.main             >>> --------------------------- Application Launch
2013-09-26 17:20:11,934 DEBUG    faf.fa.relayserver   initializing...
2013-09-26 17:20:11,936 INFO     faf.fa.proxies       binding socket 0 on port 12001
2013-09-26 17:20:11,936 INFO     faf.fa.proxies       binding socket 1 on port 12002
2013-09-26 17:20:11,936 INFO     faf.fa.proxies       binding socket 2 on port 12003
2013-09-26 17:20:11,937 INFO     faf.fa.proxies       binding socket 3 on port 12004
2013-09-26 17:20:11,937 INFO     faf.fa.proxies       binding socket 4 on port 12005
2013-09-26 17:20:11,937 INFO     faf.fa.proxies       binding socket 5 on port 12006
2013-09-26 17:20:11,937 INFO     faf.fa.proxies       binding socket 6 on port 12007
2013-09-26 17:20:11,937 INFO     faf.fa.proxies       binding socket 7 on port 12008
2013-09-26 17:20:11,937 INFO     faf.fa.proxies       binding socket 8 on port 12009
2013-09-26 17:20:11,937 INFO     faf.fa.proxies       binding socket 9 on port 12010
2013-09-26 17:20:11,937 INFO     faf.fa.proxies       binding socket 10 on port 12011
2013-09-26 17:20:11,953 INFO     faf.util             Read common stylesheet: client/client.css
2013-09-26 17:20:12,102 INFO     faf.util             Read common stylesheet: stats/formatters/style.css
2013-09-26 17:20:12,118 INFO     faf.util             Read common stylesheet: tournaments/formatters/style.css
2013-09-26 17:20:12,118 DEBUG    faf.vault            Map Vault tab instantiating
2013-09-26 17:20:13,171 DEBUG    faf.modvault         Mod Vault tab instantiating
2013-09-26 17:20:13,210 DEBUG    faf.modvault         getting installed mods. Count: 18
2013-09-26 17:20:13,227 INFO     faf.replays          Replays Widget instantiated.
2013-09-26 17:20:13,232 INFO     faf.tutorials        Tutorials instantiated.
2013-09-26 17:20:13,232 DEBUG    faf.galacticWar      Lobby instantiating.
2013-09-26 17:20:13,233 DEBUG    faf.galacticWar      GW options instantiating.
2013-09-26 17:20:13,262 INFO     faf.fa.replayserver  listening on address 127.0.0.1:15000
2013-09-26 17:20:13,263 INFO     faf.fa.relayserver   relay listening on address 127.0.0.1:53400
2013-09-26 17:20:14,368 INFO     faf.client           Outgoing JSON Message: {"command": "ask_session"}
2013-09-26 17:20:16,838 INFO     faf.client           Attempting to login as: Lame
2013-09-26 17:20:16,839 INFO     faf.client           Outgoing JSON Message: login.
2013-09-26 17:20:17,130 INFO     faf.client           Login accepted.
2013-09-26 17:20:17,131 INFO     faf.fa.upnp          Creating UPnP port mappings...
2013-09-26 17:20:17,148 ERROR    faf.fa.upnp          Couldn't get StaticPortMappingCollection
2013-09-26 17:20:17,148 INFO     faf.client           The game port is now set to 6112
2013-09-26 17:20:17,148 INFO     faf.client           sending packet to direct.faforever.com
2013-09-26 17:20:41,828 INFO     faf.client           Outgoing JSON Message: {"command": "coop_list"}
2013-09-26 17:20:56,931 INFO     faf.fa               Checking FA for: ladder1v1 and map None
2013-09-26 17:20:56,931 INFO     faf.fa               Updating FA for mod: ladder1v1, version None
2013-09-26 17:20:56,933 DEBUG    faf.updater          Update started at 2013-09-26 17:20:56
2013-09-26 17:20:56,934 DEBUG    faf.updater          Using game path: Z:\Program Files (x86)\THQ\Supreme Commander Forged Alliance
2013-09-26 17:20:56,934 DEBUG    faf.updater          Using appdata: C:\ProgramData\FAForever
2013-09-26 17:20:57,078 DEBUG    faf.updater          Connected to update server at 2013-09-26 17:20:57
2013-09-26 17:20:57,084 DEBUG    faf.updater          writeToServer(GET_FILES_TO_UPDATE, [FAF])
2013-09-26 17:20:57,115 DEBUG    faf.updater          handleAction(LIST_FILES_TO_UP) - 324 bytes
2013-09-26 17:20:57,115 DEBUG    faf.updater          Files to update: [ForgedAlliance.exe, init_faf.lua, init_ladder1v1.lua, GDFBinary.dll, SupComDataPath.lua, SupComDataPathFAF.lua, init_nonxt.lua]
2013-09-26 17:20:57,117 DEBUG    faf.updater          writeToServer(UPDATE, [bin, init_nonxt.lua, 46d9008f6b77d2c60f96272a816e4227])
2013-09-26 17:20:57,118 DEBUG    faf.updater          writeToServer(UPDATE, [bin, GDFBinary.dll, 3fc9e7684d150da5c51db71d2399f316])
2013-09-26 17:20:57,119 DEBUG    faf.updater          writeToServer(UPDATE, [bin, init_faf.lua, 7d5cebd90024c4c5dc44ae8f5c9fa35b])
2013-09-26 17:20:57,155 DEBUG    faf.updater          writeToServer(UPDATE, [bin, ForgedAlliance.exe, b779d298a8ac4412dfbcc7667cf5578f])
2013-09-26 17:20:57,157 DEBUG    faf.updater          writeToServer(UPDATE, [bin, SupComDataPath.lua, 55ac1ef97845f2291da64b830299331e])
2013-09-26 17:20:57,158 DEBUG    faf.updater          writeToServer(UPDATE, [bin, SupComDataPathFAF.lua, 962c9d1327657d77184adcf358c628f1])
2013-09-26 17:20:57,161 DEBUG    faf.updater          writeToServer(UPDATE, [bin, init_ladder1v1.lua, ea96ac9cec88af29c08556c96465acfe])
2013-09-26 17:20:57,197 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 56 bytes
2013-09-26 17:20:57,198 DEBUG    faf.updater          file : init_nonxt.lua
2013-09-26 17:20:57,198 DEBUG    faf.updater          init_nonxt.lua is up to date.
2013-09-26 17:20:57,431 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 54 bytes
2013-09-26 17:20:57,431 DEBUG    faf.updater          file : GDFBinary.dll
2013-09-26 17:20:57,433 DEBUG    faf.updater          GDFBinary.dll is up to date.
2013-09-26 17:20:57,433 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 52 bytes
2013-09-26 17:20:57,434 DEBUG    faf.updater          file : init_faf.lua
2013-09-26 17:20:57,434 DEBUG    faf.updater          init_faf.lua is up to date.
2013-09-26 17:20:57,434 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 64 bytes
2013-09-26 17:20:57,434 DEBUG    faf.updater          file : ForgedAlliance.exe
2013-09-26 17:20:57,434 DEBUG    faf.updater          ForgedAlliance.exe is up to date.
2013-09-26 17:20:57,436 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 64 bytes
2013-09-26 17:20:57,436 DEBUG    faf.updater          file : SupComDataPath.lua
2013-09-26 17:20:57,436 DEBUG    faf.updater          SupComDataPath.lua is up to date.
2013-09-26 17:20:57,437 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 70 bytes
2013-09-26 17:20:57,437 DEBUG    faf.updater          file : SupComDataPathFAF.lua
2013-09-26 17:20:57,437 DEBUG    faf.updater          SupComDataPathFAF.lua is up to date.
2013-09-26 17:20:57,440 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 64 bytes
2013-09-26 17:20:57,440 DEBUG    faf.updater          file : init_ladder1v1.lua
2013-09-26 17:20:57,440 DEBUG    faf.updater          init_ladder1v1.lua is up to date.
2013-09-26 17:20:57,440 DEBUG    faf.updater          Updates applied successfully.
2013-09-26 17:20:57,440 DEBUG    faf.updater          writeToServer(GET_FILES_TO_UPDATE, [FAFGAMEDATA])
2013-09-26 17:20:57,470 DEBUG    faf.updater          handleAction(LIST_FILES_TO_UP) - 134 bytes
2013-09-26 17:20:57,471 DEBUG    faf.updater          Files to update: [faforever.faf, faforever.nxt, lobby.nxt]
2013-09-26 17:20:57,483 DEBUG    faf.updater          writeToServer(UPDATE, [gamedata, faforever.faf, 01918c842de543150cfc20cd511986ac])
2013-09-26 17:20:57,696 DEBUG    faf.updater          writeToServer(UPDATE, [gamedata, faforever.nxt, e046d2c5af04f78aca023941c1abd949])
2013-09-26 17:20:57,723 DEBUG    faf.updater          writeToServer(UPDATE, [gamedata, lobby.nxt, 9e6521423cc955e2cfb821839d482226])
2013-09-26 17:20:57,757 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 54 bytes
2013-09-26 17:20:57,759 DEBUG    faf.updater          file : faforever.faf
2013-09-26 17:20:57,759 DEBUG    faf.updater          faforever.faf is up to date.
2013-09-26 17:20:58,069 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 54 bytes
2013-09-26 17:20:58,069 DEBUG    faf.updater          file : faforever.nxt
2013-09-26 17:20:58,069 DEBUG    faf.updater          faforever.nxt is up to date.
2013-09-26 17:20:58,069 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 46 bytes
2013-09-26 17:20:58,071 DEBUG    faf.updater          file : lobby.nxt
2013-09-26 17:20:58,071 DEBUG    faf.updater          lobby.nxt is up to date.
2013-09-26 17:20:58,071 DEBUG    faf.updater          Updates applied successfully.
2013-09-26 17:20:58,071 DEBUG    faf.updater          Disconnected from server at 2013-09-26 17:20:58
2013-09-26 17:20:58,115 DEBUG    faf.updater          Update finished at 2013-09-26 17:20:58
2013-09-26 17:20:58,115 INFO     faf.fa               Writing fa_path.lua config file.
2013-09-26 17:20:58,127 INFO     faf.fa.upnp          Creating UPnP port mappings...
2013-09-26 17:20:58,128 ERROR    faf.fa.upnp          Couldn't get StaticPortMappingCollection
2013-09-26 17:20:58,130 INFO     faf.games            Starting Ranked Search as /seraphim, port: 6112
2013-09-26 17:20:58,131 INFO     faf.client           Outgoing JSON Message: {"state": "start", "mod": "ladder1v1", "command": "game_matchmaking", "faction": "/seraphim", "gameport": 6112}
2013-09-26 17:20:58,236 INFO     faf.client           Handling game_launch via JSON {u'uid': 1337075, u'args': [u'/players 2', u'/team 1'], u'mapname': u'twin rivers.v0001', u'reason': u'ranked', u'command': u'game_launch', u'mod': u'ladder1v1'}
2013-09-26 17:20:58,237 INFO     faf.fa               Updating FA for map: twin rivers.v0001
2013-09-26 17:20:58,237 INFO     faf.fa               Map is available.
2013-09-26 17:20:58,239 INFO     faf.fa.upnp          Creating UPnP port mappings...
2013-09-26 17:20:58,242 ERROR    faf.fa.upnp          Couldn't get StaticPortMappingCollection
2013-09-26 17:20:58,242 INFO     faf.fa               Running FA with info: {'recorder': u'Lame', 'game_time': 1380208858.242, 'uid': 1337075, 'version_info': {'lobby': '0.8.80'}, 'featured_mod': u'ladder1v1'}
2013-09-26 17:20:58,242 INFO     faf.fa               Running FA via command: "C:\ProgramData\FAForever\bin\ForgedAlliance.exe" /players 2 /team 1 /seraphim /mean 1255.17 /deviation 47.1683 /init init_ladder1v1.lua /log "C:\ProgramData\FAForever\logs\game.log" /savereplay gpgnet://localhost/1337075/Lame.SCFAreplay /nobugreport /gpgnet 127.0.0.1:53400
2013-09-26 17:20:58,263 INFO     faf.client           FA has launched in an attached process.
2013-09-26 17:20:58,263 INFO     faf.client           Outgoing JSON Message: {"state": "on", "command": "fa_state"}
2013-09-26 17:20:58,263 DEBUG    faf.games            Stopping Ranked Search
2013-09-26 17:20:58,263 INFO     faf.client           Outgoing JSON Message: {"state": "stop", "command": "game_matchmaking", "mod": "ladder1v1"}
2013-09-26 17:21:05,858 DEBUG    faf.fa.relayserver   incoming connection to relay server...
2013-09-26 17:21:05,859 INFO     faf.fa.relayer       FA connected locally.
2013-09-26 17:21:05,888 DEBUG    faf.fa.relayer       faf server direct.faforever.com:8000
2013-09-26 17:21:05,888 DEBUG    faf.fa.relayer       Initializing ping timer
2013-09-26 17:21:05,888 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "GameState", "chuncks": ["Idle"]}
2013-09-26 17:21:05,920 INFO     faf.fa.relayer       Command received from server : {"commands": [1, 6112, "Lame", 63192, 1], "key": "CreateLobby"}
2013-09-26 17:21:05,921 INFO     faf.fa.relayer       Command received from server : {"commands": ["91.121.153.175:30351", "/PLAYERID 63192 Lame"], "key": "SendNatPacket"}
2013-09-26 17:21:06,118 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "GameState", "chuncks": ["Lobby"]}
2013-09-26 17:21:06,147 INFO     faf.fa.relayer       Command received from server : {"commands": ["91.121.153.175:30351", "/PLAYERID 63192 Lame"], "key": "SendNatPacket"}
2013-09-26 17:21:06,329 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "ProcessNatPacket", "chuncks": ["91.121.153.175:30351", "PACKET_RECEIVED 6117"]}
2013-09-26 17:21:06,359 INFO     faf.fa.relayer       Command received from server : {"commands": ["twin rivers.v0001"], "key": "HostGame"}
2013-09-26 17:21:06,361 INFO     faf.fa.relayer       Command received from server : {"commands": ["91.121.153.175:30351", "/PLAYERID 63192 Lame"], "key": "SendNatPacket"}
2013-09-26 17:21:06,361 INFO     faf.client           port used : 6117
2013-09-26 17:21:36,924 INFO     faf.fa.relayer       Command received from server : {"commands": [], "key": "ping"}
2013-09-26 17:22:07,926 INFO     faf.fa.relayer       Command received from server : {"commands": [], "key": "ping"}
2013-09-26 17:22:38,927 INFO     faf.fa.relayer       Command received from server : {"commands": [], "key": "ping"}
2013-09-26 17:22:51,887 INFO     faf.fa.relayer       FA disconnected locally.
2013-09-26 17:22:51,887 INFO     faf.fa.relayer       remove relay
2013-09-26 17:22:51,887 DEBUG    faf.fa.relayer       destructor called
2013-09-26 17:22:53,970 INFO     faf.client           FA has finished with exit code: 0
2013-09-26 17:22:53,970 INFO     faf.client           Outgoing JSON Message: {"state": "off", "command": "fa_state"}
2013-09-26 17:22:53,970 INFO     faf.chat             autopostjoin: true


Code:
info: checking C:\Users\f***\Documents\My Games\Gas Powered Games\Supreme Commander Forged Alliance\mods
info: checking C:\Users\f***\Documents\My Games\Gas Powered Games\Supreme Commander Forged Alliance\maps
info: checking C:\ProgramData\FAForever\bin\..\user\My Games\Gas Powered Games\Supreme Commander Forged Alliance\mods
info: checking C:\ProgramData\FAForever\bin\..\user\My Games\Gas Powered Games\Supreme Commander Forged Alliance\maps
info: checking Z:\Program Files (x86)\THQ\Supreme Commander Forged Alliance\gamedata\*.scd
info: DISK: AddSearchPath: 'c:\users\f***\documents\my games\gas powered games\supreme commander forged alliance\mods\4th_dimension_212', mounted as '/mods/4th_dimension_212/'
info: DISK: AddSearchPath: 'c:\users\f***\documents\my games\gas powered games\supreme commander forged alliance\mods\aa acu', mounted as '/mods/aa acu/'
info: DISK: AddSearchPath: 'c:\users\f***\documents\my games\gas powered games\supreme commander forged alliance\mods\auto-adjust-netlag', mounted as '/mods/auto-adjust-netlag/'
info: DISK: AddSearchPath: 'c:\users\f***\documents\my games\gas powered games\supreme commander forged alliance\mods\blackopsacus', mounted as '/mods/blackopsacus/'
info: DISK: AddSearchPath: 'c:\users\f***\documents\my games\gas powered games\supreme commander forged alliance\mods\blackopsexunits', mounted as '/mods/blackopsexunits/'
info: DISK: AddSearchPath: 'c:\users\f***\documents\my games\gas powered games\supreme commander forged alliance\mods\blackopssupport', mounted as '/mods/blackopssupport/'
info: DISK: AddSearchPath: 'c:\users\f***\documents\my games\gas powered games\supreme commander forged alliance\mods\experimental shields v2', mounted as '/mods/experimental shields v2/'
info: DISK: AddSearchPath: 'c:\users\f***\documents\my games\gas powered games\supreme commander forged alliance\mods\finalrushpro3', mounted as '/mods/finalrushpro3/'
info: DISK: AddSearchPath: 'c:\users\f***\documents\my games\gas powered games\supreme commander forged alliance\mods\finalrushpro3.zip', mounted as '/mods/finalrushpro3/'
info: DISK: AddSearchPath: 'c:\users\f***\documents\my games\gas powered games\supreme commander forged alliance\mods\force shields', mounted as '/mods/force shields/'
info: DISK: AddSearchPath: 'c:\users\f***\documents\my games\gas powered games\supreme commander forged alliance\mods\gaz_ui', mounted as '/mods/gaz_ui/'
info: DISK: AddSearchPath: 'c:\users\f***\documents\my games\gas powered games\supreme commander forged alliance\mods\global mod', mounted as '/mods/global mod/'
info: DISK: AddSearchPath: 'c:\users\f***\documents\my games\gas powered games\supreme commander forged alliance\mods\hotbuild.zip', mounted as '/mods/hotbuild/'
info: DISK: AddSearchPath: 'c:\users\f***\documents\my games\gas powered games\supreme commander forged alliance\mods\no tmls', mounted as '/mods/no tmls/'
info: DISK: AddSearchPath: 'c:\users\f***\documents\my games\gas powered games\supreme commander forged alliance\mods\para_for_all', mounted as '/mods/para_for_all/'
info: DISK: AddSearchPath: 'c:\users\f***\documents\my games\gas powered games\supreme commander forged alliance\mods\t3engineeringstations', mounted as '/mods/t3engineeringstations/'
info: DISK: AddSearchPath: 'c:\users\f***\documents\my games\gas powered games\supreme commander forged alliance\mods\totalmayhem', mounted as '/mods/totalmayhem/'
info: DISK: AddSearchPath: 'c:\users\f***\documents\my games\gas powered games\supreme commander forged alliance\mods\tvg_v4.86', mounted as '/mods/tvg_v4.86/'
info: DISK: AddSearchPath: 'c:\users\f***\documents\my games\gas powered games\supreme commander forged alliance\maps\10x10 sentry point.v0001', mounted as '/maps/10x10 sentry point.v0001/'

info: DISK: AddSearchPath: 'c:\users\f***\documents\my games\gas powered games\supreme commander forged alliance\maps\o8o_road_to_vega.v0001', mounted as '/maps/o8o_road_to_vega.v0001/'
info: DISK: AddSearchPath: 'c:\users\f***\documents\my games\gas powered games\supreme commander forged alliance\maps\open waters 20km version.v0001', mounted as '/maps/open waters 20km version.v0001/'
info: DISK: AddSearchPath: 'c:\users\f***\documents\my games\gas powered games\supreme commander forged alliance\maps\open waters v2.v0001', mounted as '/maps/open waters v2.v0001/'
info: DISK: AddSearchPath: 'c:\users\f***\documents\my games\gas powered games\supreme commander forged alliance\maps\open zeta.v0002', mounted as '/maps/open zeta.v0002/'
info: DISK: AddSearchPath: 'c:\users\f***\documents\my games\gas powered games\supreme commander forged alliance\maps\zone control for faf.v0001', mounted as '/maps/zone control for faf.v0001/'
info: DISK: AddSearchPath: 'c:\users\f***\documents\my games\gas powered games\supreme commander forged alliance\maps\zorg rampage.v0001', mounted as '/maps/zorg rampage.v0001/'
info: DISK: AddSearchPath: 'c:\programdata\faforever\gamedata\faforever.nxt', mounted as '/'
info: DISK: AddSearchPath: 'c:\programdata\faforever\gamedata\lobby.nxt', mounted as '/'
info: DISK: AddSearchPath: 'z:\program files (x86)\thq\supreme commander forged alliance\gamedata\ambience.scd', mounted as '/'
info: DISK: AddSearchPath: 'z:\program files (x86)\thq\supreme commander forged alliance\gamedata\editor.scd', mounted as '/'
info: DISK: AddSearchPath: 'z:\program files (x86)\thq\supreme commander forged alliance\gamedata\effects.scd', mounted as '/'
info: DISK: AddSearchPath: 'z:\program files (x86)\thq\supreme commander forged alliance\gamedata\env.scd', mounted as '/'
info: DISK: AddSearchPath: 'z:\program files (x86)\thq\supreme commander forged alliance\gamedata\loc_us.scd', mounted as '/'
info: DISK: AddSearchPath: 'z:\program files (x86)\thq\supreme commander forged alliance\gamedata\lua.scd', mounted as '/'
info: DISK: AddSearchPath: 'z:\program files (x86)\thq\supreme commander forged alliance\gamedata\meshes.scd', mounted as '/'
info: DISK: AddSearchPath: 'z:\program files (x86)\thq\supreme commander forged alliance\gamedata\mods.scd', mounted as '/'
info: DISK: AddSearchPath: 'z:\program files (x86)\thq\supreme commander forged alliance\gamedata\mohodata.scd', mounted as '/'
info: DISK: AddSearchPath: 'z:\program files (x86)\thq\supreme commander forged alliance\gamedata\moholua.scd', mounted as '/'
info: DISK: AddSearchPath: 'z:\program files (x86)\thq\supreme commander forged alliance\gamedata\objects.scd', mounted as '/'
info: DISK: AddSearchPath: 'z:\program files (x86)\thq\supreme commander forged alliance\gamedata\projectiles.scd', mounted as '/'
info: DISK: AddSearchPath: 'z:\program files (x86)\thq\supreme commander forged alliance\gamedata\props.scd', mounted as '/'
info: DISK: AddSearchPath: 'z:\program files (x86)\thq\supreme commander forged alliance\gamedata\schook.scd', mounted as '/'
info: DISK: AddSearchPath: 'z:\program files (x86)\thq\supreme commander forged alliance\gamedata\skins.scd', mounted as '/'
info: DISK: AddSearchPath: 'z:\program files (x86)\thq\supreme commander forged alliance\gamedata\textures.scd', mounted as '/'
info: DISK: AddSearchPath: 'z:\program files (x86)\thq\supreme commander forged alliance\gamedata\units.scd', mounted as '/'
info: DISK: AddSearchPath: 'z:\program files (x86)\thq\supreme commander forged alliance', mounted as '/'
info: Hooked /lua/userInit.lua with /schook/lua/userInit.lua
info: Hooked /lua/globalInit.lua with /schook/lua/globalInit.lua
info: MD5 of global settings: d2a23d6464d3fd77956e7648c43b5077
info: IsStreamingWaveBank("/sounds/aeonselect.xwb") => false
debug: Wavebank prepared: 2e1c488
debug: SND: Loaded WaveBank 'aeonselect' at 2e1c488
info: IsStreamingWaveBank("/sounds/ambienttest.xwb") => false
debug: Wavebank prepared: 2e1c5b8
debug: SND: Loaded WaveBank 'ambienttest' at 2e1c5b8
info: IsStreamingWaveBank("/sounds/cybranselect.xwb") => false
debug: Wavebank prepared: 2e1c6e8
debug: SND: Loaded WaveBank 'cybranselect' at 2e1c6e8
info: IsStreamingWaveBank("/sounds/explosions.xwb") => false
debug: Wavebank prepared: 2e1c818
debug: SND: Loaded WaveBank 'explosions' at 2e1c818
info: IsStreamingWaveBank("/sounds/explosionsstream.xwb") => true
debug: SND: Loaded WaveBank 'explosionsstream' at 2e1c948
info: IsStreamingWaveBank("/sounds/fmv_bg.xwb") => true
debug: SND: Loaded WaveBank 'fmv_bg' at 2e1e2b0
info: IsStreamingWaveBank("/sounds/impacts.xwb") => false
debug: Wavebank prepared: 2e1f418
debug: SND: Loaded WaveBank 'impacts' at 2e1f418
info: IsStreamingWaveBank("/sounds/interface.xwb") => false
debug: Wavebank prepared: 2e1f548
debug: SND: Loaded WaveBank 'interface' at 2e1f548
info: IsStreamingWaveBank("/sounds/music.xwb") => true
debug: SND: Loaded WaveBank 'music' at 2e1f678
info: IsStreamingWaveBank("/sounds/op_briefing.xwb") => true
debug: SND: Loaded WaveBank 'op_briefing' at 2e207e0
info: IsStreamingWaveBank("/sounds/seraphimselect.xwb") => false
debug: Wavebank prepared: 2e21948
debug: SND: Loaded WaveBank 'seraphimselect' at 2e21948
info: IsStreamingWaveBank("/sounds/uaa.xwb") => false
debug: Wavebank prepared: 2e21a78
debug: SND: Loaded WaveBank 'uaa' at 2e21a78
info: IsStreamingWaveBank("/sounds/uaadestroy.xwb") => false
debug: Wavebank prepared: 2e21ba8
debug: SND: Loaded WaveBank 'uaadestroy' at 2e21ba8
info: IsStreamingWaveBank("/sounds/uaaweapon.xwb") => false
debug: Wavebank prepared: 2e21cd8
debug: SND: Loaded WaveBank 'uaaweapon' at 2e21cd8
info: IsStreamingWaveBank("/sounds/uab.xwb") => false
debug: Wavebank prepared: 2e21e08
debug: SND: Loaded WaveBank 'uab' at 2e21e08
info: IsStreamingWaveBank("/sounds/ual.xwb") => false
debug: Wavebank prepared: 2e21f38
debug: SND: Loaded WaveBank 'ual' at 2e21f38
info: IsStreamingWaveBank("/sounds/ualdestroy.xwb") => false
debug: Wavebank prepared: 2e22068
debug: SND: Loaded WaveBank 'ualdestroy' at 2e22068
info: IsStreamingWaveBank("/sounds/ualweapon.xwb") => false
debug: Wavebank prepared: 2e22198
debug: SND: Loaded WaveBank 'ualweapon' at 2e22198
info: IsStreamingWaveBank("/sounds/uas.xwb") => false
debug: Wavebank prepared: 2e222c8
debug: SND: Loaded WaveBank 'uas' at 2e222c8
info: IsStreamingWaveBank("/sounds/uasdestroy.xwb") => true
debug: SND: Loaded WaveBank 'uasdestroy' at 2e223f8
info: IsStreamingWaveBank("/sounds/uasweapon.xwb") => false
debug: Wavebank prepared: 2e23560
debug: SND: Loaded WaveBank 'uasweapon' at 2e23560
info: IsStreamingWaveBank("/sounds/uea.xwb") => false
debug: Wavebank prepared: 2e23690
debug: SND: Loaded WaveBank 'uea' at 2e23690
info: IsStreamingWaveBank("/sounds/ueadestroy.xwb") => false
debug: Wavebank prepared: 2e237d8
debug: SND: Loaded WaveBank 'ueadestroy' at 2e237d8
info: IsStreamingWaveBank("/sounds/ueaweapon.xwb") => false
debug: Wavebank prepared: 2e23910
debug: SND: Loaded WaveBank 'ueaweapon' at 2e23910
info: IsStreamingWaveBank("/sounds/ueb.xwb") => false
debug: Wavebank prepared: 2e23a48
debug: SND: Loaded WaveBank 'ueb' at 2e23a48
info: IsStreamingWaveBank("/sounds/uefselect.xwb") => false
debug: Wavebank prepared: 2e23b80
debug: SND: Loaded WaveBank 'uefselect' at 2e23b80
info: IsStreamingWaveBank("/sounds/uel.xwb") => false
debug: Wavebank prepared: 2e23cb8
debug: SND: Loaded WaveBank 'uel' at 2e23cb8
info: IsStreamingWaveBank("/sounds/ueldestroy.xwb") => false
debug: Wavebank prepared: 2e23df0
debug: SND: Loaded WaveBank 'ueldestroy' at 2e23df0
info: IsStreamingWaveBank("/sounds/uelweapon.xwb") => false
debug: Wavebank prepared: 2e23f28
debug: SND: Loaded WaveBank 'uelweapon' at 2e23f28
info: IsStreamingWaveBank("/sounds/ues.xwb") => false
debug: Wavebank prepared: 2e24060
debug: SND: Loaded WaveBank 'ues' at 2e24060
info: IsStreamingWaveBank("/sounds/uesdestroy.xwb") => true
debug: SND: Loaded WaveBank 'uesdestroy' at 2e257c0
info: IsStreamingWaveBank("/sounds/uesweapon.xwb") => false
debug: Wavebank prepared: 2e24198
debug: SND: Loaded WaveBank 'uesweapon' at 2e24198
info: IsStreamingWaveBank("/sounds/unitrumble.xwb") => false
debug: Wavebank prepared: 2e242d0
debug: SND: Loaded WaveBank 'unitrumble' at 2e242d0
info: IsStreamingWaveBank("/sounds/unitsglobal.xwb") => false
debug: Wavebank prepared: 2e24408
debug: SND: Loaded WaveBank 'unitsglobal' at 2e24408
info: IsStreamingWaveBank("/sounds/ura.xwb") => false
debug: Wavebank prepared: 2e24540
debug: SND: Loaded WaveBank 'ura' at 2e24540
info: IsStreamingWaveBank("/sounds/uradestroy.xwb") => false
debug: Wavebank prepared: 2e24678
debug: SND: Loaded WaveBank 'uradestroy' at 2e24678
info: IsStreamingWaveBank("/sounds/uraweapon.xwb") => false
debug: Wavebank prepared: 2e247b0
debug: SND: Loaded WaveBank 'uraweapon' at 2e247b0
info: IsStreamingWaveBank("/sounds/urb.xwb") => false
debug: Wavebank prepared: 2e248e8
debug: SND: Loaded WaveBank 'urb' at 2e248e8
info: IsStreamingWaveBank("/sounds/url.xwb") => false
debug: Wavebank prepared: 2e24a20
debug: SND: Loaded WaveBank 'url' at 2e24a20
info: IsStreamingWaveBank("/sounds/urldestroy.xwb") => false
debug: Wavebank prepared: 2e24b58
debug: SND: Loaded WaveBank 'urldestroy' at 2e24b58
info: IsStreamingWaveBank("/sounds/urlweapon.xwb") => false
debug: Wavebank prepared: 2e24c90
debug: SND: Loaded WaveBank 'urlweapon' at 2e24c90
info: IsStreamingWaveBank("/sounds/urs.xwb") => false
debug: Wavebank prepared: 2e24dc8
debug: SND: Loaded WaveBank 'urs' at 2e24dc8
info: IsStreamingWaveBank("/sounds/ursdestroy.xwb") => true
debug: SND: Loaded WaveBank 'ursdestroy' at 2e26928
info: IsStreamingWaveBank("/sounds/ursstream.xwb") => true
debug: SND: Loaded WaveBank 'ursstream' at 2e27a90
info: IsStreamingWaveBank("/sounds/ursweapon.xwb") => false
debug: Wavebank prepared: 2e24f00
debug: SND: Loaded WaveBank 'ursweapon' at 2e24f00
info: IsStreamingWaveBank("/sounds/xaa_weapon.xwb") => false
debug: Wavebank prepared: 2e25038
debug: SND: Loaded WaveBank 'xaa_weapon' at 2e25038
info: IsStreamingWaveBank("/sounds/xab.xwb") => false
debug: Wavebank prepared: 2e25170
debug: SND: Loaded WaveBank 'xab' at 2e25170
info: IsStreamingWaveBank("/sounds/xal.xwb") => false
debug: Wavebank prepared: 2e252a8
debug: SND: Loaded WaveBank 'xal' at 2e252a8
info: IsStreamingWaveBank("/sounds/xal_weapon.xwb") => false
debug: Wavebank prepared: 2e253e0
debug: SND: Loaded WaveBank 'xal_weapon' at 2e253e0
info: IsStreamingWaveBank("/sounds/xas.xwb") => false
debug: Wavebank prepared: 2e25518
debug: SND: Loaded WaveBank 'xas' at 2e25518
info: IsStreamingWaveBank("/sounds/xas_weapons.xwb") => false
debug: Wavebank prepared: 2e25650
debug: SND: Loaded WaveBank 'xas_weapons' at 2e25650
info: IsStreamingWaveBank("/sounds/xea.xwb") => false
debug: Wavebank prepared: 2e28c10
debug: SND: Loaded WaveBank 'xea' at 2e28c10
info: IsStreamingWaveBank("/sounds/xea_weapons.xwb") => false
debug: Wavebank prepared: 2e28d48
debug: SND: Loaded WaveBank 'xea_weapons' at 2e28d48
info: IsStreamingWaveBank("/sounds/xeb.xwb") => false
debug: Wavebank prepared: 2e28e80
debug: SND: Loaded WaveBank 'xeb' at 2e28e80
info: IsStreamingWaveBank("/sounds/xel.xwb") => false
debug: Wavebank prepared: 2e28fb8
debug: SND: Loaded WaveBank 'xel' at 2e28fb8
info: IsStreamingWaveBank("/sounds/xel_weapons.xwb") => false
debug: Wavebank prepared: 2e290f0
debug: SND: Loaded WaveBank 'xel_weapons' at 2e290f0
info: IsStreamingWaveBank("/sounds/xes.xwb") => false
debug: Wavebank prepared: 2e29228
debug: SND: Loaded WaveBank 'xes' at 2e29228
info: IsStreamingWaveBank("/sounds/xes_destroy.xwb") => true
debug: SND: Loaded WaveBank 'xes_destroy' at 2e2abf8
info: IsStreamingWaveBank("/sounds/xes_weapons.xwb") => false
debug: Wavebank prepared: 2e29360
debug: SND: Loaded WaveBank 'xes_weapons' at 2e29360
info: IsStreamingWaveBank("/sounds/xra.xwb") => false
debug: Wavebank prepared: 2e29498
debug: SND: Loaded WaveBank 'xra' at 2e29498
info: IsStreamingWaveBank("/sounds/xra_weapon.xwb") => false
debug: Wavebank prepared: 2e295d0
debug: SND: Loaded WaveBank 'xra_weapon' at 2e295d0
info: IsStreamingWaveBank("/sounds/xrb.xwb") => false
debug: Wavebank prepared: 2e29708
debug: SND: Loaded WaveBank 'xrb' at 2e29708
info: IsStreamingWaveBank("/sounds/xrl.xwb") => false
debug: Wavebank prepared: 2e29840
debug: SND: Loaded WaveBank 'xrl' at 2e29840
info: IsStreamingWaveBank("/sounds/xrl_stream.xwb") => true
debug: SND: Loaded WaveBank 'xrl_stream' at 2e2bd60
info: IsStreamingWaveBank("/sounds/xrl_weapon.xwb") => false
debug: Wavebank prepared: 2e29978
debug: SND: Loaded WaveBank 'xrl_weapon' at 2e29978
info: IsStreamingWaveBank("/sounds/xrs.xwb") => false
debug: Wavebank prepared: 2e29ab0
debug: SND: Loaded WaveBank 'xrs' at 2e29ab0
info: IsStreamingWaveBank("/sounds/xrs_weapon.xwb") => false
debug: Wavebank prepared: 2e29be8
debug: SND: Loaded WaveBank 'xrs_weapon' at 2e29be8
info: IsStreamingWaveBank("/sounds/xsa.xwb") => false
debug: Wavebank prepared: 2e29d20
debug: SND: Loaded WaveBank 'xsa' at 2e29d20
info: IsStreamingWaveBank("/sounds/xsa_destroy.xwb") => false
debug: Wavebank prepared: 2e29e58
debug: SND: Loaded WaveBank 'xsa_destroy' at 2e29e58
info: IsStreamingWaveBank("/sounds/xsa_weapon.xwb") => false
debug: Wavebank prepared: 2e29f90
debug: SND: Loaded WaveBank 'xsa_weapon' at 2e29f90
info: IsStreamingWaveBank("/sounds/xsb.xwb") => false
debug: Wavebank prepared: 2e2a0c8
debug: SND: Loaded WaveBank 'xsb' at 2e2a0c8
info: IsStreamingWaveBank("/sounds/xsb_weapon.xwb") => false
debug: Wavebank prepared: 2e2a200
debug: SND: Loaded WaveBank 'xsb_weapon' at 2e2a200
info: IsStreamingWaveBank("/sounds/xsl.xwb") => false
debug: Wavebank prepared: 2e2a338
debug: SND: Loaded WaveBank 'xsl' at 2e2a338
info: IsStreamingWaveBank("/sounds/xsl_destroy.xwb") => false
debug: Wavebank prepared: 2e2a470
debug: SND: Loaded WaveBank 'xsl_destroy' at 2e2a470
info: IsStreamingWaveBank("/sounds/xsl_weapon.xwb") => false
debug: Wavebank prepared: 2e2a5a8
debug: SND: Loaded WaveBank 'xsl_weapon' at 2e2a5a8
info: IsStreamingWaveBank("/sounds/xss.xwb") => false
debug: Wavebank prepared: 2e2a6e0
debug: SND: Loaded WaveBank 'xss' at 2e2a6e0
info: IsStreamingWaveBank("/sounds/xss_destroy.xwb") => true
debug: SND: Loaded WaveBank 'xss_destroy' at 2e2cec8
info: IsStreamingWaveBank("/sounds/xss_weapon.xwb") => false
debug: Wavebank prepared: 2e2a818
debug: SND: Loaded WaveBank 'xss_weapon' at 2e2a818
debug: SND: Loaded SoundBank 'ambienttest'
debug: SND: Loaded SoundBank 'explosions'
debug: SND: Loaded SoundBank 'fmv_bg'
debug: SND: Loaded SoundBank 'impacts'
debug: SND: Loaded SoundBank 'interface'
debug: SND: Loaded SoundBank 'music'
debug: SND: Loaded SoundBank 'op_briefing'
debug: SND: Loaded SoundBank 'seraphimselect'
debug: SND: Loaded SoundBank 'uaa'
debug: SND: Loaded SoundBank 'uaadestroy'
debug: SND: Loaded SoundBank 'uaaweapon'
debug: SND: Loaded SoundBank 'uab'
debug: SND: Loaded SoundBank 'ual'
debug: SND: Loaded SoundBank 'ualdestroy'
debug: SND: Loaded SoundBank 'ualweapon'
debug: SND: Loaded SoundBank 'uas'
debug: SND: Loaded SoundBank 'uasdestroy'
debug: SND: Loaded SoundBank 'uasweapon'
debug: SND: Loaded SoundBank 'uea'
debug: SND: Loaded SoundBank 'ueadestroy'
debug: SND: Loaded SoundBank 'ueaweapon'
debug: SND: Loaded SoundBank 'ueb'
debug: SND: Loaded SoundBank 'uel'
debug: SND: Loaded SoundBank 'ueldestroy'
debug: SND: Loaded SoundBank 'uelweapon'
debug: SND: Loaded SoundBank 'ues'
debug: SND: Loaded SoundBank 'uesdestroy'
debug: SND: Loaded SoundBank 'uesweapon'
debug: SND: Loaded SoundBank 'unitrumble'
debug: SND: Loaded SoundBank 'unitsglobal'
debug: SND: Loaded SoundBank 'ura'
debug: SND: Loaded SoundBank 'uradestroy'
debug: SND: Loaded SoundBank 'uraweapon'
debug: SND: Loaded SoundBank 'urb'
debug: SND: Loaded SoundBank 'url'
debug: SND: Loaded SoundBank 'urldestroy'
debug: SND: Loaded SoundBank 'urlweapon'
debug: SND: Loaded SoundBank 'urs'
debug: SND: Loaded SoundBank 'ursdestroy'
debug: SND: Loaded SoundBank 'ursstream'
debug: SND: Loaded SoundBank 'ursweapon'
debug: SND: Loaded SoundBank 'xaa'
debug: SND: Loaded SoundBank 'xaa_weapon'
debug: SND: Loaded SoundBank 'xab'
debug: SND: Loaded SoundBank 'xal'
debug: SND: Loaded SoundBank 'xal_weapon'
debug: SND: Loaded SoundBank 'xas'
debug: SND: Loaded SoundBank 'xas_weapon'
debug: SND: Loaded SoundBank 'xca'
debug: SND: Loaded SoundBank 'xcb'
debug: SND: Loaded SoundBank 'xcl'
debug: SND: Loaded SoundBank 'xcs'
debug: SND: Loaded SoundBank 'xea'
debug: SND: Loaded SoundBank 'xea_weapon'
debug: SND: Loaded SoundBank 'xeb'
debug: SND: Loaded SoundBank 'xel'
debug: SND: Loaded SoundBank 'xel_weapons'
debug: SND: Loaded SoundBank 'xes'
debug: SND: Loaded SoundBank 'xes_destroy'
debug: SND: Loaded SoundBank 'xes_weapons'
debug: SND: Loaded SoundBank 'xra'
debug: SND: Loaded SoundBank 'xra_weapon'
debug: SND: Loaded SoundBank 'xrb'
debug: SND: Loaded SoundBank 'xrl'
debug: SND: Loaded SoundBank 'xrl_destroy'
debug: SND: Loaded SoundBank 'xrl_stream'
debug: SND: Loaded SoundBank 'xrl_weapon'
debug: SND: Loaded SoundBank 'xrs'
debug: SND: Loaded SoundBank 'xrs_weapon'
debug: SND: Loaded SoundBank 'xsa'
debug: SND: Loaded SoundBank 'xsa_destroy'
debug: SND: Loaded SoundBank 'xsa_weapon'
debug: SND: Loaded SoundBank 'xsb'
debug: SND: Loaded SoundBank 'xsb_weapon'
debug: SND: Loaded SoundBank 'xsl'
debug: SND: Loaded SoundBank 'xsl_destroy'
debug: SND: Loaded SoundBank 'xsl_weapon'
debug: SND: Loaded SoundBank 'xss'
debug: SND: Loaded SoundBank 'xss_destroy'
debug: SND: Loaded SoundBank 'xss_weapon'
debug: MEM: -55576832 bytes SND
info: MD5 of global settings: d2a23d6464d3fd77956e7648c43b5077
info: IsStreamingWaveBank("/sounds/voice/us/briefings.xwb") => true
debug: SND: Loaded WaveBank 'briefings' at 2e5c380
info: IsStreamingWaveBank("/sounds/voice/us/seraphim_language.xwb") => true
debug: SND: Loaded WaveBank 'seraphim_language' at 2e5d4e8
info: IsStreamingWaveBank("/sounds/voice/us/x01_vo.xwb") => true
debug: SND: Loaded WaveBank 'x01_vo' at 2e5e668
info: IsStreamingWaveBank("/sounds/voice/us/x02_vo.xwb") => true
debug: SND: Loaded WaveBank 'x02_vo' at 2e5e7d0
info: IsStreamingWaveBank("/sounds/voice/us/x03_vo.xwb") => true
debug: SND: Loaded WaveBank 'x03_vo' at 2e5e938
info: IsStreamingWaveBank("/sounds/voice/us/x04_vo.xwb") => true
debug: SND: Loaded WaveBank 'x04_vo' at 2e5eaa0
info: IsStreamingWaveBank("/sounds/voice/us/x05_vo.xwb") => true
debug: SND: Loaded WaveBank 'x05_vo' at 2e5ec08
info: IsStreamingWaveBank("/sounds/voice/us/x06_vo.xwb") => true
debug: SND: Loaded WaveBank 'x06_vo' at 2e5ed70
info: IsStreamingWaveBank("/sounds/voice/us/x1t_vo.xwb") => true
debug: SND: Loaded WaveBank 'x1t_vo' at 2e5eed8
info: IsStreamingWaveBank("/sounds/voice/us/x_fmv.xwb") => true
debug: SND: Loaded WaveBank 'x_fmv' at 2e5f040
info: IsStreamingWaveBank("/sounds/voice/us/xgg.xwb") => true
debug: SND: Loaded WaveBank 'xgg' at 2e5f1a8
debug: SND: Loaded SoundBank 'briefings'
debug: SND: Loaded SoundBank 'x01_vo'
debug: SND: Loaded SoundBank 'x02_vo'
debug: SND: Loaded SoundBank 'x03_vo'
debug: SND: Loaded SoundBank 'x04_vo'
debug: SND: Loaded SoundBank 'x05_vo'
debug: SND: Loaded SoundBank 'x06_vo'
debug: SND: Loaded SoundBank 'x1t_vo'
debug: SND: Loaded SoundBank 'x_fmv'
debug: SND: Loaded SoundBank 'xgg'
debug: MEM: -796091502 bytes SND
info: MD5 of global settings: d2a23d6464d3fd77956e7648c43b5077
debug: MEM: -796091502 bytes SND
debug: Loading module '\000/lua/sim/buffdefinitions.lua\000'
debug: Loading module '\000/lua/sim/adjacencybuffs.lua\000'
debug: Loading module '\000/lua/sim/adjacencybufffunctions.lua\000'
debug: Loading module '\000/lua/sim/cheatbuffs.lua\000'
debug: Loading module '\000/lua/keymap/keymapper.lua\000'
debug: Loading module '\000/lua/user/prefs.lua\000'
debug: Loading module '\000/lua/options/optionslogic.lua\000'
debug: Loading module '\000/lua/keymap/keyactions.lua\000'
info: Clearing cheats from added keymap.
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Alt
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Ctrl
warning: Key map contains unrecognized modifier string: Shift
warning: Key map contains unrecognized modifier string: Alt
info: adding font file /fonts/arial.ttf
info: adding font file /fonts/arialbd.ttf
info: adding font file /fonts/arialbi.ttf
info: adding font file /fonts/ariali.ttf
info: adding font file /fonts/arialn.ttf
info: adding font file /fonts/arialnb.ttf
info: adding font file /fonts/arialnbi.ttf
info: adding font file /fonts/arialni.ttf
info: adding font file /fonts/ariblk.ttf
info: adding font file /fonts/arlrdbd.ttf
info: adding font file /fonts/butterbe.ttf
info: adding font file /fonts/vdub.ttf
info: adding font file /fonts/wintermu.ttf
info: adding font file /fonts/zeroes_3.ttf
debug: Loading module '\000/lua/keymap/keynames.lua\000'
info: Compiled shader: /effects/cartographic.fx
info: Compiled shader: /effects/frame.fx
info: Compiled shader: /effects/mesh.fx
info: Compiled shader: /effects/particle.fx
info: Compiled shader: /effects/primbatcher.fx
info: Compiled shader: /effects/range.fx
info: Compiled shader: /effects/sky.fx
info: Compiled shader: /effects/terrain.fx
info: Compiled shader: /effects/ui.fx
info: Compiled shader: /effects/vision.fx
info: Compiled shader: /effects/water2.fx
info: SHADERS COMPILED
debug: Loading module '\000/lua/options/options.lua\000'
debug: Loading module '\000/lua/ui/uiutil.lua\000'
debug: Loading module '\000/lua/lazyvar.lua\000'
debug: Loading module '\000/lua/maui/layouthelpers.lua\000'
debug: Loading module '\000/lua/maui/group.lua\000'
debug: Loading module '\000/lua/maui/control.lua\000'
debug: Loading module '\000/lua/maui/text.lua\000'
debug: Loading module '\000/lua/maui/multilinetext.lua\000'
debug: Loading module '\000/lua/maui/button.lua\000'
debug: Loading module '\000/lua/maui/bitmap.lua\000'
debug: Loading module '\000/lua/maui/dragger.lua\000'
debug: Loading module '\000/lua/maui/edit.lua\000'
debug: Loading module '\000/lua/maui/checkbox.lua\000'
debug: Loading module '\000/lua/maui/scrollbar.lua\000'
debug: Loading module '\000/lua/maui/cursor.lua\000'
debug: Loading module '\000/lua/maui/border.lua\000'
debug: Loading module '\000/lua/maui/itemlist.lua\000'
debug: Loading module '\000/lua/skins/layouts.lua\000'
debug: Wavebank prepared: 2e1c948
debug: Wavebank prepared: 2e1e2b0
debug: Wavebank prepared: 2e1f678
debug: Wavebank prepared: 2e207e0
debug: Wavebank prepared: 2e223f8
debug: Wavebank prepared: 2e257c0
debug: Wavebank prepared: 2e26928
debug: Wavebank prepared: 2e27a90
debug: Wavebank prepared: 2e2abf8
debug: Wavebank prepared: 2e2bd60
debug: Wavebank prepared: 2e2cec8
debug: Wavebank prepared: 2e5c380
debug: Wavebank prepared: 2e5d4e8
debug: Wavebank prepared: 2e5e7d0
debug: Wavebank prepared: 2e5e938
debug: Wavebank prepared: 2e5eaa0
debug: Wavebank prepared: 2e5ec08
debug: Wavebank prepared: 2e5ed70
debug: Wavebank prepared: 2e5eed8
debug: Wavebank prepared: 2e5f040
debug: Loading module '\000/lua/maui/frame.lua\000'
debug: Loading module '\000/lua/ui/uimain.lua\000'
debug: Loading module '\000/lua/multiplayer/onlineprovider.lua\000'
debug: Loading module '\000/lua/ui/campaign/campaignmanager.lua\000'
debug: Loading module '\000/lua/skins/skins.lua\000'
debug: Loading module '\000/lua/multiplayer/gpgnet.lua\000'
info: GPGNET: entering idle state.
debug: Wavebank prepared: 2e5e668
debug: Wavebank prepared: 2e5f1a8
debug: Loading module '\000/lua/ui/lobby/autolobby.lua\000'
debug: Loading module '\000/lua/ui/menus/menucommon.lua\000'
debug: Loading module '\000/lua/ui/game/tooltip.lua\000'
debug: Loading module '\000/lua/ui/help/tooltips.lua\000'
debug: Loading module '\000/lua/keymap/defaultkeymap.lua\000'
debug: Loading module '\000/lua/ui/lobby/lobbycomm.lua\000'
debug: Loading module '\000/lua/gamecolors.lua\000'
info: Warning: Unable to find file \000/menus02/background-paint_black_bmp.dds
info: Unable to load texture from file: /menus02/background-paint_black_bmp.dds
info: GPGNET: setting nat handler to 0x11433004
info: LOBBY: Game port 6112[UDP] opened.
info: LOBBY: starting with local uid of 63192 [Lame]
info: GPGNET: entering lobby state.
info: GPGNET: sending nat packet to 91.121.153.175:30351
info: GPGNET: sending nat packet to 91.121.153.175:30351
info: GPGNET: received nat packet from 91.121.153.175:30351
info: Warning: Unable to find file \000/menus02/background-paint_black_bmp.dds
info: Unable to load texture from file: /menus02/background-paint_black_bmp.dds
info: /players
debug: Loading module '\000/lua/factions.lua\000'
info: /team
info: /deviation
info: /mean
info: /numgames
info: Local player info: {
info:   AIPersonality="",
info:   ArmyColor=1,
info:   Civilian=false,
info:   DEV=47.168300628662,
info:   Faction=4,
info:   Human=true,
info:   MEAN=1255.1700439453,
info:   NG="",
info:   PL=1113,
info:   PlayerColor=1,
info:   PlayerName="Lame",
info:   Ready=false,
info:   StartSpot=1,
info:   Team=1
info: }
info: GPGNET: sending nat packet to 91.121.153.175:30351
info: CNetTCPBuf::Read(): recv() failed: WSAEINTR
info: Run time: 0h01m55s

Statistics: Posted by Lame — 26 Sep 2013, 17:28


]]>
2013-09-26T17:06:14+02:00 2013-09-26T17:06:14+02:00 /viewtopic.php?t=5272&p=54542#p54542 <![CDATA[Re: Connection issues]]>
I also need that from the players you are trouble connecting to. (same test session).

Statistics: Posted by Ze_PilOt — 26 Sep 2013, 17:06


]]>
2013-09-26T16:57:32+02:00 2013-09-26T16:57:32+02:00 /viewtopic.php?t=5272&p=54541#p54541 <![CDATA[Connection issues]]> Today i'm having a lot of trouble connection to some players while beeing able to play with others with only minor problems (2*temporary disconnect in 1 game). This didnt happen to me like that before.

this log should cover me trying to join a teamgame
and after trying to launch a ladder automatch

Code:
2013-09-26 16:42:27,318 DEBUG    faf.fa.proxies       Setting low delay on socket.
2013-09-26 16:42:27,318 INFO     faf.fa.proxies       Connected to proxy server direct.faforever.com:9123
2013-09-26 16:42:27,318 INFO     faf.fa.relayer       Command received from server : {"commands": [10090], "key": "DisconnectFromPeer"}
2013-09-26 16:42:27,318 INFO     faf.fa.relayer       Command received from server : {"commands": [4, "83.8.244.231", "silver_eye", 10090], "key": "ConnectToProxy"}
2013-09-26 16:42:30,921 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "ProcessNatPacket", "chuncks": ["85.23.172.95:6112", "/PLAYERID 32970 BC_Tiep"]}
2013-09-26 16:42:30,921 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "ProcessNatPacket", "chuncks": ["178.25.167.182:6112", "/PLAYERID 18383 DNF_Stephelord"]}
2013-09-26 16:42:30,921 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "ProcessNatPacket", "chuncks": ["178.25.167.182:6112", "/ASKREPLY DNF_Stephelord"]}
2013-09-26 16:42:30,921 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "ProcessNatPacket", "chuncks": ["91.158.49.210:6112", "/PLAYERID 39721 Hartza"]}
2013-09-26 16:42:30,921 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "ProcessNatPacket", "chuncks": ["109.182.36.42:28000", "/PLAYERID 37639 RK4000"]}
2013-09-26 16:42:30,921 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "ProcessNatPacket", "chuncks": ["109.182.36.42:28000", "/PLAYERID 37639 RK4000"]}
2013-09-26 16:42:30,921 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "ProcessNatPacket", "chuncks": ["109.182.36.42:28000", "/ASKREPLY RK4000"]}
2013-09-26 16:42:30,921 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "ProcessNatPacket", "chuncks": ["87.225.34.66:6112", "/PLAYERID 13497 RA_Shado"]}
2013-09-26 16:42:30,921 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "ProcessNatPacket", "chuncks": ["87.225.34.66:6112", "/ASKREPLY RA_Shado"]}
2013-09-26 16:42:30,921 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "ProcessNatPacket", "chuncks": ["87.225.34.66:6112", "/PLAYERID 13497 RA_Shado"]}
2013-09-26 16:42:30,923 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "ProcessNatPacket", "chuncks": ["87.225.34.66:6112", "/ASKREPLY RA_Shado"]}
2013-09-26 16:42:30,923 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "ProcessNatPacket", "chuncks": ["91.158.49.210:6112", "/PLAYERID 39721 Hartza"]}
2013-09-26 16:42:30,923 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "ProcessNatPacket", "chuncks": ["91.158.49.210:6112", "/ASKREPLY Hartza"]}
2013-09-26 16:42:30,923 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "ProcessNatPacket", "chuncks": ["85.23.172.95:6112", "/PLAYERID 32970 BC_Tiep"]}
2013-09-26 16:42:30,924 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "ProcessNatPacket", "chuncks": ["85.23.172.95:6112", "/ASKREPLY BC_Tiep"]}
2013-09-26 16:42:31,109 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "Connected", "chuncks": ["48295"]}
2013-09-26 16:42:35,825 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "Connected", "chuncks": ["32970"]}
2013-09-26 16:42:35,825 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "Connected", "chuncks": ["10090"]}
2013-09-26 16:42:35,825 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "Connected", "chuncks": ["43282"]}
2013-09-26 16:42:35,825 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "Connected", "chuncks": ["37639"]}
2013-09-26 16:42:35,826 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "Connected", "chuncks": ["18383"]}
2013-09-26 16:42:35,826 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "Connected", "chuncks": ["39721"]}
2013-09-26 16:42:44,280 INFO     faf.fa.relayer       Command received from server : {"commands": [], "key": "ping"}
2013-09-26 16:42:56,423 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "Chat", "chuncks": ["hacks"]}
2013-09-26 16:43:05,915 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "Chat", "chuncks": ["this was 5/8 one minute ago"]}
2013-09-26 16:43:15,282 INFO     faf.fa.relayer       Command received from server : {"commands": [], "key": "ping"}
2013-09-26 16:43:42,278 INFO     faf.fa.relayer       FA disconnected locally.
2013-09-26 16:43:42,278 INFO     faf.fa.proxies       disconnecting from proxy server
2013-09-26 16:43:42,279 INFO     faf.fa.relayer       remove relay
2013-09-26 16:43:42,279 DEBUG    faf.fa.relayer       destructor called
2013-09-26 16:43:42,431 WARNING  faf.fa.proxies       error writing to proxy server !
2013-09-26 16:43:42,431 WARNING  faf.fa.proxies       error writing to proxy server !
2013-09-26 16:43:42,431 WARNING  faf.fa.proxies       error writing to proxy server !
2013-09-26 16:43:42,433 WARNING  faf.fa.proxies       error writing to proxy server !
2013-09-26 16:43:42,701 WARNING  faf.fa.proxies       error writing to proxy server !
2013-09-26 16:43:42,704 WARNING  faf.fa.proxies       error writing to proxy server !
2013-09-26 16:43:42,799 WARNING  faf.fa.proxies       error writing to proxy server !
2013-09-26 16:43:42,809 WARNING  faf.fa.proxies       error writing to proxy server !
2013-09-26 16:43:43,288 WARNING  faf.fa.proxies       error writing to proxy server !
2013-09-26 16:43:43,289 WARNING  faf.fa.proxies       error writing to proxy server !
2013-09-26 16:43:43,607 INFO     faf.client           FA has finished with exit code: 0
2013-09-26 16:43:43,607 INFO     faf.client           Outgoing JSON Message: {"state": "off", "command": "fa_state"}
2013-09-26 16:43:43,608 INFO     faf.chat             autopostjoin: true
2013-09-26 16:44:19,447 INFO     faf.fa               Checking FA for: ladder1v1 and map None
2013-09-26 16:44:19,447 INFO     faf.fa               Updating FA for mod: ladder1v1, version None
2013-09-26 16:44:19,448 DEBUG    faf.updater          Update started at 2013-09-26 16:44:19
2013-09-26 16:44:19,448 DEBUG    faf.updater          Using game path: Z:\Program Files (x86)\THQ\Supreme Commander Forged Alliance
2013-09-26 16:44:19,448 DEBUG    faf.updater          Using appdata: C:\ProgramData\FAForever
2013-09-26 16:44:19,611 DEBUG    faf.updater          Connected to update server at 2013-09-26 16:44:19
2013-09-26 16:44:19,615 DEBUG    faf.updater          writeToServer(GET_FILES_TO_UPDATE, [FAF])
2013-09-26 16:44:19,644 DEBUG    faf.updater          handleAction(LIST_FILES_TO_UP) - 324 bytes
2013-09-26 16:44:19,645 DEBUG    faf.updater          Files to update: [ForgedAlliance.exe, init_faf.lua, init_ladder1v1.lua, GDFBinary.dll, SupComDataPath.lua, SupComDataPathFAF.lua, init_nonxt.lua]
2013-09-26 16:44:19,647 DEBUG    faf.updater          writeToServer(UPDATE, [bin, init_nonxt.lua, 46d9008f6b77d2c60f96272a816e4227])
2013-09-26 16:44:19,648 DEBUG    faf.updater          writeToServer(UPDATE, [bin, GDFBinary.dll, 3fc9e7684d150da5c51db71d2399f316])
2013-09-26 16:44:19,650 DEBUG    faf.updater          writeToServer(UPDATE, [bin, init_faf.lua, 7d5cebd90024c4c5dc44ae8f5c9fa35b])
2013-09-26 16:44:19,687 DEBUG    faf.updater          writeToServer(UPDATE, [bin, ForgedAlliance.exe, b779d298a8ac4412dfbcc7667cf5578f])
2013-09-26 16:44:19,687 DEBUG    faf.updater          writeToServer(UPDATE, [bin, SupComDataPath.lua, 55ac1ef97845f2291da64b830299331e])
2013-09-26 16:44:19,688 DEBUG    faf.updater          writeToServer(UPDATE, [bin, SupComDataPathFAF.lua, 962c9d1327657d77184adcf358c628f1])
2013-09-26 16:44:19,690 DEBUG    faf.updater          writeToServer(UPDATE, [bin, init_ladder1v1.lua, ea96ac9cec88af29c08556c96465acfe])
2013-09-26 16:44:19,726 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 56 bytes
2013-09-26 16:44:19,726 DEBUG    faf.updater          file : init_nonxt.lua
2013-09-26 16:44:19,726 DEBUG    faf.updater          init_nonxt.lua is up to date.
2013-09-26 16:44:19,970 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 54 bytes
2013-09-26 16:44:19,970 DEBUG    faf.updater          file : GDFBinary.dll
2013-09-26 16:44:19,970 DEBUG    faf.updater          GDFBinary.dll is up to date.
2013-09-26 16:44:19,970 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 52 bytes
2013-09-26 16:44:19,970 DEBUG    faf.updater          file : init_faf.lua
2013-09-26 16:44:19,971 DEBUG    faf.updater          init_faf.lua is up to date.
2013-09-26 16:44:19,971 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 64 bytes
2013-09-26 16:44:19,971 DEBUG    faf.updater          file : ForgedAlliance.exe
2013-09-26 16:44:19,971 DEBUG    faf.updater          ForgedAlliance.exe is up to date.
2013-09-26 16:44:19,973 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 64 bytes
2013-09-26 16:44:19,973 DEBUG    faf.updater          file : SupComDataPath.lua
2013-09-26 16:44:19,973 DEBUG    faf.updater          SupComDataPath.lua is up to date.
2013-09-26 16:44:19,973 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 70 bytes
2013-09-26 16:44:19,973 DEBUG    faf.updater          file : SupComDataPathFAF.lua
2013-09-26 16:44:19,973 DEBUG    faf.updater          SupComDataPathFAF.lua is up to date.
2013-09-26 16:44:19,974 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 64 bytes
2013-09-26 16:44:19,974 DEBUG    faf.updater          file : init_ladder1v1.lua
2013-09-26 16:44:19,974 DEBUG    faf.updater          init_ladder1v1.lua is up to date.
2013-09-26 16:44:19,976 DEBUG    faf.updater          Updates applied successfully.
2013-09-26 16:44:19,976 DEBUG    faf.updater          writeToServer(GET_FILES_TO_UPDATE, [FAFGAMEDATA])
2013-09-26 16:44:20,012 DEBUG    faf.updater          handleAction(LIST_FILES_TO_UP) - 134 bytes
2013-09-26 16:44:20,013 DEBUG    faf.updater          Files to update: [faforever.faf, faforever.nxt, lobby.nxt]
2013-09-26 16:44:20,023 DEBUG    faf.updater          writeToServer(UPDATE, [gamedata, faforever.faf, 01918c842de543150cfc20cd511986ac])
2013-09-26 16:44:20,211 DEBUG    faf.updater          writeToServer(UPDATE, [gamedata, faforever.nxt, e046d2c5af04f78aca023941c1abd949])
2013-09-26 16:44:20,234 DEBUG    faf.updater          writeToServer(UPDATE, [gamedata, lobby.nxt, 9e6521423cc955e2cfb821839d482226])
2013-09-26 16:44:20,269 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 54 bytes
2013-09-26 16:44:20,269 DEBUG    faf.updater          file : faforever.faf
2013-09-26 16:44:20,269 DEBUG    faf.updater          faforever.faf is up to date.
2013-09-26 16:44:20,569 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 54 bytes
2013-09-26 16:44:20,569 DEBUG    faf.updater          file : faforever.nxt
2013-09-26 16:44:20,569 DEBUG    faf.updater          faforever.nxt is up to date.
2013-09-26 16:44:20,571 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 46 bytes
2013-09-26 16:44:20,571 DEBUG    faf.updater          file : lobby.nxt
2013-09-26 16:44:20,571 DEBUG    faf.updater          lobby.nxt is up to date.
2013-09-26 16:44:20,571 DEBUG    faf.updater          Updates applied successfully.
2013-09-26 16:44:20,571 DEBUG    faf.updater          Disconnected from server at 2013-09-26 16:44:20
2013-09-26 16:44:20,615 DEBUG    faf.updater          Update finished at 2013-09-26 16:44:20
2013-09-26 16:44:20,615 INFO     faf.fa               Writing fa_path.lua config file.
2013-09-26 16:44:20,622 INFO     faf.fa.upnp          Creating UPnP port mappings...
2013-09-26 16:44:20,625 ERROR    faf.fa.upnp          Couldn't get StaticPortMappingCollection
2013-09-26 16:44:20,625 INFO     faf.games            Starting Ranked Search as /seraphim, port: 6112
2013-09-26 16:44:20,627 INFO     faf.client           Outgoing JSON Message: {"state": "start", "mod": "ladder1v1", "command": "game_matchmaking", "faction": "/seraphim", "gameport": 6112}
2013-09-26 16:44:30,631 DEBUG    faf.games            Expanding search to 0.05
2013-09-26 16:44:30,631 INFO     faf.client           Outgoing JSON Message: {"rate": 0.05, "command": "game_matchmaking", "state": "expand", "mod": "ladder1v1"}
2013-09-26 16:44:40,631 DEBUG    faf.games            Expanding search to 0.1
2013-09-26 16:44:40,631 INFO     faf.client           Outgoing JSON Message: {"rate": 0.1, "command": "game_matchmaking", "state": "expand", "mod": "ladder1v1"}
2013-09-26 16:44:45,460 INFO     faf.client           Handling game_launch via JSON {u'uid': 1336952, u'args': [u'/players 2', u'/team 2'], u'mapname': u'8 - badlands_v4.v0001', u'reason': u'ranked', u'command': u'game_launch', u'mod': u'ladder1v1'}
2013-09-26 16:44:45,460 INFO     faf.fa               Updating FA for map: 8 - badlands_v4.v0001
2013-09-26 16:44:45,460 INFO     faf.fa               Map is available.
2013-09-26 16:44:45,460 INFO     faf.fa.upnp          Creating UPnP port mappings...
2013-09-26 16:44:45,463 ERROR    faf.fa.upnp          Couldn't get StaticPortMappingCollection
2013-09-26 16:44:45,463 INFO     faf.fa               Running FA with info: {'recorder': u'Lame', 'game_time': 1380206685.463, 'uid': 1336952, 'version_info': {'lobby': '0.8.80'}, 'featured_mod': u'ladder1v1'}
2013-09-26 16:44:45,463 INFO     faf.fa               Running FA via command: "C:\ProgramData\FAForever\bin\ForgedAlliance.exe" /players 2 /team 2 /seraphim /mean 1255.1671099 /deviation 47.1682978881 /init init_ladder1v1.lua /savereplay gpgnet://localhost/1336952/Lame.SCFAreplay /nobugreport /gpgnet 127.0.0.1:58647
2013-09-26 16:44:45,483 INFO     faf.client           FA has launched in an attached process.
2013-09-26 16:44:45,483 INFO     faf.client           Outgoing JSON Message: {"state": "on", "command": "fa_state"}
2013-09-26 16:44:45,483 DEBUG    faf.games            Stopping Ranked Search
2013-09-26 16:44:45,483 INFO     faf.client           Outgoing JSON Message: {"state": "stop", "command": "game_matchmaking", "mod": "ladder1v1"}
2013-09-26 16:44:53,832 DEBUG    faf.fa.relayserver   incoming connection to relay server...
2013-09-26 16:44:53,832 INFO     faf.fa.relayer       FA connected locally.
2013-09-26 16:44:53,861 DEBUG    faf.fa.relayer       faf server direct.faforever.com:8000
2013-09-26 16:44:53,861 DEBUG    faf.fa.relayer       Initializing ping timer
2013-09-26 16:44:53,861 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "GameState", "chuncks": ["Idle"]}
2013-09-26 16:44:53,894 INFO     faf.fa.relayer       Command received from server : {"commands": [1, 6112, "Lame", 63192, 1], "key": "CreateLobby"}
2013-09-26 16:44:53,894 INFO     faf.fa.relayer       Command received from server : {"commands": ["91.121.153.175:30351", "/PLAYERID 63192 Lame"], "key": "SendNatPacket"}
2013-09-26 16:44:53,953 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "GameState", "chuncks": ["Lobby"]}
2013-09-26 16:44:54,095 INFO     faf.fa.relayer       Command received from server : {"commands": ["91.121.153.175:30351", "/PLAYERID 63192 Lame"], "key": "SendNatPacket"}
2013-09-26 16:44:54,105 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "ProcessNatPacket", "chuncks": ["91.121.153.175:30351", "PACKET_RECEIVED 6117"]}
2013-09-26 16:44:54,138 INFO     faf.client           port used : 6117
2013-09-26 16:44:54,292 INFO     faf.fa.relayer       Command received from server : {"commands": ["182.48.101.4:37516", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 16:44:54,523 INFO     faf.fa.relayer       Command received from server : {"commands": ["182.48.101.4:37516", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 16:44:54,752 INFO     faf.fa.relayer       Command received from server : {"commands": ["182.48.101.4:37516", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 16:44:54,980 INFO     faf.fa.relayer       Command received from server : {"commands": ["182.48.101.4:37516", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 16:44:55,210 INFO     faf.fa.relayer       Command received from server : {"commands": ["182.48.101.4:37516", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 16:44:55,437 INFO     faf.fa.relayer       Command received from server : {"commands": ["182.48.101.4:37516", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 16:44:55,657 INFO     faf.fa.relayer       Command received from server : {"commands": ["182.48.101.4:37516", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 16:44:55,887 INFO     faf.fa.relayer       Command received from server : {"commands": ["182.48.101.4:37516", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 16:44:56,122 INFO     faf.fa.relayer       Command received from server : {"commands": ["182.48.101.4:37516", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 16:44:56,342 INFO     faf.fa.relayer       Command received from server : {"commands": ["182.48.101.4:37516", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 16:44:56,572 INFO     faf.fa.relayer       Command received from server : {"commands": ["182.48.101.4:37516", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 16:44:56,572 INFO     faf.fa.relayer       Command received from server : {"commands": ["182.48.101.4:37516", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 16:44:56,802 INFO     faf.fa.relayer       Command received from server : {"commands": ["182.48.101.4:37516", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 16:44:57,030 INFO     faf.fa.relayer       Command received from server : {"commands": ["182.48.101.4:37516", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 16:44:57,259 INFO     faf.fa.relayer       Command received from server : {"commands": ["182.48.101.4:37516", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 16:44:57,489 INFO     faf.fa.relayer       Command received from server : {"commands": ["182.48.101.4:37516", "Shadess", 69807], "key": "JoinGame"}
2013-09-26 16:45:07,388 INFO     faf.fa.relayer       Command received from server : {"commands": [0, "182.48.101.4", "Shadess", 69807], "key": "JoinProxy"}
2013-09-26 16:45:07,420 DEBUG    faf.fa.proxies       Setting low delay on socket.
2013-09-26 16:45:07,420 INFO     faf.fa.proxies       Connected to proxy server direct.faforever.com:9123
2013-09-26 16:45:23,821 INFO     faf.fa.relayer       FA disconnected locally.
2013-09-26 16:45:23,821 INFO     faf.fa.proxies       disconnecting from proxy server
2013-09-26 16:45:23,822 INFO     faf.fa.relayer       remove relay
2013-09-26 16:45:23,822 DEBUG    faf.fa.relayer       destructor called
2013-09-26 16:45:25,359 INFO     faf.client           FA has finished with exit code: 0
2013-09-26 16:45:25,359 INFO     faf.client           Outgoing JSON Message: {"state": "off", "command": "fa_state"}
2013-09-26 16:45:25,361 INFO     faf.chat             autopostjoin: true
2013-09-26 16:46:16,007 INFO     faf.fa               Checking FA for: ladder1v1 and map None
2013-09-26 16:46:16,007 INFO     faf.fa               Updating FA for mod: ladder1v1, version None
2013-09-26 16:46:16,009 DEBUG    faf.updater          Update started at 2013-09-26 16:46:16
2013-09-26 16:46:16,009 DEBUG    faf.updater          Using game path: Z:\Program Files (x86)\THQ\Supreme Commander Forged Alliance
2013-09-26 16:46:16,009 DEBUG    faf.updater          Using appdata: C:\ProgramData\FAForever
2013-09-26 16:46:16,190 DEBUG    faf.updater          Connected to update server at 2013-09-26 16:46:16
2013-09-26 16:46:16,196 DEBUG    faf.updater          writeToServer(GET_FILES_TO_UPDATE, [FAF])
2013-09-26 16:46:16,226 DEBUG    faf.updater          handleAction(LIST_FILES_TO_UP) - 324 bytes
2013-09-26 16:46:16,227 DEBUG    faf.updater          Files to update: [ForgedAlliance.exe, init_faf.lua, init_ladder1v1.lua, GDFBinary.dll, SupComDataPath.lua, SupComDataPathFAF.lua, init_nonxt.lua]
2013-09-26 16:46:16,229 DEBUG    faf.updater          writeToServer(UPDATE, [bin, init_nonxt.lua, 46d9008f6b77d2c60f96272a816e4227])
2013-09-26 16:46:16,230 DEBUG    faf.updater          writeToServer(UPDATE, [bin, GDFBinary.dll, 3fc9e7684d150da5c51db71d2399f316])
2013-09-26 16:46:16,232 DEBUG    faf.updater          writeToServer(UPDATE, [bin, init_faf.lua, 7d5cebd90024c4c5dc44ae8f5c9fa35b])
2013-09-26 16:46:16,266 DEBUG    faf.updater          writeToServer(UPDATE, [bin, ForgedAlliance.exe, b779d298a8ac4412dfbcc7667cf5578f])
2013-09-26 16:46:16,267 DEBUG    faf.updater          writeToServer(UPDATE, [bin, SupComDataPath.lua, 55ac1ef97845f2291da64b830299331e])
2013-09-26 16:46:16,269 DEBUG    faf.updater          writeToServer(UPDATE, [bin, SupComDataPathFAF.lua, 962c9d1327657d77184adcf358c628f1])
2013-09-26 16:46:16,269 DEBUG    faf.updater          writeToServer(UPDATE, [bin, init_ladder1v1.lua, ea96ac9cec88af29c08556c96465acfe])
2013-09-26 16:46:16,308 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 56 bytes
2013-09-26 16:46:16,308 DEBUG    faf.updater          file : init_nonxt.lua
2013-09-26 16:46:16,308 DEBUG    faf.updater          init_nonxt.lua is up to date.
2013-09-26 16:46:16,532 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 54 bytes
2013-09-26 16:46:16,532 DEBUG    faf.updater          file : GDFBinary.dll
2013-09-26 16:46:16,532 DEBUG    faf.updater          GDFBinary.dll is up to date.
2013-09-26 16:46:16,533 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 52 bytes
2013-09-26 16:46:16,533 DEBUG    faf.updater          file : init_faf.lua
2013-09-26 16:46:16,533 DEBUG    faf.updater          init_faf.lua is up to date.
2013-09-26 16:46:16,535 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 64 bytes
2013-09-26 16:46:16,535 DEBUG    faf.updater          file : ForgedAlliance.exe
2013-09-26 16:46:16,535 DEBUG    faf.updater          ForgedAlliance.exe is up to date.
2013-09-26 16:46:16,536 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 64 bytes
2013-09-26 16:46:16,536 DEBUG    faf.updater          file : SupComDataPath.lua
2013-09-26 16:46:16,536 DEBUG    faf.updater          SupComDataPath.lua is up to date.
2013-09-26 16:46:16,536 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 70 bytes
2013-09-26 16:46:16,536 DEBUG    faf.updater          file : SupComDataPathFAF.lua
2013-09-26 16:46:16,536 DEBUG    faf.updater          SupComDataPathFAF.lua is up to date.
2013-09-26 16:46:16,536 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 64 bytes
2013-09-26 16:46:16,536 DEBUG    faf.updater          file : init_ladder1v1.lua
2013-09-26 16:46:16,536 DEBUG    faf.updater          init_ladder1v1.lua is up to date.
2013-09-26 16:46:16,538 DEBUG    faf.updater          Updates applied successfully.
2013-09-26 16:46:16,538 DEBUG    faf.updater          writeToServer(GET_FILES_TO_UPDATE, [FAFGAMEDATA])
2013-09-26 16:46:16,566 DEBUG    faf.updater          handleAction(LIST_FILES_TO_UP) - 134 bytes
2013-09-26 16:46:16,568 DEBUG    faf.updater          Files to update: [faforever.faf, faforever.nxt, lobby.nxt]
2013-09-26 16:46:16,578 DEBUG    faf.updater          writeToServer(UPDATE, [gamedata, faforever.faf, 01918c842de543150cfc20cd511986ac])
2013-09-26 16:46:16,757 DEBUG    faf.updater          writeToServer(UPDATE, [gamedata, faforever.nxt, e046d2c5af04f78aca023941c1abd949])
2013-09-26 16:46:16,780 DEBUG    faf.updater          writeToServer(UPDATE, [gamedata, lobby.nxt, 9e6521423cc955e2cfb821839d482226])
2013-09-26 16:46:16,815 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 54 bytes
2013-09-26 16:46:16,815 DEBUG    faf.updater          file : faforever.faf
2013-09-26 16:46:16,815 DEBUG    faf.updater          faforever.faf is up to date.
2013-09-26 16:46:17,039 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 54 bytes
2013-09-26 16:46:17,039 DEBUG    faf.updater          file : faforever.nxt
2013-09-26 16:46:17,039 DEBUG    faf.updater          faforever.nxt is up to date.
2013-09-26 16:46:17,040 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 46 bytes
2013-09-26 16:46:17,040 DEBUG    faf.updater          file : lobby.nxt
2013-09-26 16:46:17,040 DEBUG    faf.updater          lobby.nxt is up to date.
2013-09-26 16:46:17,040 DEBUG    faf.updater          Updates applied successfully.
2013-09-26 16:46:17,042 DEBUG    faf.updater          Disconnected from server at 2013-09-26 16:46:17
2013-09-26 16:46:17,078 DEBUG    faf.updater          Update finished at 2013-09-26 16:46:17
2013-09-26 16:46:17,078 INFO     faf.fa               Writing fa_path.lua config file.
2013-09-26 16:46:17,089 INFO     faf.fa.upnp          Creating UPnP port mappings...
2013-09-26 16:46:17,094 ERROR    faf.fa.upnp          Couldn't get StaticPortMappingCollection
2013-09-26 16:46:17,094 INFO     faf.games            Starting Ranked Search as /seraphim, port: 6112
2013-09-26 16:46:17,094 INFO     faf.client           Outgoing JSON Message: {"state": "start", "mod": "ladder1v1", "command": "game_matchmaking", "faction": "/seraphim", "gameport": 6112}
2013-09-26 16:46:27,086 DEBUG    faf.games            Expanding search to 0.05
2013-09-26 16:46:27,086 INFO     faf.client           Outgoing JSON Message: {"rate": 0.05, "command": "game_matchmaking", "state": "expand", "mod": "ladder1v1"}
2013-09-26 16:46:37,101 DEBUG    faf.games            Expanding search to 0.1
2013-09-26 16:46:37,101 INFO     faf.client           Outgoing JSON Message: {"rate": 0.1, "command": "game_matchmaking", "state": "expand", "mod": "ladder1v1"}
2013-09-26 16:46:47,105 DEBUG    faf.games            Expanding search to 0.15
2013-09-26 16:46:47,105 INFO     faf.client           Outgoing JSON Message: {"rate": 0.15000000000000002, "command": "game_matchmaking", "state": "expand", "mod": "ladder1v1"}
2013-09-26 16:46:57,117 DEBUG    faf.games            Expanding search to 0.2
2013-09-26 16:46:57,117 INFO     faf.client           Outgoing JSON Message: {"rate": 0.2, "command": "game_matchmaking", "state": "expand", "mod": "ladder1v1"}
2013-09-26 16:47:07,121 DEBUG    faf.games            Search Cap reached at 0.25
2013-09-26 16:47:07,121 INFO     faf.client           Outgoing JSON Message: {"rate": 0.25, "command": "game_matchmaking", "state": "expand", "mod": "ladder1v1"}
2013-09-26 16:47:13,105 INFO     faf.client           Handling game_launch via JSON {u'uid': 1336959, u'args': [u'/players 2', u'/team 2'], u'mapname': u'scmp_020', u'reason': u'ranked', u'command': u'game_launch', u'mod': u'ladder1v1'}
2013-09-26 16:47:13,105 INFO     faf.fa               Updating FA for map: scmp_020
2013-09-26 16:47:13,107 INFO     faf.fa               Map is available.
2013-09-26 16:47:13,107 INFO     faf.fa.upnp          Creating UPnP port mappings...
2013-09-26 16:47:13,108 ERROR    faf.fa.upnp          Couldn't get StaticPortMappingCollection
2013-09-26 16:47:13,108 INFO     faf.fa               Running FA with info: {'recorder': u'Lame', 'game_time': 1380206833.109, 'uid': 1336959, 'version_info': {'lobby': '0.8.80'}, 'featured_mod': u'ladder1v1'}
2013-09-26 16:47:13,108 INFO     faf.fa               Running FA via command: "C:\ProgramData\FAForever\bin\ForgedAlliance.exe" /players 2 /team 2 /seraphim /mean 1255.1671099 /deviation 47.1682978881 /init init_ladder1v1.lua /savereplay gpgnet://localhost/1336959/Lame.SCFAreplay /nobugreport /gpgnet 127.0.0.1:58647
2013-09-26 16:47:13,131 INFO     faf.client           FA has launched in an attached process.
2013-09-26 16:47:13,131 INFO     faf.client           Outgoing JSON Message: {"state": "on", "command": "fa_state"}
2013-09-26 16:47:13,131 DEBUG    faf.games            Stopping Ranked Search
2013-09-26 16:47:13,131 INFO     faf.client           Outgoing JSON Message: {"state": "stop", "command": "game_matchmaking", "mod": "ladder1v1"}
2013-09-26 16:47:20,687 DEBUG    faf.fa.relayserver   incoming connection to relay server...
2013-09-26 16:47:20,687 INFO     faf.fa.relayer       FA connected locally.
2013-09-26 16:47:23,710 DEBUG    faf.fa.relayer       faf server direct.faforever.com:8000
2013-09-26 16:47:23,710 DEBUG    faf.fa.relayer       Initializing ping timer
2013-09-26 16:47:23,711 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "GameState", "chuncks": ["Idle"]}
2013-09-26 16:47:24,357 INFO     faf.fa.relayer       Command received from server : {"commands": [1, 6112, "Lame", 63192, 1], "key": "CreateLobby"}
2013-09-26 16:47:24,357 INFO     faf.fa.relayer       Command received from server : {"commands": ["91.121.153.175:30351", "/PLAYERID 63192 Lame"], "key": "SendNatPacket"}
2013-09-26 16:47:24,413 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "GameState", "chuncks": ["Lobby"]}
2013-09-26 16:47:24,539 INFO     faf.fa.relayer       Command received from server : {"commands": ["91.121.153.175:30351", "/PLAYERID 63192 Lame"], "key": "SendNatPacket"}
2013-09-26 16:47:24,548 INFO     faf.fa.relayer       Command transmitted from FA to server : {"action": "ProcessNatPacket", "chuncks": ["91.121.153.175:30351", "PACKET_RECEIVED 6117"]}
2013-09-26 16:47:24,592 INFO     faf.client           port used : 6117
2013-09-26 16:47:24,740 INFO     faf.fa.relayer       Command received from server : {"commands": ["182.48.101.4:37518", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 16:47:24,993 INFO     faf.fa.relayer       Command received from server : {"commands": ["182.48.101.4:37518", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 16:47:25,296 INFO     faf.fa.relayer       Command received from server : {"commands": ["182.48.101.4:37518", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 16:47:25,595 INFO     faf.fa.relayer       Command received from server : {"commands": ["182.48.101.4:37518", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 16:47:25,595 INFO     faf.fa.relayer       Command received from server : {"commands": ["182.48.101.4:37518", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 16:47:25,895 INFO     faf.fa.relayer       Command received from server : {"commands": ["182.48.101.4:37518", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 16:47:26,194 INFO     faf.fa.relayer       Command received from server : {"commands": ["182.48.101.4:37518", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 16:47:26,194 INFO     faf.fa.relayer       Command received from server : {"commands": ["182.48.101.4:37518", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 16:47:26,426 INFO     faf.fa.relayer       Command received from server : {"commands": ["182.48.101.4:37518", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 16:47:26,654 INFO     faf.fa.relayer       Command received from server : {"commands": ["182.48.101.4:37518", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 16:47:26,884 INFO     faf.fa.relayer       Command received from server : {"commands": ["182.48.101.4:37518", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 16:47:27,114 INFO     faf.fa.relayer       Command received from server : {"commands": ["182.48.101.4:37518", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 16:47:27,345 INFO     faf.fa.relayer       Command received from server : {"commands": ["182.48.101.4:37518", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 16:47:27,345 INFO     faf.fa.relayer       Command received from server : {"commands": ["182.48.101.4:37518", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 16:47:27,573 INFO     faf.fa.relayer       Command received from server : {"commands": ["182.48.101.4:37518", "/ASKREPLY Lame"], "key": "SendNatPacket"}
2013-09-26 16:47:27,802 INFO     faf.fa.relayer       Command received from server : {"commands": ["182.48.101.4:37518", "Shadess", 69807], "key": "JoinGame"}
2013-09-26 16:47:37,765 INFO     faf.fa.relayer       Command received from server : {"commands": [0, "182.48.101.4", "Shadess", 69807], "key": "JoinProxy"}
2013-09-26 16:47:37,792 DEBUG    faf.fa.proxies       Setting low delay on socket.
2013-09-26 16:47:37,792 INFO     faf.fa.proxies       Connected to proxy server direct.faforever.com:9123
2013-09-26 16:47:55,349 INFO     faf.fa.relayer       Command received from server : {"commands": [], "key": "ping"}
2013-09-26 16:48:26,355 INFO     faf.fa.relayer       Command received from server : {"commands": [], "key": "ping"}
2013-09-26 16:48:57,354 INFO     faf.fa.relayer       Command received from server : {"commands": [], "key": "ping"}
2013-09-26 16:49:28,357 INFO     faf.fa.relayer       Command received from server : {"commands": [], "key": "ping"}
2013-09-26 16:49:30,446 INFO     faf.fa.relayer       FA disconnected locally.
2013-09-26 16:49:30,446 INFO     faf.fa.proxies       disconnecting from proxy server
2013-09-26 16:49:30,446 INFO     faf.fa.relayer       remove relay
2013-09-26 16:49:30,447 DEBUG    faf.fa.relayer       destructor called
2013-09-26 16:49:31,424 INFO     faf.client           FA has finished with exit code: 0
2013-09-26 16:49:31,424 INFO     faf.client           Outgoing JSON Message: {"state": "off", "command": "fa_state"}
2013-09-26 16:49:31,424 INFO     faf.chat             autopostjoin: true

Statistics: Posted by Lame — 26 Sep 2013, 16:57


]]>