Disconnect after trying to start automatch

[threelegs]

After clicking on the button to start the automatch for a ladder 1v1 the lobby disappears. I am already afflicted by the no ranking bug.

Code: Select all

2016-03-10 15:01:43,302 INFO     fa.game_connection.GPGNetConnection GC<<: ConnectToPeer:('127.0.0.1:50302', u'Fungus', 137162)
2016-03-10 15:01:51,635 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["94.230.155.58:43551", "Hello from 173505"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-03-10 15:01:51,635 INFO     connectivity.helper.ConnectivityHelper Unknown natpacket
2016-03-10 15:01:51,638 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["94.230.155.58:43551", "Hello from 173505"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-03-10 15:01:51,638 INFO     connectivity.helper.ConnectivityHelper Unknown natpacket
2016-03-10 15:01:51,638 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["94.230.155.58:43551", "Hello from 173505"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-03-10 15:01:51,638 INFO     connectivity.helper.ConnectivityHelper Unknown natpacket
2016-03-10 15:01:52,144 INFO     connectivity.relay.Relay       Allocating local relay for zlutyzupan, 173505
2016-03-10 15:01:52,144 INFO     fa.game_session.GameSession    Bound peer zlutyzupan/173505 to 50303
2016-03-10 15:01:52,144 INFO     fa.game_connection.GPGNetConnection GC<<: ConnectToPeer:('127.0.0.1:50303', u'zlutyzupan', 173505)
2016-03-10 15:02:05,835 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["80.56.27.125:57091", "Hello from 61769"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-03-10 15:02:05,835 INFO     connectivity.helper.ConnectivityHelper Unknown natpacket
2016-03-10 15:02:05,836 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["80.56.27.125:57091", "Hello from 61769"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-03-10 15:02:05,836 INFO     connectivity.helper.ConnectivityHelper Unknown natpacket
2016-03-10 15:02:05,836 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["80.56.27.125:57091", "Hello from 61769"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-03-10 15:02:05,836 INFO     connectivity.helper.ConnectivityHelper Unknown natpacket
2016-03-10 15:02:06,141 INFO     connectivity.relay.Relay       Allocating local relay for Pr0metheus, 61769
2016-03-10 15:02:06,141 INFO     fa.game_session.GameSession    Bound peer Pr0metheus/61769 to 50304
2016-03-10 15:02:06,141 INFO     fa.game_connection.GPGNetConnection GC<<: ConnectToPeer:('127.0.0.1:50304', u'Pr0metheus', 61769)
2016-03-10 15:02:10,151 INFO     fa.game_connection.GPGNetConnection GC<<: DisconnectFromPeer:(173505,)
2016-03-10 15:02:10,154 INFO     fa.game_connection.GPGNetConnection GC >> : Disconnected : [u'173505']
2016-03-10 15:02:10,154 INFO     fa.game_session.GameSession    Incoming GPGNet: Disconnected [u'173505']
2016-03-10 15:02:10,154 INFO     fa.game_session.GameSession    Outgoing relay message Disconnected [u'173505']
2016-03-10 15:02:10,154 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["173505"], "command": "Disconnected", "target": "game"}
2016-03-10 15:02:10,772 INFO     client._clientwindow           FA has finished with exit code: 0
2016-03-10 15:02:10,772 INFO     fa.game_session.GameSession    Game has exited with status code: 0
2016-03-10 15:02:10,772 INFO     fa.game_session.GameSession    Outgoing relay message GameState ['Ended']
2016-03-10 15:02:10,772 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["Ended"], "command": "GameState", "target": "game"}
2016-03-10 15:02:43,552 INFO     fa.check                       Checking FA for: ladder1v1 and map None
2016-03-10 15:02:43,552 INFO     fa.check                       Version unknown, assuming latest
2016-03-10 15:02:43,552 INFO     fa.check                       Updating FA for mod: ladder1v1, version None
2016-03-10 15:02:43,553 INFO     fa.check                       Writing fa_path.lua config file.
2016-03-10 15:02:45,118 INFO     fa.upnp                        UPnP mapping <PyQt4.QtNetwork.QHostAddress object at 0x032B3330>:6112
2016-03-10 15:02:45,158 ERROR    fa.upnp                        Exception in UPnP createPortMapping.
Traceback (most recent call last):
  File "src\fa\upnp.py", line 35, in createPortMapping
  File "<COMObject <unknown>>", line 4, in Add
com_error: (-2147352567, 'Exception occurred.', (0, None, None, None, 0, -2147220984), None)
2016-03-10 15:02:45,295 INFO     games._gameswidget             Starting Ranked Search as Factions.CYBRAN, port: 6112
2016-03-10 15:02:45,296 INFO     client._clientwindow           Outgoing JSON Message: {"state": "start", "gameport": 6112, "command": "game_matchmaking", "faction": 3, "mod": "ladder1v1"}
2016-03-10 15:02:45,467 ERROR    client._clientwindow           Error dispatching JSON: {"command": "invalid"}
Traceback (most recent call last):
  File "src\client\_clientwindow.py", line 976, in readFromServer
  File "src\client\_clientwindow.py", line 1106, in dispatch
  File "src\client\_clientwindow.py", line 1130, in handle_invalid
Exception: {u'command': u'invalid'}

[threelegs]

Happened again this time while I was sitting in a lobby

Code: Select all

Exception: {u'command': u'invalid'}
2016-03-10 15:02:45,476 INFO     client._clientwindow           Timeout/network error: The remote host closed the connection
2016-03-10 15:02:45,476 WARNING  client._clientwindow           Disconnected from lobby server.
2016-03-10 15:02:45,476 WARNING  client._clientwindow           Disconnected from lobby server.
2016-03-10 15:10:27,489 INFO     client._clientwindow           Close Event for Application Main Window
2016-03-10 15:10:27,496 INFO     fa.upnp                        Removing UPnP port mapping.
2016-03-10 15:10:32,260 INFO     fa.upnp                        -> UDP mapping of 10.0.0.132:6112 to 73.84.210.123:6112
2016-03-10 15:10:33,601 INFO     __main__                       <<< --------------------------- Application Shutdown
2016-03-10 15:10:33,155 INFO     root                           FAF version: 0.11.52+413 Environment: production
2016-03-10 15:10:33,276 INFO     __main__                       >>> --------------------------- Application Launch
2016-03-10 15:10:33,595 INFO     faf.secondaryServer.Statistic  Instantiating secondary server.
2016-03-10 15:10:33,609 INFO     util                           Read common stylesheet: client/client.css
2016-03-10 15:10:33,733 INFO     util                           Read common stylesheet: stats/formatters/style.css
2016-03-10 15:10:33,752 INFO     faf.secondaryServer.Tournament Instantiating secondary server.
2016-03-10 15:10:33,752 INFO     util                           Read common stylesheet: tournaments/formatters/style.css
2016-03-10 15:10:34,826 INFO     replays._replayswidget         Replays Widget instantiated.
2016-03-10 15:10:34,831 INFO     tutorials._tutorialswidget     Tutorials instantiated.
2016-03-10 15:10:34,841 INFO     util                           Read common stylesheet: coop/formatters/style.css
2016-03-10 15:10:34,865 INFO     fa.replayserver                listening on address 127.0.0.1:15000
2016-03-10 15:10:35,035 INFO     client._clientwindow           Outgoing JSON Message: {"version": "0.11.52+413", "command": "ask_session", "user_agent": "faf-client"}
2016-03-10 15:11:15,716 ERROR    client._clientwindow           Error dispatching JSON: {"command": "matchmaker_info", "queues": [{"boundary_75s": [], "queue_name": "ladder1v1", "boundary_80s": []}]}
Traceback (most recent call last):
  File "src\client\_clientwindow.py", line 976, in readFromServer
  File "src\client\_clientwindow.py", line 1106, in dispatch
  File "src\client\_clientwindow.py", line 1333, in handle_matchmaker_info
AttributeError: 'NoneType' object has no attribute 'ladder_rating_deviation'
2016-03-10 15:14:38,601 ERROR    client._clientwindow           Error dispatching JSON: {"command": "matchmaker_info", "queues": [{"boundary_75s": [[320, 520]], "queue_name": "ladder1v1", "boundary_80s": [[220, 620]]}]}
Traceback (most recent call last):
  File "src\client\_clientwindow.py", line 976, in readFromServer
  File "src\client\_clientwindow.py", line 1106, in dispatch
  File "src\client\_clientwindow.py", line 1333, in handle_matchmaker_info
AttributeError: 'NoneType' object has no attribute 'ladder_rating_deviation'
2016-03-10 15:15:43,335 ERROR    util                           UniqueID Failure
Traceback (most recent call last):
  File "src\util\__init__.py", line 577, in uniqueID
  File "C:\Python27\lib\ctypes\__init__.py", line 443, in LoadLibrary
  File "C:\Python27\lib\ctypes\__init__.py", line 365, in __init__
WindowsError: [Error 126] The specified module could not be found
2016-03-10 15:15:43,339 INFO     client._clientwindow           Logging in with {'login': u'threelegs', 'session': '1607784996', 'command': 'hello', 'unique_id': None}
2016-03-10 15:15:43,569 INFO     fa.upnp                        UPnP mapping 10.0.0.132:6112
2016-03-10 15:15:51,578 INFO     fa.upnp                        -> UDP mapping of 10.0.0.132:6112 to 73.84.210.123:6112
2016-03-10 15:15:53,426 INFO     connectivity.qturnsocket.QTurnSocket Turn socket initialized: faforever.com
2016-03-10 15:15:53,427 INFO     client._clientwindow           Outgoing JSON Message: {"args": [6112], "command": "InitiateTest", "target": "connectivity"}
2016-03-10 15:15:53,582 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["37.58.123.3:30351", "Are you public? 172710"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-03-10 15:15:53,582 INFO     connectivity.helper.ConnectivityHelper Unknown natpacket
2016-03-10 15:15:53,584 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["37.58.123.3:30351", "Are you public? 172710"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-03-10 15:15:53,584 INFO     connectivity.helper.ConnectivityHelper Unknown natpacket
2016-03-10 15:15:53,584 INFO     client._clientwindow           Outgoing JSON Message: {"args": ["37.58.123.3:30351", "Are you public? 172710"], "command": "ProcessNatPacket", "target": "connectivity"}
2016-03-10 15:15:53,584 INFO     connectivity.helper.ConnectivityHelper Unknown natpacket
2016-03-10 15:15:54,273 WARNING  util                           Expensive lookup by player login, FIXME.
2016-03-10 15:15:55,438 INFO     connectivity.helper.ConnectivityHelper Connectivity state is PUBLIC, mapped address: 73.84.210.123:6112
2016-03-10 15:16:16,542 INFO     fa.check                       Checking FA for: faf and map gap of rohan.v0001
2016-03-10 15:16:16,543 INFO     fa.check                       Version unknown, assuming latest
2016-03-10 15:16:16,543 INFO     fa.check                       Updating FA for mod: faf, version None
2016-03-10 15:16:16,543 INFO     fa.check                       Writing fa_path.lua config file.
2016-03-10 15:16:18,200 INFO     fa.check                       Updating FA for map: gap of rohan.v0001
2016-03-10 15:16:18,201 INFO     fa.check                       Map is available.
2016-03-10 15:16:18,203 INFO     client._clientwindow           Outgoing JSON Message: {"command": "game_join", "uid": 4525970, "gameport": 6112}
2016-03-10 15:16:18,424 ERROR    client._clientwindow           Not ready for game launch
2016-03-10 15:16:18,474 INFO     client._clientwindow           Handling game_launch via JSON {u'args': [u'/numgames 0'], u'command': u'game_launch', u'uid': 4525970, u'mod': u'faf'}
2016-03-10 15:16:18,474 INFO     fa.upnp                        UPnP mapping 10.0.0.132:6112
2016-03-10 15:16:18,476 ERROR    fa.upnp                        Couldn't get StaticPortMappingCollection

[SpdyGonzalez]

Code: Select all

2016-03-10 15:16:18,474 INFO     fa.upnp                        UPnP mapping 10.0.0.132:6112
2016-03-10 15:16:18,476 ERROR    fa.upnp                        Couldn't get StaticPortMappingCollection

your upnp might not be working, I sugest you access your router and port forward UDP 6112 to your computer IP