开云体育

Steve,

09:18:50,153 apps.util.Log4JUtil?????????????????? INFO? - * JMRI log ** [main]
09:18:50,174 apps.util.Log4JUtil?????????????????? INFO? - This log is stored in file: C:\Users\JeanL\JMRI\log\session.log [main]
09:18:50,175 apps.util.Log4JUtil?????????????????? INFO? - This log is appended to file: C:\Users\JeanL\JMRI\log\messages.log [main]
09:18:50,194 apps.Apps???????????????????????????? INFO? - PanelPro version 5.11.4plus+jenkins+20250401T2239Z+R6f2b769ddd3 starts under Java 17.0.14 on Windows 10 amd64 v10.0 at Fri Apr 11 09:18:50 CEST 2025 [main]
09:18:50,322 t.permission.DefaultPermissionManager INFO? - Permission file: C:\Users\JeanL\JMRI\.permissions.xml [main]
09:18:50,332 t.permission.DefaultPermissionManager INFO? - Permission system is enabled: no [main]
09:18:51,815 apps.Apps???????????????????????????? INFO? - Starting with profile JLDModel.3e42cedd [main]
09:18:51,960 jmri.util.node.NodeIdentity?????????? INFO? - Using c45ffa6d-e3ad-4df3-8572-6b22ef38a992 as the JMRI storage identity for profile id 3e42cedd [AWT-EventQueue-0]
09:18:52,061 xml.AbstractSerialConnectionConfigXml INFO? - Starting to connect for "DCC++" [main]
09:18:52,105 jmri.jmrix.dccpp.serial.DCCppAdapter? INFO? - Connecting DCC++ to COM10 USB Serial [main]
09:18:52,108 jmri.jmrix.dccpp.serial.DCCppAdapter? INFO? - DCC++: Port USB-SERIAL CH340 (COM10) opened at 115200 baud, sees DTR: true RTS: true DSR: false CTS: false DCD: false flow: NONE [main]
09:18:52,164 mrix.dccpp.DCCppInitializationManager INFO? - DCC++ Initialization Complete [main]
09:18:52,729 jmri.jmrit.roster.Roster????????????? INFO? - Reading roster file with rootFromName(D:\Documents\JL\JRMI\JLDModel\JLDModel.jmri\roster.xml) [main]
09:18:53,376 jmri.util.startup.PerformFileModel??? INFO? - Loading file D:\Documents\JL\JRMI\JLDModel\JLDModel.jmri\Tables.xml [main]
09:18:58,385 jmri.util.startup.PerformScriptModel? INFO? - Running script D:\Documents\JL\JRMI\JLDModel\JLDModel.jmri\PowerOn.py [main]
09:18:58,402 jmri.jmrix.dccpp.DCCppCommandStation? INFO? - Station Type set to 'DCC-EX' [AWT-EventQueue-0]
09:18:58,403 jmri.jmrix.dccpp.DCCppCommandStation? INFO? - Build set to 'c389fe9' [AWT-EventQueue-0]
09:18:58,403 jmri.jmrix.dccpp.DCCppCommandStation? INFO? - Version set to '5.4.6' [AWT-EventQueue-0]
09:18:58,441 jmri.jmrix.dccpp.DCCppCommandStation? INFO? - changing maxNumSlots from 12 to 50 [AWT-EventQueue-0]
09:18:58,909 jmri.web.server.WebServer???????????? INFO? - Starting Web Server on port 12080 [WebServer]
09:18:59,722 jmri.web.server.WebServer???????????? INFO? - Starting ZeroConfService _http._tcp.local for Web Server with properties {path=/, json=5.4.0} [WebServer]
09:19:02,220 jmri.util.FileUtilSupport???????????? INFO? - File path program: is C:\Program Files (x86)\JMRI\ [main]
09:19:02,221 jmri.util.FileUtilSupport???????????? INFO? - File path preference: is D:\Documents\JL\JRMI\JLDModel\JLDModel.jmri\ [main]
09:19:02,221 jmri.util.FileUtilSupport???????????? INFO? - File path profile: is D:\Documents\JL\JRMI\JLDModel\JLDModel.jmri\ [main]
09:19:02,221 jmri.util.FileUtilSupport???????????? INFO? - File path settings: is C:\Users\JeanL\JMRI\ [main]
09:19:02,221 jmri.util.FileUtilSupport???????????? INFO? - File path home: is C:\Users\JeanL\ [main]
09:19:02,222 jmri.util.FileUtilSupport???????????? INFO? - File path scripts: is C:\Program Files (x86)\JMRI\jython\ [main]
09:19:02,533 t.display.layoutEditor.BlockValueFile INFO? - 2 of 2 block values restored. Rule=RESTOREALWAYS, Power=ON [main]
09:19:02,836 apps.PanelPro.PanelPro??????????????? INFO? - Main initialization done [main]
09:20:07,443 jmri.jmrit.dispatcher.AutoTrainAction INFO? - Section[[IY:AUTO:0021( Spur )] LoadTrain [Spur_Bypass.xml] [Monitor Train Transit Action 3]
09:20:31,581 jmri.jmrit.dispatcher.AutoTrainAction INFO? - Section[[IY:AUTO:0003( Bypass )] LoadTrain [Station_station.xml] [Monitor Train Transit Action 3]
09:21:04,731 jmri.jmrit.dispatcher.AutoTrainAction INFO? - Section[[IY:AUTO:0001( Station )] LoadTrain [Bypass_Spur_.xml] [Monitor Train Transit Action 5]
09:21:25,044 jmri.jmrit.dispatcher.AutoTrainAction INFO? - Section[[IY:AUTO:0021( Spur )] LoadTrain [Spur_Bypass.xml] [Monitor Train Transit Action 3]
09:23:10,860 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[45.520813] remaining. [Allocated Section Block Change on MainEast]
09:23:19,949 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[13.595825] remaining. [Allocated Section Block Change on MainEast]
09:23:31,439 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[45.520813] remaining. [Allocated Section Block Change on MainEast]
09:23:44,372 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[13.595825] remaining. [Allocated Section Block Change on MainEast]
09:23:56,697 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[45.520813] remaining. [Allocated Section Block Change on MainEast]
09:24:09,549 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[13.595825] remaining. [Allocated Section Block Change on MainEast]
09:24:16,964 jmri.jmrit.audio.JoalAudioFactory???? INFO? - Initialised JOAL using OpenAL: vendor - OpenAL Community version - 1.1 ALSOFT 1.23.1 [Listed Table Generation]
09:24:16,992 s.configurexml.DefaultIdTagManagerXml INFO? - Using PanelProIdTags.xml for tag storage [Listed Table Generation]
09:24:17,003 s.configurexml.DefaultIdTagManagerXml INFO? - Using PanelProRailComIdTags.xml for tag storage [Listed Table Generation]
09:24:22,021 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[45.520813] remaining. [Allocated Section Block Change on MainEast]
09:24:34,967 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[13.595825] remaining. [Allocated Section Block Change on MainEast]
09:24:47,241 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[45.520813] remaining. [Allocated Section Block Change on MainEast]
09:24:51,082 jmri.jmrit.consisttool.ConsistFile??? INFO? - Consist file does not exist.? One will be created if necessary. [AWT-EventQueue-0]
09:24:58,951 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[13.595825] remaining. [Allocated Section Block Change on MainEast]
09:25:12,064 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[45.520813] remaining. [Allocated Section Block Change on MainEast]
09:25:24,933 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[13.595825] remaining. [Allocated Section Block Change on MainEast]
09:25:37,292 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[45.520813] remaining. [Allocated Section Block Change on MainEast]
09:25:50,033 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[13.595825] remaining. [Allocated Section Block Change on MainEast]
09:26:02,326 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[45.520813] remaining. [Allocated Section Block Change on MainEast]
09:26:15,033 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[13.595825] remaining. [Allocated Section Block Change on MainEast]
09:26:27,412 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[45.520813] remaining. [Allocated Section Block Change on MainEast]
09:26:40,046 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[13.595825] remaining. [Allocated Section Block Change on MainEast]
09:26:52,373 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[45.520813] remaining. [Allocated Section Block Change on MainEast]
09:27:05,153 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[13.595825] remaining. [Allocated Section Block Change on MainEast]
09:27:17,241 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[45.520813] remaining. [Allocated Section Block Change on MainEast]
09:27:29,729 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[13.595825] remaining. [Allocated Section Block Change on MainEast]
09:27:42,057 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[45.520813] remaining. [Allocated Section Block Change on MainEast]
09:27:54,564 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[13.595825] remaining. [Allocated Section Block Change on MainEast]
09:28:06,962 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[45.520813] remaining. [Allocated Section Block Change on MainEast]
09:28:19,558 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[13.595825] remaining. [Allocated Section Block Change on MainEast]
09:28:31,982 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[45.520813] remaining. [Allocated Section Block Change on MainEast]
09:28:44,504 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[13.595825] remaining. [Allocated Section Block Change on MainEast]
09:28:56,819 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[45.520813] remaining. [Allocated Section Block Change on MainEast]
09:29:09,492 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[13.595825] remaining. [Allocated Section Block Change on MainEast]
09:29:21,774 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[45.520813] remaining. [Allocated Section Block Change on MainEast]
09:29:34,135 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[13.595825] remaining. [Allocated Section Block Change on MainEast]
09:29:46,446 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[45.520813] remaining. [Allocated Section Block Change on MainEast]
09:29:58,997 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[13.595825] remaining. [Allocated Section Block Change on MainEast]
09:30:11,280 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[45.520813] remaining. [Allocated Section Block Change on MainEast]
09:30:24,013 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[13.595825] remaining. [Allocated Section Block Change on MainEast]
09:30:36,364 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[45.520813] remaining. [Allocated Section Block Change on MainEast]
09:30:48,887 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[13.595825] remaining. [Allocated Section Block Change on MainEast]
09:31:01,354 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[45.520813] remaining. [Allocated Section Block Change on MainEast]
09:31:13,888 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[13.595825] remaining. [Allocated Section Block Change on MainEast]
09:31:26,237 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[45.520813] remaining. [Allocated Section Block Change on MainEast]
09:31:38,730 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[13.595825] remaining. [Allocated Section Block Change on MainEast]
09:31:51,050 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[45.520813] remaining. [Allocated Section Block Change on MainEast]
09:32:03,696 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[13.595825] remaining. [Allocated Section Block Change on MainEast]
09:32:16,089 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[45.520813] remaining. [Allocated Section Block Change on MainEast]
09:32:28,722 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[13.595825] remaining. [Allocated Section Block Change on MainEast]
09:32:41,099 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[45.520813] remaining. [Allocated Section Block Change on MainEast]
09:32:53,554 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[13.595825] remaining. [Allocated Section Block Change on MainEast]
09:33:05,994 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[45.520813] remaining. [Allocated Section Block Change on MainEast]
09:33:18,323 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[13.595825] remaining. [Allocated Section Block Change on MainEast]
09:33:30,706 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[45.520813] remaining. [Allocated Section Block Change on MainEast]
09:33:43,529 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[13.595825] remaining. [Allocated Section Block Change on MainEast]
09:33:55,933 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[45.520813] remaining. [Allocated Section Block Change on MainEast]
09:34:08,631 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[13.595825] remaining. [Allocated Section Block Change on MainEast]
09:34:21,130 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[45.520813] remaining. [Allocated Section Block Change on MainEast]
09:34:33,788 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[13.595825] remaining. [Allocated Section Block Change on MainEast]
09:34:46,298 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[45.520813] remaining. [Allocated Section Block Change on MainEast]
09:34:58,886 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[13.595825] remaining. [Allocated Section Block Change on MainEast]
09:35:11,341 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[45.520813] remaining. [Allocated Section Block Change on MainEast]
09:35:24,108 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[13.595825] remaining. [Allocated Section Block Change on MainEast]
09:35:36,473 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[45.520813] remaining. [Allocated Section Block Change on MainEast]
09:35:49,178 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[13.595825] remaining. [Allocated Section Block Change on MainEast]
09:36:01,582 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[45.520813] remaining. [Allocated Section Block Change on MainEast]
09:36:14,315 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[13.595825] remaining. [Allocated Section Block Change on MainEast]
09:36:26,794 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[45.520813] remaining. [Allocated Section Block Change on MainEast]
09:36:39,377 jmri.jmrit.roster.RosterSpeedProfile? WARN? - Throttle destroyed before zero length[13.595825] remaining. [Allocated Section Block Change on MainEast]
09:37:53,570 jmri.jmrit.dispatcher.AutoTrainAction INFO? - Section[[IY:AUTO:0001( Station )] LoadTrain [Bypass_Spur_.xml] [Monitor Train Transit Action 5]
09:38:11,162 jmri.jmrit.dispatcher.AutoTrainAction INFO? - Section[[IY:AUTO:0021( Spur )] LoadTrain [Spur_Bypass.xml] [Monitor Train Transit Action 3]
09:39:38,606 ri.jmrit.beantable.TransitTableAction WARN? - Unhandled transit section action When code: 0 [AWT-EventQueue-0]
09:40:08,586 ri.jmrit.beantable.TransitTableAction WARN? - Unhandled transit section action When code: 0 [AWT-EventQueue-0]
09:40:08,697 ri.jmrit.beantable.TransitTableAction WARN? - Unhandled transit section action When code: 0 [AWT-EventQueue-0]
09:40:36,023 ri.jmrit.beantable.TransitTableAction WARN? - Unhandled transit section action When code: 0 [AWT-EventQueue-0]
09:41:25,123 jmri.jmrit.dispatcher.AutoTrainAction INFO? - Section[[IY:AUTO:0021( Spur )] LoadTrain [Spur_Bypass.xml] [Monitor Train Transit Action 3]
09:41:49,754 jmri.jmrit.dispatcher.AutoTrainAction INFO? - Section[[IY:AUTO:0003( Bypass )] LoadTrain [Station_station.xml] [Monitor Train Transit Action 3]
09:42:22,657 jmri.jmrit.dispatcher.AutoTrainAction INFO? - Section[[IY:AUTO:0001( Station )] LoadTrain [Bypass_Spur_.xml] [Monitor Train Transit Action 5]
09:42:42,503 jmri.jmrit.dispatcher.AutoTrainAction INFO? - Section[[IY:AUTO:0021( Spur )] LoadTrain [Spur_Bypass.xml] [Monitor Train Transit Action 3]
09:43:06,978 jmri.jmrit.dispatcher.AutoTrainAction INFO? - Section[[IY:AUTO:0003( Bypass )] LoadTrain [Station_station.xml] [Monitor Train Transit Action 3]
09:43:39,849 jmri.jmrit.dispatcher.AutoTrainAction INFO? - Section[[IY:AUTO:0001( Station )] LoadTrain [Bypass_Spur_.xml] [Monitor Train Transit Action 5]
09:43:59,759 jmri.jmrit.dispatcher.AutoTrainAction INFO? - Section[[IY:AUTO:0021( Spur )] LoadTrain [Spur_Bypass.xml] [Monitor Train Transit Action 3]
09:45:12,836 ri.jmrit.beantable.TransitTableAction WARN? - Unhandled transit section action When code: 0 [AWT-EventQueue-0]
09:45:25,647 ri.jmrit.beantable.TransitTableAction WARN? - Unhandled transit section action When code: 0 [AWT-EventQueue-0]
09:45:25,655 ri.jmrit.beantable.TransitTableAction WARN? - Unhandled transit section action When code: 0 [AWT-EventQueue-0]
09:45:25,662 ri.jmrit.beantable.TransitTableAction WARN? - Unhandled transit section action When code: 0 [AWT-EventQueue-0]
09:45:25,671 ri.jmrit.beantable.TransitTableAction WARN? - Unhandled transit section action When code: 0 [AWT-EventQueue-0]
09:45:25,678 ri.jmrit.beantable.TransitTableAction WARN? - Unhandled transit section action When code: 0 [AWT-EventQueue-0]
09:45:25,895 ri.jmrit.beantable.TransitTableAction WARN? - Unhandled transit section action When code: 0 [AWT-EventQueue-0]
09:45:25,902 ri.jmrit.beantable.TransitTableAction WARN? - Unhandled transit section action When code: 0 [AWT-EventQueue-0]
09:45:25,911 ri.jmrit.beantable.TransitTableAction WARN? - Unhandled transit section action When code: 0 [AWT-EventQueue-0]
09:45:25,919 ri.jmrit.beantable.TransitTableAction WARN? - Unhandled transit section action When code: 0 [AWT-EventQueue-0]
09:45:25,927 ri.jmrit.beantable.TransitTableAction WARN? - Unhandled transit section action When code: 0 [AWT-EventQueue-0]
09:45:27,089 ri.jmrit.beantable.TransitTableAction WARN? - Unhandled transit section action When code: 0 [AWT-EventQueue-0]
09:49:14,865 jmri.jmrit.dispatcher.AutoTrainAction INFO? - Section[[IY:AUTO:0021( Spur )] LoadTrain [Spur_Bypass.xml] [Monitor Train Transit Action 3]
09:49:39,907 jmri.jmrit.dispatcher.AutoTrainAction INFO? - Section[[IY:AUTO:0003( Bypass )] LoadTrain [Station_station.xml] [Monitor Train Transit Action 3]
09:50:12,839 jmri.jmrit.dispatcher.AutoTrainAction INFO? - Section[[IY:AUTO:0001( Station )] LoadTrain [Bypass_Spur_.xml] [Monitor Train Transit Action 5]
09:50:33,131 jmri.jmrit.dispatcher.AutoTrainAction INFO? - Section[[IY:AUTO:0021( Spur )] LoadTrain [Spur_Bypass.xml] [Monitor Train Transit Action 3]
11:16:56,067 t.display.layoutEditor.BlockValueFile INFO? - 2 of 2 block values restored. Rule=RESTOREALWAYS, Power=ON [Thread-40]
11:25:54,941 apps.jmrit.log.Log4JTreePane????????? INFO? - changing Logging for jmri.jmrit.dispatcher to DEBUG [AWT-EventQueue-0]
11:26:02,645 apps.jmrit.log.Log4JTreePane????????? INFO? - changing Logging for jmri.jmrit.dispatcher to DEBUG [AWT-EventQueue-0]
11:27:02,919 jmri.jmrit.dispatcher.TrainInfoFile?? DEBUG - entered readTrainInfo for TrainInfoDefaultTemplate.xml [AWT-EventQueue-0]
11:27:02,948 jmri.jmrit.dispatcher.TrainInfoFile?? DEBUG - directory of TrainInfoFiles is D:\Documents\JL\JRMI\JLDModel\JLDModel.jmri\dispatcher\traininfo\ [AWT-EventQueue-0]
11:27:04,620 jmri.jmrit.dispatcher.TrainInfoFile?? DEBUG - directory of TrainInfoFiles is D:\Documents\JL\JRMI\JLDModel\JLDModel.jmri\dispatcher\traininfo\ [AWT-EventQueue-0]
11:27:04,621 jmri.jmrit.dispatcher.TrainInfoFile?? DEBUG - entered readTrainInfo for Bypass_Bypass_.xml [AWT-EventQueue-0]
11:27:04,623 jmri.jmrit.dispatcher.TrainInfoFile?? DEBUG - entered readTrainInfo for Bypass_Bypass_CW_D.xml [AWT-EventQueue-0]
11:27:04,626 jmri.jmrit.dispatcher.TrainInfoFile?? DEBUG - entered readTrainInfo for Bypass_Bypass_via_Station.xml [AWT-EventQueue-0]
11:27:04,629 jmri.jmrit.dispatcher.TrainInfoFile?? DEBUG - entered readTrainInfo for Bypass_Spur_.xml [AWT-EventQueue-0]
11:27:04,632 jmri.jmrit.dispatcher.TrainInfoFile?? DEBUG - entered readTrainInfo for Spur_Bypass.xml [AWT-EventQueue-0]
11:27:04,634 jmri.jmrit.dispatcher.TrainInfoFile?? DEBUG - entered readTrainInfo for Spur_Station_CCW.xml [AWT-EventQueue-0]
11:27:04,637 jmri.jmrit.dispatcher.TrainInfoFile?? DEBUG - entered readTrainInfo for Station_Spur.xml [AWT-EventQueue-0]
11:27:04,640 jmri.jmrit.dispatcher.TrainInfoFile?? DEBUG - entered readTrainInfo for Station_Station_CW_D.xml [AWT-EventQueue-0]
11:27:04,643 jmri.jmrit.dispatcher.TrainInfoFile?? DEBUG - entered readTrainInfo for Station_Station_via_Bypass.xml [AWT-EventQueue-0]
11:27:04,645 jmri.jmrit.dispatcher.TrainInfoFile?? DEBUG - entered readTrainInfo for Station_station.xml [AWT-EventQueue-0]
11:27:10,106 jmri.jmrit.dispatcher.TrainInfoFile?? DEBUG - entered readTrainInfo for Bypass_Spur_.xml [AWT-EventQueue-0]
11:27:15,741 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - loading train:, startblockname:Bypass-1, destinationBlockName:Spur [AWT-EventQueue-0]
11:27:15,741 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - trainID:BR-218, tSource:1, startBlockName:Bypass, startBlockSectionSequenceNumber:1, endBlockName:Spur, endBlockSectionSequenceNumber:5 [AWT-EventQueue-0]
11:27:15,742 jmri.jmrit.dispatcher.AutoTrainsFrame DEBUG - Adding ActiveTrain[BR-218 / Bypass-Spur CW] [AWT-EventQueue-0]
11:27:15,750 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: New AutoEngineer, address=3(S), length (mm)=2296, factor=1.0, useSpeedProfile=false [AWT-EventQueue-0]
11:27:15,750 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: requested roster entry 'BR-218', address=3, use speed profile requested=true usespeedprofile set=true [AWT-EventQueue-0]
11:27:15,751 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - First allocation returned null, normal for auotallocate [AWT-EventQueue-0]
11:27:15,751 jmri.jmrit.dispatcher.AutoTrainAction DEBUG - Adding TransitSection[IY:AUTO:0003( Bypass )] [Auto Allocator ]
11:27:15,751 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218 / Bypass-Spur CW:Next Section Expected[true] [Auto Allocator ]
11:27:15,752 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: new current signalmast SM-T1D (IF$shsm:basic:one-low(T1-D))(Stop) for section Bypass (IY:AUTO:0003) [Auto Allocator ]
11:27:15,752 jmri.jmrit.dispatcher.AutoTrainsFrame DEBUG - NewStatus[1] [Auto Allocator ]
11:27:15,752 jmri.jmrit.dispatcher.AutoTrainsFrame DEBUG - [BR-218 / Bypass-Spur CW]:Set new throttle [Auto Allocator ]
11:27:15,757 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - BR-218: Allocated section [Bypass (IY:AUTO:0003)] [Auto Allocator ]
11:27:15,758 jmri.jmrit.dispatcher.AutoAllocate??? DEBUG - BR-218: auto allocating Section T1 (IY:AUTO:0018) [Auto Allocator ]
11:27:15,758 jmri.jmrit.dispatcher.AutoTurnouts??? DEBUG - BR-218: turnout T1 commanded to Thrown (+) [Auto Allocator ]
11:27:15,859 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - BR-218: Allocated section [T1 (IY:AUTO:0018)] [Auto Allocator ]
11:27:15,859 jmri.jmrit.dispatcher.AutoAllocate??? DEBUG - BR-218: auto allocating Section MainEast (IY:AUTO:0002) [Auto Allocator ]
11:27:15,865 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - BR-218: Allocated section [MainEast (IY:AUTO:0002)] [Auto Allocator ]
11:27:15,865 jmri.jmrit.dispatcher.AutoAllocate??? DEBUG - BR-218: auto allocating Section T2 (IY:AUTO:0019) [Auto Allocator ]
11:27:15,865 jmri.jmrit.dispatcher.AutoTurnouts??? DEBUG - BR-218: turnout T2 commanded to Thrown (+) [Auto Allocator ]
11:27:15,968 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - BR-218: Allocated section [T2 (IY:AUTO:0019)] [Auto Allocator ]
11:27:16,252 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - [BR-218 / Bypass-Spur CW]flipping direction was [false] now [true] [AWT-EventQueue-0]
11:27:16,252 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - 3(S): _speedIncrement=Infinity [AWT-EventQueue-0]
11:27:16,252 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: stopping for signal [SM-T1D (IF$shsm:basic:one-low(T1-D))]? [AWT-EventQueue-0]
11:27:16,252 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: StopInCurrentSection called for Bypass (IY:AUTO:0003) task[0] targetspeed[0.0] [AWT-EventQueue-0]
11:27:16,253 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: train is already stopped or stopping. [AWT-EventQueue-0]
11:27:16,537 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: SM-T1D (IF$shsm:basic:one-low(T1-D))(Approach) Medium(50), Dest: SM-T2TC (IF$shsm:basic:one-low(T2-TC)), path max: 100 [AWT-EventQueue-0]
11:27:16,537 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: Signal SM-T1D (IF$shsm:basic:one-low(T1-D)) setting speed to 50.0 for next [AWT-EventQueue-0]
11:27:16,537 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: setTargetSpeedValue: Speed[50.0] [AWT-EventQueue-0]
11:27:16,537 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: setTargetSpeedByProfile: 0.5 SpeedState[50.0] [AWT-EventQueue-0]
11:27:16,538 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - setTargetSpeed: Set Speed[0.5] adjusted to TargetSpeed[0.5]? [AWT-EventQueue-0]
11:27:16,891 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: SM-T1D (IF$shsm:basic:one-low(T1-D))(Clear) Normal(100), Dest: SM-T2TC (IF$shsm:basic:one-low(T2-TC)), path max: 100 [AWT-EventQueue-0]
11:27:16,891 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: Signal SM-T1D (IF$shsm:basic:one-low(T1-D)) setting speed to 100.0 for previous [AWT-EventQueue-0]
11:27:16,891 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: setTargetSpeedValue: Speed[50.0] [AWT-EventQueue-0]
11:27:16,891 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: setTargetSpeedByProfile: 0.5 SpeedState[50.0] [AWT-EventQueue-0]
11:27:16,892 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - setTargetSpeed: Set Speed[0.5] adjusted to TargetSpeed[0.5]? [AWT-EventQueue-0]
11:27:21,686 jmri.jmrit.dispatcher.AutoTrainAction DEBUG - Adding TransitSection[IY:AUTO:0018( T1 )] [AWT-EventQueue-0]
11:27:21,686 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218 / Bypass-Spur CW:Next Section Expected[true] [AWT-EventQueue-0]
11:27:21,687 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: handleBlockStateChange to OCCUPIED section T1 (IY:AUTO:0018), block T1 (IB:AUTO:0006), length 150 [Allocated Section Block Change on T1]
11:27:21,687 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: new current signalmast is null for section T1 (IY:AUTO:0018) - sometimes OK [Allocated Section Block Change on T1]
11:27:21,688 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - BR-218: Allocated section [Spur (IY:AUTO:0021)] [Auto Allocator ]
11:27:22,504 jmri.jmrit.dispatcher.AutoTrainAction DEBUG - Adding TransitSection[IY:AUTO:0002( MainEast )] [AWT-EventQueue-0]
11:27:22,504 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218 / Bypass-Spur CW:Next Section Expected[true] [AWT-EventQueue-0]
11:27:22,505 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: handleBlockStateChange to OCCUPIED section MainEast (IY:AUTO:0002), block MainEast (IB:AUTO:0002), length 450 [Allocated Section Block Change on MainEast]
11:27:22,506 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: new current signalmast SM-T2TC (IF$shsm:basic:one-low(T2-TC))(Approach) for section MainEast (IY:AUTO:0002) [Allocated Section Block Change on MainEast]
11:27:22,506 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: SM-T2TC (IF$shsm:basic:one-low(T2-TC))(Approach) Medium(50), Dest: Spur (IF$vsm:basic:one-searchlight($0006)), path max: 50 [Allocated Section Block Change on MainEast]
11:27:22,506 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: Signal SM-T2TC (IF$shsm:basic:one-low(T2-TC)) setting speed to 50.0 for next [Allocated Section Block Change on MainEast]
11:27:22,506 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: setTargetSpeedValue: Speed[50.0] [Allocated Section Block Change on MainEast]
11:27:22,507 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: setTargetSpeedByProfile: 0.5 SpeedState[50.0] [Allocated Section Block Change on MainEast]
11:27:22,507 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - setTargetSpeed: Set Speed[0.5] adjusted to TargetSpeed[0.5]? [Allocated Section Block Change on MainEast]
11:27:23,405 jmri.jmrit.dispatcher.AutoTrainAction DEBUG - Remove TransitSection[IY:AUTO:0003( Bypass )] [AWT-EventQueue-0]
11:27:23,405 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - BR-218: sectionNotRequiredByHeadOnly Stopping at Secion [T1] excluding from length. [Auto Allocator ]
11:27:23,406 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - [BR-218]:Release Section [Bypass] by Length allocated [2000] release [2000] train [2296] [Auto Allocator ]
11:27:23,406 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: handleBlockStateChange to UNOCCUPIED - Section Bypass (IY:AUTO:0003), Block Bypass (IB:AUTO:0001), speed 0.5 [Allocated Section Block Change on Bypass]
11:27:24,275 jmri.jmrit.dispatcher.AutoTrainAction DEBUG - Remove TransitSection[IY:AUTO:0018( T1 )] [AWT-EventQueue-0]
11:27:24,275 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - BR-218: sectionNotRequiredByHeadOnly Stopping at Secion [MainEast] excluding from length. [Auto Allocator ]
11:27:24,275 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - [BR-218]:Release Section [Bypass] by Length allocated [2150] release [2000] train [2296] [Auto Allocator ]
11:27:24,276 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: handleBlockStateChange to UNOCCUPIED - Section T1 (IY:AUTO:0018), Block T1 (IB:AUTO:0006), speed 0.5 [Allocated Section Block Change on T1]
11:27:25,000 jmri.jmrit.dispatcher.AutoTrainAction DEBUG - Adding TransitSection[IY:AUTO:0019( T2 )] [AWT-EventQueue-0]
11:27:25,001 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218 / Bypass-Spur CW:Next Section Expected[true] [AWT-EventQueue-0]
11:27:25,001 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - BR-218: sectionNotRequiredByHeadOnly Stopping at Secion [MainEast] excluding from length. [Auto Allocator ]
11:27:25,001 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - [BR-218]:Release Section [Bypass] by Length allocated [2150] release [2000] train [2296] [Auto Allocator ]
11:27:25,002 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: handleBlockStateChange to OCCUPIED section T2 (IY:AUTO:0019), block T2 (IB:AUTO:0008), length 150 [Allocated Section Block Change on T2]
11:27:25,002 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: new current signalmast is null for section T2 (IY:AUTO:0019) - sometimes OK [Allocated Section Block Change on T2]
11:27:25,901 jmri.jmrit.dispatcher.AutoTrainAction DEBUG - Remove TransitSection[IY:AUTO:0002( MainEast )] [AWT-EventQueue-0]
11:27:25,902 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - BR-218: sectionNotRequiredByHeadOnly Stopping at Secion [T2] excluding from length. [Auto Allocator ]
11:27:25,902 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - [BR-218]:Release Section [Bypass] by Length allocated [2600] release [2000] train [2296] [Auto Allocator ]
11:27:25,902 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: handleBlockStateChange to UNOCCUPIED - Section MainEast (IY:AUTO:0002), Block MainEast (IB:AUTO:0002), speed 0.5 [Allocated Section Block Change on MainEast]
11:27:25,909 jmri.jmrit.dispatcher.AutoTrainAction DEBUG - Adding TransitSection[IY:AUTO:0021( Spur )] [AWT-EventQueue-0]
11:27:25,910 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218 / Bypass-Spur CW:Next Section Expected[false] [AWT-EventQueue-0]
11:27:25,910 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - BR-218: sectionNotRequiredByHeadOnly Stopping at Secion [T2] excluding from length. [Auto Allocator ]
11:27:25,910 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - [BR-218]:Release Section [Bypass] by Length allocated [2600] release [2000] train [2296] [Auto Allocator ]
11:27:25,910 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: handleBlockStateChange to OCCUPIED section Spur (IY:AUTO:0021), block Spur (IB:AUTO:0004), length 1100 [Allocated Section Block Change on Spur]
11:27:25,911 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: Trip end, stop in Current Section, Block= Spur (IB:AUTO:0004) [Allocated Section Block Change on Spur]
11:27:25,911 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: StopInCurrentSection called for Spur (IY:AUTO:0021) task[4] targetspeed[0.5] [Allocated Section Block Change on Spur]
11:27:25,911 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: Section [Spur (IY:AUTO:0021)] Section Length[1100] Max Train Length [2296] StopBySpeedProfile [true]. setStopNow [Allocated Section Block Change on Spur]
11:27:25,911 mri.jmrit.dispatcher.AllocatedSection DEBUG - Remaining length in section[Spur] is [1100.0] [Allocated Section Block Change on Spur]
11:27:25,911 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - Set Target Speed[0.0] with distance{1100.0] from speed[0.5] [Allocated Section Block Change on Spur]
11:27:27,682 jmri.jmrit.dispatcher.AutoTrainAction DEBUG - Remove TransitSection[IY:AUTO:0019( T2 )] [AWT-EventQueue-0]
11:27:27,682 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - BR-218: sectionNotRequiredByHeadOnly Stopping at Secion [Spur] excluding from length. [Auto Allocator ]
11:27:27,682 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - [BR-218]:Release Section [Bypass] by Length allocated [2750] release [2000] train [2296] [Auto Allocator ]
11:27:27,683 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: handleBlockStateChange to UNOCCUPIED - Section T2 (IY:AUTO:0019), Block T2 (IB:AUTO:0008), speed 0.0 [Allocated Section Block Change on T2]
11:27:33,465 jmri.jmrit.dispatcher.AutoTrainAction INFO? - Section[[IY:AUTO:0021( Spur )] LoadTrain [Spur_Bypass.xml] [Monitor Train Transit Action 3]
11:27:33,465 jmri.jmrit.dispatcher.AutoTrainAction DEBUG - Spinning off load of Spur_Bypass.xml, using Roster entry BR-218 [Monitor Train Transit Action 3]
11:27:33,465 jmri.jmrit.dispatcher.AutoTrainAction DEBUG - Delay Starting for Code [18] in Section [IY:AUTO:0021( Spur )] for [1500] [Monitor Train Transit Action 3]
11:27:33,499 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - BR-218: sectionNotRequiredByHeadOnly Stopping at Secion [Spur] including in length. [Auto Allocator ]
11:27:33,499 jmri.jmrit.dispatcher.AutoTrainsFrame DEBUG - NewStatus[64] [Wait for stop BR-218 / Bypass-Spur CW]
11:27:33,499 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - [BR-218]:Release Section [Bypass] by Length allocated [3850] release [2000] train [2296] [Auto Allocator ]
11:27:33,502 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - Section[Spur] State [4] [Wait for stop BR-218 / Bypass-Spur CW]
11:27:35,466 jmri.jmrit.dispatcher.TrainInfoFile?? DEBUG - entered readTrainInfo for Spur_Bypass.xml [AWT-EventQueue-0]
11:27:35,471 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - loading train:, startblockname:Spur-1, destinationBlockName:Bypass [AWT-EventQueue-0]
11:27:35,471 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - trainID:BR-218, tSource:1, startBlockName:Spur, startBlockSectionSequenceNumber:1, endBlockName:Bypass, endBlockSectionSequenceNumber:5 [AWT-EventQueue-0]
11:27:35,473 jmri.jmrit.dispatcher.AutoTrainsFrame DEBUG - Adding ActiveTrain[BR-218 / Spur-Bypass CCW] [AWT-EventQueue-0]
11:27:35,478 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: New AutoEngineer, address=3(S), length (mm)=2296, factor=1.0, useSpeedProfile=false [AWT-EventQueue-0]
11:27:35,479 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: requested roster entry 'BR-218', address=3, use speed profile requested=true usespeedprofile set=true [AWT-EventQueue-0]
11:27:35,479 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - First allocation returned null, normal for auotallocate [AWT-EventQueue-0]
11:27:35,479 jmri.jmrit.dispatcher.AutoTrainAction DEBUG - Adding TransitSection[IY:AUTO:0021( Spur )] [Auto Allocator ]
11:27:35,479 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218 / Spur-Bypass CCW:Next Section Expected[true] [Auto Allocator ]
11:27:35,480 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: new current signalmast SM-T2D (IF$shsm:basic:one-low(T2-D))(Clear) for section Spur (IY:AUTO:0021) [Auto Allocator ]
11:27:35,480 jmri.jmrit.dispatcher.AutoTrainsFrame DEBUG - NewStatus[1] [Auto Allocator ]
11:27:35,480 jmri.jmrit.dispatcher.AutoTrainsFrame DEBUG - [BR-218 / Spur-Bypass CCW]:Set new throttle [Auto Allocator ]
11:27:35,489 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - BR-218: Allocated section [Spur (IY:AUTO:0021)] [Auto Allocator ]
11:27:35,489 jmri.jmrit.dispatcher.AutoAllocate??? DEBUG - BR-218: auto allocating Section T2 (IY:AUTO:0019) [Auto Allocator ]
11:27:35,489 jmri.jmrit.dispatcher.AutoTurnouts??? DEBUG - BR-218: turnout T2 (DT201) already Thrown (+), skipping [Auto Allocator ]
11:27:35,491 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - BR-218: Allocated section [T2 (IY:AUTO:0019)] [Auto Allocator ]
11:27:35,491 jmri.jmrit.dispatcher.AutoAllocate??? DEBUG - BR-218: auto allocating Section MainEast (IY:AUTO:0002) [Auto Allocator ]
11:27:35,492 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - BR-218: Allocated section [MainEast (IY:AUTO:0002)] [Auto Allocator ]
11:27:35,493 jmri.jmrit.dispatcher.AutoAllocate??? DEBUG - BR-218: auto allocating Section T1 (IY:AUTO:0018) [Auto Allocator ]
11:27:35,493 jmri.jmrit.dispatcher.AutoTurnouts??? DEBUG - BR-218: turnout T1 (DT200) already Thrown (+), skipping [Auto Allocator ]
11:27:35,493 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - BR-218: Allocated section [T1 (IY:AUTO:0018)] [Auto Allocator ]
11:27:35,494 jmri.jmrit.dispatcher.AutoAllocate??? DEBUG - BR-218: auto allocating Section Bypass (IY:AUTO:0003) [Auto Allocator ]
11:27:35,496 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - BR-218: Allocated section [Bypass (IY:AUTO:0003)] [Auto Allocator ]
11:27:35,981 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - [BR-218 / Spur-Bypass CCW]flipping direction was [true] now [false] [AWT-EventQueue-0]
11:27:35,981 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - 3(S): _speedIncrement=Infinity [AWT-EventQueue-0]
11:27:35,981 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: SM-T2D (IF$shsm:basic:one-low(T2-D))(Clear) Normal(100), Dest: SM-T1TC (IF$shsm:basic:one-low(T1-TC)), path max: 100 [AWT-EventQueue-0]
11:27:35,981 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: Signal SM-T2D (IF$shsm:basic:one-low(T2-D)) setting speed to 100.0 for next [AWT-EventQueue-0]
11:27:35,981 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: setTargetSpeedValue: Speed[100.0] [AWT-EventQueue-0]
11:27:35,981 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: setTargetSpeedByProfile: 1.0 SpeedState[100.0] [AWT-EventQueue-0]
11:27:35,982 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - setTargetSpeed: Set Speed[1.0] adjusted to TargetSpeed[0.8]? [AWT-EventQueue-0]
11:27:40,067 jmri.jmrit.dispatcher.AutoTrainAction DEBUG - Adding TransitSection[IY:AUTO:0019( T2 )] [AWT-EventQueue-0]
11:27:40,068 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218 / Spur-Bypass CCW:Next Section Expected[true] [AWT-EventQueue-0]
11:27:40,068 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: handleBlockStateChange to OCCUPIED section T2 (IY:AUTO:0019), block T2 (IB:AUTO:0008), length 150 [Allocated Section Block Change on T2]
11:27:40,068 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: new current signalmast is null for section T2 (IY:AUTO:0019) - sometimes OK [Allocated Section Block Change on T2]
11:27:40,780 jmri.jmrit.dispatcher.AutoTrainAction DEBUG - Adding TransitSection[IY:AUTO:0002( MainEast )] [AWT-EventQueue-0]
11:27:40,780 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218 / Spur-Bypass CCW:Next Section Expected[true] [AWT-EventQueue-0]
11:27:40,781 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: handleBlockStateChange to OCCUPIED section MainEast (IY:AUTO:0002), block MainEast (IB:AUTO:0002), length 450 [Allocated Section Block Change on MainEast]
11:27:40,782 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: new current signalmast SM-T1TC (IF$shsm:basic:one-low(T1-TC))(Approach) for section MainEast (IY:AUTO:0002) [Allocated Section Block Change on MainEast]
11:27:40,782 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: SM-T1TC (IF$shsm:basic:one-low(T1-TC))(Approach) Medium(50), Dest: SM-T3D (IF$shsm:basic:one-low(T3-D)), path max: 100 [Allocated Section Block Change on MainEast]
11:27:40,782 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: Signal SM-T1TC (IF$shsm:basic:one-low(T1-TC)) setting speed to 50.0 for next [Allocated Section Block Change on MainEast]
11:27:40,782 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: setTargetSpeedValue: Speed[50.0] [Allocated Section Block Change on MainEast]
11:27:40,782 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: setTargetSpeedByProfile: 0.5 SpeedState[50.0] [Allocated Section Block Change on MainEast]
11:27:40,782 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - setTargetSpeed: Set Speed[0.5] adjusted to TargetSpeed[0.5]? [Allocated Section Block Change on MainEast]
11:27:41,712 jmri.jmrit.dispatcher.AutoTrainAction DEBUG - Remove TransitSection[IY:AUTO:0021( Spur )] [AWT-EventQueue-0]
11:27:41,712 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - BR-218: sectionNotRequiredByHeadOnly Stopping at Secion [T2] excluding from length. [Auto Allocator ]
11:27:41,712 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - [BR-218]:Release Section [Spur] by Length allocated [1100] release [1100] train [2296] [Auto Allocator ]
11:27:41,713 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: handleBlockStateChange to UNOCCUPIED - Section Spur (IY:AUTO:0021), Block Spur (IB:AUTO:0004), speed 0.5 [Allocated Section Block Change on Spur]
11:27:42,379 jmri.jmrit.dispatcher.AutoTrainAction DEBUG - Remove TransitSection[IY:AUTO:0019( T2 )] [AWT-EventQueue-0]
11:27:42,379 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - BR-218: sectionNotRequiredByHeadOnly Stopping at Secion [MainEast] excluding from length. [Auto Allocator ]
11:27:42,379 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - [BR-218]:Release Section [Spur] by Length allocated [1250] release [1100] train [2296] [Auto Allocator ]
11:27:42,380 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: handleBlockStateChange to UNOCCUPIED - Section T2 (IY:AUTO:0019), Block T2 (IB:AUTO:0008), speed 0.5 [Allocated Section Block Change on T2]
11:27:43,003 jmri.jmrit.dispatcher.AutoTrainAction DEBUG - Adding TransitSection[IY:AUTO:0018( T1 )] [AWT-EventQueue-0]
11:27:43,003 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218 / Spur-Bypass CCW:Next Section Expected[true] [AWT-EventQueue-0]
11:27:43,004 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - BR-218: sectionNotRequiredByHeadOnly Stopping at Secion [MainEast] excluding from length. [Auto Allocator ]
11:27:43,004 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - [BR-218]:Release Section [Spur] by Length allocated [1250] release [1100] train [2296] [Auto Allocator ]
11:27:43,004 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: handleBlockStateChange to OCCUPIED section T1 (IY:AUTO:0018), block T1 (IB:AUTO:0006), length 150 [Allocated Section Block Change on T1]
11:27:43,004 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: new current signalmast is null for section T1 (IY:AUTO:0018) - sometimes OK [Allocated Section Block Change on T1]
11:27:43,854 jmri.jmrit.dispatcher.AutoTrainAction DEBUG - Adding TransitSection[IY:AUTO:0003( Bypass )] [AWT-EventQueue-0]
11:27:43,854 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218 / Spur-Bypass CCW:Next Section Expected[false] [AWT-EventQueue-0]
11:27:43,855 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - BR-218: sectionNotRequiredByHeadOnly Stopping at Secion [MainEast] excluding from length. [Auto Allocator ]
11:27:43,855 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - [BR-218]:Release Section [Spur] by Length allocated [1250] release [1100] train [2296] [Auto Allocator ]
11:27:43,855 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: handleBlockStateChange to OCCUPIED section Bypass (IY:AUTO:0003), block Bypass (IB:AUTO:0001), length 2000 [Allocated Section Block Change on Bypass]
11:27:43,855 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: Trip end, stop in Current Section, Block= Bypass (IB:AUTO:0001) [Allocated Section Block Change on Bypass]
11:27:43,855 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: StopInCurrentSection called for Bypass (IY:AUTO:0003) task[4] targetspeed[0.5] [Allocated Section Block Change on Bypass]
11:27:43,855 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: Section [Bypass (IY:AUTO:0003)] Section Length[2000] Max Train Length [2296] StopBySpeedProfile [true]. setStopNow [Allocated Section Block Change on Bypass]
11:27:43,855 mri.jmrit.dispatcher.AllocatedSection DEBUG - Remaining length in section[Bypass] is [2000.0] [Allocated Section Block Change on Bypass]
11:27:43,856 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - Set Target Speed[0.0] with distance{2000.0] from speed[0.5] [Allocated Section Block Change on Bypass]
11:27:43,926 jmri.jmrit.dispatcher.AutoTrainAction DEBUG - Remove TransitSection[IY:AUTO:0002( MainEast )] [AWT-EventQueue-0]
11:27:43,926 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - BR-218: sectionNotRequiredByHeadOnly Stopping at Secion [T1] excluding from length. [Auto Allocator ]
11:27:43,926 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - [BR-218]:Release Section [Spur] by Length allocated [1700] release [1100] train [2296] [Auto Allocator ]
11:27:43,927 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: handleBlockStateChange to UNOCCUPIED - Section MainEast (IY:AUTO:0002), Block MainEast (IB:AUTO:0002), speed 0.0 [Allocated Section Block Change on MainEast]
11:27:45,624 jmri.jmrit.dispatcher.AutoTrainAction DEBUG - Remove TransitSection[IY:AUTO:0018( T1 )] [AWT-EventQueue-0]
11:27:45,624 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - BR-218: sectionNotRequiredByHeadOnly Stopping at Secion [Bypass] excluding from length. [Auto Allocator ]
11:27:45,625 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - [BR-218]:Release Section [Spur] by Length allocated [1850] release [1100] train [2296] [Auto Allocator ]
11:27:45,625 jmri.jmrit.dispatcher.AutoActiveTrain DEBUG - BR-218: handleBlockStateChange to UNOCCUPIED - Section T1 (IY:AUTO:0018), Block T1 (IB:AUTO:0006), speed 0.0 [Allocated Section Block Change on T1]
11:27:58,560 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - BR-218: sectionNotRequiredByHeadOnly Stopping at Secion [Bypass] including in length. [Auto Allocator ]
11:27:58,560 jmri.jmrit.dispatcher.AutoTrainsFrame DEBUG - NewStatus[64] [Wait for stop BR-218 / Spur-Bypass CCW]
11:27:58,560 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - [BR-218]:Release Section [Spur] by Length allocated [3850] release [1100] train [2296] [Auto Allocator ]
11:27:58,560 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - BR-218: releasing section [Spur (IY:AUTO:0021)] [Auto Allocator ]
11:27:58,564 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - BR-218: sectionNotRequiredByHeadOnly Stopping at Secion [Bypass] including in length. [Auto Allocator ]
11:27:58,564 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - [BR-218]:Release Section [T2] by Length allocated [2750] release [150] train [2296] [Auto Allocator ]
11:27:58,564 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - BR-218: releasing section [T2 (IY:AUTO:0019)] [Auto Allocator ]
11:27:58,566 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - BR-218: sectionNotRequiredByHeadOnly Stopping at Secion [Bypass] including in length. [Auto Allocator ]
11:27:58,567 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - [BR-218]:Release Section [MainEast] by Length allocated [2600] release [450] train [2296] [Auto Allocator ]
11:27:58,567 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - BR-218: sectionNotRequiredByHeadOnly Stopping at Secion [Bypass] including in length. [Auto Allocator ]
11:27:58,567 jmri.jmrit.dispatcher.DispatcherFrame DEBUG - [BR-218]:Release Section [MainEast] by Length allocated [2600] release [450] train [2296] [Auto Allocator ]
11:27:58,572 jmri.jmrit.dispatcher.ActiveTrain???? ERROR - Attempt to remove an unallocated Section T2 (IY:AUTO:0019) [Auto Allocator ]

JeanLouisDelestre@...

De: "Steve_G via groups.io" <RailRodder22@...>
?: [email protected]
贰苍惫辞测é: Jeudi 10 Avril 2025 23:50:45
Objet: Re: [jmriusers] Chaining transits with a different locomotive #dispatcher