VGOEmulator.net

Well. my new code is definitely being hit repeatedly. The Console:

[quote]03:01:20.837 I Net Connected to login server 68.98.218.5:10102
05:25:41.972 I UDP New client connected from 68.48.243.242:62251
05:25:41.972 I UDP Received session request from 68.48.243.242:62251 with connection ID 307007920
05:25:42.190 I Net New Session: Account ID: 134 Session ID: 'kge27r56v3ls5sd271tpfmmiv3'
05:25:46.277 D Rules Rule: R_Player:DefaultMovementSpeed, Value: 750.0
05:25:46.293 D Rules Rule: R_Chunk:ProcessThreadSleepMS, Value: 50
05:25:46.309 D Rules Rule: R_Chunk:RemoveSpawnDistance, Value: 17000
05:25:46.309 D Rules Rule: R_Chunk:MaxSendSpawnDistance, Value: 8500
05:25:46.309 D Rules Rule: R_Chunk:HearChatDistance, Value: 8500
05:25:46.309 D Chunk Starting chunk 'Falgarholm' (175)
05:25:46.309 D Rules Rule: R_Dev:LoadNPCData, Value: 1
05:25:46.309 D Unreal Loading Unreal data from the database.
05:25:46.324 D NPC Loading NPCs
05:25:46.574 D NPC Loaded 102 NPCs.
05:25:46.652 D Object Loaded 1 Objects.
05:25:46.652 D Music Loaded 1 Music files.
05:25:46.652 D Sound Loaded 1 Sounds.
05:25:46.667 D Unreal Loaded 1 Movers.
05:25:46.823 I UDP New client connected from 68.48.243.242:62252
05:25:46.823 I UDP Received session request from 68.48.243.242:62252 with connection ID 388555484
05:25:47.042 I Chunk New Session: Account ID: 134 Session ID: 'kge27r56v3ls5sd271tpfmmiv3'
05:25:47.276 D Chunk control_text='HELLO REVISION=0 MINVER=3151 VER=3186'
05:25:47.479 D Chunk control_text='LOGIN'
05:26:26.807 D Chunk control_text='JOIN'
05:27:11.485 I UDP Client from 68.48.243.242:62252 set to disconnect : Timeout
05:27:11.735 I UDP Client from 68.48.243.242:62251 set to disconnect : Timeout
05:27:12.499 I UDP Client from 68.48.243.242:62252 has been removed.
05:27:12.562 I Chunk Starting chunk shutdown timer for Falgarholm.
05:27:12.749 I UDP Client from 68.48.243.242:62251 has been removed.
05:27:22.640 05:27:22.640 I I UDP UDP New client connected from 68.48.243.242:62252
New client connected from 68.48.243.242:62251
05:27:22.640 D UDP Received an ack with an empty sent packets list?
05:27:22.671 I Chunk Chunk shutdown cancelled for Falgarholm.
05:27:23.451 D UDP Received an ack with an empty sent packets list?
05:27:53.185 E Unreal Could not find unreal channel list for account id 0!
05:28:14.682 E Packet Server packet struct (type=2) (client) with opcode 0x00000597 (1431) not found
0000: 00 09 00 EF 02 00 97 05 - 00 00 06 00 00 00 33 00 ..............3.
0010: 38 00 00 00 BA 8E 8.....
05:28:14.698 E Chunk Unhandled opcode 0x00000597 (1431) from 68.48.243.242
05:28:57.474 E Packet Server packet struct (type=2) (client) with opcode 0x00000597 (1431) not found
0000: 00 09 01 B3 02 00 97 05 - 00 00 06 00 00 00 33 00 ..............3.
0010: 38 00 00 00 7D E7 8...}.
05:28:57.489 E Chunk Unhandled opcode 0x00000597 (1431) from 68.48.243.242
05:29:44.446 D General In CampTimers::Check(): UNRECOVERABLE ERROR: character == null
05:29:49.438 D General In CampTimers::Check(): UNRECOVERABLE ERROR: character == null
05:29:54.492 D General In CampTimers::Check(): UNRECOVERABLE ERROR: character == null
05:29:59.485 D General In CampTimers::Check(): UNRECOVERABLE ERROR: character == null
05:31:25.238 I UDP Client from 68.48.243.242:62251 set to disconnect : Timeout
05:31:26.003 I UDP Client from 68.48.243.242:62252 set to disconnect : Timeout
05:31:26.252 I UDP Client from 68.48.243.242:62251 has been removed.
05:31:27.017 I UDP Client from 68.48.243.242:62252 has been removed.
05:31:32.087 I Chunk Starting chunk shutdown timer for Falgarholm.
05:36:32.109 I Chunk Shutdown timer expired. Shutting down Falgarholm.
07:38:37.831 I UDP New client connected from 90.31.161.157:53434
07:38:37.831 I UDP Received session request from 90.31.161.157:53434 with connection ID 1971706
07:38:38.206 I Net New Session: Account ID: 138 Session ID: '6l11uh3n3v8mqgv8m6gl71qjl5'
07:39:03.196 D Rules Rule: R_Player:DefaultMovementSpeed, Value: 750.0
07:39:03.211 D Rules Rule: R_Chunk:ProcessThreadSleepMS, Value: 50
07:39:03.227 D Rules Rule: R_Chunk:RemoveSpawnDistance, Value: 17000
07:39:03.227 D Rules Rule: R_Chunk:MaxSendSpawnDistance, Value: 8500
07:39:03.227 D Rules Rule: R_Chunk:HearChatDistance, Value: 8500
07:39:03.227 D Chunk Starting chunk 'Renton Keep' (152)
07:39:03.227 D Rules Rule: R_Dev:LoadNPCData, Value: 1
07:39:03.227 D Unreal Loading Unreal data from the database.
07:39:03.242 D NPC Loading NPCs
07:39:03.710 D NPC Loaded 150 NPCs.
07:39:03.835 D Object Loaded 51 Objects.
07:39:03.835 D Music Loaded 1 Music files.
07:39:03.851 D Sound Loaded 1 Sounds.
07:39:03.851 D Unreal Loaded 1 Movers.
07:39:04.132 I UDP New client connected from 90.31.161.157:58493
07:39:04.132 I UDP Received session request from 90.31.161.157:58493 with connection ID 443995806
07:39:04.444 I Chunk New Session: Account ID: 138 Session ID: '6l11uh3n3v8mqgv8m6gl71qjl5'
07:39:04.771 D Chunk control_text='HELLO REVISION=0 MINVER=3151 VER=3186'
07:39:05.052 D Chunk control_text='LOGIN'
07:39:10.559 D Chunk control_text='JOIN'
07:42:25.783 D Command Player set .speed to 3500
07:44:06.390 I Chunk Received zone request!
07:44:06.390 I Chunk New zone (-26, 27)
07:44:06.390 D Rules Rule: R_Chunk:ProcessThreadSleepMS, Value: 50
07:44:06.405 D Rules Rule: R_Chunk:RemoveSpawnDistance, Value: 17000
07:44:06.405 D Rules Rule: R_Chunk:MaxSendSpawnDistance, Value: 8500
07:44:06.405 D Rules Rule: R_Chunk:HearChatDistance, Value: 8500
07:44:06.405 D Chunk Starting chunk 'Ruins of Trengal Keep' (153)
07:44:06.405 D Rules Rule: R_Dev:LoadNPCData, Value: 1
07:44:06.405 D Unreal Loading Unreal data from the database.
07:44:06.405 D NPC Loading NPCs
07:44:06.702 D NPC Loaded 74 NPCs.
07:44:06.780 D Object Loaded 13 Objects.
07:44:06.795 D Music Loaded 1 Music files.
07:44:06.795 D Sound Loaded 1 Sounds.
07:44:06.795 D Unreal Loaded 1 Movers.
07:44:07.060 I UDP Client from 90.31.161.157:58493 set to disconnect : Application
07:44:07.076 I UDP New client connected from 90.31.161.157:56716
07:44:07.076 I UDP Received session request from 90.31.161.157:56716 with connection ID 1240440250
07:44:07.388 I Chunk New Session: Account ID: 138 Session ID: '6l11uh3n3v8mqgv8m6gl71qjl5'
07:44:07.731 D Chunk control_text='HELLO REVISION=0 MINVER=3151 VER=3186'
07:44:07.996 D Chunk control_text='LOGIN'
07:44:08.449 I UDP Client from 90.31.161.157:58493 has been removed.
07:44:08.511 I Chunk Starting chunk shutdown timer for Renton Keep.
07:44:09.010 D Chunk control_text='JOIN'
07:49:08.533 I Chunk Shutdown timer expired. Shutting down Renton Keep.
07:50:59.108 E Chunk Unhandled opcode 0x000003A0 (928) from 90.31.161.157
0000: 00 09 07 CC 02 00 A0 03 - 00 00 09 00 00 00 EF 05 ................
0010: 00 00 EF 05 00 00 01 0A - 1B .........
07:52:56.577 I UDP Client from 90.31.161.157:53434 set to disconnect : Timeout
07:52:56.733 I UDP Client from 90.31.161.157:56716 set to disconnect : Timeout
07:52:57.591 I UDP Client from 90.31.161.157:53434 has been removed.
07:52:57.747 I UDP Client from 90.31.161.157:56716 has been removed.
07:52:57.794 I Chunk Starting chunk shutdown timer for Ruins of Trengal Keep.
07:57:57.815 I Chunk Shutdown timer expired. Shutting down Ruins of Trengal Keep.
09:10:04.830 I UDP New client connected from 173.51.246.121:8050
09:10:04.830 I UDP Received session request from 173.51.246.121:8050 with connection ID 445799917
09:10:05.126 I Net New Session: Account ID: 20 Session ID: 'tkqqj3utbqe87ucqpsb1fbqre0'
09:11:02.880 D Rules Rule: R_Player:DefaultMovementSpeed, Value: 750.0
09:11:02.895 D Rules Rule: R_Chunk:ProcessThreadSleepMS, Value: 50
09:11:02.895 D Rules Rule: R_Chunk:RemoveSpawnDistance, Value: 17000
09:11:02.895 D Rules Rule: R_Chunk:MaxSendSpawnDistance, Value: 8500
09:11:02.911 D Rules Rule: R_Chunk:HearChatDistance, Value: 8500
09:11:02.911 D Chunk Starting chunk 'Mekalia' (100)
09:11:02.911 D Rules Rule: R_Dev:LoadNPCData, Value: 1
09:11:02.911 D Unreal Loading Unreal data from the database.
09:11:02.911 D NPC Loading NPCs
09:11:03.082 D NPC Loaded 62 NPCs.
09:11:03.223 D Object Loaded 108 Objects.
09:11:03.223 D Music Loaded 1 Music files.
09:11:03.238 D Sound Loaded 1 Sounds.
09:11:03.238 D Unreal Loaded 1 Movers.
09:11:03.394 I UDP New client connected from 173.51.246.121:16669
09:11:03.394 I UDP Received session request from 173.51.246.121:16669 with connection ID 1430169100
09:11:03.582 I Chunk New Session: Account ID: 20 Session ID: 'tkqqj3utbqe87ucqpsb1fbqre0'
09:11:03.831 D Chunk control_text='HELLO REVISION=0 MINVER=3151 VER=3186'
09:11:04.003 D Chunk control_text='LOGIN'
09:11:20.243 D Chunk control_text='JOIN'
09:12:00.709 I UDP Client from 173.51.246.121:16669 set to disconnect : Timeout
09:12:01.131 I UDP Client from 173.51.246.121:8050 set to disconnect : Timeout
09:12:01.723 I UDP Client from 173.51.246.121:16669 has been removed.
09:12:01.755 I Chunk Starting chunk shutdown timer for Mekalia.
09:12:02.145 I UDP Client from 173.51.246.121:8050 has been removed.
09:12:23.843 09:12:23.843 I I UDP UDP New client connected from 173.51.246.121:6328
New client connected from 173.51.246.121:52579
09:12:23.843 09:12:23.843 D D UDP UDP Received an ack with an empty sent packets list?
Received an ack with an empty sent packets list?
09:12:23.905 I Chunk Chunk shutdown cancelled for Mekalia.
09:12:29.630 I UDP New client connected from 68.98.218.5:44245
09:12:29.630 I UDP Received session request from 68.98.218.5:44245 with connection ID 582394609
09:12:29.755 I Net New Session: Account ID: 1 Session ID: 'erngppv69rmue3mktt7h243u51'
09:12:58.784 E Unreal Could not find unreal channel list for account id 0!
09:13:15.352 D Rules Rule: R_Player:DefaultMovementSpeed, Value: 750.0
09:13:15.367 D Rules Rule: R_Chunk:ProcessThreadSleepMS, Value: 50
09:13:15.367 D Rules Rule: R_Chunk:RemoveSpawnDistance, Value: 17000
09:13:15.367 D Rules Rule: R_Chunk:MaxSendSpawnDistance, Value: 8500
09:13:15.367 D Rules Rule: R_Chunk:HearChatDistance, Value: 8500
09:13:15.383 D Chunk Starting chunk 'Tursh Village' (144)
09:13:15.383 D Rules Rule: R_Dev:LoadNPCData, Value: 1
09:13:15.383 D Unreal Loading Unreal data from the database.
09:13:15.383 D NPC Loading NPCs
09:13:16.272 D NPC Loaded 429 NPCs.
09:13:16.428 D Object Loaded 106 Objects.
09:13:16.444 D Music Loaded 1 Music files.
09:13:16.444 D Sound Loaded 1 Sounds.
09:13:16.444 D Unreal Loaded 1 Movers.
09:13:16.506 I UDP New client connected from 68.98.218.5:21287
09:13:16.506 I UDP Received session request from 68.98.218.5:21287 with connection ID 1370155506
09:13:16.615 I Chunk New Session: Account ID: 1 Session ID: 'erngppv69rmue3mktt7h243u51'
09:13:16.756 D Chunk control_text='HELLO REVISION=0 MINVER=3151 VER=3186'
09:13:16.849 D Chunk control_text='LOGIN'
09:13:19.892 D Chunk control_text='JOIN'
09:13:28.332 D UDP Received an ack with an empty sent packets list?
09:13:50.064 D General In CampTimers::Check(): UNRECOVERABLE ERROR: character == null
09:13:55.056 D General In CampTimers::Check(): UNRECOVERABLE ERROR: character == null
09:14:00.049 D General In CampTimers::Check(): UNRECOVERABLE ERROR: character == null
09:14:05.041 D General In CampTimers::Check(): UNRECOVERABLE ERROR: character == null
09:14:06.835 D UDP Received an ack with an empty sent packets list?
[/quote]
No crash, so that's good... but, why are we there? As Volt suggests... now to find the reason.

