2025-11-19T21:54:03.599Z,1763589243.599 [Supervisor](DEBUG): Initializing supervisor. 2025-11-19T21:54:03.603Z,1763589243.603 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2025-11-19T21:54:03.604Z,1763589243.604 [SyncHandler](INFO): Protected caller Thread ID is 6772 2025-11-19T21:54:03.604Z,1763589243.604 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2025-11-19T21:54:03.605Z,1763589243.605 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2025-11-19T21:54:03.606Z,1763589243.606 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 6773 2025-11-19T21:54:03.610Z,1763589243.610 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2025-11-19T21:54:03.630Z,1763589243.630 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2025-11-19T21:54:03.631Z,1763589243.631 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2025-11-19T21:54:03.631Z,1763589243.631 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 6774 2025-11-19T21:54:03.636Z,1763589243.636 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2025-11-19T21:54:03.637Z,1763589243.637 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2025-11-19T21:54:03.637Z,1763589243.637 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 6775 2025-11-19T21:54:03.639Z,1763589243.639 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2025-11-19T21:54:03.640Z,1763589243.640 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2025-11-19T21:54:03.640Z,1763589243.640 [logger ThreadHandler](INFO): Protected caller Thread ID is 6776 2025-11-19T21:54:03.644Z,1763589243.644 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2025-11-19T21:54:03.644Z,1763589243.644 [Supervisor](INFO): Looking for Config files in directory: Config/ 2025-11-19T21:54:03.647Z,1763589243.647 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2025-11-19T21:54:04.034Z,1763589244.034 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2025-11-19T21:54:04.035Z,1763589244.035 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2025-11-19T21:54:04.135Z,1763589244.135 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Guidance 2025-11-19T21:54:04.135Z,1763589244.135 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2025-11-19T21:54:04.251Z,1763589244.251 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2025-11-19T21:54:04.252Z,1763589244.252 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2025-11-19T21:54:04.390Z,1763589244.390 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2025-11-19T21:54:04.391Z,1763589244.391 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2025-11-19T21:54:04.734Z,1763589244.734 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2025-11-19T21:54:04.735Z,1763589244.735 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2025-11-19T21:54:04.841Z,1763589244.841 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2025-11-19T21:54:04.842Z,1763589244.842 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2025-11-19T21:54:05.231Z,1763589245.231 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2025-11-19T21:54:05.232Z,1763589245.232 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2025-11-19T21:54:05.455Z,1763589245.455 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2025-11-19T21:54:05.455Z,1763589245.455 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2025-11-19T21:54:05.544Z,1763589245.544 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2025-11-19T21:54:05.784Z,1763589245.784 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2025-11-19T21:54:05.784Z,1763589245.784 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2025-11-19T21:54:06.007Z,1763589246.007 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2025-11-19T21:54:06.008Z,1763589246.008 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2025-11-19T21:54:06.542Z,1763589246.542 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2025-11-19T21:54:06.542Z,1763589246.542 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2025-11-19T21:54:06.727Z,1763589246.727 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2025-11-19T21:54:06.728Z,1763589246.728 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2025-11-19T21:54:07.010Z,1763589247.010 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2025-11-19T21:54:07.010Z,1763589247.010 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2025-11-19T21:54:07.826Z,1763589247.826 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2025-11-19T21:54:07.827Z,1763589247.827 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2025-11-19T21:54:08.372Z,1763589248.372 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2025-11-19T21:54:08.375Z,1763589248.375 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/ 2025-11-19T21:54:08.376Z,1763589248.376 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Control.cfg 2025-11-19T21:54:08.481Z,1763589248.481 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Science.cfg 2025-11-19T21:54:08.627Z,1763589248.627 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/secure.cfg 2025-11-19T21:54:08.797Z,1763589248.797 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Servo.cfg 2025-11-19T21:54:08.910Z,1763589248.910 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/BIT.cfg 2025-11-19T21:54:09.011Z,1763589249.011 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Battery.cfg 2025-11-19T21:54:09.278Z,1763589249.278 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2025-11-19T21:54:09.279Z,1763589249.279 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/vehicle.cfg 2025-11-19T21:54:09.396Z,1763589249.396 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/logger.cfg 2025-11-19T21:54:09.502Z,1763589249.502 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Sensor.cfg 2025-11-19T21:54:09.645Z,1763589249.645 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Simulator.cfg 2025-11-19T21:54:09.741Z,1763589249.741 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2025-11-19T21:54:09.753Z,1763589249.753 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2025-11-19T21:54:09.911Z,1763589249.911 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2025-11-19T21:54:09.912Z,1763589249.912 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2025-11-19T21:54:09.980Z,1763589249.980 [VerticalControl](DEBUG): Construct VerticalControl. 2025-11-19T21:54:10.040Z,1763589250.040 [VerticalControl] Loaded 2025-11-19T21:54:10.040Z,1763589250.040 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2025-11-19T21:54:10.043Z,1763589250.043 [HorizontalControl](DEBUG): Construct HorizontalControl. 2025-11-19T21:54:10.091Z,1763589250.091 [HorizontalControl] Loaded 2025-11-19T21:54:10.091Z,1763589250.091 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2025-11-19T21:54:10.094Z,1763589250.094 [SpeedControl](DEBUG): Construct SpeedControl. 2025-11-19T21:54:10.097Z,1763589250.097 [SpeedControl] Loaded 2025-11-19T21:54:10.097Z,1763589250.097 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2025-11-19T21:54:10.099Z,1763589250.099 [LoopControl](DEBUG): Construct LoopControl. 2025-11-19T21:54:10.100Z,1763589250.100 [LoopControl] Loaded 2025-11-19T21:54:10.100Z,1763589250.100 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2025-11-19T21:54:10.101Z,1763589250.101 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2025-11-19T21:54:10.101Z,1763589250.101 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2025-11-19T21:54:10.177Z,1763589250.177 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2025-11-19T21:54:10.177Z,1763589250.177 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2025-11-19T21:54:11.052Z,1763589251.052 [AHRS_M2] Loaded 2025-11-19T21:54:11.052Z,1763589251.052 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2025-11-19T21:54:11.331Z,1763589251.331 [BackseatComponent] Loaded 2025-11-19T21:54:11.331Z,1763589251.331 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2025-11-19T21:54:11.332Z,1763589251.332 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408BE4E0 2025-11-19T21:54:11.332Z,1763589251.332 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 6856 2025-11-19T21:54:11.335Z,1763589251.335 [LcmPublisher](INFO): Full slate access is ENABLED. All requested slate values (including non-universals) will be published on LCM. 2025-11-19T21:54:11.336Z,1763589251.336 [LcmPublisher] Loaded 2025-11-19T21:54:11.336Z,1763589251.336 [ComponentRegistry](DEBUG): SyncComponent "LcmPublisher" handled in the control thread. 2025-11-19T21:54:12.135Z,1763589252.135 [BPC1] Loaded 2025-11-19T21:54:12.136Z,1763589252.136 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2025-11-19T21:54:12.231Z,1763589252.231 [DAT] Loaded 2025-11-19T21:54:12.231Z,1763589252.231 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2025-11-19T21:54:12.232Z,1763589252.232 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 408EE4E0 2025-11-19T21:54:12.232Z,1763589252.232 [DAT ThreadHandler](INFO): Protected caller Thread ID is 6857 2025-11-19T21:54:12.322Z,1763589252.322 [DataOverHttps] Loaded 2025-11-19T21:54:12.323Z,1763589252.323 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2025-11-19T21:54:12.324Z,1763589252.324 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4091E4E0 2025-11-19T21:54:12.324Z,1763589252.324 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 6858 2025-11-19T21:54:12.347Z,1763589252.347 [Depth_Keller] Loaded 2025-11-19T21:54:12.347Z,1763589252.347 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2025-11-19T21:54:12.352Z,1763589252.352 [DropWeight] Loaded 2025-11-19T21:54:12.352Z,1763589252.352 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2025-11-19T21:54:12.415Z,1763589252.415 [NAL9602] Loaded 2025-11-19T21:54:12.415Z,1763589252.415 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2025-11-19T21:54:12.446Z,1763589252.446 [Onboard] Loaded 2025-11-19T21:54:12.446Z,1763589252.446 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2025-11-19T21:54:12.447Z,1763589252.447 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4094E4E0 2025-11-19T21:54:12.448Z,1763589252.448 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 6859 2025-11-19T21:54:12.461Z,1763589252.461 [Power24vConverter] Loaded 2025-11-19T21:54:12.462Z,1763589252.462 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2025-11-19T21:54:12.477Z,1763589252.477 [Radio_Surface] Loaded 2025-11-19T21:54:12.477Z,1763589252.477 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2025-11-19T21:54:12.478Z,1763589252.478 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4097E4E0 2025-11-19T21:54:12.479Z,1763589252.479 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 6860 2025-11-19T21:54:12.494Z,1763589252.494 [Sonardyne_Nano] Loaded 2025-11-19T21:54:12.494Z,1763589252.494 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2025-11-19T21:54:12.494Z,1763589252.494 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2025-11-19T21:54:12.495Z,1763589252.495 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2025-11-19T21:54:12.509Z,1763589252.509 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2025-11-19T21:54:12.510Z,1763589252.510 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2025-11-19T21:54:12.557Z,1763589252.557 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2025-11-19T21:54:12.557Z,1763589252.557 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2025-11-19T21:54:12.741Z,1763589252.741 [SBIT](DEBUG): Construct Startup Built In Test. 2025-11-19T21:54:12.750Z,1763589252.750 [SBIT] Loaded 2025-11-19T21:54:12.750Z,1763589252.750 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2025-11-19T21:54:12.753Z,1763589252.753 [IBIT](DEBUG): Construct Initiated Built In Test. 2025-11-19T21:54:12.766Z,1763589252.766 [IBIT] Loaded 2025-11-19T21:54:12.766Z,1763589252.766 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2025-11-19T21:54:12.771Z,1763589252.771 [CBIT](DEBUG): Construct Continuous Built In Test. 2025-11-19T21:54:12.849Z,1763589252.849 [CBIT] Loaded 2025-11-19T21:54:12.849Z,1763589252.849 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2025-11-19T21:54:12.881Z,1763589252.881 [GFScanner] Loaded 2025-11-19T21:54:12.881Z,1763589252.881 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread. 2025-11-19T21:54:12.882Z,1763589252.882 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2025-11-19T21:54:12.882Z,1763589252.882 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2025-11-19T21:54:13.264Z,1763589253.264 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2025-11-19T21:54:13.264Z,1763589253.264 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2025-11-19T21:54:13.327Z,1763589253.327 [DepthRateCalculator] Loaded 2025-11-19T21:54:13.328Z,1763589253.328 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2025-11-19T21:54:13.333Z,1763589253.333 [PitchRateCalculator] Loaded 2025-11-19T21:54:13.333Z,1763589253.333 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2025-11-19T21:54:13.344Z,1763589253.344 [SpeedCalculator] Loaded 2025-11-19T21:54:13.344Z,1763589253.344 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2025-11-19T21:54:13.349Z,1763589253.349 [YawRateCalculator] Loaded 2025-11-19T21:54:13.349Z,1763589253.349 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2025-11-19T21:54:13.367Z,1763589253.367 [ElevatorOffsetCalculator] Loaded 2025-11-19T21:54:13.367Z,1763589253.367 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2025-11-19T21:54:13.368Z,1763589253.368 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2025-11-19T21:54:13.369Z,1763589253.369 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2025-11-19T21:54:13.573Z,1763589253.573 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2025-11-19T21:54:13.574Z,1763589253.574 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2025-11-19T21:54:13.704Z,1763589253.704 [DeadReckonUsingMultipleVelocitySources] Loaded 2025-11-19T21:54:13.704Z,1763589253.704 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2025-11-19T21:54:13.718Z,1763589253.718 [NavChart] Loaded 2025-11-19T21:54:13.718Z,1763589253.718 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2025-11-19T21:54:13.723Z,1763589253.723 [UniversalFixResidualReporter] Loaded 2025-11-19T21:54:13.724Z,1763589253.724 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2025-11-19T21:54:13.724Z,1763589253.724 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2025-11-19T21:54:13.725Z,1763589253.725 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2025-11-19T21:54:13.897Z,1763589253.897 [BuoyancyServo] Loaded 2025-11-19T21:54:13.898Z,1763589253.898 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2025-11-19T21:54:13.920Z,1763589253.920 [ElevatorServo] Loaded 2025-11-19T21:54:13.921Z,1763589253.921 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2025-11-19T21:54:13.942Z,1763589253.942 [MassServo] Loaded 2025-11-19T21:54:13.942Z,1763589253.942 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2025-11-19T21:54:13.962Z,1763589253.962 [RudderServo] Loaded 2025-11-19T21:54:13.962Z,1763589253.962 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2025-11-19T21:54:13.979Z,1763589253.979 [ThrusterHE] Loaded 2025-11-19T21:54:13.979Z,1763589253.979 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2025-11-19T21:54:13.980Z,1763589253.980 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2025-11-19T21:54:13.980Z,1763589253.980 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2025-11-19T21:54:14.199Z,1763589254.199 [CTD_Seabird] Loaded 2025-11-19T21:54:14.199Z,1763589254.199 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2025-11-19T21:54:14.201Z,1763589254.201 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40C0E4E0 2025-11-19T21:54:14.201Z,1763589254.201 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 6861 2025-11-19T21:54:14.237Z,1763589254.237 [ESPComponent] Loaded 2025-11-19T21:54:14.237Z,1763589254.237 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2025-11-19T21:54:14.258Z,1763589254.258 [PAR_Licor] Loaded 2025-11-19T21:54:14.259Z,1763589254.259 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2025-11-19T21:54:14.304Z,1763589254.304 [WetLabsBB2FL] Loaded 2025-11-19T21:54:14.304Z,1763589254.304 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2025-11-19T21:54:14.305Z,1763589254.305 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40C3E4E0 2025-11-19T21:54:14.305Z,1763589254.305 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 6862 2025-11-19T21:54:14.306Z,1763589254.306 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2025-11-19T21:54:14.312Z,1763589254.312 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2025-11-19T21:54:14.315Z,1763589254.315 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2025-11-19T21:54:14.326Z,1763589254.326 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2025-11-19T21:54:14.327Z,1763589254.327 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C6E4E0 2025-11-19T21:54:14.327Z,1763589254.327 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 6863 2025-11-19T21:54:14.332Z,1763589254.332 [Supervisor](INFO): Main Thread ID is 6771 2025-11-19T21:54:14.332Z,1763589254.332 [Supervisor](DEBUG): Running supervisor. 2025-11-19T21:54:14.332Z,1763589254.332 [CommandExec ThreadHandler](INFO): Handler Thread ID is 6864 2025-11-19T21:54:14.333Z,1763589254.333 [CommandExec](INFO): Initializing the command executive. 2025-11-19T21:54:14.335Z,1763589254.335 [CommandLine ThreadHandler](INFO): Handler Thread ID is 6865 2025-11-19T21:54:14.337Z,1763589254.337 [controlThread ThreadHandler](INFO): Handler Thread ID is 6866 2025-11-19T21:54:14.337Z,1763589254.337 [controlThread](DEBUG): Initializing ControlThread 2025-11-19T21:54:14.338Z,1763589254.338 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2025-11-19T21:54:14.340Z,1763589254.340 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2025-11-19T21:54:14.340Z,1763589254.340 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2025-11-19T21:54:14.341Z,1763589254.341 [LoopControl](DEBUG): Initialize LoopControlComponent. 2025-11-19T21:54:14.344Z,1763589254.344 [SBIT](INFO): Initialize SBIT Component. 2025-11-19T21:54:14.344Z,1763589254.344 [SBIT](IMPORTANT): git: 2025-11-06-4-g76494056e 2025-11-19T21:54:14.345Z,1763589254.345 [SBIT](INFO): git hash: 76494056ed9c20a4ea114d534fa322c9d45bc993 2025-11-19T21:54:14.345Z,1763589254.345 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2025-11-19T21:54:14.346Z,1763589254.346 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #639 PREEMPT Wed Mar 12 12:53:33 PDT 2014 Kernel Reported: #1 PREEMPT Tue Nov 28 15:04:22 PST 2023 2025-11-19T21:54:14.347Z,1763589254.347 [SBIT](INFO): Beginning SBIT in 117.000000 seconds. 2025-11-19T21:54:14.348Z,1763589254.348 [IBIT](INFO): Initialize IBIT Component. 2025-11-19T21:54:14.349Z,1763589254.349 [CBIT](DEBUG): Initialize CBIT Component. 2025-11-19T21:54:14.350Z,1763589254.350 [logger ThreadHandler](INFO): Handler Thread ID is 6867 2025-11-19T21:54:14.360Z,1763589254.360 [CBIT](DEBUG): Initialized mux pins. 2025-11-19T21:54:14.360Z,1763589254.360 [CBIT](DEBUG): Initializing the watchdog timer. 2025-11-19T21:54:14.368Z,1763589254.368 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 6868 2025-11-19T21:54:14.385Z,1763589254.385 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2025-11-19T21:54:14.385Z,1763589254.385 [CBIT](DEBUG): Initializing heartbeat. 2025-11-19T21:54:14.386Z,1763589254.386 [DAT ThreadHandler](INFO): Handler Thread ID is 6869 2025-11-19T21:54:14.387Z,1763589254.387 [DAT](INFO): Powering up 2025-11-19T21:54:14.387Z,1763589254.387 [DAT](DEBUG): Initializing DAT. 2025-11-19T21:54:14.393Z,1763589254.393 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 6871 2025-11-19T21:54:14.395Z,1763589254.395 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2025-11-19T21:54:14.416Z,1763589254.416 [Onboard ThreadHandler](INFO): Handler Thread ID is 6872 2025-11-19T21:54:14.433Z,1763589254.433 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 6873 2025-11-19T21:54:14.452Z,1763589254.452 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 6874 2025-11-19T21:54:14.453Z,1763589254.453 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-11-19T21:54:14.456Z,1763589254.456 [CBIT](DEBUG): Deactivating emergency mode. 2025-11-19T21:54:14.457Z,1763589254.457 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 6876 2025-11-19T21:54:14.460Z,1763589254.460 [WetLabsBB2FL](INFO): Powering up 2025-11-19T21:54:14.462Z,1763589254.462 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 6878 2025-11-19T21:54:14.469Z,1763589254.469 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2025-11-19T21:54:14.469Z,1763589254.469 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2025-11-19T21:54:14.469Z,1763589254.469 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2025-11-19T21:54:14.469Z,1763589254.469 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2025-11-19T21:54:14.469Z,1763589254.469 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2025-11-19T21:54:14.469Z,1763589254.469 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2025-11-19T21:54:14.470Z,1763589254.470 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2025-11-19T21:54:14.470Z,1763589254.470 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2025-11-19T21:54:14.496Z,1763589254.496 [CBIT](DEBUG): Backplane powered. 2025-11-19T21:54:14.496Z,1763589254.496 [GFScanner](DEBUG): Initializing GFScanner 2025-11-19T21:54:14.496Z,1763589254.496 [GFScanner](DEBUG): Deactivating GF circuits. 2025-11-19T21:54:14.501Z,1763589254.501 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2025-11-19T21:54:14.501Z,1763589254.501 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2025-11-19T21:54:14.501Z,1763589254.501 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2025-11-19T21:54:14.502Z,1763589254.502 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2025-11-19T21:54:14.502Z,1763589254.502 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2025-11-19T21:54:14.503Z,1763589254.503 [NavChart](DEBUG): Initialize NavChart Navigation. 2025-11-19T21:54:14.504Z,1763589254.504 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2025-11-19T21:54:14.512Z,1763589254.512 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2025-11-19T21:54:14.513Z,1763589254.513 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2025-11-19T21:54:14.513Z,1763589254.513 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2025-11-19T21:54:14.517Z,1763589254.517 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2025-11-19T21:54:14.588Z,1763589254.588 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2025-11-19T21:54:14.599Z,1763589254.599 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2025-11-19T21:54:14.659Z,1763589254.659 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Startup { behavior Guidance:GoToSurface { run in progression } aggregate StartupSatComms { run in sequence readDatum { timeout duration=P1M Universal:latitude_fix } readDatum { timeout duration=P1M Universal:platform_communications } } } 2025-11-19T21:54:14.660Z,1763589254.660 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2025-11-19T21:54:14.660Z,1763589254.660 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2025-11-19T21:54:14.663Z,1763589254.663 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2025-11-19T21:54:14.840Z,1763589254.840 [Radio_Surface](INFO): Powering up 2025-11-19T21:54:14.965Z,1763589254.965 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into: 0 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2025-11-19T21:54:14.987Z,1763589254.987 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2025-11-19T21:54:14.989Z,1763589254.989 [Default:A.Wait](DEBUG): Construct Wait. 2025-11-19T21:54:14.991Z,1763589254.991 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2025-11-19T21:54:15.041Z,1763589255.041 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2025-11-19T21:54:15.043Z,1763589255.043 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2025-11-19T21:54:15.066Z,1763589255.066 [Default:E.Execute](DEBUG): Construct Execute. 2025-11-19T21:54:15.085Z,1763589255.085 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Default { arguments { ElapsedSinceDefaultStarted = 0 minute } behavior Guidance:Wait { """ Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. """ run in sequence set duration = 13 second } behavior Guidance:GoToSurface { run in progression } aggregate CheckIn { run in sequence repeat=288 readDatum id="Read_GPS" { timeout duration=P5M Universal:time_fix } readDatum id="Read_Iridium" { timeout duration=P4H { behavior Guidance:Execute { run in sequence set command = "Burn on" } syslog critical "Dropped weight due to communications timeout." } Universal:platform_communications } behavior Guidance:Wait { run in sequence set duration = 5 minute } assign in sequence ElapsedSinceDefaultStarted = elapsed ( Universal:mission_started ) syslog important "Default mission has been running for " + ElapsedSinceDefaultStarted~minute } syslog important "Restarting logs and Default mission." behavior Guidance:Execute { run in sequence set command = "restart logs" } } 2025-11-19T21:54:15.089Z,1763589255.089 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmPublisher,Reporter,LogSplitter, 2025-11-19T21:54:15.113Z,1763589255.113 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-11-19T21:54:15.260Z,1763589255.260 [Depth_Keller](INFO): Initializing. 2025-11-19T21:54:15.262Z,1763589255.262 [Power24vConverter](INFO): Powering up. 2025-11-19T21:54:15.262Z,1763589255.262 [Sonardyne_Nano](INFO): Initializing. 2025-11-19T21:54:15.301Z,1763589255.301 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-11-19T21:54:15.352Z,1763589255.352 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2025-11-19T21:54:15.360Z,1763589255.360 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2025-11-19T21:54:15.361Z,1763589255.361 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-11-19T21:54:15.368Z,1763589255.368 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-11-19T21:54:15.369Z,1763589255.369 [MassServo](DEBUG): Initializing EZServoServo. 2025-11-19T21:54:15.376Z,1763589255.376 [MassServo](DEBUG): Initializing MassServo. 2025-11-19T21:54:15.377Z,1763589255.377 [RudderServo](DEBUG): Initializing EZServoServo. 2025-11-19T21:54:15.384Z,1763589255.384 [RudderServo](DEBUG): Initializing RudderServo. 2025-11-19T21:54:15.385Z,1763589255.385 [ThrusterHE](DEBUG): Initializing EZServoServo. 2025-11-19T21:54:15.392Z,1763589255.392 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2025-11-19T21:54:15.554Z,1763589255.554 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2025-11-19T21:54:15.554Z,1763589255.554 [DropWeight] Hardware Fault, FailCount= 1 2025-11-19T21:54:15.554Z,1763589255.554 [DropWeight](ERROR): Hardware Fault 2025-11-19T21:54:15.599Z,1763589255.599 [CommandExec](FAULT): Scheduling is paused 2025-11-19T21:54:15.608Z,1763589255.608 [CBIT](INFO): Critical error at 20251119T215415 2025-11-19T21:54:15.608Z,1763589255.608 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2025-11-19T21:54:15.611Z,1763589255.611 [CBIT](ERROR): Hardware Fault in component: DropWeight 2025-11-19T21:54:15.620Z,1763589255.620 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2025-11-19T21:54:15.931Z,1763589255.931 [CBIT](INFO): Critical error at 20251119T215415 2025-11-19T21:54:16.568Z,1763589256.568 [WetLabsBB2FL](INFO): Powering down 2025-11-19T21:54:17.527Z,1763589257.527 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2025-11-19T21:54:18.764Z,1763589258.764 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2311 2025-11-19T21:54:19.175Z,1763589259.175 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2025-11-19T21:54:21.004Z,1763589261.004 [RudderServo](FAULT): Overload Error 2025-11-19T21:54:21.004Z,1763589261.004 [RudderServo] Hardware Fault, FailCount= 1 2025-11-19T21:54:21.004Z,1763589261.004 [RudderServo](ERROR): Hardware Fault 2025-11-19T21:54:21.113Z,1763589261.113 [ThrusterHE](ERROR): Zero Speed Commanded. 2025-11-19T21:54:21.176Z,1763589261.176 [CBIT](ERROR): Hardware Fault in component: RudderServo 2025-11-19T21:54:21.288Z,1763589261.288 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-11-19T21:54:21.288Z,1763589261.288 [RudderServo](INFO): Powering down 2025-11-19T21:54:21.484Z,1763589261.484 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit. 2025-11-19T21:54:22.140Z,1763589262.140 [RudderServo](DEBUG): Initializing EZServoServo. 2025-11-19T21:54:22.261Z,1763589262.261 [RudderServo](DEBUG): Initializing RudderServo. 2025-11-19T21:54:22.265Z,1763589262.265 [CBIT](INFO): Clearing failed state for component RudderServo 2025-11-19T21:54:22.265Z,1763589262.265 [RudderServo] No Fault, FailCount= 1 2025-11-19T21:54:26.989Z,1763589266.989 [DAT](INFO): DAT read: 2025-11-19T21:54:26.990Z,1763589266.990 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2025-11-19T21:54:27.352Z,1763589267.352 [RudderServo](FAULT): Overload Error 2025-11-19T21:54:27.352Z,1763589267.352 [RudderServo] Hardware Fault, FailCount= 2 2025-11-19T21:54:27.352Z,1763589267.352 [RudderServo](ERROR): Hardware Fault 2025-11-19T21:54:27.464Z,1763589267.464 [CBIT](ERROR): Hardware Fault in component: RudderServo 2025-11-19T21:54:27.721Z,1763589267.721 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-11-19T21:54:27.721Z,1763589267.721 [RudderServo](INFO): Powering down 2025-11-19T21:54:28.517Z,1763589268.517 [RudderServo](DEBUG): Initializing EZServoServo. 2025-11-19T21:54:28.614Z,1763589268.614 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004844 2025-11-19T21:54:28.637Z,1763589268.637 [RudderServo](DEBUG): Initializing RudderServo. 2025-11-19T21:54:28.642Z,1763589268.642 [CBIT](INFO): Clearing failed state for component RudderServo 2025-11-19T21:54:28.642Z,1763589268.642 [RudderServo] No Fault, FailCount= 2 2025-11-19T21:54:28.753Z,1763589268.753 [DAT](INFO): DAT read: MF Frequency Band 2025-11-19T21:54:28.754Z,1763589268.754 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2025-11-19T21:54:28.755Z,1763589268.755 [DAT](INFO): DAT read: Nov 11 2025 02:05:13 2025-11-19T21:54:29.765Z,1763589269.765 [DAT](INFO): DAT read: Features enabled [Bearing] 2025-11-19T21:54:29.771Z,1763589269.771 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2025-11-19T21:54:29.773Z,1763589269.773 [DAT](INFO): commRate: 800 2025-11-19T21:54:31.828Z,1763589271.828 [DAT](INFO): entering command mode 2025-11-19T21:54:32.028Z,1763589272.028 [DAT](INFO): DAT read: 2025-11-19T21:54:32.029Z,1763589272.029 [DAT](INFO): DAT read: user:1> 2025-11-19T21:54:32.029Z,1763589272.029 [DAT](INFO): setting verbose to 3 2025-11-19T21:54:32.281Z,1763589272.281 [DAT](INFO): DAT read: user:1> 2025-11-19T21:54:32.282Z,1763589272.282 [DAT](INFO): DAT read: Verbose | 3 2025-11-19T21:54:32.282Z,1763589272.282 [DAT](INFO): set verbose to 3 2025-11-19T21:54:32.282Z,1763589272.282 [DAT](INFO): setting DatVerbose to 27440 2025-11-19T21:54:32.533Z,1763589272.533 [DAT](INFO): DAT read: user:2> 2025-11-19T21:54:32.534Z,1763589272.534 [DAT](INFO): DAT read: DatVerbose | 27440 2025-11-19T21:54:32.534Z,1763589272.534 [DAT](INFO): set DatVerbose to 27440 2025-11-19T21:54:32.534Z,1763589272.534 [DAT](INFO): setting transmit power to 8 2025-11-19T21:54:32.785Z,1763589272.785 [DAT](INFO): DAT read: user:3> 2025-11-19T21:54:32.786Z,1763589272.786 [DAT](INFO): DAT read: TxPower | 8 (Max) 2025-11-19T21:54:32.786Z,1763589272.786 [DAT](INFO): set transmit power to 8 2025-11-19T21:54:32.786Z,1763589272.786 [DAT](INFO): setting local address to 1 2025-11-19T21:54:33.037Z,1763589273.037 [DAT](INFO): DAT read: user:4> 2025-11-19T21:54:33.038Z,1763589273.038 [DAT](INFO): DAT read: LocalAddr | 1 2025-11-19T21:54:33.038Z,1763589273.038 [DAT](INFO): set local address to 1 2025-11-19T21:54:33.039Z,1763589273.039 [DAT](INFO): Setting time to: 21:54:33 And date to:11/19/2025 2025-11-19T21:54:33.288Z,1763589273.288 [DAT](INFO): DAT read: user:5> 2025-11-19T21:54:33.289Z,1763589273.289 [DAT](INFO): DAT read: Wed Nov 19, 2025 21:54:33 2025-11-19T21:54:33.290Z,1763589273.290 [DAT](INFO): Local DAT time set to Wed Nov 19, 2025 21:54:33 2025-11-19T21:54:33.796Z,1763589273.796 [RudderServo](FAULT): Overload Error 2025-11-19T21:54:33.797Z,1763589273.797 [RudderServo] Hardware Fault, FailCount= 3 2025-11-19T21:54:33.797Z,1763589273.797 [RudderServo](ERROR): Hardware Fault 2025-11-19T21:54:33.908Z,1763589273.908 [CBIT](ERROR): Hardware Fault in component: RudderServo 2025-11-19T21:54:33.909Z,1763589273.909 [CBIT](CRITICAL): Hardware Fault in component: RudderServo 2025-11-19T21:54:34.200Z,1763589274.200 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-11-19T21:54:34.200Z,1763589274.200 [RudderServo](INFO): Powering down 2025-11-19T21:54:34.203Z,1763589274.203 [CBIT](INFO): Critical error at 20251119T215433 2025-11-19T21:54:35.000Z,1763589275.000 [RudderServo](DEBUG): Initializing EZServoServo. 2025-11-19T21:54:35.121Z,1763589275.121 [RudderServo](DEBUG): Initializing RudderServo. 2025-11-19T21:54:42.601Z,1763589282.601 [NAL9602](INFO): Powering up NAL9602 2025-11-19T21:54:53.513Z,1763589293.513 [NAL9602](INFO): NAL9602 initialized 2025-11-19T21:55:24.550Z,1763589324.550 [CommandExec](IMPORTANT): got command failComponent none RudderServo 2025-11-19T21:55:24.550Z,1763589324.550 [RudderServo] No Fault, FailCount= 3 2025-11-19T21:55:24.550Z,1763589324.550 [CommandExec](IMPORTANT): RudderServo failureMode is No Fault 2025-11-19T21:55:29.869Z,1763589329.869 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-11-19T21:55:44.610Z,1763589344.610 [CommandExec](IMPORTANT): got command maintain control HorizontalControl.rudderAngleAction 15 degree 2025-11-19T21:55:44.627Z,1763589344.627 [ComponentRegistry](DEBUG): SyncComponent "Maintain_HorizontalControl.rudderAngleAction" handled in the control thread. 2025-11-19T21:55:44.894Z,1763589344.894 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_HorizontalControl.rudderAngleAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmPublisher,Reporter,LogSplitter, 2025-11-19T21:55:45.218Z,1763589345.218 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-11-19T21:55:48.114Z,1763589348.114 [RudderServo](FAULT): Overload Error 2025-11-19T21:55:48.114Z,1763589348.114 [RudderServo] Hardware Fault, FailCount= 1 2025-11-19T21:55:48.114Z,1763589348.114 [RudderServo](ERROR): Hardware Fault 2025-11-19T21:55:48.224Z,1763589348.224 [CBIT](ERROR): Hardware Fault in component: RudderServo 2025-11-19T21:55:48.491Z,1763589348.491 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-11-19T21:55:48.491Z,1763589348.491 [RudderServo](INFO): Powering down 2025-11-19T21:55:49.302Z,1763589349.302 [RudderServo](DEBUG): Initializing EZServoServo. 2025-11-19T21:55:49.422Z,1763589349.422 [RudderServo](DEBUG): Initializing RudderServo. 2025-11-19T21:55:49.426Z,1763589349.426 [CBIT](INFO): Clearing failed state for component RudderServo 2025-11-19T21:55:49.426Z,1763589349.426 [RudderServo] No Fault, FailCount= 1 2025-11-19T21:55:54.592Z,1763589354.592 [RudderServo](FAULT): Overload Error 2025-11-19T21:55:54.592Z,1763589354.592 [RudderServo] Hardware Fault, FailCount= 2 2025-11-19T21:55:54.592Z,1763589354.592 [RudderServo](ERROR): Hardware Fault 2025-11-19T21:55:54.704Z,1763589354.704 [CBIT](ERROR): Hardware Fault in component: RudderServo 2025-11-19T21:55:54.954Z,1763589354.954 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-11-19T21:55:54.955Z,1763589354.955 [RudderServo](INFO): Powering down 2025-11-19T21:55:55.745Z,1763589355.745 [RudderServo](DEBUG): Initializing EZServoServo. 2025-11-19T21:55:55.865Z,1763589355.865 [RudderServo](DEBUG): Initializing RudderServo. 2025-11-19T21:55:55.869Z,1763589355.869 [CBIT](INFO): Clearing failed state for component RudderServo 2025-11-19T21:55:55.869Z,1763589355.869 [RudderServo] No Fault, FailCount= 2 2025-11-19T21:55:57.974Z,1763589357.974 [CommandExec](IMPORTANT): got command failComponent none RudderServo 2025-11-19T21:55:57.975Z,1763589357.975 [CommandExec](IMPORTANT): RudderServo failureMode is No Fault 2025-11-19T21:56:00.165Z,1763589360.165 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-11-19T21:56:01.048Z,1763589361.048 [RudderServo](FAULT): Overload Error 2025-11-19T21:56:01.048Z,1763589361.048 [RudderServo] Hardware Fault, FailCount= 3 2025-11-19T21:56:01.048Z,1763589361.048 [RudderServo](ERROR): Hardware Fault 2025-11-19T21:56:01.160Z,1763589361.160 [CBIT](ERROR): Hardware Fault in component: RudderServo 2025-11-19T21:56:01.160Z,1763589361.160 [CBIT](CRITICAL): Hardware Fault in component: RudderServo 2025-11-19T21:56:01.407Z,1763589361.407 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-11-19T21:56:01.407Z,1763589361.407 [RudderServo](INFO): Powering down 2025-11-19T21:56:01.409Z,1763589361.409 [CBIT](INFO): Critical error at 20251119T215601 2025-11-19T21:56:02.206Z,1763589362.206 [RudderServo](DEBUG): Initializing EZServoServo. 2025-11-19T21:56:02.321Z,1763589362.321 [RudderServo](DEBUG): Initializing RudderServo. 2025-11-19T21:56:03.865Z,1763589363.865 [CommandExec](IMPORTANT): got command maintain control HorizontalControl.rudderAngleAction 15 degree 2025-11-19T21:56:11.897Z,1763589371.897 [SBIT](IMPORTANT): Beginning Startup BIT 2025-11-19T21:56:11.901Z,1763589371.901 [GFScanner](IMPORTANT): Beginning ground fault scan 2025-11-19T21:56:13.952Z,1763589373.952 [ElevatorServo](FAULT): Overload Error 2025-11-19T21:56:13.952Z,1763589373.952 [ElevatorServo] Hardware Fault, FailCount= 1 2025-11-19T21:56:13.952Z,1763589373.952 [ElevatorServo](ERROR): Hardware Fault 2025-11-19T21:56:14.201Z,1763589374.201 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2025-11-19T21:56:14.327Z,1763589374.327 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-11-19T21:56:14.327Z,1763589374.327 [ElevatorServo](INFO): Powering down 2025-11-19T21:56:15.114Z,1763589375.114 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-11-19T21:56:15.174Z,1763589375.174 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-11-19T21:56:15.289Z,1763589375.289 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-11-19T21:56:15.321Z,1763589375.321 [CBIT](INFO): Clearing failed state for component ElevatorServo 2025-11-19T21:56:15.321Z,1763589375.321 [ElevatorServo] No Fault, FailCount= 1 2025-11-19T21:56:16.443Z,1763589376.443 [GFScanner](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.013101 CHAN A1 (24V): 0.000591 CHAN A2 (12V): 0.000251 CHAN A3 (5V): -0.001747 CHAN B0 (3.3V): 0.000349 CHAN B1 (3.15aV): 0.000058 CHAN B2 (3.15bV): -0.000128 CHAN B3 (GND): -0.000088 OPEN: 0.007022 Full Scale: +/- 1 mA 2025-11-19T21:56:20.152Z,1763589380.152 [ElevatorServo](FAULT): Overload Error 2025-11-19T21:56:20.152Z,1763589380.152 [ElevatorServo] Hardware Fault, FailCount= 2 2025-11-19T21:56:20.152Z,1763589380.152 [ElevatorServo](ERROR): Hardware Fault 2025-11-19T21:56:20.185Z,1763589380.185 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2025-11-19T21:56:20.415Z,1763589380.415 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-11-19T21:56:20.415Z,1763589380.415 [ElevatorServo](INFO): Powering down 2025-11-19T21:56:21.214Z,1763589381.214 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-11-19T21:56:21.329Z,1763589381.329 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-11-19T21:56:21.361Z,1763589381.361 [CBIT](INFO): Clearing failed state for component ElevatorServo 2025-11-19T21:56:21.361Z,1763589381.361 [ElevatorServo] No Fault, FailCount= 2 2025-11-19T21:56:24.966Z,1763589384.966 [SBIT](ERROR): Could not read rudderAngleReader_. 2025-11-19T21:56:26.192Z,1763589386.192 [ElevatorServo](FAULT): Overload Error 2025-11-19T21:56:26.192Z,1763589386.192 [ElevatorServo] Hardware Fault, FailCount= 3 2025-11-19T21:56:26.192Z,1763589386.192 [ElevatorServo](ERROR): Hardware Fault 2025-11-19T21:56:26.199Z,1763589386.199 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2025-11-19T21:56:26.199Z,1763589386.199 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo 2025-11-19T21:56:26.466Z,1763589386.466 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-11-19T21:56:26.466Z,1763589386.466 [ElevatorServo](INFO): Powering down 2025-11-19T21:56:26.470Z,1763589386.470 [CBIT](INFO): Critical error at 20251119T215626 2025-11-19T21:56:27.254Z,1763589387.254 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-11-19T21:56:27.373Z,1763589387.373 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-11-19T21:56:29.703Z,1763589389.703 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-11-19T21:56:45.286Z,1763589405.286 [CommandExec](IMPORTANT): got command maintain control HorizontalControl.rudderAngleAction -15 degree 2025-11-19T21:56:47.472Z,1763589407.472 [CommandExec](IMPORTANT): got command failComponent 2025-11-19T21:56:47.473Z,1763589407.473 [CommandExec](IMPORTANT): Failed components: 2025-11-19T21:56:47.473Z,1763589407.473 [CommandExec](IMPORTANT): DropWeight: Hardware Fault 2025-11-19T21:56:47.473Z,1763589407.473 [CommandExec](IMPORTANT): ElevatorServo: Hardware Fault 2025-11-19T21:56:47.473Z,1763589407.473 [CommandExec](IMPORTANT): RudderServo: Hardware Fault 2025-11-19T21:56:51.523Z,1763589411.523 [SBIT](ERROR): Could not read elevatorAngleReader_. 2025-11-19T21:56:51.541Z,1763589411.541 [SBIT](ERROR): Could not read rudderAngleReader_. 2025-11-19T21:56:51.541Z,1763589411.541 [SBIT](FAULT): Control surface position failure. 2025-11-19T21:56:58.229Z,1763589418.229 [CommandExec](IMPORTANT): got command failComponent none RudderServo 2025-11-19T21:56:58.229Z,1763589418.229 [RudderServo] No Fault, FailCount= 3 2025-11-19T21:56:58.230Z,1763589418.230 [CommandExec](IMPORTANT): RudderServo failureMode is No Fault 2025-11-19T21:57:02.456Z,1763589422.456 [RudderServo](FAULT): Overload Error 2025-11-19T21:57:02.456Z,1763589422.456 [RudderServo] Hardware Fault, FailCount= 4 2025-11-19T21:57:02.456Z,1763589422.456 [RudderServo](ERROR): Hardware Fault 2025-11-19T21:57:02.565Z,1763589422.565 [CBIT](ERROR): Hardware Fault in component: RudderServo 2025-11-19T21:57:02.565Z,1763589422.565 [CBIT](CRITICAL): Hardware Fault in component: RudderServo 2025-11-19T21:57:02.823Z,1763589422.823 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-11-19T21:57:02.823Z,1763589422.823 [RudderServo](INFO): Powering down 2025-11-19T21:57:02.826Z,1763589422.826 [CBIT](INFO): Critical error at 20251119T215702 2025-11-19T21:57:03.614Z,1763589423.614 [RudderServo](DEBUG): Initializing EZServoServo. 2025-11-19T21:57:03.733Z,1763589423.733 [RudderServo](DEBUG): Initializing RudderServo. 2025-11-19T21:57:05.230Z,1763589425.230 [SBIT](ERROR): Could not read elevatorAngleReader_. 2025-11-19T21:57:05.230Z,1763589425.230 [SBIT](ERROR): Could not read rudderAngleReader_. 2025-11-19T21:57:05.230Z,1763589425.230 [SBIT](FAULT): Control surface position failure. 2025-11-19T21:57:05.634Z,1763589425.634 [SBIT](CRITICAL): SBIT FAILED 2025-11-19T21:57:05.634Z,1763589425.634 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2025-11-19T21:57:05.635Z,1763589425.635 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=19 count; 2025-11-19T21:57:05.635Z,1763589425.635 [SBIT](IMPORTANT): BackseatComponent.fullSlateAccess=1 bool; 2025-11-19T21:57:05.635Z,1763589425.635 [SBIT](IMPORTANT): DAT.surfaceThreshold=-0.5 meter; 2025-11-19T21:57:05.635Z,1763589425.635 [SBIT](IMPORTANT): Express linearApproximation TrackAcousticContact.range_to_contact 15.000000 meter; 2025-11-19T21:57:05.635Z,1763589425.635 [SBIT](IMPORTANT): Express linearApproximation _.planktivore_HM_AvgRois 2.000000 count_per_second; 2025-11-19T21:57:05.635Z,1763589425.635 [SBIT](IMPORTANT): Express linearApproximation _.planktivore_LM_AvgRois 100.000000 count_per_second; 2025-11-19T21:57:05.635Z,1763589425.635 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=162.414241 cubic_centimeter; 2025-11-19T21:57:05.636Z,1763589425.636 [SBIT](IMPORTANT): VerticalControl.massDefault=24.263883 millimeter; 2025-11-19T21:57:05.636Z,1763589425.636 [SBIT](IMPORTANT): Waterlinked.loadAtStartup=0 bool; 2025-11-19T21:57:05.637Z,1763589425.637 [CBIT](INFO): Critical error at 20251119T215705 2025-11-19T21:57:06.050Z,1763589426.050 [MissionManager](IMPORTANT): Started mission Startup 2025-11-19T21:57:06.050Z,1763589426.050 [Startup] Running Loop=1 2025-11-19T21:57:06.050Z,1763589426.050 [Startup](DEBUG): Aggregate::initialize Startup 2025-11-19T21:57:06.050Z,1763589426.050 [Startup:A.GoToSurface] Running Loop=1 2025-11-19T21:57:06.050Z,1763589426.050 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-11-19T21:57:06.051Z,1763589426.051 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-11-19T21:57:06.051Z,1763589426.051 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-11-19T21:57:06.051Z,1763589426.051 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-11-19T21:57:06.052Z,1763589426.052 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-11-19T21:57:06.053Z,1763589426.053 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-11-19T21:57:06.053Z,1763589426.053 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-11-19T21:57:06.055Z,1763589426.055 [Startup:StartupSatComms] Running Loop=1 2025-11-19T21:57:06.055Z,1763589426.055 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2025-11-19T21:57:06.055Z,1763589426.055 [Startup:StartupSatComms:A] Running Loop=1 2025-11-19T21:57:06.449Z,1763589426.449 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2025-11-19T21:57:14.521Z,1763589434.521 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2025-11-19T21:57:14.521Z,1763589434.521 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-11-19T21:57:14.531Z,1763589434.531 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-11-19T21:57:14.944Z,1763589434.944 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-11-19T21:57:14.944Z,1763589434.944 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2025-11-19T21:57:18.108Z,1763589438.108 [CommandExec](IMPORTANT): got command quit 2025-11-19T21:57:19.112Z,1763589439.112 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2025-11-19T21:57:19.112Z,1763589439.112 [CommandExec](INFO): Uninitializing the command executive. 2025-11-19T21:57:19.112Z,1763589439.112 [CommandExec](INFO): Uninitializing the command scheduler. 2025-11-19T21:57:19.113Z,1763589439.113 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-11-19T21:57:19.308Z,1763589439.308 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2025-11-19T21:57:19.308Z,1763589439.308 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2025-11-19T21:57:19.308Z,1763589439.308 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-11-19T21:57:19.309Z,1763589439.309 [NavChartDb](INFO): Join timeout helper Thread ID is 6900 2025-11-19T21:57:19.544Z,1763589439.544 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2025-11-19T21:57:19.544Z,1763589439.544 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-11-19T21:57:19.560Z,1763589439.560 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2025-11-19T21:57:19.560Z,1763589439.560 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-11-19T21:57:19.560Z,1763589439.560 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 6901 2025-11-19T21:57:20.028Z,1763589440.028 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2025-11-19T21:57:20.028Z,1763589440.028 [WetLabsBB2FL](INFO): Powering down 2025-11-19T21:57:20.029Z,1763589440.029 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-11-19T21:57:20.032Z,1763589440.032 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2025-11-19T21:57:20.032Z,1763589440.032 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-11-19T21:57:20.032Z,1763589440.032 [CTD_Seabird](INFO): Join timeout helper Thread ID is 6902 2025-11-19T21:57:20.232Z,1763589440.232 [CTD_Seabird](INFO): Powering down 2025-11-19T21:57:20.244Z,1763589440.244 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2025-11-19T21:57:20.244Z,1763589440.244 [CTD_Seabird](INFO): Powering down 2025-11-19T21:57:20.256Z,1763589440.256 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-11-19T21:57:20.268Z,1763589440.268 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2025-11-19T21:57:20.268Z,1763589440.268 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-11-19T21:57:20.269Z,1763589440.269 [Radio_Surface](INFO): Join timeout helper Thread ID is 6903 2025-11-19T21:57:20.292Z,1763589440.292 [Radio_Surface](INFO): Powering down 2025-11-19T21:57:20.293Z,1763589440.293 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2025-11-19T21:57:20.293Z,1763589440.293 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-11-19T21:57:20.294Z,1763589440.294 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2025-11-19T21:57:20.294Z,1763589440.294 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-11-19T21:57:20.294Z,1763589440.294 [Onboard](INFO): Join timeout helper Thread ID is 6904 2025-11-19T21:57:24.588Z,1763589444.588 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2025-11-19T21:57:24.588Z,1763589444.588 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-11-19T21:57:24.593Z,1763589444.593 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2025-11-19T21:57:24.593Z,1763589444.593 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-11-19T21:57:24.593Z,1763589444.593 [DataOverHttps](INFO): Join timeout helper Thread ID is 6905 2025-11-19T21:57:24.695Z,1763589444.695 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2025-11-19T21:57:24.698Z,1763589444.698 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-11-19T21:57:24.709Z,1763589444.709 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2025-11-19T21:57:24.709Z,1763589444.709 [DAT ThreadHandler](INFO): Thread cancelled. 2025-11-19T21:57:24.709Z,1763589444.709 [DAT](INFO): Join timeout helper Thread ID is 6906 2025-11-19T21:57:24.936Z,1763589444.936 [DAT](INFO): Powering down 2025-11-19T21:57:25.016Z,1763589445.016 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2025-11-19T21:57:25.017Z,1763589445.017 [DAT](INFO): Powering down 2025-11-19T21:57:25.018Z,1763589445.018 [DAT ThreadHandler](INFO): Thread cancelled. 2025-11-19T21:57:25.029Z,1763589445.029 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2025-11-19T21:57:25.029Z,1763589445.029 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-11-19T21:57:25.029Z,1763589445.029 [BackseatComponent](INFO): Join timeout helper Thread ID is 6907 2025-11-19T21:57:25.092Z,1763589445.092 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2025-11-19T21:57:25.092Z,1763589445.092 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-11-19T21:57:25.094Z,1763589445.094 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2025-11-19T21:57:25.094Z,1763589445.094 [logger ThreadHandler](INFO): Thread cancelled. 2025-11-19T21:57:25.094Z,1763589445.094 [logger](INFO): Join timeout helper Thread ID is 6908 2025-11-19T21:57:25.136Z,1763589445.136 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2025-11-19T21:57:25.136Z,1763589445.136 [logger ThreadHandler](INFO): Thread cancelled. 2025-11-19T21:57:25.145Z,1763589445.145 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2025-11-19T21:57:25.145Z,1763589445.145 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-11-19T21:57:25.145Z,1763589445.145 [CommandLine](INFO): Join timeout helper Thread ID is 6909 2025-11-19T21:57:25.172Z,1763589445.172 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2025-11-19T21:57:25.172Z,1763589445.172 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-11-19T21:57:25.185Z,1763589445.185 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2025-11-19T21:57:25.185Z,1763589445.185 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-11-19T21:57:25.185Z,1763589445.185 [CommandExec](INFO): Join timeout helper Thread ID is 6910 2025-11-19T21:57:25.186Z,1763589445.186 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2025-11-19T21:57:25.186Z,1763589445.186 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-11-19T21:57:25.187Z,1763589445.187 [controlThread](INFO): Join timeout helper Thread ID is 6911 2025-11-19T21:57:25.400Z,1763589445.400 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2025-11-19T21:57:25.400Z,1763589445.400 [controlThread](DEBUG): Uninitializing ControlThread 2025-11-19T21:57:25.401Z,1763589445.401 [AHRS_M2](INFO): Powering down 2025-11-19T21:57:25.480Z,1763589445.480 [NAL9602](INFO): Powering down 2025-11-19T21:57:25.481Z,1763589445.481 [Sonardyne_Nano](INFO): Powering down 2025-11-19T21:57:25.688Z,1763589445.688 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2025-11-19T21:57:25.689Z,1763589445.689 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2025-11-19T21:57:25.689Z,1763589445.689 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2025-11-19T21:57:25.690Z,1763589445.690 [MissionManager](INFO): Uninitializing Mission Default 2025-11-19T21:57:25.693Z,1763589445.693 [MissionManager](INFO): Uninitializing Mission Startup 2025-11-19T21:57:25.693Z,1763589445.693 [Startup] Stopped 2025-11-19T21:57:25.693Z,1763589445.693 [Startup](DEBUG): Aggregate::uninitialize Startup 2025-11-19T21:57:25.693Z,1763589445.693 [Startup:A.GoToSurface] Stopped 2025-11-19T21:57:25.693Z,1763589445.693 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-11-19T21:57:25.693Z,1763589445.693 [Startup:StartupSatComms] Stopped 2025-11-19T21:57:25.693Z,1763589445.693 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2025-11-19T21:57:25.693Z,1763589445.693 [Startup:StartupSatComms:A] Stopped 2025-11-19T21:57:25.695Z,1763589445.695 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2025-11-19T21:57:25.695Z,1763589445.695 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2025-11-19T21:57:25.695Z,1763589445.695 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2025-11-19T21:57:25.696Z,1763589445.696 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2025-11-19T21:57:25.696Z,1763589445.696 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2025-11-19T21:57:25.696Z,1763589445.696 [BuoyancyServo](INFO): Powering down 2025-11-19T21:57:25.708Z,1763589445.708 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-11-19T21:57:25.708Z,1763589445.708 [ElevatorServo](INFO): Powering down 2025-11-19T21:57:25.709Z,1763589445.709 [MassServo](DEBUG): Uninitialize Mass Servo. 2025-11-19T21:57:25.709Z,1763589445.709 [MassServo](INFO): Powering down 2025-11-19T21:57:25.710Z,1763589445.710 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-11-19T21:57:25.710Z,1763589445.710 [RudderServo](INFO): Powering down 2025-11-19T21:57:25.711Z,1763589445.711 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2025-11-19T21:57:25.711Z,1763589445.711 [ThrusterHE](INFO): Powering down 2025-11-19T21:57:25.712Z,1763589445.712 [SBIT](DEBUG): Uninitialize SBIT Component. 2025-11-19T21:57:25.712Z,1763589445.712 [IBIT](DEBUG): Uninitialize IBIT Component. 2025-11-19T21:57:25.712Z,1763589445.712 [CBIT](DEBUG): Uninitialize CBIT Component. 2025-11-19T21:57:25.713Z,1763589445.713 [CBIT](DEBUG): Powering off loads. 2025-11-19T21:57:25.724Z,1763589445.724 [CBIT](DEBUG): Disabling WDT. 2025-11-19T21:57:25.736Z,1763589445.736 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-11-19T21:57:25.736Z,1763589445.736 [GFScanner](DEBUG): Opening all GF detection circuits. 2025-11-19T21:57:25.737Z,1763589445.737 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-11-19T21:57:25.769Z,1763589445.769 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-11-19T21:57:25.772Z,1763589445.772 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-11-19T21:57:25.778Z,1763589445.778 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-11-19T21:57:25.784Z,1763589445.784 [DAT ThreadHandler](INFO): Thread cancelled. 2025-11-19T21:57:25.827Z,1763589445.827 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-11-19T21:57:25.860Z,1763589445.860 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-11-19T21:57:25.860Z,1763589445.860 [GFScanner](DEBUG): Opening all GF detection circuits. 2025-11-19T21:57:26.151Z,1763589446.151 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-11-19T21:57:26.157Z,1763589446.157 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-11-19T21:57:26.165Z,1763589446.165 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-11-19T21:57:26.231Z,1763589446.231 [logger ThreadHandler](INFO): Thread cancelled.