2025-09-15T01:45:11.071Z,1757900711.071 [Supervisor](DEBUG): Initializing supervisor.
2025-09-15T01:45:11.075Z,1757900711.075 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2025-09-15T01:45:11.076Z,1757900711.076 [SyncHandler](INFO): Protected caller Thread ID is 1025
2025-09-15T01:45:11.076Z,1757900711.076 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2025-09-15T01:45:11.077Z,1757900711.077 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2025-09-15T01:45:11.078Z,1757900711.078 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1026
2025-09-15T01:45:11.082Z,1757900711.082 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2025-09-15T01:45:11.102Z,1757900711.102 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2025-09-15T01:45:11.103Z,1757900711.103 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2025-09-15T01:45:11.103Z,1757900711.103 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 1027
2025-09-15T01:45:11.108Z,1757900711.108 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2025-09-15T01:45:11.109Z,1757900711.109 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2025-09-15T01:45:11.109Z,1757900711.109 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1028
2025-09-15T01:45:11.111Z,1757900711.111 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2025-09-15T01:45:11.112Z,1757900711.112 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2025-09-15T01:45:11.113Z,1757900711.113 [logger ThreadHandler](INFO): Protected caller Thread ID is 1029
2025-09-15T01:45:11.117Z,1757900711.117 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2025-09-15T01:45:11.117Z,1757900711.117 [Supervisor](INFO): Looking for Config files in directory: Config/
2025-09-15T01:45:11.119Z,1757900711.119 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2025-09-15T01:45:11.472Z,1757900711.472 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2025-09-15T01:45:11.473Z,1757900711.473 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2025-09-15T01:45:12.268Z,1757900712.268 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2025-09-15T01:45:12.268Z,1757900712.268 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2025-09-15T01:45:12.387Z,1757900712.387 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2025-09-15T01:45:12.387Z,1757900712.387 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2025-09-15T01:45:12.966Z,1757900712.966 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2025-09-15T01:45:12.966Z,1757900712.966 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2025-09-15T01:45:13.074Z,1757900713.074 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2025-09-15T01:45:13.074Z,1757900713.074 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2025-09-15T01:45:13.175Z,1757900713.175 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Guidance
2025-09-15T01:45:13.175Z,1757900713.175 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2025-09-15T01:45:13.613Z,1757900713.613 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2025-09-15T01:45:13.613Z,1757900713.613 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2025-09-15T01:45:13.850Z,1757900713.850 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2025-09-15T01:45:13.851Z,1757900713.851 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2025-09-15T01:45:14.001Z,1757900714.001 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2025-09-15T01:45:14.002Z,1757900714.002 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2025-09-15T01:45:14.267Z,1757900714.267 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2025-09-15T01:45:14.267Z,1757900714.267 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2025-09-15T01:45:14.857Z,1757900714.857 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2025-09-15T01:45:14.857Z,1757900714.857 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2025-09-15T01:45:15.726Z,1757900715.726 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2025-09-15T01:45:15.726Z,1757900715.726 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2025-09-15T01:45:15.816Z,1757900715.816 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2025-09-15T01:45:16.013Z,1757900716.013 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2025-09-15T01:45:16.014Z,1757900716.014 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2025-09-15T01:45:16.280Z,1757900716.280 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2025-09-15T01:45:16.280Z,1757900716.280 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2025-09-15T01:45:16.603Z,1757900716.603 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2025-09-15T01:45:16.605Z,1757900716.605 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-brizo/
2025-09-15T01:45:16.606Z,1757900716.606 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Control.cfg
2025-09-15T01:45:16.716Z,1757900716.716 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Sensor.cfg
2025-09-15T01:45:16.882Z,1757900716.882 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Simulator.cfg
2025-09-15T01:45:16.979Z,1757900716.979 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/secure.cfg
2025-09-15T01:45:17.073Z,1757900717.073 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Servo.cfg
2025-09-15T01:45:17.197Z,1757900717.197 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/workSite.cfg
2025-09-15T01:45:17.301Z,1757900717.301 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Dock.cfg
2025-09-15T01:45:17.425Z,1757900717.425 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/vehicle.cfg
2025-09-15T01:45:17.540Z,1757900717.540 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Battery.cfg
2025-09-15T01:45:17.829Z,1757900717.829 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2025-09-15T01:45:17.830Z,1757900717.830 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Science.cfg
2025-09-15T01:45:17.974Z,1757900717.974 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/logger.cfg
2025-09-15T01:45:18.077Z,1757900718.077 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/BIT.cfg
2025-09-15T01:45:18.181Z,1757900718.181 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Navigation.cfg
2025-09-15T01:45:18.276Z,1757900718.276 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2025-09-15T01:45:18.287Z,1757900718.287 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2025-09-15T01:45:18.440Z,1757900718.440 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2025-09-15T01:45:18.440Z,1757900718.440 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2025-09-15T01:45:18.451Z,1757900718.451 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2025-09-15T01:45:18.452Z,1757900718.452 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2025-09-15T01:45:18.508Z,1757900718.508 [DepthRateCalculator] Loaded
2025-09-15T01:45:18.508Z,1757900718.508 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2025-09-15T01:45:18.514Z,1757900718.514 [PitchRateCalculator] Loaded
2025-09-15T01:45:18.514Z,1757900718.514 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2025-09-15T01:45:18.525Z,1757900718.525 [SpeedCalculator] Loaded
2025-09-15T01:45:18.526Z,1757900718.526 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2025-09-15T01:45:18.531Z,1757900718.531 [YawRateCalculator] Loaded
2025-09-15T01:45:18.531Z,1757900718.531 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2025-09-15T01:45:18.554Z,1757900718.554 [ElevatorOffsetCalculator] Loaded
2025-09-15T01:45:18.554Z,1757900718.554 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2025-09-15T01:45:18.555Z,1757900718.555 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2025-09-15T01:45:18.555Z,1757900718.555 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2025-09-15T01:45:18.615Z,1757900718.615 [VerticalControl](DEBUG): Construct VerticalControl.
2025-09-15T01:45:18.674Z,1757900718.674 [VerticalControl] Loaded
2025-09-15T01:45:18.674Z,1757900718.674 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2025-09-15T01:45:18.677Z,1757900718.677 [HorizontalControl](DEBUG): Construct HorizontalControl.
2025-09-15T01:45:18.727Z,1757900718.727 [HorizontalControl] Loaded
2025-09-15T01:45:18.728Z,1757900718.728 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2025-09-15T01:45:18.730Z,1757900718.730 [SpeedControl](DEBUG): Construct SpeedControl.
2025-09-15T01:45:18.733Z,1757900718.733 [SpeedControl] Loaded
2025-09-15T01:45:18.733Z,1757900718.733 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2025-09-15T01:45:18.736Z,1757900718.736 [LoopControl](DEBUG): Construct LoopControl.
2025-09-15T01:45:18.737Z,1757900718.737 [LoopControl] Loaded
2025-09-15T01:45:18.737Z,1757900718.737 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2025-09-15T01:45:18.737Z,1757900718.737 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2025-09-15T01:45:18.738Z,1757900718.738 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2025-09-15T01:45:18.860Z,1757900718.860 [DeadReckonUsingMultipleVelocitySources] Loaded
2025-09-15T01:45:18.861Z,1757900718.861 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2025-09-15T01:45:18.875Z,1757900718.875 [NavChart] Loaded
2025-09-15T01:45:18.876Z,1757900718.876 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2025-09-15T01:45:18.882Z,1757900718.882 [UniversalFixResidualReporter] Loaded
2025-09-15T01:45:18.882Z,1757900718.882 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2025-09-15T01:45:18.882Z,1757900718.882 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2025-09-15T01:45:18.883Z,1757900718.883 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2025-09-15T01:45:19.082Z,1757900719.082 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2025-09-15T01:45:19.083Z,1757900719.083 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2025-09-15T01:45:19.621Z,1757900719.621 [AHRS_M2] Loaded
2025-09-15T01:45:19.621Z,1757900719.621 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2025-09-15T01:45:19.661Z,1757900719.661 [BackseatComponent] Loaded
2025-09-15T01:45:19.662Z,1757900719.662 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2025-09-15T01:45:19.663Z,1757900719.663 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409404E0
2025-09-15T01:45:19.663Z,1757900719.663 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 1117
2025-09-15T01:45:19.666Z,1757900719.666 [LcmUniversalReporter] Loaded
2025-09-15T01:45:19.666Z,1757900719.666 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2025-09-15T01:45:20.971Z,1757900720.971 [BPC1] Loaded
2025-09-15T01:45:20.972Z,1757900720.972 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2025-09-15T01:45:21.211Z,1757900721.211 [DataOverHttps] Loaded
2025-09-15T01:45:21.211Z,1757900721.211 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2025-09-15T01:45:21.212Z,1757900721.212 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409704E0
2025-09-15T01:45:21.213Z,1757900721.213 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1118
2025-09-15T01:45:21.269Z,1757900721.269 [Depth_Keller] Loaded
2025-09-15T01:45:21.269Z,1757900721.269 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2025-09-15T01:45:21.338Z,1757900721.338 [NAL9602] Loaded
2025-09-15T01:45:21.338Z,1757900721.338 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2025-09-15T01:45:21.375Z,1757900721.375 [Onboard] Loaded
2025-09-15T01:45:21.375Z,1757900721.375 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2025-09-15T01:45:21.376Z,1757900721.376 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409A04E0
2025-09-15T01:45:21.376Z,1757900721.376 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 1119
2025-09-15T01:45:21.391Z,1757900721.391 [Power24vConverter] Loaded
2025-09-15T01:45:21.392Z,1757900721.392 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2025-09-15T01:45:21.409Z,1757900721.409 [Radio_Surface] Loaded
2025-09-15T01:45:21.409Z,1757900721.409 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2025-09-15T01:45:21.411Z,1757900721.411 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409D04E0
2025-09-15T01:45:21.411Z,1757900721.411 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1120
2025-09-15T01:45:21.427Z,1757900721.427 [Sonardyne_Nano] Loaded
2025-09-15T01:45:21.427Z,1757900721.427 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2025-09-15T01:45:21.428Z,1757900721.428 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2025-09-15T01:45:21.429Z,1757900721.429 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2025-09-15T01:45:21.579Z,1757900721.579 [BuoyancyServo] Loaded
2025-09-15T01:45:21.580Z,1757900721.580 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2025-09-15T01:45:21.604Z,1757900721.604 [ElevatorServo] Loaded
2025-09-15T01:45:21.604Z,1757900721.604 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2025-09-15T01:45:21.634Z,1757900721.634 [DockingStepper] Loaded
2025-09-15T01:45:21.635Z,1757900721.635 [ComponentRegistry](DEBUG): SyncComponent "DockingStepper" handled in the control thread.
2025-09-15T01:45:21.657Z,1757900721.657 [MassServo] Loaded
2025-09-15T01:45:21.658Z,1757900721.658 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2025-09-15T01:45:21.680Z,1757900721.680 [RudderServo] Loaded
2025-09-15T01:45:21.680Z,1757900721.680 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2025-09-15T01:45:21.698Z,1757900721.698 [ThrusterHE] Loaded
2025-09-15T01:45:21.699Z,1757900721.699 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2025-09-15T01:45:21.699Z,1757900721.699 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2025-09-15T01:45:21.700Z,1757900721.700 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2025-09-15T01:45:21.766Z,1757900721.766 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2025-09-15T01:45:21.766Z,1757900721.766 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2025-09-15T01:45:21.797Z,1757900721.797 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2025-09-15T01:45:21.798Z,1757900721.798 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2025-09-15T01:45:22.180Z,1757900722.180 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2025-09-15T01:45:22.181Z,1757900722.181 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2025-09-15T01:45:22.367Z,1757900722.367 [CTD_Seabird] Loaded
2025-09-15T01:45:22.367Z,1757900722.367 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2025-09-15T01:45:22.368Z,1757900722.368 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B924E0
2025-09-15T01:45:22.368Z,1757900722.368 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1121
2025-09-15T01:45:22.407Z,1757900722.407 [ESPComponent] Loaded
2025-09-15T01:45:22.407Z,1757900722.407 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2025-09-15T01:45:22.431Z,1757900722.431 [PAR_Licor] Loaded
2025-09-15T01:45:22.431Z,1757900722.431 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2025-09-15T01:45:22.479Z,1757900722.479 [WetLabsBB2FL] Loaded
2025-09-15T01:45:22.479Z,1757900722.479 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2025-09-15T01:45:22.480Z,1757900722.480 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40BC24E0
2025-09-15T01:45:22.481Z,1757900722.481 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1122
2025-09-15T01:45:22.481Z,1757900722.481 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2025-09-15T01:45:22.482Z,1757900722.482 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2025-09-15T01:45:22.662Z,1757900722.662 [SBIT](DEBUG): Construct Startup Built In Test.
2025-09-15T01:45:22.671Z,1757900722.671 [SBIT] Loaded
2025-09-15T01:45:22.672Z,1757900722.672 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2025-09-15T01:45:22.675Z,1757900722.675 [IBIT](DEBUG): Construct Initiated Built In Test.
2025-09-15T01:45:22.688Z,1757900722.688 [IBIT] Loaded
2025-09-15T01:45:22.689Z,1757900722.689 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2025-09-15T01:45:22.695Z,1757900722.695 [CBIT](DEBUG): Construct Continuous Built In Test.
2025-09-15T01:45:22.781Z,1757900722.781 [CBIT] Loaded
2025-09-15T01:45:22.781Z,1757900722.781 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2025-09-15T01:45:22.815Z,1757900722.815 [GFScanner] Loaded
2025-09-15T01:45:22.816Z,1757900722.816 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread.
2025-09-15T01:45:22.816Z,1757900722.816 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2025-09-15T01:45:22.823Z,1757900722.823 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2025-09-15T01:45:22.826Z,1757900722.826 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2025-09-15T01:45:22.838Z,1757900722.838 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2025-09-15T01:45:22.839Z,1757900722.839 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C3D4E0
2025-09-15T01:45:22.840Z,1757900722.840 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1123
2025-09-15T01:45:22.844Z,1757900722.844 [Supervisor](INFO): Main Thread ID is 825
2025-09-15T01:45:22.844Z,1757900722.844 [Supervisor](DEBUG): Running supervisor.
2025-09-15T01:45:22.845Z,1757900722.845 [CommandExec ThreadHandler](INFO): Handler Thread ID is 1124
2025-09-15T01:45:22.845Z,1757900722.845 [CommandExec](INFO): Initializing the command executive.
2025-09-15T01:45:22.847Z,1757900722.847 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1125
2025-09-15T01:45:22.849Z,1757900722.849 [controlThread ThreadHandler](INFO): Handler Thread ID is 1126
2025-09-15T01:45:22.849Z,1757900722.849 [controlThread](DEBUG): Initializing ControlThread
2025-09-15T01:45:22.850Z,1757900722.850 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2025-09-15T01:45:22.851Z,1757900722.851 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2025-09-15T01:45:22.851Z,1757900722.851 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2025-09-15T01:45:22.851Z,1757900722.851 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2025-09-15T01:45:22.852Z,1757900722.852 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2025-09-15T01:45:22.852Z,1757900722.852 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2025-09-15T01:45:22.854Z,1757900722.854 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2025-09-15T01:45:22.855Z,1757900722.855 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2025-09-15T01:45:22.855Z,1757900722.855 [LoopControl](DEBUG): Initialize LoopControlComponent.
2025-09-15T01:45:22.856Z,1757900722.856 [NavChart](DEBUG): Initialize NavChart Navigation.
2025-09-15T01:45:22.856Z,1757900722.856 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2025-09-15T01:45:22.861Z,1757900722.861 [SBIT](INFO): Initialize SBIT Component.
2025-09-15T01:45:22.861Z,1757900722.861 [SBIT](IMPORTANT): git: 2025-09-02
2025-09-15T01:45:22.862Z,1757900722.862 [SBIT](INFO): git hash: 79ab46e6183b98c19ab2829623a4adc5bf79cefb
2025-09-15T01:45:22.862Z,1757900722.862 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2025-09-15T01:45:22.863Z,1757900722.863 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #1 PREEMPT Tue Sep 24 11:12:27 PDT 2019
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2025-09-15T01:45:22.864Z,1757900722.864 [SBIT](INFO): Beginning SBIT in 79.000000 seconds.
2025-09-15T01:45:22.865Z,1757900722.865 [IBIT](INFO): Initialize IBIT Component.
2025-09-15T01:45:22.866Z,1757900722.866 [CBIT](DEBUG): Initialize CBIT Component.
2025-09-15T01:45:22.866Z,1757900722.866 [logger ThreadHandler](INFO): Handler Thread ID is 1127
2025-09-15T01:45:22.877Z,1757900722.877 [CBIT](DEBUG): Initialized mux pins.
2025-09-15T01:45:22.877Z,1757900722.877 [CBIT](DEBUG): Initializing the watchdog timer.
2025-09-15T01:45:22.885Z,1757900722.885 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 1128
2025-09-15T01:45:22.897Z,1757900722.897 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1129
2025-09-15T01:45:22.899Z,1757900722.899 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2025-09-15T01:45:22.901Z,1757900722.901 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2025-09-15T01:45:22.901Z,1757900722.901 [CBIT](DEBUG): Initializing heartbeat.
2025-09-15T01:45:22.909Z,1757900722.909 [Onboard ThreadHandler](INFO): Handler Thread ID is 1130
2025-09-15T01:45:22.926Z,1757900722.926 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1131
2025-09-15T01:45:22.945Z,1757900722.945 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1132
2025-09-15T01:45:22.946Z,1757900722.946 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2025-09-15T01:45:22.951Z,1757900722.951 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1134
2025-09-15T01:45:22.957Z,1757900722.957 [WetLabsBB2FL](INFO): Powering up
2025-09-15T01:45:22.958Z,1757900722.958 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1136
2025-09-15T01:45:22.961Z,1757900722.961 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2025-09-15T01:45:22.961Z,1757900722.961 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2025-09-15T01:45:22.961Z,1757900722.961 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2025-09-15T01:45:22.962Z,1757900722.962 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2025-09-15T01:45:22.962Z,1757900722.962 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2025-09-15T01:45:22.962Z,1757900722.962 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2025-09-15T01:45:22.962Z,1757900722.962 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2025-09-15T01:45:22.962Z,1757900722.962 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2025-09-15T01:45:22.973Z,1757900722.973 [CBIT](DEBUG): Deactivating emergency mode.
2025-09-15T01:45:23.013Z,1757900723.013 [CBIT](DEBUG): Backplane powered.
2025-09-15T01:45:23.014Z,1757900723.014 [GFScanner](DEBUG): Initializing GFScanner
2025-09-15T01:45:23.014Z,1757900723.014 [GFScanner](DEBUG): Deactivating GF circuits.
2025-09-15T01:45:23.018Z,1757900723.018 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2025-09-15T01:45:23.029Z,1757900723.029 [MissionManager](INFO): Loading Mission from file: Missions/underIce/StartupUnder.tl
2025-09-15T01:45:23.029Z,1757900723.029 [MissionManager](DEBUG): TethyslAPI: loading: Missions/underIce/StartupUnder.tl
2025-09-15T01:45:23.031Z,1757900723.031 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/underIce/StartupUnder.tl
2025-09-15T01:45:23.036Z,1757900723.036 [MissionManager](DEBUG): TethyslAPI: Missions/underIce/StartupUnder.tl translated into:
<?xml version="1.0" encoding="UTF-8" ?>
<!--generated by tl2xml-->
<Mission Id="StartupUnder" />

