2026-01-12T18:11:33.912Z,1768241493.912 [Supervisor](DEBUG): Initializing supervisor.
2026-01-12T18:11:33.916Z,1768241493.916 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2026-01-12T18:11:33.917Z,1768241493.917 [SyncHandler](INFO): Protected caller Thread ID is 3590
2026-01-12T18:11:33.917Z,1768241493.917 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2026-01-12T18:11:33.918Z,1768241493.918 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2026-01-12T18:11:33.919Z,1768241493.919 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 3591
2026-01-12T18:11:33.923Z,1768241493.923 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2026-01-12T18:11:33.942Z,1768241493.942 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2026-01-12T18:11:33.943Z,1768241493.943 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2026-01-12T18:11:33.943Z,1768241493.943 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 3592
2026-01-12T18:11:33.947Z,1768241493.947 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2026-01-12T18:11:33.948Z,1768241493.948 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2026-01-12T18:11:33.948Z,1768241493.948 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 3593
2026-01-12T18:11:33.951Z,1768241493.951 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2026-01-12T18:11:33.951Z,1768241493.951 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2026-01-12T18:11:33.952Z,1768241493.952 [logger ThreadHandler](INFO): Protected caller Thread ID is 3594
2026-01-12T18:11:33.955Z,1768241493.955 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2026-01-12T18:11:33.956Z,1768241493.956 [Supervisor](INFO): Looking for Config files in directory: Config/
2026-01-12T18:11:33.961Z,1768241493.961 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2026-01-12T18:11:34.122Z,1768241494.122 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2026-01-12T18:11:34.124Z,1768241494.124 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2026-01-12T18:11:34.362Z,1768241494.362 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2026-01-12T18:11:34.363Z,1768241494.363 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2026-01-12T18:11:34.633Z,1768241494.633 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2026-01-12T18:11:34.634Z,1768241494.634 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2026-01-12T18:11:34.750Z,1768241494.750 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2026-01-12T18:11:34.752Z,1768241494.752 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2026-01-12T18:11:35.511Z,1768241495.511 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2026-01-12T18:11:35.511Z,1768241495.511 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2026-01-12T18:11:36.032Z,1768241496.032 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2026-01-12T18:11:36.032Z,1768241496.032 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2026-01-12T18:11:36.572Z,1768241496.572 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2026-01-12T18:11:36.574Z,1768241496.574 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2026-01-12T18:11:36.998Z,1768241496.998 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2026-01-12T18:11:36.000Z,1768241497.000 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2026-01-12T18:11:37.350Z,1768241497.350 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2026-01-12T18:11:37.352Z,1768241497.352 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2026-01-12T18:11:37.744Z,1768241497.744 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2026-01-12T18:11:37.745Z,1768241497.745 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2026-01-12T18:11:38.014Z,1768241498.014 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2026-01-12T18:11:38.194Z,1768241498.194 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2026-01-12T18:11:38.659Z,1768241498.659 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2026-01-12T18:11:38.660Z,1768241498.660 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2026-01-12T18:11:38.764Z,1768241498.764 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Guidance
2026-01-12T18:11:38.764Z,1768241498.764 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2026-01-12T18:11:38.854Z,1768241498.854 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2026-01-12T18:11:39.047Z,1768241499.047 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2026-01-12T18:11:39.047Z,1768241499.047 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2026-01-12T18:11:39.300Z,1768241499.300 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2026-01-12T18:11:39.303Z,1768241499.303 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2026-01-12T18:11:39.305Z,1768241499.305 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2026-01-12T18:11:39.399Z,1768241499.399 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2026-01-12T18:11:39.671Z,1768241499.671 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2026-01-12T18:11:39.672Z,1768241499.672 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2026-01-12T18:11:39.768Z,1768241499.768 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2026-01-12T18:11:39.948Z,1768241499.948 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2026-01-12T18:11:40.059Z,1768241500.059 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2026-01-12T18:11:40.178Z,1768241500.178 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2026-01-12T18:11:40.298Z,1768241500.298 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2026-01-12T18:11:40.402Z,1768241500.402 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2026-01-12T18:11:40.570Z,1768241500.570 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Derivation.cfg
2026-01-12T18:11:40.677Z,1768241500.677 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/workSite.cfg
2026-01-12T18:11:40.772Z,1768241500.772 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2026-01-12T18:11:40.880Z,1768241500.880 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2026-01-12T18:11:40.978Z,1768241500.978 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/
2026-01-12T18:11:40.978Z,1768241500.978 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2026-01-12T18:11:40.989Z,1768241500.989 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2026-01-12T18:11:41.196Z,1768241501.196 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2026-01-12T18:11:41.196Z,1768241501.196 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2026-01-12T18:11:41.382Z,1768241501.382 [BuoyancyServo] Loaded
2026-01-12T18:11:41.383Z,1768241501.383 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2026-01-12T18:11:41.406Z,1768241501.406 [ElevatorServo] Loaded
2026-01-12T18:11:41.406Z,1768241501.406 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2026-01-12T18:11:41.428Z,1768241501.428 [MassServo] Loaded
2026-01-12T18:11:41.428Z,1768241501.428 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2026-01-12T18:11:41.450Z,1768241501.450 [RudderServo] Loaded
2026-01-12T18:11:41.450Z,1768241501.450 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2026-01-12T18:11:41.468Z,1768241501.468 [ThrusterHE] Loaded
2026-01-12T18:11:41.468Z,1768241501.468 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2026-01-12T18:11:41.469Z,1768241501.469 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2026-01-12T18:11:41.469Z,1768241501.469 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2026-01-12T18:11:41.656Z,1768241501.656 [SBIT](DEBUG): Construct Startup Built In Test.
2026-01-12T18:11:41.671Z,1768241501.671 [SBIT] Loaded
2026-01-12T18:11:41.671Z,1768241501.671 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2026-01-12T18:11:41.674Z,1768241501.674 [IBIT](DEBUG): Construct Initiated Built In Test.
2026-01-12T18:11:41.694Z,1768241501.694 [IBIT] Loaded
2026-01-12T18:11:41.695Z,1768241501.694 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2026-01-12T18:11:41.700Z,1768241501.700 [CBIT](DEBUG): Construct Continuous Built In Test.
2026-01-12T18:11:41.894Z,1768241501.894 [CBIT] Loaded
2026-01-12T18:11:41.895Z,1768241501.895 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2026-01-12T18:11:41.925Z,1768241501.925 [GFScanner] Loaded
2026-01-12T18:11:41.926Z,1768241501.926 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread.
2026-01-12T18:11:41.926Z,1768241501.926 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2026-01-12T18:11:41.927Z,1768241501.927 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2026-01-12T18:11:42.131Z,1768241502.131 [CTD_Seabird] Loaded
2026-01-12T18:11:42.132Z,1768241502.132 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2026-01-12T18:11:42.133Z,1768241502.133 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406874E0
2026-01-12T18:11:42.133Z,1768241502.133 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 3682
2026-01-12T18:11:42.168Z,1768241502.168 [ESPComponent] Loaded
2026-01-12T18:11:42.168Z,1768241502.168 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2026-01-12T18:11:42.190Z,1768241502.190 [PAR_Licor] Loaded
2026-01-12T18:11:42.190Z,1768241502.190 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2026-01-12T18:11:42.233Z,1768241502.233 [WetLabsBB2FL] Loaded
2026-01-12T18:11:42.234Z,1768241502.234 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2026-01-12T18:11:42.235Z,1768241502.235 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406B74E0
2026-01-12T18:11:42.235Z,1768241502.235 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 3683
2026-01-12T18:11:42.236Z,1768241502.236 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2026-01-12T18:11:42.236Z,1768241502.236 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2026-01-12T18:11:42.303Z,1768241502.303 [DepthRateCalculator] Loaded
2026-01-12T18:11:42.303Z,1768241502.303 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2026-01-12T18:11:42.308Z,1768241502.308 [PitchRateCalculator] Loaded
2026-01-12T18:11:42.309Z,1768241502.309 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2026-01-12T18:11:42.319Z,1768241502.319 [SpeedCalculator] Loaded
2026-01-12T18:11:42.319Z,1768241502.319 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2026-01-12T18:11:42.324Z,1768241502.324 [YawRateCalculator] Loaded
2026-01-12T18:11:42.324Z,1768241502.324 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2026-01-12T18:11:42.343Z,1768241502.343 [ElevatorOffsetCalculator] Loaded
2026-01-12T18:11:42.344Z,1768241502.344 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2026-01-12T18:11:42.344Z,1768241502.344 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2026-01-12T18:11:42.345Z,1768241502.345 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2026-01-12T18:11:42.505Z,1768241502.505 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2026-01-12T18:11:42.505Z,1768241502.505 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2026-01-12T18:11:42.548Z,1768241502.548 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2026-01-12T18:11:42.549Z,1768241502.549 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2026-01-12T18:11:42.680Z,1768241502.680 [DeadReckonUsingMultipleVelocitySources] Loaded
2026-01-12T18:11:42.681Z,1768241502.681 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2026-01-12T18:11:42.694Z,1768241502.694 [NavChart] Loaded
2026-01-12T18:11:42.695Z,1768241502.695 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2026-01-12T18:11:42.700Z,1768241502.700 [UniversalFixResidualReporter] Loaded
2026-01-12T18:11:42.700Z,1768241502.700 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2026-01-12T18:11:42.701Z,1768241502.701 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2026-01-12T18:11:42.702Z,1768241502.702 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2026-01-12T18:11:43.320Z,1768241503.320 [AHRS_M2] Loaded
2026-01-12T18:11:43.320Z,1768241503.320 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2026-01-12T18:11:43.358Z,1768241503.358 [BackseatComponent] Loaded
2026-01-12T18:11:43.358Z,1768241503.358 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2026-01-12T18:11:43.359Z,1768241503.359 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 40A854E0
2026-01-12T18:11:43.360Z,1768241503.360 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 3684
2026-01-12T18:11:43.363Z,1768241503.363 [LcmPublisher] Loaded
2026-01-12T18:11:43.363Z,1768241503.363 [ComponentRegistry](DEBUG): SyncComponent "LcmPublisher" handled in the control thread.
2026-01-12T18:11:44.509Z,1768241504.509 [BPC1] Loaded
2026-01-12T18:11:44.510Z,1768241504.510 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2026-01-12T18:11:44.610Z,1768241504.610 [DAT] Loaded
2026-01-12T18:11:44.610Z,1768241504.610 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2026-01-12T18:11:44.611Z,1768241504.611 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40AB54E0
2026-01-12T18:11:44.612Z,1768241504.612 [DAT ThreadHandler](INFO): Protected caller Thread ID is 3685
2026-01-12T18:11:44.687Z,1768241504.687 [DataOverHttps] Loaded
2026-01-12T18:11:44.687Z,1768241504.687 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2026-01-12T18:11:44.688Z,1768241504.688 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40AE54E0
2026-01-12T18:11:44.688Z,1768241504.688 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 3686
2026-01-12T18:11:44.712Z,1768241504.712 [Depth_Keller] Loaded
2026-01-12T18:11:44.712Z,1768241504.712 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2026-01-12T18:11:44.717Z,1768241504.717 [DropWeight] Loaded
2026-01-12T18:11:44.717Z,1768241504.717 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2026-01-12T18:11:44.789Z,1768241504.789 [NAL9602] Loaded
2026-01-12T18:11:44.789Z,1768241504.789 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2026-01-12T18:11:44.815Z,1768241504.815 [Onboard] Loaded
2026-01-12T18:11:44.815Z,1768241504.815 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2026-01-12T18:11:44.816Z,1768241504.816 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40B154E0
2026-01-12T18:11:44.817Z,1768241504.817 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 3687
2026-01-12T18:11:44.823Z,1768241504.823 [PowerOnly](INFO): Adding load control power supply at /dev/loadC3
2026-01-12T18:11:44.836Z,1768241504.836 [PowerOnly] Loaded
2026-01-12T18:11:44.836Z,1768241504.836 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread.
2026-01-12T18:11:44.850Z,1768241504.850 [Power24vConverter] Loaded
2026-01-12T18:11:44.850Z,1768241504.850 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2026-01-12T18:11:44.866Z,1768241504.866 [Radio_Surface] Loaded
2026-01-12T18:11:44.867Z,1768241504.867 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2026-01-12T18:11:44.868Z,1768241504.868 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40B454E0
2026-01-12T18:11:44.868Z,1768241504.868 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 3688
2026-01-12T18:11:44.883Z,1768241504.883 [Sonardyne_Nano] Loaded
2026-01-12T18:11:44.884Z,1768241504.884 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2026-01-12T18:11:44.884Z,1768241504.884 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2026-01-12T18:11:44.885Z,1768241504.885 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2026-01-12T18:11:44.966Z,1768241504.966 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2026-01-12T18:11:44.967Z,1768241504.967 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2026-01-12T18:11:45.031Z,1768241505.031 [VerticalControl](DEBUG): Construct VerticalControl.
2026-01-12T18:11:45.082Z,1768241505.082 [VerticalControl] Loaded
2026-01-12T18:11:45.082Z,1768241505.082 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2026-01-12T18:11:45.085Z,1768241505.085 [HorizontalControl](DEBUG): Construct HorizontalControl.
2026-01-12T18:11:45.129Z,1768241505.129 [HorizontalControl] Loaded
2026-01-12T18:11:45.129Z,1768241505.129 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2026-01-12T18:11:45.132Z,1768241505.132 [SpeedControl](DEBUG): Construct SpeedControl.
2026-01-12T18:11:45.133Z,1768241505.133 [SpeedControl] Loaded
2026-01-12T18:11:45.133Z,1768241505.133 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2026-01-12T18:11:45.136Z,1768241505.136 [LoopControl](DEBUG): Construct LoopControl.
2026-01-12T18:11:45.137Z,1768241505.137 [LoopControl] Loaded
2026-01-12T18:11:45.137Z,1768241505.137 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2026-01-12T18:11:45.138Z,1768241505.138 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2026-01-12T18:11:45.138Z,1768241505.138 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2026-01-12T18:11:45.152Z,1768241505.152 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2026-01-12T18:11:45.152Z,1768241505.152 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2026-01-12T18:11:45.531Z,1768241505.531 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2026-01-12T18:11:45.538Z,1768241505.538 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2026-01-12T18:11:45.541Z,1768241505.541 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2026-01-12T18:11:45.552Z,1768241505.552 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2026-01-12T18:11:45.553Z,1768241505.553 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C6D4E0
2026-01-12T18:11:45.553Z,1768241505.553 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 3689
2026-01-12T18:11:45.558Z,1768241505.558 [Supervisor](INFO): Main Thread ID is 827
2026-01-12T18:11:45.558Z,1768241505.558 [Supervisor](DEBUG): Running supervisor.
2026-01-12T18:11:45.559Z,1768241505.559 [CommandExec ThreadHandler](INFO): Handler Thread ID is 3690
2026-01-12T18:11:45.559Z,1768241505.559 [CommandExec](INFO): Initializing the command executive.
2026-01-12T18:11:45.561Z,1768241505.561 [CommandLine ThreadHandler](INFO): Handler Thread ID is 3691
2026-01-12T18:11:45.564Z,1768241505.564 [controlThread ThreadHandler](INFO): Handler Thread ID is 3692
2026-01-12T18:11:45.564Z,1768241505.564 [controlThread](DEBUG): Initializing ControlThread
2026-01-12T18:11:45.566Z,1768241505.566 [SBIT](INFO): Initialize SBIT Component.
2026-01-12T18:11:45.566Z,1768241505.566 [SBIT](IMPORTANT): git: 2025-12-04
2026-01-12T18:11:45.567Z,1768241505.567 [SBIT](INFO): git hash: 9bae910f87c476713ef0b63f9da99d151f0f5f1b
2026-01-12T18:11:45.567Z,1768241505.567 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2026-01-12T18:11:45.568Z,1768241505.568 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2026-01-12T18:11:45.570Z,1768241505.570 [SBIT](INFO): Beginning SBIT in 144.000000 seconds.
2026-01-12T18:11:45.570Z,1768241505.570 [IBIT](INFO): Initialize IBIT Component.
2026-01-12T18:11:45.571Z,1768241505.571 [CBIT](DEBUG): Initialize CBIT Component.
2026-01-12T18:11:45.572Z,1768241505.572 [logger ThreadHandler](INFO): Handler Thread ID is 3693
2026-01-12T18:11:45.585Z,1768241505.585 [CBIT](DEBUG): Initialized mux pins.
2026-01-12T18:11:45.585Z,1768241505.585 [CBIT](DEBUG): Initializing the watchdog timer.
2026-01-12T18:11:45.598Z,1768241505.598 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 3694
2026-01-12T18:11:45.598Z,1768241505.598 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2026-01-12T18:11:45.603Z,1768241505.603 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 3696
2026-01-12T18:11:45.606Z,1768241505.606 [WetLabsBB2FL](INFO): Powering up
2026-01-12T18:11:45.607Z,1768241505.607 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 3698
2026-01-12T18:11:45.609Z,1768241505.609 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2026-01-12T18:11:45.610Z,1768241505.610 [CBIT](DEBUG): Initializing heartbeat.
2026-01-12T18:11:45.623Z,1768241505.623 [DAT ThreadHandler](INFO): Handler Thread ID is 3699
2026-01-12T18:11:45.624Z,1768241505.624 [DAT](INFO): Powering up
2026-01-12T18:11:45.624Z,1768241505.624 [DAT](DEBUG): Initializing DAT.
2026-01-12T18:11:45.630Z,1768241505.630 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 3701
2026-01-12T18:11:45.632Z,1768241505.632 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2026-01-12T18:11:45.646Z,1768241505.646 [Onboard ThreadHandler](INFO): Handler Thread ID is 3702
2026-01-12T18:11:45.663Z,1768241505.663 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 3703
2026-01-12T18:11:45.681Z,1768241505.681 [CBIT](DEBUG): Deactivating emergency mode.
2026-01-12T18:11:45.682Z,1768241505.682 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 3704
2026-01-12T18:11:45.689Z,1768241505.689 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2026-01-12T18:11:45.690Z,1768241505.690 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2026-01-12T18:11:45.690Z,1768241505.690 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2026-01-12T18:11:45.690Z,1768241505.690 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2026-01-12T18:11:45.690Z,1768241505.690 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2026-01-12T18:11:45.690Z,1768241505.690 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2026-01-12T18:11:45.691Z,1768241505.691 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2026-01-12T18:11:45.691Z,1768241505.691 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2026-01-12T18:11:45.721Z,1768241505.721 [CBIT](DEBUG): Backplane powered.
2026-01-12T18:11:45.721Z,1768241505.721 [GFScanner](DEBUG): Initializing GFScanner
2026-01-12T18:11:45.722Z,1768241505.722 [GFScanner](DEBUG): Deactivating GF circuits.
2026-01-12T18:11:45.730Z,1768241505.730 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2026-01-12T18:11:45.730Z,1768241505.730 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2026-01-12T18:11:45.730Z,1768241505.730 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2026-01-12T18:11:45.731Z,1768241505.731 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2026-01-12T18:11:45.731Z,1768241505.731 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2026-01-12T18:11:45.733Z,1768241505.733 [NavChart](DEBUG): Initialize NavChart Navigation.
2026-01-12T18:11:45.733Z,1768241505.733 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2026-01-12T18:11:45.736Z,1768241505.736 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2026-01-12T18:11:45.738Z,1768241505.738 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2026-01-12T18:11:45.739Z,1768241505.739 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2026-01-12T18:11:45.740Z,1768241505.740 [LoopControl](DEBUG): Initialize LoopControlComponent.
2026-01-12T18:11:45.740Z,1768241505.740 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2026-01-12T18:11:45.745Z,1768241505.745 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2026-01-12T18:11:45.745Z,1768241505.745 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2026-01-12T18:11:45.752Z,1768241505.752 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2026-01-12T18:11:45.832Z,1768241505.832 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
2026-01-12T18:11:45.850Z,1768241505.850 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2026-01-12T18:11:45.896Z,1768241505.896 [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-01-12T18:11:45.896Z,1768241505.896 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2026-01-12T18:11:45.896Z,1768241505.896 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2026-01-12T18:11:45.903Z,1768241505.903 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2026-01-12T18:11:46.069Z,1768241506.069 [Radio_Surface](INFO): Powering up
2026-01-12T18:11:46.239Z,1768241506.239 [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-01-12T18:11:46.261Z,1768241506.261 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2026-01-12T18:11:46.262Z,1768241506.262 [Default:A.Wait](DEBUG): Construct Wait.
2026-01-12T18:11:46.265Z,1768241506.265 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2026-01-12T18:11:46.316Z,1768241506.316 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2026-01-12T18:11:46.319Z,1768241506.319 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2026-01-12T18:11:46.340Z,1768241506.340 [Default:E.Execute](DEBUG): Construct Execute.
2026-01-12T18:11:46.344Z,1768241506.344 [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-01-12T18:11:46.361Z,1768241506.361 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,PowerOnly,Power24vConverter,Sonardyne_Nano,PAR_Licor,Depth_Keller,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-01-12T18:11:46.406Z,1768241506.406 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2026-01-12T18:11:46.470Z,1768241506.470 [Depth_Keller](INFO): Initializing.
2026-01-12T18:11:46.472Z,1768241506.472 [Power24vConverter](INFO): Powering up.
2026-01-12T18:11:46.472Z,1768241506.472 [Sonardyne_Nano](INFO): Initializing.
2026-01-12T18:11:46.517Z,1768241506.517 [DepthRateCalculator](ERROR): Depth measurement is not active
2026-01-12T18:11:46.548Z,1768241506.548 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2026-01-12T18:11:46.553Z,1768241506.553 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2026-01-12T18:11:46.554Z,1768241506.554 [ElevatorServo](DEBUG): Initializing EZServoServo.
2026-01-12T18:11:46.561Z,1768241506.561 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2026-01-12T18:11:46.562Z,1768241506.562 [MassServo](DEBUG): Initializing EZServoServo.
2026-01-12T18:11:46.570Z,1768241506.570 [MassServo](DEBUG): Initializing MassServo.
2026-01-12T18:11:46.570Z,1768241506.570 [RudderServo](DEBUG): Initializing EZServoServo.
2026-01-12T18:11:46.577Z,1768241506.577 [RudderServo](DEBUG): Initializing RudderServo.
2026-01-12T18:11:46.578Z,1768241506.578 [ThrusterHE](DEBUG): Initializing EZServoServo.
2026-01-12T18:11:46.585Z,1768241506.585 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2026-01-12T18:11:46.814Z,1768241506.814 [PowerOnly](INFO): Powering up loadControl
2026-01-12T18:11:48.217Z,1768241508.217 [WetLabsBB2FL](INFO): Powering down
2026-01-12T18:11:48.396Z,1768241508.396 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART
2026-01-12T18:11:49.687Z,1768241509.687 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2213
2026-01-12T18:11:57.974Z,1768241517.974 [DAT](INFO): DAT read:
2026-01-12T18:11:57.975Z,1768241517.975 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series
2026-01-12T18:11:59.738Z,1768241519.738 [DAT](INFO): DAT read: MF Frequency Band
2026-01-12T18:11:59.739Z,1768241519.739 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0
2026-01-12T18:11:59.740Z,1768241519.740 [DAT](INFO): DAT read: Jan 12 2026 18:12:22
2026-01-12T18:12:00.747Z,1768241520.747 [DAT](INFO): DAT read: Features enabled [Bearing]
2026-01-12T18:12:00.748Z,1768241520.748 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC
2026-01-12T18:12:00.748Z,1768241520.748 [DAT](INFO): commRate: 1200
2026-01-12T18:12:02.813Z,1768241522.813 [DAT](INFO): entering command mode
2026-01-12T18:12:03.016Z,1768241523.016 [DAT](INFO): DAT read:
2026-01-12T18:12:03.016Z,1768241523.016 [DAT](INFO): DAT read: user:1>
2026-01-12T18:12:03.017Z,1768241523.017 [DAT](INFO): setting verbose to 3
2026-01-12T18:12:03.266Z,1768241523.266 [DAT](INFO): DAT read: user:1>
2026-01-12T18:12:03.267Z,1768241523.267 [DAT](INFO): DAT read: Verbose | 3
2026-01-12T18:12:03.267Z,1768241523.267 [DAT](INFO): set verbose to 3
2026-01-12T18:12:03.268Z,1768241523.268 [DAT](INFO): setting DatVerbose to 27440
2026-01-12T18:12:03.518Z,1768241523.518 [DAT](INFO): DAT read: user:2>
2026-01-12T18:12:03.519Z,1768241523.519 [DAT](INFO): DAT read: DatVerbose | 27440
2026-01-12T18:12:03.519Z,1768241523.519 [DAT](INFO): set DatVerbose to 27440
2026-01-12T18:12:03.520Z,1768241523.520 [DAT](INFO): setting transmit power to 8
2026-01-12T18:12:03.770Z,1768241523.770 [DAT](INFO): DAT read: user:3>
2026-01-12T18:12:03.771Z,1768241523.771 [DAT](INFO): DAT read: TxPower | 8 (Max)
2026-01-12T18:12:03.771Z,1768241523.771 [DAT](INFO): set transmit power to 8
2026-01-12T18:12:03.771Z,1768241523.771 [DAT](INFO): setting local address to 5
2026-01-12T18:12:04.022Z,1768241524.022 [DAT](INFO): DAT read: user:4>
2026-01-12T18:12:04.023Z,1768241524.023 [DAT](INFO): DAT read: LocalAddr | 5
2026-01-12T18:12:04.023Z,1768241524.023 [DAT](INFO): set local address to 5
2026-01-12T18:12:04.024Z,1768241524.024 [DAT](INFO): Setting time to: 18:12:4 And date to:1/12/2026
2026-01-12T18:12:04.274Z,1768241524.274 [DAT](INFO): DAT read: user:5>
2026-01-12T18:12:04.275Z,1768241524.275 [DAT](INFO): DAT read: Mon Jan 12, 2026 18:12:04
2026-01-12T18:12:04.275Z,1768241524.275 [DAT](INFO): Local DAT time set to Mon Jan 12, 2026 18:12:04
2026-01-12T18:12:15.107Z,1768241535.107 [NAL9602](INFO): Powering up NAL9602
2026-01-12T18:12:26.017Z,1768241546.017 [NAL9602](INFO): NAL9602 initialized
2026-01-12T18:13:01.974Z,1768241581.974 [NAL9602](INFO): SBD MO Status=2, MOMSN=25075, MT Status=2, MTMSN=0
2026-01-12T18:13:01.974Z,1768241581.974 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2026-01-12T18:13:57.726Z,1768241637.726 [NAL9602](INFO): SBD MO Status=0, MOMSN=25075, MT Status=0, MTMSN=0
2026-01-12T18:13:57.727Z,1768241637.727 [NAL9602](INFO): No messages in MT queue
2026-01-12T18:13:58.408Z,1768241638.408 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004874
2026-01-12T18:14:10.283Z,1768241650.283 [SBIT](IMPORTANT): Beginning Startup BIT
2026-01-12T18:14:10.288Z,1768241650.288 [GFScanner](IMPORTANT): Beginning ground fault scan
2026-01-12T18:14:14.782Z,1768241654.782 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.012735
CHAN A1 (24V): 0.001215
CHAN A2 (12V): -0.005376
CHAN A3 (5V): -0.002271
CHAN B0 (3.3V): -0.000990
CHAN B1 (3.15aV): -0.001161
CHAN B2 (3.15bV): -0.001206
CHAN B3 (GND): -0.000168
OPEN: 0.006594
Full Scale: +/- 1 mA
2026-01-12T18:14:45.878Z,1768241685.878 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2026-01-12T18:14:45.878Z,1768241685.878 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2026-01-12T18:14:45.888Z,1768241685.888 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2026-01-12T18:14:46.301Z,1768241686.301 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2026-01-12T18:14:46.301Z,1768241686.301 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2026-01-12T18:15:04.167Z,1768241704.167 [SBIT](IMPORTANT): SBIT PASSED
2026-01-12T18:15:04.168Z,1768241704.168 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2026-01-12T18:15:04.168Z,1768241704.168 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=5 count;
2026-01-12T18:15:04.168Z,1768241704.168 [SBIT](IMPORTANT): CBIT.navErrorThreshold=100 percent;
2026-01-12T18:15:04.168Z,1768241704.168 [SBIT](IMPORTANT): CBIT.runNavErrorCritical=1 bool;
2026-01-12T18:15:04.169Z,1768241704.169 [SBIT](IMPORTANT): DVL_micro.loadAtStartup=0 bool;
2026-01-12T18:15:04.169Z,1768241704.169 [SBIT](IMPORTANT): Express linearApproximation PowerOnly.component_avgCurrent_loadControl 50.000000 milliampere;
2026-01-12T18:15:04.169Z,1768241704.169 [SBIT](IMPORTANT): Express linearApproximation PowerOnly.samplePowerOnly 1.000000 bool;
2026-01-12T18:15:04.169Z,1768241704.169 [SBIT](IMPORTANT): IBIT.batteryCapacityThreshold=-1 ampere_hour;
2026-01-12T18:15:04.169Z,1768241704.169 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=10 volt;
2026-01-12T18:15:04.169Z,1768241704.169 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=384.695336 cubic_centimeter;
2026-01-12T18:15:04.170Z,1768241704.170 [SBIT](IMPORTANT): VerticalControl.massDefault=31.165311 millimeter;
2026-01-12T18:15:04.590Z,1768241704.590 [MissionManager](IMPORTANT): Started mission Startup
2026-01-12T18:15:04.590Z,1768241704.590 [Startup] Running Loop=1
2026-01-12T18:15:04.591Z,1768241704.591 [Startup](DEBUG): Aggregate::initialize Startup
2026-01-12T18:15:04.591Z,1768241704.591 [Startup:A.GoToSurface] Running Loop=1
2026-01-12T18:15:04.591Z,1768241704.591 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2026-01-12T18:15:04.591Z,1768241704.591 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2026-01-12T18:15:04.592Z,1768241704.592 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2026-01-12T18:15:04.592Z,1768241704.592 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2026-01-12T18:15:04.592Z,1768241704.592 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2026-01-12T18:15:04.593Z,1768241704.593 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2026-01-12T18:15:04.593Z,1768241704.593 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2026-01-12T18:15:04.595Z,1768241704.595 [Startup:StartupSatComms] Running Loop=1
2026-01-12T18:15:04.595Z,1768241704.595 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2026-01-12T18:15:04.595Z,1768241704.595 [Startup:StartupSatComms:A] Running Loop=1
2026-01-12T18:15:04.999Z,1768241704.999 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2026-01-12T18:16:04.783Z,1768241764.783 [Startup:StartupSatComms:A](INFO): Timed out from 2026-01-12T18:15:04.6Z
2026-01-12T18:16:04.783Z,1768241764.783 [Startup:StartupSatComms:A] Stopped
2026-01-12T18:16:04.783Z,1768241764.783 [Startup:StartupSatComms:B] Running Loop=1
2026-01-12T18:16:05.187Z,1768241765.187 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2026-01-12T18:16:10.824Z,1768241770.824 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20260112T181133/Courier0000.lzma
2026-01-12T18:16:11.823Z,1768241771.823 [DataOverHttps](INFO): Moved sent file to Logs/20260112T181133/Courier0000.lzma.bak
2026-01-12T18:16:11.823Z,1768241771.823 [DataOverHttps](INFO): SBD MOMSN=26556278
2026-01-12T18:16:29.699Z,1768241789.699 [DataOverHttps](INFO): Sending 1037 bytes from file Logs/20260112T181133/Express0001.lzma
2026-01-12T18:16:30.699Z,1768241790.699 [DataOverHttps](INFO): Moved sent file to Logs/20260112T181133/Express0001.lzma.bak
2026-01-12T18:16:30.699Z,1768241790.699 [DataOverHttps](INFO): SBD MOMSN=26556281
2026-01-12T18:16:31.860Z,1768241791.860 [Startup:StartupSatComms:B] Stopped
2026-01-12T18:16:31.860Z,1768241791.860 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2026-01-12T18:16:31.860Z,1768241791.860 [Startup:StartupSatComms] Stopped
2026-01-12T18:16:31.860Z,1768241791.860 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2026-01-12T18:16:31.861Z,1768241791.861 [Startup](INFO): Completed Startup
2026-01-12T18:16:31.861Z,1768241791.861 [MissionManager](INFO): Startup is completed.
2026-01-12T18:16:31.861Z,1768241791.861 [MissionManager](INFO): Uninitializing Mission Startup
2026-01-12T18:16:31.862Z,1768241791.862 [Startup] Stopped
2026-01-12T18:16:31.862Z,1768241791.862 [Startup](DEBUG): Aggregate::uninitialize Startup
2026-01-12T18:16:31.862Z,1768241791.862 [Startup:A.GoToSurface] Stopped
2026-01-12T18:16:31.862Z,1768241791.862 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2026-01-12T18:16:32.254Z,1768241792.254 [MissionManager](IMPORTANT): Started mission Default
2026-01-12T18:16:32.255Z,1768241792.255 [Default] Running Loop=1
2026-01-12T18:16:32.255Z,1