My ping is always fine and I rarely get packet loss, yet I do experience a lot of lag in this game. I noticed that lag may be related to individual players.
Here’s a good example of heavy lag, which had been going on for a little while longer than shown in this video, but as can be seen ends instantly as soon as I kill one specific enemy player:
Battle was on the Russian server.
Here are the logs to go with that battle:
game.log
12:57:31.662 | MasterServerSession: connect to dedicated server, session 2604341, at addr 91.230.61.172|35015, zoneId 0
12:57:31.691 | client: start connecting to 91.230.61.172|35015...
12:57:31.914 | client: connected to 91.230.61.172|35015, setting up session...
12:57:32.167 | client: ADD_PLAYER 0 (kamaz266, 00086E4D) status 6
12:57:32.167 | client: ADD_PLAYER 1 (Gnarler, 000998FC) status 6
12:57:32.167 | client: ADD_PLAYER 2 (O4yMeJIa9CoBa, 00096DF5) status 6
12:57:32.167 | client: ADD_PLAYER 3 (schwein, 0009027D) status 2
12:57:32.167 | client: ADD_PLAYER 4 (Denn, 00006B1B) status 6
12:57:32.167 | client: ADD_PLAYER 5 (phish, 00091AB5) status 6
12:57:32.167 | client: ADD_PLAYER 6 (Gerald1989, 0005CE59) status 6
12:57:32.167 | client: ADD_PLAYER 7 (captainCHAOS, 00089BD5) status 2
12:57:32.167 | client: ADD_PLAYER 8 (Snib, 0000A7DE) status 1
12:57:32.167 | client: ADD_PLAYER 9 (cripe, 0009BADD) status 6
12:57:32.167 | client: ADD_PLAYER 10 (Keekabeeks, 000787D9) status 6
12:57:32.167 | client: ADD_PLAYER 11 (LBVF150, 00087C3F) status 6
12:57:32.167 | client: ADD_PLAYER 12 (Crabentus, 0009740A) status 6
12:57:32.167 | client: ADD_PLAYER 13 (surfer44168, 0005E338) status 2
12:57:32.167 | client: ADD_PLAYER 14 (Bananchk, 00096D1E) status 6
12:57:32.167 | client: ADD_PLAYER 15 (Mad42, 0008740D) status 6
12:57:32.167 | client: ADD_PLAYER 16 (ltFrost, 000964C9) status 2
12:57:32.167 | client: ADD_PLAYER 17 (AlarionX, 00095384) status 6
12:57:32.167 | client: ADD_PLAYER 18 (nybzero, 00097FBF) status 6
12:57:32.167 | client: ADD_PLAYER 19 (Alehandro14, 0009B532) status 2
12:57:32.167 | client: server assigned id 8
12:57:32.167 | client: got level load message 's1420_ceres3_northmsite'
12:57:32.251 | ReplayManager: stopping activity due to map change
12:57:32.332 | ====== starting level: 'levels\area3\s1420_ceres3_northmsite' Sentinel client ======
12:57:32.441 | client: send ready message
12:57:32.541 | client: ADD_PLAYER 0 (kamaz266, 00086E4D) status 2
12:57:32.541 | client: ADD_PLAYER 1 (Gnarler, 000998FC) status 6
12:57:32.541 | client: ADD_PLAYER 2 (O4yMeJIa9CoBa, 00096DF5) status 2
12:57:32.541 | client: ADD_PLAYER 3 (schwein, 0009027D) status 2
12:57:32.541 | client: ADD_PLAYER 4 (Denn, 00006B1B) status 6
12:57:32.541 | client: ADD_PLAYER 5 (phish, 00091AB5) status 6
12:57:32.541 | client: ADD_PLAYER 6 (Gerald1989, 0005CE59) status 6
12:57:32.541 | client: ADD_PLAYER 7 (captainCHAOS, 00089BD5) status 2
12:57:32.541 | client: ADD_PLAYER 8 (Snib, 0000A7DE) status 2
12:57:32.542 | client: ADD_PLAYER 9 (cripe, 0009BADD) status 2
12:57:32.542 | client: ADD_PLAYER 10 (Keekabeeks, 000787D9) status 6
12:57:32.542 | client: ADD_PLAYER 11 (LBVF150, 00087C3F) status 2
12:57:32.542 | client: ADD_PLAYER 12 (Crabentus, 0009740A) status 6
12:57:32.542 | client: ADD_PLAYER 13 (surfer44168, 0005E338) status 2
12:57:32.542 | client: ADD_PLAYER 14 (Bananchk, 00096D1E) status 6
12:57:32.542 | client: ADD_PLAYER 15 (Mad42, 0008740D) status 2
12:57:32.542 | client: ADD_PLAYER 16 (ltFrost, 000964C9) status 2
12:57:32.542 | client: ADD_PLAYER 17 (AlarionX, 00095384) status 2
12:57:32.542 | client: ADD_PLAYER 18 (nybzero, 00097FBF) status 6
12:57:32.542 | client: ADD_PLAYER 19 (Alehandro14, 0009B532) status 2
12:57:32.542 | client: ADD_PLAYER 8 (Snib, 0000A7DE) status 4
12:57:32.590 | client: got init message (and 1st snapshot). ping 57
12:57:32.590 | client: ADD_PLAYER 16 (ltFrost, 000964C9) status 4
12:57:32.590 | client: ADD_PLAYER 0 (kamaz266, 00086E4D) status 4
12:57:33.730 | ====== level started: 'levels\area3\s1420_ceres3_northmsite' success ======
12:57:33.730 | client: ADD_PLAYER 3 (schwein, 0009027D) status 4
12:57:33.730 | client: ADD_PLAYER 13 (surfer44168, 0005E338) status 4
12:57:33.730 | client: ADD_PLAYER 7 (captainCHAOS, 00089BD5) status 4
12:57:33.730 | client: ADD_PLAYER 9 (cripe, 0009BADD) status 4
12:57:33.730 | client: ADD_PLAYER 2 (O4yMeJIa9CoBa, 00096DF5) status 4
12:57:33.730 | client: ADD_PLAYER 19 (Alehandro14, 0009B532) status 4
12:57:33.730 | client: ADD_PLAYER 11 (LBVF150, 00087C3F) status 4
12:57:33.731 | client: ADD_PLAYER 14 (Bananchk, 00096D1E) status 4
12:57:33.731 | client: ADD_PLAYER 1 (Gnarler, 000998FC) status 4
12:57:33.750 | client: ADD_PLAYER 10 (Keekabeeks, 000787D9) status 4
12:57:33.834 | client: ADD_PLAYER 6 (Gerald1989, 0005CE59) status 4
12:57:34.086 | client: ADD_PLAYER 17 (AlarionX, 00095384) status 4
12:57:34.506 | client: ADD_PLAYER 4 (Denn, 00006B1B) status 4
12:57:34.506 | client: ADD_PLAYER 15 (Mad42, 0008740D) status 4
12:57:35.178 | client: ADD_PLAYER 12 (Crabentus, 0009740A) status 4
12:57:44.755 | client: ADD_PLAYER 5 (phish, 00091AB5) status 4
12:57:45.427 | client: ADD_PLAYER 18 (nybzero, 00097FBF) status 4
12:57:58.437 | json parse: 0.00ms jsmn, 0.03ms to-m3dDict, 0.03ms total
12:58:50.391 WARNING| Client: received Entity sync notification #0 for entity with netId 477, but entity doesn't exist(def 'SpellAuraEntity')
12:58:56.155 WARNING| Client: received Entity sync notification #0 for entity with netId 545, but entity doesn't exist(def 'SpellAuraEntity')
12:59:11.932 ERROR| Material 'Materials.Default' has no effect 'rocket'
12:59:12.391 ERROR| Material 'Materials.Default' has no effect 'rocket'
12:59:12.816 ERROR| Material 'Materials.Default' has no effect 'rocket'
12:59:13.241 ERROR| Material 'Materials.Default' has no effect 'rocket'
12:59:13.683 ERROR| Material 'Materials.Default' has no effect 'rocket'
12:59:19.395 ERROR| Material 'Materials.Default' has no effect 'rocket'
12:59:31.976 | client: player 2 leave game
13:00:05.047 WARNING| Client: received Entity sync notification #0 for entity with netId 1846, but entity doesn't exist(def 'SpellAuraEntity')
13:00:20.365 | client: ADD_PLAYER 2 (O4yMeJIa9CoBa, 00096DF5) status 4
13:01:06.426 WARNING| Client: received Entity sync notification #0 for entity with netId 2562, but entity doesn't exist(def 'SpellAuraEntity')
13:02:15.912 WARNING| Client: received Entity sync notification #0 for entity with netId 3541, but entity doesn't exist(def 'SpellAuraEntity')
13:02:33.338 ERROR| Material 'Materials.Default' has no effect 'rocket'
13:02:43.199 ERROR| Material 'Materials.Default' has no effect 'rocket'
13:03:02.804 | client: player 12 leave game
13:04:39.065 | json parse: 0.00ms jsmn, 0.02ms to-m3dDict, 0.02ms total
13:05:35.016 WARNING| Client: received Entity sync notification #0 for entity with netId 5539, but entity doesn't exist(def 'SpellAuraEntity')
13:06:17.403 | client: player 19 leave game
13:06:29.345 | json parse: 0.00ms jsmn, 0.02ms to-m3dDict, 0.02ms total
13:07:01.722 | json parse: 0.00ms jsmn, 0.03ms to-m3dDict, 0.03ms total
13:07:03.525 WARNING| frame 337916 gameGlobals.frameTimeReal is too large (0.608242)
13:07:51.710 | client: player 2 leave game
13:08:03.902 | client: ADD_PLAYER 2 (O4yMeJIa9CoBa, 00096DF5) status 4
13:08:04.225 WARNING| Client: received Entity sync notification #0 for entity with netId 6604, but entity doesn't exist(def 'SpellAuraEntity')
13:09:11.763 WARNING| Client: received Entity sync notification #0 for entity with netId 7318, but entity doesn't exist(def 'SpellAuraEntity')
13:09:12.834 ERROR| Material 'Materials.Default' has no effect 'rocket'
13:10:34.818 WARNING| Client: received Entity sync notification #0 for entity with netId 8119, but entity doesn't exist(def 'SpellAuraEntity')
13:11:14.078 ERROR| Material 'Materials.Default' has no effect 'rocket'
13:11:14.452 ERROR| Material 'Materials.Default' has no effect 'rocket'
13:11:14.826 ERROR| Material 'Materials.Default' has no effect 'rocket'
13:11:15.132 ERROR| Material 'Materials.Default' has no effect 'rocket'
13:11:15.421 ERROR| Material 'Materials.Default' has no effect 'rocket'
13:11:56.964 WARNING| Re-requesting vessel information due to m_nextVesselsLockRecheck <= 0.0f (frameTimeReal = 0.017001)
13:12:03.374 | client: player 15 leave game
13:12:11.415 ERROR| Material 'Materials.Default' has no effect 'rocket'
13:12:54.801 | client: player 1 leave game
13:13:01.007 WARNING| script (ui\scripts\windows\lootwnd.lua@260): UI.LootWnd:CanShowLoot()[ERROR]: lootAttemptsNum is 0
13:13:01.432 WARNING| m_bufferizedUICalls delivery took 12.0 ms
13:13:03.868 | client: player 4 leave game
13:13:04.480 | client: connection closed
13:13:04.480 | Network stats (bytes per second): avg pushed 771, max pushed 1021, avg sent 1835, max sent 2427, avg received 4301, max received 8002
game.net.log
12:57:28.386 NET| :resp ( AC_LEAVE_MM_QUEUE ) retCode = 0, param1 = 1, param2 = 0, u64param = 0
12:57:28.386 NET| response processing took 0.3 ms
12:57:31.242 NET| <--( op: CSCMD_ASYNC_REQ, resp: 0 )
12:57:31.242 NET| :resp ( AC_PLAYER_VESSELS ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
12:57:31.242 NET| response processing took 0.5 ms
12:57:31.662 NET| <--( op: SCMD_CONNECT_DEDICATED_SERVER, resp: 0 )
12:57:31.662 NET| :SCMD_CONNECT_DEDICATED_SERVER 91.230.61.172:35015 / 2604341 zone 0
12:57:31.691 NET| response processing took 29.1 ms
12:57:32.519 NET| :req ( AC_USER_PROFILE_GET )
12:57:32.519 NET| -->( op: CSCMD_ASYNC_REQ, req: 893 )
12:57:32.743 NET| <--( op: CSCMD_ASYNC_REQ, resp: 893 )
12:57:32.743 NET| :resp ( AC_USER_PROFILE_GET ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
12:57:32.743 NET| response processing took 0.1 ms
12:57:44.923 NET| :req ( AC_UNIVERSE_GET )
12:57:44.923 NET| -->( op: CSCMD_ASYNC_REQ, req: 895 )
12:57:45.007 NET| <--( op: CSCMD_ASYNC_REQ, resp: 895 )
12:57:45.007 NET| :resp ( AC_UNIVERSE_GET ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
12:57:45.007 NET| response processing took 0.2 ms
12:58:01.107 NET| -->( op: SCMD_KEEP_ALIVE, req: 896 )
12:58:01.175 NET| <--( op: SCMD_KEEP_ALIVE, resp: 896 )
12:58:01.175 NET| new RTT: 68ms
12:58:01.175 NET| response processing took 0.1 ms
12:58:02.915 NET| :req ( AC_USER_PROFILE_GET )
12:58:02.915 NET| -->( op: CSCMD_ASYNC_REQ, req: 897 )
12:58:03.051 NET| <--( op: CSCMD_ASYNC_REQ, resp: 897 )
12:58:03.051 NET| :resp ( AC_USER_PROFILE_GET ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
12:58:03.051 NET| response processing took 0.3 ms
12:58:14.806 NET| :req ( AC_UNIVERSE_GET )
12:58:14.806 NET| -->( op: CSCMD_ASYNC_REQ, req: 898 )
12:58:14.873 NET| <--( op: CSCMD_ASYNC_REQ, resp: 898 )
12:58:14.873 NET| :resp ( AC_UNIVERSE_GET ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
12:58:14.873 NET| response processing took 0.1 ms
12:58:33.254 NET| <--( op: SCMD_USER_PROFILE_NOTIFICATION, resp: 0 )
12:58:33.254 NET| :upn ( 1 ) uid 0000A7DE
12:58:33.254 NET| response processing took 0.1 ms
12:58:33.254 NET| <--( op: SCMD_USER_PROFILE_NOTIFICATION, resp: 0 )
12:58:33.254 NET| :upn ( 1 ) uid 0000A7DE
12:58:33.254 NET| response processing took 0.0 ms
12:58:44.816 NET| :req ( AC_UNIVERSE_GET )
12:58:44.816 NET| -->( op: CSCMD_ASYNC_REQ, req: 900 )
12:58:44.883 NET| <--( op: CSCMD_ASYNC_REQ, resp: 900 )
12:58:44.883 NET| :resp ( AC_UNIVERSE_GET ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
12:58:44.883 NET| response processing took 0.1 ms
12:59:01.119 NET| -->( op: SCMD_KEEP_ALIVE, req: 901 )
12:59:01.187 NET| <--( op: SCMD_KEEP_ALIVE, resp: 901 )
12:59:01.187 NET| new RTT: 68ms
12:59:01.187 NET| response processing took 0.1 ms
12:59:14.824 NET| :req ( AC_UNIVERSE_GET )
12:59:14.824 NET| -->( op: CSCMD_ASYNC_REQ, req: 902 )
12:59:14.890 NET| <--( op: CSCMD_ASYNC_REQ, resp: 902 )
12:59:14.890 NET| :resp ( AC_UNIVERSE_GET ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
12:59:14.890 NET| response processing took 0.2 ms
12:59:17.270 NET| <--( op: SCMD_USER_PROFILE_NOTIFICATION, resp: 0 )
12:59:17.270 NET| :upn ( 1 ) uid 0000A7DE
12:59:17.270 NET| response processing took 0.1 ms
12:59:17.270 NET| <--( op: SCMD_USER_PROFILE_NOTIFICATION, resp: 0 )
12:59:17.270 NET| :upn ( 1 ) uid 0000A7DE
12:59:17.270 NET| response processing took 0.0 ms
12:59:35.665 NET| <--( op: SCMD_USER_PROFILE_NOTIFICATION, resp: 0 )
12:59:35.665 NET| :upn ( 1 ) uid 0000A7DE
12:59:35.665 NET| response processing took 0.1 ms
12:59:35.665 NET| <--( op: SCMD_USER_PROFILE_NOTIFICATION, resp: 0 )
12:59:35.665 NET| :upn ( 1 ) uid 0000A7DE
12:59:35.665 NET| response processing took 0.0 ms
12:59:44.833 NET| :req ( AC_UNIVERSE_GET )
12:59:44.833 NET| -->( op: CSCMD_ASYNC_REQ, req: 904 )
12:59:44.900 NET| <--( op: CSCMD_ASYNC_REQ, resp: 904 )
12:59:44.900 NET| :resp ( AC_UNIVERSE_GET ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
12:59:44.900 NET| response processing took 0.1 ms
13:00:01.136 NET| -->( op: SCMD_KEEP_ALIVE, req: 905 )
13:00:01.204 NET| <--( op: SCMD_KEEP_ALIVE, resp: 905 )
13:00:01.204 NET| new RTT: 68ms
13:00:01.204 NET| response processing took 0.1 ms
13:00:14.840 NET| :req ( AC_UNIVERSE_GET )
13:00:14.840 NET| -->( op: CSCMD_ASYNC_REQ, req: 907 )
13:00:14.924 NET| <--( op: CSCMD_ASYNC_REQ, resp: 907 )
13:00:14.924 NET| :resp ( AC_UNIVERSE_GET ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
13:00:14.924 NET| response processing took 0.1 ms
13:00:44.850 NET| :req ( AC_UNIVERSE_GET )
13:00:44.850 NET| -->( op: CSCMD_ASYNC_REQ, req: 909 )
13:00:44.917 NET| <--( op: CSCMD_ASYNC_REQ, resp: 909 )
13:00:44.917 NET| :resp ( AC_UNIVERSE_GET ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
13:00:44.917 NET| response processing took 0.1 ms
13:01:01.139 NET| -->( op: SCMD_KEEP_ALIVE, req: 910 )
13:01:01.207 NET| <--( op: SCMD_KEEP_ALIVE, resp: 910 )
13:01:01.207 NET| new RTT: 68ms
13:01:01.207 NET| response processing took 0.1 ms
13:01:14.860 NET| :req ( AC_UNIVERSE_GET )
13:01:14.860 NET| -->( op: CSCMD_ASYNC_REQ, req: 911 )
13:01:14.927 NET| <--( op: CSCMD_ASYNC_REQ, resp: 911 )
13:01:14.927 NET| :resp ( AC_UNIVERSE_GET ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
13:01:14.927 NET| response processing took 0.1 ms
13:01:31.945 NET| <--( op: SCMD_USER_PROFILE_NOTIFICATION, resp: 0 )
13:01:31.945 NET| :upn ( 1 ) uid 0000A7DE
13:01:31.945 NET| response processing took 0.1 ms
13:01:42.468 NET| <--( op: SCMD_USER_PROFILE_NOTIFICATION, resp: 0 )
13:01:42.468 NET| :upn ( 1 ) uid 0000A7DE
13:01:42.468 NET| response processing took 0.1 ms
13:01:42.468 NET| <--( op: SCMD_USER_PROFILE_NOTIFICATION, resp: 0 )
13:01:42.468 NET| :upn ( 1 ) uid 0000A7DE
13:01:42.468 NET| response processing took 0.0 ms
13:01:44.866 NET| :req ( AC_UNIVERSE_GET )
13:01:44.866 NET| -->( op: CSCMD_ASYNC_REQ, req: 913 )
13:01:44.933 NET| <--( op: CSCMD_ASYNC_REQ, resp: 913 )
13:01:44.933 NET| :resp ( AC_UNIVERSE_GET ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
13:01:44.933 NET| response processing took 0.1 ms
13:02:01.155 NET| -->( op: SCMD_KEEP_ALIVE, req: 914 )
13:02:01.223 NET| <--( op: SCMD_KEEP_ALIVE, resp: 914 )
13:02:01.223 NET| new RTT: 68ms
13:02:01.223 NET| response processing took 0.1 ms
13:02:14.876 NET| :req ( AC_UNIVERSE_GET )
13:02:14.876 NET| -->( op: CSCMD_ASYNC_REQ, req: 915 )
13:02:14.943 NET| <--( op: CSCMD_ASYNC_REQ, resp: 915 )
13:02:14.943 NET| :resp ( AC_UNIVERSE_GET ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
13:02:14.943 NET| response processing took 0.1 ms
13:02:29.309 NET| <--( op: SCMD_USER_PROFILE_NOTIFICATION, resp: 0 )
13:02:29.309 NET| :upn ( 1 ) uid 0000A7DE
13:02:29.309 NET| response processing took 0.1 ms
13:02:29.309 NET| <--( op: SCMD_USER_PROFILE_NOTIFICATION, resp: 0 )
13:02:29.309 NET| :upn ( 1 ) uid 0000A7DE
13:02:29.309 NET| response processing took 0.0 ms
13:02:40.309 NET| <--( op: SCMD_USER_PROFILE_NOTIFICATION, resp: 0 )
13:02:40.309 NET| :upn ( 1 ) uid 0000A7DE
13:02:40.309 NET| response processing took 0.1 ms
13:02:44.883 NET| :req ( AC_UNIVERSE_GET )
13:02:44.883 NET| -->( op: CSCMD_ASYNC_REQ, req: 917 )
13:02:44.950 NET| <--( op: CSCMD_ASYNC_REQ, resp: 917 )
13:02:44.950 NET| :resp ( AC_UNIVERSE_GET ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
13:02:44.950 NET| response processing took 0.1 ms
13:03:01.169 NET| -->( op: SCMD_KEEP_ALIVE, req: 918 )
13:03:01.237 NET| <--( op: SCMD_KEEP_ALIVE, resp: 918 )
13:03:01.237 NET| new RTT: 68ms
13:03:01.237 NET| response processing took 0.1 ms
13:03:05.028 NET| <--( op: SCMD_USER_PROFILE_NOTIFICATION, resp: 0 )
13:03:05.028 NET| :upn ( 1 ) uid 0000A7DE
13:03:05.028 NET| response processing took 0.1 ms
13:03:05.028 NET| <--( op: SCMD_USER_PROFILE_NOTIFICATION, resp: 0 )
13:03:05.028 NET| :upn ( 1 ) uid 0000A7DE
13:03:05.028 NET| response processing took 0.0 ms
13:03:14.889 NET| :req ( AC_UNIVERSE_GET )
13:03:14.889 NET| -->( op: CSCMD_ASYNC_REQ, req: 919 )
13:03:14.974 NET| <--( op: CSCMD_ASYNC_REQ, resp: 919 )
13:03:14.974 NET| :resp ( AC_UNIVERSE_GET ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
13:03:14.974 NET| response processing took 0.1 ms
13:03:21.706 NET| <--( op: SCMD_USER_PROFILE_NOTIFICATION, resp: 0 )
13:03:21.706 NET| :upn ( 1 ) uid 0000A7DE
13:03:21.706 NET| response processing took 0.1 ms
13:03:44.896 NET| :req ( AC_UNIVERSE_GET )
13:03:44.896 NET| -->( op: CSCMD_ASYNC_REQ, req: 921 )
13:03:44.963 NET| <--( op: CSCMD_ASYNC_REQ, resp: 921 )
13:03:44.963 NET| :resp ( AC_UNIVERSE_GET ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
13:03:44.963 NET| response processing took 0.1 ms
13:03:51.662 NET| <--( op: SCMD_USER_PROFILE_NOTIFICATION, resp: 0 )
13:03:51.662 NET| :upn ( 1 ) uid 0000A7DE
13:03:51.662 NET| response processing took 0.1 ms
13:04:01.182 NET| -->( op: SCMD_KEEP_ALIVE, req: 922 )
13:04:01.250 NET| <--( op: SCMD_KEEP_ALIVE, resp: 922 )
13:04:01.250 NET| new RTT: 68ms
13:04:01.250 NET| response processing took 0.1 ms
13:04:11.706 NET| <--( op: SCMD_USER_PROFILE_NOTIFICATION, resp: 0 )
13:04:11.706 NET| :upn ( 1 ) uid 0000A7DE
13:04:11.706 NET| response processing took 0.1 ms
13:04:11.706 NET| <--( op: SCMD_USER_PROFILE_NOTIFICATION, resp: 0 )
13:04:11.706 NET| :upn ( 1 ) uid 0000A7DE
13:04:11.706 NET| response processing took 0.0 ms
13:04:14.903 NET| :req ( AC_UNIVERSE_GET )
13:04:14.903 NET| -->( op: CSCMD_ASYNC_REQ, req: 923 )
13:04:14.987 NET| <--( op: CSCMD_ASYNC_REQ, resp: 923 )
13:04:14.987 NET| :resp ( AC_UNIVERSE_GET ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
13:04:14.987 NET| response processing took 0.1 ms
13:04:33.144 NET| <--( op: SCMD_USER_PROFILE_NOTIFICATION, resp: 0 )
13:04:33.144 NET| :upn ( 1 ) uid 0000A7DE
13:04:33.144 NET| response processing took 0.1 ms
13:04:33.144 NET| <--( op: SCMD_USER_PROFILE_NOTIFICATION, resp: 0 )
13:04:33.144 NET| :upn ( 1 ) uid 0000A7DE
13:04:33.144 NET| response processing took 0.0 ms
13:04:44.915 NET| :req ( AC_UNIVERSE_GET )
13:04:44.915 NET| -->( op: CSCMD_ASYNC_REQ, req: 925 )
13:04:44.982 NET| <--( op: CSCMD_ASYNC_REQ, resp: 925 )
13:04:44.982 NET| :resp ( AC_UNIVERSE_GET ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
13:04:44.982 NET| response processing took 0.1 ms
13:05:01.201 NET| -->( op: SCMD_KEEP_ALIVE, req: 926 )
13:05:01.269 NET| <--( op: SCMD_KEEP_ALIVE, resp: 926 )
13:05:01.269 NET| new RTT: 68ms
13:05:01.269 NET| response processing took 0.1 ms
13:05:14.921 NET| :req ( AC_UNIVERSE_GET )
13:05:14.921 NET| -->( op: CSCMD_ASYNC_REQ, req: 927 )
13:05:14.988 NET| <--( op: CSCMD_ASYNC_REQ, resp: 927 )
13:05:14.988 NET| :resp ( AC_UNIVERSE_GET ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
13:05:14.988 NET| response processing took 0.1 ms
13:05:44.928 NET| :req ( AC_UNIVERSE_GET )
13:05:44.928 NET| -->( op: CSCMD_ASYNC_REQ, req: 929 )
13:05:44.995 NET| <--( op: CSCMD_ASYNC_REQ, resp: 929 )
13:05:44.995 NET| :resp ( AC_UNIVERSE_GET ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
13:05:44.995 NET| response processing took 0.1 ms
13:05:47.885 NET| <--( op: SCMD_USER_PROFILE_NOTIFICATION, resp: 0 )
13:05:47.885 NET| :upn ( 1 ) uid 0000A7DE
13:05:47.885 NET| response processing took 0.1 ms
13:06:01.218 NET| -->( op: SCMD_KEEP_ALIVE, req: 930 )
13:06:01.303 NET| <--( op: SCMD_KEEP_ALIVE, resp: 930 )
13:06:01.303 NET| new RTT: 85ms
13:06:01.303 NET| response processing took 0.1 ms
13:06:14.939 NET| :req ( AC_UNIVERSE_GET )
13:06:14.939 NET| -->( op: CSCMD_ASYNC_REQ, req: 931 )
13:06:15.006 NET| <--( op: CSCMD_ASYNC_REQ, resp: 931 )
13:06:15.006 NET| :resp ( AC_UNIVERSE_GET ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
13:06:15.006 NET| response processing took 0.1 ms
13:06:44.949 NET| :req ( AC_UNIVERSE_GET )
13:06:44.949 NET| -->( op: CSCMD_ASYNC_REQ, req: 933 )
13:06:45.016 NET| <--( op: CSCMD_ASYNC_REQ, resp: 933 )
13:06:45.016 NET| :resp ( AC_UNIVERSE_GET ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
13:06:45.016 NET| response processing took 0.1 ms
13:07:01.368 NET| -->( op: SCMD_KEEP_ALIVE, req: 934 )
13:07:01.450 NET| <--( op: SCMD_KEEP_ALIVE, resp: 934 )
13:07:01.450 NET| new RTT: 82ms
13:07:01.450 NET| response processing took 0.1 ms
13:07:15.043 NET| :req ( AC_UNIVERSE_GET )
13:07:15.043 NET| -->( op: CSCMD_ASYNC_REQ, req: 935 )
13:07:15.109 NET| <--( op: CSCMD_ASYNC_REQ, resp: 935 )
13:07:15.109 NET| :resp ( AC_UNIVERSE_GET ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
13:07:15.109 NET| response processing took 0.2 ms
13:07:44.987 NET| :req ( AC_UNIVERSE_GET )
13:07:44.987 NET| -->( op: CSCMD_ASYNC_REQ, req: 937 )
13:07:45.059 NET| <--( op: CSCMD_ASYNC_REQ, resp: 937 )
13:07:45.059 NET| :resp ( AC_UNIVERSE_GET ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
13:07:45.059 NET| response processing took 0.1 ms
13:07:58.733 NET| <--( op: SCMD_USER_PROFILE_NOTIFICATION, resp: 0 )
13:07:58.733 NET| :upn ( 1 ) uid 0000A7DE
13:07:58.733 NET| response processing took 0.1 ms
13:07:58.733 NET| <--( op: SCMD_USER_PROFILE_NOTIFICATION, resp: 0 )
13:07:58.733 NET| :upn ( 1 ) uid 0000A7DE
13:07:58.733 NET| response processing took 0.0 ms
13:08:01.301 NET| -->( op: SCMD_KEEP_ALIVE, req: 938 )
13:08:01.369 NET| <--( op: SCMD_KEEP_ALIVE, resp: 938 )
13:08:01.369 NET| new RTT: 68ms
13:08:01.369 NET| response processing took 0.1 ms
13:08:14.988 NET| :req ( AC_UNIVERSE_GET )
13:08:14.988 NET| -->( op: CSCMD_ASYNC_REQ, req: 939 )
13:08:15.072 NET| <--( op: CSCMD_ASYNC_REQ, resp: 939 )
13:08:15.072 NET| :resp ( AC_UNIVERSE_GET ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
13:08:15.072 NET| response processing took 0.1 ms
13:08:45.000 NET| :req ( AC_UNIVERSE_GET )
13:08:45.000 NET| -->( op: CSCMD_ASYNC_REQ, req: 941 )
13:08:45.067 NET| <--( op: CSCMD_ASYNC_REQ, resp: 941 )
13:08:45.067 NET| :resp ( AC_UNIVERSE_GET ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
13:08:45.067 NET| response processing took 0.1 ms
13:09:01.307 NET| -->( op: SCMD_KEEP_ALIVE, req: 942 )
13:09:01.375 NET| <--( op: SCMD_KEEP_ALIVE, resp: 942 )
13:09:01.375 NET| new RTT: 68ms
13:09:01.375 NET| response processing took 0.1 ms
13:09:01.970 NET| <--( op: SCMD_USER_PROFILE_NOTIFICATION, resp: 0 )
13:09:01.970 NET| :upn ( 1 ) uid 0000A7DE
13:09:01.970 NET| response processing took 0.1 ms
13:09:13.412 NET| <--( op: SCMD_USER_PROFILE_NOTIFICATION, resp: 0 )
13:09:13.412 NET| :upn ( 1 ) uid 0000A7DE
13:09:13.412 NET| response processing took 0.1 ms
13:09:15.011 NET| :req ( AC_UNIVERSE_GET )
13:09:15.011 NET| -->( op: CSCMD_ASYNC_REQ, req: 943 )
13:09:15.095 NET| <--( op: CSCMD_ASYNC_REQ, resp: 943 )
13:09:15.095 NET| :resp ( AC_UNIVERSE_GET ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
13:09:15.095 NET| response processing took 0.1 ms
13:09:32.821 NET| <--( op: SCMD_USER_PROFILE_NOTIFICATION, resp: 0 )
13:09:32.821 NET| :upn ( 1 ) uid 0000A7DE
13:09:32.821 NET| response processing took 0.1 ms
13:09:32.821 NET| <--( op: SCMD_USER_PROFILE_NOTIFICATION, resp: 0 )
13:09:32.821 NET| :upn ( 1 ) uid 0000A7DE
13:09:32.821 NET| response processing took 0.0 ms
13:09:45.018 NET| :req ( AC_UNIVERSE_GET )
13:09:45.018 NET| -->( op: CSCMD_ASYNC_REQ, req: 945 )
13:09:45.085 NET| <--( op: CSCMD_ASYNC_REQ, resp: 945 )
13:09:45.085 NET| :resp ( AC_UNIVERSE_GET ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
13:09:45.085 NET| response processing took 0.1 ms
13:10:01.321 NET| -->( op: SCMD_KEEP_ALIVE, req: 946 )
13:10:01.389 NET| <--( op: SCMD_KEEP_ALIVE, resp: 946 )
13:10:01.389 NET| new RTT: 68ms
13:10:01.389 NET| response processing took 0.1 ms
13:10:15.030 NET| :req ( AC_UNIVERSE_GET )
13:10:15.030 NET| -->( op: CSCMD_ASYNC_REQ, req: 947 )
13:10:15.097 NET| <--( op: CSCMD_ASYNC_REQ, resp: 947 )
13:10:15.097 NET| :resp ( AC_UNIVERSE_GET ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
13:10:15.097 NET| response processing took 0.1 ms
13:10:45.036 NET| :req ( AC_UNIVERSE_GET )
13:10:45.036 NET| -->( op: CSCMD_ASYNC_REQ, req: 949 )
13:10:45.103 NET| <--( op: CSCMD_ASYNC_REQ, resp: 949 )
13:10:45.103 NET| :resp ( AC_UNIVERSE_GET ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
13:10:45.103 NET| response processing took 0.1 ms
13:10:54.590 NET| <--( op: SCMD_USER_PROFILE_NOTIFICATION, resp: 0 )
13:10:54.590 NET| :upn ( 1 ) uid 0000A7DE
13:10:54.590 NET| response processing took 0.1 ms
13:11:01.327 NET| -->( op: SCMD_KEEP_ALIVE, req: 950 )
13:11:01.395 NET| <--( op: SCMD_KEEP_ALIVE, resp: 950 )
13:11:01.395 NET| new RTT: 68ms
13:11:01.395 NET| response processing took 0.1 ms
13:11:04.931 NET| <--( op: SCMD_USER_PROFILE_NOTIFICATION, resp: 0 )
13:11:04.931 NET| :upn ( 1 ) uid 0000A7DE
13:11:04.931 NET| response processing took 0.1 ms
13:11:15.048 NET| :req ( AC_UNIVERSE_GET )
13:11:15.048 NET| -->( op: CSCMD_ASYNC_REQ, req: 951 )
13:11:15.115 NET| <--( op: CSCMD_ASYNC_REQ, resp: 951 )
13:11:15.115 NET| :resp ( AC_UNIVERSE_GET ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
13:11:15.115 NET| response processing took 0.1 ms
13:11:16.866 NET| <--( op: SCMD_USER_PROFILE_NOTIFICATION, resp: 0 )
13:11:16.866 NET| :upn ( 1 ) uid 0000A7DE
13:11:16.866 NET| response processing took 0.1 ms
13:11:28.614 NET| <--( op: SCMD_USER_PROFILE_NOTIFICATION, resp: 0 )
13:11:28.614 NET| :upn ( 1 ) uid 0000A7DE
13:11:28.614 NET| response processing took 0.1 ms
13:11:28.614 NET| <--( op: SCMD_USER_PROFILE_NOTIFICATION, resp: 0 )
13:11:28.614 NET| :upn ( 1 ) uid 0000A7DE
13:11:28.614 NET| response processing took 0.0 ms
13:11:43.378 NET| <--( op: SCMD_USER_PROFILE_NOTIFICATION, resp: 0 )
13:11:43.378 NET| :upn ( 1 ) uid 0000A7DE
13:11:43.378 NET| response processing took 0.1 ms
13:11:45.062 NET| :req ( AC_UNIVERSE_GET )
13:11:45.062 NET| -->( op: CSCMD_ASYNC_REQ, req: 953 )
13:11:45.129 NET| <--( op: CSCMD_ASYNC_REQ, resp: 953 )
13:11:45.129 NET| :resp ( AC_UNIVERSE_GET ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
13:11:45.129 NET| response processing took 0.1 ms
13:11:56.964 NET| :req ( AC_PLAYER_VESSELS )
13:11:56.964 NET| -->( op: CSCMD_ASYNC_REQ, req: 954 )
13:11:57.253 NET| <--( op: CSCMD_ASYNC_REQ, resp: 954 )
13:11:57.253 NET| :resp ( AC_PLAYER_VESSELS ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
13:11:57.253 NET| response processing took 0.2 ms
13:11:58.749 NET| <--( op: SCMD_USER_PROFILE_NOTIFICATION, resp: 0 )
13:11:58.749 NET| :upn ( 1 ) uid 0000A7DE
13:11:58.749 NET| response processing took 0.1 ms
13:12:01.334 NET| -->( op: SCMD_KEEP_ALIVE, req: 955 )
13:12:01.402 NET| <--( op: SCMD_KEEP_ALIVE, resp: 955 )
13:12:01.402 NET| new RTT: 68ms
13:12:01.402 NET| response processing took 0.1 ms
13:12:15.071 NET| :req ( AC_UNIVERSE_GET )
13:12:15.072 NET| -->( op: CSCMD_ASYNC_REQ, req: 956 )
13:12:15.138 NET| <--( op: CSCMD_ASYNC_REQ, resp: 956 )
13:12:15.138 NET| :resp ( AC_UNIVERSE_GET ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
13:12:15.138 NET| response processing took 0.1 ms
13:12:45.074 NET| :req ( AC_UNIVERSE_GET )
13:12:45.074 NET| -->( op: CSCMD_ASYNC_REQ, req: 958 )
13:12:45.158 NET| <--( op: CSCMD_ASYNC_REQ, resp: 958 )
13:12:45.158 NET| :resp ( AC_UNIVERSE_GET ) retCode = 0, param1 = 0, param2 = 0, u64param = 0
13:12:45.158 NET| response processing took 0.1 ms
13:13:01.335 NET| -->( op: SCMD_KEEP_ALIVE, req: 959 )
13:13:01.403 NET| <--( op: SCMD_KEEP_ALIVE, resp: 959 )
13:13:01.403 NET| new RTT: 68ms
13:13:01.403 NET| response processing took 0.1 ms
13:13:01.420 NET| <--( op: SCMD_GAME_ENDED, resp: 0 )