This is good. Because this we can fault trace.

While chatting with Dak just now in-game, my client closed for no reason. A victim of that other bug, where all connections get disconnected randomly.


Continuation of that log session:
[quote]09:16:22.510 I Chunk Received zone request!
09:16:22.510 I Chunk New zone (-12, -9)
09:16:22.510 D Rules Rule: R_Chunk:ProcessThreadSleepMS, Value: 50
09:16:22.510 D Rules Rule: R_Chunk:RemoveSpawnDistance, Value: 17000
09:16:22.510 D Rules Rule: R_Chunk:MaxSendSpawnDistance, Value: 8500
09:16:22.526 D Rules Rule: R_Chunk:HearChatDistance, Value: 8500
09:16:22.526 D Chunk Starting chunk 'Qa Riverbank' (93)
09:16:22.526 D Rules Rule: R_Dev:LoadNPCData, Value: 1
09:16:22.526 D Unreal Loading Unreal data from the database.
09:16:22.526 D NPC Loading NPCs
09:16:22.838 D NPC Loaded 128 NPCs.
09:16:22.932 D Object Loaded 25 Objects.
09:16:22.932 D Music Loaded 1 Music files.
09:16:22.932 D Sound Loaded 1 Sounds.
09:16:22.932 D Unreal Loaded 1 Movers.
09:16:27.580 I Chunk Starting chunk shutdown timer for Qa Riverbank.
09:21:23.907 I UDP Client from 173.51.246.121:52579 set to disconnect : Timeout
09:21:24.499 I UDP Client from 173.51.246.121:6328 set to disconnect : Timeout
09:21:24.921 I UDP Client from 173.51.246.121:52579 has been removed.
09:21:25.513 I UDP Client from 173.51.246.121:6328 has been removed.
09:21:27.604 I Chunk Shutdown timer expired. Shutting down Qa Riverbank.
09:21:30.583 I Chunk Starting chunk shutdown timer for Mekalia.
09:22:02.641 I UDP New client connected from 173.51.246.121:6220
09:22:02.641 I UDP Received session request from 173.51.246.121:6220 with connection ID 1771152143
09:22:02.906 I Net New Session: Account ID: 20 Session ID: 'tkqqj3utbqe87ucqpsb1fbqre0'
09:22:08.756 D Rules Rule: R_Player:DefaultMovementSpeed, Value: 750.0
09:22:08.772 D Rules Rule: R_Chunk:ProcessThreadSleepMS, Value: 50
09:22:08.772 D Rules Rule: R_Chunk:RemoveSpawnDistance, Value: 17000
09:22:08.788 D Rules Rule: R_Chunk:MaxSendSpawnDistance, Value: 8500
09:22:08.788 D Rules Rule: R_Chunk:HearChatDistance, Value: 8500
09:22:08.788 D Chunk Starting chunk 'Dahknarg' (180)
09:22:08.788 D Rules Rule: R_Dev:LoadNPCData, Value: 1
09:22:08.788 D Unreal Loading Unreal data from the database.
09:22:08.788 D NPC Loading NPCs
09:22:09.162 D NPC Loaded 160 NPCs.
09:22:09.256 D Object Loaded 29 Objects.
09:22:09.271 D Music Loaded 1 Music files.
09:22:09.271 D Sound Loaded 1 Sounds.
09:22:09.271 D Unreal Loaded 1 Movers.
09:22:09.412 I UDP New client connected from 173.51.246.121:36879
09:22:09.412 I UDP Received session request from 173.51.246.121:36879 with connection ID 188567504
09:22:09.568 I Chunk New Session: Account ID: 20 Session ID: 'tkqqj3utbqe87ucqpsb1fbqre0'
09:22:09.770 D Chunk control_text='HELLO REVISION=0 MINVER=3151 VER=3186'
09:22:09.973 D Chunk control_text='LOGIN'
09:22:19.801 D Chunk control_text='JOIN'
09:22:50.097 I UDP Client from 173.51.246.121:6220 set to disconnect : Timeout
09:22:51.111 I UDP Client from 173.51.246.121:6220 has been removed.
09:23:00.503 I UDP Client from 173.51.246.121:36879 set to disconnect : Timeout
09:23:01.517 I UDP Client from 173.51.246.121:36879 has been removed.
09:23:01.579 I Chunk Starting chunk shutdown timer for Dahknarg.
09:23:07.039 I UDP New client connected from 173.51.246.121:35601
09:23:07.039 D UDP Received an ack with an empty sent packets list?
09:23:07.039 E UDP Received packet with unknown protocol opcode 0x0400 (1024) from 173.51.246.121:
0000: 04 00 15 00 50 ....P
09:23:07.039 I UDP Client from 173.51.246.121:35601 set to disconnect : Application
09:23:07.102 I Chunk Chunk shutdown cancelled for Dahknarg.
09:23:08.615 I UDP Client from 173.51.246.121:35601 has been removed.
09:23:13.732 I Chunk Starting chunk shutdown timer for Dahknarg.
09:23:59.815 I UDP New client connected from 173.51.246.121:32964
09:23:59.815 I UDP Received session request from 173.51.246.121:32964 with connection ID 159442370
09:23:59.971 I Net New Session: Account ID: 20 Session ID: 'tkqqj3utbqe87ucqpsb1fbqre0'
09:24:05.806 D Rules Rule: R_Player:DefaultMovementSpeed, Value: 750.0
09:24:06.164 I UDP New client connected from 173.51.246.121:40107
09:24:06.164 I UDP Received session request from 173.51.246.121:40107 with connection ID 170092966
09:24:06.227 I Chunk Chunk shutdown cancelled for Dahknarg.
09:24:06.320 I Chunk New Session: Account ID: 20 Session ID: 'tkqqj3utbqe87ucqpsb1fbqre0'
09:24:06.523 D Chunk control_text='HELLO REVISION=0 MINVER=3151 VER=3186'
09:24:06.664 D Chunk control_text='LOGIN'
09:24:09.846 D Chunk control_text='JOIN'
09:24:30.610 D Chat [NewTelon] Ainien: Hi John. This is Dakadin
09:24:44.447 D Chat [NewTelon] Ainien: That change fixed the camp timers issues
09:25:45.070 D Command Player .rift to chunk name Tursh Village
09:25:45.210 I UDP New client connected from 173.51.246.121:61900
09:25:45.210 I UDP Received session request from 173.51.246.121:61900 with connection ID 121817936
09:25:45.226 I UDP Client from 173.51.246.121:40107 set to disconnect : Application
09:25:45.397 I Chunk New Session: Account ID: 20 Session ID: 'tkqqj3utbqe87ucqpsb1fbqre0'
09:25:45.600 D Chunk control_text='HELLO REVISION=0 MINVER=3151 VER=3186'
09:25:45.818 D Chunk control_text='LOGIN'
09:25:46.801 I UDP Client from 173.51.246.121:40107 has been removed.
09:25:51.871 I Chunk Starting chunk shutdown timer for Dahknarg.
09:25:58.236 D Chunk control_text='JOIN'
09:26:08.922 D Chat [NewTelon] John: hey
09:26:26.083 I UDP Client from 173.51.246.121:32964 set to disconnect : Timeout
09:26:27.097 I UDP Client from 173.51.246.121:32964 has been removed.
09:26:30.295 D Chat [NewTelon] John: but... i'm hitting that new error code
09:26:30.622 I Chunk Shutdown timer expired. Shutting down Mekalia.
09:26:45.348 I UDP Client from 68.98.218.5:44245 set to disconnect : Timeout
09:26:45.458 I UDP New client connected from 173.51.246.121:11444
09:26:45.458 D UDP Received an ack with an empty sent packets list?
09:26:45.598 I UDP Client from 173.51.246.121:61900 set to disconnect : Timeout
09:26:46.362 I UDP Client from 68.98.218.5:44245 has been removed.
09:26:46.612 I UDP Client from 173.51.246.121:61900 has been removed.
09:27:11.400 I UDP New client connected from 173.51.246.121:19697
09:27:11.400 I UDP Received session request from 173.51.246.121:19697 with connection ID 519324661
09:27:11.572 I Net New Session: Account ID: 20 Session ID: 'tkqqj3utbqe87ucqpsb1fbqre0'
09:27:15.051 I UDP New client connected from 173.51.246.121:26953
09:27:15.051 I UDP Received session request from 173.51.246.121:26953 with connection ID 580048352
09:27:15.285 I Chunk New Session: Account ID: 20 Session ID: 'tkqqj3utbqe87ucqpsb1fbqre0'
09:27:15.519 D Chunk control_text='HELLO REVISION=0 MINVER=3151 VER=3186'
09:27:15.800 D Chunk control_text='LOGIN'
09:27:19.419 D Chunk control_text='JOIN'
09:27:25.909 I UDP Client from 173.51.246.121:19697 set to disconnect : Timeout
09:27:26.158 I UDP Client from 68.98.218.5:21287 set to disconnect : Timeout
09:27:26.158 I UDP Client from 173.51.246.121:11444 set to disconnect : Timeout
09:27:26.923 I UDP Client from 173.51.246.121:19697 has been removed.
09:27:27.172 I UDP Client from 68.98.218.5:21287 has been removed.
09:27:27.172 I UDP Client from 173.51.246.121:11444 has been removed.
09:28:06.719 I UDP Client from 173.51.246.121:26953 set to disconnect : Timeout
09:28:07.733 I UDP Client from 173.51.246.121:26953 has been removed.
09:28:07.764 I Chunk Starting chunk shutdown timer for Tursh Village.[/quote]
Everyone online got dumped at the blue lines.

Yes the code did help with keeping the server up. I logged in with my problem character and couldn't interact with the world so I tried /camp. There was no response so I ran around trying a few other things and did /camp again. It said I had already started camping so I knew it was catching the issue. I couldn't do anything and the client didn't crash after 5 minutes so I ended up closing the client.

I then logged in with another character to talk to John about it since I saw he was online. I was fine until I tried to go to his chunk. Then we both got booted.

Committed (for internal devtest / New Telon) added robustness vs invocation from clients with empty (null) characters, including warning messages to client and server console.