The International Simutrans Forum

Simutrans Extended => Simutrans-Extended bug reports => Simutrans-Extended development => Simutrans-Extended closed bug reports => Topic started by: Vladki on August 29, 2016, 07:04:02 PM

Title: Server desync
Post by: Vladki on August 29, 2016, 07:04:02 PM
I have got some debug output on desync - just when building a semaphore (distant)

Warning: NWC_CHECK:     time difference to server 40
Warning: karte_t:::do_network_world_command:    sync_step=36512  server=[ss=36512 st=9128 nfc=0 rand=308616853 halt=1 line=1 cnvy=1 ssr=1117859445,308616853,0,0,0,0,0,0 str=308616853,308616853,308616853,308616853,308616853,308616853,308616853,0,308616853,308616853,308616853,308616853,308616853,8831220,312502,0 exr=0,0,0,0,0,0,0,0  client=[ss=36512 st=9128 nfc=0 rand=308616853 halt=1 line=1 cnvy=1 ssr=1117859445,308616853,0,0,0,0,0,0 str=308616853,308616853,308616853,308616853,308616853,308616853,308616853,0,308616853,308616853,308616853,308616853,308616853,8831220,312502,0 exr=0,0,0,0,0,0,0,0 
Message: network_command_t::rdwr:       read packet_id=9, client_id=0
Warning: network_check_activity():      received cmd id=9 nwc_check_t from socket[8]
Warning: NWC_CHECK:     time difference to server -280
Message: network_command_t::rdwr:       read packet_id=9, client_id=0
Warning: network_check_activity():      received cmd id=9 nwc_check_t from socket[8]
Warning: NWC_CHECK:     time difference to server -280
Message: network_command_t::rdwr:       write packet_id=8, client_id=2
Warning: nwc_tool_t::rdwr:      rdwr id=8 client=0 plnr=0 pos=43,52,0 tool_id=4116 defpar=lq-semaphore-distant,16,1,1,51,51,0 init=0 flags=0
Message: packet_t::send:        sent 229 bytes to socket[8]; id=8, size=229
Message: network_command_t::rdwr:       read packet_id=9, client_id=0
Warning: network_check_activity():      received cmd id=9 nwc_check_t from socket[8]
Warning: NWC_CHECK:     time difference to server 640
Warning: karte_t:::do_network_world_command:    sync_step=36608  server=[ss=36608 st=9152 nfc=0 rand=930007874 halt=1 line=1 cnvy=1 ssr=217293025,2807993870,0,0,0,0,0,0 str=2807993870,2807993870,2807993870,2807993870,2807993870,2807993870,2807993870,0,930007874,930007874,930007874,930007874,930007874,9860100,348910,0 exr=0,0,0,0,0,0,0,0  client=[ss=36608 st=9152 nfc=0 rand=930007874 halt=1 line=1 cnvy=1 ssr=217293025,2807993870,0,0,0,0,0,0 str=2807993870,2807993870,2807993870,2807993870,2807993870,2807993870,2807993870,0,930007874,930007874,930007874,930007874,930007874,9860100,348910,0 exr=0,0,0,0,0,0,0,0 
Message: network_command_t::rdwr:       read packet_id=8, client_id=0
Warning: nwc_tool_t::rdwr:      rdwr id=8 client=2 plnr=0 pos=43,52,0 tool_id=4116 defpar=lq-semaphore-distant,16,1,1,51,51,0 init=0 flags=0
Warning: network_check_activity():      received cmd id=8 nwc_tool_t from socket[8]
Warning: network_world_command_t::execute:      wanted to execute(8) in the past
Warning: karte_t::network_disconnect(): Lost synchronisation with server. Random flags: 0
Warning: nwc_routesearch_t::reset:      all static variables are reset
World finished ...
Show banner ...
Title: Re: Server desync
Post by: Ves on August 29, 2016, 07:07:17 PM
And now I got an out of bound:

FATAL ERROR: vector_tpl<T>::[] - class koord3d: index out of bounds: 65530 not in 0..20

Appears to be the same as the other one.
Title: Re: Server desync
Post by: Vladki on August 29, 2016, 08:00:16 PM
More debug output (from server):


Warning: NWC_CHECK:     time difference to server 120
Warning: karte_t:::do_network_world_command:    sync_step=33024  server=[ss=33024 st=8256 nfc=0 rand=2928070699 halt=1 line=1 cnvy=1 ssr=2445345475,2928070699,0,0,0,0,0,0 str=2928070699,2928070699,2928070699,2928070699,2928070699,2928070699,2928070699,0,2928070699,2928070699,2928070699,2928070699,2928070699,265066742,9385901,0 exr=0,0,0,0,0,0,0,0  client=[ss=33024 st=8256 nfc=0 rand=2928070699 halt=1 line=1 cnvy=1 ssr=2445345475,2928070699,0,0,0,0,0,0 str=2928070699,2928070699,2928070699,2928070699,2928070699,2928070699,2928070699,0,2928070699,2928070699,2928070699,2928070699,2928070699,265066742,9385901,0 exr=0,0,0,0,0,0,0,0 
Message: network_command_t::rdwr:       read packet_id=9, client_id=0
Warning: network_check_activity():      received cmd id=9 nwc_check_t from socket[8]
Warning: NWC_CHECK:     time difference to server 40
Warning: karte_t:::do_network_world_command:    sync_step=33056  server=[ss=33056 st=8264 nfc=0 rand=2612630715 halt=1 line=1 cnvy=1 ssr=2064525739,2612630715,0,0,0,0,0,0 str=2612630715,2612630715,2612630715,2612630715,2612630715,2612630715,2612630715,0,2612630715,2612630715,2612630715,2612630715,2612630715,265409926,9398053,0 exr=0,0,0,0,0,0,0,0  client=[ss=33056 st=8264 nfc=0 rand=2612630715 halt=1 line=1 cnvy=1 ssr=2064525739,2612630715,0,0,0,0,0,0 str=2612630715,2612630715,2612630715,2612630715,2612630715,2612630715,2612630715,0,2612630715,2612630715,2612630715,2612630715,2612630715,265409926,9398053,0 exr=0,0,0,0,0,0,0,0 
FATAL ERROR: vector_tpl<T>::[] - 7koord3d: index out of bounds: 65530 not in 0..20
Aborting program execution ...

For help with this error or to file a bug report please see the Simutrans forum at
http://forum.simutrans.com
Neúspěšně ukončen (SIGABRT)


Next fail had also this:

ERROR: rail_vehicle_t::activate_choose_signal():        could not reserved route after find_route!
FATAL ERROR: vector_tpl<T>::[] - 7koord3d: index out of bounds: 65530 not in 0..20
Title: Re: Server desync
Post by: Vladki on August 30, 2016, 09:44:52 PM
desyncs were caused by my home wifi connection. Tonight I connected by wire, and got no problems
Title: Re: Server desync
Post by: jamespetts on August 31, 2016, 10:11:18 PM
Thank you for your reports. Has the latest fix prevented the crashes, or are there still some cases in which these occur?
Title: Re: Server desync
Post by: Vladki on September 05, 2016, 09:26:54 PM
No crashes so far.