2026-02-09T16:43:23.399Z,1770655403.399 [Supervisor](DEBUG): Initializing supervisor. 2026-02-09T16:43:23.404Z,1770655403.404 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2026-02-09T16:43:23.404Z,1770655403.404 [SyncHandler](INFO): Protected caller Thread ID is 6631 2026-02-09T16:43:23.405Z,1770655403.405 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2026-02-09T16:43:23.406Z,1770655403.406 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2026-02-09T16:43:23.406Z,1770655403.406 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 6632 2026-02-09T16:43:23.410Z,1770655403.410 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2026-02-09T16:43:23.430Z,1770655403.430 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2026-02-09T16:43:23.431Z,1770655403.431 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2026-02-09T16:43:23.431Z,1770655403.431 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 6633 2026-02-09T16:43:23.435Z,1770655403.435 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2026-02-09T16:43:23.436Z,1770655403.436 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2026-02-09T16:43:23.436Z,1770655403.436 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 6634 2026-02-09T16:43:23.439Z,1770655403.439 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2026-02-09T16:43:23.440Z,1770655403.440 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2026-02-09T16:43:23.440Z,1770655403.440 [logger ThreadHandler](INFO): Protected caller Thread ID is 6635 2026-02-09T16:43:23.444Z,1770655403.444 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2026-02-09T16:43:23.444Z,1770655403.444 [Supervisor](INFO): Looking for Config files in directory: Config/ 2026-02-09T16:43:23.446Z,1770655403.446 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2026-02-09T16:43:23.780Z,1770655403.780 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2026-02-09T16:43:23.781Z,1770655403.781 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2026-02-09T16:43:23.881Z,1770655403.881 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Guidance 2026-02-09T16:43:23.882Z,1770655403.882 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2026-02-09T16:43:23.999Z,1770655403.999 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2026-02-09T16:43:23.999Z,1770655403.999 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2026-02-09T16:43:24.140Z,1770655404.140 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2026-02-09T16:43:24.141Z,1770655404.141 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2026-02-09T16:43:24.493Z,1770655404.493 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2026-02-09T16:43:24.493Z,1770655404.493 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2026-02-09T16:43:24.599Z,1770655404.599 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2026-02-09T16:43:24.600Z,1770655404.600 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2026-02-09T16:43:24.000Z,1770655405.000 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2026-02-09T16:43:25.000Z,1770655405.000 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2026-02-09T16:43:25.229Z,1770655405.229 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2026-02-09T16:43:25.230Z,1770655405.230 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2026-02-09T16:43:25.319Z,1770655405.319 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2026-02-09T16:43:25.567Z,1770655405.567 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2026-02-09T16:43:25.567Z,1770655405.567 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2026-02-09T16:43:25.791Z,1770655405.791 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2026-02-09T16:43:25.792Z,1770655405.792 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2026-02-09T16:43:26.336Z,1770655406.336 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2026-02-09T16:43:26.336Z,1770655406.336 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2026-02-09T16:43:26.526Z,1770655406.526 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2026-02-09T16:43:26.527Z,1770655406.527 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2026-02-09T16:43:26.815Z,1770655406.815 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2026-02-09T16:43:26.816Z,1770655406.816 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2026-02-09T16:43:27.652Z,1770655407.652 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2026-02-09T16:43:27.653Z,1770655407.653 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2026-02-09T16:43:28.231Z,1770655408.231 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2026-02-09T16:43:28.233Z,1770655408.233 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/ 2026-02-09T16:43:28.234Z,1770655408.234 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Control.cfg 2026-02-09T16:43:28.339Z,1770655408.339 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Science.cfg 2026-02-09T16:43:28.478Z,1770655408.478 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/secure.cfg 2026-02-09T16:43:28.572Z,1770655408.572 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Servo.cfg 2026-02-09T16:43:28.688Z,1770655408.688 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/BIT.cfg 2026-02-09T16:43:28.792Z,1770655408.792 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Battery.cfg 2026-02-09T16:43:29.059Z,1770655409.059 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2026-02-09T16:43:29.060Z,1770655409.060 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/vehicle.cfg 2026-02-09T16:43:29.178Z,1770655409.178 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/logger.cfg 2026-02-09T16:43:29.286Z,1770655409.286 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Sensor.cfg 2026-02-09T16:43:29.434Z,1770655409.434 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Simulator.cfg 2026-02-09T16:43:29.529Z,1770655409.529 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2026-02-09T16:43:29.536Z,1770655409.536 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2026-02-09T16:43:29.668Z,1770655409.668 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2026-02-09T16:43:29.668Z,1770655409.668 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2026-02-09T16:43:29.722Z,1770655409.722 [VerticalControl](DEBUG): Construct VerticalControl. 2026-02-09T16:43:29.781Z,1770655409.781 [VerticalControl] Loaded 2026-02-09T16:43:29.782Z,1770655409.782 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2026-02-09T16:43:29.784Z,1770655409.784 [HorizontalControl](DEBUG): Construct HorizontalControl. 2026-02-09T16:43:29.831Z,1770655409.831 [HorizontalControl] Loaded 2026-02-09T16:43:29.832Z,1770655409.832 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2026-02-09T16:43:29.834Z,1770655409.834 [SpeedControl](DEBUG): Construct SpeedControl. 2026-02-09T16:43:29.837Z,1770655409.837 [SpeedControl] Loaded 2026-02-09T16:43:29.837Z,1770655409.837 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2026-02-09T16:43:29.840Z,1770655409.840 [LoopControl](DEBUG): Construct LoopControl. 2026-02-09T16:43:29.840Z,1770655409.840 [LoopControl] Loaded 2026-02-09T16:43:29.841Z,1770655409.841 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2026-02-09T16:43:29.841Z,1770655409.841 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2026-02-09T16:43:29.842Z,1770655409.842 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2026-02-09T16:43:29.899Z,1770655409.899 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2026-02-09T16:43:29.900Z,1770655409.900 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2026-02-09T16:43:30.366Z,1770655410.366 [AHRS_M2] Loaded 2026-02-09T16:43:30.366Z,1770655410.366 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2026-02-09T16:43:30.405Z,1770655410.405 [BackseatComponent] Loaded 2026-02-09T16:43:30.406Z,1770655410.406 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2026-02-09T16:43:30.407Z,1770655410.407 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408BD4E0 2026-02-09T16:43:30.407Z,1770655410.407 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 6714 2026-02-09T16:43:30.410Z,1770655410.410 [LcmPublisher] Loaded 2026-02-09T16:43:30.411Z,1770655410.411 [ComponentRegistry](DEBUG): SyncComponent "LcmPublisher" handled in the control thread. 2026-02-09T16:43:31.219Z,1770655411.219 [BPC1] Loaded 2026-02-09T16:43:31.220Z,1770655411.220 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2026-02-09T16:43:31.317Z,1770655411.317 [DAT] Loaded 2026-02-09T16:43:31.317Z,1770655411.317 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2026-02-09T16:43:31.318Z,1770655411.318 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 408ED4E0 2026-02-09T16:43:31.319Z,1770655411.319 [DAT ThreadHandler](INFO): Protected caller Thread ID is 6715 2026-02-09T16:43:31.391Z,1770655411.391 [DataOverHttps] Loaded 2026-02-09T16:43:31.392Z,1770655411.392 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2026-02-09T16:43:31.393Z,1770655411.393 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4091D4E0 2026-02-09T16:43:31.393Z,1770655411.393 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 6716 2026-02-09T16:43:31.416Z,1770655411.416 [Depth_Keller] Loaded 2026-02-09T16:43:31.416Z,1770655411.416 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2026-02-09T16:43:31.421Z,1770655411.421 [DropWeight] Loaded 2026-02-09T16:43:31.421Z,1770655411.421 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2026-02-09T16:43:31.486Z,1770655411.486 [NAL9602] Loaded 2026-02-09T16:43:31.486Z,1770655411.486 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2026-02-09T16:43:31.516Z,1770655411.516 [Onboard] Loaded 2026-02-09T16:43:31.516Z,1770655411.516 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2026-02-09T16:43:31.517Z,1770655411.517 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4094D4E0 2026-02-09T16:43:31.517Z,1770655411.517 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 6717 2026-02-09T16:43:31.531Z,1770655411.531 [Power24vConverter] Loaded 2026-02-09T16:43:31.532Z,1770655411.532 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2026-02-09T16:43:31.547Z,1770655411.547 [Radio_Surface] Loaded 2026-02-09T16:43:31.548Z,1770655411.548 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2026-02-09T16:43:31.549Z,1770655411.549 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4097D4E0 2026-02-09T16:43:31.549Z,1770655411.549 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 6718 2026-02-09T16:43:31.565Z,1770655411.565 [Sonardyne_Nano] Loaded 2026-02-09T16:43:31.565Z,1770655411.565 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2026-02-09T16:43:31.589Z,1770655411.589 [Waterlinked] Loaded 2026-02-09T16:43:31.589Z,1770655411.589 [ComponentRegistry](DEBUG): SyncComponent "Waterlinked" handled in the control thread. 2026-02-09T16:43:31.590Z,1770655411.590 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2026-02-09T16:43:31.590Z,1770655411.590 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2026-02-09T16:43:31.601Z,1770655411.601 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2026-02-09T16:43:31.601Z,1770655411.601 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2026-02-09T16:43:31.630Z,1770655411.630 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2026-02-09T16:43:31.630Z,1770655411.630 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2026-02-09T16:43:31.787Z,1770655411.787 [SBIT](DEBUG): Construct Startup Built In Test. 2026-02-09T16:43:31.796Z,1770655411.796 [SBIT] Loaded 2026-02-09T16:43:31.796Z,1770655411.796 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2026-02-09T16:43:31.799Z,1770655411.799 [IBIT](DEBUG): Construct Initiated Built In Test. 2026-02-09T16:43:31.812Z,1770655411.812 [IBIT] Loaded 2026-02-09T16:43:31.812Z,1770655411.812 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2026-02-09T16:43:31.817Z,1770655411.817 [CBIT](DEBUG): Construct Continuous Built In Test. 2026-02-09T16:43:31.896Z,1770655411.896 [CBIT] Loaded 2026-02-09T16:43:31.896Z,1770655411.896 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2026-02-09T16:43:31.929Z,1770655411.929 [GFScanner] Loaded 2026-02-09T16:43:31.929Z,1770655411.929 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread. 2026-02-09T16:43:31.929Z,1770655411.929 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2026-02-09T16:43:31.930Z,1770655411.930 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2026-02-09T16:43:32.262Z,1770655412.262 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2026-02-09T16:43:32.263Z,1770655412.263 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2026-02-09T16:43:32.312Z,1770655412.312 [DepthRateCalculator] Loaded 2026-02-09T16:43:32.312Z,1770655412.312 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2026-02-09T16:43:32.317Z,1770655412.317 [PitchRateCalculator] Loaded 2026-02-09T16:43:32.317Z,1770655412.317 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2026-02-09T16:43:32.327Z,1770655412.327 [SpeedCalculator] Loaded 2026-02-09T16:43:32.328Z,1770655412.328 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2026-02-09T16:43:32.332Z,1770655412.332 [YawRateCalculator] Loaded 2026-02-09T16:43:32.332Z,1770655412.332 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2026-02-09T16:43:32.351Z,1770655412.351 [ElevatorOffsetCalculator] Loaded 2026-02-09T16:43:32.351Z,1770655412.351 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2026-02-09T16:43:32.352Z,1770655412.352 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2026-02-09T16:43:32.353Z,1770655412.353 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2026-02-09T16:43:32.524Z,1770655412.524 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2026-02-09T16:43:32.525Z,1770655412.525 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2026-02-09T16:43:32.638Z,1770655412.638 [DeadReckonUsingMultipleVelocitySources] Loaded 2026-02-09T16:43:32.638Z,1770655412.638 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2026-02-09T16:43:32.651Z,1770655412.651 [NavChart] Loaded 2026-02-09T16:43:32.652Z,1770655412.652 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2026-02-09T16:43:32.657Z,1770655412.657 [UniversalFixResidualReporter] Loaded 2026-02-09T16:43:32.658Z,1770655412.658 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2026-02-09T16:43:32.658Z,1770655412.658 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2026-02-09T16:43:32.659Z,1770655412.659 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2026-02-09T16:43:32.792Z,1770655412.792 [BuoyancyServo] Loaded 2026-02-09T16:43:32.792Z,1770655412.792 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2026-02-09T16:43:32.815Z,1770655412.815 [ElevatorServo] Loaded 2026-02-09T16:43:32.816Z,1770655412.816 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2026-02-09T16:43:32.837Z,1770655412.837 [MassServo] Loaded 2026-02-09T16:43:32.838Z,1770655412.838 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2026-02-09T16:43:32.858Z,1770655412.858 [RudderServo] Loaded 2026-02-09T16:43:32.859Z,1770655412.859 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2026-02-09T16:43:32.875Z,1770655412.875 [ThrusterHE] Loaded 2026-02-09T16:43:32.876Z,1770655412.876 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2026-02-09T16:43:32.876Z,1770655412.876 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2026-02-09T16:43:32.876Z,1770655412.876 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2026-02-09T16:43:33.047Z,1770655413.047 [CTD_Seabird] Loaded 2026-02-09T16:43:33.048Z,1770655413.048 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2026-02-09T16:43:33.049Z,1770655413.049 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40C0D4E0 2026-02-09T16:43:33.049Z,1770655413.049 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 6719 2026-02-09T16:43:33.086Z,1770655413.086 [ESPComponent] Loaded 2026-02-09T16:43:33.087Z,1770655413.087 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2026-02-09T16:43:33.109Z,1770655413.109 [PAR_Licor] Loaded 2026-02-09T16:43:33.109Z,1770655413.109 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2026-02-09T16:43:33.154Z,1770655413.154 [WetLabsBB2FL] Loaded 2026-02-09T16:43:33.154Z,1770655413.154 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2026-02-09T16:43:33.155Z,1770655413.155 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40C3D4E0 2026-02-09T16:43:33.155Z,1770655413.155 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 6720 2026-02-09T16:43:33.156Z,1770655413.156 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2026-02-09T16:43:33.162Z,1770655413.162 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2026-02-09T16:43:33.165Z,1770655413.165 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2026-02-09T16:43:33.177Z,1770655413.177 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2026-02-09T16:43:33.178Z,1770655413.178 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C6D4E0 2026-02-09T16:43:33.178Z,1770655413.178 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 6721 2026-02-09T16:43:33.183Z,1770655413.183 [Supervisor](INFO): Main Thread ID is 6630 2026-02-09T16:43:33.183Z,1770655413.183 [Supervisor](DEBUG): Running supervisor. 2026-02-09T16:43:33.183Z,1770655413.183 [CommandExec ThreadHandler](INFO): Handler Thread ID is 6722 2026-02-09T16:43:33.184Z,1770655413.184 [CommandExec](INFO): Initializing the command executive. 2026-02-09T16:43:33.186Z,1770655413.186 [CommandLine ThreadHandler](INFO): Handler Thread ID is 6723 2026-02-09T16:43:33.188Z,1770655413.188 [controlThread ThreadHandler](INFO): Handler Thread ID is 6724 2026-02-09T16:43:33.188Z,1770655413.188 [controlThread](DEBUG): Initializing ControlThread 2026-02-09T16:43:33.189Z,1770655413.189 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2026-02-09T16:43:33.191Z,1770655413.191 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2026-02-09T16:43:33.191Z,1770655413.191 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2026-02-09T16:43:33.192Z,1770655413.192 [LoopControl](DEBUG): Initialize LoopControlComponent. 2026-02-09T16:43:33.195Z,1770655413.195 [SBIT](INFO): Initialize SBIT Component. 2026-02-09T16:43:33.195Z,1770655413.195 [SBIT](IMPORTANT): git: 2026-02-05 2026-02-09T16:43:33.196Z,1770655413.196 [SBIT](INFO): git hash: 2c49374f7e1dd0ac66edaf2b178ef330b988eff4 2026-02-09T16:43:33.196Z,1770655413.196 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2026-02-09T16:43:33.197Z,1770655413.197 [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-09T16:43:33.198Z,1770655413.198 [SBIT](INFO): Beginning SBIT in 41.000000 seconds. 2026-02-09T16:43:33.199Z,1770655413.199 [IBIT](INFO): Initialize IBIT Component. 2026-02-09T16:43:33.199Z,1770655413.199 [CBIT](DEBUG): Initialize CBIT Component. 2026-02-09T16:43:33.200Z,1770655413.200 [logger ThreadHandler](INFO): Handler Thread ID is 6725 2026-02-09T16:43:33.214Z,1770655413.214 [CBIT](DEBUG): Initialized mux pins. 2026-02-09T16:43:33.214Z,1770655413.214 [CBIT](DEBUG): Initializing the watchdog timer. 2026-02-09T16:43:33.226Z,1770655413.226 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 6726 2026-02-09T16:43:33.238Z,1770655413.238 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2026-02-09T16:43:33.238Z,1770655413.238 [CBIT](DEBUG): Initializing heartbeat. 2026-02-09T16:43:33.239Z,1770655413.239 [DAT ThreadHandler](INFO): Handler Thread ID is 6727 2026-02-09T16:43:33.240Z,1770655413.240 [DAT](INFO): Powering up 2026-02-09T16:43:33.240Z,1770655413.240 [DAT](DEBUG): Initializing DAT. 2026-02-09T16:43:33.243Z,1770655413.243 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 6729 2026-02-09T16:43:33.245Z,1770655413.245 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2026-02-09T16:43:33.267Z,1770655413.267 [Onboard ThreadHandler](INFO): Handler Thread ID is 6730 2026-02-09T16:43:33.285Z,1770655413.285 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 6731 2026-02-09T16:43:33.301Z,1770655413.301 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 6732 2026-02-09T16:43:33.310Z,1770655413.310 [CBIT](DEBUG): Deactivating emergency mode. 2026-02-09T16:43:33.318Z,1770655413.318 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 6733 2026-02-09T16:43:33.320Z,1770655413.320 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2026-02-09T16:43:33.322Z,1770655413.322 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 6735 2026-02-09T16:43:33.325Z,1770655413.325 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2026-02-09T16:43:33.325Z,1770655413.325 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2026-02-09T16:43:33.325Z,1770655413.325 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2026-02-09T16:43:33.325Z,1770655413.325 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2026-02-09T16:43:33.326Z,1770655413.326 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2026-02-09T16:43:33.326Z,1770655413.326 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2026-02-09T16:43:33.326Z,1770655413.326 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2026-02-09T16:43:33.326Z,1770655413.326 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2026-02-09T16:43:33.342Z,1770655413.342 [WetLabsBB2FL](INFO): Powering up 2026-02-09T16:43:33.350Z,1770655413.350 [CBIT](DEBUG): Backplane powered. 2026-02-09T16:43:33.350Z,1770655413.350 [GFScanner](DEBUG): Initializing GFScanner 2026-02-09T16:43:33.350Z,1770655413.350 [GFScanner](DEBUG): Deactivating GF circuits. 2026-02-09T16:43:33.355Z,1770655413.355 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2026-02-09T16:43:33.355Z,1770655413.355 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2026-02-09T16:43:33.355Z,1770655413.355 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2026-02-09T16:43:33.356Z,1770655413.356 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2026-02-09T16:43:33.356Z,1770655413.356 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2026-02-09T16:43:33.357Z,1770655413.357 [NavChart](DEBUG): Initialize NavChart Navigation. 2026-02-09T16:43:33.358Z,1770655413.358 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2026-02-09T16:43:33.362Z,1770655413.362 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2026-02-09T16:43:33.363Z,1770655413.363 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2026-02-09T16:43:33.364Z,1770655413.364 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2026-02-09T16:43:33.365Z,1770655413.365 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2026-02-09T16:43:33.440Z,1770655413.440 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2026-02-09T16:43:33.464Z,1770655413.464 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2026-02-09T16:43:33.505Z,1770655413.505 [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-09T16:43:33.508Z,1770655413.508 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2026-02-09T16:43:33.508Z,1770655413.508 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2026-02-09T16:43:33.511Z,1770655413.511 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2026-02-09T16:43:33.694Z,1770655413.694 [Radio_Surface](INFO): Powering up 2026-02-09T16:43:33.814Z,1770655413.814 [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-09T16:43:33.820Z,1770655413.820 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2026-02-09T16:43:33.821Z,1770655413.821 [Default:A.Wait](DEBUG): Construct Wait. 2026-02-09T16:43:33.833Z,1770655413.833 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2026-02-09T16:43:33.883Z,1770655413.883 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2026-02-09T16:43:33.885Z,1770655413.885 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2026-02-09T16:43:33.907Z,1770655413.907 [Default:E.Execute](DEBUG): Construct Execute. 2026-02-09T16:43:33.926Z,1770655413.926 [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-09T16:43:33.931Z,1770655413.931 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,Waterlinked,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-09T16:43:33.955Z,1770655413.955 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2026-02-09T16:43:34.015Z,1770655414.015 [Depth_Keller](INFO): Initializing. 2026-02-09T16:43:34.016Z,1770655414.016 [Power24vConverter](INFO): Powering up. 2026-02-09T16:43:34.017Z,1770655414.017 [Sonardyne_Nano](INFO): Initializing. 2026-02-09T16:43:34.055Z,1770655414.055 [DepthRateCalculator](ERROR): Depth measurement is not active 2026-02-09T16:43:34.081Z,1770655414.081 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2026-02-09T16:43:34.090Z,1770655414.090 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2026-02-09T16:43:34.091Z,1770655414.091 [ElevatorServo](DEBUG): Initializing EZServoServo. 2026-02-09T16:43:34.099Z,1770655414.099 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2026-02-09T16:43:34.099Z,1770655414.099 [MassServo](DEBUG): Initializing EZServoServo. 2026-02-09T16:43:34.106Z,1770655414.106 [MassServo](DEBUG): Initializing MassServo. 2026-02-09T16:43:34.107Z,1770655414.107 [RudderServo](DEBUG): Initializing EZServoServo. 2026-02-09T16:43:34.114Z,1770655414.114 [RudderServo](DEBUG): Initializing RudderServo. 2026-02-09T16:43:34.115Z,1770655414.115 [ThrusterHE](DEBUG): Initializing EZServoServo. 2026-02-09T16:43:34.122Z,1770655414.122 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2026-02-09T16:43:35.934Z,1770655415.934 [WetLabsBB2FL](INFO): Powering down 2026-02-09T16:43:35.960Z,1770655415.960 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2026-02-09T16:43:37.247Z,1770655417.247 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2311 2026-02-09T16:43:39.803Z,1770655419.803 [ThrusterHE](ERROR): Zero Speed Commanded. 2026-02-09T16:43:41.342Z,1770655421.342 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit. 2026-02-09T16:43:46.131Z,1770655426.131 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.006623 2026-02-09T16:43:46.595Z,1770655426.595 [DAT](INFO): DAT read: 2026-02-09T16:43:46.596Z,1770655426.596 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2026-02-09T16:43:48.359Z,1770655428.359 [DAT](INFO): DAT read: MF Frequency Band 2026-02-09T16:43:48.360Z,1770655428.360 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2026-02-09T16:43:48.361Z,1770655428.361 [DAT](INFO): DAT read: Feb 9 2026 16:28:00 2026-02-09T16:43:49.368Z,1770655429.368 [DAT](INFO): DAT read: Features enabled [Bearing] 2026-02-09T16:43:49.369Z,1770655429.369 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2026-02-09T16:43:49.370Z,1770655429.370 [DAT](INFO): commRate: 800 2026-02-09T16:43:51.434Z,1770655431.434 [DAT](INFO): entering command mode 2026-02-09T16:43:51.634Z,1770655431.634 [DAT](INFO): DAT read: 2026-02-09T16:43:51.635Z,1770655431.635 [DAT](INFO): DAT read: user:1> 2026-02-09T16:43:51.635Z,1770655431.635 [DAT](INFO): setting verbose to 3 2026-02-09T16:43:51.887Z,1770655431.887 [DAT](INFO): DAT read: user:1> 2026-02-09T16:43:51.888Z,1770655431.888 [DAT](INFO): DAT read: Verbose | 3 2026-02-09T16:43:51.888Z,1770655431.888 [DAT](INFO): set verbose to 3 2026-02-09T16:43:51.888Z,1770655431.888 [DAT](INFO): setting DatVerbose to 27440 2026-02-09T16:43:52.139Z,1770655432.139 [DAT](INFO): DAT read: user:2> 2026-02-09T16:43:52.140Z,1770655432.140 [DAT](INFO): DAT read: DatVerbose | 27440 2026-02-09T16:43:52.140Z,1770655432.140 [DAT](INFO): set DatVerbose to 27440 2026-02-09T16:43:52.140Z,1770655432.140 [DAT](INFO): setting transmit power to 8 2026-02-09T16:43:52.391Z,1770655432.391 [DAT](INFO): DAT read: user:3> 2026-02-09T16:43:52.391Z,1770655432.391 [DAT](INFO): DAT read: TxPower | 8 (Max) 2026-02-09T16:43:52.392Z,1770655432.392 [DAT](INFO): set transmit power to 8 2026-02-09T16:43:52.392Z,1770655432.392 [DAT](INFO): setting local address to 1 2026-02-09T16:43:52.643Z,1770655432.643 [DAT](INFO): DAT read: user:4> 2026-02-09T16:43:52.644Z,1770655432.644 [DAT](INFO): DAT read: LocalAddr | 1 2026-02-09T16:43:52.644Z,1770655432.644 [DAT](INFO): set local address to 1 2026-02-09T16:43:52.645Z,1770655432.645 [DAT](INFO): Setting time to: 16:43:52 And date to:2/9/2026 2026-02-09T16:43:52.895Z,1770655432.895 [DAT](INFO): DAT read: user:5> 2026-02-09T16:43:52.896Z,1770655432.896 [DAT](INFO): DAT read: Mon Feb 9, 2026 16:43:52 2026-02-09T16:43:52.896Z,1770655432.896 [DAT](INFO): Local DAT time set to Mon Feb 9, 2026 16:43:52 2026-02-09T16:44:01.848Z,1770655441.848 [NAL9602](INFO): Powering up NAL9602 2026-02-09T16:44:11.446Z,1770655451.446 [Waterlinked](INFO): Powering down 2026-02-09T16:44:12.963Z,1770655452.963 [NAL9602](INFO): NAL9602 initialized 2026-02-09T16:44:14.621Z,1770655454.621 [SBIT](IMPORTANT): Beginning Startup BIT 2026-02-09T16:44:14.626Z,1770655454.626 [GFScanner](IMPORTANT): Beginning ground fault scan 2026-02-09T16:44:19.111Z,1770655459.111 [GFScanner](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.012887 CHAN A1 (24V): 0.001110 CHAN A2 (12V): 0.000766 CHAN A3 (5V): -0.001619 CHAN B0 (3.3V): 0.000631 CHAN B1 (3.15aV): 0.000242 CHAN B2 (3.15bV): 0.000357 CHAN B3 (GND): -0.000856 OPEN: 0.006719 Full Scale: +/- 1 mA 2026-02-09T16:45:08.411Z,1770655508.411 [SBIT](IMPORTANT): SBIT PASSED 2026-02-09T16:45:08.411Z,1770655508.411 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2026-02-09T16:45:08.412Z,1770655508.412 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=19 count; 2026-02-09T16:45:08.412Z,1770655508.412 [SBIT](IMPORTANT): Express linearApproximation _.planktivore_HM_AvgRois 2.000000 count_per_second; 2026-02-09T16:45:08.412Z,1770655508.412 [SBIT](IMPORTANT): Express linearApproximation _.planktivore_LM_AvgRois 100.000000 count_per_second; 2026-02-09T16:45:08.412Z,1770655508.412 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=173.954944 cubic_centimeter; 2026-02-09T16:45:08.412Z,1770655508.412 [SBIT](IMPORTANT): VerticalControl.massDefault=-5.462987 millimeter; 2026-02-09T16:45:08.780Z,1770655508.780 [MissionManager](IMPORTANT): Started mission Startup 2026-02-09T16:45:08.781Z,1770655508.781 [Startup] Running Loop=1 2026-02-09T16:45:08.781Z,1770655508.781 [Startup](DEBUG): Aggregate::initialize Startup 2026-02-09T16:45:08.781Z,1770655508.781 [Startup:A.GoToSurface] Running Loop=1 2026-02-09T16:45:08.781Z,1770655508.781 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2026-02-09T16:45:08.781Z,1770655508.781 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2026-02-09T16:45:08.786Z,1770655508.786 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2026-02-09T16:45:08.786Z,1770655508.786 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2026-02-09T16:45:08.787Z,1770655508.787 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2026-02-09T16:45:08.787Z,1770655508.787 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2026-02-09T16:45:08.787Z,1770655508.787 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2026-02-09T16:45:08.789Z,1770655508.789 [Startup:StartupSatComms] Running Loop=1 2026-02-09T16:45:08.789Z,1770655508.789 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2026-02-09T16:45:08.789Z,1770655508.789 [Startup:StartupSatComms:A] Running Loop=1 2026-02-09T16:45:09.186Z,1770655509.187 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2026-02-09T16:45:48.798Z,1770655548.798 [CommandExec](IMPORTANT): got command failComponent 2026-02-09T16:45:48.799Z,1770655548.799 [CommandExec](IMPORTANT): Failed components: 2026-02-09T16:45:48.799Z,1770655548.799 [CommandExec](IMPORTANT): No failed Components. 2026-02-09T16:46:08.971Z,1770655568.971 [Startup:StartupSatComms:A](INFO): Timed out from 2026-02-09T16:45:08.8Z 2026-02-09T16:46:08.972Z,1770655568.972 [Startup:StartupSatComms:A] Stopped 2026-02-09T16:46:08.972Z,1770655568.972 [Startup:StartupSatComms:B] Running Loop=1 2026-02-09T16:46:09.386Z,1770655569.386 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2026-02-09T16:46:13.158Z,1770655573.158 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20260209T164323/Courier0000.lzma 2026-02-09T16:46:14.160Z,1770655574.160 [DataOverHttps](INFO): Moved sent file to Logs/20260209T164323/Courier0000.lzma.bak 2026-02-09T16:46:14.160Z,1770655574.160 [DataOverHttps](INFO): SBD MOMSN=26641421 2026-02-09T16:46:29.911Z,1770655589.911 [DataOverHttps](INFO): Sending 890 bytes from file Logs/20260209T164323/Express0001.lzma 2026-02-09T16:46:30.912Z,1770655590.912 [DataOverHttps](INFO): Moved sent file to Logs/20260209T164323/Express0001.lzma.bak 2026-02-09T16:46:30.912Z,1770655590.912 [DataOverHttps](INFO): SBD MOMSN=26641424 2026-02-09T16:46:32.074Z,1770655592.074 [Startup:StartupSatComms:B] Stopped 2026-02-09T16:46:32.074Z,1770655592.074 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2026-02-09T16:46:32.074Z,1770655592.074 [Startup:StartupSatComms] Stopped 2026-02-09T16:46:32.074Z,1770655592.074 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2026-02-09T16:46:32.075Z,1770655592.075 [Startup](INFO): Completed Startup 2026-02-09T16:46:32.075Z,1770655592.075 [MissionManager](INFO): Startup is completed. 2026-02-09T16:46:32.075Z,1770655592.075 [MissionManager](INFO): Uninitializing Mission Startup 2026-02-09T16:46:32.075Z,1770655592.075 [Startup] Stopped 2026-02-09T16:46:32.075Z,1770655592.075 [Startup](DEBUG): Aggregate::uninitialize Startup 2026-02-09T16:46:32.075Z,1770655592.075 [Startup:A.GoToSurface] Stopped 2026-02-09T16:46:32.075Z,1770655592.075 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2026-02-09T16:46:32.517Z,1770655592.517 [MissionManager](IMPORTANT): Started mission Default 2026-02-09T16:46:32.518Z,1770655592.518 [Default] Running Loop=1 2026-02-09T16:46:32.518Z,1770655592.518 [Default](DEBUG): Aggregate::initialize Default 2026-02-09T16:46:32.518Z,1770655592.518 [Default:B.GoToSurface] Running Loop=1 2026-02-09T16:46:32.518Z,1770655592.518 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2026-02-09T16:46:32.518Z,1770655592.518 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2026-02-09T16:46:32.519Z,1770655592.519 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2026-02-09T16:46:32.519Z,1770655592.519 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2026-02-09T16:46:32.519Z,1770655592.519 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2026-02-09T16:46:32.520Z,1770655592.520 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2026-02-09T16:46:32.520Z,1770655592.520 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2026-02-09T16:46:32.520Z,1770655592.520 [Default:A.Wait] Running Loop=1 2026-02-09T16:46:32.520Z,1770655592.520 [Default:A.Wait](DEBUG): Initialize Wait Component. 2026-02-09T16:46:33.714Z,1770655593.714 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2026-02-09T16:46:33.714Z,1770655593.714 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2026-02-09T16:46:33.724Z,1770655593.724 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2026-02-09T16:46:34.123Z,1770655594.123 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2026-02-09T16:46:34.123Z,1770655594.123 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2026-02-09T16:46:45.820Z,1770655605.820 [Default:A.Wait](INFO): Done Waiting. 2026-02-09T16:46:45.821Z,1770655605.821 [Default:A.Wait] Stopped 2026-02-09T16:46:45.821Z,1770655605.821 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2026-02-09T16:46:46.201Z,1770655606.201 [Default:CheckIn] Running Loop=1 2026-02-09T16:46:46.201Z,1770655606.201 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-02-09T16:46:46.201Z,1770655606.201 [Default:CheckIn:Read_GPS] Running Loop=1 2026-02-09T16:46:46.609Z,1770655606.609 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2026-02-09T16:47:31.867Z,1770655651.867 [CommandExec](IMPORTANT): got command burn on 2026-02-09T16:47:31.867Z,1770655651.867 [CommandExec](IMPORTANT): Activating dropweight wire 2026-02-09T16:47:38.107Z,1770655658.107 [CommandExec](IMPORTANT): got command burn off 2026-02-09T16:47:38.107Z,1770655658.107 [CommandExec](IMPORTANT): Deactivating dropweight wire 2026-02-09T16:48:47.799Z,1770655727.799 [BPC1](ERROR): Battery stick #8 (s/n: 01E7) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-09T16:48:47.800Z,1770655727.800 [BPC1](ERROR): Battery stick #17 (s/n: 0084) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0. 2026-02-09T16:48:47.801Z,1770655727.801 [BPC1](ERROR): Battery stick #24 (s/n: 01D3) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-09T16:48:47.801Z,1770655727.801 [BPC1](ERROR): Battery stick #29 (s/n: 00A7) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0. 2026-02-09T16:48:47.802Z,1770655727.802 [BPC1](ERROR): Battery stick #37 (s/n: 0181) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-09T16:48:47.803Z,1770655727.803 [BPC1](ERROR): Battery stick #38 (s/n: 01BC) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-09T16:48:47.803Z,1770655727.803 [BPC1](ERROR): Battery stick #39 (s/n: 0189) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-09T16:48:47.804Z,1770655727.804 [BPC1](ERROR): Battery stick #44 (s/n: 01BB) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-09T16:48:47.805Z,1770655727.805 [BPC1](ERROR): Battery stick #57 (s/n: 019F) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-09T16:48:47.806Z,1770655727.806 [BPC1](ERROR): Battery stick #59 (s/n: 0184) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x5AD0. 2026-02-09T16:48:47.806Z,1770655727.806 [BPC1](INFO): Calculating totals. Valid battery stick count: 35. Valid reserve battery stick count: 1. 2026-02-09T16:48:47.809Z,1770655727.809 [BPC1](INFO): Received data from all battery sticks. 2026-02-09T16:49:16.887Z,1770655756.887 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2026-02-09T16:49:34.671Z,1770655774.671 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2026-02-09T16:49:34.671Z,1770655774.671 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2026-02-09T16:49:34.681Z,1770655774.681 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2026-02-09T16:49:35.100Z,1770655775.100 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2026-02-09T16:49:35.100Z,1770655775.100 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2026-02-09T16:51:46.400Z,1770655906.400 [Default:CheckIn:Read_GPS](INFO): Timed out from 2026-02-09T16:46:46.2Z 2026-02-09T16:51:46.400Z,1770655906.400 [Default:CheckIn:Read_GPS] Stopped 2026-02-09T16:51:46.400Z,1770655906.400 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-02-09T16:51:46.804Z,1770655906.804 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2026-02-09T16:51:53.157Z,1770655913.157 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20260209T164323/Courier0004.lzma 2026-02-09T16:51:54.160Z,1770655914.160 [DataOverHttps](INFO): Moved sent file to Logs/20260209T164323/Courier0004.lzma.bak 2026-02-09T16:51:54.161Z,1770655914.161 [DataOverHttps](INFO): SBD MOMSN=26641447 2026-02-09T16:52:09.674Z,1770655929.674 [DataOverHttps](INFO): Sending 256 bytes from file Logs/20260209T164323/Express0005.lzma 2026-02-09T16:52:10.676Z,1770655930.676 [DataOverHttps](INFO): Moved sent file to Logs/20260209T164323/Express0005.lzma.bak 2026-02-09T16:52:10.676Z,1770655930.676 [DataOverHttps](INFO): SBD MOMSN=26641449 2026-02-09T16:52:11.832Z,1770655931.832 [Default:CheckIn:Read_Iridium] Stopped 2026-02-09T16:52:11.832Z,1770655931.832 [Default:CheckIn:C.Wait] Running Loop=1 2026-02-09T16:52:11.832Z,1770655931.832 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-02-09T16:52:35.667Z,1770655955.667 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2026-02-09T16:52:35.667Z,1770655955.667 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2026-02-09T16:52:35.677Z,1770655955.677 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2026-02-09T16:52:36.086Z,1770655956.086 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2026-02-09T16:52:36.086Z,1770655956.086 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2026-02-09T16:54:15.452Z,1770656055.452 [NAL9602](FAULT): GPS failed to acquire within timeout. 2026-02-09T16:54:15.452Z,1770656055.452 [NAL9602] Data Fault, FailCount= 1 2026-02-09T16:54:15.452Z,1770656055.452 [NAL9602](ERROR): Data Fault 2026-02-09T16:54:15.469Z,1770656055.469 [CBIT](ERROR): Data Fault in component: NAL9602 2026-02-09T16:54:15.851Z,1770656055.851 [NAL9602](INFO): Powering down 2026-02-09T16:54:16.699Z,1770656056.699 [CBIT](INFO): Clearing failed state for component NAL9602 2026-02-09T16:54:16.699Z,1770656056.699 [NAL9602] No Fault, FailCount= 1 2026-02-09T16:54:46.151Z,1770656086.151 [NAL9602](INFO): Powering up NAL9602 2026-02-09T16:54:57.064Z,1770656097.064 [NAL9602](INFO): NAL9602 initialized 2026-02-09T16:55:36.684Z,1770656136.684 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2026-02-09T16:55:36.684Z,1770656136.684 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2026-02-09T16:55:36.694Z,1770656136.694 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2026-02-09T16:55:37.092Z,1770656137.092 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2026-02-09T16:55:37.092Z,1770656137.092 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2026-02-09T16:57:12.436Z,1770656232.436 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-02-09T16:57:12.436Z,1770656232.436 [Default:CheckIn:C.Wait] Stopped 2026-02-09T16:57:12.436Z,1770656232.436 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-02-09T16:57:12.436Z,1770656232.436 [Default:CheckIn:D] Running Loop=1 2026-02-09T16:57:12.836Z,1770656232.836 [Default:CheckIn:D] Stopped 2026-02-09T16:57:12.836Z,1770656232.836 [Default:CheckIn:E] Running Loop=1 2026-02-09T16:57:13.248Z,1770656233.248 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.671968 min 2026-02-09T16:57:13.248Z,1770656233.248 [Default:CheckIn:E] Stopped 2026-02-09T16:57:13.248Z,1770656233.248 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-02-09T16:57:13.248Z,1770656233.248 [Default:CheckIn] Stopped 2026-02-09T16:57:13.248Z,1770656233.248 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-02-09T16:57:13.248Z,1770656233.248 [Default:CheckIn](INFO): Running loop #2 2026-02-09T16:57:13.249Z,1770656233.249 [Default:CheckIn] Running Loop=2 2026-02-09T16:57:13.249Z,1770656233.249 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-02-09T16:57:13.249Z,1770656233.249 [Default:CheckIn:Read_GPS] Running Loop=1 2026-02-09T16:58:27.955Z,1770656307.955 [DataOverHttps](IMPORTANT): SBD MTMSN=20260209T165827 2026-02-09T16:58:34.033Z,1770656314.033 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165832.00,A,3648.17231,N,12147.28256,W,0.991,44.70,090226,,,A*4B 2026-02-09T16:58:34.036Z,1770656314.036 [NAL9602](INFO): GPS fix at 20260209T165832: (36.802872, -121.788043) 2026-02-09T16:58:34.048Z,1770656314.048 [Default:CheckIn:Read_GPS] Stopped 2026-02-09T16:58:34.048Z,1770656314.048 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-02-09T16:58:41.313Z,1770656321.313 [DataOverHttps](INFO): Sending 223 bytes from file Logs/20260209T164323/Courier0007.lzma 2026-02-09T16:58:41.316Z,1770656321.316 [DataOverHttps](INFO): Received command: ibit 2026-02-09T16:58:41.359Z,1770656321.359 [CommandExec](IMPORTANT): got command ibit 2026-02-09T16:58:41.743Z,1770656321.743 [IBIT](IMPORTANT): Beginning Initiated BIT 2026-02-09T16:58:41.744Z,1770656321.744 [IBIT](IMPORTANT): Beginning control surface checks. 2026-02-09T16:58:41.747Z,1770656321.747 [GFScanner](IMPORTANT): Beginning ground fault scan 2026-02-09T16:58:42.806Z,1770656322.806 [DataOverHttps](INFO): Moved sent file to Logs/20260209T164323/Courier0007.lzma.bak 2026-02-09T16:58:42.806Z,1770656322.806 [DataOverHttps](INFO): SBD MOMSN=26641513 2026-02-09T16:58:43.317Z,1770656323.317 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165842.00,A,3648.17509,N,12147.28126,W,0.097,18.22,090226,,,A*45 2026-02-09T16:58:43.339Z,1770656323.339 [NAL9602](INFO): GPS fix at 20260209T165842: (36.802918, -121.788021) 2026-02-09T16:58:45.794Z,1770656325.794 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165845.00,A,3648.17476,N,12147.28129,W,0.680,16.50,090226,,,A*4F 2026-02-09T16:58:45.796Z,1770656325.796 [NAL9602](INFO): GPS fix at 20260209T165845: (36.802913, -121.788021) 2026-02-09T16:58:46.369Z,1770656326.369 [GFScanner](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.000608 CHAN A1 (24V): 0.000759 CHAN A2 (12V): -0.000564 CHAN A3 (5V): -0.001956 CHAN B0 (3.3V): 0.000608 CHAN B1 (3.15aV): -0.000222 CHAN B2 (3.15bV): -0.000620 CHAN B3 (GND): -0.000406 OPEN: 0.006394 Full Scale: +/- 1 mA 2026-02-09T16:58:49.108Z,1770656329.108 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165848.00,A,3648.17393,N,12147.28134,W,1.711,111.05,090226,,,A*7C 2026-02-09T16:58:49.114Z,1770656329.114 [NAL9602](INFO): GPS fix at 20260209T165848: (36.802899, -121.788022) 2026-02-09T16:58:51.876Z,1770656331.876 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165851.00,A,3648.17598,N,12147.28032,W,0.136,111.05,090226,,,A*7C 2026-02-09T16:58:51.878Z,1770656331.878 [NAL9602](INFO): GPS fix at 20260209T165851: (36.802933, -121.788005) 2026-02-09T16:58:54.704Z,1770656334.704 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165854.00,A,3648.17705,N,12147.27980,W,0.428,111.05,090226,,,A*7A 2026-02-09T16:58:54.716Z,1770656334.716 [NAL9602](INFO): GPS fix at 20260209T165854: (36.802951, -121.787997) 2026-02-09T16:58:57.936Z,1770656337.936 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165857.00,A,3648.17793,N,12147.27932,W,1.283,70.32,090226,,,A*4B 2026-02-09T16:58:57.948Z,1770656337.948 [NAL9602](INFO): GPS fix at 20260209T165857: (36.802965, -121.787989) 2026-02-09T16:59:00.769Z,1770656340.769 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165900.00,A,3648.17858,N,12147.27899,W,0.194,70.32,090226,,,A*44 2026-02-09T16:59:00.771Z,1770656340.771 [NAL9602](INFO): GPS fix at 20260209T165900: (36.802976, -121.787983) 2026-02-09T16:59:03.996Z,1770656343.996 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165903.00,A,3648.17924,N,12147.27877,W,0.641,46.09,090226,,,A*4F 2026-02-09T16:59:03.999Z,1770656343.999 [NAL9602](INFO): GPS fix at 20260209T165903: (36.802987, -121.787980) 2026-02-09T16:59:06.824Z,1770656346.824 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165906.00,A,3648.17905,N,12147.27895,W,0.797,46.09,090226,,,A*4F 2026-02-09T16:59:06.826Z,1770656346.826 [NAL9602](INFO): GPS fix at 20260209T165906: (36.802984, -121.787982) 2026-02-09T16:59:10.056Z,1770656350.056 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165909.00,A,3648.17923,N,12147.27893,W,0.622,46.09,090226,,,A*4D 2026-02-09T16:59:10.067Z,1770656350.067 [NAL9602](INFO): GPS fix at 20260209T165909: (36.802987, -121.787982) 2026-02-09T16:59:10.387Z,1770656350.387 [DataOverHttps](IMPORTANT): SBD MTMSN=20260209T165909 2026-02-09T16:59:12.885Z,1770656352.885 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165912.00,A,3648.17900,N,12147.27900,W,0.914,46.09,090226,,,A*47 2026-02-09T16:59:12.888Z,1770656352.888 [NAL9602](INFO): GPS fix at 20260209T165912: (36.802983, -121.787983) 2026-02-09T16:59:16.121Z,1770656356.121 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165915.00,A,3648.17856,N,12147.27915,W,0.603,46.09,090226,,,A*4F 2026-02-09T16:59:16.123Z,1770656356.123 [NAL9602](INFO): GPS fix at 20260209T165915: (36.802976, -121.787986) 2026-02-09T16:59:18.013Z,1770656358.013 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20260209T164323/Courier0010.lzma 2026-02-09T16:59:18.015Z,1770656358.015 [DataOverHttps](INFO): Received command: failc 2026-02-09T16:59:18.057Z,1770656358.057 [CommandExec](IMPORTANT): got command failComponent 2026-02-09T16:59:18.057Z,1770656358.057 [CommandExec](IMPORTANT): Failed components: 2026-02-09T16:59:18.057Z,1770656358.057 [CommandExec](IMPORTANT): No failed Components. 2026-02-09T16:59:18.949Z,1770656358.949 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165918.00,A,3648.17852,N,12147.27926,W,0.680,46.09,090226,,,A*4D 2026-02-09T16:59:18.952Z,1770656358.952 [NAL9602](INFO): GPS fix at 20260209T165918: (36.802975, -121.787988) 2026-02-09T16:59:19.237Z,1770656359.237 [DataOverHttps](INFO): Moved sent file to Logs/20260209T164323/Courier0010.lzma.bak 2026-02-09T16:59:19.237Z,1770656359.237 [DataOverHttps](INFO): SBD MOMSN=26641518 2026-02-09T16:59:21.772Z,1770656361.772 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165921.00,A,3648.17847,N,12147.27918,W,0.719,46.09,090226,,,A*4F 2026-02-09T16:59:21.774Z,1770656361.774 [NAL9602](INFO): GPS fix at 20260209T165921: (36.802974, -121.787986) 2026-02-09T16:59:25.005Z,1770656365.005 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165924.00,A,3648.17824,N,12147.27915,W,0.350,46.09,090226,,,A*4B 2026-02-09T16:59:25.007Z,1770656365.007 [NAL9602](INFO): GPS fix at 20260209T165924: (36.802971, -121.787986) 2026-02-09T16:59:27.832Z,1770656367.832 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165927.00,A,3648.17780,N,12147.27934,W,0.428,46.09,090226,,,A*42 2026-02-09T16:59:27.846Z,1770656367.846 [NAL9602](INFO): GPS fix at 20260209T165927: (36.802963, -121.787989) 2026-02-09T16:59:31.065Z,1770656371.065 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165930.00,A,3648.17774,N,12147.27929,W,0.991,46.09,090226,,,A*4C 2026-02-09T16:59:31.067Z,1770656371.067 [NAL9602](INFO): GPS fix at 20260209T165930: (36.802962, -121.787988) 2026-02-09T16:59:33.897Z,1770656373.897 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165933.00,A,3648.17787,N,12147.27911,W,0.467,46.09,090226,,,A*4C 2026-02-09T16:59:33.899Z,1770656373.899 [NAL9602](INFO): GPS fix at 20260209T165933: (36.802965, -121.787985) 2026-02-09T16:59:34.981Z,1770656374.981 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20260209T164323/Courier0013.lzma 2026-02-09T16:59:37.129Z,1770656377.129 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165936.00,A,3648.17813,N,12147.27888,W,0.991,46.09,090226,,,A*4E 2026-02-09T16:59:37.132Z,1770656377.132 [NAL9602](INFO): GPS fix at 20260209T165936: (36.802969, -121.787981) 2026-02-09T16:59:39.953Z,1770656379.953 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165939.00,A,3648.17894,N,12147.27847,W,0.622,46.09,090226,,,A*4A 2026-02-09T16:59:39.956Z,1770656379.956 [NAL9602](INFO): GPS fix at 20260209T165939: (36.802982, -121.787975) 2026-02-09T16:59:42.009Z,1770656382.009 [DataOverHttps](INFO): Moved sent file to Logs/20260209T164323/Courier0013.lzma.bak 2026-02-09T16:59:42.009Z,1770656382.009 [DataOverHttps](INFO): SBD MOMSN=26641521 2026-02-09T16:59:42.781Z,1770656382.781 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165942.00,A,3648.17926,N,12147.27832,W,0.350,32.39,090226,,,A*4C 2026-02-09T16:59:42.783Z,1770656382.783 [NAL9602](INFO): GPS fix at 20260209T165942: (36.802988, -121.787972) 2026-02-09T16:59:46.013Z,1770656386.013 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165945.00,A,3648.17826,N,12147.27876,W,0.525,32.39,090226,,,A*4E 2026-02-09T16:59:46.015Z,1770656386.015 [NAL9602](INFO): GPS fix at 20260209T165945: (36.802971, -121.787979) 2026-02-09T16:59:48.845Z,1770656388.845 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165948.00,A,3648.17746,N,12147.27911,W,0.467,153.40,090226,,,A*75 2026-02-09T16:59:48.847Z,1770656388.847 [NAL9602](INFO): GPS fix at 20260209T165948: (36.802958, -121.787985) 2026-02-09T16:59:52.075Z,1770656392.075 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165951.00,A,3648.17688,N,12147.27945,W,1.730,176.44,090226,,,A*7C 2026-02-09T16:59:52.077Z,1770656392.077 [NAL9602](INFO): GPS fix at 20260209T165951: (36.802948, -121.787991) 2026-02-09T16:59:54.900Z,1770656394.900 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165954.00,A,3648.17651,N,12147.27956,W,1.244,105.53,090226,,,A*7B 2026-02-09T16:59:54.902Z,1770656394.902 [NAL9602](INFO): GPS fix at 20260209T165954: (36.802942, -121.787993) 2026-02-09T16:59:58.133Z,1770656398.133 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165957.00,A,3648.17524,N,12147.28013,W,0.428,188.24,090226,,,A*76 2026-02-09T16:59:58.137Z,1770656398.137 [NAL9602](INFO): GPS fix at 20260209T165957: (36.802921, -121.788002) 2026-02-09T17:00:00.961Z,1770656400.961 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,170000.00,A,3648.17459,N,12147.28046,W,1.400,191.50,090226,,,A*72 2026-02-09T17:00:00.963Z,1770656400.963 [NAL9602](INFO): GPS fix at 20260209T170000: (36.802910, -121.788008) 2026-02-09T17:00:03.018Z,1770656403.018 [DataOverHttps](INFO): Sending 443 bytes from file Logs/20260209T164323/Express0008.lzma 2026-02-09T17:00:03.797Z,1770656403.797 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,170003.00,A,3648.17532,N,12147.28007,W,0.583,191.50,090226,,,A*73 2026-02-09T17:00:03.800Z,1770656403.800 [NAL9602](INFO): GPS fix at 20260209T170003: (36.802922, -121.788001) 2026-02-09T17:00:07.020Z,1770656407.020 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,170006.00,A,3648.17566,N,12147.27998,W,0.272,191.50,090226,,,A*7E 2026-02-09T17:00:07.033Z,1770656407.033 [NAL9602](INFO): GPS fix at 20260209T170006: (36.802928, -121.788000) 2026-02-09T17:00:09.853Z,1770656409.853 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,170009.00,A,3648.17560,N,12147.28010,W,0.583,191.50,090226,,,A*78 2026-02-09T17:00:09.855Z,1770656409.855 [NAL9602](INFO): GPS fix at 20260209T170009: (36.802927, -121.788002) 2026-02-09T17:00:13.085Z,1770656413.085 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,170012.00,A,3648.17557,N,12147.28029,W,0.486,191.50,090226,,,A*78 2026-02-09T17:00:13.087Z,1770656413.087 [NAL9602](INFO): GPS fix at 20260209T170012: (36.802926, -121.788005) 2026-02-09T17:00:15.064Z,1770656415.064 [DataOverHttps](INFO): Moved sent file to Logs/20260209T164323/Express0008.lzma.bak 2026-02-09T17:00:15.064Z,1770656415.064 [DataOverHttps](INFO): SBD MOMSN=26641524 2026-02-09T17:00:15.913Z,1770656415.913 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,170015.00,A,3648.17551,N,12147.28059,W,0.175,191.50,090226,,,A*77 2026-02-09T17:00:15.915Z,1770656415.915 [NAL9602](INFO): GPS fix at 20260209T170015: (36.802925, -121.788010) 2026-02-09T17:00:19.141Z,1770656419.141 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,170018.00,A,3648.17537,N,12147.28077,W,0.486,191.50,090226,,,A*7F 2026-02-09T17:00:19.143Z,1770656419.143 [NAL9602](INFO): GPS fix at 20260209T170018: (36.802923, -121.788013) 2026-02-09T17:00:21.970Z,1770656421.970 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,170021.00,A,3648.17551,N,12147.28070,W,0.428,191.50,090226,,,A*76 2026-02-09T17:00:21.972Z,1770656421.972 [NAL9602](INFO): GPS fix at 20260209T170021: (36.802925, -121.788012) 2026-02-09T17:00:24.796Z,1770656424.796 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,170024.00,A,3648.17560,N,12147.28048,W,0.447,191.50,090226,,,A*73 2026-02-09T17:00:24.799Z,1770656424.799 [NAL9602](INFO): GPS fix at 20260209T170024: (36.802927, -121.788008) 2026-02-09T17:00:28.029Z,1770656428.029 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,170027.00,A,3648.17571,N,12147.28032,W,0.194,191.50,090226,,,A*76 2026-02-09T17:00:28.031Z,1770656428.031 [NAL9602](INFO): GPS fix at 20260209T170027: (36.802929, -121.788005) 2026-02-09T17:00:30.857Z,1770656430.857 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,170030.00,A,3648.17558,N,12147.28013,W,0.078,191.50,090226,,,A*7B 2026-02-09T17:00:30.859Z,1770656430.859 [NAL9602](INFO): GPS fix at 20260209T170030: (36.802926, -121.788002) 2026-02-09T17:00:31.981Z,1770656431.981 [DataOverHttps](INFO): Sending 188 bytes from file Logs/20260209T164323/Express0011.lzma 2026-02-09T17:00:32.090Z,1770656432.090 [IBIT](FAULT): Error acquiring IBIT communications status. Timeout expired. 2026-02-09T17:00:32.499Z,1770656432.499 [IBIT](IMPORTANT): Battery Status: Battery Charge (AH): 0.000000 Voltage: 16.611000 2026-02-09T17:00:32.499Z,1770656432.499 [IBIT](IMPORTANT): batteryCapacityThreshold: 50.000000 Ah 2026-02-09T17:00:32.499Z,1770656432.499 [IBIT](IMPORTANT): batteryVoltageThreshold: 13.700000 V 2026-02-09T17:00:32.916Z,1770656432.916 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 % 2026-02-09T17:00:32.916Z,1770656432.916 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi 2026-02-09T17:00:32.917Z,1770656432.917 [IBIT](IMPORTANT): Pressure:10.303260 PSI 2026-02-09T17:00:32.917Z,1770656432.917 [IBIT](IMPORTANT): Humidity:5.628129 % 2026-02-09T17:00:33.299Z,1770656433.299 [IBIT](IMPORTANT): Vehicle Pitch:-2.246532 degrees 2026-02-09T17:00:33.299Z,1770656433.299 [IBIT](IMPORTANT): Vehicle Roll:-5.363307 degrees 2026-02-09T17:00:33.299Z,1770656433.299 [IBIT](IMPORTANT): Vehicle Heading:15.915294 degrees 2026-02-09T17:00:33.724Z,1770656433.724 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m 2026-02-09T17:00:33.724Z,1770656433.724 [IBIT](IMPORTANT): buoyancyNeutral: 173.954941 cc 2026-02-09T17:00:33.724Z,1770656433.724 [IBIT](IMPORTANT): massDefault: -0.546299 cm 2026-02-09T17:00:33.725Z,1770656433.725 [IBIT](IMPORTANT): stopDepth: 290.000000 m 2026-02-09T17:00:33.725Z,1770656433.725 [IBIT](IMPORTANT): abortDepth: 300.000000 m 2026-02-09T17:00:33.725Z,1770656433.725 [IBIT](IMPORTANT): IBIT FAILED 2026-02-09T17:00:34.093Z,1770656434.093 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,170033.00,A,3648.17519,N,12147.28008,W,0.389,191.50,090226,,,A*7A 2026-02-09T17:00:34.107Z,1770656434.107 [NAL9602](INFO): GPS fix at 20260209T170033: (36.802920, -121.788001) 2026-02-09T17:00:35.996Z,1770656435.996 [DataOverHttps](INFO): Moved sent file to Logs/20260209T164323/Express0011.lzma.bak 2026-02-09T17:00:35.996Z,1770656435.996 [DataOverHttps](INFO): SBD MOMSN=26641529 2026-02-09T17:01:06.471Z,1770656466.471 [NAL9602](INFO): Not Powering down - fast GPS 2026-02-09T17:01:47.178Z,1770656507.178 [DataOverHttps](INFO): Sending 514 bytes from file Logs/20260209T164323/Express0014.lzma 2026-02-09T17:01:52.196Z,1770656512.196 [DataOverHttps](INFO): Moved sent file to Logs/20260209T164323/Express0014.lzma.bak 2026-02-09T17:01:52.196Z,1770656512.196 [DataOverHttps](INFO): SBD MOMSN=26641535 2026-02-09T17:01:53.354Z,1770656513.354 [Default:CheckIn:Read_Iridium] Stopped 2026-02-09T17:01:53.370Z,1770656513.370 [Default:CheckIn:C.Wait] Running Loop=1 2026-02-09T17:01:53.370Z,1770656513.370 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-02-09T17:03:55.130Z,1770656635.130 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting. 2026-02-09T17:06:53.929Z,1770656813.929 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-02-09T17:06:53.929Z,1770656813.929 [Default:CheckIn:C.Wait] Stopped 2026-02-09T17:06:53.930Z,1770656813.930 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-02-09T17:06:53.930Z,1770656813.930 [Default:CheckIn:D] Running Loop=1 2026-02-09T17:06:54.335Z,1770656814.335 [Default:CheckIn:D] Stopped 2026-02-09T17:06:54.335Z,1770656814.335 [Default:CheckIn:E] Running Loop=1 2026-02-09T17:06:54.728Z,1770656814.728 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 20.363615 min 2026-02-09T17:06:54.729Z,1770656814.729 [Default:CheckIn:E] Stopped 2026-02-09T17:06:54.729Z,1770656814.729 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-02-09T17:06:54.729Z,1770656814.729 [Default:CheckIn] Stopped 2026-02-09T17:06:54.729Z,1770656814.729 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-02-09T17:06:54.729Z,1770656814.729 [Default:CheckIn](INFO): Running loop #3 2026-02-09T17:06:54.729Z,1770656814.729 [Default:CheckIn] Running Loop=3 2026-02-09T17:06:54.729Z,1770656814.729 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-02-09T17:06:54.729Z,1770656814.729 [Default:CheckIn:Read_GPS] Running Loop=1 2026-02-09T17:06:56.741Z,1770656816.741 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,170656.00,A,3648.17170,N,12147.28325,W,0.156,199.73,090226,,,A*71 2026-02-09T17:06:56.743Z,1770656816.743 [NAL9602](INFO): GPS fix at 20260209T170656: (36.802862, -121.788054) 2026-02-09T17:06:56.755Z,1770656816.755 [Default:CheckIn:Read_GPS] Stopped 2026-02-09T17:06:56.755Z,1770656816.755 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-02-09T17:07:05.313Z,1770656825.313 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20260209T164323/Courier0016.lzma 2026-02-09T17:07:10.332Z,1770656830.332 [DataOverHttps](INFO): Moved sent file to Logs/20260209T164323/Courier0016.lzma.bak 2026-02-09T17:07:10.332Z,1770656830.332 [DataOverHttps](INFO): SBD MOMSN=26641561 2026-02-09T17:07:30.681Z,1770656850.681 [NAL9602](INFO): SBD MO Status=2, MOMSN=30463, MT Status=2, MTMSN=0 2026-02-09T17:07:30.681Z,1770656850.681 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-02-09T17:07:45.487Z,1770656865.487 [DataOverHttps](INFO): Sending 869 bytes from file Logs/20260209T164323/Express0017.lzma 2026-02-09T17:07:58.540Z,1770656878.540 [DataOverHttps](INFO): Moved sent file to Logs/20260209T164323/Express0017.lzma.bak 2026-02-09T17:07:58.540Z,1770656878.540 [DataOverHttps](INFO): SBD MOMSN=26641564 2026-02-09T17:07:59.782Z,1770656879.782 [Default:CheckIn:Read_Iridium] Stopped 2026-02-09T17:07:59.782Z,1770656879.782 [Default:CheckIn:C.Wait] Running Loop=1 2026-02-09T17:07:59.782Z,1770656879.782 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-02-09T17:08:09.057Z,1770656889.057 [NAL9602](INFO): SBD MO Status=2, MOMSN=30463, MT Status=2, MTMSN=0 2026-02-09T17:08:09.057Z,1770656889.057 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-02-09T17:09:22.593Z,1770656962.593 [NAL9602](INFO): SBD MO Status=2, MOMSN=30463, MT Status=2, MTMSN=0 2026-02-09T17:09:22.593Z,1770656962.593 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-02-09T17:09:30.870Z,1770656970.870 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-09T17:09:56.520Z,1770656996.520 [NAL9602](INFO): SBD MO Status=2, MOMSN=30463, MT Status=2, MTMSN=0 2026-02-09T17:09:56.520Z,1770656996.520 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-02-09T17:10:41.369Z,1770657041.369 [NAL9602](INFO): SBD MO Status=2, MOMSN=30463, MT Status=2, MTMSN=0 2026-02-09T17:10:41.369Z,1770657041.369 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-02-09T17:10:58.340Z,1770657058.340 [NAL9602](INFO): SBD MO Status=2, MOMSN=30463, MT Status=2, MTMSN=0 2026-02-09T17:10:58.341Z,1770657058.341 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-02-09T17:11:08.433Z,1770657068.433 [NAL9602](INFO): SBD MO Status=0, MOMSN=30463, MT Status=0, MTMSN=0 2026-02-09T17:11:08.433Z,1770657068.433 [NAL9602](INFO): No messages in MT queue 2026-02-09T17:11:39.135Z,1770657099.135 [NAL9602](INFO): Not Powering down - fast GPS 2026-02-09T17:11:42.084Z,1770657102.084 [DataOverHttps](IMPORTANT): SBD MTMSN=20260209T171141 2026-02-09T17:11:49.413Z,1770657109.413 [DataOverHttps](INFO): Received command: ibit 2026-02-09T17:11:49.458Z,1770657109.458 [CommandExec](IMPORTANT): got command ibit 2026-02-09T17:11:49.664Z,1770657109.664 [IBIT](IMPORTANT): Beginning Initiated BIT 2026-02-09T17:11:49.664Z,1770657109.664 [IBIT](IMPORTANT): Beginning control surface checks. 2026-02-09T17:11:49.672Z,1770657109.672 [GFScanner](IMPORTANT): Beginning ground fault scan 2026-02-09T17:11:51.261Z,1770657111.261 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,171150.00,A,3648.17299,N,12147.28160,W,0.117,199.73,090226,,,A*73 2026-02-09T17:11:51.263Z,1770657111.263 [NAL9602](INFO): GPS fix at 20260209T171150: (36.802883, -121.788027) 2026-02-09T17:11:54.175Z,1770657114.175 [GFScanner](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.000984 CHAN A1 (24V): 0.000288 CHAN A2 (12V): 0.000418 CHAN A3 (5V): -0.001178 CHAN B0 (3.3V): 0.000334 CHAN B1 (3.15aV): -0.000145 CHAN B2 (3.15bV): -0.000452 CHAN B3 (GND): -0.000035 OPEN: 0.006751 Full Scale: +/- 1 mA 2026-02-09T17:12:14.712Z,1770657134.712 [NAL9602](INFO): SBD MO Status=2, MOMSN=30464, MT Status=2, MTMSN=0 2026-02-09T17:12:14.713Z,1770657134.713 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-02-09T17:12:35.724Z,1770657155.724 [IBIT](IMPORTANT): Communications Status: Fix Status: 1 Iridium Signal Strength: 2 Latitude: 36.802883 Longitude: -121.788025 2026-02-09T17:12:36.129Z,1770657156.129 [IBIT](IMPORTANT): Battery Status: Battery Charge (AH): 0.000000 Voltage: 16.532000 2026-02-09T17:12:36.129Z,1770657156.129 [IBIT](IMPORTANT): batteryCapacityThreshold: 50.000000 Ah 2026-02-09T17:12:36.130Z,1770657156.130 [IBIT](IMPORTANT): batteryVoltageThreshold: 13.700000 V 2026-02-09T17:12:36.525Z,1770657156.525 [NAL9602](INFO): SBD MO Status=2, MOMSN=30464, MT Status=2, MTMSN=0 2026-02-09T17:12:36.525Z,1770657156.525 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-02-09T17:12:36.541Z,1770657156.541 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 % 2026-02-09T17:12:36.541Z,1770657156.541 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi 2026-02-09T17:12:36.541Z,1770657156.541 [IBIT](IMPORTANT): Pressure:10.321183 PSI 2026-02-09T17:12:36.542Z,1770657156.542 [IBIT](IMPORTANT): Humidity:5.573190 % 2026-02-09T17:12:36.960Z,1770657156.960 [IBIT](IMPORTANT): Vehicle Pitch:-2.240755 degrees 2026-02-09T17:12:36.960Z,1770657156.960 [IBIT](IMPORTANT): Vehicle Roll:-5.340291 degrees 2026-02-09T17:12:36.961Z,1770657156.961 [IBIT](IMPORTANT): Vehicle Heading:15.504229 degrees 2026-02-09T17:12:37.349Z,1770657157.349 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m 2026-02-09T17:12:37.358Z,1770657157.358 [IBIT](IMPORTANT): buoyancyNeutral: 173.954941 cc 2026-02-09T17:12:37.358Z,1770657157.358 [IBIT](IMPORTANT): massDefault: -0.546299 cm 2026-02-09T17:12:37.359Z,1770657157.359 [IBIT](IMPORTANT): stopDepth: 290.000000 m 2026-02-09T17:12:37.359Z,1770657157.359 [IBIT](IMPORTANT): abortDepth: 300.000000 m 2026-02-09T17:12:37.359Z,1770657157.359 [IBIT](IMPORTANT): IBIT PASSED 2026-02-09T17:13:00.381Z,1770657180.381 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-02-09T17:13:00.381Z,1770657180.381 [Default:CheckIn:C.Wait] Stopped 2026-02-09T17:13:00.382Z,1770657180.382 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-02-09T17:13:00.382Z,1770657180.382 [Default:CheckIn:D] Running Loop=1 2026-02-09T17:13:00.780Z,1770657180.780 [Default:CheckIn:D] Stopped 2026-02-09T17:13:00.781Z,1770657180.781 [Default:CheckIn:E] Running Loop=1 2026-02-09T17:13:01.170Z,1770657181.170 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 26.471043 min 2026-02-09T17:13:01.170Z,1770657181.170 [Default:CheckIn:E] Stopped 2026-02-09T17:13:01.170Z,1770657181.170 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-02-09T17:13:01.170Z,1770657181.170 [Default:CheckIn] Stopped 2026-02-09T17:13:01.171Z,1770657181.171 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-02-09T17:13:01.171Z,1770657181.171 [Default:CheckIn](INFO): Running loop #4 2026-02-09T17:13:01.171Z,1770657181.171 [Default:CheckIn] Running Loop=4 2026-02-09T17:13:01.171Z,1770657181.171 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-02-09T17:13:01.171Z,1770657181.171 [Default:CheckIn:Read_GPS] Running Loop=1 2026-02-09T17:13:45.910Z,1770657225.910 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-09T17:14:15.359Z,1770657255.359 [DataOverHttps](IMPORTANT): SBD MTMSN=20260209T171414 2026-02-09T17:14:23.917Z,1770657263.917 [DataOverHttps](INFO): Received command: ibit 2026-02-09T17:14:23.968Z,1770657263.968 [CommandExec](IMPORTANT): got command ibit 2026-02-09T17:14:23.997Z,1770657263.997 [IBIT](IMPORTANT): Beginning Initiated BIT 2026-02-09T17:14:23.997Z,1770657263.997 [IBIT](IMPORTANT): Beginning control surface checks. 2026-02-09T17:14:24.000Z,1770657264.000 [GFScanner](IMPORTANT): Beginning ground fault scan 2026-02-09T17:14:28.532Z,1770657268.532 [GFScanner](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.000801 CHAN A1 (24V): 0.000486 CHAN A2 (12V): 0.000104 CHAN A3 (5V): -0.001089 CHAN B0 (3.3V): 0.000281 CHAN B1 (3.15aV): 0.000124 CHAN B2 (3.15bV): -0.000095 CHAN B3 (GND): 0.000143 OPEN: 0.006883 Full Scale: +/- 1 mA 2026-02-09T17:15:37.540Z,1770657337.540 [IBIT](IMPORTANT): Communications Status: Fix Status: 1 Iridium Signal Strength: 2 Latitude: 36.802883 Longitude: -121.788025 2026-02-09T17:15:37.936Z,1770657337.936 [IBIT](IMPORTANT): Battery Status: Battery Charge (AH): 0.000000 Voltage: 16.532000 2026-02-09T17:15:37.936Z,1770657337.936 [IBIT](IMPORTANT): batteryCapacityThreshold: 50.000000 Ah 2026-02-09T17:15:37.937Z,1770657337.937 [IBIT](IMPORTANT): batteryVoltageThreshold: 13.700000 V 2026-02-09T17:15:38.342Z,1770657338.342 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 % 2026-02-09T17:15:38.342Z,1770657338.342 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi 2026-02-09T17:15:38.343Z,1770657338.343 [IBIT](IMPORTANT): Pressure:10.301325 PSI 2026-02-09T17:15:38.343Z,1770657338.343 [IBIT](IMPORTANT): Humidity:5.573190 % 2026-02-09T17:15:38.755Z,1770657338.755 [IBIT](IMPORTANT): Vehicle Pitch:-2.255018 degrees 2026-02-09T17:15:38.755Z,1770657338.755 [IBIT](IMPORTANT): Vehicle Roll:-5.355986 degrees 2026-02-09T17:15:38.755Z,1770657338.755 [IBIT](IMPORTANT): Vehicle Heading:15.488632 degrees 2026-02-09T17:15:39.139Z,1770657339.139 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m 2026-02-09T17:15:39.140Z,1770657339.140 [IBIT](IMPORTANT): buoyancyNeutral: 173.954941 cc 2026-02-09T17:15:39.140Z,1770657339.140 [IBIT](IMPORTANT): massDefault: -0.546299 cm 2026-02-09T17:15:39.140Z,1770657339.140 [IBIT](IMPORTANT): stopDepth: 290.000000 m 2026-02-09T17:15:39.140Z,1770657339.140 [IBIT](IMPORTANT): abortDepth: 300.000000 m 2026-02-09T17:15:39.141Z,1770657339.141 [IBIT](IMPORTANT): IBIT PASSED 2026-02-09T17:15:44.377Z,1770657344.377 [NAL9602](INFO): SBD MO Status=0, MOMSN=30464, MT Status=0, MTMSN=0 2026-02-09T17:15:44.377Z,1770657344.377 [NAL9602](INFO): No messages in MT queue 2026-02-09T17:15:45.589Z,1770657345.589 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,171544.00,A,3648.16942,N,12147.28353,W,0.622,201.25,090226,,,A*7C 2026-02-09T17:15:45.591Z,1770657345.591 [NAL9602](INFO): GPS fix at 20260209T171544: (36.802824, -121.788059) 2026-02-09T17:15:45.602Z,1770657345.602 [Default:CheckIn:Read_GPS] Stopped 2026-02-09T17:15:45.602Z,1770657345.602 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-02-09T17:15:52.728Z,1770657352.728 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20260209T164323/Courier0019.lzma 2026-02-09T17:15:54.732Z,1770657354.732 [DataOverHttps](INFO): Moved sent file to Logs/20260209T164323/Courier0019.lzma.bak 2026-02-09T17:15:54.732Z,1770657354.732 [DataOverHttps](INFO): SBD MOMSN=26641626 2026-02-09T17:16:10.539Z,1770657370.539 [DataOverHttps](INFO): Sending 977 bytes from file Logs/20260209T164323/Express0020.lzma 2026-02-09T17:16:18.315Z,1770657378.315 [NAL9602](INFO): Not Powering down - fast GPS 2026-02-09T17:16:25.620Z,1770657385.620 [DataOverHttps](INFO): Moved sent file to Logs/20260209T164323/Express0020.lzma.bak 2026-02-09T17:16:25.620Z,1770657385.620 [DataOverHttps](INFO): SBD MOMSN=26641629 2026-02-09T17:17:02.929Z,1770657422.929 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20260209T164323/Express0021.lzma 2026-02-09T17:17:13.970Z,1770657433.970 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting. 2026-02-09T17:17:21.349Z,1770657441.349 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20260209T164323/Express0021.lzma 2026-02-09T17:17:22.356Z,1770657442.356 [DataOverHttps](INFO): Moved sent file to Logs/20260209T164323/Express0021.lzma.bak 2026-02-09T17:17:22.356Z,1770657442.356 [DataOverHttps](INFO): SBD MOMSN=26641680 2026-02-09T17:17:23.396Z,1770657443.396 [Default:CheckIn:Read_Iridium] Stopped 2026-02-09T17:17:23.396Z,1770657443.396 [Default:CheckIn:C.Wait] Running Loop=1 2026-02-09T17:17:23.397Z,1770657443.397 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-02-09T17:22:23.989Z,1770657743.989 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-02-09T17:22:23.989Z,1770657743.989 [Default:CheckIn:C.Wait] Stopped 2026-02-09T17:22:23.989Z,1770657743.989 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-02-09T17:22:23.989Z,1770657743.989 [Default:CheckIn:D] Running Loop=1 2026-02-09T17:22:24.389Z,1770657744.389 [Default:CheckIn:D] Stopped 2026-02-09T17:22:24.389Z,1770657744.389 [Default:CheckIn:E] Running Loop=1 2026-02-09T17:22:24.789Z,1770657744.789 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 35.864522 min 2026-02-09T17:22:24.789Z,1770657744.789 [Default:CheckIn:E] Stopped 2026-02-09T17:22:24.789Z,1770657744.789 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-02-09T17:22:24.790Z,1770657744.790 [Default:CheckIn] Stopped 2026-02-09T17:22:24.790Z,1770657744.790 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-02-09T17:22:24.790Z,1770657744.790 [Default:CheckIn](INFO): Running loop #5 2026-02-09T17:22:24.790Z,1770657744.790 [Default:CheckIn] Running Loop=5 2026-02-09T17:22:24.790Z,1770657744.790 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-02-09T17:22:24.790Z,1770657744.790 [Default:CheckIn:Read_GPS] Running Loop=1 2026-02-09T17:22:26.801Z,1770657746.801 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,172226.00,A,3648.17267,N,12147.28077,W,0.330,265.06,090226,,,A*71 2026-02-09T17:22:26.804Z,1770657746.804 [NAL9602](INFO): GPS fix at 20260209T172226: (36.802878, -121.788013) 2026-02-09T17:22:26.815Z,1770657746.815 [Default:CheckIn:Read_GPS] Stopped 2026-02-09T17:22:26.815Z,1770657746.815 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-02-09T17:22:34.852Z,1770657754.852 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20260209T164323/Courier0024.lzma 2026-02-09T17:22:37.860Z,1770657757.860 [DataOverHttps](INFO): Moved sent file to Logs/20260209T164323/Courier0024.lzma.bak 2026-02-09T17:22:37.860Z,1770657757.860 [DataOverHttps](INFO): SBD MOMSN=26641689 2026-02-09T17:23:04.705Z,1770657784.705 [DataOverHttps](INFO): Sending 154 bytes from file Logs/20260209T164323/Express0026.lzma 2026-02-09T17:23:05.708Z,1770657785.708 [DataOverHttps](INFO): Moved sent file to Logs/20260209T164323/Express0026.lzma.bak 2026-02-09T17:23:05.708Z,1770657785.708 [DataOverHttps](INFO): SBD MOMSN=26641692 2026-02-09T17:23:06.805Z,1770657786.805 [Default:CheckIn:Read_Iridium] Stopped 2026-02-09T17:23:06.805Z,1770657786.805 [Default:CheckIn:C.Wait] Running Loop=1 2026-02-09T17:23:06.806Z,1770657786.806 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-02-09T17:23:44.699Z,1770657824.699 [DataOverHttps](IMPORTANT): SBD MTMSN=20260209T172344 2026-02-09T17:23:52.125Z,1770657832.125 [DataOverHttps](INFO): Received command: ibit 2026-02-09T17:23:52.187Z,1770657832.187 [CommandExec](IMPORTANT): got command ibit 2026-02-09T17:23:52.473Z,1770657832.473 [IBIT](IMPORTANT): Beginning Initiated BIT 2026-02-09T17:23:52.473Z,1770657832.473 [IBIT](IMPORTANT): Beginning control surface checks. 2026-02-09T17:23:52.476Z,1770657832.476 [GFScanner](IMPORTANT): Beginning ground fault scan 2026-02-09T17:23:56.983Z,1770657836.983 [GFScanner](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.001205 CHAN A1 (24V): 0.000347 CHAN A2 (12V): 0.000048 CHAN A3 (5V): -0.001697 CHAN B0 (3.3V): 0.000446 CHAN B1 (3.15aV): 0.000599 CHAN B2 (3.15bV): -0.000313 CHAN B3 (GND): -0.000344 OPEN: 0.006619 Full Scale: +/- 1 mA 2026-02-09T17:24:38.556Z,1770657878.556 [IBIT](IMPORTANT): Communications Status: Fix Status: 1 Iridium Signal Strength: 5 Latitude: 36.802879 Longitude: -121.788010 2026-02-09T17:24:38.941Z,1770657878.941 [IBIT](IMPORTANT): Battery Status: Battery Charge (AH): 0.000000 Voltage: 16.532000 2026-02-09T17:24:38.941Z,1770657878.941 [IBIT](IMPORTANT): batteryCapacityThreshold: 50.000000 Ah 2026-02-09T17:24:38.941Z,1770657878.941 [IBIT](IMPORTANT): batteryVoltageThreshold: 13.700000 V 2026-02-09T17:24:39.348Z,1770657879.348 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 % 2026-02-09T17:24:39.348Z,1770657879.348 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi 2026-02-09T17:24:39.349Z,1770657879.349 [IBIT](IMPORTANT): Pressure:10.273549 PSI 2026-02-09T17:24:39.349Z,1770657879.349 [IBIT](IMPORTANT): Humidity:5.548773 % 2026-02-09T17:24:39.764Z,1770657879.764 [IBIT](IMPORTANT): Vehicle Pitch:-2.258031 degrees 2026-02-09T17:24:39.764Z,1770657879.764 [IBIT](IMPORTANT): Vehicle Roll:-5.347197 degrees 2026-02-09T17:24:39.764Z,1770657879.764 [IBIT](IMPORTANT): Vehicle Heading:15.499094 degrees 2026-02-09T17:24:40.151Z,1770657880.151 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m 2026-02-09T17:24:40.152Z,1770657880.152 [IBIT](IMPORTANT): buoyancyNeutral: 173.954941 cc 2026-02-09T17:24:40.152Z,1770657880.152 [IBIT](IMPORTANT): massDefault: -0.546299 cm 2026-02-09T17:24:40.152Z,1770657880.152 [IBIT](IMPORTANT): stopDepth: 290.000000 m 2026-02-09T17:24:40.152Z,1770657880.152 [IBIT](IMPORTANT): abortDepth: 300.000000 m 2026-02-09T17:24:40.152Z,1770657880.152 [IBIT](IMPORTANT): IBIT PASSED 2026-02-09T17:24:52.653Z,1770657892.653 [NAL9602](INFO): SBD MO Status=0, MOMSN=30465, MT Status=0, MTMSN=0 2026-02-09T17:24:52.653Z,1770657892.653 [NAL9602](INFO): No messages in MT queue 2026-02-09T17:25:23.355Z,1770657923.355 [NAL9602](INFO): Not Powering down - fast GPS 2026-02-09T17:28:07.397Z,1770658087.397 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-02-09T17:28:07.397Z,1770658087.397 [Default:CheckIn:C.Wait] Stopped 2026-02-09T17:28:07.397Z,1770658087.397 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-02-09T17:28:07.397Z,1770658087.397 [Default:CheckIn:D] Running Loop=1 2026-02-09T17:28:07.797Z,1770658087.797 [Default:CheckIn:D] Stopped 2026-02-09T17:28:07.797Z,1770658087.797 [Default:CheckIn:E] Running Loop=1 2026-02-09T17:28:08.197Z,1770658088.197 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 41.587984 min 2026-02-09T17:28:08.197Z,1770658088.197 [Default:CheckIn:E] Stopped 2026-02-09T17:28:08.197Z,1770658088.197 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-02-09T17:28:08.197Z,1770658088.197 [Default:CheckIn] Stopped 2026-02-09T17:28:08.197Z,1770658088.197 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-02-09T17:28:08.198Z,1770658088.198 [Default:CheckIn](INFO): Running loop #6 2026-02-09T17:28:08.198Z,1770658088.198 [Default:CheckIn] Running Loop=6 2026-02-09T17:28:08.198Z,1770658088.198 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-02-09T17:28:08.198Z,1770658088.198 [Default:CheckIn:Read_GPS] Running Loop=1 2026-02-09T17:28:10.210Z,1770658090.210 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,172809.00,A,3648.17436,N,12147.28026,W,0.058,54.52,090226,,,A*4C 2026-02-09T17:28:10.212Z,1770658090.212 [NAL9602](INFO): GPS fix at 20260209T172809: (36.802906, -121.788004) 2026-02-09T17:28:10.223Z,1770658090.223 [Default:CheckIn:Read_GPS] Stopped 2026-02-09T17:28:10.224Z,1770658090.224 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-02-09T17:28:18.897Z,1770658098.897 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20260209T164323/Courier0028.lzma 2026-02-09T17:28:21.908Z,1770658101.908 [DataOverHttps](INFO): Moved sent file to Logs/20260209T164323/Courier0028.lzma.bak 2026-02-09T17:28:21.908Z,1770658101.908 [DataOverHttps](INFO): SBD MOMSN=26641703 2026-02-09T17:28:34.052Z,1770658114.052 [NAL9602](INFO): SBD MO Status=2, MOMSN=30466, MT Status=2, MTMSN=0 2026-02-09T17:28:34.053Z,1770658114.053 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-02-09T17:28:41.131Z,1770658121.131 [DataOverHttps](INFO): Sending 794 bytes from file Logs/20260209T164323/Express0029.lzma 2026-02-09T17:28:47.160Z,1770658127.160 [DataOverHttps](INFO): Moved sent file to Logs/20260209T164323/Express0029.lzma.bak 2026-02-09T17:28:47.160Z,1770658127.160 [DataOverHttps](INFO): SBD MOMSN=26641706 2026-02-09T17:29:05.984Z,1770658145.984 [NAL9602](INFO): SBD MO Status=2, MOMSN=30466, MT Status=2, MTMSN=0 2026-02-09T17:29:05.985Z,1770658145.985 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-02-09T17:29:08.093Z,1770658148.093 [DataOverHttps](INFO): Sending 63 bytes from file Logs/20260209T164323/Express0032.lzma 2026-02-09T17:29:10.102Z,1770658150.102 [DataOverHttps](INFO): Moved sent file to Logs/20260209T164323/Express0032.lzma.bak 2026-02-09T17:29:10.103Z,1770658150.103 [DataOverHttps](INFO): SBD MOMSN=26641732 2026-02-09T17:29:11.227Z,1770658151.227 [Default:CheckIn:Read_Iridium] Stopped 2026-02-09T17:29:11.227Z,1770658151.227 [Default:CheckIn:C.Wait] Running Loop=1 2026-02-09T17:29:11.227Z,1770658151.227 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-02-09T17:30:18.281Z,1770658218.281 [NAL9602](INFO): SBD MO Status=0, MOMSN=30466, MT Status=0, MTMSN=0 2026-02-09T17:30:18.281Z,1770658218.281 [NAL9602](INFO): No messages in MT queue 2026-02-09T17:30:48.987Z,1770658248.987 [NAL9602](INFO): Not Powering down - fast GPS 2026-02-09T17:33:39.085Z,1770658419.085 [Sonardyne_Nano](INFO): Battery at maximum, disabling charging 2026-02-09T17:34:11.809Z,1770658451.809 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-02-09T17:34:11.809Z,1770658451.809 [Default:CheckIn:C.Wait] Stopped 2026-02-09T17:34:11.809Z,1770658451.809 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-02-09T17:34:11.810Z,1770658451.810 [Default:CheckIn:D] Running Loop=1 2026-02-09T17:34:12.214Z,1770658452.214 [Default:CheckIn:D] Stopped 2026-02-09T17:34:12.214Z,1770658452.214 [Default:CheckIn:E] Running Loop=1 2026-02-09T17:34:12.622Z,1770658452.622 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 47.661601 min 2026-02-09T17:34:12.622Z,1770658452.622 [Default:CheckIn:E] Stopped 2026-02-09T17:34:12.623Z,1770658452.623 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-02-09T17:34:12.623Z,1770658452.623 [Default:CheckIn] Stopped 2026-02-09T17:34:12.623Z,1770658452.623 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-02-09T17:34:12.623Z,1770658452.623 [Default:CheckIn](INFO): Running loop #7 2026-02-09T17:34:12.623Z,1770658452.623 [Default:CheckIn] Running Loop=7 2026-02-09T17:34:12.623Z,1770658452.623 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-02-09T17:34:12.623Z,1770658452.623 [Default:CheckIn:Read_GPS] Running Loop=1 2026-02-09T17:34:14.628Z,1770658454.628 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,173413.00,A,3648.17266,N,12147.28329,W,0.019,54.52,090226,,,A*40 2026-02-09T17:34:14.630Z,1770658454.630 [NAL9602](INFO): GPS fix at 20260209T173413: (36.802878, -121.788055) 2026-02-09T17:34:14.657Z,1770658454.657 [Default:CheckIn:Read_GPS] Stopped 2026-02-09T17:34:14.657Z,1770658454.657 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-02-09T17:34:15.446Z,1770658455.446 [Default:CheckIn:Read_Iridium] Stopped 2026-02-09T17:34:15.446Z,1770658455.446 [Default:CheckIn:C.Wait] Running Loop=1 2026-02-09T17:34:15.446Z,1770658455.446 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-02-09T17:34:27.154Z,1770658467.154 [NAL9602](INFO): SBD MO Status=0, MOMSN=30467, MT Status=0, MTMSN=0 2026-02-09T17:34:27.154Z,1770658467.154 [NAL9602](INFO): No messages in MT queue 2026-02-09T17:34:57.867Z,1770658497.867 [NAL9602](INFO): Not Powering down - fast GPS 2026-02-09T17:39:16.034Z,1770658756.034 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-02-09T17:39:16.034Z,1770658756.034 [Default:CheckIn:C.Wait] Stopped 2026-02-09T17:39:16.034Z,1770658756.034 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-02-09T17:39:16.034Z,1770658756.034 [Default:CheckIn:D] Running Loop=1 2026-02-09T17:39:16.455Z,1770658756.455 [Default:CheckIn:D] Stopped 2026-02-09T17:39:16.455Z,1770658756.455 [Default:CheckIn:E] Running Loop=1 2026-02-09T17:39:16.845Z,1770658756.845 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 52.732279 min 2026-02-09T17:39:16.845Z,1770658756.845 [Default:CheckIn:E] Stopped 2026-02-09T17:39:16.862Z,1770658756.862 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-02-09T17:39:16.862Z,1770658756.862 [Default:CheckIn] Stopped 2026-02-09T17:39:16.862Z,1770658756.862 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-02-09T17:39:16.862Z,1770658756.862 [Default:CheckIn](INFO): Running loop #8 2026-02-09T17:39:16.862Z,1770658756.862 [Default:CheckIn] Running Loop=8 2026-02-09T17:39:16.862Z,1770658756.862 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-02-09T17:39:16.862Z,1770658756.862 [Default:CheckIn:Read_GPS] Running Loop=1 2026-02-09T17:39:18.857Z,1770658758.857 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,173918.00,A,3648.17437,N,12147.28256,W,0.175,54.52,090226,,,A*46 2026-02-09T17:39:18.859Z,1770658758.859 [NAL9602](INFO): GPS fix at 20260209T173918: (36.802906, -121.788043) 2026-02-09T17:39:18.870Z,1770658758.870 [Default:CheckIn:Read_GPS] Stopped 2026-02-09T17:39:18.870Z,1770658758.870 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-02-09T17:39:26.794Z,1770658766.794 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20260209T164323/Courier0034.lzma 2026-02-09T17:39:28.800Z,1770658768.800 [DataOverHttps](INFO): Moved sent file to Logs/20260209T164323/Courier0034.lzma.bak 2026-02-09T17:39:28.800Z,1770658768.800 [DataOverHttps](INFO): SBD MOMSN=26641746 2026-02-09T17:39:44.617Z,1770658784.617 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20260209T164323/Courier0037.lzma 2026-02-09T17:39:47.628Z,1770658787.628 [DataOverHttps](INFO): Moved sent file to Logs/20260209T164323/Courier0037.lzma.bak 2026-02-09T17:39:47.628Z,1770658787.628 [DataOverHttps](INFO): SBD MOMSN=26641749 2026-02-09T17:40:12.429Z,1770658812.429 [DataOverHttps](INFO): Sending 155 bytes from file Logs/20260209T164323/Express0035.lzma 2026-02-09T17:40:15.440Z,1770658815.440 [DataOverHttps](INFO): Moved sent file to Logs/20260209T164323/Express0035.lzma.bak 2026-02-09T17:40:15.440Z,1770658815.440 [DataOverHttps](INFO): SBD MOMSN=26641752 2026-02-09T17:40:32.413Z,1770658832.413 [DataOverHttps](INFO): Sending 157 bytes from file Logs/20260209T164323/Express0038.lzma 2026-02-09T17:40:37.432Z,1770658837.432 [DataOverHttps](INFO): Moved sent file to Logs/20260209T164323/Express0038.lzma.bak 2026-02-09T17:40:37.432Z,1770658837.432 [DataOverHttps](INFO): SBD MOMSN=26641755 2026-02-09T17:40:38.494Z,1770658838.494 [Default:CheckIn:Read_Iridium] Stopped 2026-02-09T17:40:38.495Z,1770658838.495 [Default:CheckIn:C.Wait] Running Loop=1 2026-02-09T17:40:38.495Z,1770658838.495 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-02-09T17:42:41.323Z,1770658961.323 [NAL9602](INFO): SBD MO Status=0, MOMSN=30468, MT Status=0, MTMSN=0 2026-02-09T17:42:41.323Z,1770658961.323 [NAL9602](INFO): No messages in MT queue 2026-02-09T17:43:12.015Z,1770658992.015 [NAL9602](INFO): Not Powering down - fast GPS 2026-02-09T17:45:39.089Z,1770659139.089 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-02-09T17:45:39.089Z,1770659139.089 [Default:CheckIn:C.Wait] Stopped 2026-02-09T17:45:39.089Z,1770659139.089 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-02-09T17:45:39.089Z,1770659139.089 [Default:CheckIn:D] Running Loop=1 2026-02-09T17:45:39.489Z,1770659139.489 [Default:CheckIn:D] Stopped 2026-02-09T17:45:39.489Z,1770659139.489 [Default:CheckIn:E] Running Loop=1 2026-02-09T17:45:39.889Z,1770659139.889 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 59.116191 min 2026-02-09T17:45:39.889Z,1770659139.889 [Default:CheckIn:E] Stopped 2026-02-09T17:45:39.889Z,1770659139.889 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-02-09T17:45:39.889Z,1770659139.889 [Default:CheckIn] Stopped 2026-02-09T17:45:39.889Z,1770659139.889 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-02-09T17:45:39.890Z,1770659139.890 [Default:CheckIn](INFO): Running loop #9 2026-02-09T17:45:39.890Z,1770659139.890 [Default:CheckIn] Running Loop=9 2026-02-09T17:45:39.890Z,1770659139.890 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-02-09T17:45:39.890Z,1770659139.890 [Default:CheckIn:Read_GPS] Running Loop=1 2026-02-09T17:45:41.909Z,1770659141.909 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,174541.00,A,3648.17425,N,12147.28099,W,0.447,267.02,090226,,,A*70 2026-02-09T17:45:41.911Z,1770659141.911 [NAL9602](INFO): GPS fix at 20260209T174541: (36.802904, -121.788016) 2026-02-09T17:45:41.922Z,1770659141.922 [Default:CheckIn:Read_GPS] Stopped 2026-02-09T17:45:41.922Z,1770659141.922 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-02-09T17:45:49.925Z,1770659149.925 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20260209T164323/Courier0040.lzma 2026-02-09T17:45:51.932Z,1770659151.932 [DataOverHttps](INFO): Moved sent file to Logs/20260209T164323/Courier0040.lzma.bak 2026-02-09T17:45:51.932Z,1770659151.932 [DataOverHttps](INFO): SBD MOMSN=26641764 2026-02-09T17:46:00.081Z,1770659160.081 [NAL9602](INFO): SBD MO Status=0, MOMSN=30469, MT Status=0, MTMSN=0 2026-02-09T17:46:00.081Z,1770659160.081 [NAL9602](INFO): No messages in MT queue 2026-02-09T17:46:09.769Z,1770659169.769 [DataOverHttps](INFO): Sending 155 bytes from file Logs/20260209T164323/Express0041.lzma 2026-02-09T17:46:13.784Z,1770659173.784 [DataOverHttps](INFO): Moved sent file to Logs/20260209T164323/Express0041.lzma.bak 2026-02-09T17:46:13.784Z,1770659173.784 [DataOverHttps](INFO): SBD MOMSN=26641767 2026-02-09T17:46:15.041Z,1770659175.041 [Default:CheckIn:Read_Iridium] Stopped 2026-02-09T17:46:15.042Z,1770659175.042 [Default:CheckIn:C.Wait] Running Loop=1 2026-02-09T17:46:15.042Z,1770659175.042 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-02-09T17:46:30.782Z,1770659190.782 [NAL9602](INFO): Not Powering down - fast GPS 2026-02-09T17:49:36.976Z,1770659376.976 [DataOverHttps](IMPORTANT): SBD MTMSN=20260209T174936 2026-02-09T17:49:44.457Z,1770659384.457 [DataOverHttps](INFO): Received command: restart sys 2026-02-09T17:49:44.523Z,1770659384.523 [CommandExec](IMPORTANT): got command restart system 2026-02-09T17:49:46.626Z,1770659386.626 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2026-02-09T17:49:46.626Z,1770659386.626 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2026-02-09T17:49:46.628Z,1770659386.628 [CommandExec](INFO): Uninitializing the command executive. 2026-02-09T17:49:46.628Z,1770659386.628 [CommandExec](INFO): Uninitializing the command scheduler. 2026-02-09T17:49:46.628Z,1770659386.628 [CommandExec ThreadHandler](INFO): Thread cancelled. 2026-02-09T17:49:46.802Z,1770659386.802 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2026-02-09T17:49:46.802Z,1770659386.802 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2026-02-09T17:49:46.802Z,1770659386.802 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2026-02-09T17:49:46.803Z,1770659386.803 [NavChartDb](INFO): Join timeout helper Thread ID is 6923 2026-02-09T17:49:46.918Z,1770659386.918 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2026-02-09T17:49:46.918Z,1770659386.918 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2026-02-09T17:49:46.926Z,1770659386.926 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2026-02-09T17:49:46.926Z,1770659386.926 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2026-02-09T17:49:46.926Z,1770659386.926 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 6924 2026-02-09T17:49:47.090Z,1770659387.090 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2026-02-09T17:49:47.091Z,1770659387.091 [WetLabsBB2FL](INFO): Powering down 2026-02-09T17:49:47.092Z,1770659387.092 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2026-02-09T17:49:47.106Z,1770659387.106 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2026-02-09T17:49:47.106Z,1770659387.106 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2026-02-09T1