2025-09-15T01:45:23.036Z,1757900723.036 [MissionManager](ERROR): Top node has no child nodes: Mission
2025-09-15T01:45:23.036Z,1757900723.036 [MissionManager](ERROR): Could not load startup mission.
2025-09-15T01:45:23.037Z,1757900723.037 [MissionManager](INFO): Loading Mission from file: Missions/underIce/DefaultWithUndock.tl
2025-09-15T01:45:23.037Z,1757900723.037 [MissionManager](DEBUG): TethyslAPI: loading: Missions/underIce/DefaultWithUndock.tl
2025-09-15T01:45:23.038Z,1757900723.038 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/underIce/DefaultWithUndock.tl
2025-09-15T01:45:23.333Z,1757900723.333 [Radio_Surface](INFO): Powering up
2025-09-15T01:45:23.593Z,1757900723.593 [MissionManager](DEBUG): TethyslAPI: Missions/underIce/DefaultWithUndock.tl translated into:
<?xml version="1.0" encoding="UTF-8" ?>
<!--generated by tl2xml-->
<Mission Id="DefaultWithUndock">
    <DefineArg Name="ElapsedSinceDefaultStarted">
        <Units:minute />
        <Value>0</Value>
    </DefineArg>
    <DefineArg Name="DetachTimeout">
        <Units:hour />
        <Value>6</Value>
    </DefineArg>
    <DefineArg Name="TransponderCode">
        <Dock:Dock.transponderCode />
    </DefineArg>
    <DefineArg Name="TrackingUpdatePeriod">
        <Units:second />
        <Value>10</Value>
    </DefineArg>
    <DefineArg Name="NumberOfPings">
        <Units:count />
        <Value>1</Value>
    </DefineArg>
    <DefineArg Name="DriftTimeout">
        <Units:minute />
        <Value>3</Value>
    </DefineArg>
    <Guidance:Wait>
        <Sequence />
        <Setting>
            <Guidance:Wait.duration />
            <Units:second />
            <Value>30</Value>
        </Setting>
    </Guidance:Wait>
    <Aggregate Id="LeaveDock">
        <Sequence />
        <Timeout Duration="DetachTimeout">
            <Syslog Severity="Important">
                Timed out while trying to detach from dock at current depth of 
                <Universal:depth />
                <Units:meter />
                .
            </Syslog>
        </Timeout>
        <Estimation:TrackAcousticContact>
            <While>
                <Universal:depth />
                <Gt>
                    <Control:VerticalControl.surfaceThreshold />
                </Gt>
            </While>
            <Setting>
                <Estimation:TrackAcousticContact.contactLabelSetting />
                <Arg Name="TransponderCode" />
            </Setting>
            <Setting>
                <Estimation:TrackAcousticContact.numberOfSamplesSetting />
                <Arg Name="NumberOfPings" />
            </Setting>
            <Setting>
                <Estimation:TrackAcousticContact.updatePeriodSetting />
                <Arg Name="TrackingUpdatePeriod" />
            </Setting>
        </Estimation:TrackAcousticContact>
        <Dock:Undock>
            <Sequence />
            <Setting>
                <Dock:Undock.driftTimeout />
                <Arg Name="DriftTimeout" />
            </Setting>
        </Dock:Undock>
    </Aggregate>
    <Aggregate Id="SurfaceDefault">
        <Sequence />
        <Guidance:GoToSurface>
            <Progression />
        </Guidance:GoToSurface>
        <Aggregate Id="CheckIn">
            <Sequence Repeat="288" />
            <ReadDatum Id="Read_GPS">
                <Timeout Duration="P5M" />
                <Universal:time_fix />
            </ReadDatum>
            <ReadDatum Id="Read_Iridium">
                <Timeout Duration="P2H">
                    <Guidance:Execute>
                        <Sequence />
                        <Setting>
                            <Guidance:Execute.command />
                            <String>Burn on</String>
                        </Setting>
                    </Guidance:Execute>
                    <Syslog Severity="Critical">Dropped weight due to communications timeout.</Syslog>
                </Timeout>
                <Universal:platform_communications />
            </ReadDatum>
            <Guidance:Wait>
                <Sequence />
                <Setting>
                    <Guidance:Wait.duration />
                    <Units:minute />
                    <Value>5</Value>
                </Setting>
            </Guidance:Wait>
            <Assign>
                <Sequence />
                <Arg Name="ElapsedSinceDefaultStarted" />
                <Elapsed>
                    <Universal:mission_started />
                </Elapsed>
            </Assign>
            <Syslog Severity="Important">
                Default mission has been running for 
                <Arg Name="ElapsedSinceDefaultStarted" />
                <Units:minute />
            </Syslog>
        </Aggregate>
    </Aggregate>
    <Syslog Severity="Important">Restarting logs and Default mission.</Syslog>
    <Guidance:Execute>
        <Sequence />
        <Setting>
            <Guidance:Execute.command />
            <String>restart logs</String>
        </Setting>
    </Guidance:Execute>
