2025-09-23T15:31:49.208Z,1758641509.208 [Supervisor](DEBUG): Initializing supervisor.
2025-09-23T15:31:49.212Z,1758641509.212 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2025-09-23T15:31:49.212Z,1758641509.212 [SyncHandler](INFO): Protected caller Thread ID is 837
2025-09-23T15:31:49.213Z,1758641509.213 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2025-09-23T15:31:49.214Z,1758641509.214 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2025-09-23T15:31:49.214Z,1758641509.214 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 838
2025-09-23T15:31:49.218Z,1758641509.218 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2025-09-23T15:31:49.239Z,1758641509.239 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2025-09-23T15:31:49.240Z,1758641509.240 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2025-09-23T15:31:49.240Z,1758641509.240 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 839
2025-09-23T15:31:49.244Z,1758641509.244 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2025-09-23T15:31:49.245Z,1758641509.245 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2025-09-23T15:31:49.246Z,1758641509.246 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 840
2025-09-23T15:31:49.248Z,1758641509.248 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2025-09-23T15:31:49.249Z,1758641509.249 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2025-09-23T15:31:49.249Z,1758641509.249 [logger ThreadHandler](INFO): Protected caller Thread ID is 841
2025-09-23T15:31:49.253Z,1758641509.253 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2025-09-23T15:31:49.254Z,1758641509.254 [Supervisor](INFO): Looking for Config files in directory: Config/
2025-09-23T15:31:49.258Z,1758641509.258 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2025-09-23T15:31:49.602Z,1758641509.602 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2025-09-23T15:31:49.602Z,1758641509.602 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2025-09-23T15:31:49.703Z,1758641509.703 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Guidance
2025-09-23T15:31:49.705Z,1758641509.705 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2025-09-23T15:31:49.822Z,1758641509.822 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2025-09-23T15:31:49.823Z,1758641509.823 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2025-09-23T15:31:49.965Z,1758641509.965 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2025-09-23T15:31:49.966Z,1758641509.966 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2025-09-23T15:31:50.338Z,1758641510.338 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2025-09-23T15:31:50.339Z,1758641510.339 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2025-09-23T15:31:50.445Z,1758641510.445 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2025-09-23T15:31:50.446Z,1758641510.446 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2025-09-23T15:31:50.860Z,1758641510.860 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2025-09-23T15:31:50.860Z,1758641510.860 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2025-09-23T15:31:51.099Z,1758641511.099 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2025-09-23T15:31:51.101Z,1758641511.101 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2025-09-23T15:31:51.189Z,1758641511.189 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2025-09-23T15:31:51.443Z,1758641511.443 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2025-09-23T15:31:51.445Z,1758641511.445 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2025-09-23T15:31:51.679Z,1758641511.679 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2025-09-23T15:31:51.681Z,1758641511.681 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2025-09-23T15:31:52.267Z,1758641512.267 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2025-09-23T15:31:52.270Z,1758641512.270 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2025-09-23T15:31:52.464Z,1758641512.464 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2025-09-23T15:31:52.466Z,1758641512.466 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2025-09-23T15:31:52.762Z,1758641512.762 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2025-09-23T15:31:52.762Z,1758641512.762 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2025-09-23T15:31:53.667Z,1758641513.667 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2025-09-23T15:31:53.669Z,1758641513.669 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2025-09-23T15:31:54.259Z,1758641514.259 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2025-09-23T15:31:54.261Z,1758641514.261 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/
2025-09-23T15:31:54.263Z,1758641514.263 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Control.cfg
2025-09-23T15:31:54.371Z,1758641514.371 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Science.cfg
2025-09-23T15:31:54.513Z,1758641514.513 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/secure.cfg
2025-09-23T15:31:54.607Z,1758641514.607 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Servo.cfg
2025-09-23T15:31:54.724Z,1758641514.724 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/BIT.cfg
2025-09-23T15:31:54.826Z,1758641514.826 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Battery.cfg
2025-09-23T15:31:55.104Z,1758641515.104 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2025-09-23T15:31:55.105Z,1758641515.105 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/vehicle.cfg
2025-09-23T15:31:55.224Z,1758641515.224 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/logger.cfg
2025-09-23T15:31:55.331Z,1758641515.331 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Sensor.cfg
2025-09-23T15:31:55.479Z,1758641515.479 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Simulator.cfg
2025-09-23T15:31:55.574Z,1758641515.574 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2025-09-23T15:31:55.587Z,1758641515.587 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2025-09-23T15:31:55.768Z,1758641515.768 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2025-09-23T15:31:55.769Z,1758641515.769 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2025-09-23T15:31:55.843Z,1758641515.843 [VerticalControl](DEBUG): Construct VerticalControl.
2025-09-23T15:31:55.907Z,1758641515.907 [VerticalControl] Loaded
2025-09-23T15:31:55.908Z,1758641515.908 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2025-09-23T15:31:55.911Z,1758641515.911 [HorizontalControl](DEBUG): Construct HorizontalControl.
2025-09-23T15:31:55.960Z,1758641515.960 [HorizontalControl] Loaded
2025-09-23T15:31:55.961Z,1758641515.961 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2025-09-23T15:31:55.963Z,1758641515.963 [SpeedControl](DEBUG): Construct SpeedControl.
2025-09-23T15:31:55.966Z,1758641515.966 [SpeedControl] Loaded
2025-09-23T15:31:55.966Z,1758641515.966 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2025-09-23T15:31:55.969Z,1758641515.969 [LoopControl](DEBUG): Construct LoopControl.
2025-09-23T15:31:55.970Z,1758641515.970 [LoopControl] Loaded
2025-09-23T15:31:55.970Z,1758641515.970 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2025-09-23T15:31:55.970Z,1758641515.970 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2025-09-23T15:31:55.971Z,1758641515.971 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2025-09-23T15:31:56.061Z,1758641516.061 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2025-09-23T15:31:56.062Z,1758641516.062 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2025-09-23T15:31:56.932Z,1758641516.932 [AHRS_M2] Loaded
2025-09-23T15:31:56.932Z,1758641516.932 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2025-09-23T15:31:57.187Z,1758641517.187 [BackseatComponent] Loaded
2025-09-23T15:31:57.187Z,1758641517.187 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2025-09-23T15:31:57.188Z,1758641517.188 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408BD4E0
2025-09-23T15:31:57.188Z,1758641517.188 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 921
2025-09-23T15:31:57.191Z,1758641517.191 [LcmUniversalReporter] Loaded
2025-09-23T15:31:57.192Z,1758641517.192 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2025-09-23T15:31:58.068Z,1758641518.068 [BPC1] Loaded
2025-09-23T15:31:58.069Z,1758641518.069 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2025-09-23T15:31:58.170Z,1758641518.170 [DAT] Loaded
2025-09-23T15:31:58.170Z,1758641518.170 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2025-09-23T15:31:58.171Z,1758641518.171 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 408ED4E0
2025-09-23T15:31:58.171Z,1758641518.171 [DAT ThreadHandler](INFO): Protected caller Thread ID is 922
2025-09-23T15:31:58.316Z,1758641518.316 [DataOverHttps] Loaded
2025-09-23T15:31:58.316Z,1758641518.316 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2025-09-23T15:31:58.317Z,1758641518.317 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4091D4E0
2025-09-23T15:31:58.317Z,1758641518.317 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 923
2025-09-23T15:31:58.341Z,1758641518.341 [Depth_Keller] Loaded
2025-09-23T15:31:58.342Z,1758641518.342 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2025-09-23T15:31:58.347Z,1758641518.347 [DropWeight] Loaded
2025-09-23T15:31:58.347Z,1758641518.347 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2025-09-23T15:31:58.415Z,1758641518.415 [NAL9602] Loaded
2025-09-23T15:31:58.415Z,1758641518.415 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2025-09-23T15:31:58.446Z,1758641518.446 [Onboard] Loaded
2025-09-23T15:31:58.447Z,1758641518.447 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2025-09-23T15:31:58.448Z,1758641518.448 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4094D4E0
2025-09-23T15:31:58.448Z,1758641518.448 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 924
2025-09-23T15:31:58.463Z,1758641518.463 [Power24vConverter] Loaded
2025-09-23T15:31:58.463Z,1758641518.463 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2025-09-23T15:31:58.479Z,1758641518.479 [Radio_Surface] Loaded
2025-09-23T15:31:58.480Z,1758641518.480 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2025-09-23T15:31:58.481Z,1758641518.481 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4097D4E0
2025-09-23T15:31:58.481Z,1758641518.481 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 925
2025-09-23T15:31:58.498Z,1758641518.498 [Sonardyne_Nano] Loaded
2025-09-23T15:31:58.498Z,1758641518.498 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2025-09-23T15:31:58.498Z,1758641518.498 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2025-09-23T15:31:58.499Z,1758641518.499 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2025-09-23T15:31:58.516Z,1758641518.516 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2025-09-23T15:31:58.517Z,1758641518.517 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2025-09-23T15:31:58.565Z,1758641518.565 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2025-09-23T15:31:58.566Z,1758641518.566 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2025-09-23T15:31:58.774Z,1758641518.774 [SBIT](DEBUG): Construct Startup Built In Test.
2025-09-23T15:31:58.783Z,1758641518.783 [SBIT] Loaded
2025-09-23T15:31:58.784Z,1758641518.784 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2025-09-23T15:31:58.787Z,1758641518.787 [IBIT](DEBUG): Construct Initiated Built In Test.
2025-09-23T15:31:58.800Z,1758641518.800 [IBIT] Loaded
2025-09-23T15:31:58.800Z,1758641518.800 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2025-09-23T15:31:58.806Z,1758641518.806 [CBIT](DEBUG): Construct Continuous Built In Test.
2025-09-23T15:31:58.890Z,1758641518.890 [CBIT] Loaded
2025-09-23T15:31:58.890Z,1758641518.890 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2025-09-23T15:31:58.924Z,1758641518.924 [GFScanner] Loaded
2025-09-23T15:31:58.925Z,1758641518.925 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread.
2025-09-23T15:31:58.925Z,1758641518.925 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2025-09-23T15:31:58.926Z,1758641518.926 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2025-09-23T15:31:59.425Z,1758641519.425 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2025-09-23T15:31:59.426Z,1758641519.426 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2025-09-23T15:31:59.499Z,1758641519.499 [DepthRateCalculator] Loaded
2025-09-23T15:31:59.499Z,1758641519.499 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2025-09-23T15:31:59.505Z,1758641519.505 [PitchRateCalculator] Loaded
2025-09-23T15:31:59.505Z,1758641519.505 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2025-09-23T15:31:59.516Z,1758641519.516 [SpeedCalculator] Loaded
2025-09-23T15:31:59.516Z,1758641519.516 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2025-09-23T15:31:59.521Z,1758641519.521 [YawRateCalculator] Loaded
2025-09-23T15:31:59.521Z,1758641519.521 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2025-09-23T15:31:59.541Z,1758641519.541 [ElevatorOffsetCalculator] Loaded
2025-09-23T15:31:59.541Z,1758641519.541 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2025-09-23T15:31:59.542Z,1758641519.542 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2025-09-23T15:31:59.542Z,1758641519.542 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2025-09-23T15:31:59.774Z,1758641519.774 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2025-09-23T15:31:59.774Z,1758641519.774 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2025-09-23T15:31:59.918Z,1758641519.918 [DeadReckonUsingMultipleVelocitySources] Loaded
2025-09-23T15:31:59.918Z,1758641519.918 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2025-09-23T15:31:59.933Z,1758641519.933 [NavChart] Loaded
2025-09-23T15:31:59.933Z,1758641519.933 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2025-09-23T15:31:59.939Z,1758641519.939 [UniversalFixResidualReporter] Loaded
2025-09-23T15:31:59.939Z,1758641519.939 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2025-09-23T15:31:59.940Z,1758641519.940 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2025-09-23T15:31:59.941Z,1758641519.941 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2025-09-23T15:32:00.134Z,1758641520.134 [BuoyancyServo] Loaded
2025-09-23T15:32:00.134Z,1758641520.134 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2025-09-23T15:32:00.158Z,1758641520.158 [ElevatorServo] Loaded
2025-09-23T15:32:00.159Z,1758641520.159 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2025-09-23T15:32:00.182Z,1758641520.182 [MassServo] Loaded
2025-09-23T15:32:00.182Z,1758641520.182 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2025-09-23T15:32:00.203Z,1758641520.203 [RudderServo] Loaded
2025-09-23T15:32:00.204Z,1758641520.204 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2025-09-23T15:32:00.221Z,1758641520.221 [ThrusterHE] Loaded
2025-09-23T15:32:00.222Z,1758641520.222 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2025-09-23T15:32:00.222Z,1758641520.222 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2025-09-23T15:32:00.223Z,1758641520.223 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2025-09-23T15:32:00.455Z,1758641520.455 [CTD_Seabird] Loaded
2025-09-23T15:32:00.455Z,1758641520.455 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2025-09-23T15:32:00.456Z,1758641520.456 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40C0D4E0
2025-09-23T15:32:00.457Z,1758641520.457 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 927
2025-09-23T15:32:00.495Z,1758641520.495 [ESPComponent] Loaded
2025-09-23T15:32:00.495Z,1758641520.495 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2025-09-23T15:32:00.519Z,1758641520.519 [PAR_Licor] Loaded
2025-09-23T15:32:00.519Z,1758641520.519 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2025-09-23T15:32:00.566Z,1758641520.566 [WetLabsBB2FL] Loaded
2025-09-23T15:32:00.566Z,1758641520.566 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2025-09-23T15:32:00.567Z,1758641520.567 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40C3D4E0
2025-09-23T15:32:00.568Z,1758641520.568 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 928
2025-09-23T15:32:00.569Z,1758641520.569 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2025-09-23T15:32:00.575Z,1758641520.575 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2025-09-23T15:32:00.578Z,1758641520.578 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2025-09-23T15:32:00.590Z,1758641520.590 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2025-09-23T15:32:00.591Z,1758641520.591 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C6D4E0
2025-09-23T15:32:00.591Z,1758641520.591 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 929
2025-09-23T15:32:00.596Z,1758641520.596 [Supervisor](INFO): Main Thread ID is 828
2025-09-23T15:32:00.596Z,1758641520.596 [Supervisor](DEBUG): Running supervisor.
2025-09-23T15:32:00.596Z,1758641520.596 [CommandExec ThreadHandler](INFO): Handler Thread ID is 930
2025-09-23T15:32:00.597Z,1758641520.597 [CommandExec](INFO): Initializing the command executive.
2025-09-23T15:32:00.598Z,1758641520.598 [CommandLine ThreadHandler](INFO): Handler Thread ID is 931
2025-09-23T15:32:00.601Z,1758641520.601 [controlThread ThreadHandler](INFO): Handler Thread ID is 932
2025-09-23T15:32:00.601Z,1758641520.601 [controlThread](DEBUG): Initializing ControlThread
2025-09-23T15:32:00.602Z,1758641520.602 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2025-09-23T15:32:00.604Z,1758641520.604 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2025-09-23T15:32:00.604Z,1758641520.604 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2025-09-23T15:32:00.605Z,1758641520.605 [LoopControl](DEBUG): Initialize LoopControlComponent.
2025-09-23T15:32:00.608Z,1758641520.608 [SBIT](INFO): Initialize SBIT Component.
2025-09-23T15:32:00.608Z,1758641520.608 [SBIT](IMPORTANT): git: 2025-09-19
2025-09-23T15:32:00.608Z,1758641520.608 [SBIT](INFO): git hash: f5f7d10969816d125effdffd07357c8d50a3a0d0
2025-09-23T15:32:00.609Z,1758641520.609 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2025-09-23T15:32:00.610Z,1758641520.610 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #639 PREEMPT Wed Mar 12 12:53:33 PDT 2014
Kernel Reported: #1 PREEMPT Tue Nov 28 15:04:22 PST 2023
2025-09-23T15:32:00.611Z,1758641520.611 [SBIT](INFO): Beginning SBIT in 104.000000 seconds.
2025-09-23T15:32:00.612Z,1758641520.612 [IBIT](INFO): Initialize IBIT Component.
2025-09-23T15:32:00.613Z,1758641520.613 [CBIT](DEBUG): Initialize CBIT Component.
2025-09-23T15:32:00.613Z,1758641520.613 [logger ThreadHandler](INFO): Handler Thread ID is 933
2025-09-23T15:32:00.624Z,1758641520.624 [CBIT](DEBUG): Initialized mux pins.
2025-09-23T15:32:00.624Z,1758641520.624 [CBIT](DEBUG): Initializing the watchdog timer.
2025-09-23T15:32:00.632Z,1758641520.632 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 934
2025-09-23T15:32:00.648Z,1758641520.648 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2025-09-23T15:32:00.648Z,1758641520.648 [CBIT](DEBUG): Initializing heartbeat.
2025-09-23T15:32:00.649Z,1758641520.649 [DAT ThreadHandler](INFO): Handler Thread ID is 935
2025-09-23T15:32:00.650Z,1758641520.650 [DAT](INFO): Powering up
2025-09-23T15:32:00.650Z,1758641520.650 [DAT](DEBUG): Initializing DAT.
2025-09-23T15:32:00.653Z,1758641520.653 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 937
2025-09-23T15:32:00.655Z,1758641520.655 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2025-09-23T15:32:00.676Z,1758641520.676 [Onboard ThreadHandler](INFO): Handler Thread ID is 938
2025-09-23T15:32:00.693Z,1758641520.693 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 939
2025-09-23T15:32:00.716Z,1758641520.716 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 940
2025-09-23T15:32:00.720Z,1758641520.720 [CBIT](DEBUG): Deactivating emergency mode.
2025-09-23T15:32:00.720Z,1758641520.720 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2025-09-23T15:32:00.725Z,1758641520.725 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 942
2025-09-23T15:32:00.728Z,1758641520.728 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 944
2025-09-23T15:32:00.730Z,1758641520.730 [WetLabsBB2FL](INFO): Powering up
2025-09-23T15:32:00.737Z,1758641520.737 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2025-09-23T15:32:00.738Z,1758641520.738 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2025-09-23T15:32:00.738Z,1758641520.738 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2025-09-23T15:32:00.738Z,1758641520.738 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2025-09-23T15:32:00.738Z,1758641520.738 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2025-09-23T15:32:00.738Z,1758641520.738 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2025-09-23T15:32:00.738Z,1758641520.738 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2025-09-23T15:32:00.739Z,1758641520.739 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2025-09-23T15:32:00.760Z,1758641520.760 [CBIT](DEBUG): Backplane powered.
2025-09-23T15:32:00.760Z,1758641520.760 [GFScanner](DEBUG): Initializing GFScanner
2025-09-23T15:32:00.760Z,1758641520.760 [GFScanner](DEBUG): Deactivating GF circuits.
2025-09-23T15:32:00.764Z,1758641520.764 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2025-09-23T15:32:00.765Z,1758641520.765 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2025-09-23T15:32:00.765Z,1758641520.765 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2025-09-23T15:32:00.766Z,1758641520.766 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2025-09-23T15:32:00.766Z,1758641520.766 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2025-09-23T15:32:00.767Z,1758641520.767 [NavChart](DEBUG): Initialize NavChart Navigation.
2025-09-23T15:32:00.767Z,1758641520.767 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2025-09-23T15:32:00.785Z,1758641520.785 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2025-09-23T15:32:00.786Z,1758641520.786 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2025-09-23T15:32:00.786Z,1758641520.786 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2025-09-23T15:32:00.790Z,1758641520.790 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2025-09-23T15:32:00.888Z,1758641520.888 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
2025-09-23T15:32:00.910Z,1758641520.910 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2025-09-23T15:32:00.952Z,1758641520.952 [MissionManager](DEBUG):
# Copyright (c) 2024 MBARI
# MBARI Proprietary Information. Confidential. All Rights Reserved
# Unauthorized copying or distribution of this file via any medium is strictly
# prohibited.
#
# WARNING - This file contains information whose export is restricted by the
# Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as
# amended. Violations of these export laws are subject to severe civil and/or
# criminal penalties.
mission Startup {
behavior Guidance:GoToSurface {
run in progression
}
aggregate StartupSatComms {
run in sequence
readDatum {
timeout duration=P1M
Universal:latitude_fix
}
readDatum {
timeout duration=P1M
Universal:platform_communications
}
}
}
2025-09-23T15:32:00.953Z,1758641520.953 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2025-09-23T15:32:00.953Z,1758641520.953 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2025-09-23T15:32:00.958Z,1758641520.958 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2025-09-23T15:32:01.100Z,1758641521.100 [Radio_Surface](INFO): Powering up
2025-09-23T15:32:01.279Z,1758641521.279 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into:
0
13
Burn on
Dropped weight due to communications timeout.
5
Default mission has been running for
Restarting logs and Default mission.
restart logs
2025-09-23T15:32:01.302Z,1758641521.302 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2025-09-23T15:32:01.303Z,1758641521.303 [Default:A.Wait](DEBUG): Construct Wait.
2025-09-23T15:32:01.317Z,1758641521.317 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2025-09-23T15:32:01.368Z,1758641521.368 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2025-09-23T15:32:01.370Z,1758641521.370 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2025-09-23T15:32:01.389Z,1758641521.389 [Default:E.Execute](DEBUG): Construct Execute.
2025-09-23T15:32:01.401Z,1758641521.401 [MissionManager](DEBUG):
# Copyright (c) 2024 MBARI
# MBARI Proprietary Information. Confidential. All Rights Reserved
# Unauthorized copying or distribution of this file via any medium is strictly
# prohibited.
#
# WARNING - This file contains information whose export is restricted by the
# Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as
# amended. Violations of these export laws are subject to severe civil and/or
# criminal penalties.
mission Default {
arguments {
ElapsedSinceDefaultStarted = 0 minute
}
behavior Guidance:Wait {
"""
Wait a moment to see if the scheduler starts a new mission before
starting to actually run Default.
"""
run in sequence
set duration = 13 second
}
behavior Guidance:GoToSurface {
run in progression
}
aggregate CheckIn {
run in sequence repeat=288
readDatum id="Read_GPS" {
timeout duration=P5M
Universal:time_fix
}
readDatum id="Read_Iridium" {
timeout duration=P4H {
behavior Guidance:Execute {
run in sequence
set command = "Burn on"
}
syslog critical "Dropped weight due to communications timeout."
}
Universal:platform_communications
}
behavior Guidance:Wait {
run in sequence
set duration = 5 minute
}
assign in sequence ElapsedSinceDefaultStarted = elapsed ( Universal:mission_started )
syslog important "Default mission has been running for " + ElapsedSinceDefaultStarted~minute
}
syslog important "Restarting logs and Default mission."
behavior Guidance:Execute {
run in sequence
set command = "restart logs"
}
}
2025-09-23T15:32:01.407Z,1758641521.407 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter,
2025-09-23T15:32:01.431Z,1758641521.431 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2025-09-23T15:32:01.584Z,1758641521.584 [Depth_Keller](INFO): Initializing.
2025-09-23T15:32:01.586Z,1758641521.586 [Power24vConverter](INFO): Powering up.
2025-09-23T15:32:01.586Z,1758641521.586 [Sonardyne_Nano](INFO): Initializing.
2025-09-23T15:32:01.628Z,1758641521.628 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-09-23T15:32:01.655Z,1758641521.655 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2025-09-23T15:32:01.660Z,1758641521.660 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2025-09-23T15:32:01.661Z,1758641521.661 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-09-23T15:32:01.668Z,1758641521.668 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-09-23T15:32:01.669Z,1758641521.669 [MassServo](DEBUG): Initializing EZServoServo.
2025-09-23T15:32:01.676Z,1758641521.676 [MassServo](DEBUG): Initializing MassServo.
2025-09-23T15:32:01.677Z,1758641521.677 [RudderServo](DEBUG): Initializing EZServoServo.
2025-09-23T15:32:01.684Z,1758641521.684 [RudderServo](DEBUG): Initializing RudderServo.
2025-09-23T15:32:01.685Z,1758641521.685 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-09-23T15:32:01.692Z,1758641521.692 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-09-23T15:32:02.836Z,1758641522.836 [WetLabsBB2FL](INFO): Powering down
2025-09-23T15:32:03.838Z,1758641523.838 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART
2025-09-23T15:32:05.081Z,1758641525.081 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2311
2025-09-23T15:32:05.483Z,1758641525.483 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging
2025-09-23T15:32:07.309Z,1758641527.309 [ThrusterHE](ERROR): Zero Speed Commanded.
2025-09-23T15:32:07.752Z,1758641527.752 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit.
2025-09-23T15:32:14.029Z,1758641534.029 [DAT](INFO): DAT read:
2025-09-23T15:32:14.030Z,1758641534.030 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series
2025-09-23T15:32:15.793Z,1758641535.793 [DAT](INFO): DAT read: MF Frequency Band
2025-09-23T15:32:15.794Z,1758641535.794 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0
2025-09-23T15:32:15.795Z,1758641535.795 [DAT](INFO): DAT read: Sep 22 2025 23:08:32
2025-09-23T15:32:16.801Z,1758641536.801 [DAT](INFO): DAT read: Features enabled [Bearing]
2025-09-23T15:32:16.802Z,1758641536.802 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
2025-09-23T15:32:16.803Z,1758641536.803 [DAT](INFO): commRate: 800
2025-09-23T15:32:18.872Z,1758641538.872 [DAT](INFO): entering command mode
2025-09-23T15:32:19.072Z,1758641539.072 [DAT](INFO): DAT read:
2025-09-23T15:32:19.073Z,1758641539.073 [DAT](INFO): DAT read: user:1>
2025-09-23T15:32:19.073Z,1758641539.073 [DAT](INFO): setting verbose to 3
2025-09-23T15:32:19.325Z,1758641539.325 [DAT](INFO): DAT read: user:1>
2025-09-23T15:32:19.326Z,1758641539.326 [DAT](INFO): DAT read: Verbose | 3
2025-09-23T15:32:19.326Z,1758641539.326 [DAT](INFO): set verbose to 3
2025-09-23T15:32:19.326Z,1758641539.326 [DAT](INFO): setting DatVerbose to 27440
2025-09-23T15:32:19.576Z,1758641539.576 [DAT](INFO): DAT read: user:2>
2025-09-23T15:32:19.577Z,1758641539.577 [DAT](INFO): DAT read: DatVerbose | 27440
2025-09-23T15:32:19.578Z,1758641539.578 [DAT](INFO): set DatVerbose to 27440
2025-09-23T15:32:19.578Z,1758641539.578 [DAT](INFO): setting transmit power to 8
2025-09-23T15:32:19.829Z,1758641539.829 [DAT](INFO): DAT read: user:3>
2025-09-23T15:32:19.830Z,1758641539.830 [DAT](INFO): DAT read: TxPower | 8 (Max)
2025-09-23T15:32:19.830Z,1758641539.830 [DAT](INFO): set transmit power to 8
2025-09-23T15:32:19.831Z,1758641539.831 [DAT](INFO): setting local address to 1
2025-09-23T15:32:20.081Z,1758641540.081 [DAT](INFO): DAT read: user:4>
2025-09-23T15:32:20.082Z,1758641540.082 [DAT](INFO): DAT read: LocalAddr | 1
2025-09-23T15:32:20.082Z,1758641540.082 [DAT](INFO): set local address to 1
2025-09-23T15:32:20.083Z,1758641540.083 [DAT](INFO): Setting time to: 15:32:20 And date to:9/23/2025
2025-09-23T15:32:20.333Z,1758641540.333 [DAT](INFO): DAT read: user:5>
2025-09-23T15:32:20.334Z,1758641540.334 [DAT](INFO): DAT read: Tue Sep 23, 2025 15:32:20
2025-09-23T15:32:20.334Z,1758641540.334 [DAT](INFO): Local DAT time set to Tue Sep 23, 2025 15:32:20
2025-09-23T15:32:28.489Z,1758641548.489 [NAL9602](INFO): Powering up NAL9602
2025-09-23T15:32:39.398Z,1758641559.398 [NAL9602](INFO): NAL9602 initialized
2025-09-23T15:32:41.949Z,1758641561.949 [CommandExec](IMPORTANT): got command strobe off
2025-09-23T15:32:41.949Z,1758641561.949 [CommandExec](IMPORTANT): Deactivating strobe
2025-09-23T15:33:08.089Z,1758641588.089 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:33:16.353Z,1758641596.353 [CommandExec](IMPORTANT): got command configSet list
2025-09-23T15:33:16.353Z,1758641596.353 [CommandExec](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2025-09-23T15:33:16.354Z,1758641596.354 [CommandExec](IMPORTANT): BPC1.batteryMissingStickThreshold=15 count;
2025-09-23T15:33:16.354Z,1758641596.354 [CommandExec](IMPORTANT): Express linearApproximation TrackAcousticContact.range_to_contact 15.000000 meter;
2025-09-23T15:33:16.355Z,1758641596.355 [CommandExec](IMPORTANT): Express linearApproximation _.planktivore_HM_AvgRois 2.000000 count_per_second;
2025-09-23T15:33:16.356Z,1758641596.356 [CommandExec](IMPORTANT): Express linearApproximation _.planktivore_LM_AvgRois 100.000000 count_per_second;
2025-09-23T15:33:16.357Z,1758641596.357 [CommandExec](IMPORTANT): VerticalControl.buoyancyNeutral=261.037951 cubic_centimeter;
2025-09-23T15:33:16.358Z,1758641596.358 [CommandExec](IMPORTANT): VerticalControl.massDefault=21.200440 millimeter;
2025-09-23T15:33:16.358Z,1758641596.358 [CommandExec](IMPORTANT): Waterlinked.loadAtStartup=0 bool;
2025-09-23T15:33:21.863Z,1758641601.863 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:33:37.211Z,1758641617.211 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:33:45.271Z,1758641625.271 [SBIT](IMPORTANT): Beginning Startup BIT
2025-09-23T15:33:45.276Z,1758641625.276 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-09-23T15:33:49.780Z,1758641629.780 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.001018
CHAN A1 (24V): 0.001668
CHAN A2 (12V): 0.000534
CHAN A3 (5V): -0.001587
CHAN B0 (3.3V): 0.000376
CHAN B1 (3.15aV): 0.000372
CHAN B2 (3.15bV): -0.000267
CHAN B3 (GND): -0.000965
OPEN: 0.006097
Full Scale: +/- 1 mA
2025-09-23T15:33:52.160Z,1758641632.160 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:33:56.583Z,1758641636.583 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:33:59.790Z,1758641639.790 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:34:02.685Z,1758641642.685 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:34:05.514Z,1758641645.514 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:34:08.745Z,1758641648.745 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:34:10.015Z,1758641650.015 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:34:11.580Z,1758641651.580 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:34:14.402Z,1758641654.402 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:34:17.231Z,1758641657.231 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:34:20.058Z,1758641660.058 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:34:23.296Z,1758641663.296 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:34:26.117Z,1758641666.117 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:34:28.958Z,1758641668.958 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:34:31.018Z,1758641671.018 [CommandExec](IMPORTANT): got command configSet list
2025-09-23T15:34:31.018Z,1758641671.018 [CommandExec](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2025-09-23T15:34:31.019Z,1758641671.019 [CommandExec](IMPORTANT): BPC1.batteryMissingStickThreshold=15 count;
2025-09-23T15:34:31.025Z,1758641671.025 [CommandExec](IMPORTANT): Express linearApproximation TrackAcousticContact.range_to_contact 15.000000 meter;
2025-09-23T15:34:31.027Z,1758641671.027 [CommandExec](IMPORTANT): Express linearApproximation _.planktivore_HM_AvgRois 2.000000 count_per_second;
2025-09-23T15:34:31.027Z,1758641671.027 [CommandExec](IMPORTANT): Express linearApproximation _.planktivore_LM_AvgRois 100.000000 count_per_second;
2025-09-23T15:34:31.032Z,1758641671.032 [CommandExec](IMPORTANT): VerticalControl.buoyancyNeutral=261.037951 cubic_centimeter;
2025-09-23T15:34:31.033Z,1758641671.033 [CommandExec](IMPORTANT): VerticalControl.massDefault=21.200440 millimeter;
2025-09-23T15:34:31.034Z,1758641671.034 [CommandExec](IMPORTANT): Waterlinked.loadAtStartup=0 bool;
2025-09-23T15:34:31.790Z,1758641671.790 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:34:34.614Z,1758641674.614 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:34:37.442Z,1758641677.442 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:34:39.479Z,1758641679.479 [SBIT](IMPORTANT): SBIT PASSED
2025-09-23T15:34:39.479Z,1758641679.479 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2025-09-23T15:34:39.480Z,1758641679.480 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=15 count;
2025-09-23T15:34:39.480Z,1758641679.480 [SBIT](IMPORTANT): Express linearApproximation TrackAcousticContact.range_to_contact 15.000000 meter;
2025-09-23T15:34:39.480Z,1758641679.480 [SBIT](IMPORTANT): Express linearApproximation _.planktivore_HM_AvgRois 2.000000 count_per_second;
2025-09-23T15:34:39.480Z,1758641679.480 [SBIT](IMPORTANT): Express linearApproximation _.planktivore_LM_AvgRois 100.000000 count_per_second;
2025-09-23T15:34:39.480Z,1758641679.480 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=261.037951 cubic_centimeter;
2025-09-23T15:34:39.481Z,1758641679.481 [SBIT](IMPORTANT): VerticalControl.massDefault=21.200440 millimeter;
2025-09-23T15:34:39.481Z,1758641679.481 [SBIT](IMPORTANT): Waterlinked.loadAtStartup=0 bool;
2025-09-23T15:34:39.883Z,1758641679.883 [MissionManager](IMPORTANT): Started mission Startup
2025-09-23T15:34:39.884Z,1758641679.884 [Startup] Running Loop=1
2025-09-23T15:34:39.884Z,1758641679.884 [Startup](DEBUG): Aggregate::initialize Startup
2025-09-23T15:34:39.884Z,1758641679.884 [Startup:A.GoToSurface] Running Loop=1
2025-09-23T15:34:39.884Z,1758641679.884 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-09-23T15:34:39.885Z,1758641679.885 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-09-23T15:34:39.885Z,1758641679.885 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-09-23T15:34:39.885Z,1758641679.885 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-09-23T15:34:39.886Z,1758641679.886 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-09-23T15:34:39.886Z,1758641679.886 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-09-23T15:34:39.886Z,1758641679.886 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-09-23T15:34:39.888Z,1758641679.888 [Startup:StartupSatComms] Running Loop=1
2025-09-23T15:34:39.888Z,1758641679.888 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2025-09-23T15:34:39.888Z,1758641679.888 [Startup:StartupSatComms:A] Running Loop=1
2025-09-23T15:34:40.350Z,1758641680.350 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:34:40.373Z,1758641680.373 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2025-09-23T15:34:42.694Z,1758641682.694 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:34:45.522Z,1758641685.522 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:34:46.602Z,1758641686.602 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005021
2025-09-23T15:34:49.528Z,1758641689.528 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:34:52.760Z,1758641692.760 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:34:55.587Z,1758641695.587 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:34:58.820Z,1758641698.820 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:35:00.865Z,1758641700.865 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2025-09-23T15:35:00.865Z,1758641700.865 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-09-23T15:35:00.876Z,1758641700.876 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-09-23T15:35:01.286Z,1758641701.286 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-09-23T15:35:01.287Z,1758641701.287 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2025-09-23T15:35:01.646Z,1758641701.646 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:35:04.479Z,1758641704.479 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:35:07.709Z,1758641707.709 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:35:10.941Z,1758641710.941 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:35:13.767Z,1758641713.767 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:35:16.595Z,1758641716.595 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:35:19.827Z,1758641719.827 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:35:22.654Z,1758641722.654 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:35:25.483Z,1758641725.483 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:35:28.311Z,1758641728.311 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:35:31.138Z,1758641731.138 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:35:34.371Z,1758641734.371 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:35:37.197Z,1758641737.197 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:35:40.028Z,1758641740.028 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:35:40.039Z,1758641740.039 [Startup:StartupSatComms:A](INFO): Timed out from 2025-09-23T15:34:39.9Z
2025-09-23T15:35:40.039Z,1758641740.039 [Startup:StartupSatComms:A] Stopped
2025-09-23T15:35:40.040Z,1758641740.040 [Startup:StartupSatComms:B] Running Loop=1
2025-09-23T15:35:40.455Z,1758641740.455 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-09-23T15:35:42.854Z,1758641742.854 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:35:45.682Z,1758641745.682 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:35:46.516Z,1758641746.516 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20250923T153149/Courier0000.lzma
2025-09-23T15:35:47.518Z,1758641747.518 [DataOverHttps](INFO): Moved sent file to Logs/20250923T153149/Courier0000.lzma.bak
2025-09-23T15:35:47.518Z,1758641747.518 [DataOverHttps](INFO): SBD MOMSN=26064720
2025-09-23T15:35:48.511Z,1758641748.511 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:35:51.743Z,1758641751.743 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:35:54.571Z,1758641754.571 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:35:57.399Z,1758641757.399 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:36:00.630Z,1758641760.630 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:36:01.245Z,1758641761.245 [CommandExec](IMPORTANT): got command failComponent
2025-09-23T15:36:01.245Z,1758641761.245 [CommandExec](IMPORTANT): Failed components:
2025-09-23T15:36:01.245Z,1758641761.245 [CommandExec](IMPORTANT): No failed Components.
2025-09-23T15:36:03.207Z,1758641763.207 [DataOverHttps](INFO): Sending 1051 bytes from file Logs/20250923T153149/Express0001.lzma
2025-09-23T15:36:03.459Z,1758641763.459 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:36:04.207Z,1758641764.207 [DataOverHttps](INFO): Moved sent file to Logs/20250923T153149/Express0001.lzma.bak
2025-09-23T15:36:04.208Z,1758641764.208 [DataOverHttps](INFO): SBD MOMSN=26064727
2025-09-23T15:36:05.489Z,1758641765.489 [Startup:StartupSatComms:B] Stopped
2025-09-23T15:36:05.490Z,1758641765.490 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2025-09-23T15:36:05.490Z,1758641765.490 [Startup:StartupSatComms] Stopped
2025-09-23T15:36:05.490Z,1758641765.490 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2025-09-23T15:36:05.491Z,1758641765.491 [Startup](INFO): Completed Startup
2025-09-23T15:36:05.491Z,1758641765.491 [MissionManager](INFO): Startup is completed.
2025-09-23T15:36:05.491Z,1758641765.491 [MissionManager](INFO): Uninitializing Mission Startup
2025-09-23T15:36:05.491Z,1758641765.491 [Startup] Stopped
2025-09-23T15:36:05.491Z,1758641765.491 [Startup](DEBUG): Aggregate::uninitialize Startup
2025-09-23T15:36:05.491Z,1758641765.491 [Startup:A.GoToSurface] Stopped
2025-09-23T15:36:05.491Z,1758641765.491 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-09-23T15:36:05.898Z,1758641765.898 [MissionManager](IMPORTANT): Started mission Default
2025-09-23T15:36:05.898Z,1758641765.898 [Default] Running Loop=1
2025-09-23T15:36:05.898Z,1758641765.898 [Default](DEBUG): Aggregate::initialize Default
2025-09-23T15:36:05.899Z,1758641765.899 [Default:B.GoToSurface] Running Loop=1
2025-09-23T15:36:05.899Z,1758641765.899 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-09-23T15:36:05.899Z,1758641765.899 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-09-23T15:36:05.899Z,1758641765.899 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-09-23T15:36:05.899Z,1758641765.899 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-09-23T15:36:05.900Z,1758641765.900 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-09-23T15:36:05.900Z,1758641765.900 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-09-23T15:36:05.901Z,1758641765.901 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-09-23T15:36:05.901Z,1758641765.901 [Default:A.Wait] Running Loop=1
2025-09-23T15:36:05.901Z,1758641765.901 [Default:A.Wait](DEBUG): Initialize Wait Component.
2025-09-23T15:36:06.285Z,1758641766.285 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:36:08.711Z,1758641768.711 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:36:11.538Z,1758641771.538 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:36:14.367Z,1758641774.367 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:36:19.254Z,1758641779.254 [Default:A.Wait](INFO): Done Waiting.
2025-09-23T15:36:19.255Z,1758641779.255 [Default:A.Wait] Stopped
2025-09-23T15:36:19.255Z,1758641779.255 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2025-09-23T15:36:19.658Z,1758641779.658 [Default:CheckIn] Running Loop=1
2025-09-23T15:36:19.658Z,1758641779.658 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-09-23T15:36:19.658Z,1758641779.658 [Default:CheckIn:Read_GPS] Running Loop=1
2025-09-23T15:36:20.051Z,1758641780.051 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-09-23T15:36:21.230Z,1758641781.230 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T15:36:37.794Z,1758641797.794 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T15:36:54.358Z,1758641814.358 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T15:37:10.519Z,1758641830.519 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T15:37:23.854Z,1758641843.854 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:37:27.087Z,1758641847.087 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:37:27.497Z,1758641847.497 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T15:37:30.318Z,1758641850.318 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:37:33.550Z,1758641853.550 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:37:36.782Z,1758641856.782 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:37:40.015Z,1758641860.015 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:37:42.454Z,1758641862.454 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-09-23T15:37:43.246Z,1758641863.246 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:37:44.069Z,1758641864.069 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T15:37:46.478Z,1758641866.478 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:37:49.710Z,1758641869.710 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:37:53.346Z,1758641873.346 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:37:56.578Z,1758641876.578 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:37:59.810Z,1758641879.810 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:38:00.629Z,1758641880.629 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T15:38:01.838Z,1758641881.838 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2025-09-23T15:38:01.838Z,1758641881.838 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-09-23T15:38:01.848Z,1758641881.848 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-09-23T15:38:02.262Z,1758641882.262 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-09-23T15:38:02.262Z,1758641882.262 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2025-09-23T15:38:03.042Z,1758641883.042 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:38:06.274Z,1758641886.274 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:38:09.506Z,1758641889.506 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:38:12.738Z,1758641892.738 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:38:15.971Z,1758641895.971 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:38:16.830Z,1758641896.830 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:38:19.202Z,1758641899.202 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:38:22.434Z,1758641902.434 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:38:25.667Z,1758641905.667 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:38:28.898Z,1758641908.898 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:38:32.130Z,1758641912.130 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:38:34.146Z,1758641914.146 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T15:38:35.362Z,1758641915.362 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:38:38.594Z,1758641918.594 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:38:41.826Z,1758641921.826 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:38:45.058Z,1758641925.058 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:38:48.694Z,1758641928.694 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:38:51.926Z,1758641931.926 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:38:53.998Z,1758641933.998 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:38:55.158Z,1758641935.158 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:38:58.391Z,1758641938.391 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:39:01.623Z,1758641941.623 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:39:02.337Z,1758641942.337 [CommandExec](IMPORTANT): got command burn on
2025-09-23T15:39:02.337Z,1758641942.337 [CommandExec](IMPORTANT): Activating dropweight wire
2025-09-23T15:39:04.854Z,1758641944.854 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:39:07.553Z,1758641947.553 [CommandExec](IMPORTANT): got command burn off
2025-09-23T15:39:07.553Z,1758641947.553 [CommandExec](IMPORTANT): Deactivating dropweight wire
2025-09-23T15:39:08.086Z,1758641948.086 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:39:11.319Z,1758641951.319 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:39:14.550Z,1758641954.550 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:39:17.782Z,1758641957.782 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:39:21.014Z,1758641961.014 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:39:24.246Z,1758641964.246 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:39:27.479Z,1758641967.479 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:39:30.710Z,1758641970.710 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:39:33.942Z,1758641973.942 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:39:35.793Z,1758641975.793 [CommandExec](IMPORTANT): got command failComponent
2025-09-23T15:39:35.793Z,1758641975.793 [CommandExec](IMPORTANT): Failed components:
2025-09-23T15:39:35.793Z,1758641975.793 [CommandExec](IMPORTANT): No failed Components.
2025-09-23T15:39:37.174Z,1758641977.174 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:39:40.406Z,1758641980.406 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:39:43.638Z,1758641983.638 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:39:46.870Z,1758641986.870 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:39:51.725Z,1758641991.725 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:40:01.473Z,1758642001.473 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:40:06.724Z,1758642006.724 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:40:11.216Z,1758642011.216 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:40:21.272Z,1758642021.272 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:40:31.012Z,1758642031.012 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:40:41.110Z,1758642041.110 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:40:51.162Z,1758642051.162 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:41:01.261Z,1758642061.261 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:41:02.833Z,1758642062.833 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2025-09-23T15:41:02.833Z,1758642062.833 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-09-23T15:41:02.870Z,1758642062.870 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-09-23T15:41:03.241Z,1758642063.241 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-09-23T15:41:03.241Z,1758642063.241 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2025-09-23T15:41:10.124Z,1758642070.124 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:41:10.959Z,1758642070.959 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:41:19.802Z,1758642079.802 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-09-23T15:36:19.7Z
2025-09-23T15:41:19.802Z,1758642079.802 [Default:CheckIn:Read_GPS] Stopped
2025-09-23T15:41:19.802Z,1758642079.802 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-09-23T15:41:20.210Z,1758642080.210 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-09-23T15:41:21.058Z,1758642081.058 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:41:23.891Z,1758642083.891 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:41:26.999Z,1758642086.999 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250923T153149/Courier0004.lzma
2025-09-23T15:41:28.002Z,1758642088.002 [DataOverHttps](INFO): Moved sent file to Logs/20250923T153149/Courier0004.lzma.bak
2025-09-23T15:41:28.002Z,1758642088.002 [DataOverHttps](INFO): SBD MOMSN=26064805
2025-09-23T15:41:30.754Z,1758642090.754 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-09-23T15:41:36.807Z,1758642096.807 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-09-23T15:41:43.637Z,1758642103.637 [DataOverHttps](INFO): Sending 306 bytes from file Logs/20250923T153149/Express0005.lzma
2025-09-23T15:41:44.638Z,1758642104.638 [DataOverHttps](INFO): Moved sent file to Logs/20250923T153149/Express0005.lzma.bak
2025-09-23T15:41:44.638Z,1758642104.638 [DataOverHttps](INFO): SBD MOMSN=26064807
2025-09-23T15:41:45.685Z,1758642105.685 [Default:CheckIn:Read_Iridium] Stopped
2025-09-23T15:41:45.685Z,1758642105.685 [Default:CheckIn:C.Wait] Running Loop=1
2025-09-23T15:41:45.685Z,1758642105.685 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-09-23T15:41:52.107Z,1758642112.107 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T15:42:07.061Z,1758642127.061 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T15:42:22.411Z,1758642142.411 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T15:42:37.354Z,1758642157.354 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T15:42:42.614Z,1758642162.614 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-09-23T15:42:42.614Z,1758642162.614 [NAL9602] Data Fault, FailCount= 1
2025-09-23T15:42:42.614Z,1758642162.614 [NAL9602](ERROR): Data Fault
2025-09-23T15:42:42.654Z,1758642162.654 [CBIT](ERROR): Data Fault in component: NAL9602
2025-09-23T15:42:43.017Z,1758642163.017 [NAL9602](INFO): Powering down
2025-09-23T15:42:43.850Z,1758642163.850 [CBIT](INFO): Clearing failed state for component NAL9602
2025-09-23T15:42:43.850Z,1758642163.850 [NAL9602] No Fault, FailCount= 1
2025-09-23T15:42:53.112Z,1758642173.112 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T15:43:08.462Z,1758642188.462 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T15:43:13.319Z,1758642193.319 [NAL9602](INFO): Powering up NAL9602
2025-09-23T15:43:24.239Z,1758642204.239 [NAL9602](INFO): NAL9602 initialized
2025-09-23T15:44:03.833Z,1758642243.833 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2025-09-23T15:44:03.833Z,1758642243.833 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-09-23T15:44:03.843Z,1758642243.843 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-09-23T15:44:04.258Z,1758642244.258 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-09-23T15:44:04.258Z,1758642244.258 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2025-09-23T15:45:45.214Z,1758642345.214 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T15:45:58.950Z,1758642358.950 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T15:46:13.090Z,1758642373.090 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T15:46:26.422Z,1758642386.422 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T15:46:40.160Z,1758642400.160 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T15:46:46.261Z,1758642406.261 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-09-23T15:46:46.261Z,1758642406.261 [Default:CheckIn:C.Wait] Stopped
2025-09-23T15:46:46.261Z,1758642406.261 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-09-23T15:46:46.262Z,1758642406.262 [Default:CheckIn:D] Running Loop=1
2025-09-23T15:46:46.650Z,1758642406.650 [Default:CheckIn:D] Stopped
2025-09-23T15:46:46.650Z,1758642406.650 [Default:CheckIn:E] Running Loop=1
2025-09-23T15:46:47.055Z,1758642407.055 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.679199 min
2025-09-23T15:46:47.055Z,1758642407.055 [Default:CheckIn:E] Stopped
2025-09-23T15:46:47.055Z,1758642407.055 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-09-23T15:46:47.055Z,1758642407.055 [Default:CheckIn] Stopped
2025-09-23T15:46:47.055Z,1758642407.055 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-09-23T15:46:47.055Z,1758642407.055 [Default:CheckIn](INFO): Running loop #2
2025-09-23T15:46:47.055Z,1758642407.055 [Default:CheckIn] Running Loop=2
2025-09-23T15:46:47.055Z,1758642407.055 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-09-23T15:46:47.055Z,1758642407.055 [Default:CheckIn:Read_GPS] Running Loop=1
2025-09-23T15:46:54.298Z,1758642414.298 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T15:47:04.817Z,1758642424.817 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2025-09-23T15:47:04.817Z,1758642424.817 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-09-23T15:47:04.828Z,1758642424.828 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-09-23T15:47:05.250Z,1758642425.250 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-09-23T15:47:05.251Z,1758642425.251 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2025-09-23T15:47:08.438Z,1758642428.438 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T15:47:12.082Z,1758642432.082 [BPC1](ERROR): Battery stick #17 (s/n: 0084) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-09-23T15:47:12.083Z,1758642432.083 [BPC1](ERROR): Battery stick #24 (s/n: 01D3) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-09-23T15:47:12.084Z,1758642432.084 [BPC1](ERROR): Battery stick #29 (s/n: 00A7) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0.
2025-09-23T15:47:12.085Z,1758642432.085 [BPC1](ERROR): Battery stick #38 (s/n: 01BC) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48E0.
2025-09-23T15:47:12.086Z,1758642432.086 [BPC1](ERROR): Battery stick #51 (s/n: 01D6) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-09-23T15:47:12.086Z,1758642432.086 [BPC1](ERROR): Battery stick #57 (s/n: 019F) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-09-23T15:47:12.087Z,1758642432.087 [BPC1](ERROR): Battery stick #59 (s/n: 0184) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0.
2025-09-23T15:47:12.087Z,1758642432.087 [BPC1](INFO): Calculating totals. Valid battery stick count: 39. Valid reserve battery stick count: 4.
2025-09-23T15:47:12.091Z,1758642432.091 [BPC1](INFO): Received data from all battery sticks.
2025-09-23T15:50:05.816Z,1758642605.816 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2025-09-23T15:50:05.816Z,1758642605.816 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-09-23T15:50:05.830Z,1758642605.830 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-09-23T15:50:06.249Z,1758642606.249 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-09-23T15:50:06.249Z,1758642606.249 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2025-09-23T15:51:47.231Z,1758642707.231 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-09-23T15:46:47.1Z
2025-09-23T15:51:47.231Z,1758642707.231 [Default:CheckIn:Read_GPS] Stopped
2025-09-23T15:51:47.231Z,1758642707.231 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-09-23T15:51:54.152Z,1758642714.152 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20250923T153149/Courier0007.lzma
2025-09-23T15:52:05.202Z,1758642725.202 [DataOverHttps](INFO): Moved sent file to Logs/20250923T153149/Courier0007.lzma.bak
2025-09-23T15:52:05.202Z,1758642725.202 [DataOverHttps](INFO): SBD MOMSN=26064874
2025-09-23T15:52:30.848Z,1758642750.848 [DataOverHttps](INFO): Sending 182 bytes from file Logs/20250923T153149/Express0008.lzma
2025-09-23T15:52:41.890Z,1758642761.890 [DataOverHttps](INFO): Moved sent file to Logs/20250923T153149/Express0008.lzma.bak
2025-09-23T15:52:41.890Z,1758642761.890 [DataOverHttps](INFO): SBD MOMSN=26064876
2025-09-23T15:52:42.985Z,1758642762.985 [Default:CheckIn:Read_Iridium] Stopped
2025-09-23T15:52:42.985Z,1758642762.985 [Default:CheckIn:C.Wait] Running Loop=1
2025-09-23T15:52:42.985Z,1758642762.985 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-09-23T15:53:06.862Z,1758642786.862 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2025-09-23T15:53:06.862Z,1758642786.862 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-09-23T15:53:06.873Z,1758642786.873 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-09-23T15:53:07.284Z,1758642787.284 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-09-23T15:53:07.284Z,1758642787.284 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2025-09-23T15:53:25.430Z,1758642805.430 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-09-23T15:53:25.430Z,1758642805.430 [NAL9602] Data Fault, FailCount= 2
2025-09-23T15:53:25.430Z,1758642805.430 [NAL9602](ERROR): Data Fault
2025-09-23T15:53:25.476Z,1758642805.476 [CBIT](ERROR): Data Fault in component: NAL9602
2025-09-23T15:53:25.833Z,1758642805.833 [NAL9602](INFO): Powering down
2025-09-23T15:53:26.666Z,1758642806.666 [CBIT](INFO): Clearing failed state for component NAL9602
2025-09-23T15:53:26.666Z,1758642806.666 [NAL9602] No Fault, FailCount= 2
2025-09-23T15:53:56.133Z,1758642836.133 [NAL9602](INFO): Powering up NAL9602
2025-09-23T15:54:07.042Z,1758642847.042 [NAL9602](INFO): NAL9602 initialized
2025-09-23T15:54:32.092Z,1758642872.092 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,155430.00,A,3648.17406,N,12147.28103,W,0.019,0.00,230925,,,A*79
2025-09-23T15:54:32.103Z,1758642872.103 [NAL9602](INFO): GPS fix at 20250923T155430: (36.802901, -121.788017)
2025-09-23T15:55:04.469Z,1758642904.469 [NAL9602](INFO): Not Powering down - fast GPS
2025-09-23T15:56:49.605Z,1758643009.605 [DAT](INFO): DAT read: user:6>Rx Time:15:56:47.9203
2025-09-23T15:56:49.606Z,1758643009.606 [DAT](INFO): Rx dataTimestamp_ set to:1758643009.605531
2025-09-23T15:56:49.606Z,1758643009.606 [DAT](INFO): DAT read:
2025-09-23T15:56:49.607Z,1758643009.607 [DAT](INFO): DAT read: $Packet for address 0
2025-09-23T15:56:49.607Z,1758643009.607 [DAT](INFO): received a packet notification
2025-09-23T15:56:54.393Z,1758643014.393 [DAT](INFO): DAT read: Rx Time:15:56:52.7083
2025-09-23T15:56:54.394Z,1758643014.394 [DAT](INFO): Rx dataTimestamp_ set to:1758643014.393673
2025-09-23T15:56:54.394Z,1758643014.394 [DAT](INFO): DAT read:
2025-09-23T15:56:54.395Z,1758643014.395 [DAT](INFO): DAT read: $Packet for address 0
2025-09-23T15:56:54.395Z,1758643014.395 [DAT](INFO): received a packet notification
2025-09-23T15:57:43.724Z,1758643063.724 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-09-23T15:57:43.724Z,1758643063.724 [Default:CheckIn:C.Wait] Stopped
2025-09-23T15:57:43.724Z,1758643063.724 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-09-23T15:57:43.724Z,1758643063.724 [Default:CheckIn:D] Running Loop=1
2025-09-23T15:57:44.132Z,1758643064.132 [Default:CheckIn:D] Stopped
2025-09-23T15:57:44.132Z,1758643064.132 [Default:CheckIn:E] Running Loop=1
2025-09-23T15:57:44.530Z,1758643064.530 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.637231 min
2025-09-23T15:57:44.530Z,1758643064.530 [Default:CheckIn:E] Stopped
2025-09-23T15:57:44.530Z,1758643064.530 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-09-23T15:57:44.531Z,1758643064.531 [Default:CheckIn] Stopped
2025-09-23T15:57:44.531Z,1758643064.531 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-09-23T15:57:44.531Z,1758643064.531 [Default:CheckIn](INFO): Running loop #3
2025-09-23T15:57:44.531Z,1758643064.531 [Default:CheckIn] Running Loop=3
2025-09-23T15:57:44.531Z,1758643064.531 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-09-23T15:57:44.531Z,1758643064.531 [Default:CheckIn:Read_GPS] Running Loop=1
2025-09-23T15:57:46.534Z,1758643066.534 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,155744.00,A,3648.14236,N,12147.25941,W,0.078,201.73,230925,,,A*7C
2025-09-23T15:57:46.536Z,1758643066.536 [NAL9602](INFO): GPS fix at 20250923T155744: (36.802373, -121.787657)
2025-09-23T15:57:46.547Z,1758643066.547 [Default:CheckIn:Read_GPS] Stopped
2025-09-23T15:57:46.547Z,1758643066.547 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-09-23T15:57:54.084Z,1758643074.084 [DataOverHttps](INFO): Sending 222 bytes from file Logs/20250923T153149/Courier0010.lzma
2025-09-23T15:58:05.134Z,1758643085.134 [DataOverHttps](INFO): Moved sent file to Logs/20250923T153149/Courier0010.lzma.bak
2025-09-23T15:58:05.134Z,1758643085.134 [DataOverHttps](INFO): SBD MOMSN=26064901
2025-09-23T15:58:15.623Z,1758643095.623 [NAL9602](INFO): SBD MO Status=2, MOMSN=27983, MT Status=2, MTMSN=0
2025-09-23T15:58:15.623Z,1758643095.623 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-09-23T15:58:31.009Z,1758643111.009 [DataOverHttps](INFO): Sending 421 bytes from file Logs/20250923T153149/Express0011.lzma
2025-09-23T15:58:42.050Z,1758643122.050 [DataOverHttps](INFO): Moved sent file to Logs/20250923T153149/Express0011.lzma.bak
2025-09-23T15:58:42.050Z,1758643122.050 [DataOverHttps](INFO): SBD MOMSN=26064905
2025-09-23T15:58:43.123Z,1758643123.123 [Default:CheckIn:Read_Iridium] Stopped
2025-09-23T15:58:43.123Z,1758643123.123 [Default:CheckIn:C.Wait] Running Loop=1
2025-09-23T15:58:43.123Z,1758643123.123 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-09-23T15:58:58.903Z,1758643138.903 [NAL9602](INFO): SBD MO Status=2, MOMSN=27983, MT Status=2, MTMSN=0
2025-09-23T15:58:58.903Z,1758643138.903 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-09-23T15:59:25.176Z,1758643165.176 [NAL9602](INFO): SBD MO Status=0, MOMSN=27983, MT Status=0, MTMSN=0
2025-09-23T15:59:25.176Z,1758643165.176 [NAL9602](INFO): No messages in MT queue
2025-09-23T15:59:55.874Z,1758643195.874 [NAL9602](INFO): Not Powering down - fast GPS
2025-09-23T16:02:03.274Z,1758643323.274 [DataOverHttps](IMPORTANT): SBD MTMSN=20250923T160202
2025-09-23T16:02:10.768Z,1758643330.768 [DataOverHttps](INFO): Received command: ibit
2025-09-23T16:02:10.843Z,1758643330.843 [CommandExec](IMPORTANT): got command ibit
2025-09-23T16:02:10.871Z,1758643330.871 [IBIT](IMPORTANT): Beginning Initiated BIT
2025-09-23T16:02:10.872Z,1758643330.872 [IBIT](IMPORTANT): Beginning control surface checks.
2025-09-23T16:02:10.875Z,1758643330.875 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-09-23T16:02:12.471Z,1758643332.471 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160210.00,A,3648.15661,N,12147.22482,W,0.058,38.35,230925,,,D*41
2025-09-23T16:02:12.473Z,1758643332.473 [NAL9602](INFO): GPS fix at 20250923T160210: (36.802610, -121.787080)
2025-09-23T16:02:15.416Z,1758643335.416 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.000530
CHAN A1 (24V): 0.000724
CHAN A2 (12V): 0.000212
CHAN A3 (5V): -0.000876
CHAN B0 (3.3V): 0.000420
CHAN B1 (3.15aV): -0.000348
CHAN B2 (3.15bV): -0.000482
CHAN B3 (GND): -0.000080
OPEN: 0.006353
Full Scale: +/- 1 mA
2025-09-23T16:02:21.818Z,1758643341.818 [DataOverHttps](IMPORTANT): SBD MTMSN=20250923T160220
2025-09-23T16:02:29.280Z,1758643349.280 [DataOverHttps](INFO): Received command: failc
2025-09-23T16:02:29.294Z,1758643349.294 [CommandExec](IMPORTANT): got command failComponent
2025-09-23T16:02:29.294Z,1758643349.294 [CommandExec](IMPORTANT): Failed components:
2025-09-23T16:02:29.294Z,1758643349.294 [CommandExec](IMPORTANT): No failed Components.
2025-09-23T16:02:29.879Z,1758643349.879 [NAL9602](INFO): SBD MO Status=2, MOMSN=27984, MT Status=2, MTMSN=0
2025-09-23T16:02:29.879Z,1758643349.879 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-09-23T16:03:28.948Z,1758643408.948 [IBIT](IMPORTANT): Communications Status:
Fix Status: 1
Iridium Signal Strength: 1
Latitude: 36.802608 Longitude: -121.787079
2025-09-23T16:03:29.325Z,1758643409.325 [IBIT](IMPORTANT): Battery Status:
Battery Charge (AH): 0.000000
Voltage: 16.611000
2025-09-23T16:03:29.325Z,1758643409.325 [IBIT](IMPORTANT): batteryCapacityThreshold: 50.000000 Ah
2025-09-23T16:03:29.326Z,1758643409.326 [IBIT](IMPORTANT): batteryVoltageThreshold: 13.700000 V
2025-09-23T16:03:29.698Z,1758643409.698 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 %
2025-09-23T16:03:29.698Z,1758643409.698 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi
2025-09-23T16:03:29.699Z,1758643409.699 [IBIT](IMPORTANT): Pressure:10.173535 PSI
2025-09-23T16:03:29.699Z,1758643409.699 [IBIT](IMPORTANT): Humidity:23.641802 %
2025-09-23T16:03:30.097Z,1758643410.097 [IBIT](IMPORTANT): Vehicle Pitch:-0.882385 degrees
2025-09-23T16:03:30.097Z,1758643410.097 [IBIT](IMPORTANT): Vehicle Roll:-2.735601 degrees
2025-09-23T16:03:30.097Z,1758643410.097 [IBIT](IMPORTANT): Vehicle Heading:197.709122 degrees
2025-09-23T16:03:30.513Z,1758643410.513 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m
2025-09-23T16:03:30.514Z,1758643410.514 [IBIT](IMPORTANT): buoyancyNeutral: 261.037964 cc
2025-09-23T16:03:30.514Z,1758643410.514 [IBIT](IMPORTANT): massDefault: 2.120044 cm
2025-09-23T16:03:30.514Z,1758643410.514 [IBIT](IMPORTANT): stopDepth: 290.000000 m
2025-09-23T16:03:30.515Z,1758643410.515 [IBIT](IMPORTANT): abortDepth: 300.000000 m
2025-09-23T16:03:30.515Z,1758643410.515 [IBIT](IMPORTANT): IBIT PASSED
2025-09-23T16:03:43.824Z,1758643423.824 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-09-23T16:03:43.825Z,1758643423.825 [Default:CheckIn:C.Wait] Stopped
2025-09-23T16:03:43.825Z,1758643423.825 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-09-23T16:03:43.825Z,1758643423.825 [Default:CheckIn:D] Running Loop=1
2025-09-23T16:03:44.248Z,1758643424.248 [Default:CheckIn:D] Stopped
2025-09-23T16:03:44.248Z,1758643424.248 [Default:CheckIn:E] Running Loop=1
2025-09-23T16:03:44.645Z,1758643424.645 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 27.639154 min
2025-09-23T16:03:44.645Z,1758643424.645 [Default:CheckIn:E] Stopped
2025-09-23T16:03:44.645Z,1758643424.645 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-09-23T16:03:44.645Z,1758643424.645 [Default:CheckIn] Stopped
2025-09-23T16:03:44.645Z,1758643424.645 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-09-23T16:03:44.646Z,1758643424.646 [Default:CheckIn](INFO): Running loop #4
2025-09-23T16:03:44.646Z,1758643424.646 [Default:CheckIn] Running Loop=4
2025-09-23T16:03:44.646Z,1758643424.646 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-09-23T16:03:44.646Z,1758643424.646 [Default:CheckIn:Read_GPS] Running Loop=1
2025-09-23T16:04:27.447Z,1758643467.447 [NAL9602](INFO): SBD MO Status=0, MOMSN=27984, MT Status=0, MTMSN=0
2025-09-23T16:04:27.447Z,1758643467.447 [NAL9602](INFO): No messages in MT queue
2025-09-23T16:04:28.655Z,1758643468.655 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160426.00,A,3648.15619,N,12147.22457,W,0.097,38.35,230925,,,D*46
2025-09-23T16:04:28.657Z,1758643468.657 [NAL9602](INFO): GPS fix at 20250923T160426: (36.802603, -121.787076)
2025-09-23T16:04:28.704Z,1758643468.704 [Default:CheckIn:Read_GPS] Stopped
2025-09-23T16:04:28.704Z,1758643468.704 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-09-23T16:04:31.932Z,1758643471.932 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250923T153149/Courier0013.lzma
2025-09-23T16:04:42.974Z,1758643482.974 [DataOverHttps](INFO): Moved sent file to Logs/20250923T153149/Courier0013.lzma.bak
2025-09-23T16:04:42.974Z,1758643482.974 [DataOverHttps](INFO): SBD MOMSN=26064948
2025-09-23T16:05:01.541Z,1758643501.541 [NAL9602](INFO): Not Powering down - fast GPS
2025-09-23T16:05:11.650Z,1758643511.650 [DataOverHttps](INFO): Sending 927 bytes from file Logs/20250923T153149/Express0014.lzma
2025-09-23T16:05:22.690Z,1758643522.690 [DataOverHttps](INFO): Moved sent file to Logs/20250923T153149/Express0014.lzma.bak
2025-09-23T16:05:22.690Z,1758643522.690 [DataOverHttps](INFO): SBD MOMSN=26064952
2025-09-23T16:05:48.652Z,1758643548.652 [DataOverHttps](INFO): Sending 63 bytes from file Logs/20250923T153149/Express0017.lzma
2025-09-23T16:05:59.694Z,1758643559.694 [DataOverHttps](INFO): Moved sent file to Logs/20250923T153149/Express0017.lzma.bak
2025-09-23T16:05:59.694Z,1758643559.694 [DataOverHttps](INFO): SBD MOMSN=26064984
2025-09-23T16:06:00.940Z,1758643560.940 [Default:CheckIn:Read_Iridium] Stopped
2025-09-23T16:06:00.940Z,1758643560.940 [Default:CheckIn:C.Wait] Running Loop=1
2025-09-23T16:06:00.940Z,1758643560.940 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-09-23T16:11:01.533Z,1758643861.533 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-09-23T16:11:01.533Z,1758643861.533 [Default:CheckIn:C.Wait] Stopped
2025-09-23T16:11:01.533Z,1758643861.533 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-09-23T16:11:01.533Z,1758643861.533 [Default:CheckIn:D] Running Loop=1
2025-09-23T16:11:01.943Z,1758643861.943 [Default:CheckIn:D] Stopped
2025-09-23T16:11:01.943Z,1758643861.943 [Default:CheckIn:E] Running Loop=1
2025-09-23T16:11:02.360Z,1758643862.360 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 34.934070 min
2025-09-23T16:11:02.360Z,1758643862.360 [Default:CheckIn:E] Stopped
2025-09-23T16:11:02.360Z,1758643862.360 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-09-23T16:11:02.360Z,1758643862.360 [Default:CheckIn] Stopped
2025-09-23T16:11:02.360Z,1758643862.360 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-09-23T16:11:02.361Z,1758643862.361 [Default:CheckIn](INFO): Running loop #5
2025-09-23T16:11:02.361Z,1758643862.361 [Default:CheckIn] Running Loop=5
2025-09-23T16:11:02.361Z,1758643862.361 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-09-23T16:11:02.361Z,1758643862.361 [Default:CheckIn:Read_GPS] Running Loop=1
2025-09-23T16:11:04.348Z,1758643864.348 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161103.00,A,3648.15473,N,12147.22306,W,0.019,38.35,230925,,,D*4E
2025-09-23T16:11:04.350Z,1758643864.350 [NAL9602](INFO): GPS fix at 20250923T161103: (36.802579, -121.787051)
2025-09-23T16:11:04.361Z,1758643864.361 [Default:CheckIn:Read_GPS] Stopped
2025-09-23T16:11:04.361Z,1758643864.361 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-09-23T16:11:11.400Z,1758643871.400 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250923T153149/Courier0019.lzma
2025-09-23T16:11:21.727Z,1758643881.727 [NAL9602](INFO): SBD MO Status=0, MOMSN=27985, MT Status=0, MTMSN=0
2025-09-23T16:11:21.727Z,1758643881.727 [NAL9602](INFO): No messages in MT queue
2025-09-23T16:11:22.442Z,1758643882.442 [DataOverHttps](INFO): Moved sent file to Logs/20250923T153149/Courier0019.lzma.bak
2025-09-23T16:11:22.442Z,1758643882.442 [DataOverHttps](INFO): SBD MOMSN=26065037
2025-09-23T16:11:48.325Z,1758643908.325 [DataOverHttps](INFO): Sending 155 bytes from file Logs/20250923T153149/Express0020.lzma
2025-09-23T16:11:52.438Z,1758643912.438 [NAL9602](INFO): Not Powering down - fast GPS
2025-09-23T16:11:59.370Z,1758643919.370 [DataOverHttps](INFO): Moved sent file to Logs/20250923T153149/Express0020.lzma.bak
2025-09-23T16:11:59.370Z,1758643919.370 [DataOverHttps](INFO): SBD MOMSN=26065041
2025-09-23T16:12:00.529Z,1758643920.529 [Default:CheckIn:Read_Iridium] Stopped
2025-09-23T16:12:00.529Z,1758643920.529 [Default:CheckIn:C.Wait] Running Loop=1
2025-09-23T16:12:00.529Z,1758643920.529 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-09-23T16:17:01.100Z,1758644221.100 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-09-23T16:17:01.100Z,1758644221.100 [Default:CheckIn:C.Wait] Stopped
2025-09-23T16:17:01.100Z,1758644221.100 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-09-23T16:17:01.100Z,1758644221.100 [Default:CheckIn:D] Running Loop=1
2025-09-23T16:17:01.513Z,1758644221.513 [Default:CheckIn:D] Stopped
2025-09-23T16:17:01.513Z,1758644221.513 [Default:CheckIn:E] Running Loop=1
2025-09-23T16:17:01.924Z,1758644221.924 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 40.926904 min
2025-09-23T16:17:01.924Z,1758644221.924 [Default:CheckIn:E] Stopped
2025-09-23T16:17:01.924Z,1758644221.924 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-09-23T16:17:01.924Z,1758644221.924 [Default:CheckIn] Stopped
2025-09-23T16:17:01.924Z,1758644221.924 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-09-23T16:17:01.925Z,1758644221.925 [Default:CheckIn](INFO): Running loop #6
2025-09-23T16:17:01.925Z,1758644221.925 [Default:CheckIn] Running Loop=6
2025-09-23T16:17:01.925Z,1758644221.925 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-09-23T16:17:01.925Z,1758644221.925 [Default:CheckIn:Read_GPS] Running Loop=1
2025-09-23T16:17:03.923Z,1758644223.923 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161703.00,A,3648.15380,N,12147.22347,W,0.019,38.35,230925,,,D*46
2025-09-23T16:17:03.925Z,1758644223.925 [NAL9602](INFO): GPS fix at 20250923T161703: (36.802563, -121.787058)
2025-09-23T16:17:03.937Z,1758644223.937 [Default:CheckIn:Read_GPS] Stopped
2025-09-23T16:17:03.937Z,1758644223.937 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-09-23T16:17:11.284Z,1758644231.284 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250923T153149/Courier0022.lzma
2025-09-23T16:17:22.326Z,1758644242.326 [DataOverHttps](INFO): Moved sent file to Logs/20250923T153149/Courier0022.lzma.bak
2025-09-23T16:17:22.326Z,1758644242.326 [DataOverHttps](IMPORTANT): SBD MOMSN=26065052, MTMSN=20250923T161721
2025-09-23T16:17:29.748Z,1758644249.748 [DataOverHttps](INFO): Received command: ibit
2025-09-23T16:17:29.837Z,1758644249.837 [CommandExec](IMPORTANT): got command ibit
2025-09-23T16:17:30.214Z,1758644250.214 [IBIT](IMPORTANT): Beginning Initiated BIT
2025-09-23T16:17:30.214Z,1758644250.214 [IBIT](IMPORTANT): Beginning control surface checks.
2025-09-23T16:17:30.222Z,1758644250.222 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-09-23T16:17:31.391Z,1758644251.391 [NAL9602](INFO): SBD MO Status=2, MOMSN=27986, MT Status=2, MTMSN=0
2025-09-23T16:17:31.391Z,1758644251.391 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-09-23T16:17:34.712Z,1758644254.712 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.001314
CHAN A1 (24V): 0.001041
CHAN A2 (12V): 0.000568
CHAN A3 (5V): -0.001101
CHAN B0 (3.3V): 0.000426
CHAN B1 (3.15aV): 0.000369
CHAN B2 (3.15bV): -0.000446
CHAN B3 (GND): -0.000275
OPEN: 0.006298
Full Scale: +/- 1 mA
2025-09-23T16:17:48.296Z,1758644268.296 [DataOverHttps](INFO): Sending 154 bytes from file Logs/20250923T153149/Express0023.lzma
2025-09-23T16:17:48.767Z,1758644268.767 [NAL9602](INFO): SBD MO Status=0, MOMSN=27986, MT Status=0, MTMSN=0
2025-09-23T16:17:48.767Z,1758644268.767 [NAL9602](INFO): No messages in MT queue
2025-09-23T16:17:49.981Z,1758644269.981 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161749.00,A,3648.15577,N,12147.22500,W,0.097,38.35,230925,,,D*45
2025-09-23T16:17:49.983Z,1758644269.983 [NAL9602](INFO): GPS fix at 20250923T161749: (36.802596, -121.787083)
2025-09-23T16:17:52.807Z,1758644272.807 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161752.00,A,3648.15598,N,12147.22516,W,0.039,38.35,230925,,,D*4D
2025-09-23T16:17:52.809Z,1758644272.809 [NAL9602](INFO): GPS fix at 20250923T161752: (36.802600, -121.787086)
2025-09-23T16:17:56.043Z,1758644276.043 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161755.00,A,3648.15605,N,12147.22519,W,0.039,38.35,230925,,,D*42
2025-09-23T16:17:56.045Z,1758644276.045 [NAL9602](INFO): GPS fix at 20250923T161755: (36.802601, -121.787087)
2025-09-23T16:17:58.871Z,1758644278.871 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161758.00,A,3648.15624,N,12147.22533,W,0.019,38.35,230925,,,D*46
2025-09-23T16:17:58.874Z,1758644278.874 [NAL9602](INFO): GPS fix at 20250923T161758: (36.802604, -121.787089)
2025-09-23T16:17:59.338Z,1758644279.338 [DataOverHttps](INFO): Moved sent file to Logs/20250923T153149/Express0023.lzma.bak
2025-09-23T16:17:59.338Z,1758644279.338 [DataOverHttps](INFO): SBD MOMSN=26065056
2025-09-23T16:18:02.099Z,1758644282.099 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161801.00,A,3648.15635,N,12147.22543,W,0.039,38.35,230925,,,D*40
2025-09-23T16:18:02.102Z,1758644282.102 [NAL9602](INFO): GPS fix at 20250923T161801: (36.802606, -121.787091)
2025-09-23T16:18:04.931Z,1758644284.931 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161804.00,A,3648.15622,N,12147.22549,W,0.019,38.35,230925,,,D*4B
2025-09-23T16:18:04.933Z,1758644284.933 [NAL9602](INFO): GPS fix at 20250923T161804: (36.802604, -121.787092)
2025-09-23T16:18:07.755Z,1758644287.755 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161807.00,A,3648.15617,N,12147.22569,W,0.019,38.35,230925,,,D*4C
2025-09-23T16:18:07.757Z,1758644287.757 [NAL9602](INFO): GPS fix at 20250923T161807: (36.802603, -121.787095)
2025-09-23T16:18:10.995Z,1758644290.995 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161810.00,A,3648.15623,N,12147.22593,W,0.039,38.35,230925,,,D*4A
2025-09-23T16:18:10.997Z,1758644290.997 [NAL9602](INFO): GPS fix at 20250923T161810: (36.802604, -121.787099)
2025-09-23T16:18:13.819Z,1758644293.819 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161813.00,A,3648.15635,N,12147.22615,W,0.019,38.35,230925,,,D*41
2025-09-23T16:18:13.821Z,1758644293.821 [NAL9602](INFO): GPS fix at 20250923T161813: (36.802606, -121.787103)
2025-09-23T16:18:16.680Z,1758644296.680 [IBIT](IMPORTANT): Communications Status:
Fix Status: 1
Iridium Signal Strength: 2
Latitude: 36.802605 Longitude: -121.787102
2025-09-23T16:18:17.056Z,1758644297.056 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161816.00,A,3648.15639,N,12147.22623,W,0.019,38.35,230925,,,D*4D
2025-09-23T16:18:17.058Z,1758644297.058 [NAL9602](INFO): GPS fix at 20250923T161816: (36.802607, -121.787104)
2025-09-23T16:18:17.090Z,1758644297.090 [IBIT](IMPORTANT): Battery Status:
Battery Charge (AH): 0.000000
Voltage: 16.611000
2025-09-23T16:18:17.090Z,1758644297.090 [IBIT](IMPORTANT): batteryCapacityThreshold: 50.000000 Ah
2025-09-23T16:18:17.091Z,1758644297.091 [IBIT](IMPORTANT): batteryVoltageThreshold: 13.700000 V
2025-09-23T16:18:17.497Z,1758644297.497 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 %
2025-09-23T16:18:17.498Z,1758644297.498 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi
2025-09-23T16:18:17.498Z,1758644297.498 [IBIT](IMPORTANT): Pressure:10.201246 PSI
2025-09-23T16:18:17.498Z,1758644297.498 [IBIT](IMPORTANT): Humidity:22.909290 %
2025-09-23T16:18:17.874Z,1758644297.874 [IBIT](IMPORTANT): Vehicle Pitch:-0.903667 degrees
2025-09-23T16:18:17.875Z,1758644297.875 [IBIT](IMPORTANT): Vehicle Roll:-2.759177 degrees
2025-09-23T16:18:17.875Z,1758644297.875 [IBIT](IMPORTANT): Vehicle Heading:197.768845 degrees
2025-09-23T16:18:18.289Z,1758644298.289 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m
2025-09-23T16:18:18.290Z,1758644298.290 [IBIT](IMPORTANT): buoyancyNeutral: 261.037964 cc
2025-09-23T16:18:18.290Z,1758644298.290 [IBIT](IMPORTANT): massDefault: 2.120044 cm
2025-09-23T16:18:18.290Z,1758644298.290 [IBIT](IMPORTANT): stopDepth: 290.000000 m
2025-09-23T16:18:18.290Z,1758644298.290 [IBIT](IMPORTANT): abortDepth: 300.000000 m
2025-09-23T16:18:18.290Z,1758644298.290 [IBIT](IMPORTANT): IBIT PASSED
2025-09-23T16:18:25.629Z,1758644305.629 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250923T153149/Courier0025.lzma
2025-09-23T16:18:36.670Z,1758644316.670 [DataOverHttps](INFO): Moved sent file to Logs/20250923T153149/Courier0025.lzma.bak
2025-09-23T16:18:36.670Z,1758644316.670 [DataOverHttps](INFO): SBD MOMSN=26065067
2025-09-23T16:18:49.366Z,1758644329.366 [NAL9602](INFO): Not Powering down - fast GPS
2025-09-23T16:19:02.629Z,1758644342.629 [DataOverHttps](INFO): Sending 210 bytes from file Logs/20250923T153149/Express0026.lzma
2025-09-23T16:19:13.670Z,1758644353.670 [DataOverHttps](INFO): Moved sent file to Logs/20250923T153149/Express0026.lzma.bak
2025-09-23T16:19:13.670Z,1758644353.670 [DataOverHttps](INFO): SBD MOMSN=26065069
2025-09-23T16:19:14.831Z,1758644354.831 [Default:CheckIn:Read_Iridium] Stopped
2025-09-23T16:19:14.831Z,1758644354.831 [Default:CheckIn:C.Wait] Running Loop=1
2025-09-23T16:19:14.831Z,1758644354.831 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-09-23T16:24:15.485Z,1758644655.485 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-09-23T16:24:15.485Z,1758644655.485 [Default:CheckIn:C.Wait] Stopped
2025-09-23T16:24:15.485Z,1758644655.485 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-09-23T16:24:15.485Z,1758644655.485 [Default:CheckIn:D] Running Loop=1
2025-09-23T16:24:15.897Z,1758644655.897 [Default:CheckIn:D] Stopped
2025-09-23T16:24:15.897Z,1758644655.897 [Default:CheckIn:E] Running Loop=1
2025-09-23T16:24:16.319Z,1758644656.319 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 48.166650 min
2025-09-23T16:24:16.319Z,1758644656.319 [Default:CheckIn:E] Stopped
2025-09-23T16:24:16.319Z,1758644656.319 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-09-23T16:24:16.319Z,1758644656.319 [Default:CheckIn] Stopped
2025-09-23T16:24:16.320Z,1758644656.320 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-09-23T16:24:16.320Z,1758644656.320 [Default:CheckIn](INFO): Running loop #7
2025-09-23T16:24:16.320Z,1758644656.320 [Default:CheckIn] Running Loop=7
2025-09-23T16:24:16.320Z,1758644656.320 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-09-23T16:24:16.320Z,1758644656.320 [Default:CheckIn:Read_GPS] Running Loop=1
2025-09-23T16:24:18.304Z,1758644658.304 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,162417.00,A,3648.15652,N,12147.22508,W,0.039,38.35,230925,,,A*43
2025-09-23T16:24:18.306Z,1758644658.306 [NAL9602](INFO): GPS fix at 20250923T162417: (36.802609, -121.787085)
2025-09-23T16:24:18.317Z,1758644658.317 [Default:CheckIn:Read_GPS] Stopped
2025-09-23T16:24:18.317Z,1758644658.317 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-09-23T16:24:26.268Z,1758644666.268 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250923T153149/Courier0028.lzma
2025-09-23T16:24:32.048Z,1758644672.048 [NAL9602](INFO): SBD MO Status=0, MOMSN=27987, MT Status=0, MTMSN=0
2025-09-23T16:24:32.048Z,1758644672.048 [NAL9602](INFO): No messages in MT queue
2025-09-23T16:24:37.318Z,1758644677.318 [DataOverHttps](INFO): Moved sent file to Logs/20250923T153149/Courier0028.lzma.bak
2025-09-23T16:24:37.318Z,1758644677.318 [DataOverHttps](INFO): SBD MOMSN=26065084
2025-09-23T16:25:02.745Z,1758644702.745 [NAL9602](INFO): Not Powering down - fast GPS
2025-09-23T16:25:03.222Z,1758644703.222 [DataOverHttps](INFO): Sending 840 bytes from file Logs/20250923T153149/Express0029.lzma
2025-09-23T16:25:14.262Z,1758644714.262 [DataOverHttps](INFO): Moved sent file to Logs/20250923T153149/Express0029.lzma.bak
2025-09-23T16:25:14.262Z,1758644714.262 [DataOverHttps](INFO): SBD MOMSN=26065087
2025-09-23T16:25:15.285Z,1758644715.285 [Default:CheckIn:Read_Iridium] Stopped
2025-09-23T16:25:15.285Z,1758644715.285 [Default:CheckIn:C.Wait] Running Loop=1
2025-09-23T16:25:15.285Z,1758644715.285 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-09-23T16:27:07.269Z,1758644827.269 [DataOverHttps](IMPORTANT): SBD MTMSN=20250923T162706
2025-09-23T16:27:14.672Z,1758644834.672 [DataOverHttps](INFO): Received command: ibit
2025-09-23T16:27:14.713Z,1758644834.713 [CommandExec](IMPORTANT): got command ibit
2025-09-23T16:27:14.927Z,1758644834.927 [IBIT](IMPORTANT): Beginning Initiated BIT
2025-09-23T16:27:14.927Z,1758644834.927 [IBIT](IMPORTANT): Beginning control surface checks.
2025-09-23T16:27:14.931Z,1758644834.931 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-09-23T16:27:16.518Z,1758644836.518 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,162715.00,A,3648.15505,N,12147.22423,W,0.058,38.35,230925,,,A*4C
2025-09-23T16:27:16.520Z,1758644836.520 [NAL9602](INFO): GPS fix at 20250923T162715: (36.802584, -121.787070)
2025-09-23T16:27:19.453Z,1758644839.453 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.000425
CHAN A1 (24V): 0.000971
CHAN A2 (12V): 0.000283
CHAN A3 (5V): -0.001583
CHAN B0 (3.3V): 0.000131
CHAN B1 (3.15aV): -0.000195
CHAN B2 (3.15bV): 0.000077
CHAN B3 (GND): -0.000472
OPEN: 0.006083
Full Scale: +/- 1 mA
2025-09-23T16:27:32.691Z,1758644852.691 [NAL9602](INFO): SBD MO Status=0, MOMSN=27988, MT Status=0, MTMSN=0
2025-09-23T16:27:32.692Z,1758644852.692 [NAL9602](INFO): No messages in MT queue
2025-09-23T16:27:33.904Z,1758644853.904 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,162733.00,A,3648.15469,N,12147.22469,W,0.058,38.35,230925,,,A*4D
2025-09-23T16:27:33.906Z,1758644853.906 [NAL9602](INFO): GPS fix at 20250923T162733: (36.802578, -121.787078)
2025-09-23T16:27:37.159Z,1758644857.159 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,162736.00,A,3648.15474,N,12147.22477,W,0.058,38.35,230925,,,A*4B
2025-09-23T16:27:37.161Z,1758644857.161 [NAL9602](INFO): GPS fix at 20250923T162736: (36.802579, -121.787080)
2025-09-23T16:27:39.969Z,1758644859.969 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,162739.00,A,3648.15487,N,12147.22494,W,0.019,38.35,230925,,,A*40
2025-09-23T16:27:39.971Z,1758644859.971 [NAL9602](INFO): GPS fix at 20250923T162739: (36.802581, -121.787082)
2025-09-23T16:27:43.204Z,1758644863.204 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,162742.00,A,3648.15502,N,12147.22513,W,0.019,38.35,230925,,,A*4E
2025-09-23T16:27:43.206Z,1758644863.206 [NAL9602](INFO): GPS fix at 20250923T162742: (36.802584, -121.787086)
2025-09-23T16:27:46.028Z,1758644866.028 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,162745.00,A,3648.15514,N,12147.22526,W,0.019,38.35,230925,,,A*48
2025-09-23T16:27:46.030Z,1758644866.030 [NAL9602](INFO): GPS fix at 20250923T162745: (36.802586, -121.787088)
2025-09-23T16:27:48.853Z,1758644868.853 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,162748.00,A,3648.15526,N,12147.22530,W,0.000,38.35,230925,,,A*4B
2025-09-23T16:27:48.855Z,1758644868.855 [NAL9602](INFO): GPS fix at 20250923T162748: (36.802588, -121.787088)
2025-09-23T16:27:52.085Z,1758644872.085 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,162751.00,A,3648.15541,N,12147.22543,W,0.039,38.35,230925,,,A*4C
2025-09-23T16:27:52.088Z,1758644872.088 [NAL9602](INFO): GPS fix at 20250923T162751: (36.802590, -121.787091)
2025-09-23T16:27:54.913Z,1758644874.913 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,162754.00,A,3648.15551,N,12147.22561,W,0.039,38.35,230925,,,A*48
2025-09-23T16:27:54.915Z,1758644874.915 [NAL9602](INFO): GPS fix at 20250923T162754: (36.802592, -121.787093)
2025-09-23T16:27:58.149Z,1758644878.149 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,162757.00,A,3648.15556,N,12147.22574,W,0.117,38.35,230925,,,A*45
2025-09-23T16:27:58.151Z,1758644878.151 [NAL9602](INFO): GPS fix at 20250923T162757: (36.802593, -121.787096)
2025-09-23T16:28:00.975Z,1758644880.975 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,162800.00,A,3648.15563,N,12147.22577,W,0.078,38.35,230925,,,A*45
2025-09-23T16:28:00.977Z,1758644880.977 [NAL9602](INFO): GPS fix at 20250923T162800: (36.802594, -121.787096)
2025-09-23T16:28:01.415Z,1758644881.415 [IBIT](IMPORTANT): Communications Status:
Fix Status: 1
Iridium Signal Strength: 4
Latitude: 36.802593 Longitude: -121.787094
2025-09-23T16:28:01.813Z,1758644881.813 [IBIT](IMPORTANT): Battery Status:
Battery Charge (AH): 0.000000
Voltage: 16.572001
2025-09-23T16:28:01.814Z,1758644881.814 [IBIT](IMPORTANT): batteryCapacityThreshold: 50.000000 Ah
2025-09-23T16:28:01.814Z,1758644881.814 [IBIT](IMPORTANT): batteryVoltageThreshold: 13.700000 V
2025-09-23T16:28:02.202Z,1758644882.202 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 %
2025-09-23T16:28:02.202Z,1758644882.202 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi
2025-09-23T16:28:02.202Z,1758644882.202 [IBIT](IMPORTANT): Pressure:10.216294 PSI
2025-09-23T16:28:02.203Z,1758644882.203 [IBIT](IMPORTANT): Humidity:22.433159 %
2025-09-23T16:28:02.621Z,1758644882.621 [IBIT](IMPORTANT): Vehicle Pitch:-0.913060 degrees
2025-09-23T16:28:02.621Z,1758644882.621 [IBIT](IMPORTANT): Vehicle Roll:-2.762525 degrees
2025-09-23T16:28:02.622Z,1758644882.622 [IBIT](IMPORTANT): Vehicle Heading:197.780258 degrees
2025-09-23T16:28:03.029Z,1758644883.029 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m
2025-09-23T16:28:03.030Z,1758644883.030 [IBIT](IMPORTANT): buoyancyNeutral: 261.037964 cc
2025-09-23T16:28:03.030Z,1758644883.030 [IBIT](IMPORTANT): massDefault: 2.120044 cm
2025-09-23T16:28:03.030Z,1758644883.030 [IBIT](IMPORTANT): stopDepth: 290.000000 m
2025-09-23T16:28:03.031Z,1758644883.031 [IBIT](IMPORTANT): abortDepth: 300.000000 m
2025-09-23T16:28:03.031Z,1758644883.031 [IBIT](IMPORTANT): IBIT PASSED
2025-09-23T16:28:33.690Z,1758644913.690 [NAL9602](INFO): Not Powering down - fast GPS
2025-09-23T16:30:15.953Z,1758645015.953 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-09-23T16:30:15.953Z,1758645015.953 [Default:CheckIn:C.Wait] Stopped
2025-09-23T16:30:15.953Z,1758645015.953 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-09-23T16:30:15.953Z,1758645015.953 [Default:CheckIn:D] Running Loop=1
2025-09-23T16:30:16.345Z,1758645016.345 [Default:CheckIn:D] Stopped
2025-09-23T16:30:16.345Z,1758645016.345 [Default:CheckIn:E] Running Loop=1
2025-09-23T16:30:16.792Z,1758645016.792 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 54.174113 min
2025-09-23T16:30:16.792Z,1758645016.792 [Default:CheckIn:E] Stopped
2025-09-23T16:30:16.792Z,1758645016.792 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-09-23T16:30:16.793Z,1758645016.793 [Default:CheckIn] Stopped
2025-09-23T16:30:16.793Z,1758645016.793 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-09-23T16:30:16.793Z,1758645016.793 [Default:CheckIn](INFO): Running loop #8
2025-09-23T16:30:16.793Z,1758645016.793 [Default:CheckIn] Running Loop=8
2025-09-23T16:30:16.793Z,1758645016.793 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-09-23T16:30:16.793Z,1758645016.793 [Default:CheckIn:Read_GPS] Running Loop=1
2025-09-23T16:30:18.743Z,1758645018.743 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,163018.00,A,3648.15564,N,12147.22486,W,0.019,38.35,230925,,,A*4A
2025-09-23T16:30:18.745Z,1758645018.745 [NAL9602](INFO): GPS fix at 20250923T163018: (36.802594, -121.787081)
2025-09-23T16:30:18.785Z,1758645018.785 [Default:CheckIn:Read_GPS] Stopped
2025-09-23T16:30:18.785Z,1758645018.785 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-09-23T16:30:20.069Z,1758645020.069 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250923T153149/Courier0031.lzma
2025-09-23T16:30:30.846Z,1758645030.846 [DataOverHttps](INFO): Moved sent file to Logs/20250923T153149/Courier0031.lzma.bak
2025-09-23T16:30:30.846Z,1758645030.846 [DataOverHttps](INFO): SBD MOMSN=26065145
2025-09-23T16:30:39.347Z,1758645039.347 [NAL9602](INFO): SBD MO Status=0, MOMSN=27989, MT Status=0, MTMSN=0
2025-09-23T16:30:39.347Z,1758645039.347 [NAL9602](INFO): No messages in MT queue
2025-09-23T16:30:57.974Z,1758645057.974 [DataOverHttps](INFO): Sending 966 bytes from file Logs/20250923T153149/Express0032.lzma
2025-09-23T16:31:09.014Z,1758645069.014 [DataOverHttps](INFO): Moved sent file to Logs/20250923T153149/Express0032.lzma.bak
2025-09-23T16:31:09.014Z,1758645069.014 [DataOverHttps](INFO): SBD MOMSN=26065152
2025-09-23T16:31:10.053Z,1758645070.053 [NAL9602](INFO): Not Powering down - fast GPS
2025-09-23T16:31:34.953Z,1758645094.953 [DataOverHttps](INFO): Sending 63 bytes from file Logs/20250923T153149/Express0035.lzma
2025-09-23T16:31:46.002Z,1758645106.002 [DataOverHttps](INFO): Moved sent file to Logs/20250923T153149/Express0035.lzma.bak
2025-09-23T16:31:46.002Z,1758645106.002 [DataOverHttps](INFO): SBD MOMSN=26065193
2025-09-23T16:31:47.230Z,1758645107.230 [Default:CheckIn:Read_Iridium] Stopped
2025-09-23T16:31:47.230Z,1758645107.230 [Default:CheckIn:C.Wait] Running Loop=1
2025-09-23T16:31:47.231Z,1758645107.231 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-09-23T16:36:47.884Z,1758645407.884 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-09-23T16:36:47.896Z,1758645407.896 [Default:CheckIn:C.Wait] Stopped
2025-09-23T16:36:47.897Z,1758645407.897 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-09-23T16:36:47.897Z,1758645407.897 [Default:CheckIn:D] Running Loop=1
2025-09-23T16:36:48.282Z,1758645408.282 [Default:CheckIn:D] Stopped
2025-09-23T16:36:48.282Z,1758645408.282 [Default:CheckIn:E] Running Loop=1
2025-09-23T16:36:48.693Z,1758645408.693 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 60.706396 min
2025-09-23T16:36:48.693Z,1758645408.693 [Default:CheckIn:E] Stopped
2025-09-23T16:36:48.693Z,1758645408.693 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-09-23T16:36:48.693Z,1758645408.693 [Default:CheckIn] Stopped
2025-09-23T16:36:48.693Z,1758645408.693 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-09-23T16:36:48.694Z,1758645408.694 [Default:CheckIn](INFO): Running loop #9
2025-09-23T16:36:48.694Z,1758645408.694 [Default:CheckIn] Running Loop=9
2025-09-23T16:36:48.694Z,1758645408.694 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-09-23T16:36:48.694Z,1758645408.694 [Default:CheckIn:Read_GPS] Running Loop=1
2025-09-23T16:36:50.691Z,1758645410.691 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,163649.00,A,3648.15449,N,12147.22354,W,0.019,38.35,230925,,,A*4E
2025-09-23T16:36:50.703Z,1758645410.703 [NAL9602](INFO): GPS fix at 20250923T163649: (36.802575, -121.787059)
2025-09-23T16:36:50.738Z,1758645410.738 [Default:CheckIn:Read_GPS] Stopped
2025-09-23T16:36:50.739Z,1758645410.739 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-09-23T16:36:59.128Z,1758645419.128 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250923T153149/Courier0037.lzma
2025-09-23T16:37:10.170Z,1758645430.170 [DataOverHttps](INFO): Moved sent file to Logs/20250923T153149/Courier0037.lzma.bak
2025-09-23T16:37:10.170Z,1758645430.170 [DataOverHttps](INFO): SBD MOMSN=26065202
2025-09-23T16:37:12.517Z,1758645432.517 [NAL9602](INFO): SBD MO Status=2, MOMSN=27990, MT Status=2, MTMSN=0
2025-09-23T16:37:12.518Z,1758645432.518 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-09-23T16:37:29.482Z,1758645449.482 [NAL9602](INFO): SBD MO Status=0, MOMSN=27990, MT Status=0, MTMSN=0
2025-09-23T16:37:29.482Z,1758645449.482 [NAL9602](INFO): No messages in MT queue
2025-09-23T16:37:36.049Z,1758645456.049 [DataOverHttps](INFO): Sending 157 bytes from file Logs/20250923T153149/Express0038.lzma
2025-09-23T16:37:47.098Z,1758645467.098 [DataOverHttps](INFO): Moved sent file to Logs/20250923T153149/Express0038.lzma.bak
2025-09-23T16:37:47.098Z,1758645467.098 [DataOverHttps](INFO): SBD MOMSN=26065205
2025-09-23T16:37:48.477Z,1758645468.477 [Default:CheckIn:Read_Iridium] Stopped
2025-09-23T16:37:48.477Z,1758645468.477 [Default:CheckIn:C.Wait] Running Loop=1
2025-09-23T16:37:48.477Z,1758645468.477 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-09-23T16:38:00.181Z,1758645480.181 [NAL9602](INFO): Not Powering down - fast GPS
2025-09-23T16:42:49.127Z,1758645769.127 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-09-23T16:42:49.127Z,1758645769.127 [Default:CheckIn:C.Wait] Stopped
2025-09-23T16:42:49.127Z,1758645769.127 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-09-23T16:42:49.128Z,1758645769.128 [Default:CheckIn:D] Running Loop=1
2025-09-23T16:42:49.539Z,1758645769.539 [Default:CheckIn:D] Stopped
2025-09-23T16:42:49.539Z,1758645769.539 [Default:CheckIn:E] Running Loop=1
2025-09-23T16:42:49.936Z,1758645769.936 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 66.727348 min
2025-09-23T16:42:49.937Z,1758645769.937 [Default:CheckIn:E] Stopped
2025-09-23T16:42:49.937Z,1758645769.937 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-09-23T16:42:49.937Z,1758645769.937 [Default:CheckIn] Stopped
2025-09-23T16:42:49.937Z,1758645769.937 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-09-23T16:42:49.937Z,1758645769.937 [Default:CheckIn](INFO): Running loop #10
2025-09-23T16:42:49.937Z,1758645769.937 [Default:CheckIn] Running Loop=10
2025-09-23T16:42:49.937Z,1758645769.937 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-09-23T16:42:49.937Z,1758645769.937 [Default:CheckIn:Read_GPS] Running Loop=1
2025-09-23T16:42:51.935Z,1758645771.935 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164251.00,A,3648.15094,N,12147.21914,W,0.039,161.32,230925,,,D*70
2025-09-23T16:42:51.938Z,1758645771.938 [NAL9602](INFO): GPS fix at 20250923T164251: (36.802516, -121.786986)
2025-09-23T16:42:51.983Z,1758645771.983 [Default:CheckIn:Read_GPS] Stopped
2025-09-23T16:42:51.983Z,1758645771.983 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-09-23T16:42:59.936Z,1758645779.936 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250923T153149/Courier0040.lzma
2025-09-23T16:43:10.978Z,1758645790.978 [DataOverHttps](INFO): Moved sent file to Logs/20250923T153149/Courier0040.lzma.bak
2025-09-23T16:43:10.978Z,1758645790.978 [DataOverHttps](INFO): SBD MOMSN=26065230
2025-09-23T16:43:36.939Z,1758645816.939 [DataOverHttps](INFO): Sending 155 bytes from file Logs/20250923T153149/Express0041.lzma
2025-09-23T16:43:47.970Z,1758645827.970 [DataOverHttps](INFO): Moved sent file to Logs/20250923T153149/Express0041.lzma.bak
2025-09-23T16:43:47.970Z,1758645827.970 [DataOverHttps](INFO): SBD MOMSN=26065234
2025-09-23T16:43:49.326Z,1758645829.326 [Default:CheckIn:Read_Iridium] Stopped
2025-09-23T16:43:49.326Z,1758645829.326 [Default:CheckIn:C.Wait] Running Loop=1
2025-09-23T16:43:49.326Z,1758645829.326 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-09-23T16:44:07.489Z,1758645847.489 [NAL9602](INFO): SBD MO Status=2, MOMSN=27991, MT Status=2, MTMSN=0
2025-09-23T16:44:07.489Z,1758645847.489 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-09-23T16:44:36.489Z,1758645876.489 [DAT](INFO): DAT read: Rx Time:16:44:34.7351
2025-09-23T16:44:36.490Z,1758645876.490 [DAT](INFO): Rx dataTimestamp_ set to:1758645876.489648
2025-09-23T16:44:36.490Z,1758645876.490 [DAT](INFO): DAT read:
2025-09-23T16:44:36.491Z,1758645876.491 [DAT](INFO): DAT read: $Packet for address 0
2025-09-23T16:44:36.491Z,1758645876.491 [DAT](INFO): received a packet notification
2025-09-23T16:44:58.407Z,1758645898.407 [NAL9602](INFO): SBD MO Status=0, MOMSN=27991, MT Status=0, MTMSN=0
2025-09-23T16:44:58.407Z,1758645898.407 [NAL9602](INFO): No messages in MT queue
2025-09-23T16:45:29.109Z,1758645929.109 [NAL9602](INFO): Not Powering down - fast GPS
2025-09-23T16:48:28.480Z,1758646108.480 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T16:48:43.482Z,1758646123.482 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T16:48:49.914Z,1758646129.914 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-09-23T16:48:49.914Z,1758646129.914 [Default:CheckIn:C.Wait] Stopped
2025-09-23T16:48:49.914Z,1758646129.914 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-09-23T16:48:49.914Z,1758646129.914 [Default:CheckIn:D] Running Loop=1
2025-09-23T16:48:50.322Z,1758646130.322 [Default:CheckIn:D] Stopped
2025-09-23T16:48:50.322Z,1758646130.322 [Default:CheckIn:E] Running Loop=1
2025-09-23T16:48:50.731Z,1758646130.731 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 72.740397 min
2025-09-23T16:48:50.731Z,1758646130.731 [Default:CheckIn:E] Stopped
2025-09-23T16:48:50.731Z,1758646130.731 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-09-23T16:48:50.731Z,1758646130.731 [Default:CheckIn] Stopped
2025-09-23T16:48:50.731Z,1758646130.731 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-09-23T16:48:50.731Z,1758646130.731 [Default:CheckIn](INFO): Running loop #11
2025-09-23T16:48:50.731Z,1758646130.731 [Default:CheckIn] Running Loop=11
2025-09-23T16:48:50.732Z,1758646130.732 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-09-23T16:48:50.732Z,1758646130.732 [Default:CheckIn:Read_GPS] Running Loop=1
2025-09-23T16:48:52.726Z,1758646132.726 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164852.00,A,3648.17096,N,12147.20643,W,1.769,36.87,230925,,,D*4B
2025-09-23T16:48:52.737Z,1758646132.737 [NAL9602](INFO): GPS fix at 20250923T164852: (36.802849, -121.786774)
2025-09-23T16:48:52.784Z,1758646132.784 [Default:CheckIn:Read_GPS] Stopped
2025-09-23T16:48:52.784Z,1758646132.784 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-09-23T16:48:58.100Z,1758646138.100 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7).
2025-09-23T16:49:00.068Z,1758646140.068 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250923T153149/Courier0043.lzma
2025-09-23T16:49:11.110Z,1758646151.110 [DataOverHttps](INFO): Moved sent file to Logs/20250923T153149/Courier0043.lzma.bak
2025-09-23T16:49:11.111Z,1758646151.111 [DataOverHttps](INFO): SBD MOMSN=26065245
2025-09-23T16:49:16.387Z,1758646156.387 [NAL9602](INFO): SBD MO Status=0, MOMSN=27992, MT Status=0, MTMSN=0
2025-09-23T16:49:16.387Z,1758646156.387 [NAL9602](INFO): No messages in MT queue
2025-09-23T16:49:37.188Z,1758646177.188 [DataOverHttps](INFO): Sending 175 bytes from file Logs/20250923T153149/Express0044.lzma
2025-09-23T16:49:46.985Z,1758646186.985 [NAL9602](INFO): Not Powering down - fast GPS
2025-09-23T16:49:48.230Z,1758646188.230 [DataOverHttps](INFO): Moved sent file to Logs/20250923T153149/Express0044.lzma.bak
2025-09-23T16:49:48.230Z,1758646188.230 [DataOverHttps](INFO): SBD MOMSN=26065249
2025-09-23T16:49:49.428Z,1758646189.428 [Default:CheckIn:Read_Iridium] Stopped
2025-09-23T16:49:49.428Z,1758646189.428 [Default:CheckIn:C.Wait] Running Loop=1
2025-09-23T16:49:49.428Z,1758646189.428 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-09-23T16:51:26.375Z,1758646286.375 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T16:51:40.513Z,1758646300.513 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T16:51:54.653Z,1758646314.653 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T16:52:08.388Z,1758646328.388 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T16:52:21.720Z,1758646341.720 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T16:52:35.074Z,1758646355.074 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T16:52:48.404Z,1758646368.404 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T16:53:02.544Z,1758646382.544 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T16:53:16.280Z,1758646396.280 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T16:53:30.019Z,1758646410.019 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T16:54:50.036Z,1758646490.036 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-09-23T16:54:50.063Z,1758646490.063 [Default:CheckIn:C.Wait] Stopped
2025-09-23T16:54:50.064Z,1758646490.064 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-09-23T16:54:50.064Z,1758646490.064 [Default:CheckIn:D] Running Loop=1
2025-09-23T16:54:50.435Z,1758646490.435 [Default:CheckIn:D] Stopped
2025-09-23T16:54:50.435Z,1758646490.435 [Default:CheckIn:E] Running Loop=1
2025-09-23T16:54:50.943Z,1758646490.943 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 78.742261 min
2025-09-23T16:54:50.943Z,1758646490.943 [Default:CheckIn:E] Stopped
2025-09-23T16:54:50.943Z,1758646490.943 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-09-23T16:54:50.943Z,1758646490.943 [Default:CheckIn] Stopped
2025-09-23T16:54:50.944Z,1758646490.944 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-09-23T16:54:50.944Z,1758646490.944 [Default:CheckIn](INFO): Running loop #12
2025-09-23T16:54:50.944Z,1758646490.944 [Default:CheckIn] Running Loop=12
2025-09-23T16:54:50.944Z,1758646490.944 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-09-23T16:54:50.944Z,1758646490.944 [Default:CheckIn:Read_GPS] Running Loop=1
2025-09-23T16:54:52.843Z,1758646492.843 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165452.00,A,3648.47977,N,12147.28863,W,8.222,230.63,230925,,,D*7C
2025-09-23T16:54:52.854Z,1758646492.854 [NAL9602](INFO): GPS fix at 20250923T165452: (36.807996, -121.788144)
2025-09-23T16:54:52.890Z,1758646492.890 [Default:CheckIn:Read_GPS] Stopped
2025-09-23T16:54:52.890Z,1758646492.890 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-09-23T16:54:59.952Z,1758646499.952 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250923T153149/Courier0046.lzma
2025-09-23T16:55:10.994Z,1758646510.994 [DataOverHttps](INFO): Moved sent file to Logs/20250923T153149/Courier0046.lzma.bak
2025-09-23T16:55:10.994Z,1758646510.994 [DataOverHttps](INFO): SBD MOMSN=26065270
2025-09-23T16:55:23.359Z,1758646523.359 [NAL9602](INFO): SBD MO Status=2, MOMSN=27993, MT Status=2, MTMSN=0
2025-09-23T16:55:23.359Z,1758646523.359 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-09-23T16:55:37.024Z,1758646537.024 [DataOverHttps](INFO): Sending 177 bytes from file Logs/20250923T153149/Express0047.lzma
2025-09-23T16:55:48.067Z,1758646548.067 [DataOverHttps](INFO): Moved sent file to Logs/20250923T153149/Express0047.lzma.bak
2025-09-23T16:55:48.067Z,1758646548.067 [DataOverHttps](INFO): SBD MOMSN=26065273
2025-09-23T16:55:49.289Z,1758646549.289 [Default:CheckIn:Read_Iridium] Stopped
2025-09-23T16:55:49.289Z,1758646549.289 [Default:CheckIn:C.Wait] Running Loop=1
2025-09-23T16:55:49.289Z,1758646549.289 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-09-23T16:56:04.948Z,1758646564.948 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T16:56:09.397Z,1758646569.397 [NAL9602](INFO): SBD MO Status=0, MOMSN=27993, MT Status=0, MTMSN=0
2025-09-23T16:56:09.397Z,1758646569.397 [NAL9602](INFO): No messages in MT queue
2025-09-23T16:56:19.897Z,1758646579.897 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T16:56:35.248Z,1758646595.248 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T16:56:40.106Z,1758646600.106 [NAL9602](INFO): Not Powering down - fast GPS
2025-09-23T16:56:51.004Z,1758646611.004 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T16:57:06.357Z,1758646626.357 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T16:57:21.306Z,1758646641.306 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T16:57:36.252Z,1758646656.252 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T16:57:51.616Z,1758646671.616 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T16:58:06.552Z,1758646686.552 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T16:58:20.692Z,1758646700.692 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7).
2025-09-23T17:00:49.783Z,1758646849.783 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T17:00:49.864Z,1758646849.864 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-09-23T17:00:49.864Z,1758646849.864 [Default:CheckIn:C.Wait] Stopped
2025-09-23T17:00:49.865Z,1758646849.865 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-09-23T17:00:49.865Z,1758646849.865 [Default:CheckIn:D] Running Loop=1
2025-09-23T17:00:50.225Z,1758646850.225 [Default:CheckIn:D] Stopped
2025-09-23T17:00:50.225Z,1758646850.225 [Default:CheckIn:E] Running Loop=1
2025-09-23T17:00:50.620Z,1758646850.620 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 84.738778 min
2025-09-23T17:00:50.628Z,1758646850.628 [Default:CheckIn:E] Stopped
2025-09-23T17:00:50.628Z,1758646850.628 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-09-23T17:00:50.628Z,1758646850.628 [Default:CheckIn] Stopped
2025-09-23T17:00:50.628Z,1758646850.628 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-09-23T17:00:50.629Z,1758646850.629 [Default:CheckIn](INFO): Running loop #13
2025-09-23T17:00:50.629Z,1758646850.629 [Default:CheckIn] Running Loop=13
2025-09-23T17:00:50.629Z,1758646850.629 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-09-23T17:00:50.629Z,1758646850.629 [Default:CheckIn:Read_GPS] Running Loop=1
2025-09-23T17:00:52.608Z,1758646852.608 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,170051.00,A,3648.17390,N,12149.44478,W,19.361,250.04,230925,,,D*4A
2025-09-23T17:00:52.626Z,1758646852.626 [NAL9602](INFO): GPS fix at 20250923T170051: (36.802898, -121.824080)
2025-09-23T17:00:52.672Z,1758646852.672 [Default:CheckIn:Read_GPS] Stopped
2025-09-23T17:00:52.672Z,1758646852.672 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-09-23T17:01:00.096Z,1758646860.096 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250923T153149/Courier0049.lzma
2025-09-23T17:01:04.064Z,1758646864.064 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T17:01:11.138Z,1758646871.138 [DataOverHttps](INFO): Moved sent file to Logs/20250923T153149/Courier0049.lzma.bak
2025-09-23T17:01:11.138Z,1758646871.138 [DataOverHttps](INFO): SBD MOMSN=26065294
2025-09-23T17:01:13.751Z,1758646873.751 [NAL9602](INFO): SBD MO Status=2, MOMSN=27994, MT Status=2, MTMSN=0
2025-09-23T17:01:13.752Z,1758646873.752 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-09-23T17:01:17.805Z,1758646877.805 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T17:01:31.553Z,1758646891.553 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T17:01:35.587Z,1758646895.587 [NAL9602](INFO): SBD MO Status=2, MOMSN=27994, MT Status=2, MTMSN=0
2025-09-23T17:01:35.587Z,1758646895.587 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-09-23T17:01:37.259Z,1758646897.259 [DataOverHttps](INFO): Sending 175 bytes from file Logs/20250923T153149/Express0050.lzma
2025-09-23T17:01:45.276Z,1758646905.276 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T17:01:48.310Z,1758646908.310 [DataOverHttps](INFO): Moved sent file to Logs/20250923T153149/Express0050.lzma.bak
2025-09-23T17:01:48.310Z,1758646908.310 [DataOverHttps](INFO): SBD MOMSN=26065299
2025-09-23T17:01:49.342Z,1758646909.342 [Default:CheckIn:Read_Iridium] Stopped
2025-09-23T17:01:49.342Z,1758646909.342 [Default:CheckIn:C.Wait] Running Loop=1
2025-09-23T17:01:49.342Z,1758646909.342 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-09-23T17:01:52.579Z,1758646912.579 [NAL9602](INFO): SBD MO Status=2, MOMSN=27994, MT Status=2, MTMSN=0
2025-09-23T17:01:52.579Z,1758646912.579 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-09-23T17:01:59.036Z,1758646919.036 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T17:02:12.772Z,1758646932.772 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T17:02:14.007Z,1758646934.007 [NAL9602](INFO): SBD MO Status=0, MOMSN=27994, MT Status=0, MTMSN=0
2025-09-23T17:02:14.007Z,1758646934.007 [NAL9602](INFO): No messages in MT queue
2025-09-23T17:02:26.508Z,1758646946.508 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T17:02:39.841Z,1758646959.841 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T17:02:44.693Z,1758646964.693 [NAL9602](INFO): Not Powering down - fast GPS
2025-09-23T17:02:53.584Z,1758646973.584 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T17:05:27.916Z,1758647127.916 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T17:05:43.339Z,1758647143.339 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T17:05:58.216Z,1758647158.216 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T17:06:13.164Z,1758647173.164 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T17:06:28.920Z,1758647188.920 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T17:06:43.881Z,1758647203.881 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T17:06:49.951Z,1758647209.951 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-09-23T17:06:49.951Z,1758647209.951 [Default:CheckIn:C.Wait] Stopped
2025-09-23T17:06:49.951Z,1758647209.951 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-09-23T17:06:49.951Z,1758647209.951 [Default:CheckIn:D] Running Loop=1
2025-09-23T17:06:50.363Z,1758647210.363 [Default:CheckIn:D] Stopped
2025-09-23T17:06:50.363Z,1758647210.363 [Default:CheckIn:E] Running Loop=1
2025-09-23T17:06:50.762Z,1758647210.762 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 90.741081 min
2025-09-23T17:06:50.762Z,1758647210.762 [Default:CheckIn:E] Stopped
2025-09-23T17:06:50.762Z,1758647210.762 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-09-23T17:06:50.762Z,1758647210.762 [Default:CheckIn] Stopped
2025-09-23T17:06:50.762Z,1758647210.762 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-09-23T17:06:50.762Z,1758647210.762 [Default:CheckIn](INFO): Running loop #14
2025-09-23T17:06:50.762Z,1758647210.762 [Default:CheckIn] Running Loop=14
2025-09-23T17:06:50.763Z,1758647210.763 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-09-23T17:06:50.763Z,1758647210.763 [Default:CheckIn:Read_GPS] Running Loop=1
2025-09-23T17:06:52.761Z,1758647212.761 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,170652.00,A,3647.71894,N,12150.96949,W,0.816,182.38,230925,,,D*77
2025-09-23T17:06:52.763Z,1758647212.763 [NAL9602](INFO): GPS fix at 20250923T170652: (36.795316, -121.849491)
2025-09-23T17:06:52.774Z,1758647212.774 [Default:CheckIn:Read_GPS] Stopped
2025-09-23T17:06:52.774Z,1758647212.774 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-09-23T17:06:59.220Z,1758647219.220 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T17:06:59.224Z,1758647219.224 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-09-23T17:07:06.515Z,1758647226.515 [NAL9602](INFO): SBD MO Status=0, MOMSN=27995, MT Status=0, MTMSN=0
2025-09-23T17:07:06.515Z,1758647226.515 [NAL9602](INFO): No messages in MT queue
2025-09-23T17:07:08.024Z,1758647228.024 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250923T153149/Courier0052.lzma
2025-09-23T17:07:14.168Z,1758647234.168 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T17:07:14.169Z,1758647234.169 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-09-23T17:07:19.066Z,1758647239.066 [DataOverHttps](INFO): Moved sent file to Logs/20250923T153149/Courier0052.lzma.bak
2025-09-23T17:07:19.066Z,1758647239.066 [DataOverHttps](INFO): SBD MOMSN=26065310
2025-09-23T17:07:29.520Z,1758647249.520 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-09-23T17:07:37.205Z,1758647257.205 [NAL9602](INFO): Not Powering down - fast GPS
2025-09-23T17:07:40.714Z,1758647260.714 [DataOverHttps](IMPORTANT): SBD MTMSN=20250923T170739
2025-09-23T17:07:45.288Z,1758647265.288 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7).
2025-09-23T17:07:48.253Z,1758647268.253 [DataOverHttps](INFO): Sending 175 bytes from file Logs/20250923T153149/Express0053.lzma
2025-09-23T17:07:48.255Z,1758647268.255 [DataOverHttps](INFO): Received command: restart logs