Ok this is one of the log entries from a game where this happened.
--- Date: 2012-10-22 (Mon Oct 2012)
19:50:28.206 | //////////////////////////////////////////////////////////////////////////////
19:50:28.206 | //
19:50:28.206 | // Build: StarConflict 0.5.5.17198 (Sep 28 2012 12:08:50)
19:50:28.206 | // params: -lang ENGLISH
19:50:28.206 | //
19:50:28.206 | //////////////////////////////////////////////////////////////////////////////
19:50:28.206 |
19:50:28.209 | Failed to initialize Steam. Probably Steam client is not running.
19:50:28.209 | Preloaded 1 SStrings
19:50:28.652 | Number of audio devices: 1
19:50:28.652 | Audio device 0: Speakers (Realtek High Definition Audio)
19:50:28.668 | Sound caps: OUTPUT_FORMAT_PCM8 OUTPUT_FORMAT_PCM16 OUTPUT_FORMAT_PCM24 OUTPUT_FORMAT_PCM32 OUTPUT_FORMAT_PCMFLOAT
19:50:28.668 | Speaker mode: STEREO
19:50:28.669 | Speaker mode: STEREO
19:50:41.754 | Entity Defs hash 95147E34. calculated in 0.81 sec
19:50:42.808 | BnRandCaller succeeded
19:50:50.984 | ====== starting level: 'levels/mainmenu/mainmenu' ======
19:50:55.202 | MasterServer_RequestServerStatus
19:50:55.202 | MasterServer_RequestServerVersion
19:50:55.202 | MasterServer_RequestNewsFeed
19:50:55.202 | MasterServer_RequestServerAddresess
19:50:55.241 | ====== level started: 'levels/mainmenu/mainmenu' success ======
19:50:55.777 WARNING| frame 3 gameGlobals.frameTimeReal is too large (0.170272)
19:50:55.893 WARNING| frame 4 gameGlobals.frameTimeReal is too large (0.438178)
19:50:55.922 WARNING| frame 5 gameGlobals.frameTimeReal is too large (0.116316)
19:50:55.928 | MasterServer_OnServerStatus: status code 0, server status 1
19:50:55.962 | MasterServer_OnServerVersion: status code 0, version 0.5.5.17198, my version is 0.5.5.17198
19:50:55.962 | MasterServer_OnServerAddresess: status code 0
19:50:56.010 | MasterServer_OnNewsFeed: status code 0
19:51:06.058 | MasterServerEndpoint: connecting to load balancer at 91.230.60.102:3801 [0]...
19:51:06.214 | MasterServerEndpoint: connected to load balancer 91.230.60.102:3801, awaiting shard address...
19:51:06.372 | MasterServerEndpoint: received shard address ( 91.230.60.100:3802 )
19:51:06.372 | MasterServerEndpoint: received chat server address ( 91.230.60.102:3815 )
19:51:06.372 | Disconnecting from load balancer
19:51:06.530 | MasterServerEndpoint: connected to shard 91.230.60.100:3802, awaiting auth request...
19:51:07.485 | MasterServerEndpoint: Successfully login to masterServer 91.230.60.100:3802, uid 00009135
19:51:07.696 | StoreSvc: received store hash, its 577b3652
19:51:07.696 | StoreSvc: loading store cache
19:51:07.697 | StoreSvc: cache signature matches, loading the store from cache
19:51:07.701 | Total game store size : 190.15332 Kb
19:51:07.701 | StoreSvc: loading took 4.4 ms
19:51:10.582 WARNING| frame 237 gameGlobals.frameTimeReal is too large (2.459203)
19:51:10.717 WARNING| frame 238 gameGlobals.frameTimeReal is too large (0.109680)
19:51:10.794 WARNING| frame 239 gameGlobals.frameTimeReal is too large (0.135597)
19:51:12.228 WARNING| frame 260 gameGlobals.frameTimeReal is too large (0.172533)
19:51:12.302 WARNING| frame 261 gameGlobals.frameTimeReal is too large (0.114930)
19:51:21.721 WARNING| m_bufferizedUICalls delivery took 159.8 ms
19:51:21.745 WARNING| frame 380 gameGlobals.frameTimeReal is too large (0.162284)
19:51:29.467 WARNING| m_bufferizedUICalls delivery took 60.3 ms
19:51:33.028 WARNING| m_bufferizedUICalls delivery took 146.6 ms
19:51:33.033 WARNING| frame 551 gameGlobals.frameTimeReal is too large (0.148810)
19:51:45.843 WARNING| m_bufferizedUICalls delivery took 57.9 ms
19:51:47.443 | MasterServerEndpoint: enter matchmaking queue 6 with mmvalue 19
19:54:17.572 WARNING| MasterServerEndpoint: leave matchmaking queue ( but will join the game soon )
19:54:18.815 | MasterServerSession: connect to dedicated server, session 195693, at addr 91.230.60.112|35001
19:54:18.857 | client: start connecting to 91.230.60.112|35001...
19:54:18.873 WARNING| m_bufferizedUICalls delivery took 14.7 ms
19:54:19.381 | client: connected to 91.230.60.112|35001, setting up session...
19:54:19.950 | client: ADD_PLAYER 0 (tirlim, 000093FD) status 2
19:54:19.950 | client: ADD_PLAYER 1 (God4, 000083A0) status 6
19:54:19.950 | client: ADD_PLAYER 2 (RaptorM1, 00009135) status 1
19:54:19.950 | client: ADD_PLAYER 3 (Donnybrook, 00005AD9) status 6
19:54:19.950 | client: ADD_PLAYER 20 ((bot)Olivia, 00000000) status 4
19:54:19.950 | client: ADD_PLAYER 21 ((bot)Matthew, 00000000) status 4
19:54:19.950 | client: ADD_PLAYER 22 ((bot)Ashley, 00000000) status 4
19:54:19.950 | client: ADD_PLAYER 23 ((bot)Abigail, 00000000) status 4
19:54:19.950 | client: ADD_PLAYER 24 ((bot)Jacob, 00000000) status 4
19:54:19.950 | client: ADD_PLAYER 25 ((bot)Sophia, 00000000) status 4
19:54:19.950 | client: ADD_PLAYER 26 ((bot)Ethan, 00000000) status 4
19:54:19.950 | client: ADD_PLAYER 27 ((bot)Christophe, 00000000) status 4
19:54:19.950 | client: ADD_PLAYER 28 ((bot)Sandra, 00000000) status 4
19:54:19.950 | client: ADD_PLAYER 29 ((bot)Ryan, 00000000) status 4
19:54:19.950 | client: ADD_PLAYER 30 ((bot)Joshua, 00000000) status 4
19:54:19.950 | client: ADD_PLAYER 31 ((bot)Mary, 00000000) status 4
19:54:19.951 | client: server assigned id 2
19:54:19.951 | client: got level load message 'levels\pandora_rocky'
19:54:21.481 | ====== starting level: 'levels\pandora_rocky' CaptureTheBase client ======
--- Date: 2012-10-22 (Mon Oct 2012)
19:51:06.058 NET| connecting to lb 91.230.60.102:3801 [0]
19:51:06.214 NET| connected to 1
19:51:06.372 NET| <--( op: SCMD_ASSIGNED_SHARD, resp: 0 )
19:51:06.372 NET| disconnected with reason 0, m_sessionState 2
19:51:06.530 NET| connected to 100
19:51:06.688 NET| <--( op: SCMD_AUTH_REQ, resp: 0 )
19:51:06.689 NET| -->( op: CCMD_AUTH_REQUEST, req: 1 )
19:51:07.485 NET| <--( op: SCMD_AUTH_ACK, resp: 0 )
19:51:07.485 NET| :req ( AC_SQUAD_INFO )
19:51:07.485 NET| -->( op: CSCMD_ASYNC_REQ, req: 2 )
19:51:07.486 NET| chat: Connect() requested
19:51:07.486 NET| chat: channel opened, waiting for connection
19:51:07.543 NET| -->( op: CCMD_STORE, req: 3 )
19:51:07.543 NET| :req ( AC_SKILLS_UPDATE )
19:51:07.543 NET| -->( op: CSCMD_ASYNC_REQ, req: 4 )
19:51:07.543 NET| :req ( AC_PLAYER_INVENTORY )
19:51:07.543 NET| -->( op: CSCMD_ASYNC_REQ, req: 5 )
19:51:07.543 NET| :req ( AC_PLAYER_VESSELS )
19:51:07.543 NET| -->( op: CSCMD_ASYNC_REQ, req: 6 )
19:51:07.543 NET| :req ( AC_PLAYER_CREDITS )
19:51:07.543 NET| -->( op: CSCMD_ASYNC_REQ, req: 7 )
19:51:07.543 NET| :req ( AC_BATTLE_SLOTS )
19:51:07.543 NET| -->( op: CSCMD_ASYNC_REQ, req: 8 )
19:51:07.543 NET| :req ( AC_PREMIUM_INFO )
19:51:07.543 NET| -->( op: CSCMD_ASYNC_REQ, req: 9 )
19:51:07.543 NET| :req ( AC_GET_USERDATA )
19:51:07.543 NET| -->( op: CSCMD_ASYNC_REQ, req: 10 )
19:51:07.543 NET| :req ( AC_PLAYER_FACTION )
19:51:07.543 NET| -->( op: CSCMD_ASYNC_REQ, req: 11 )
19:51:07.543 NET| :req ( AC_FREE_REPAIR_INFO )
19:51:07.544 NET| -->( op: CSCMD_ASYNC_REQ, req: 12 )
19:51:07.544 NET| :req ( AC_ACCOUNT_AURAS )
19:51:07.544 NET| -->( op: CSCMD_ASYNC_REQ, req: 13 )
19:51:07.644 NET| chat: OnConnect(): sending authorization data
19:51:07.696 NET| <--( op: SCMD_STORE, resp: 3 )
19:51:07.701 NET| -->( op: CCMD_STORE, req: 15 )
19:51:07.701 NET| response processing took 5.4 ms
19:51:07.701 NET| <--( op: CSCMD_ASYNC_REQ, resp: 2 )
19:51:07.701 NET| :resp ( AC_SQUAD_INFO )
19:51:07.701 NET| response processing took 0.1 ms
19:51:07.750 NET| <--( op: CSCMD_ASYNC_REQ, resp: 4 )
19:51:07.750 NET| :resp ( AC_SKILLS_UPDATE )
19:51:07.750 NET| response processing took 0.1 ms
19:51:07.750 NET| <--( op: CSCMD_ASYNC_REQ, resp: 5 )
19:51:07.750 NET| :resp ( AC_PLAYER_INVENTORY )
19:51:07.750 NET| response processing took 0.1 ms
19:51:07.855 NET| chat: server authorization: ok
19:51:07.908 NET| <--( op: CSCMD_ASYNC_REQ, resp: 6 )
19:51:07.908 NET| :resp ( AC_PLAYER_VESSELS )
19:51:07.908 NET| response processing took 0.2 ms
19:51:07.908 NET| <--( op: CSCMD_ASYNC_REQ, resp: 7 )
19:51:07.908 NET| :resp ( AC_PLAYER_CREDITS )
19:51:07.908 NET| response processing took 0.0 ms
19:51:07.908 NET| <--( op: CSCMD_ASYNC_REQ, resp: 8 )
19:51:07.908 NET| :resp ( AC_BATTLE_SLOTS )
19:51:07.908 NET| response processing took 0.0 ms
19:51:07.908 NET| <--( op: CSCMD_ASYNC_REQ, resp: 9 )
19:51:07.908 NET| :resp ( AC_PREMIUM_INFO )
19:51:07.908 NET| response processing took 0.0 ms
19:51:07.908 NET| <--( op: CSCMD_ASYNC_REQ, resp: 11 )
19:51:07.908 NET| :resp ( AC_PLAYER_FACTION )
19:51:07.908 NET| response processing took 0.0 ms
19:51:07.908 NET| <--( op: CSCMD_ASYNC_REQ, resp: 12 )
19:51:07.908 NET| :resp ( AC_FREE_REPAIR_INFO )
19:51:07.908 NET| response processing took 0.0 ms
19:51:07.909 NET| <--( op: CSCMD_ASYNC_REQ, resp: 10 )
19:51:07.909 NET| :resp ( AC_GET_USERDATA )
19:51:07.909 NET| response processing took 0.5 ms
19:51:07.909 NET| <--( op: CSCMD_ASYNC_REQ, resp: 13 )
19:51:07.909 NET| :resp ( AC_ACCOUNT_AURAS )
19:51:07.909 NET| response processing took 0.0 ms
19:51:08.013 NET| <--( op: SCMD_STORE, resp: 15 )
19:51:08.164 NET| :req ( AC_SERVER_INFO )
19:51:08.164 NET| -->( op: CSCMD_ASYNC_REQ, req: 17 )
19:51:08.164 NET| :req ( AC_PLAYER_CREDENTIALS )
19:51:08.164 NET| -->( op: CSCMD_ASYNC_REQ, req: 18 )
19:51:08.164 NET| :req ( AC_PLAYER_STATS )
19:51:08.164 NET| -->( op: CSCMD_ASYNC_REQ, req: 19 )
19:51:10.464 NET| response processing took 2451.0 ms
19:51:10.464 NET| <--( op: CSCMD_ASYNC_REQ, resp: 17 )
19:51:10.464 NET| :resp ( AC_SERVER_INFO )
19:51:10.464 NET| response processing took 0.0 ms
19:51:10.464 NET| <--( op: CSCMD_ASYNC_REQ, resp: 18 )
19:51:10.464 NET| :resp ( AC_PLAYER_CREDENTIALS )
19:51:10.464 NET| response processing took 0.0 ms
19:51:10.464 NET| <--( op: CSCMD_ASYNC_REQ, resp: 19 )
19:51:10.464 NET| :resp ( AC_PLAYER_STATS )
19:51:10.464 NET| response processing took 0.0 ms
19:51:15.495 NET| :req ( AC_SERVER_INFO )
19:51:15.496 NET| -->( op: CSCMD_ASYNC_REQ, req: 21 )
19:51:15.657 NET| <--( op: CSCMD_ASYNC_REQ, resp: 21 )
19:51:15.657 NET| :resp ( AC_SERVER_INFO )
19:51:15.657 NET| response processing took 0.1 ms
19:51:20.504 NET| :req ( AC_SERVER_INFO )
19:51:20.504 NET| -->( op: CSCMD_ASYNC_REQ, req: 22 )
19:51:20.669 NET| <--( op: CSCMD_ASYNC_REQ, resp: 22 )
19:51:20.670 NET| :resp ( AC_SERVER_INFO )
19:51:20.670 NET| response processing took 0.1 ms
19:51:21.311 NET| :req ( AC_BATTLE_SLOT_CHANGE_VESSEL )
19:51:21.312 NET| -->( op: CSCMD_ASYNC_REQ, req: 23 )
19:51:21.561 NET| <--( op: CSCMD_ASYNC_REQ, resp: 23 )
19:51:21.562 NET| :resp ( AC_BATTLE_SLOT_CHANGE_VESSEL )
19:51:21.562 NET| response processing took 0.1 ms
19:51:25.549 NET| :req ( AC_SERVER_INFO )
19:51:25.549 NET| -->( op: CSCMD_ASYNC_REQ, req: 24 )
19:51:25.763 NET| <--( op: CSCMD_ASYNC_REQ, resp: 24 )
19:51:25.763 NET| :resp ( AC_SERVER_INFO )
19:51:25.763 NET| response processing took 0.1 ms
19:51:28.131 NET| -->( op: SCMD_KEEP_ALIVE, req: 25 )
19:51:28.313 NET| <--( op: SCMD_KEEP_ALIVE, resp: 25 )
19:51:28.313 NET| new RTT: 0.0ms
19:51:28.313 NET| response processing took 0.1 ms
19:51:29.163 NET| :req ( AC_BATTLE_SLOT_CHANGE_VESSEL )
19:51:29.164 NET| -->( op: CSCMD_ASYNC_REQ, req: 26 )
19:51:29.406 NET| <--( op: CSCMD_ASYNC_REQ, resp: 26 )
19:51:29.406 NET| :resp ( AC_BATTLE_SLOT_CHANGE_VESSEL )
19:51:29.406 NET| response processing took 0.1 ms
19:51:30.560 NET| :req ( AC_SERVER_INFO )
19:51:30.561 NET| -->( op: CSCMD_ASYNC_REQ, req: 27 )
19:51:30.741 NET| <--( op: CSCMD_ASYNC_REQ, resp: 27 )
19:51:30.741 NET| :resp ( AC_SERVER_INFO )
19:51:30.741 NET| response processing took 0.1 ms
19:51:32.639 NET| :req ( AC_BATTLE_SLOT_CHANGE_VESSEL )
19:51:32.639 NET| -->( op: CSCMD_ASYNC_REQ, req: 28 )
19:51:32.882 NET| <--( op: CSCMD_ASYNC_REQ, resp: 28 )
19:51:32.882 NET| :resp ( AC_BATTLE_SLOT_CHANGE_VESSEL )
19:51:32.882 NET| response processing took 0.1 ms
19:51:35.632 NET| :req ( AC_SERVER_INFO )
19:51:35.632 NET| -->( op: CSCMD_ASYNC_REQ, req: 29 )
19:51:35.792 NET| <--( op: CSCMD_ASYNC_REQ, resp: 29 )
19:51:35.792 NET| :resp ( AC_SERVER_INFO )
19:51:35.792 NET| response processing took 0.1 ms
19:51:40.650 NET| :req ( AC_SERVER_INFO )
19:51:40.651 NET| -->( op: CSCMD_ASYNC_REQ, req: 30 )
19:51:40.811 NET| <--( op: CSCMD_ASYNC_REQ, resp: 30 )
19:51:40.811 NET| :resp ( AC_SERVER_INFO )
19:51:40.811 NET| response processing took 0.1 ms
19:51:45.567 NET| :req ( AC_BATTLE_SLOT_CHANGE_VESSEL )
19:51:45.567 NET| -->( op: CSCMD_ASYNC_REQ, req: 31 )
19:51:45.677 NET| :req ( AC_SERVER_INFO )
19:51:45.677 NET| -->( op: CSCMD_ASYNC_REQ, req: 32 )
19:51:45.785 NET| <--( op: CSCMD_ASYNC_REQ, resp: 31 )
19:51:45.785 NET| :resp ( AC_BATTLE_SLOT_CHANGE_VESSEL )
19:51:45.785 NET| response processing took 0.1 ms
19:51:45.846 NET| <--( op: CSCMD_ASYNC_REQ, resp: 32 )
19:51:45.846 NET| :resp ( AC_SERVER_INFO )
19:51:45.847 NET| response processing took 0.1 ms
19:51:47.165 NET| :req ( AC_ENTER_MM_QUEUE )
19:51:47.166 NET| -->( op: CSCMD_ASYNC_REQ, req: 33 )
19:51:47.443 NET| <--( op: CSCMD_ASYNC_REQ, resp: 33 )
19:51:47.443 NET| :resp ( AC_ENTER_MM_QUEUE )
19:51:47.443 NET| response processing took 0.1 ms
19:51:47.444 NET| :req ( AC_MM_INFO )
19:51:47.444 NET| -->( op: CSCMD_ASYNC_REQ, req: 34 )
19:51:47.615 NET| <--( op: CSCMD_ASYNC_REQ, resp: 34 )
19:51:47.615 NET| :resp ( AC_MM_INFO )
19:51:47.615 NET| response processing took 0.1 ms
19:51:50.719 NET| :req ( AC_SERVER_INFO )
19:51:50.719 NET| -->( op: CSCMD_ASYNC_REQ, req: 35 )
19:51:50.887 NET| <--( op: CSCMD_ASYNC_REQ, resp: 35 )
19:51:50.887 NET| :resp ( AC_SERVER_INFO )
19:51:50.887 NET| response processing took 0.1 ms
19:51:55.745 NET| :req ( AC_SERVER_INFO )
19:51:55.745 NET| -->( op: CSCMD_ASYNC_REQ, req: 36 )
19:51:55.912 NET| <--( op: CSCMD_ASYNC_REQ, resp: 36 )
19:51:55.912 NET| :resp ( AC_SERVER_INFO )
19:51:55.912 NET| response processing took 0.1 ms
19:51:57.442 NET| :req ( AC_MM_INFO )
19:51:57.442 NET| -->( op: CSCMD_ASYNC_REQ, req: 37 )
19:51:57.610 NET| <--( op: CSCMD_ASYNC_REQ, resp: 37 )
19:51:57.611 NET| :resp ( AC_MM_INFO )
19:51:57.611 NET| response processing took 0.1 ms
19:52:00.774 NET| :req ( AC_SERVER_INFO )
19:52:00.774 NET| -->( op: CSCMD_ASYNC_REQ, req: 38 )
19:52:00.942 NET| <--( op: CSCMD_ASYNC_REQ, resp: 38 )
19:52:00.942 NET| :resp ( AC_SERVER_INFO )
19:52:00.942 NET| response processing took 0.1 ms
19:52:05.829 NET| :req ( AC_SERVER_INFO )
19:52:05.829 NET| -->( op: CSCMD_ASYNC_REQ, req: 39 )
19:52:05.998 NET| <--( op: CSCMD_ASYNC_REQ, resp: 39 )
19:52:05.998 NET| :resp ( AC_SERVER_INFO )
19:52:05.998 NET| response processing took 0.1 ms
19:52:07.465 NET| :req ( AC_MM_INFO )
19:52:07.465 NET| -->( op: CSCMD_ASYNC_REQ, req: 40 )
19:52:07.634 NET| <--( op: CSCMD_ASYNC_REQ, resp: 40 )
19:52:07.634 NET| :resp ( AC_MM_INFO )
19:52:07.634 NET| response processing took 0.1 ms
19:52:10.869 NET| :req ( AC_SERVER_INFO )
19:52:10.869 NET| -->( op: CSCMD_ASYNC_REQ, req: 42 )
19:52:11.038 NET| <--( op: CSCMD_ASYNC_REQ, resp: 42 )
19:52:11.038 NET| :resp ( AC_SERVER_INFO )
19:52:11.038 NET| response processing took 0.1 ms
19:52:15.898 NET| :req ( AC_SERVER_INFO )
19:52:15.898 NET| -->( op: CSCMD_ASYNC_REQ, req: 43 )
19:52:16.067 NET| <--( op: CSCMD_ASYNC_REQ, resp: 43 )
19:52:16.067 NET| :resp ( AC_SERVER_INFO )
19:52:16.067 NET| response processing took 0.1 ms
19:52:17.479 NET| :req ( AC_MM_INFO )
19:52:17.479 NET| -->( op: CSCMD_ASYNC_REQ, req: 44 )
19:52:17.648 NET| <--( op: CSCMD_ASYNC_REQ, resp: 44 )
19:52:17.648 NET| :resp ( AC_MM_INFO )
19:52:17.648 NET| response processing took 0.1 ms
19:52:20.924 NET| :req ( AC_SERVER_INFO )
19:52:20.924 NET| -->( op: CSCMD_ASYNC_REQ, req: 45 )
19:52:21.093 NET| <--( op: CSCMD_ASYNC_REQ, resp: 45 )
19:52:21.093 NET| :resp ( AC_SERVER_INFO )
19:52:21.093 NET| response processing took 0.1 ms
19:52:25.969 NET| :req ( AC_SERVER_INFO )
19:52:25.969 NET| -->( op: CSCMD_ASYNC_REQ, req: 46 )
19:52:26.138 NET| <--( op: CSCMD_ASYNC_REQ, resp: 46 )
19:52:26.138 NET| :resp ( AC_SERVER_INFO )
19:52:26.138 NET| response processing took 0.1 ms
19:52:27.492 NET| :req ( AC_MM_INFO )
19:52:27.493 NET| -->( op: CSCMD_ASYNC_REQ, req: 47 )
19:52:27.661 NET| <--( op: CSCMD_ASYNC_REQ, resp: 47 )
19:52:27.661 NET| :resp ( AC_MM_INFO )
19:52:27.661 NET| response processing took 0.1 ms
19:52:28.175 NET| -->( op: SCMD_KEEP_ALIVE, req: 48 )
19:52:28.345 NET| <--( op: SCMD_KEEP_ALIVE, resp: 48 )
19:52:28.345 NET| new RTT: 0.0ms
19:52:28.345 NET| response processing took 0.1 ms
19:52:31.018 NET| :req ( AC_SERVER_INFO )
19:52:31.018 NET| -->( op: CSCMD_ASYNC_REQ, req: 49 )
19:52:31.187 NET| <--( op: CSCMD_ASYNC_REQ, resp: 49 )
19:52:31.187 NET| :resp ( AC_SERVER_INFO )
19:52:31.187 NET| response processing took 0.1 ms
19:52:36.063 NET| :req ( AC_SERVER_INFO )
19:52:36.063 NET| -->( op: CSCMD_ASYNC_REQ, req: 50 )
19:52:36.232 NET| <--( op: CSCMD_ASYNC_REQ, resp: 50 )
19:52:36.232 NET| :resp ( AC_SERVER_INFO )
19:52:36.232 NET| response processing took 0.1 ms
19:52:37.538 NET| :req ( AC_MM_INFO )
19:52:37.538 NET| -->( op: CSCMD_ASYNC_REQ, req: 51 )
19:52:37.707 NET| <--( op: CSCMD_ASYNC_REQ, resp: 51 )
19:52:37.707 NET| :resp ( AC_MM_INFO )
19:52:37.707 NET| response processing took 0.1 ms
19:52:41.099 NET| :req ( AC_SERVER_INFO )
19:52:41.099 NET| -->( op: CSCMD_ASYNC_REQ, req: 52 )
19:52:41.267 NET| <--( op: CSCMD_ASYNC_REQ, resp: 52 )
19:52:41.267 NET| :resp ( AC_SERVER_INFO )
19:52:41.267 NET| response processing took 0.1 ms
19:52:46.123 NET| :req ( AC_SERVER_INFO )
19:52:46.123 NET| -->( op: CSCMD_ASYNC_REQ, req: 53 )
19:52:46.292 NET| <--( op: CSCMD_ASYNC_REQ, resp: 53 )
19:52:46.292 NET| :resp ( AC_SERVER_INFO )
19:52:46.292 NET| response processing took 0.1 ms
19:52:47.541 NET| :req ( AC_MM_INFO )
19:52:47.541 NET| -->( op: CSCMD_ASYNC_REQ, req: 54 )
19:52:47.710 NET| <--( op: CSCMD_ASYNC_REQ, resp: 54 )
19:52:47.710 NET| :resp ( AC_MM_INFO )
19:52:47.710 NET| response processing took 0.1 ms
19:52:51.163 NET| :req ( AC_SERVER_INFO )
19:52:51.164 NET| -->( op: CSCMD_ASYNC_REQ, req: 55 )
19:52:51.332 NET| <--( op: CSCMD_ASYNC_REQ, resp: 55 )
19:52:51.332 NET| :resp ( AC_SERVER_INFO )
19:52:51.332 NET| response processing took 0.1 ms
19:52:56.212 NET| :req ( AC_SERVER_INFO )
19:52:56.212 NET| -->( op: CSCMD_ASYNC_REQ, req: 56 )
19:52:56.380 NET| <--( op: CSCMD_ASYNC_REQ, resp: 56 )
19:52:56.380 NET| :resp ( AC_SERVER_INFO )
19:52:56.380 NET| response processing took 0.1 ms
19:52:57.565 NET| :req ( AC_MM_INFO )
19:52:57.565 NET| -->( op: CSCMD_ASYNC_REQ, req: 57 )
19:52:57.733 NET| <--( op: CSCMD_ASYNC_REQ, resp: 57 )
19:52:57.733 NET| :resp ( AC_MM_INFO )
19:52:57.733 NET| response processing took 0.1 ms
19:53:01.233 NET| :req ( AC_SERVER_INFO )
19:53:01.234 NET| -->( op: CSCMD_ASYNC_REQ, req: 58 )
19:53:01.402 NET| <--( op: CSCMD_ASYNC_REQ, resp: 58 )
19:53:01.402 NET| :resp ( AC_SERVER_INFO )
19:53:01.402 NET| response processing took 0.1 ms
19:53:06.266 NET| :req ( AC_SERVER_INFO )
19:53:06.267 NET| -->( op: CSCMD_ASYNC_REQ, req: 59 )
19:53:06.435 NET| <--( op: CSCMD_ASYNC_REQ, resp: 59 )
19:53:06.435 NET| :resp ( AC_SERVER_INFO )
19:53:06.435 NET| response processing took 0.1 ms
19:53:07.573 NET| :req ( AC_MM_INFO )
19:53:07.574 NET| -->( op: CSCMD_ASYNC_REQ, req: 60 )
19:53:07.741 NET| <--( op: CSCMD_ASYNC_REQ, resp: 60 )
19:53:07.741 NET| :resp ( AC_MM_INFO )
19:53:07.741 NET| response processing took 0.1 ms
19:53:11.310 NET| :req ( AC_SERVER_INFO )
19:53:11.310 NET| -->( op: CSCMD_ASYNC_REQ, req: 62 )
19:53:11.479 NET| <--( op: CSCMD_ASYNC_REQ, resp: 62 )
19:53:11.479 NET| :resp ( AC_SERVER_INFO )
19:53:11.479 NET| response processing took 0.1 ms
19:53:16.345 NET| :req ( AC_SERVER_INFO )
19:53:16.345 NET| -->( op: CSCMD_ASYNC_REQ, req: 63 )
19:53:16.514 NET| <--( op: CSCMD_ASYNC_REQ, resp: 63 )
19:53:16.514 NET| :resp ( AC_SERVER_INFO )
19:53:16.514 NET| response processing took 0.1 ms
19:53:17.587 NET| :req ( AC_MM_INFO )
19:53:17.588 NET| -->( op: CSCMD_ASYNC_REQ, req: 64 )
19:53:17.755 NET| <--( op: CSCMD_ASYNC_REQ, resp: 64 )
19:53:17.755 NET| :resp ( AC_MM_INFO )
19:53:17.755 NET| response processing took 0.1 ms
19:53:21.367 NET| :req ( AC_SERVER_INFO )
19:53:21.367 NET| -->( op: CSCMD_ASYNC_REQ, req: 65 )
19:53:21.536 NET| <--( op: CSCMD_ASYNC_REQ, resp: 65 )
19:53:21.536 NET| :resp ( AC_SERVER_INFO )
19:53:21.536 NET| response processing took 0.1 ms
19:53:26.410 NET| :req ( AC_SERVER_INFO )
19:53:26.410 NET| -->( op: CSCMD_ASYNC_REQ, req: 66 )
19:53:26.578 NET| <--( op: CSCMD_ASYNC_REQ, resp: 66 )
19:53:26.578 NET| :resp ( AC_SERVER_INFO )
19:53:26.578 NET| response processing took 0.1 ms
19:53:27.595 NET| :req ( AC_MM_INFO )
19:53:27.595 NET| -->( op: CSCMD_ASYNC_REQ, req: 67 )
19:53:27.763 NET| <--( op: CSCMD_ASYNC_REQ, resp: 67 )
19:53:27.763 NET| :resp ( AC_MM_INFO )
19:53:27.764 NET| response processing took 0.1 ms
19:53:28.225 NET| -->( op: SCMD_KEEP_ALIVE, req: 68 )
19:53:28.394 NET| <--( op: SCMD_KEEP_ALIVE, resp: 68 )
19:53:28.394 NET| new RTT: 0.0ms
19:53:28.394 NET| response processing took 0.1 ms
19:53:31.459 NET| :req ( AC_SERVER_INFO )
19:53:31.459 NET| -->( op: CSCMD_ASYNC_REQ, req: 69 )
19:53:31.627 NET| <--( op: CSCMD_ASYNC_REQ, resp: 69 )
19:53:31.627 NET| :resp ( AC_SERVER_INFO )
19:53:31.627 NET| response processing took 0.1 ms
19:53:36.480 NET| :req ( AC_SERVER_INFO )
19:53:36.480 NET| -->( op: CSCMD_ASYNC_REQ, req: 70 )
19:53:36.648 NET| <--( op: CSCMD_ASYNC_REQ, resp: 70 )
19:53:36.648 NET| :resp ( AC_SERVER_INFO )
19:53:36.648 NET| response processing took 0.1 ms
19:53:37.610 NET| :req ( AC_MM_INFO )
19:53:37.611 NET| -->( op: CSCMD_ASYNC_REQ, req: 71 )
19:53:37.778 NET| <--( op: CSCMD_ASYNC_REQ, resp: 71 )
19:53:37.778 NET| :resp ( AC_MM_INFO )
19:53:37.778 NET| response processing took 0.1 ms
19:53:41.510 NET| :req ( AC_SERVER_INFO )
19:53:41.511 NET| -->( op: CSCMD_ASYNC_REQ, req: 72 )
19:53:41.680 NET| <--( op: CSCMD_ASYNC_REQ, resp: 72 )
19:53:41.680 NET| :resp ( AC_SERVER_INFO )
19:53:41.680 NET| response processing took 0.1 ms
19:53:46.548 NET| :req ( AC_SERVER_INFO )
19:53:46.549 NET| -->( op: CSCMD_ASYNC_REQ, req: 73 )
19:53:46.717 NET| <--( op: CSCMD_ASYNC_REQ, resp: 73 )
19:53:46.717 NET| :resp ( AC_SERVER_INFO )
19:53:46.717 NET| response processing took 0.1 ms
19:53:47.624 NET| :req ( AC_MM_INFO )
19:53:47.625 NET| -->( op: CSCMD_ASYNC_REQ, req: 74 )
19:53:47.793 NET| <--( op: CSCMD_ASYNC_REQ, resp: 74 )
19:53:47.793 NET| :resp ( AC_MM_INFO )
19:53:47.793 NET| response processing took 0.1 ms
19:53:51.572 NET| :req ( AC_SERVER_INFO )
19:53:51.573 NET| -->( op: CSCMD_ASYNC_REQ, req: 75 )
19:53:51.741 NET| <--( op: CSCMD_ASYNC_REQ, resp: 75 )
19:53:51.742 NET| :resp ( AC_SERVER_INFO )
19:53:51.742 NET| response processing took 0.1 ms
19:53:56.593 NET| :req ( AC_SERVER_INFO )
19:53:56.593 NET| -->( op: CSCMD_ASYNC_REQ, req: 76 )
19:53:56.761 NET| <--( op: CSCMD_ASYNC_REQ, resp: 76 )
19:53:56.761 NET| :resp ( AC_SERVER_INFO )
19:53:56.761 NET| response processing took 0.1 ms
19:53:57.665 NET| :req ( AC_MM_INFO )
19:53:57.665 NET| -->( op: CSCMD_ASYNC_REQ, req: 77 )
19:53:57.832 NET| <--( op: CSCMD_ASYNC_REQ, resp: 77 )
19:53:57.832 NET| :resp ( AC_MM_INFO )
19:53:57.833 NET| response processing took 0.1 ms
19:54:01.617 NET| :req ( AC_SERVER_INFO )
19:54:01.617 NET| -->( op: CSCMD_ASYNC_REQ, req: 78 )
19:54:01.786 NET| <--( op: CSCMD_ASYNC_REQ, resp: 78 )
19:54:01.786 NET| :resp ( AC_SERVER_INFO )
19:54:01.786 NET| response processing took 0.1 ms
19:54:06.642 NET| :req ( AC_SERVER_INFO )
19:54:06.642 NET| -->( op: CSCMD_ASYNC_REQ, req: 79 )
19:54:06.811 NET| <--( op: CSCMD_ASYNC_REQ, resp: 79 )
19:54:06.811 NET| :resp ( AC_SERVER_INFO )
19:54:06.811 NET| response processing took 0.1 ms
19:54:07.715 NET| :req ( AC_MM_INFO )
19:54:07.715 NET| -->( op: CSCMD_ASYNC_REQ, req: 80 )
19:54:07.883 NET| <--( op: CSCMD_ASYNC_REQ, resp: 80 )
19:54:07.883 NET| :resp ( AC_MM_INFO )
19:54:07.883 NET| response processing took 0.1 ms
19:54:11.683 NET| :req ( AC_SERVER_INFO )
19:54:11.684 NET| -->( op: CSCMD_ASYNC_REQ, req: 82 )
19:54:11.852 NET| <--( op: CSCMD_ASYNC_REQ, resp: 82 )
19:54:11.852 NET| :resp ( AC_SERVER_INFO )
19:54:11.852 NET| response processing took 0.1 ms
19:54:16.719 NET| :req ( AC_SERVER_INFO )
19:54:16.719 NET| -->( op: CSCMD_ASYNC_REQ, req: 83 )
19:54:16.888 NET| <--( op: CSCMD_ASYNC_REQ, resp: 83 )
19:54:16.888 NET| :resp ( AC_SERVER_INFO )
19:54:16.888 NET| response processing took 0.1 ms
19:54:17.572 NET| <--( op: CSCMD_ASYNC_REQ, resp: 0 )
19:54:17.572 NET| :resp ( AC_LEAVE_MM_QUEUE )
19:54:17.572 NET| response processing took 0.2 ms
19:54:18.815 NET| <--( op: SCMD_CONNECT_DEDICATED_SERVER, resp: 0 )
19:54:18.858 NET| response processing took 43.0 ms
19:54:18.858 NET| <--( op: CSCMD_ASYNC_REQ, resp: 0 )
19:54:18.858 NET| :resp ( AC_PLAYER_VESSELS )
19:54:18.858 NET| response processing took 0.1 ms