Upon further investigation it seems that during Loading the game asks for initial info from the server and sometimes gets bad data (could be that data is a bit random and that is why sometimes the game works?)
09:03:17.713 NET| connected to 100
09:03:17.779 NET| <--( op: SCMD_AUTH_REQ, resp: 0 )
09:03:17.996 NET| -->( op: CCMD_AUTH_REQUEST, req: 1 )
09:03:21.581 NET| <--( op: SCMD_AUTH_ACK, resp: 0 )
09:03:21.581 NET| :req ( AC_SERVER_INFO )
09:03:21.582 NET| -->( op: CSCMD_ASYNC_REQ, req: 2 )
09:03:21.582 NET| chat: Connect() requested
09:03:21.582 NET| :req ( AC_WELCOME_MSG )
09:03:21.582 NET| -->( op: CSCMD_ASYNC_REQ, req: 3 )
09:03:21.582 NET| :req ( AC_MOTD )
09:03:21.582 NET| -->( op: CSCMD_ASYNC_REQ, req: 4 )
09:03:21.582 NET| <--( op: CSCMD_ASYNC_REQ, resp: 0 )
09:03:21.582 NET| :resp ( AC_VESSEL_STRIP_IMPROPER_BATTLE ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
09:03:21.583 NET| response processing took 0.2 ms
09:03:21.583 NET| <--( op: SCMD_NOTIFICATION, resp: 0 )
09:03:21.583 NET| :n 54
09:03:21.583 NET| response processing took 0.2 ms
09:03:21.667 NET| chat: channel opened, waiting for connection
09:03:21.700 NET| <--( op: CSCMD_ASYNC_REQ, resp: 0 )
09:03:21.700 NET| :resp ( AC_SHIP_QUESTS ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
09:03:21.700 NET| response processing took 0.5 ms
09:03:21.701 NET| <--( op: CSCMD_ASYNC_REQ, resp: 0 )
09:03:21.701 NET| :resp ( AC_ACCOUNT_AURAS ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
09:03:21.701 NET| response processing took 0.7 ms
09:03:21.702 NET| <--( op: CSCMD_ASYNC_REQ, resp: 2 )
09:03:21.702 NET| :resp ( AC_SERVER_INFO ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
09:03:21.702 NET| response processing took 0.3 ms
09:03:21.702 NET| <--( op: CSCMD_ASYNC_REQ, resp: 3 )
09:03:21.702 NET| :resp ( AC_WELCOME_MSG ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
09:03:21.703 NET| response processing took 0.5 ms
09:03:21.703 NET| <--( op: CSCMD_ASYNC_REQ, resp: 4 )
09:03:21.703 NET| :resp ( AC_MOTD ) retCode = 4, param1 = 0, param2 = 0, u64param = 0
09:03:21.703 NET| response processing took 0.3 ms
Among other data elements, it returns “AC_VESSEL_STRIP_IMPROPER_BATTLE”
At this exact moment in game.log I have:
09:03:21.581 | MasterServerEndpoint: Successfully login to masterServer, uid 3796342, nick koziej, spaceStationZoneId 231
09:03:21.583 WARNING| script (ui/scripts/windows/loginwnd.lua@0): UI.LoginWnd:GameStore_OnStripImproperBattleVessels(): invalid mode 2; expected 3(WATIING_DATA_VALIDATION)
09:03:21.667 | Profile 'marcin' saved successfully in '/home/marcin/.local/share/starconflict/profiles/0001.prfl'
09:03:37.180 | disconnected from masterServer with reason 41
09:03:37.180 | Closed connection with masterServer addr 95.213.156.198:3802, reason 41
09:03:37.185 WARNING| script (ui/scripts/work/uigamefuncs.lua@0): UI:ShipPreset_WriteToFile()[ERROR]: invalid uid
What happens next in net.log is:
09:03:21.743 NET| ProtoServer::OnPeerConnected: 188.93.18.235:3815, outbound: true
09:03:21.817 NET| ProtoServer::ProcessHandshake: 0.0.0.0:0->188.93.18.235:3815, 1 inbound, 1 outbound channels
09:03:21.861 NET| ProtoServer::ProcessClaimPeerID: Peer 188.93.18.235:3815 has a valid PeerID claim
09:03:21.919 NET| ProtoServer::ProcessEnforcePeerID: Peer 188.93.18.235:3815 enforced PeerID 89.73.137.102:46167 on me
09:03:21.919 NET| chat: OnConnect(): sending authorization data
09:03:22.093 NET| chat: server authorization: ok
09:03:35.478 NET| :req ( AC_ZONES_LUA_ACTIVE_EVENTS_UPDATE )
09:03:35.478 NET| -->( op: CSCMD_ASYNC_REQ, req: 5 )
09:03:35.536 NET| :req ( AC_UNIVERSE_GET )
09:03:35.536 NET| -->( op: CSCMD_ASYNC_REQ, req: 6 )
09:03:35.580 NET| <--( op: CSCMD_ASYNC_REQ, resp: 5 )
09:03:35.580 NET| :resp ( AC_ZONES_LUA_ACTIVE_EVENTS_UPDATE ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
09:03:35.580 NET| response processing took 0.1 ms
09:03:35.700 NET| <--( op: CSCMD_ASYNC_REQ, resp: 6 )
09:03:35.701 NET| :resp ( AC_UNIVERSE_GET ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
09:03:35.701 NET| response processing took 0.6 ms
09:03:37.179 NET| chat: Disconnect() requested
09:03:37.180 NET| chat: OnDisconnect()
09:03:37.180 NET| disconnected with reason 41, m_sessionState 5
09:03:37.180 NET| chat: Disconnect() requested
The game still shows “Loading” screen, not informing of the error, but nothing else happens in the logs, game is stuck.
In the case of successful game load, instead of “invalid mode 2; expected 3” I have:
23:09:27.642 | MasterServerEndpoint: Successfully login to masterServer, uid 3796342, nick koziej, spaceStationZoneId 231
23:09:27.766 | ShipPresetsRead: no ship preset file found (/home/marcin/.local/share/starconflict/ship_presets/ship_presets_3796342.shpr)