2026-02-05T19:56:25.404Z,1770321385.404 [Supervisor](DEBUG): Initializing supervisor.
2026-02-05T19:56:25.408Z,1770321385.408 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2026-02-05T19:56:25.408Z,1770321385.408 [SyncHandler](INFO): Protected caller Thread ID is 2559
2026-02-05T19:56:25.409Z,1770321385.409 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2026-02-05T19:56:25.410Z,1770321385.410 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2026-02-05T19:56:25.410Z,1770321385.410 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 2560
2026-02-05T19:56:25.414Z,1770321385.414 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2026-02-05T19:56:25.433Z,1770321385.433 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2026-02-05T19:56:25.434Z,1770321385.434 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2026-02-05T19:56:25.435Z,1770321385.435 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 2561
2026-02-05T19:56:25.439Z,1770321385.439 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2026-02-05T19:56:25.440Z,1770321385.440 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2026-02-05T19:56:25.440Z,1770321385.440 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 2562
2026-02-05T19:56:25.442Z,1770321385.442 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2026-02-05T19:56:25.443Z,1770321385.443 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2026-02-05T19:56:25.444Z,1770321385.444 [logger ThreadHandler](INFO): Protected caller Thread ID is 2563
2026-02-05T19:56:25.447Z,1770321385.447 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2026-02-05T19:56:25.448Z,1770321385.448 [Supervisor](INFO): Looking for Config files in directory: Config/
2026-02-05T19:56:25.449Z,1770321385.449 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2026-02-05T19:56:25.776Z,1770321385.776 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2026-02-05T19:56:25.776Z,1770321385.776 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2026-02-05T19:56:25.875Z,1770321385.875 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Guidance
2026-02-05T19:56:25.876Z,1770321385.876 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2026-02-05T19:56:25.990Z,1770321385.990 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2026-02-05T19:56:25.991Z,1770321385.991 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2026-02-05T19:56:26.130Z,1770321386.130 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2026-02-05T19:56:26.130Z,1770321386.130 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2026-02-05T19:56:26.476Z,1770321386.476 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2026-02-05T19:56:26.477Z,1770321386.477 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2026-02-05T19:56:26.581Z,1770321386.581 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2026-02-05T19:56:26.581Z,1770321386.581 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2026-02-05T19:56:26.974Z,1770321386.974 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2026-02-05T19:56:26.974Z,1770321386.974 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2026-02-05T19:56:27.199Z,1770321387.199 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2026-02-05T19:56:27.199Z,1770321387.199 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2026-02-05T19:56:27.287Z,1770321387.287 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2026-02-05T19:56:27.533Z,1770321387.533 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2026-02-05T19:56:27.533Z,1770321387.533 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2026-02-05T19:56:27.769Z,1770321387.769 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2026-02-05T19:56:27.770Z,1770321387.770 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2026-02-05T19:56:28.306Z,1770321388.306 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2026-02-05T19:56:28.307Z,1770321388.307 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2026-02-05T19:56:28.491Z,1770321388.491 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2026-02-05T19:56:28.492Z,1770321388.492 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2026-02-05T19:56:28.774Z,1770321388.774 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2026-02-05T19:56:28.775Z,1770321388.775 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2026-02-05T19:56:29.594Z,1770321389.594 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2026-02-05T19:56:29.595Z,1770321389.595 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2026-02-05T19:56:30.142Z,1770321390.142 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2026-02-05T19:56:30.144Z,1770321390.144 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/
2026-02-05T19:56:30.145Z,1770321390.145 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Control.cfg
2026-02-05T19:56:30.249Z,1770321390.249 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Science.cfg
2026-02-05T19:56:30.384Z,1770321390.384 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/secure.cfg
2026-02-05T19:56:30.476Z,1770321390.476 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Servo.cfg
2026-02-05T19:56:30.590Z,1770321390.590 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/BIT.cfg
2026-02-05T19:56:30.691Z,1770321390.691 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Battery.cfg
2026-02-05T19:56:30.957Z,1770321390.957 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2026-02-05T19:56:30.957Z,1770321390.957 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/vehicle.cfg
2026-02-05T19:56:31.074Z,1770321391.074 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/logger.cfg
2026-02-05T19:56:31.178Z,1770321391.178 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Sensor.cfg
2026-02-05T19:56:31.323Z,1770321391.323 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Simulator.cfg
2026-02-05T19:56:31.418Z,1770321391.418 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/root/
2026-02-05T19:56:31.418Z,1770321391.418 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2026-02-05T19:56:31.428Z,1770321391.428 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2026-02-05T19:56:31.562Z,1770321391.562 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2026-02-05T19:56:31.563Z,1770321391.563 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2026-02-05T19:56:31.617Z,1770321391.617 [VerticalControl](DEBUG): Construct VerticalControl.
2026-02-05T19:56:31.677Z,1770321391.677 [VerticalControl] Loaded
2026-02-05T19:56:31.677Z,1770321391.677 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2026-02-05T19:56:31.680Z,1770321391.680 [HorizontalControl](DEBUG): Construct HorizontalControl.
2026-02-05T19:56:31.727Z,1770321391.727 [HorizontalControl] Loaded
2026-02-05T19:56:31.727Z,1770321391.727 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2026-02-05T19:56:31.730Z,1770321391.730 [SpeedControl](DEBUG): Construct SpeedControl.
2026-02-05T19:56:31.733Z,1770321391.733 [SpeedControl] Loaded
2026-02-05T19:56:31.733Z,1770321391.733 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2026-02-05T19:56:31.736Z,1770321391.736 [LoopControl](DEBUG): Construct LoopControl.
2026-02-05T19:56:31.736Z,1770321391.736 [LoopControl] Loaded
2026-02-05T19:56:31.736Z,1770321391.736 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2026-02-05T19:56:31.737Z,1770321391.737 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2026-02-05T19:56:31.737Z,1770321391.737 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2026-02-05T19:56:31.796Z,1770321391.796 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2026-02-05T19:56:31.797Z,1770321391.797 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2026-02-05T19:56:32.294Z,1770321392.294 [AHRS_M2] Loaded
2026-02-05T19:56:32.295Z,1770321392.295 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2026-02-05T19:56:32.333Z,1770321392.333 [BackseatComponent] Loaded
2026-02-05T19:56:32.334Z,1770321392.334 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2026-02-05T19:56:32.335Z,1770321392.335 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408BD4E0
2026-02-05T19:56:32.335Z,1770321392.335 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 2642
2026-02-05T19:56:32.338Z,1770321392.338 [LcmPublisher](INFO): Full slate access is ENABLED. All requested slate values (including non-universals) will be published on LCM.
2026-02-05T19:56:32.338Z,1770321392.338 [LcmPublisher] Loaded
2026-02-05T19:56:32.339Z,1770321392.339 [ComponentRegistry](DEBUG): SyncComponent "LcmPublisher" handled in the control thread.
2026-02-05T19:56:33.168Z,1770321393.168 [BPC1] Loaded
2026-02-05T19:56:33.169Z,1770321393.169 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2026-02-05T19:56:33.265Z,1770321393.265 [DAT] Loaded
2026-02-05T19:56:33.265Z,1770321393.265 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2026-02-05T19:56:33.266Z,1770321393.266 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 408ED4E0
2026-02-05T19:56:33.266Z,1770321393.266 [DAT ThreadHandler](INFO): Protected caller Thread ID is 2643
2026-02-05T19:56:33.340Z,1770321393.340 [DataOverHttps] Loaded
2026-02-05T19:56:33.340Z,1770321393.340 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2026-02-05T19:56:33.341Z,1770321393.341 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4091D4E0
2026-02-05T19:56:33.341Z,1770321393.341 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 2644
2026-02-05T19:56:33.364Z,1770321393.364 [Depth_Keller] Loaded
2026-02-05T19:56:33.364Z,1770321393.364 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2026-02-05T19:56:33.369Z,1770321393.369 [DropWeight] Loaded
2026-02-05T19:56:33.369Z,1770321393.369 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2026-02-05T19:56:33.433Z,1770321393.433 [NAL9602] Loaded
2026-02-05T19:56:33.434Z,1770321393.434 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2026-02-05T19:56:33.463Z,1770321393.463 [Onboard] Loaded
2026-02-05T19:56:33.463Z,1770321393.463 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2026-02-05T19:56:33.464Z,1770321393.464 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4094D4E0
2026-02-05T19:56:33.465Z,1770321393.465 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 2645
2026-02-05T19:56:33.478Z,1770321393.478 [Power24vConverter] Loaded
2026-02-05T19:56:33.479Z,1770321393.479 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2026-02-05T19:56:33.494Z,1770321393.494 [Radio_Surface] Loaded
2026-02-05T19:56:33.495Z,1770321393.495 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2026-02-05T19:56:33.496Z,1770321393.496 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4097D4E0
2026-02-05T19:56:33.496Z,1770321393.496 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 2646
2026-02-05T19:56:33.511Z,1770321393.511 [Sonardyne_Nano] Loaded
2026-02-05T19:56:33.511Z,1770321393.511 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2026-02-05T19:56:33.512Z,1770321393.512 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2026-02-05T19:56:33.512Z,1770321393.512 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2026-02-05T19:56:33.522Z,1770321393.522 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2026-02-05T19:56:33.523Z,1770321393.523 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2026-02-05T19:56:33.552Z,1770321393.552 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2026-02-05T19:56:33.552Z,1770321393.552 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2026-02-05T19:56:33.713Z,1770321393.713 [SBIT](DEBUG): Construct Startup Built In Test.
2026-02-05T19:56:33.722Z,1770321393.722 [SBIT] Loaded
2026-02-05T19:56:33.722Z,1770321393.722 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2026-02-05T19:56:33.725Z,1770321393.725 [IBIT](DEBUG): Construct Initiated Built In Test.
2026-02-05T19:56:33.738Z,1770321393.738 [IBIT] Loaded
2026-02-05T19:56:33.738Z,1770321393.738 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2026-02-05T19:56:33.743Z,1770321393.743 [CBIT](DEBUG): Construct Continuous Built In Test.
2026-02-05T19:56:33.822Z,1770321393.822 [CBIT] Loaded
2026-02-05T19:56:33.822Z,1770321393.822 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2026-02-05T19:56:33.855Z,1770321393.855 [GFScanner] Loaded
2026-02-05T19:56:33.855Z,1770321393.855 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread.
2026-02-05T19:56:33.856Z,1770321393.856 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2026-02-05T19:56:33.856Z,1770321393.856 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2026-02-05T19:56:34.197Z,1770321394.197 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2026-02-05T19:56:34.198Z,1770321394.198 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2026-02-05T19:56:34.258Z,1770321394.258 [DepthRateCalculator] Loaded
2026-02-05T19:56:34.258Z,1770321394.258 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2026-02-05T19:56:34.263Z,1770321394.263 [PitchRateCalculator] Loaded
2026-02-05T19:56:34.264Z,1770321394.264 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2026-02-05T19:56:34.274Z,1770321394.274 [SpeedCalculator] Loaded
2026-02-05T19:56:34.274Z,1770321394.274 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2026-02-05T19:56:34.278Z,1770321394.278 [YawRateCalculator] Loaded
2026-02-05T19:56:34.278Z,1770321394.278 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2026-02-05T19:56:34.297Z,1770321394.297 [ElevatorOffsetCalculator] Loaded
2026-02-05T19:56:34.298Z,1770321394.298 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2026-02-05T19:56:34.298Z,1770321394.298 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2026-02-05T19:56:34.299Z,1770321394.299 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2026-02-05T19:56:34.475Z,1770321394.475 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2026-02-05T19:56:34.475Z,1770321394.475 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2026-02-05T19:56:34.587Z,1770321394.587 [DeadReckonUsingMultipleVelocitySources] Loaded
2026-02-05T19:56:34.587Z,1770321394.587 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2026-02-05T19:56:34.601Z,1770321394.601 [NavChart] Loaded
2026-02-05T19:56:34.602Z,1770321394.602 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2026-02-05T19:56:34.607Z,1770321394.607 [UniversalFixResidualReporter] Loaded
2026-02-05T19:56:34.608Z,1770321394.608 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2026-02-05T19:56:34.608Z,1770321394.608 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2026-02-05T19:56:34.608Z,1770321394.608 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2026-02-05T19:56:34.744Z,1770321394.744 [BuoyancyServo] Loaded
2026-02-05T19:56:34.744Z,1770321394.744 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2026-02-05T19:56:34.767Z,1770321394.767 [ElevatorServo] Loaded
2026-02-05T19:56:34.768Z,1770321394.768 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2026-02-05T19:56:34.789Z,1770321394.789 [MassServo] Loaded
2026-02-05T19:56:34.789Z,1770321394.789 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2026-02-05T19:56:34.810Z,1770321394.810 [RudderServo] Loaded
2026-02-05T19:56:34.810Z,1770321394.810 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2026-02-05T19:56:34.827Z,1770321394.827 [ThrusterHE] Loaded
2026-02-05T19:56:34.827Z,1770321394.827 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2026-02-05T19:56:34.828Z,1770321394.828 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2026-02-05T19:56:34.828Z,1770321394.828 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2026-02-05T19:56:35.000Z,1770321395.000 [CTD_Seabird] Loaded
2026-02-05T19:56:35.001Z,1770321395.001 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2026-02-05T19:56:35.002Z,1770321395.002 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40C0D4E0
2026-02-05T19:56:35.002Z,1770321395.002 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 2647
2026-02-05T19:56:35.039Z,1770321395.039 [ESPComponent] Loaded
2026-02-05T19:56:35.039Z,1770321395.039 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2026-02-05T19:56:35.061Z,1770321395.061 [PAR_Licor] Loaded
2026-02-05T19:56:35.061Z,1770321395.061 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2026-02-05T19:56:35.106Z,1770321395.106 [WetLabsBB2FL] Loaded
2026-02-05T19:56:35.106Z,1770321395.106 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2026-02-05T19:56:35.107Z,1770321395.107 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40C3D4E0
2026-02-05T19:56:35.108Z,1770321395.108 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 2648
2026-02-05T19:56:35.108Z,1770321395.108 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2026-02-05T19:56:35.115Z,1770321395.115 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2026-02-05T19:56:35.118Z,1770321395.118 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2026-02-05T19:56:35.129Z,1770321395.129 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2026-02-05T19:56:35.130Z,1770321395.130 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C6D4E0
2026-02-05T19:56:35.130Z,1770321395.130 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 2649
2026-02-05T19:56:35.135Z,1770321395.135 [Supervisor](INFO): Main Thread ID is 827
2026-02-05T19:56:35.135Z,1770321395.135 [Supervisor](DEBUG): Running supervisor.
2026-02-05T19:56:35.135Z,1770321395.135 [CommandExec ThreadHandler](INFO): Handler Thread ID is 2650
2026-02-05T19:56:35.136Z,1770321395.136 [CommandExec](INFO): Initializing the command executive.
2026-02-05T19:56:35.138Z,1770321395.138 [CommandLine ThreadHandler](INFO): Handler Thread ID is 2651
2026-02-05T19:56:35.141Z,1770321395.141 [controlThread ThreadHandler](INFO): Handler Thread ID is 2652
2026-02-05T19:56:35.141Z,1770321395.141 [controlThread](DEBUG): Initializing ControlThread
2026-02-05T19:56:35.142Z,1770321395.142 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2026-02-05T19:56:35.144Z,1770321395.144 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2026-02-05T19:56:35.144Z,1770321395.144 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2026-02-05T19:56:35.145Z,1770321395.145 [LoopControl](DEBUG): Initialize LoopControlComponent.
2026-02-05T19:56:35.148Z,1770321395.148 [SBIT](INFO): Initialize SBIT Component.
2026-02-05T19:56:35.148Z,1770321395.148 [SBIT](IMPORTANT): git: 2026-02-05
2026-02-05T19:56:35.149Z,1770321395.149 [SBIT](INFO): git hash: 2c49374f7e1dd0ac66edaf2b178ef330b988eff4
2026-02-05T19:56:35.149Z,1770321395.149 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2026-02-05T19:56:35.150Z,1770321395.150 [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
2026-02-05T19:56:35.151Z,1770321395.151 [SBIT](INFO): Beginning SBIT in 59.000000 seconds.
2026-02-05T19:56:35.152Z,1770321395.152 [IBIT](INFO): Initialize IBIT Component.
2026-02-05T19:56:35.153Z,1770321395.153 [CBIT](DEBUG): Initialize CBIT Component.
2026-02-05T19:56:35.154Z,1770321395.154 [logger ThreadHandler](INFO): Handler Thread ID is 2653
2026-02-05T19:56:35.165Z,1770321395.165 [CBIT](DEBUG): Initialized mux pins.
2026-02-05T19:56:35.165Z,1770321395.165 [CBIT](DEBUG): Initializing the watchdog timer.
2026-02-05T19:56:35.173Z,1770321395.173 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 2654
2026-02-05T19:56:35.189Z,1770321395.189 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2026-02-05T19:56:35.189Z,1770321395.189 [CBIT](DEBUG): Initializing heartbeat.
2026-02-05T19:56:35.190Z,1770321395.190 [DAT ThreadHandler](INFO): Handler Thread ID is 2655
2026-02-05T19:56:35.191Z,1770321395.191 [DAT](INFO): Powering up
2026-02-05T19:56:35.191Z,1770321395.191 [DAT](DEBUG): Initializing DAT.
2026-02-05T19:56:35.194Z,1770321395.194 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 2657
2026-02-05T19:56:35.196Z,1770321395.196 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2026-02-05T19:56:35.217Z,1770321395.217 [Onboard ThreadHandler](INFO): Handler Thread ID is 2658
2026-02-05T19:56:35.235Z,1770321395.235 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 2659
2026-02-05T19:56:35.253Z,1770321395.253 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 2660
2026-02-05T19:56:35.254Z,1770321395.254 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2026-02-05T19:56:35.258Z,1770321395.258 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 2662
2026-02-05T19:56:35.261Z,1770321395.261 [CBIT](DEBUG): Deactivating emergency mode.
2026-02-05T19:56:35.262Z,1770321395.262 [WetLabsBB2FL](INFO): Powering up
2026-02-05T19:56:35.263Z,1770321395.263 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 2664
2026-02-05T19:56:35.265Z,1770321395.265 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2026-02-05T19:56:35.266Z,1770321395.266 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2026-02-05T19:56:35.266Z,1770321395.266 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2026-02-05T19:56:35.266Z,1770321395.266 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2026-02-05T19:56:35.266Z,1770321395.266 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2026-02-05T19:56:35.266Z,1770321395.266 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2026-02-05T19:56:35.267Z,1770321395.267 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2026-02-05T19:56:35.267Z,1770321395.267 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2026-02-05T19:56:35.301Z,1770321395.301 [CBIT](DEBUG): Backplane powered.
2026-02-05T19:56:35.301Z,1770321395.301 [GFScanner](DEBUG): Initializing GFScanner
2026-02-05T19:56:35.301Z,1770321395.301 [GFScanner](DEBUG): Deactivating GF circuits.
2026-02-05T19:56:35.306Z,1770321395.306 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2026-02-05T19:56:35.306Z,1770321395.306 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2026-02-05T19:56:35.306Z,1770321395.306 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2026-02-05T19:56:35.307Z,1770321395.307 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2026-02-05T19:56:35.307Z,1770321395.307 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2026-02-05T19:56:35.308Z,1770321395.308 [NavChart](DEBUG): Initialize NavChart Navigation.
2026-02-05T19:56:35.309Z,1770321395.309 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2026-02-05T19:56:35.322Z,1770321395.322 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2026-02-05T19:56:35.322Z,1770321395.322 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2026-02-05T19:56:35.323Z,1770321395.323 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2026-02-05T19:56:35.324Z,1770321395.324 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2026-02-05T19:56:35.392Z,1770321395.392 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
2026-02-05T19:56:35.417Z,1770321395.417 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2026-02-05T19:56:35.463Z,1770321395.463 [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
}
}
}
2026-02-05T19:56:35.464Z,1770321395.464 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2026-02-05T19:56:35.464Z,1770321395.464 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2026-02-05T19:56:35.465Z,1770321395.465 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2026-02-05T19:56:35.641Z,1770321395.641 [Radio_Surface](INFO): Powering up
2026-02-05T19:56:35.768Z,1770321395.768 [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
2026-02-05T19:56:35.790Z,1770321395.790 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2026-02-05T19:56:35.791Z,1770321395.791 [Default:A.Wait](DEBUG): Construct Wait.
2026-02-05T19:56:35.810Z,1770321395.810 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2026-02-05T19:56:35.856Z,1770321395.856 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2026-02-05T19:56:35.859Z,1770321395.859 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2026-02-05T19:56:35.877Z,1770321395.877 [Default:E.Execute](DEBUG): Construct Execute.
2026-02-05T19:56:35.880Z,1770321395.880 [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"
}
}
2026-02-05T19:56:35.893Z,1770321395.893 [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,
2026-02-05T19:56:35.909Z,1770321395.909 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2026-02-05T19:56:35.966Z,1770321395.966 [Depth_Keller](INFO): Initializing.
2026-02-05T19:56:35.967Z,1770321395.967 [Power24vConverter](INFO): Powering up.
2026-02-05T19:56:35.968Z,1770321395.968 [Sonardyne_Nano](INFO): Initializing.
2026-02-05T19:56:36.009Z,1770321396.009 [DepthRateCalculator](ERROR): Depth measurement is not active
2026-02-05T19:56:36.036Z,1770321396.036 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2026-02-05T19:56:36.041Z,1770321396.041 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2026-02-05T19:56:36.042Z,1770321396.042 [ElevatorServo](DEBUG): Initializing EZServoServo.
2026-02-05T19:56:36.049Z,1770321396.049 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2026-02-05T19:56:36.050Z,1770321396.050 [MassServo](DEBUG): Initializing EZServoServo.
2026-02-05T19:56:36.057Z,1770321396.057 [MassServo](DEBUG): Initializing MassServo.
2026-02-05T19:56:36.058Z,1770321396.058 [RudderServo](DEBUG): Initializing EZServoServo.
2026-02-05T19:56:36.065Z,1770321396.065 [RudderServo](DEBUG): Initializing RudderServo.
2026-02-05T19:56:36.066Z,1770321396.066 [ThrusterHE](DEBUG): Initializing EZServoServo.
2026-02-05T19:56:36.073Z,1770321396.073 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2026-02-05T19:56:36.346Z,1770321396.346 [DropWeight](CRITICAL): DROP WEIGHT MISSING.
2026-02-05T19:56:36.347Z,1770321396.346 [DropWeight] Hardware Fault, FailCount= 1
2026-02-05T19:56:36.347Z,1770321396.347 [DropWeight](ERROR): Hardware Fault
2026-02-05T19:56:36.387Z,1770321396.387 [CommandExec](FAULT): Scheduling is paused
2026-02-05T19:56:36.388Z,1770321396.388 [CBIT](INFO): Critical error at 20260205T195636
2026-02-05T19:56:36.388Z,1770321396.388 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2026-02-05T19:56:36.399Z,1770321396.399 [CBIT](ERROR): Hardware Fault in component: DropWeight
2026-02-05T19:56:36.399Z,1770321396.399 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2026-02-05T19:56:36.739Z,1770321396.739 [CBIT](INFO): Critical error at 20260205T195636
2026-02-05T19:56:37.873Z,1770321397.873 [WetLabsBB2FL](INFO): Powering down
2026-02-05T19:56:37.923Z,1770321397.923 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART
2026-02-05T19:56:39.210Z,1770321399.210 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2311
2026-02-05T19:56:41.791Z,1770321401.791 [ThrusterHE](ERROR): Zero Speed Commanded.
2026-02-05T19:56:47.538Z,1770321407.538 [DAT](INFO): DAT read:
2026-02-05T19:56:47.539Z,1770321407.539 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series
2026-02-05T19:56:49.303Z,1770321409.303 [DAT](INFO): DAT read: MF Frequency Band
2026-02-05T19:56:49.304Z,1770321409.304 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0
2026-02-05T19:56:49.305Z,1770321409.305 [DAT](INFO): DAT read: Feb 5 2026 19:56:43
2026-02-05T19:56:50.310Z,1770321410.310 [DAT](INFO): DAT read: Features enabled [Bearing]
2026-02-05T19:56:50.311Z,1770321410.311 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
2026-02-05T19:56:50.312Z,1770321410.312 [DAT](INFO): commRate: 800
2026-02-05T19:56:52.377Z,1770321412.377 [DAT](INFO): entering command mode
2026-02-05T19:56:52.578Z,1770321412.578 [DAT](INFO): DAT read:
2026-02-05T19:56:52.578Z,1770321412.578 [DAT](INFO): DAT read: user:1>
2026-02-05T19:56:52.579Z,1770321412.579 [DAT](INFO): setting verbose to 3
2026-02-05T19:56:52.830Z,1770321412.830 [DAT](INFO): DAT read: user:1>
2026-02-05T19:56:52.831Z,1770321412.831 [DAT](INFO): DAT read: Verbose | 3
2026-02-05T19:56:52.831Z,1770321412.831 [DAT](INFO): set verbose to 3
2026-02-05T19:56:52.831Z,1770321412.831 [DAT](INFO): setting DatVerbose to 27440
2026-02-05T19:56:53.082Z,1770321413.082 [DAT](INFO): DAT read: user:2>
2026-02-05T19:56:53.083Z,1770321413.083 [DAT](INFO): DAT read: DatVerbose | 27440
2026-02-05T19:56:53.083Z,1770321413.083 [DAT](INFO): set DatVerbose to 27440
2026-02-05T19:56:53.083Z,1770321413.083 [DAT](INFO): setting transmit power to 8
2026-02-05T19:56:53.334Z,1770321413.334 [DAT](INFO): DAT read: user:3>
2026-02-05T19:56:53.335Z,1770321413.335 [DAT](INFO): DAT read: TxPower | 8 (Max)
2026-02-05T19:56:53.335Z,1770321413.335 [DAT](INFO): set transmit power to 8
2026-02-05T19:56:53.335Z,1770321413.335 [DAT](INFO): setting local address to 1
2026-02-05T19:56:53.586Z,1770321413.586 [DAT](INFO): DAT read: user:4>
2026-02-05T19:56:53.587Z,1770321413.587 [DAT](INFO): DAT read: LocalAddr | 1
2026-02-05T19:56:53.587Z,1770321413.587 [DAT](INFO): set local address to 1
2026-02-05T19:56:53.588Z,1770321413.588 [DAT](INFO): Setting time to: 19:56:53 And date to:2/5/2026
2026-02-05T19:56:53.838Z,1770321413.838 [DAT](INFO): DAT read: user:5>
2026-02-05T19:56:53.839Z,1770321413.839 [DAT](INFO): DAT read: Thu Feb 5, 2026 19:56:53
2026-02-05T19:56:53.839Z,1770321413.839 [DAT](INFO): Local DAT time set to Thu Feb 5, 2026 19:56:53
2026-02-05T19:57:03.835Z,1770321423.835 [NAL9602](INFO): Powering up NAL9602
2026-02-05T19:57:14.735Z,1770321434.735 [NAL9602](INFO): NAL9602 initialized
2026-02-05T19:57:34.964Z,1770321454.964 [SBIT](IMPORTANT): Beginning Startup BIT
2026-02-05T19:57:34.969Z,1770321454.969 [GFScanner](IMPORTANT): Beginning ground fault scan
2026-02-05T19:57:39.513Z,1770321459.513 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.000155
CHAN A1 (24V): 0.000939
CHAN A2 (12V): -0.000325
CHAN A3 (5V): -0.001509
CHAN B0 (3.3V): 0.000382
CHAN B1 (3.15aV): 0.000051
CHAN B2 (3.15bV): -0.000316
CHAN B3 (GND): -0.000245
OPEN: 0.006322
Full Scale: +/- 1 mA
2026-02-05T19:58:28.728Z,1770321508.728 [SBIT](IMPORTANT): SBIT PASSED
2026-02-05T19:58:28.728Z,1770321508.728 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2026-02-05T19:58:28.729Z,1770321508.729 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=19 count;
2026-02-05T19:58:28.729Z,1770321508.729 [SBIT](IMPORTANT): BackseatComponent.fullSlateAccess=1 bool;
2026-02-05T19:58:28.729Z,1770321508.729 [SBIT](IMPORTANT): DAT.surfaceThreshold=-0.5 meter;
2026-02-05T19:58:28.729Z,1770321508.729 [SBIT](IMPORTANT): Express linearApproximation PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 100.000000 micromole_per_second_per_square_meter;
2026-02-05T19:58:28.729Z,1770321508.729 [SBIT](IMPORTANT): Express linearApproximation TrackAcousticContact.range_to_contact 15.000000 meter;
2026-02-05T19:58:28.730Z,1770321508.730 [SBIT](IMPORTANT): Express linearApproximation _.planktivore_HM_AvgRois 2.000000 count_per_second;
2026-02-05T19:58:28.730Z,1770321508.730 [SBIT](IMPORTANT): Express linearApproximation _.planktivore_LM_AvgRois 100.000000 count_per_second;
2026-02-05T19:58:28.730Z,1770321508.730 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=187.304467 cubic_centimeter;
2026-02-05T19:58:28.730Z,1770321508.730 [SBIT](IMPORTANT): VerticalControl.massDefault=-1 centimeter;
2026-02-05T19:58:28.730Z,1770321508.730 [SBIT](IMPORTANT): Waterlinked.loadAtStartup=0 bool;
2026-02-05T19:58:29.138Z,1770321509.138 [MissionManager](IMPORTANT): Started mission Startup
2026-02-05T19:58:29.138Z,1770321509.138 [Startup] Running Loop=1
2026-02-05T19:58:29.138Z,1770321509.138 [Startup](DEBUG): Aggregate::initialize Startup
2026-02-05T19:58:29.139Z,1770321509.139 [Startup:A.GoToSurface] Running Loop=1
2026-02-05T19:58:29.139Z,1770321509.139 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2026-02-05T19:58:29.139Z,1770321509.139 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2026-02-05T19:58:29.140Z,1770321509.140 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2026-02-05T19:58:29.140Z,1770321509.140 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2026-02-05T19:58:29.140Z,1770321509.140 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2026-02-05T19:58:29.141Z,1770321509.141 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2026-02-05T19:58:29.141Z,1770321509.141 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2026-02-05T19:58:29.142Z,1770321509.142 [Startup:StartupSatComms] Running Loop=1
2026-02-05T19:58:29.143Z,1770321509.143 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2026-02-05T19:58:29.143Z,1770321509.143 [Startup:StartupSatComms:A] Running Loop=1
2026-02-05T19:58:29.531Z,1770321509.531 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2026-02-05T19:59:29.332Z,1770321569.332 [Startup:StartupSatComms:A](INFO): Timed out from 2026-02-05T19:58:29.1Z
2026-02-05T19:59:29.332Z,1770321569.332 [Startup:StartupSatComms:A] Stopped
2026-02-05T19:59:29.332Z,1770321569.332 [Startup:StartupSatComms:B] Running Loop=1
2026-02-05T19:59:29.740Z,1770321569.740 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2026-02-05T19:59:35.405Z,1770321575.405 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2026-02-05T19:59:35.405Z,1770321575.405 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2026-02-05T19:59:35.415Z,1770321575.415 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2026-02-05T19:59:35.795Z,1770321575.795 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2026-02-05T19:59:35.795Z,1770321575.795 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2026-02-05T20:00:20.459Z,1770321620.459 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004212
2026-02-05T20:00:29.535Z,1770321629.535 [Startup:StartupSatComms:B](INFO): Timed out from 2026-02-05T19:59:29.3Z
2026-02-05T20:00:29.535Z,1770321629.535 [Startup:StartupSatComms:B] Stopped
2026-02-05T20:00:29.535Z,1770321629.535 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2026-02-05T20:00:29.535Z,1770321629.535 [Startup:StartupSatComms] Stopped
2026-02-05T20:00:29.535Z,1770321629.535 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2026-02-05T20:00:29.536Z,1770321629.536 [Startup](INFO): Completed Startup
2026-02-05T20:00:29.536Z,1770321629.536 [MissionManager](INFO): Startup is completed.
2026-02-05T20:00:29.536Z,1770321629.536 [MissionManager](INFO): Uninitializing Mission Startup
2026-02-05T20:00:29.536Z,1770321629.536 [Startup] Stopped
2026-02-05T20:00:29.536Z,1770321629.536 [Startup](DEBUG): Aggregate::uninitialize Startup
2026-02-05T20:00:29.537Z,1770321629.537 [Startup:A.GoToSurface] Stopped
2026-02-05T20:00:29.537Z,1770321629.537 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2026-02-05T20:00:30.012Z,1770321630.012 [MissionManager](IMPORTANT): Started mission Default
2026-02-05T20:00:30.046Z,1770321630.046 [Default] Running Loop=1
2026-02-05T20:00:30.046Z,1770321630.046 [Default](DEBUG): Aggregate::initialize Default
2026-02-05T20:00:30.046Z,1770321630.046 [Default:B.GoToSurface] Running Loop=1
2026-02-05T20:00:30.046Z,1770321630.046 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2026-02-05T20:00:30.047Z,1770321630.047 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2026-02-05T20:00:30.047Z,1770321630.047 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2026-02-05T20:00:30.047Z,1770321630.047 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2026-02-05T20:00:30.047Z,1770321630.047 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2026-02-05T20:00:30.048Z,1770321630.048 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2026-02-05T20:00:30.048Z,1770321630.048 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2026-02-05T20:00:30.048Z,1770321630.048 [Default:A.Wait] Running Loop=1
2026-02-05T20:00:30.048Z,1770321630.048 [Default:A.Wait](DEBUG): Initialize Wait Component.
2026-02-05T20:00:43.298Z,1770321643.298 [Default:A.Wait](INFO): Done Waiting.
2026-02-05T20:00:43.298Z,1770321643.298 [Default:A.Wait] Stopped
2026-02-05T20:00:43.298Z,1770321643.298 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2026-02-05T20:00:43.687Z,1770321643.687 [Default:CheckIn] Running Loop=1
2026-02-05T20:00:43.687Z,1770321643.687 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2026-02-05T20:00:43.687Z,1770321643.687 [Default:CheckIn:Read_GPS] Running Loop=1
2026-02-05T20:00:44.085Z,1770321644.085 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2026-02-05T20:00:52.030Z,1770321652.030 [CommandExec](IMPORTANT): got command failComponent
2026-02-05T20:00:52.030Z,1770321652.030 [CommandExec](IMPORTANT): Failed components:
2026-02-05T20:00:52.030Z,1770321652.030 [CommandExec](IMPORTANT): DropWeight: Hardware Fault
2026-02-05T20:01:11.694Z,1770321671.694 [CommandExec](IMPORTANT): got command failComponent
2026-02-05T20:01:11.694Z,1770321671.694 [CommandExec](IMPORTANT): Failed components:
2026-02-05T20:01:11.694Z,1770321671.694 [CommandExec](IMPORTANT): DropWeight: Hardware Fault
2026-02-05T20:01:15.230Z,1770321675.230 [CommandExec](IMPORTANT): got command burn off
2026-02-05T20:01:15.230Z,1770321675.230 [CommandExec](IMPORTANT): Deactivating dropweight wire
2026-02-05T20:01:18.153Z,1770321678.153 [CommandExec](IMPORTANT): got command failComponent
2026-02-05T20:01:18.154Z,1770321678.154 [CommandExec](IMPORTANT): Failed components:
2026-02-05T20:01:18.154Z,1770321678.154 [CommandExec](IMPORTANT): DropWeight: Hardware Fault
2026-02-05T20:02:07.278Z,1770321727.278 [CommandExec](IMPORTANT): got command restart system
2026-02-05T20:02:09.345Z,1770321729.345 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2026-02-05T20:02:09.345Z,1770321729.345 [CommandExec](INFO): Uninitializing the command executive.
2026-02-05T20:02:09.346Z,1770321729.346 [CommandExec](INFO): Uninitializing the command scheduler.
2026-02-05T20:02:09.346Z,1770321729.346 [CommandExec ThreadHandler](INFO): Thread cancelled.
2026-02-05T20:02:09.457Z,1770321729.457 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2026-02-05T20:02:09.458Z,1770321729.458 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2026-02-05T20:02:09.458Z,1770321729.458 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2026-02-05T20:02:09.458Z,1770321729.458 [NavChartDb](INFO): Join timeout helper Thread ID is 2699
2026-02-05T20:02:09.666Z,1770321729.666 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2026-02-05T20:02:09.666Z,1770321729.666 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2026-02-05T20:02:09.681Z,1770321729.681 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2026-02-05T20:02:09.681Z,1770321729.681 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2026-02-05T20:02:09.682Z,1770321729.682 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 2700
2026-02-05T20:02:10.090Z,1770321730.090 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2026-02-05T20:02:10.090Z,1770321730.090 [WetLabsBB2FL](INFO): Powering down
2026-02-05T20:02:10.091Z,1770321730.091 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2026-02-05T20:02:10.093Z,1770321730.093 [ComponentRegistry]