</Mission>

2025-09-15T01:45:23.616Z,1757900723.616 [MissionManager](INFO): DefineArg DefaultWithUndock.ElapsedSinceDefaultStarted = 0.000000 min
2025-09-15T01:45:23.620Z,1757900723.620 [MissionManager](INFO): DefineArg DefaultWithUndock.DetachTimeout = 6.000000 h
2025-09-15T01:45:23.636Z,1757900723.636 [MissionManager](INFO): DefineArg DefaultWithUndock.TransponderCode = 50 count
2025-09-15T01:45:23.640Z,1757900723.640 [MissionManager](INFO): DefineArg DefaultWithUndock.TrackingUpdatePeriod = 10.000000 s
2025-09-15T01:45:23.664Z,1757900723.664 [MissionManager](INFO): DefineArg DefaultWithUndock.NumberOfPings = 1.000000 count
2025-09-15T01:45:23.668Z,1757900723.668 [MissionManager](INFO): DefineArg DefaultWithUndock.DriftTimeout = 3.000000 min
2025-09-15T01:45:23.685Z,1757900723.685 [DefaultWithUndock:A.Wait](DEBUG): Construct Wait.
2025-09-15T01:45:23.715Z,1757900723.715 [DefaultWithUndock:LeaveDock:A.](CRITICAL): No USBL component is enabled. Check vehicle configuration.
2025-09-15T01:45:23.857Z,1757900723.857 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Construct.
2025-09-15T01:45:23.857Z,1757900723.857 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values.
2025-09-15T01:45:23.916Z,1757900723.916 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): Construct GoToSurface.
2025-09-15T01:45:23.960Z,1757900723.960 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2025-09-15T01:45:23.963Z,1757900723.963 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Construct Wait.
2025-09-15T01:45:23.982Z,1757900723.982 [DefaultWithUndock:E.Execute](DEBUG): Construct Execute.
2025-09-15T01:45:23.986Z,1757900723.986 [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 DefaultWithUndock {
  arguments {
    ElapsedSinceDefaultStarted = 0 minute

    DetachTimeout = 6 hour
      """
      Maximum time duration for the vehicle to detach form the dock.
      """

    TransponderCode = Dock:Dock.transponderCode
      """
      Dock transponder address.
      """

    TrackingUpdatePeriod = 10 second
      """
      Time duration between acoustic range queries while the mission is
      detaching from the dock.
      """

    NumberOfPings = 1 count
      """
      Number of pings requested each time.
      """

    DriftTimeout = 3 minute
      """
      How long to allow vehicle to drift away from dock before retrying reverse
      """
  }

  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 = 30 second
  }

  aggregate LeaveDock {
    run in sequence

    timeout duration=DetachTimeout {
      syslog important "Timed out while trying to detach from dock at current depth of "
           + Universal:depth~meter + "."
    }

    # Acoustic tracking directives

    behavior Estimation:TrackAcousticContact {
      run while (
        Universal:depth > Control:VerticalControl.surfaceThreshold
      )

      set contactLabelSetting = TransponderCode
      set numberOfSamplesSetting = NumberOfPings
      set updatePeriodSetting = TrackingUpdatePeriod
    }

    # Leave the dock

    behavior Dock:Undock {
      run in sequence

      set driftTimeout = DriftTimeout
    }
  }

  aggregate SurfaceDefault {
    run in sequence

    # This mission assumes open water so from here on it's the same old default that's always used

    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=P2H {
          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-09-15T01:45:23.997Z,1757900723.997 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,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,DockingStepper,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter,
2025-09-15T01:45:24.021Z,1757900724.021 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2025-09-15T01:45:24.089Z,1757900724.089 [Depth_Keller](INFO): Initializing.
2025-09-15T01:45:24.090Z,1757900724.090 [Power24vConverter](INFO): Powering up.
2025-09-15T01:45:24.091Z,1757900724.091 [Sonardyne_Nano](INFO): Initializing.
2025-09-15T01:45:24.133Z,1757900724.133 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-09-15T01:45:24.159Z,1757900724.159 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2025-09-15T01:45:24.165Z,1757900724.165 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2025-09-15T01:45:24.166Z,1757900724.166 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-09-15T01:45:24.173Z,1757900724.173 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-09-15T01:45:24.174Z,1757900724.174 [DockingStepper](DEBUG): Initializing EZServoServo.
2025-09-15T01:45:24.181Z,1757900724.181 [DockingStepper](DEBUG): Initializing DockingStepper.
2025-09-15T01:45:24.182Z,1757900724.182 [MassServo](DEBUG): Initializing EZServoServo.
2025-09-15T01:45:24.189Z,1757900724.189 [MassServo](DEBUG): Initializing MassServo.
2025-09-15T01:45:24.190Z,1757900724.190 [RudderServo](DEBUG): Initializing EZServoServo.
2025-09-15T01:45:24.198Z,1757900724.198 [RudderServo](DEBUG): Initializing RudderServo.
2025-09-15T01:45:24.199Z,1757900724.199 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-09-15T01:45:24.205Z,1757900724.205 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-09-15T01:45:24.207Z,1757900724.207 [CommandExec](FAULT): Scheduling is paused
2025-09-15T01:45:24.207Z,1757900724.207 [CBIT](INFO): Critical error at 20250915T014523
2025-09-15T01:45:24.208Z,1757900724.208 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2025-09-15T01:45:25.061Z,1757900725.061 [WetLabsBB2FL](INFO): Powering down
2025-09-15T01:45:26.027Z,1757900726.027 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART
2025-09-15T01:45:27.313Z,1757900727.313 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2207
2025-09-15T01:45:28.585Z,1757900728.585 [Radio_Surface](INFO): Checking local IP, expecting subnet 10.89.11
2025-09-15T01:45:28.586Z,1757900728.586 [Radio_Surface](INFO): Found local IP address 10.89.11.2 for eth0
2025-09-15T01:45:29.794Z,1757900729.794 [ThrusterHE](ERROR): Zero Speed Commanded.
2025-09-15T01:45:29.977Z,1757900729.977 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit.
2025-09-15T01:45:51.482Z,1757900751.482 [NAL9602](INFO): Powering up NAL9602
2025-09-15T01:45:54.021Z,1757900754.021 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:46:02.390Z,1757900762.390 [NAL9602](INFO): NAL9602 initialized
2025-09-15T01:46:13.303Z,1757900773.303 [NAL9602](INFO): SBD MO Status=0, MOMSN=1719, MT Status=0, MTMSN=0
2025-09-15T01:46:13.304Z,1757900773.304 [NAL9602](INFO): No messages in MT queue
2025-09-15T01:46:25.157Z,1757900785.157 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:46:42.399Z,1757900802.399 [SBIT](IMPORTANT): Beginning Startup BIT
2025-09-15T01:46:42.426Z,1757900802.426 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-09-15T01:46:46.962Z,1757900806.962 [GFScanner](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.003040
CHAN A1 (24V): -0.187112
CHAN A2 (12V): -0.004066
CHAN A3 (5V): -0.005767
CHAN B0 (3.3V): 0.000160
CHAN B1 (3.15aV): -0.000374
CHAN B2 (3.15bV): 0.000113
CHAN B3 (GND): -0.004016
OPEN: 0.005324
Full Scale: +/- 1 mA
2025-09-15T01:46:56.281Z,1757900816.281 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:47:27.405Z,1757900847.405 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:47:36.603Z,1757900856.603 [SBIT](IMPORTANT): SBIT PASSED
2025-09-15T01:47:36.603Z,1757900856.603 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2025-09-15T01:47:36.604Z,1757900856.604 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=26 count;

2025-09-15T01:47:36.604Z,1757900856.604 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool;

2025-09-15T01:47:36.604Z,1757900856.604 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool;

2025-09-15T01:47:36.604Z,1757900856.604 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=5 minute;

2025-09-15T01:47:36.604Z,1757900856.604 [SBIT](IMPORTANT): ESPComponent.simulateHardware=0 bool;

2025-09-15T01:47:36.604Z,1757900856.604 [SBIT](IMPORTANT): Express linearApproximation DAT.acoustic_contact_range 15.000000 meter;

2025-09-15T01:47:36.604Z,1757900856.604 [SBIT](IMPORTANT): IBIT.batteryCapacityThreshold=-0.5 ampere_hour;

2025-09-15T01:47:36.604Z,1757900856.604 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=9 volt;

2025-09-15T01:47:36.605Z,1757900856.605 [SBIT](IMPORTANT): RDI_Pathfinder.loadAtStartup=0 bool;

2025-09-15T01:47:36.605Z,1757900856.605 [SBIT](IMPORTANT): SpeedControl.rollOptimum=0.800000 m/s;

2025-09-15T01:47:36.605Z,1757900856.605 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=90 cubic_centimeter;

2025-09-15T01:47:36.605Z,1757900856.605 [SBIT](IMPORTANT): VerticalControl.massDefault=-1.5 centimeter;

2025-09-15T01:47:37.017Z,1757900857.017 [MissionManager](IMPORTANT): Started mission DefaultWithUndock
2025-09-15T01:47:37.017Z,1757900857.017 [DefaultWithUndock] Running Loop=1
2025-09-15T01:47:37.017Z,1757900857.017 [DefaultWithUndock](DEBUG): Aggregate::initialize DefaultWithUndock
2025-09-15T01:47:37.018Z,1757900857.018 [DefaultWithUndock:A.Wait] Running Loop=1
2025-09-15T01:47:37.018Z,1757900857.018 [DefaultWithUndock:A.Wait](DEBUG): Initialize Wait Component.
2025-09-15T01:47:58.545Z,1757900878.545 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:48:07.299Z,1757900887.299 [DefaultWithUndock:A.Wait](INFO): Done Waiting.
2025-09-15T01:48:07.299Z,1757900887.299 [DefaultWithUndock:A.Wait] Stopped
2025-09-15T01:48:07.299Z,1757900887.299 [DefaultWithUndock:A.Wait](DEBUG): Uninitialize Wait Component.
2025-09-15T01:48:07.299Z,1757900887.299 [DefaultWithUndock:LeaveDock] Running Loop=1
2025-09-15T01:48:07.299Z,1757900887.299 [DefaultWithUndock:LeaveDock](DEBUG): Aggregate::initialize DefaultWithUndock:LeaveDock
2025-09-15T01:48:07.299Z,1757900887.299 [DefaultWithUndock:LeaveDock:A.] Running Loop=1
2025-09-15T01:48:07.299Z,1757900887.299 [DefaultWithUndock:LeaveDock:A.](INFO): Initializing TrackAcousticContact.
2025-09-15T01:48:07.300Z,1757900887.300 [DefaultWithUndock:LeaveDock:B.Undock] Running Loop=1
2025-09-15T01:48:07.300Z,1757900887.300 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initialize.
2025-09-15T01:48:07.300Z,1757900887.300 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values.
2025-09-15T01:48:07.727Z,1757900887.727 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initialize.
2025-09-15T01:48:07.727Z,1757900887.727 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values.
2025-09-15T01:48:07.728Z,1757900887.728 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detached from dock at depth 0.076610 m.
2025-09-15T01:48:07.729Z,1757900887.729 [DefaultWithUndock:LeaveDock:A.] Stopped
2025-09-15T01:48:07.729Z,1757900887.729 [DefaultWithUndock:LeaveDock:A.](DEBUG): Uninitializing TrackAcousticContact.
2025-09-15T01:48:08.136Z,1757900888.136 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detected possible detachment. Starting timer.
2025-09-15T01:48:08.536Z,1757900888.536 [DockingStepper](DEBUG): Initializing EZServoServo.
2025-09-15T01:48:08.650Z,1757900888.650 [DockingStepper](DEBUG): Initializing DockingStepper.
2025-09-15T01:48:23.110Z,1757900903.110 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2025-09-15T01:48:23.110Z,1757900903.110 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-09-15T01:48:23.206Z,1757900903.206 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-09-15T01:48:23.590Z,1757900903.590 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-09-15T01:48:23.590Z,1757900903.590 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2025-09-15T01:48:27.254Z,1757900907.254 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003919
2025-09-15T01:48:28.253Z,1757900908.253 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:48:28.307Z,1757900908.307 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detached at range: nan m. Transitioning docking module to standby.
2025-09-15T01:48:28.723Z,1757900908.723 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Docking module at standby.
2025-09-15T01:48:29.135Z,1757900909.135 [DefaultWithUndock:LeaveDock:B.Undock](IMPORTANT): Undocking sequence complete.
2025-09-15T01:48:29.135Z,1757900909.135 [DefaultWithUndock:LeaveDock:B.Undock] Stopped
2025-09-15T01:48:29.135Z,1757900909.135 [DefaultWithUndock:LeaveDock](INFO): Completed DefaultWithUndock:LeaveDock
2025-09-15T01:48:29.135Z,1757900909.135 [DefaultWithUndock:LeaveDock] Stopped
2025-09-15T01:48:29.135Z,1757900909.135 [DefaultWithUndock:LeaveDock](DEBUG): Aggregate::uninitialize DefaultWithUndock:LeaveDock
2025-09-15T01:48:29.135Z,1757900909.135 [DefaultWithUndock:SurfaceDefault] Running Loop=1
2025-09-15T01:48:29.136Z,1757900909.136 [DefaultWithUndock:SurfaceDefault](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault
2025-09-15T01:48:29.136Z,1757900909.136 [DefaultWithUndock:SurfaceDefault:A.GoToSurface] Running Loop=1
2025-09-15T01:48:29.136Z,1757900909.136 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-09-15T01:48:29.136Z,1757900909.136 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-09-15T01:48:29.137Z,1757900909.137 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-09-15T01:48:29.137Z,1757900909.137 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-09-15T01:48:29.138Z,1757900909.138 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-09-15T01:48:29.138Z,1757900909.138 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-09-15T01:48:29.138Z,1757900909.138 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-09-15T01:48:29.544Z,1757900909.544 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=1
2025-09-15T01:48:29.544Z,1757900909.544 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2025-09-15T01:48:29.544Z,1757900909.544 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2025-09-15T01:48:29.920Z,1757900909.920 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-09-15T01:48:36.789Z,1757900916.789 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:48:45.149Z,1757900925.149 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:48:50.108Z,1757900930.108 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,014846.00,A,3645.99004,N,12151.86933,W,0.641,0.00,150925,,,A*7B
2025-09-15T01:48:50.111Z,1757900930.111 [NAL9602](INFO): GPS fix at 20250915T014846: (36.766501, -121.864489)
2025-09-15T01:48:50.124Z,1757900930.124 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2025-09-15T01:48:50.124Z,1757900930.124 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2025-09-15T01:48:50.553Z,1757900930.553 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-09-15T01:48:51.400Z,1757900931.400 [DataOverHttps](INFO): Sending 218 bytes from file Logs/20250915T013347/Courier0004.lzma
2025-09-15T01:48:52.115Z,1757900932.115 [DataOverHttps](INFO): Moved sent file to Logs/20250915T013347/Courier0004.lzma.bak
2025-09-15T01:48:52.115Z,1757900932.115 [DataOverHttps](INFO): SBD MOMSN=25989643
2025-09-15T01:49:09.189Z,1757900949.189 [DataOverHttps](INFO): Sending 364 bytes from file Logs/20250915T014511/Courier0000.lzma
2025-09-15T01:49:10.190Z,1757900950.190 [DataOverHttps](INFO): Moved sent file to Logs/20250915T014511/Courier0000.lzma.bak
2025-09-15T01:49:10.191Z,1757900950.191 [DataOverHttps](INFO): SBD MOMSN=25989648
2025-09-15T01:49:18.770Z,1757900958.770 [DataOverHttps](IMPORTANT): SBD MTMSN=20250915T014918
2025-09-15T01:49:22.214Z,1757900962.214 [NAL9602](INFO): Not Powering down - fast GPS
2025-09-15T01:49:26.261Z,1757900966.261 [DataOverHttps](INFO): Sending 463 bytes from file Logs/20250915T013347/Express0005.lzma
2025-09-15T01:49:26.265Z,1757900966.265 [DataOverHttps](INFO): Received command: schedule resume
2025-09-15T01:49:26.283Z,1757900966.283 [CommandExec](IMPORTANT): got command schedule resume
2025-09-15T01:49:26.283Z,1757900966.283 [CommandExec](IMPORTANT): Scheduling is resumed
2025-09-15T01:49:27.477Z,1757900967.477 [DataOverHttps](INFO): Moved sent file to Logs/20250915T013347/Express0005.lzma.bak
2025-09-15T01:49:27.477Z,1757900967.477 [DataOverHttps](INFO): SBD MOMSN=25989655
2025-09-15T01:49:43.189Z,1757900983.189 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250915T014511/Courier0004.lzma
2025-09-15T01:49:44.186Z,1757900984.186 [DataOverHttps](INFO): Moved sent file to Logs/20250915T014511/Courier0004.lzma.bak
2025-09-15T01:49:44.187Z,1757900984.187 [DataOverHttps](INFO): SBD MOMSN=25989671
2025-09-15T01:50:01.032Z,1757901001.032 [DataOverHttps](INFO): Sending 1217 bytes from file Logs/20250915T014511/Express0001.lzma
2025-09-15T01:50:02.031Z,1757901002.031 [DataOverHttps](INFO): Moved sent file to Logs/20250915T014511/Express0001.lzma.bak
2025-09-15T01:50:02.031Z,1757901002.031 [DataOverHttps](INFO): SBD MOMSN=25989673
2025-09-15T01:50:20.361Z,1757901020.361 [DataOverHttps](INFO): Sending 184 bytes from file Logs/20250915T014511/Express0005.lzma
2025-09-15T01:50:21.363Z,1757901021.363 [DataOverHttps](INFO): Moved sent file to Logs/20250915T014511/Express0005.lzma.bak
2025-09-15T01:50:21.363Z,1757901021.363 [DataOverHttps](INFO): SBD MOMSN=25989700
2025-09-15T01:50:23.260Z,1757901023.260 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2025-09-15T01:50:23.260Z,1757901023.260 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1
2025-09-15T01:50:23.260Z,1757901023.260 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-09-15T01:50:30.797Z,1757901030.797 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:50:39.309Z,1757901039.309 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:50:47.725Z,1757901047.725 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:50:57.193Z,1757901057.193 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:51:05.713Z,1757901065.713 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:51:14.109Z,1757901074.109 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:51:14.574Z,1757901074.574 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-15T01:51:22.677Z,1757901082.677 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:51:31.161Z,1757901091.161 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:51:39.637Z,1757901099.637 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:51:48.117Z,1757901108.117 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:51:56.573Z,1757901116.573 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:52:05.025Z,1757901125.025 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:52:13.541Z,1757901133.541 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:52:22.025Z,1757901142.025 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:52:30.522Z,1757901150.522 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:52:39.041Z,1757901159.041 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:52:46.282Z,1757901166.282 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-15T01:52:47.425Z,1757901167.425 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:52:55.917Z,1757901175.917 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:53:04.409Z,1757901184.409 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:53:12.985Z,1757901192.985 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:53:21.597Z,1757901201.597 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:53:29.913Z,1757901209.913 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:53:38.378Z,1757901218.378 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:53:44.053Z,1757901224.053 [BPC1](ERROR): Battery stick #17 (s/n: 00C9) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0.
2025-09-15T01:53:44.054Z,1757901224.054 [BPC1](ERROR): Battery stick #24 (s/n: 011E) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-09-15T01:53:44.055Z,1757901224.055 [BPC1](ERROR): Battery stick #26 (s/n: 0112) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-09-15T01:53:44.056Z,1757901224.056 [BPC1](ERROR): Battery stick #27 (s/n: 00AF) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0.
2025-09-15T01:53:44.057Z,1757901224.057 [BPC1](ERROR): Battery stick #44 (s/n: 00E4) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-09-15T01:53:44.057Z,1757901224.057 [BPC1](ERROR): Battery stick #54 (s/n: 009C) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-09-15T01:53:44.058Z,1757901224.058 [BPC1](ERROR): Battery stick #58 (s/n: 00F3) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0.
2025-09-15T01:53:44.059Z,1757901224.059 [BPC1](INFO): Calculating totals. Valid battery stick count: 28. Valid reserve battery stick count: 2.
2025-09-15T01:53:44.062Z,1757901224.062 [BPC1](INFO): Received data from all battery sticks.
2025-09-15T01:53:46.957Z,1757901226.957 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:53:55.365Z,1757901235.365 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:54:03.821Z,1757901243.821 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:54:12.291Z,1757901252.291 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:54:20.729Z,1757901260.729 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:54:29.111Z,1757901269.111 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:54:37.785Z,1757901277.785 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:54:46.301Z,1757901286.301 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:54:54.721Z,1757901294.721 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:55:03.289Z,1757901303.289 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:55:11.717Z,1757901311.717 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-09-15T01:55:19.094Z,1757901319.094 [DataOverHttps](IMPORTANT): SBD MTMSN=20250915T015518
2025-09-15T01:55:23.870Z,1757901323.870 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](INFO): Done Waiting.
2025-09-15T01:55:23.870Z,1757901323.870 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped
2025-09-15T01:55:23.870Z,1757901323.870 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-09-15T01:55:23.870Z,1757901323.870 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Running Loop=1
2025-09-15T01:55:24.265Z,1757901324.265 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Stopped
2025-09-15T01:55:24.265Z,1757901324.265 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Running Loop=1
2025-09-15T01:55:24.678Z,1757901324.678 [DefaultWithUndock:SurfaceDefault:CheckIn:E](IMPORTANT): Default mission has been running for  7.787462 min 
2025-09-15T01:55:24.679Z,1757901324.679 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Stopped
2025-09-15T01:55:24.679Z,1757901324.679 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Completed DefaultWithUndock:SurfaceDefault:CheckIn
2025-09-15T01:55:24.679Z,1757901324.679 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2025-09-15T01:55:24.679Z,1757901324.679 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2025-09-15T01:55:24.679Z,1757901324.679 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Running loop #2
2025-09-15T01:55:24.679Z,1757901324.679 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=2
2025-09-15T01:55:24.679Z,1757901324.679 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2025-09-15T01:55:24.679Z,1757901324.679 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2025-09-15T01:55:25.042Z,1757901325.042 [Power24vConverter](INFO): Powering down.
2025-09-15T01:55:26.596Z,1757901326.596 [DataOverHttps](INFO): Received command: restart app
2025-09-15T01:55:26.658Z,1757901326.658 [CommandExec](IMPORTANT): got command restart application
2025-09-15T01:55:26.673Z,1757901326.673 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,015522.00,A,3645.96880,N,12151.79291,W,1.341,104.77,150925,,,A*7C
2025-09-15T01:55:26.675Z,1757901326.675 [NAL9602](INFO): GPS fix at 20250915T015522: (36.766147, -121.863215)
2025-09-15T01:55:26.687Z,1757901326.687 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2025-09-15T01:55:26.687Z,1757901326.687 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2025-09-15T01:55:27.661Z,1757901327.661 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2025-09-15T01:55:27.661Z,1757901327.661 [CommandExec](INFO): Uninitializing the command executive.
2025-09-15T01:55:27.661Z,1757901327.661 [CommandExec](INFO): Uninitializing the command scheduler.
2025-09-15T01:55:27.661Z,1757901327.661 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-09-15T01:55:27.741Z,1757901327.741 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2025-09-15T01:55:27.741Z,1757901327.741 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2025-09-15T01:55:27.741Z,1757901327.741 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-09-15T01:55:27.742Z,1757901327.742 [NavChartDb](INFO): Join timeout helper Thread ID is 1188
2025-09-15T01:55:28.065Z,1757901328.065 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2025-09-15T01:55:28.065Z,1757901328.065 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-09-15T01:55:28.085Z,1757901328.085 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2025-09-15T01:55:28.085Z,1757901328.085 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-09-15T01:55:28.085Z,1757901328.085 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1189
2025-09-15T01:55:28.489Z,1757901328.489 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2025-09-15T01:55:28.489Z,1757901328.489 [WetLabsBB2FL](INFO): Powering down
2025-09-15T01:55:28.490Z,1757901328.490 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-09-15T01:55:28.493Z,1757901328.493 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2025-09-15T01:55:28.493Z,1757901328.493 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-09-15T01:55:28.493Z,1757901328.493 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1190
2025-09-15T01:55:29.469Z,1757901329.469 [CTD_Seabird](INFO): Powering down
2025-09-15T01:55:29.481Z,1757901329.481 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2025-09-15T01:55:29.481Z,1757901329.481 [CTD_Seabird](INFO): Powering down
2025-09-15T01:55:29.493Z,1757901329.493 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-09-15T01:55:29.497Z,1757901329.497 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2025-09-15T01:55:29.497Z,1757901329.497 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-09-15T01:55:29.497Z,1757901329.497 [Radio_Surface](INFO): Join timeout helper Thread ID is 1191
2025-09-15T01:55:29.785Z,1757901329.785 [Radio_Surface](INFO): Powering down
2025-09-15T01:55:29.786Z,1757901329.786 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2025-09-15T01:55:29.787Z,1757901329.787 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-09-15T01:55:29.805Z,1757901329.805 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2025-09-15T01:55:29.805Z,1757901329.805 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-09-15T01:55:29.805Z,1757901329.805 [Onboard](INFO): Join timeout helper Thread ID is 1192
2025-09-15T01:55:33.465Z,1757901333.465 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2025-09-15T01:55:33.466Z,1757901333.466 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-09-15T01:55:33.470Z,1757901333.470 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2025-09-15T01:55:33.470Z,1757901333.470 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-09-15T01:55:33.470Z,1757901333.470 [DataOverHttps](INFO): Join timeout helper Thread ID is 1193
2025-09-15T01:55:33.968Z,1757901333.968 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2025-09-15T01:55:33.975Z,1757901333.975 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-09-15T01:55:33.988Z,1757901333.988 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2025-09-15T01:55:33.988Z,1757901333.988 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-09-15T01:55:33.989Z,1757901333.989 [BackseatComponent](INFO): Join timeout helper Thread ID is 1194
2025-09-15T01:55:34.069Z,1757901334.069 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2025-09-15T01:55:34.069Z,1757901334.069 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-09-15T01:55:34.085Z,1757901334.085 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2025-09-15T01:55:34.086Z,1757901334.086 [logger ThreadHandler](INFO): Thread cancelled.
2025-09-15T01:55:34.086Z,1757901334.086 [logger](INFO): Join timeout helper Thread ID is 1195
2025-09-15T01:55:34.093Z,1757901334.093 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2025-09-15T01:55:34.093Z,1757901334.093 [logger ThreadHandler](INFO): Thread cancelled.
2025-09-15T01:55:34.105Z,1757901334.105 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2025-09-15T01:55:34.106Z,1757901334.106 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-09-15T01:55:34.106Z,1757901334.106 [CommandLine](INFO): Join timeout helper Thread ID is 1196
2025-09-15T01:55:34.193Z,1757901334.193 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2025-09-15T01:55:34.193Z,1757901334.193 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-09-15T01:55:34.205Z,1757901334.205 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2025-09-15T01:55:34.205Z,1757901334.205 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-09-15T01:55:34.206Z,1757901334.206 [CommandExec](INFO): Join timeout helper Thread ID is 1197
2025-09-15T01:55:34.207Z,1757901334.207 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2025-09-15T01:55:34.207Z,1757901334.207 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-09-15T01:55:34.207Z,1757901334.207 [controlThread](INFO): Join timeout helper Thread ID is 1198
2025-09-15T01:55:34.317Z,1757901334.317 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2025-09-15T01:55:34.317Z,1757901334.317 [controlThread](DEBUG): Uninitializing ControlThread
2025-09-15T01:55:34.318Z,1757901334.318 [AHRS_M2](INFO): Powering down
2025-09-15T01:55:34.397Z,1757901334.397 [NAL9602](INFO): Powering down
2025-09-15T01:55:34.398Z,1757901334.398 [Sonardyne_Nano](INFO): Powering down
2025-09-15T01:55:34.605Z,1757901334.605 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2025-09-15T01:55:34.606Z,1757901334.606 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2025-09-15T01:55:34.606Z,1757901334.606 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2025-09-15T01:55:34.607Z,1757901334.607 [MissionManager](INFO): Uninitializing Mission DefaultWithUndock
2025-09-15T01:55:34.607Z,1757901334.607 [DefaultWithUndock] Stopped
2025-09-15T01:55:34.607Z,1757901334.607 [DefaultWithUndock](DEBUG): Aggregate::uninitialize DefaultWithUndock
2025-09-15T01:55:34.607Z,1757901334.607 [DefaultWithUndock:SurfaceDefault] Stopped
2025-09-15T01:55:34.607Z,1757901334.607 [DefaultWithUndock:SurfaceDefault](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault
2025-09-15T01:55:34.607Z,1757901334.607 [DefaultWithUndock:SurfaceDefault:A.GoToSurface] Stopped
2025-09-15T01:55:34.607Z,1757901334.607 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-09-15T01:55:34.607Z,1757901334.607 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2025-09-15T01:55:34.608Z,1757901334.608 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2025-09-15T01:55:34.608Z,1757901334.608 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2025-09-15T01:55:34.616Z,1757901334.616 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2025-09-15T01:55:34.616Z,1757901334.616 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2025-09-15T01:55:34.617Z,1757901334.617 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2025-09-15T01:55:34.617Z,1757901334.617 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2025-09-15T01:55:34.617Z,1757901334.617 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2025-09-15T01:55:34.617Z,1757901334.617 [BuoyancyServo](INFO): Powering down
2025-09-15T01:55:34.629Z,1757901334.629 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-09-15T01:55:34.629Z,1757901334.629 [ElevatorServo](INFO): Powering down
2025-09-15T01:55:34.630Z,1757901334.630 [DockingStepper](DEBUG): Uninitialize Docking Stepper.
2025-09-15T01:55:34.630Z,1757901334.630 [DockingStepper](INFO): Powering down
2025-09-15T01:55:34.631Z,1757901334.631 [MassServo](DEBUG): Uninitialize Mass Servo.
2025-09-15T01:55:34.631Z,1757901334.631 [MassServo](INFO): Powering down
2025-09-15T01:55:34.632Z,1757901334.632 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-09-15T01:55:34.632Z,1757901334.632 [RudderServo](INFO): Powering down
2025-09-15T01:55:34.633Z,1757901334.633 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2025-09-15T01:55:34.633Z,1757901334.633 [ThrusterHE](INFO): Powering down
2025-09-15T01:55:34.634Z,1757901334.634 [SBIT](DEBUG): Uninitialize SBIT Component.
2025-09-15T01:55:34.634Z,1757901334.634 [IBIT](DEBUG): Uninitialize IBIT Component.
2025-09-15T01:55:34.634Z,1757901334.634 [CBIT](DEBUG): Uninitialize CBIT Component.
2025-09-15T01:55:34.634Z,1757901334.634 [CBIT](DEBUG): Powering off loads.
2025-09-15T01:55:34.645Z,1757901334.645 [CBIT](DEBUG): Disabling WDT.
2025-09-15T01:55:34.657Z,1757901334.657 [GFScanner](DEBUG): Uninitialize GFScanner component.
2025-09-15T01:55:34.657Z,1757901334.657 [GFScanner](DEBUG): Opening all GF detection circuits.
2025-09-15T01:55:34.658Z,1757901334.658 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-09-15T01:55:34.706Z,1757901334.705 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-09-15T01:55:34.708Z,1757901334.708 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-09-15T01:55:34.715Z,1757901334.715 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-09-15T01:55:34.759Z,1757901334.759 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-09-15T01:55:34.817Z,1757901334.817 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-09-15T01:55:34.823Z,1757901334.823 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-09-15T01:55:34.831Z,1757901334.831 [GFScanner](DEBUG): Uninitialize GFScanner component.
2025-09-15T01:55:34.832Z,1757901334.832 [GFScanner](DEBUG): Opening all GF detection circuits.
2025-09-15T01:55:34.847Z,1757901334.847 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-09-15T01:55:34.921Z,1757901334.921 [logger ThreadHandler](INFO): Thread cancelled.