2025-05-13T06:01:40.601Z,1747116100.601 [Supervisor](DEBUG): Initializing supervisor.
2025-05-13T06:01:40.606Z,1747116100.606 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2025-05-13T06:01:40.606Z,1747116100.606 [SyncHandler](INFO): Protected caller Thread ID is 834
2025-05-13T06:01:40.607Z,1747116100.607 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2025-05-13T06:01:40.608Z,1747116100.608 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2025-05-13T06:01:40.608Z,1747116100.608 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 835
2025-05-13T06:01:40.612Z,1747116100.612 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2025-05-13T06:01:40.632Z,1747116100.632 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2025-05-13T06:01:40.633Z,1747116100.633 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2025-05-13T06:01:40.633Z,1747116100.633 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 836
2025-05-13T06:01:40.638Z,1747116100.638 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2025-05-13T06:01:40.639Z,1747116100.639 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2025-05-13T06:01:40.639Z,1747116100.639 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 837
2025-05-13T06:01:40.641Z,1747116100.641 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2025-05-13T06:01:40.642Z,1747116100.642 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2025-05-13T06:01:40.643Z,1747116100.643 [logger ThreadHandler](INFO): Protected caller Thread ID is 838
2025-05-13T06:01:40.647Z,1747116100.647 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2025-05-13T06:01:40.647Z,1747116100.647 [Supervisor](INFO): Looking for Config files in directory: Config/
2025-05-13T06:01:40.651Z,1747116100.651 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2025-05-13T06:01:41.005Z,1747116101.005 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2025-05-13T06:01:41.007Z,1747116101.007 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2025-05-13T06:01:41.287Z,1747116101.287 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2025-05-13T06:01:41.288Z,1747116101.288 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2025-05-13T06:01:41.819Z,1747116101.819 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2025-05-13T06:01:41.820Z,1747116101.820 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2025-05-13T06:01:42.067Z,1747116102.067 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2025-05-13T06:01:42.069Z,1747116102.069 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2025-05-13T06:01:42.311Z,1747116102.311 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2025-05-13T06:01:42.312Z,1747116102.312 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2025-05-13T06:01:43.135Z,1747116103.135 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2025-05-13T06:01:43.137Z,1747116103.137 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2025-05-13T06:01:43.502Z,1747116103.502 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2025-05-13T06:01:43.503Z,1747116103.503 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2025-05-13T06:01:43.625Z,1747116103.625 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2025-05-13T06:01:43.625Z,1747116103.625 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2025-05-13T06:01:43.716Z,1747116103.716 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2025-05-13T06:01:43.922Z,1747116103.922 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2025-05-13T06:01:43.923Z,1747116103.923 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2025-05-13T06:01:44.337Z,1747116104.337 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2025-05-13T06:01:44.339Z,1747116104.339 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2025-05-13T06:01:44.575Z,1747116104.575 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2025-05-13T06:01:44.575Z,1747116104.575 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2025-05-13T06:01:44.725Z,1747116104.725 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2025-05-13T06:01:44.726Z,1747116104.726 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2025-05-13T06:01:44.817Z,1747116104.817 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2025-05-13T06:01:45.262Z,1747116105.262 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2025-05-13T06:01:45.263Z,1747116105.263 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2025-05-13T06:01:45.842Z,1747116105.842 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2025-05-13T06:01:45.844Z,1747116105.844 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-opah/
2025-05-13T06:01:45.846Z,1747116105.846 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Science.cfg
2025-05-13T06:01:45.962Z,1747116105.962 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Battery.cfg
2025-05-13T06:01:46.241Z,1747116106.241 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2025-05-13T06:01:46.243Z,1747116106.243 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Navigation.cfg
2025-05-13T06:01:46.357Z,1747116106.357 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/vehicle.cfg
2025-05-13T06:01:46.464Z,1747116106.464 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/BIT.cfg
2025-05-13T06:01:46.582Z,1747116106.582 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Sensor.cfg
2025-05-13T06:01:46.731Z,1747116106.731 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Control.cfg
2025-05-13T06:01:46.840Z,1747116106.840 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/logger.cfg
2025-05-13T06:01:46.960Z,1747116106.960 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/secure.cfg
2025-05-13T06:01:47.054Z,1747116107.054 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Servo.cfg
2025-05-13T06:01:47.178Z,1747116107.178 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Simulator.cfg
2025-05-13T06:01:47.274Z,1747116107.274 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2025-05-13T06:01:47.278Z,1747116107.278 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2025-05-13T06:01:47.295Z,1747116107.295 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2025-05-13T06:01:47.295Z,1747116107.295 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2025-05-13T06:01:47.438Z,1747116107.438 [DeadReckonUsingMultipleVelocitySources] Loaded
2025-05-13T06:01:47.438Z,1747116107.438 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2025-05-13T06:01:47.478Z,1747116107.478 [DeadReckonWithRespectToSeafloor] Loaded
2025-05-13T06:01:47.479Z,1747116107.479 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2025-05-13T06:01:47.492Z,1747116107.492 [NavChart] Loaded
2025-05-13T06:01:47.492Z,1747116107.492 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2025-05-13T06:01:47.498Z,1747116107.498 [UniversalFixResidualReporter] Loaded
2025-05-13T06:01:47.498Z,1747116107.498 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2025-05-13T06:01:47.499Z,1747116107.499 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2025-05-13T06:01:47.499Z,1747116107.499 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2025-05-13T06:01:48.349Z,1747116108.349 [AHRS_M2] Loaded
2025-05-13T06:01:48.349Z,1747116108.349 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2025-05-13T06:01:48.603Z,1747116108.603 [BackseatComponent](INFO): Found secondary power supply at: /dev/loadC3
2025-05-13T06:01:48.604Z,1747116108.604 [BackseatComponent] Loaded
2025-05-13T06:01:48.604Z,1747116108.604 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2025-05-13T06:01:48.605Z,1747116108.605 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4085D4E0
2025-05-13T06:01:48.605Z,1747116108.605 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 920
2025-05-13T06:01:48.608Z,1747116108.608 [LcmUniversalReporter] Loaded
2025-05-13T06:01:48.609Z,1747116108.609 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2025-05-13T06:01:49.413Z,1747116109.413 [BPC1] Loaded
2025-05-13T06:01:49.413Z,1747116109.413 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2025-05-13T06:01:49.660Z,1747116109.660 [DAT] Loaded
2025-05-13T06:01:49.661Z,1747116109.661 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2025-05-13T06:01:49.662Z,1747116109.662 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 4088D4E0
2025-05-13T06:01:49.662Z,1747116109.662 [DAT ThreadHandler](INFO): Protected caller Thread ID is 921
2025-05-13T06:01:50.035Z,1747116110.035 [DataOverHttps] Loaded
2025-05-13T06:01:50.035Z,1747116110.035 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2025-05-13T06:01:50.036Z,1747116110.036 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408BD4E0
2025-05-13T06:01:50.036Z,1747116110.036 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 922
2025-05-13T06:01:50.058Z,1747116110.058 [DepthKeller33X] Loaded
2025-05-13T06:01:50.059Z,1747116110.059 [ComponentRegistry](DEBUG): SyncComponent "DepthKeller33X" handled in the control thread.
2025-05-13T06:01:50.065Z,1747116110.065 [DropWeight] Loaded
2025-05-13T06:01:50.065Z,1747116110.065 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2025-05-13T06:01:50.248Z,1747116110.248 [NAL9602] Loaded
2025-05-13T06:01:50.248Z,1747116110.248 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2025-05-13T06:01:50.280Z,1747116110.280 [Onboard] Loaded
2025-05-13T06:01:50.281Z,1747116110.281 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2025-05-13T06:01:50.282Z,1747116110.282 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408ED4E0
2025-05-13T06:01:50.282Z,1747116110.282 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 923
2025-05-13T06:01:50.296Z,1747116110.296 [Power24vConverter] Loaded
2025-05-13T06:01:50.296Z,1747116110.296 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2025-05-13T06:01:50.313Z,1747116110.313 [Radio_Surface] Loaded
2025-05-13T06:01:50.313Z,1747116110.313 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2025-05-13T06:01:50.315Z,1747116110.315 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4091D4E0
2025-05-13T06:01:50.315Z,1747116110.315 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 924
2025-05-13T06:01:50.362Z,1747116110.362 [RDI_Pathfinder] Loaded
2025-05-13T06:01:50.362Z,1747116110.362 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2025-05-13T06:01:50.377Z,1747116110.377 [Sonardyne_Nano] Loaded
2025-05-13T06:01:50.378Z,1747116110.378 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2025-05-13T06:01:50.378Z,1747116110.378 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2025-05-13T06:01:50.379Z,1747116110.379 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2025-05-13T06:01:50.451Z,1747116110.451 [DepthRateCalculator] Loaded
2025-05-13T06:01:50.452Z,1747116110.452 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2025-05-13T06:01:50.457Z,1747116110.457 [PitchRateCalculator] Loaded
2025-05-13T06:01:50.457Z,1747116110.457 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2025-05-13T06:01:50.467Z,1747116110.467 [SpeedCalculator] Loaded
2025-05-13T06:01:50.467Z,1747116110.467 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2025-05-13T06:01:50.472Z,1747116110.472 [YawRateCalculator] Loaded
2025-05-13T06:01:50.472Z,1747116110.472 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2025-05-13T06:01:50.495Z,1747116110.495 [ElevatorOffsetCalculator] Loaded
2025-05-13T06:01:50.495Z,1747116110.495 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2025-05-13T06:01:50.495Z,1747116110.495 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2025-05-13T06:01:50.496Z,1747116110.496 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2025-05-13T06:01:50.583Z,1747116110.583 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2025-05-13T06:01:50.584Z,1747116110.584 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2025-05-13T06:01:50.754Z,1747116110.754 [BuoyancyServo] Loaded
2025-05-13T06:01:50.754Z,1747116110.754 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2025-05-13T06:01:50.778Z,1747116110.778 [ElevatorServo] Loaded
2025-05-13T06:01:50.778Z,1747116110.778 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2025-05-13T06:01:50.802Z,1747116110.802 [MassServo] Loaded
2025-05-13T06:01:50.802Z,1747116110.802 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2025-05-13T06:01:50.825Z,1747116110.825 [RudderServo] Loaded
2025-05-13T06:01:50.825Z,1747116110.825 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2025-05-13T06:01:50.843Z,1747116110.843 [ThrusterHE] Loaded
2025-05-13T06:01:50.843Z,1747116110.843 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2025-05-13T06:01:50.844Z,1747116110.844 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2025-05-13T06:01:50.844Z,1747116110.844 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2025-05-13T06:01:51.112Z,1747116111.112 [CTD_Seabird] Loaded
2025-05-13T06:01:51.112Z,1747116111.112 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2025-05-13T06:01:51.113Z,1747116111.113 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A514E0
2025-05-13T06:01:51.114Z,1747116111.114 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 926
2025-05-13T06:01:51.134Z,1747116111.134 [RBRTridente] Loaded
2025-05-13T06:01:51.135Z,1747116111.135 [ComponentRegistry](DEBUG): Component "RBRTridente" handled in its own thread.
2025-05-13T06:01:51.136Z,1747116111.136 [RBRTridente ThreadHandler](DEBUG): Created PCaller Thread at 40A814E0
2025-05-13T06:01:51.136Z,1747116111.136 [RBRTridente ThreadHandler](INFO): Protected caller Thread ID is 927
2025-05-13T06:01:51.137Z,1747116111.137 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2025-05-13T06:01:51.138Z,1747116111.138 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2025-05-13T06:01:51.304Z,1747116111.304 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2025-05-13T06:01:51.305Z,1747116111.305 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2025-05-13T06:01:51.527Z,1747116111.527 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2025-05-13T06:01:51.528Z,1747116111.528 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2025-05-13T06:01:51.946Z,1747116111.946 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2025-05-13T06:01:51.947Z,1747116111.947 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2025-05-13T06:01:52.019Z,1747116112.019 [VerticalControl](DEBUG): Construct VerticalControl.
2025-05-13T06:01:52.073Z,1747116112.073 [VerticalControl] Loaded
2025-05-13T06:01:52.073Z,1747116112.073 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2025-05-13T06:01:52.076Z,1747116112.076 [HorizontalControl](DEBUG): Construct HorizontalControl.
2025-05-13T06:01:52.124Z,1747116112.124 [HorizontalControl] Loaded
2025-05-13T06:01:52.124Z,1747116112.124 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2025-05-13T06:01:52.127Z,1747116112.127 [SpeedControl](DEBUG): Construct SpeedControl.
2025-05-13T06:01:52.128Z,1747116112.128 [SpeedControl] Loaded
2025-05-13T06:01:52.129Z,1747116112.129 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2025-05-13T06:01:52.132Z,1747116112.132 [LoopControl](DEBUG): Construct LoopControl.
2025-05-13T06:01:52.132Z,1747116112.132 [LoopControl] Loaded
2025-05-13T06:01:52.132Z,1747116112.132 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2025-05-13T06:01:52.133Z,1747116112.133 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2025-05-13T06:01:52.133Z,1747116112.133 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2025-05-13T06:01:52.336Z,1747116112.336 [SBIT](DEBUG): Construct Startup Built In Test.
2025-05-13T06:01:52.345Z,1747116112.345 [SBIT] Loaded
2025-05-13T06:01:52.345Z,1747116112.345 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2025-05-13T06:01:52.348Z,1747116112.348 [IBIT](DEBUG): Construct Initiated Built In Test.
2025-05-13T06:01:52.362Z,1747116112.362 [IBIT] Loaded
2025-05-13T06:01:52.362Z,1747116112.362 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2025-05-13T06:01:52.368Z,1747116112.368 [CBIT](DEBUG): Construct Continuous Built In Test.
2025-05-13T06:01:52.449Z,1747116112.449 [CBIT] Loaded
2025-05-13T06:01:52.450Z,1747116112.450 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2025-05-13T06:01:52.483Z,1747116112.483 [GFScanner] Loaded
2025-05-13T06:01:52.483Z,1747116112.483 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread.
2025-05-13T06:01:52.484Z,1747116112.484 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2025-05-13T06:01:52.484Z,1747116112.484 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2025-05-13T06:01:52.532Z,1747116112.532 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2025-05-13T06:01:52.539Z,1747116112.539 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2025-05-13T06:01:52.541Z,1747116112.541 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2025-05-13T06:01:52.553Z,1747116112.553 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2025-05-13T06:01:52.554Z,1747116112.554 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C684E0
2025-05-13T06:01:52.554Z,1747116112.554 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 928
2025-05-13T06:01:52.559Z,1747116112.559 [Supervisor](INFO): Main Thread ID is 825
2025-05-13T06:01:52.559Z,1747116112.559 [Supervisor](DEBUG): Running supervisor.
2025-05-13T06:01:52.559Z,1747116112.559 [CommandExec ThreadHandler](INFO): Handler Thread ID is 929
2025-05-13T06:01:52.560Z,1747116112.560 [CommandExec](INFO): Initializing the command executive.
2025-05-13T06:01:52.562Z,1747116112.562 [CommandLine ThreadHandler](INFO): Handler Thread ID is 930
2025-05-13T06:01:52.564Z,1747116112.564 [controlThread ThreadHandler](INFO): Handler Thread ID is 931
2025-05-13T06:01:52.564Z,1747116112.564 [controlThread](DEBUG): Initializing ControlThread
2025-05-13T06:01:52.566Z,1747116112.566 [NavChart](DEBUG): Initialize NavChart Navigation.
2025-05-13T06:01:52.566Z,1747116112.566 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2025-05-13T06:01:52.570Z,1747116112.570 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2025-05-13T06:01:52.570Z,1747116112.570 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2025-05-13T06:01:52.570Z,1747116112.570 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2025-05-13T06:01:52.571Z,1747116112.571 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2025-05-13T06:01:52.571Z,1747116112.571 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2025-05-13T06:01:52.573Z,1747116112.573 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2025-05-13T06:01:52.575Z,1747116112.575 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2025-05-13T06:01:52.575Z,1747116112.575 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2025-05-13T06:01:52.576Z,1747116112.576 [LoopControl](DEBUG): Initialize LoopControlComponent.
2025-05-13T06:01:52.576Z,1747116112.576 [SBIT](INFO): Initialize SBIT Component.
2025-05-13T06:01:52.577Z,1747116112.577 [SBIT](IMPORTANT): git: 2025-05-12_C
2025-05-13T06:01:52.577Z,1747116112.577 [SBIT](INFO): git hash: 744972d0e89d691354588810814e474e12b24991
2025-05-13T06:01:52.577Z,1747116112.577 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2025-05-13T06:01:52.578Z,1747116112.578 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Mon Nov 27 01:04:18 PST 2023
2025-05-13T06:01:52.579Z,1747116112.579 [SBIT](INFO): Beginning SBIT in 39.000000 seconds.
2025-05-13T06:01:52.580Z,1747116112.580 [IBIT](INFO): Initialize IBIT Component.
2025-05-13T06:01:52.581Z,1747116112.581 [CBIT](DEBUG): Initialize CBIT Component.
2025-05-13T06:01:52.581Z,1747116112.581 [logger ThreadHandler](INFO): Handler Thread ID is 932
2025-05-13T06:01:52.594Z,1747116112.594 [CBIT](DEBUG): Initialized mux pins.
2025-05-13T06:01:52.594Z,1747116112.594 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL.
2025-05-13T06:01:52.594Z,1747116112.594 [CBIT](DEBUG): Initializing the watchdog timer.
2025-05-13T06:01:52.603Z,1747116112.603 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 933
2025-05-13T06:01:52.618Z,1747116112.618 [CBIT](CRITICAL): LAST REBOOT DUE TO WATCHDOG TIMER RESET.
2025-05-13T06:01:52.619Z,1747116112.619 [CBIT](DEBUG): Initializing heartbeat.
2025-05-13T06:01:52.619Z,1747116112.619 [DAT ThreadHandler](INFO): Handler Thread ID is 934
2025-05-13T06:01:52.620Z,1747116112.620 [DAT](INFO): Powering up
2025-05-13T06:01:52.620Z,1747116112.620 [DAT](DEBUG): Initializing DAT.
2025-05-13T06:01:52.624Z,1747116112.624 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 936
2025-05-13T06:01:52.625Z,1747116112.625 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2025-05-13T06:01:52.647Z,1747116112.647 [Onboard ThreadHandler](INFO): Handler Thread ID is 937
2025-05-13T06:01:52.665Z,1747116112.665 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 938
2025-05-13T06:01:52.679Z,1747116112.679 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 939
2025-05-13T06:01:52.679Z,1747116112.679 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2025-05-13T06:01:52.683Z,1747116112.683 [RBRTridente ThreadHandler](INFO): Handler Thread ID is 941
2025-05-13T06:01:52.684Z,1747116112.684 [RBRTridente](INFO): Start
2025-05-13T06:01:52.687Z,1747116112.687 [RBRTridente](INFO): Powering up
2025-05-13T06:01:52.688Z,1747116112.688 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 943
2025-05-13T06:01:52.690Z,1747116112.690 [CBIT](DEBUG): Deactivating emergency mode.
2025-05-13T06:01:52.696Z,1747116112.696 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2025-05-13T06:01:52.696Z,1747116112.696 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2025-05-13T06:01:52.697Z,1747116112.697 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2025-05-13T06:01:52.697Z,1747116112.697 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2025-05-13T06:01:52.697Z,1747116112.697 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2025-05-13T06:01:52.697Z,1747116112.697 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2025-05-13T06:01:52.697Z,1747116112.697 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2025-05-13T06:01:52.697Z,1747116112.697 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2025-05-13T06:01:52.730Z,1747116112.730 [CBIT](DEBUG): Backplane powered.
2025-05-13T06:01:52.731Z,1747116112.731 [GFScanner](DEBUG): Initializing GFScanner
2025-05-13T06:01:52.731Z,1747116112.731 [GFScanner](DEBUG): Deactivating GF circuits.
2025-05-13T06:01:52.735Z,1747116112.735 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2025-05-13T06:01:52.736Z,1747116112.736 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2025-05-13T06:01:52.736Z,1747116112.736 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2025-05-13T06:01:52.740Z,1747116112.740 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2025-05-13T06:01:52.819Z,1747116112.819 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
2025-05-13T06:01:52.840Z,1747116112.840 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2025-05-13T06:01:52.890Z,1747116112.890 [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-05-13T06:01:52.891Z,1747116112.891 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2025-05-13T06:01:52.891Z,1747116112.891 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2025-05-13T06:01:52.907Z,1747116112.907 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2025-05-13T06:01:53.070Z,1747116113.070 [Radio_Surface](INFO): Powering up
2025-05-13T06:01:53.086Z,1747116113.086 [RBRTridente](INFO): Starting
2025-05-13T06:01:53.181Z,1747116113.181 [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-05-13T06:01:53.195Z,1747116113.195 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2025-05-13T06:01:53.196Z,1747116113.196 [Default:A.Wait](DEBUG): Construct Wait.
2025-05-13T06:01:53.222Z,1747116113.222 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2025-05-13T06:01:53.250Z,1747116113.250 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2025-05-13T06:01:53.253Z,1747116113.253 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2025-05-13T06:01:53.275Z,1747116113.275 [Default:E.Execute](DEBUG): Construct Execute.
2025-05-13T06:01:53.291Z,1747116113.291 [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-05-13T06:01:53.295Z,1747116113.295 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,DepthKeller33X,DropWeight,NAL9602,Power24vConverter,RDI_Pathfinder,Sonardyne_Nano,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter,
2025-05-13T06:01:53.317Z,1747116113.317 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2025-05-13T06:01:53.471Z,1747116113.471 [DepthKeller33X](INFO): Initializing.
2025-05-13T06:01:53.491Z,1747116113.491 [Power24vConverter](INFO): Powering up.
2025-05-13T06:01:53.492Z,1747116113.492 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2025-05-13T06:01:53.493Z,1747116113.493 [RBRTridente](INFO): Stop
2025-05-13T06:01:53.495Z,1747116113.495 [Sonardyne_Nano](INFO): Initializing.
2025-05-13T06:01:53.514Z,1747116113.514 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-05-13T06:01:53.526Z,1747116113.526 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2025-05-13T06:01:53.527Z,1747116113.527 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2025-05-13T06:01:53.528Z,1747116113.528 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-05-13T06:01:53.534Z,1747116113.534 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-05-13T06:01:53.535Z,1747116113.535 [MassServo](DEBUG): Initializing EZServoServo.
2025-05-13T06:01:53.542Z,1747116113.542 [MassServo](DEBUG): Initializing MassServo.
2025-05-13T06:01:53.543Z,1747116113.543 [RudderServo](DEBUG): Initializing EZServoServo.
2025-05-13T06:01:53.550Z,1747116113.550 [RudderServo](DEBUG): Initializing RudderServo.
2025-05-13T06:01:53.551Z,1747116113.551 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-05-13T06:01:53.558Z,1747116113.558 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-05-13T06:01:53.560Z,1747116113.560 [CommandExec](FAULT): Scheduling is paused
2025-05-13T06:01:53.561Z,1747116113.561 [CBIT](INFO): Critical error at 20250513T060152
2025-05-13T06:01:53.561Z,1747116113.561 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2025-05-13T06:01:53.563Z,1747116113.563 [RBRTridente](INFO): Powering down
2025-05-13T06:01:53.751Z,1747116113.751 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-05-13T06:01:53.894Z,1747116113.894 [RBRTridente](INFO): Stopping
2025-05-13T06:01:54.110Z,1747116114.110 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-05-13T06:01:54.514Z,1747116114.514 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-05-13T06:01:54.920Z,1747116114.920 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-05-13T06:01:55.344Z,1747116115.344 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-05-13T06:01:55.733Z,1747116115.733 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART
2025-05-13T06:01:56.979Z,1747116116.979 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:01:56.979Z,1747116116.979 [Power24vConverter] Hardware Fault, FailCount= 1
2025-05-13T06:01:56.979Z,1747116116.979 [Power24vConverter](ERROR): Hardware Fault
2025-05-13T06:01:56.979Z,1747116116.979 [Power24vConverter](INFO): Powering down.
2025-05-13T06:01:56.980Z,1747116116.980 [Power24vConverter](FAULT): 24V Power is reporting not powering/powered.
2025-05-13T06:01:56.983Z,1747116116.983 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2213
2025-05-13T06:01:57.187Z,1747116117.187 [CBIT](ERROR): Hardware Fault in component: Power24vConverter
2025-05-13T06:01:57.383Z,1747116117.383 [Power24vConverter](INFO): Powering down.
2025-05-13T06:01:57.848Z,1747116117.848 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-05-13T06:01:58.208Z,1747116118.208 [Power24vConverter](INFO): Powering down.
2025-05-13T06:01:58.624Z,1747116118.624 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-05-13T06:01:59.003Z,1747116119.003 [Power24vConverter](INFO): Powering down.
2025-05-13T06:01:59.183Z,1747116119.183 [ThrusterHE](ERROR): Zero Speed Commanded.
2025-05-13T06:01:59.408Z,1747116119.408 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-05-13T06:01:59.714Z,1747116119.714 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit.
2025-05-13T06:01:59.813Z,1747116119.813 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:00.232Z,1747116120.232 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-05-13T06:02:00.644Z,1747116120.644 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:01.023Z,1747116121.023 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-05-13T06:02:01.427Z,1747116121.427 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:01.835Z,1747116121.835 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-05-13T06:02:02.206Z,1747116122.206 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:02.612Z,1747116122.612 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-05-13T06:02:03.028Z,1747116123.028 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:03.812Z,1747116123.812 [Power24vConverter](INFO): Powering up.
2025-05-13T06:02:04.123Z,1747116124.123 [CBIT](INFO): Clearing failed state for component Power24vConverter
2025-05-13T06:02:04.123Z,1747116124.123 [Power24vConverter] No Fault, FailCount= 1
2025-05-13T06:02:05.052Z,1747116125.052 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:05.052Z,1747116125.052 [Power24vConverter] Hardware Fault, FailCount= 1
2025-05-13T06:02:05.052Z,1747116125.052 [Power24vConverter](ERROR): Hardware Fault
2025-05-13T06:02:05.052Z,1747116125.052 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:05.053Z,1747116125.053 [Power24vConverter](FAULT): 24V Power is reporting not powering/powered.
2025-05-13T06:02:05.095Z,1747116125.095 [CBIT](ERROR): Hardware Fault in component: Power24vConverter
2025-05-13T06:02:05.464Z,1747116125.464 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:05.832Z,1747116125.832 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:06.240Z,1747116126.240 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:06.656Z,1747116126.656 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:07.060Z,1747116127.060 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:07.476Z,1747116127.476 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:07.852Z,1747116127.852 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:08.259Z,1747116128.259 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:08.673Z,1747116128.673 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:09.092Z,1747116129.092 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:09.469Z,1747116129.469 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:09.873Z,1747116129.873 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:10.280Z,1747116130.280 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:10.692Z,1747116130.692 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:11.102Z,1747116131.102 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:11.491Z,1747116131.491 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:11.896Z,1747116131.896 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:12.303Z,1747116132.303 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:12.716Z,1747116132.716 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:13.124Z,1747116133.124 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:13.536Z,1747116133.536 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:13.918Z,1747116133.918 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:14.329Z,1747116134.329 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:14.731Z,1747116134.731 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:15.144Z,1747116135.144 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:15.560Z,1747116135.560 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:15.963Z,1747116135.963 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:15.965Z,1747116135.965 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2025-05-13T06:02:15.965Z,1747116135.965 [RDI_Pathfinder] Communications Fault, FailCount= 1
2025-05-13T06:02:15.965Z,1747116135.965 [RDI_Pathfinder](ERROR): Communications Fault
2025-05-13T06:02:15.979Z,1747116135.979 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2025-05-13T06:02:16.342Z,1747116136.342 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:16.414Z,1747116136.414 [RDI_Pathfinder](INFO): Powering down
2025-05-13T06:02:16.745Z,1747116136.745 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:17.153Z,1747116137.153 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:17.182Z,1747116137.182 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2025-05-13T06:02:17.182Z,1747116137.182 [RDI_Pathfinder] No Fault, FailCount= 1
2025-05-13T06:02:17.564Z,1747116137.564 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:17.565Z,1747116137.565 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2025-05-13T06:02:17.979Z,1747116137.979 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:18.361Z,1747116138.361 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:18.768Z,1747116138.768 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:19.170Z,1747116139.170 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:19.596Z,1747116139.596 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:19.000Z,1747116140.000 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:20.380Z,1747116140.380 [NAL9602](INFO): Powering up NAL9602
2025-05-13T06:02:20.381Z,1747116140.381 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:20.784Z,1747116140.784 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:21.196Z,1747116141.196 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:21.605Z,1747116141.605 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:22.020Z,1747116142.020 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:22.396Z,1747116142.396 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:22.801Z,1747116142.801 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:23.215Z,1747116143.215 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:23.625Z,1747116143.625 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:24.036Z,1747116144.036 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:24.417Z,1747116144.417 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:24.822Z,1747116144.822 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:25.228Z,1747116145.228 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:25.644Z,1747116145.644 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:26.060Z,1747116146.060 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:26.436Z,1747116146.436 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:26.843Z,1747116146.843 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:27.247Z,1747116147.247 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:27.672Z,1747116147.672 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:28.076Z,1747116148.076 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:28.492Z,1747116148.492 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:28.861Z,1747116148.861 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:29.267Z,1747116149.267 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:29.691Z,1747116149.691 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:30.100Z,1747116150.100 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:30.476Z,1747116150.476 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:30.895Z,1747116150.895 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:31.296Z,1747116151.296 [NAL9602](INFO): NAL9602 initialized
2025-05-13T06:02:31.296Z,1747116151.296 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:31.708Z,1747116151.708 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:32.134Z,1747116152.134 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:32.148Z,1747116152.148 [SBIT](IMPORTANT): Beginning Startup BIT
2025-05-13T06:02:32.153Z,1747116152.153 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-05-13T06:02:32.511Z,1747116152.511 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:32.915Z,1747116152.915 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:33.311Z,1747116153.311 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:33.379Z,1747116153.379 [GFScanner](ERROR): Error reading 24V bus power status. Assuming off for scan purposes.
2025-05-13T06:02:33.734Z,1747116153.734 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:34.516Z,1747116154.516 [Power24vConverter](INFO): Powering up.
2025-05-13T06:02:34.735Z,1747116154.735 [CBIT](INFO): Clearing failed state for component Power24vConverter
2025-05-13T06:02:34.735Z,1747116154.735 [Power24vConverter] No Fault, FailCount= 1
2025-05-13T06:02:36.646Z,1747116156.646 [GFScanner](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): -0.002051
CHAN A1 (24V) N/A reporting off
CHAN A2 (12V): -0.001853
CHAN A3 (5V): -0.022730
CHAN B0 (3.3V): 0.002015
CHAN B1 (3.15aV): -0.000920
CHAN B2 (3.15bV): 0.010222
CHAN B3 (GND): -0.000201
OPEN: 0.008066
Full Scale: +/- 1 mA
2025-05-13T06:02:38.169Z,1747116158.169 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:38.169Z,1747116158.169 [Power24vConverter] Hardware Fault, FailCount= 1
2025-05-13T06:02:38.169Z,1747116158.169 [Power24vConverter](ERROR): Hardware Fault
2025-05-13T06:02:38.169Z,1747116158.169 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:38.170Z,1747116158.170 [Power24vConverter](FAULT): 24V Power is reporting not powering/powered.
2025-05-13T06:02:38.353Z,1747116158.353 [CBIT](ERROR): Hardware Fault in component: Power24vConverter
2025-05-13T06:02:38.584Z,1747116158.584 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:38.961Z,1747116158.961 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:39.368Z,1747116159.368 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:39.784Z,1747116159.784 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:39.785Z,1747116159.785 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2025-05-13T06:02:39.785Z,1747116159.785 [RDI_Pathfinder] Communications Fault, FailCount= 2
2025-05-13T06:02:39.785Z,1747116159.785 [RDI_Pathfinder](ERROR): Communications Fault
2025-05-13T06:02:39.967Z,1747116159.967 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2025-05-13T06:02:40.196Z,1747116160.196 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:40.263Z,1747116160.263 [RDI_Pathfinder](INFO): Powering down
2025-05-13T06:02:40.591Z,1747116160.591 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:40.995Z,1747116160.995 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:41.152Z,1747116161.152 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2025-05-13T06:02:41.152Z,1747116161.152 [RDI_Pathfinder] No Fault, FailCount= 2
2025-05-13T06:02:41.389Z,1747116161.389 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-13T06:02:41.390Z,1747116161.390 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2025-05-13T06:02:41.805Z,1747116161.805 [Power24vConverter](INFO): Powering down.
2025-05-13T06:02:42.598Z,1747116162.598 [Power24vConverter](INFO): Powering up.
2025-05-13T06:02:42.751Z,1747116162.751 [CBIT](INFO): Clearing failed state for component Power24vConverter
2025-05-13T06:02:42.751Z,1747116162.751 [Power24vConverter] No Fault, FailCount= 1
2025-05-13T06:02:52.867Z,1747116172.867 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2025-05-13T06:02:52.867Z,1747116172.867 [DAT] Communications Fault, FailCount= 1
2025-05-13T06:02:52.867Z,1747116172.867 [DAT](ERROR): Communications Fault
2025-05-13T06:02:53.030Z,1747116173.030 [CBIT](ERROR): Communications Fault in component: DAT
2025-05-13T06:02:53.270Z,1747116173.270 [DAT](INFO): Powering down
2025-05-13T06:02:53.751Z,1747116173.751 [DAT](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-05-13T06:02:53.751Z,1747116173.751 [DAT] Hardware Fault, FailCount= 1
2025-05-13T06:02:53.751Z,1747116173.751 [DAT](ERROR): Hardware Fault
2025-05-13T06:02:54.527Z,1747116174.527 [CBIT](INFO): Clearing failed state for component DAT
2025-05-13T06:02:54.527Z,1747116174.527 [DAT] No Fault, FailCount= 1
2025-05-13T06:02:56.326Z,1747116176.326 [DAT](INFO): Powering up
2025-05-13T06:02:56.326Z,1747116176.326 [DAT](DEBUG): Initializing DAT.
2025-05-13T06:02:59.982Z,1747116179.982 [BPC1](ERROR): BPC1B: No match for serial number 0109 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:02:59.983Z,1747116179.983 [BPC1](ERROR): BPC1B: No match for serial number 00EA in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:02:59.984Z,1747116179.984 [BPC1](ERROR): BPC1B: No match for serial number 00A4 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:02:59.985Z,1747116179.985 [BPC1](ERROR): BPC1B: No match for serial number 0118 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:02:59.986Z,1747116179.986 [BPC1](ERROR): BPC1B: No match for serial number 0137 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:02:59.988Z,1747116179.988 [BPC1](ERROR): BPC1B: No match for serial number 0135 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:02:59.989Z,1747116179.989 [BPC1](ERROR): BPC1B: No match for serial number 009D in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:03:00.373Z,1747116180.372 [BPC1](ERROR): BPC1A: No match for serial number 00DF in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:03:00.374Z,1747116180.374 [BPC1](ERROR): BPC1A: No match for serial number 0123 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:03:00.375Z,1747116180.375 [BPC1](ERROR): BPC1A: No match for serial number 00FB in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:03:00.376Z,1747116180.376 [BPC1](ERROR): BPC1A: No match for serial number 00B3 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:03:00.377Z,1747116180.377 [BPC1](ERROR): BPC1A: No match for serial number 00C7 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:03:00.378Z,1747116180.378 [BPC1](ERROR): BPC1A: No match for serial number 013F in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:03:00.379Z,1747116180.379 [BPC1](ERROR): BPC1A: No match for serial number 0159 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:03:00.390Z,1747116180.390 [BPC1](FAULT): Failed to parse data from all battery packs.
2025-05-13T06:03:00.390Z,1747116180.390 [BPC1] Data Fault, FailCount= 1
2025-05-13T06:03:00.390Z,1747116180.390 [BPC1](ERROR): Data Fault
2025-05-13T06:03:00.635Z,1747116180.635 [CBIT](ERROR): Data Fault in component: BPC1
2025-05-13T06:03:07.672Z,1747116187.672 [DAT](INFO): DAT read:
2025-05-13T06:03:07.673Z,1747116187.673 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series
2025-05-13T06:03:09.183Z,1747116189.183 [DAT](INFO): DAT read: MF Frequency Band
2025-05-13T06:03:09.184Z,1747116189.184 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.14.0
2025-05-13T06:03:09.185Z,1747116189.185 [DAT](INFO): DAT read: May 13 2025 06:03:04
2025-05-13T06:03:10.191Z,1747116190.191 [DAT](INFO): DAT read: Features enabled [Bearing]
2025-05-13T06:03:10.193Z,1747116190.193 [DAT](INFO): DAT read: CONNECT 00600 bits/sec 1 of 4, Rate 1/2 CC 25.00ms MGP
2025-05-13T06:03:10.193Z,1747116190.193 [DAT](INFO): commRate: 600
2025-05-13T06:03:12.258Z,1747116192.258 [DAT](INFO): entering command mode
2025-05-13T06:03:12.459Z,1747116192.459 [DAT](INFO): DAT read:
2025-05-13T06:03:12.459Z,1747116192.459 [DAT](INFO): DAT read: user:1>
2025-05-13T06:03:12.460Z,1747116192.460 [DAT](INFO): setting verbose to 3
2025-05-13T06:03:12.715Z,1747116192.715 [DAT](INFO): DAT read: user:1>
2025-05-13T06:03:12.724Z,1747116192.724 [DAT](INFO): DAT read: Verbose | 3
2025-05-13T06:03:12.726Z,1747116192.726 [DAT](INFO): set verbose to 3
2025-05-13T06:03:12.729Z,1747116192.729 [DAT](INFO): setting DatVerbose to 27440
2025-05-13T06:03:12.963Z,1747116192.963 [DAT](INFO): DAT read: user:2>
2025-05-13T06:03:12.964Z,1747116192.964 [DAT](INFO): DAT read: DatVerbose | 27440
2025-05-13T06:03:12.964Z,1747116192.964 [DAT](INFO): set DatVerbose to 27440
2025-05-13T06:03:12.965Z,1747116192.965 [DAT](INFO): setting transmit power to 8
2025-05-13T06:03:13.215Z,1747116193.215 [DAT](INFO): DAT read: user:3>
2025-05-13T06:03:13.216Z,1747116193.216 [DAT](INFO): DAT read: TxPower | 8 (Max)
2025-05-13T06:03:13.216Z,1747116193.216 [DAT](INFO): set transmit power to 8
2025-05-13T06:03:13.216Z,1747116193.216 [DAT](INFO): setting local address to 3
2025-05-13T06:03:13.467Z,1747116193.467 [DAT](INFO): DAT read: user:4>
2025-05-13T06:03:13.468Z,1747116193.468 [DAT](INFO): DAT read: LocalAddr | 3
2025-05-13T06:03:13.468Z,1747116193.468 [DAT](INFO): set local address to 3
2025-05-13T06:03:13.469Z,1747116193.469 [DAT](INFO): Setting time to: 6:3:13 And date to:5/13/2025
2025-05-13T06:03:13.719Z,1747116193.719 [DAT](INFO): DAT read: user:5>
2025-05-13T06:03:13.720Z,1747116193.720 [DAT](INFO): DAT read: Tue May 13, 2025 06:03:13
2025-05-13T06:03:13.720Z,1747116193.720 [DAT](INFO): Local DAT time set to Tue May 13, 2025 06:03:13
2025-05-13T06:03:25.973Z,1747116205.973 [SBIT](IMPORTANT): SBIT PASSED
2025-05-13T06:03:25.974Z,1747116205.974 [SBIT](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2025-05-13T06:03:26.259Z,1747116206.259 [MissionManager](IMPORTANT): Started mission Startup
2025-05-13T06:03:26.260Z,1747116206.260 [Startup] Running Loop=1
2025-05-13T06:03:26.260Z,1747116206.260 [Startup](DEBUG): Aggregate::initialize Startup
2025-05-13T06:03:26.260Z,1747116206.260 [Startup:A.GoToSurface] Running Loop=1
2025-05-13T06:03:26.260Z,1747116206.260 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-05-13T06:03:26.260Z,1747116206.260 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-05-13T06:03:26.261Z,1747116206.261 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-05-13T06:03:26.261Z,1747116206.261 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-05-13T06:03:26.261Z,1747116206.261 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-05-13T06:03:26.262Z,1747116206.262 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-05-13T06:03:26.262Z,1747116206.262 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-05-13T06:03:26.264Z,1747116206.264 [Startup:StartupSatComms] Running Loop=1
2025-05-13T06:03:26.264Z,1747116206.264 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2025-05-13T06:03:26.264Z,1747116206.264 [Startup:StartupSatComms:A] Running Loop=1
2025-05-13T06:03:26.654Z,1747116206.654 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2025-05-13T06:03:32.292Z,1747116212.292 [NAL9602](INFO): SBD MO Status=2, MOMSN=10161, MT Status=2, MTMSN=0
2025-05-13T06:03:32.292Z,1747116212.292 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-05-13T06:03:55.981Z,1747116235.981 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004188
2025-05-13T06:04:26.435Z,1747116266.435 [Startup:StartupSatComms:A](INFO): Timed out from 2025-05-13T06:03:26.3Z
2025-05-13T06:04:26.435Z,1747116266.435 [Startup:StartupSatComms:A] Stopped
2025-05-13T06:04:26.435Z,1747116266.435 [Startup:StartupSatComms:B] Running Loop=1
2025-05-13T06:04:26.865Z,1747116266.865 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-05-13T06:04:29.329Z,1747116269.329 [NAL9602](INFO): SBD MO Status=2, MOMSN=10161, MT Status=2, MTMSN=0
2025-05-13T06:04:29.329Z,1747116269.329 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-05-13T06:04:33.486Z,1747116273.486 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20250513T040145/Courier0064.lzma
2025-05-13T06:04:34.488Z,1747116274.488 [DataOverHttps](INFO): Moved sent file to Logs/20250513T040145/Courier0064.lzma.bak
2025-05-13T06:04:34.488Z,1747116274.488 [DataOverHttps](INFO): SBD MOMSN=24858488
2025-05-13T06:04:42.651Z,1747116282.651 [NAL9602](INFO): SBD MO Status=2, MOMSN=10161, MT Status=2, MTMSN=0
2025-05-13T06:04:42.651Z,1747116282.651 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-05-13T06:04:51.094Z,1747116291.094 [DataOverHttps](INFO): Sending 213 bytes from file Logs/20250513T060140/Courier0000.lzma
2025-05-13T06:04:52.097Z,1747116292.097 [DataOverHttps](INFO): Moved sent file to Logs/20250513T060140/Courier0000.lzma.bak
2025-05-13T06:04:52.097Z,1747116292.097 [DataOverHttps](INFO): SBD MOMSN=24858490
2025-05-13T06:04:52.763Z,1747116292.763 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2025-05-13T06:04:52.763Z,1747116292.763 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-13T06:04:52.765Z,1747116292.765 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2025-05-13T06:04:52.765Z,1747116292.765 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-13T06:04:52.783Z,1747116292.783 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-13T06:04:52.783Z,1747116292.783 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-13T06:04:53.245Z,1747116293.245 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-13T06:04:53.245Z,1747116293.245 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2025-05-13T06:04:53.246Z,1747116293.246 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-13T06:04:53.246Z,1747116293.246 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2025-05-13T06:05:08.647Z,1747116308.647 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20250513T040145/Express0065.lzma
2025-05-13T06:05:09.648Z,1747116309.648 [DataOverHttps](INFO): Moved sent file to Logs/20250513T040145/Express0065.lzma.bak
2025-05-13T06:05:09.648Z,1747116309.648 [DataOverHttps](INFO): SBD MOMSN=24858494
2025-05-13T06:05:26.633Z,1747116326.633 [DataOverHttps](INFO): Sending 1217 bytes from file Logs/20250513T060140/Express0001.lzma
2025-05-13T06:05:26.729Z,1747116326.729 [Startup:StartupSatComms:B](INFO): Timed out from 2025-05-13T06:04:26.4Z
2025-05-13T06:05:26.729Z,1747116326.729 [Startup:StartupSatComms:B] Stopped
2025-05-13T06:05:26.729Z,1747116326.729 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2025-05-13T06:05:26.729Z,1747116326.729 [Startup:StartupSatComms] Stopped
2025-05-13T06:05:26.729Z,1747116326.729 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2025-05-13T06:05:26.730Z,1747116326.730 [Startup](INFO): Completed Startup
2025-05-13T06:05:26.731Z,1747116326.731 [MissionManager](INFO): Startup is completed.
2025-05-13T06:05:26.731Z,1747116326.731 [MissionManager](INFO): Uninitializing Mission Startup
2025-05-13T06:05:26.731Z,1747116326.731 [Startup] Stopped
2025-05-13T06:05:26.731Z,1747116326.731 [Startup](DEBUG): Aggregate::uninitialize Startup
2025-05-13T06:05:26.731Z,1747116326.731 [Startup:A.GoToSurface] Stopped
2025-05-13T06:05:26.731Z,1747116326.731 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-05-13T06:05:27.131Z,1747116327.131 [MissionManager](IMPORTANT): Started mission Default
2025-05-13T06:05:27.132Z,1747116327.132 [Default] Running Loop=1
2025-05-13T06:05:27.132Z,1747116327.132 [Default](DEBUG): Aggregate::initialize Default
2025-05-13T06:05:27.132Z,1747116327.132 [Default:B.GoToSurface] Running Loop=1
2025-05-13T06:05:27.132Z,1747116327.132 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-05-13T06:05:27.132Z,1747116327.132 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-05-13T06:05:27.133Z,1747116327.133 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-05-13T06:05:27.133Z,1747116327.133 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-05-13T06:05:27.133Z,1747116327.133 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-05-13T06:05:27.134Z,1747116327.134 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-05-13T06:05:27.134Z,1747116327.134 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-05-13T06:05:27.134Z,1747116327.134 [Default:A.Wait] Running Loop=1
2025-05-13T06:05:27.134Z,1747116327.134 [Default:A.Wait](DEBUG): Initialize Wait Component.
2025-05-13T06:05:27.632Z,1747116327.632 [DataOverHttps](INFO): Moved sent file to Logs/20250513T060140/Express0001.lzma.bak
2025-05-13T06:05:27.632Z,1747116327.632 [DataOverHttps](INFO): SBD MOMSN=24858496
2025-05-13T06:05:40.504Z,1747116340.504 [Default:A.Wait](INFO): Done Waiting.
2025-05-13T06:05:40.504Z,1747116340.504 [Default:A.Wait] Stopped
2025-05-13T06:05:40.504Z,1747116340.504 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2025-05-13T06:05:40.931Z,1747116340.931 [Default:CheckIn] Running Loop=1
2025-05-13T06:05:40.932Z,1747116340.932 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-13T06:05:40.932Z,1747116340.932 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-13T06:05:41.298Z,1747116341.298 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-05-13T06:05:53.049Z,1747116353.049 [RDI_Pathfinder](ERROR): only read 1 of 4 data items for water velocity. Device response is::WS,-32768-32768,V
2025-05-13T06:07:34.016Z,1747116454.016 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-05-13T06:07:35.213Z,1747116455.213 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,060734.00,A,3648.16694,N,12147.27900,W,0.175,0.00,130525,,,D*74
2025-05-13T06:07:35.217Z,1747116455.217 [NAL9602](INFO): GPS fix at 20250513T060734: (36.802782, -121.787983)
2025-05-13T06:07:35.260Z,1747116455.260 [Default:CheckIn:Read_GPS] Stopped
2025-05-13T06:07:35.261Z,1747116455.261 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-05-13T06:07:35.698Z,1747116455.698 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-05-13T06:07:38.966Z,1747116458.966 [DataOverHttps](INFO): Sending 223 bytes from file Logs/20250513T060140/Courier0004.lzma
2025-05-13T06:07:39.969Z,1747116459.969 [DataOverHttps](INFO): Moved sent file to Logs/20250513T060140/Courier0004.lzma.bak
2025-05-13T06:07:39.969Z,1747116459.969 [DataOverHttps](INFO): SBD MOMSN=24858569
2025-05-13T06:07:56.942Z,1747116476.942 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2025-05-13T06:07:56.942Z,1747116476.942 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-13T06:07:56.984Z,1747116476.984 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-13T06:07:57.307Z,1747116477.307 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-13T06:07:57.307Z,1747116477.307 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2025-05-13T06:07:58.444Z,1747116478.444 [DataOverHttps](INFO): Sending 412 bytes from file Logs/20250513T060140/Express0005.lzma
2025-05-13T06:07:59.444Z,1747116479.444 [DataOverHttps](INFO): Moved sent file to Logs/20250513T060140/Express0005.lzma.bak
2025-05-13T06:07:59.444Z,1747116479.444 [DataOverHttps](INFO): SBD MOMSN=24858572
2025-05-13T06:08:00.948Z,1747116480.948 [Default:CheckIn:Read_Iridium] Stopped
2025-05-13T06:08:00.948Z,1747116480.948 [Default:CheckIn:C.Wait] Running Loop=1
2025-05-13T06:08:00.948Z,1747116480.948 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-05-13T06:08:07.379Z,1747116487.379 [NAL9602](INFO): Not Powering down - fast GPS
2025-05-13T06:09:27.396Z,1747116567.396 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error. Device response is::TS35, 100.04, 94.20, 52.94
2025-05-13T06:11:08.881Z,1747116668.881 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2025-05-13T06:11:08.881Z,1747116668.881 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-13T06:11:08.965Z,1747116668.965 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-13T06:11:09.217Z,1747116669.217 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-13T06:11:09.217Z,1747116669.217 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2025-05-13T06:13:01.614Z,1747116781.614 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-05-13T06:13:01.614Z,1747116781.614 [Default:CheckIn:C.Wait] Stopped
2025-05-13T06:13:01.614Z,1747116781.614 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-05-13T06:13:01.614Z,1747116781.614 [Default:CheckIn:D] Running Loop=1
2025-05-13T06:13:01.632Z,1747116781.632 [CBIT](INFO): Clearing failed state for component BPC1
2025-05-13T06:13:01.632Z,1747116781.632 [BPC1] No Fault, FailCount= 1
2025-05-13T06:13:01.999Z,1747116781.999 [Default:CheckIn:D] Stopped
2025-05-13T06:13:01.999Z,1747116781.999 [Default:CheckIn:E] Running Loop=1
2025-05-13T06:13:02.379Z,1747116782.379 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 7.581126 min
2025-05-13T06:13:02.379Z,1747116782.379 [Default:CheckIn:E] Stopped
2025-05-13T06:13:02.379Z,1747116782.379 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-05-13T06:13:02.380Z,1747116782.380 [Default:CheckIn] Stopped
2025-05-13T06:13:02.380Z,1747116782.380 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-05-13T06:13:02.380Z,1747116782.380 [Default:CheckIn](INFO): Running loop #2
2025-05-13T06:13:02.380Z,1747116782.380 [Default:CheckIn] Running Loop=2
2025-05-13T06:13:02.380Z,1747116782.380 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-13T06:13:02.380Z,1747116782.380 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-13T06:13:04.370Z,1747116784.370 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,061303.00,A,3648.16875,N,12147.28239,W,0.097,299.68,130525,,,A*7E
2025-05-13T06:13:04.372Z,1747116784.372 [NAL9602](INFO): GPS fix at 20250513T061303: (36.802813, -121.788040)
2025-05-13T06:13:04.480Z,1747116784.480 [Default:CheckIn:Read_GPS] Stopped
2025-05-13T06:13:04.480Z,1747116784.480 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-05-13T06:13:17.298Z,1747116797.298 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250513T060140/Courier0007.lzma
2025-05-13T06:13:18.301Z,1747116798.301 [DataOverHttps](INFO): Moved sent file to Logs/20250513T060140/Courier0007.lzma.bak
2025-05-13T06:13:18.301Z,1747116798.301 [DataOverHttps](INFO): SBD MOMSN=24858582
2025-05-13T06:13:35.200Z,1747116815.200 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2025-05-13T06:13:35.278Z,1747116815.278 [NAL9602](ERROR): received:
+CSQ:0
OK161, 2, 0, 0, 0
OK
2025-05-13T06:13:41.134Z,1747116821.134 [DataOverHttps](INFO): Sending 201 bytes from file Logs/20250513T060140/Express0008.lzma
2025-05-13T06:13:42.136Z,1747116822.136 [DataOverHttps](INFO): Moved sent file to Logs/20250513T060140/Express0008.lzma.bak
2025-05-13T06:13:42.136Z,1747116822.136 [DataOverHttps](INFO): SBD MOMSN=24858585
2025-05-13T06:13:43.304Z,1747116823.304 [Default:CheckIn:Read_Iridium] Stopped
2025-05-13T06:13:43.304Z,1747116823.304 [Default:CheckIn:C.Wait] Running Loop=1
2025-05-13T06:13:43.304Z,1747116823.304 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-05-13T06:14:09.148Z,1747116849.148 [BPC1](ERROR): BPC1A: No match for serial number 0102 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:14:09.152Z,1747116849.152 [BPC1](ERROR): BPC1A: No match for serial number 0108 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:14:09.155Z,1747116849.155 [BPC1](ERROR): BPC1A: No match for serial number 0093 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:14:09.159Z,1747116849.159 [BPC1](ERROR): BPC1A: No match for serial number 00AA in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:14:09.170Z,1747116849.170 [BPC1](ERROR): BPC1A: No match for serial number 00B8 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:14:09.199Z,1747116849.199 [BPC1](ERROR): BPC1A: No match for serial number 00D8 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:14:09.200Z,1747116849.200 [BPC1](ERROR): BPC1A: No match for serial number 00DB in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:14:09.201Z,1747116849.201 [BPC1](ERROR): BPC1A: No match for serial number 015C in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:14:09.207Z,1747116849.207 [BPC1](ERROR): BPC1B: No match for serial number 012A in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:14:09.208Z,1747116849.208 [BPC1](ERROR): BPC1B: No match for serial number 0121 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:14:09.209Z,1747116849.209 [BPC1](ERROR): BPC1B: No match for serial number 009E in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:14:09.221Z,1747116849.221 [BPC1](ERROR): BPC1B: No match for serial number 014C in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:14:09.231Z,1747116849.231 [BPC1](ERROR): BPC1B: No match for serial number 0111 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:14:09.232Z,1747116849.232 [BPC1](ERROR): BPC1B: No match for serial number 0110 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:14:09.234Z,1747116849.234 [BPC1](ERROR): BPC1B: No match for serial number 0132 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:14:09.239Z,1747116849.239 [BPC1](ERROR): BPC1B: No match for serial number 0148 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:14:09.239Z,1747116849.239 [BPC1](FAULT): Failed to parse data from all battery packs.
2025-05-13T06:14:09.239Z,1747116849.239 [BPC1] Data Fault, FailCount= 2
2025-05-13T06:14:09.239Z,1747116849.239 [BPC1](ERROR): Data Fault
2025-05-13T06:14:09.349Z,1747116849.349 [CBIT](ERROR): Data Fault in component: BPC1
2025-05-13T06:14:24.618Z,1747116864.618 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2025-05-13T06:14:24.618Z,1747116864.618 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-13T06:14:24.666Z,1747116864.666 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-13T06:14:24.918Z,1747116864.918 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-13T06:14:24.919Z,1747116864.919 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2025-05-13T06:17:49.806Z,1747117069.806 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for beam range. Device response is::RA,100.39, 52.94, 102.11
2025-05-13T06:17:49.880Z,1747117069.880 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2025-05-13T06:17:49.880Z,1747117069.880 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-13T06:17:49.912Z,1747117069.912 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-13T06:17:50.254Z,1747117070.254 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-13T06:17:50.254Z,1747117070.254 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2025-05-13T06:18:07.165Z,1747117087.165 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-05-13T06:18:37.895Z,1747117117.895 [NAL9602](INFO): Not Powering down - fast GPS
2025-05-13T06:18:43.956Z,1747117123.956 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-05-13T06:18:43.956Z,1747117123.956 [Default:CheckIn:C.Wait] Stopped
2025-05-13T06:18:43.956Z,1747117123.956 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-05-13T06:18:43.957Z,1747117123.957 [Default:CheckIn:D] Running Loop=1
2025-05-13T06:18:44.419Z,1747117124.419 [Default:CheckIn:D] Stopped
2025-05-13T06:18:44.419Z,1747117124.419 [Default:CheckIn:E] Running Loop=1
2025-05-13T06:18:44.785Z,1747117124.785 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 13.288123 min
2025-05-13T06:18:44.785Z,1747117124.785 [Default:CheckIn:E] Stopped
2025-05-13T06:18:44.785Z,1747117124.785 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-05-13T06:18:44.786Z,1747117124.786 [Default:CheckIn] Stopped
2025-05-13T06:18:44.786Z,1747117124.786 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-05-13T06:18:44.786Z,1747117124.786 [Default:CheckIn](INFO): Running loop #3
2025-05-13T06:18:44.786Z,1747117124.786 [Default:CheckIn] Running Loop=3
2025-05-13T06:18:44.786Z,1747117124.786 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-13T06:18:44.786Z,1747117124.786 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-13T06:18:46.791Z,1747117126.791 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,061846.00,A,3648.16659,N,12147.27830,W,0.194,216.44,130525,,,D*76
2025-05-13T06:18:46.794Z,1747117126.794 [NAL9602](INFO): GPS fix at 20250513T061846: (36.802777, -121.787972)
2025-05-13T06:18:46.813Z,1747117126.813 [Default:CheckIn:Read_GPS] Stopped
2025-05-13T06:18:46.814Z,1747117126.814 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-05-13T06:18:59.091Z,1747117139.091 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250513T060140/Courier0010.lzma
2025-05-13T06:19:00.092Z,1747117140.092 [DataOverHttps](INFO): Moved sent file to Logs/20250513T060140/Courier0010.lzma.bak
2025-05-13T06:19:00.092Z,1747117140.092 [DataOverHttps](INFO): SBD MOMSN=24858594
2025-05-13T06:19:08.875Z,1747117148.875 [RDI_Pathfinder](ERROR): only read 3 of 4 data items for beam range. Device response is::RA, 0.00, 93.85, 100.04, 54.66,
2025-05-13T06:19:15.780Z,1747117155.780 [RDI_Pathfinder](ERROR): only read 3 of 4 data items for beam range. Device response is::RA, 0.00, 0.00, 100.04, 95.57,
2025-05-13T06:19:17.364Z,1747117157.364 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2025-05-13T06:19:17.442Z,1747117157.442 [NAL9602](ERROR): received:
+CSQ:0
OK161, 2, 0, 0, 0
OK
2025-05-13T06:19:21.243Z,1747117161.243 [DataOverHttps](INFO): Sending 264 bytes from file Logs/20250513T060140/Express0011.lzma
2025-05-13T06:19:22.244Z,1747117162.244 [DataOverHttps](INFO): Moved sent file to Logs/20250513T060140/Express0011.lzma.bak
2025-05-13T06:19:22.244Z,1747117162.244 [DataOverHttps](INFO): SBD MOMSN=24858597
2025-05-13T06:19:23.497Z,1747117163.497 [Default:CheckIn:Read_Iridium] Stopped
2025-05-13T06:19:23.497Z,1747117163.497 [Default:CheckIn:C.Wait] Running Loop=1
2025-05-13T06:19:23.497Z,1747117163.497 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-05-13T06:19:47.272Z,1747117187.272 [NAL9602](INFO): SBD MO Status=2, MOMSN=10161, MT Status=2, MTMSN=0
2025-05-13T06:19:47.273Z,1747117187.273 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-05-13T06:20:08.725Z,1747117208.725 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for bottom velocity. Device response is::BS,-32768,32768,V
2025-05-13T06:20:28.939Z,1747117228.939 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error. Device response is::TS,00020807400636,35.0, +19.0, 0.0, 0
2025-05-13T06:21:38.958Z,1747117298.958 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. Device response is::WD, +0.03, -0.2 -0.05, 20.00, 86.26
2025-05-13T06:21:38.969Z,1747117298.969 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2025-05-13T06:21:38.969Z,1747117298.969 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-13T06:21:38.981Z,1747117298.981 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-13T06:21:39.334Z,1747117299.334 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-13T06:21:39.334Z,1747117299.334 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2025-05-13T06:23:59.877Z,1747117439.877 [NAL9602](INFO): SBD MO Status=2, MOMSN=10161, MT Status=2, MTMSN=0
2025-05-13T06:23:59.878Z,1747117439.878 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-05-13T06:24:00.199Z,1747117440.199 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-05-13T06:24:10.129Z,1747117450.129 [CBIT](INFO): Clearing failed state for component BPC1
2025-05-13T06:24:10.129Z,1747117450.129 [BPC1] No Fault, FailCount= 2
2025-05-13T06:24:24.212Z,1747117464.212 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-05-13T06:24:24.212Z,1747117464.212 [Default:CheckIn:C.Wait] Stopped
2025-05-13T06:24:24.212Z,1747117464.212 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-05-13T06:24:24.212Z,1747117464.212 [Default:CheckIn:D] Running Loop=1
2025-05-13T06:24:24.583Z,1747117464.583 [Default:CheckIn:D] Stopped
2025-05-13T06:24:24.583Z,1747117464.583 [Default:CheckIn:E] Running Loop=1
2025-05-13T06:24:24.946Z,1747117464.946 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 18.957532 min
2025-05-13T06:24:24.946Z,1747117464.946 [Default:CheckIn:E] Stopped
2025-05-13T06:24:24.946Z,1747117464.946 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-05-13T06:24:24.946Z,1747117464.946 [Default:CheckIn] Stopped
2025-05-13T06:24:24.947Z,1747117464.947 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-05-13T06:24:24.947Z,1747117464.947 [Default:CheckIn](INFO): Running loop #4
2025-05-13T06:24:24.947Z,1747117464.947 [Default:CheckIn] Running Loop=4
2025-05-13T06:24:24.947Z,1747117464.947 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-13T06:24:24.947Z,1747117464.947 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-13T06:24:26.969Z,1747117466.969 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,062426.00,A,3648.16447,N,12147.27948,W,0.156,215.84,130525,,,D*7D
2025-05-13T06:24:26.974Z,1747117466.974 [NAL9602](INFO): GPS fix at 20250513T062426: (36.802741, -121.787991)
2025-05-13T06:24:27.023Z,1747117467.023 [Default:CheckIn:Read_GPS] Stopped
2025-05-13T06:24:27.023Z,1747117467.023 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-05-13T06:24:37.588Z,1747117477.588 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250513T060140/Courier0013.lzma
2025-05-13T06:24:38.588Z,1747117478.588 [DataOverHttps](INFO): Moved sent file to Logs/20250513T060140/Courier0013.lzma.bak
2025-05-13T06:24:38.588Z,1747117478.588 [DataOverHttps](INFO): SBD MOMSN=24858609
2025-05-13T06:24:59.120Z,1747117499.120 [NAL9602](INFO): Not Powering down - fast GPS
2025-05-13T06:25:10.932Z,1747117510.932 [DataOverHttps](INFO): Sending 245 bytes from file Logs/20250513T060140/Express0014.lzma
2025-05-13T06:25:11.928Z,1747117511.928 [DataOverHttps](INFO): Moved sent file to Logs/20250513T060140/Express0014.lzma.bak
2025-05-13T06:25:11.928Z,1747117511.928 [DataOverHttps](INFO): SBD MOMSN=24858615
2025-05-13T06:25:13.288Z,1747117513.288 [Default:CheckIn:Read_Iridium] Stopped
2025-05-13T06:25:13.288Z,1747117513.288 [Default:CheckIn:C.Wait] Running Loop=1
2025-05-13T06:25:13.288Z,1747117513.288 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-05-13T06:25:17.741Z,1747117517.741 [BPC1](ERROR): BPC1B: No match for serial number 012A in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:25:17.746Z,1747117517.746 [BPC1](ERROR): BPC1B: No match for serial number 0121 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:25:17.748Z,1747117517.748 [BPC1](ERROR): BPC1B: No match for serial number 009E in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:25:17.788Z,1747117517.788 [BPC1](ERROR): BPC1B: No match for serial number 014C in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:25:17.789Z,1747117517.789 [BPC1](ERROR): BPC1B: No match for serial number 0111 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:25:17.794Z,1747117517.794 [BPC1](ERROR): BPC1B: No match for serial number 0110 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:25:17.795Z,1747117517.795 [BPC1](ERROR): BPC1B: No match for serial number 0132 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:25:17.796Z,1747117517.796 [BPC1](ERROR): BPC1B: No match for serial number 0148 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:25:18.084Z,1747117518.084 [BPC1](ERROR): BPC1A: No match for serial number 0102 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:25:18.085Z,1747117518.085 [BPC1](ERROR): BPC1A: No match for serial number 0108 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:25:18.111Z,1747117518.111 [BPC1](ERROR): BPC1A: No match for serial number 0093 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:25:18.112Z,1747117518.112 [BPC1](ERROR): BPC1A: No match for serial number 00AA in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:25:18.114Z,1747117518.114 [BPC1](ERROR): BPC1A: No match for serial number 00B8 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:25:18.131Z,1747117518.131 [BPC1](ERROR): BPC1A: No match for serial number 00D8 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:25:18.132Z,1747117518.132 [BPC1](ERROR): BPC1A: No match for serial number 00DB in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:25:18.134Z,1747117518.134 [BPC1](ERROR): BPC1A: No match for serial number 015C in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:25:18.146Z,1747117518.146 [BPC1](FAULT): Failed to parse data from all battery packs.
2025-05-13T06:25:18.146Z,1747117518.146 [BPC1] Data Fault, FailCount= 3
2025-05-13T06:25:18.146Z,1747117518.146 [BPC1](ERROR): Data Fault
2025-05-13T06:25:18.375Z,1747117518.375 [CBIT](ERROR): Data Fault in component: BPC1
2025-05-13T06:25:19.018Z,1747117519.018 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error. Device response is::TS,00020807445665,35.0, +19.0,518.7, 0
2025-05-13T06:25:19.043Z,1747117519.043 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2025-05-13T06:25:19.043Z,1747117519.043 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-13T06:25:19.101Z,1747117519.101 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-13T06:25:19.404Z,1747117519.404 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-13T06:25:19.404Z,1747117519.404 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2025-05-13T06:25:54.866Z,1747117554.866 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. Device response is::WD, +0.03, -5, +10,A
2025-05-13T06:26:29.208Z,1747117589.208 [RDI_Pathfinder](ERROR): only read 3 of 4 data items for beam range. Device response is::RA, 0.00, 94.37, 99.53, 02.11
2025-05-13T06:28:58.507Z,1747117738.507 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2025-05-13T06:28:58.507Z,1747117738.507 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-13T06:28:58.543Z,1747117738.543 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-13T06:28:58.873Z,1747117738.873 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-13T06:28:58.873Z,1747117738.873 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2025-05-13T06:30:13.970Z,1747117813.970 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-05-13T06:30:13.970Z,1747117813.970 [Default:CheckIn:C.Wait] Stopped
2025-05-13T06:30:13.970Z,1747117813.970 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-05-13T06:30:13.970Z,1747117813.970 [Default:CheckIn:D] Running Loop=1
2025-05-13T06:30:14.412Z,1747117814.412 [Default:CheckIn:D] Stopped
2025-05-13T06:30:14.412Z,1747117814.412 [Default:CheckIn:E] Running Loop=1
2025-05-13T06:30:14.782Z,1747117814.782 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 24.788013 min
2025-05-13T06:30:14.782Z,1747117814.782 [Default:CheckIn:E] Stopped
2025-05-13T06:30:14.782Z,1747117814.782 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-05-13T06:30:14.782Z,1747117814.782 [Default:CheckIn] Stopped
2025-05-13T06:30:14.782Z,1747117814.782 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-05-13T06:30:14.782Z,1747117814.782 [Default:CheckIn](INFO): Running loop #5
2025-05-13T06:30:14.783Z,1747117814.783 [Default:CheckIn] Running Loop=5
2025-05-13T06:30:14.783Z,1747117814.783 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-13T06:30:14.783Z,1747117814.783 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-13T06:30:16.794Z,1747117816.794 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,063016.00,A,3648.16528,N,12147.28019,W,0.039,215.84,130525,,,D*79
2025-05-13T06:30:16.796Z,1747117816.796 [NAL9602](INFO): GPS fix at 20250513T063016: (36.802755, -121.788003)
2025-05-13T06:30:16.817Z,1747117816.817 [Default:CheckIn:Read_GPS] Stopped
2025-05-13T06:30:16.817Z,1747117816.817 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-05-13T06:30:27.179Z,1747117827.179 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250513T060140/Courier0016.lzma
2025-05-13T06:30:28.176Z,1747117828.176 [DataOverHttps](INFO): Moved sent file to Logs/20250513T060140/Courier0016.lzma.bak
2025-05-13T06:30:28.177Z,1747117828.177 [DataOverHttps](INFO): SBD MOMSN=24858624
2025-05-13T06:30:49.202Z,1747117849.202 [DataOverHttps](INFO): Sending 215 bytes from file Logs/20250513T060140/Express0017.lzma
2025-05-13T06:30:50.201Z,1747117850.201 [DataOverHttps](INFO): Moved sent file to Logs/20250513T060140/Express0017.lzma.bak
2025-05-13T06:30:50.201Z,1747117850.201 [DataOverHttps](INFO): SBD MOMSN=24858632
2025-05-13T06:30:51.530Z,1747117851.530 [Default:CheckIn:Read_Iridium] Stopped
2025-05-13T06:30:51.542Z,1747117851.542 [Default:CheckIn:C.Wait] Running Loop=1
2025-05-13T06:30:51.542Z,1747117851.542 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-05-13T06:31:59.671Z,1747117919.671 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2025-05-13T06:31:59.671Z,1747117919.671 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-13T06:31:59.683Z,1747117919.683 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-13T06:32:00.152Z,1747117920.152 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-13T06:32:00.152Z,1747117920.152 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2025-05-13T06:33:43.924Z,1747118023.924 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for beam range. Device response is::RA, 0.00, 0.00, 91.59
2025-05-13T06:34:59.947Z,1747118099.947 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error. Device response is::TS,00020807543723,35.0, +19.0, 0., 0
2025-05-13T06:35:00.751Z,1747118100.751 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2025-05-13T06:35:00.751Z,1747118100.751 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-13T06:35:00.822Z,1747118100.822 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-13T06:35:01.215Z,1747118101.215 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-13T06:35:01.216Z,1747118101.216 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2025-05-13T06:35:19.317Z,1747118119.317 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-05-13T06:35:19.441Z,1747118119.441 [CBIT](INFO): Clearing failed state for component BPC1
2025-05-13T06:35:19.441Z,1747118119.441 [BPC1] No Fault, FailCount= 3
2025-05-13T06:35:50.008Z,1747118150.008 [NAL9602](INFO): Not Powering down - fast GPS
2025-05-13T06:35:52.040Z,1747118152.040 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-05-13T06:35:52.041Z,1747118152.041 [Default:CheckIn:C.Wait] Stopped
2025-05-13T06:35:52.041Z,1747118152.041 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-05-13T06:35:52.041Z,1747118152.041 [Default:CheckIn:D] Running Loop=1
2025-05-13T06:35:52.446Z,1747118152.446 [Default:CheckIn:D] Stopped
2025-05-13T06:35:52.446Z,1747118152.446 [Default:CheckIn:E] Running Loop=1
2025-05-13T06:35:52.880Z,1747118152.880 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 30.421912 min
2025-05-13T06:35:52.880Z,1747118152.880 [Default:CheckIn:E] Stopped
2025-05-13T06:35:52.881Z,1747118152.881 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-05-13T06:35:52.881Z,1747118152.881 [Default:CheckIn] Stopped
2025-05-13T06:35:52.881Z,1747118152.881 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-05-13T06:35:52.881Z,1747118152.881 [Default:CheckIn](INFO): Running loop #6
2025-05-13T06:35:52.881Z,1747118152.881 [Default:CheckIn] Running Loop=6
2025-05-13T06:35:52.881Z,1747118152.881 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-13T06:35:52.881Z,1747118152.881 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-13T06:35:54.881Z,1747118154.881 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,063554.00,A,3648.16441,N,12147.28440,W,0.350,279.15,130525,,,D*72
2025-05-13T06:35:54.883Z,1747118154.883 [NAL9602](INFO): GPS fix at 20250513T063554: (36.802740, -121.788073)
2025-05-13T06:35:54.950Z,1747118154.950 [Default:CheckIn:Read_GPS] Stopped
2025-05-13T06:35:54.950Z,1747118154.950 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-05-13T06:36:03.790Z,1747118163.790 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250513T060140/Courier0019.lzma
2025-05-13T06:36:04.793Z,1747118164.793 [DataOverHttps](INFO): Moved sent file to Logs/20250513T060140/Courier0019.lzma.bak
2025-05-13T06:36:04.793Z,1747118164.793 [DataOverHttps](INFO): SBD MOMSN=24858652
2025-05-13T06:36:25.611Z,1747118185.611 [DataOverHttps](INFO): Sending 235 bytes from file Logs/20250513T060140/Express0020.lzma
2025-05-13T06:36:25.653Z,1747118185.653 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2025-05-13T06:36:25.729Z,1747118185.729 [NAL9602](ERROR): received:
+CSQ:0
OK161, 2, 0, 0, 0
OK
2025-05-13T06:36:26.613Z,1747118186.613 [DataOverHttps](INFO): Moved sent file to Logs/20250513T060140/Express0020.lzma.bak
2025-05-13T06:36:26.613Z,1747118186.613 [DataOverHttps](INFO): SBD MOMSN=24858655
2025-05-13T06:36:27.208Z,1747118187.208 [BPC1](ERROR): BPC1A: No match for serial number 0102 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:36:27.209Z,1747118187.209 [BPC1](ERROR): BPC1A: No match for serial number 0108 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:36:27.220Z,1747118187.220 [BPC1](ERROR): BPC1A: No match for serial number 0093 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:36:27.221Z,1747118187.221 [BPC1](ERROR): BPC1A: No match for serial number 00AA in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:36:27.222Z,1747118187.222 [BPC1](ERROR): BPC1A: No match for serial number 00B8 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:36:27.224Z,1747118187.224 [BPC1](ERROR): BPC1A: No match for serial number 00D8 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:36:27.225Z,1747118187.225 [BPC1](ERROR): BPC1A: No match for serial number 00DB in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:36:27.226Z,1747118187.226 [BPC1](ERROR): BPC1A: No match for serial number 015C in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:36:27.228Z,1747118187.228 [BPC1](ERROR): BPC1B: No match for serial number 012A in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:36:27.230Z,1747118187.230 [BPC1](ERROR): BPC1B: No match for serial number 0121 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:36:27.271Z,1747118187.271 [BPC1](ERROR): BPC1B: No match for serial number 009E in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:36:27.273Z,1747118187.273 [BPC1](ERROR): BPC1B: No match for serial number 014C in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:36:27.274Z,1747118187.274 [BPC1](ERROR): BPC1B: No match for serial number 0111 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:36:27.275Z,1747118187.275 [BPC1](ERROR): BPC1B: No match for serial number 0110 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:36:27.277Z,1747118187.277 [BPC1](ERROR): BPC1B: No match for serial number 0132 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:36:27.278Z,1747118187.278 [BPC1](ERROR): BPC1B: No match for serial number 0148 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:36:27.278Z,1747118187.278 [BPC1](FAULT): Failed to parse data from all battery packs.
2025-05-13T06:36:27.278Z,1747118187.278 [BPC1] Data Fault, FailCount= 4
2025-05-13T06:36:27.278Z,1747118187.278 [BPC1](ERROR): Data Fault
2025-05-13T06:36:27.446Z,1747118187.446 [CBIT](ERROR): Data Fault in component: BPC1
2025-05-13T06:36:28.114Z,1747118188.114 [Default:CheckIn:Read_Iridium] Stopped
2025-05-13T06:36:28.114Z,1747118188.114 [Default:CheckIn:C.Wait] Running Loop=1
2025-05-13T06:36:28.114Z,1747118188.114 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-05-13T06:38:01.929Z,1747118281.929 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2025-05-13T06:38:01.930Z,1747118281.930 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-13T06:38:02.021Z,1747118282.021 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-13T06:38:02.307Z,1747118282.307 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-13T06:38:02.307Z,1747118282.307 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2025-05-13T06:40:57.677Z,1747118457.677 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-05-13T06:41:28.370Z,1747118488.370 [NAL9602](INFO): Not Powering down - fast GPS
2025-05-13T06:41:28.816Z,1747118488.816 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-05-13T06:41:28.816Z,1747118488.816 [Default:CheckIn:C.Wait] Stopped
2025-05-13T06:41:28.817Z,1747118488.817 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-05-13T06:41:28.817Z,1747118488.817 [Default:CheckIn:D] Running Loop=1
2025-05-13T06:41:29.230Z,1747118489.230 [Default:CheckIn:D] Stopped
2025-05-13T06:41:29.230Z,1747118489.230 [Default:CheckIn:E] Running Loop=1
2025-05-13T06:41:29.660Z,1747118489.660 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 36.034953 min
2025-05-13T06:41:29.660Z,1747118489.660 [Default:CheckIn:E] Stopped
2025-05-13T06:41:29.660Z,1747118489.660 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-05-13T06:41:29.660Z,1747118489.660 [Default:CheckIn] Stopped
2025-05-13T06:41:29.660Z,1747118489.660 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-05-13T06:41:29.660Z,1747118489.660 [Default:CheckIn](INFO): Running loop #7
2025-05-13T06:41:29.660Z,1747118489.660 [Default:CheckIn] Running Loop=7
2025-05-13T06:41:29.660Z,1747118489.660 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-13T06:41:29.660Z,1747118489.660 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-13T06:41:31.619Z,1747118491.619 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,064130.00,A,3648.16993,N,12147.28283,W,0.369,11.80,130525,,,D*42
2025-05-13T06:41:31.621Z,1747118491.621 [NAL9602](INFO): GPS fix at 20250513T064130: (36.802832, -121.788047)
2025-05-13T06:41:31.707Z,1747118491.707 [Default:CheckIn:Read_GPS] Stopped
2025-05-13T06:41:31.707Z,1747118491.707 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-05-13T06:41:41.375Z,1747118501.375 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250513T060140/Courier0022.lzma
2025-05-13T06:41:42.377Z,1747118502.377 [DataOverHttps](INFO): Moved sent file to Logs/20250513T060140/Courier0022.lzma.bak
2025-05-13T06:41:42.377Z,1747118502.377 [DataOverHttps](INFO): SBD MOMSN=24858666
2025-05-13T06:41:59.261Z,1747118519.261 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2025-05-13T06:41:59.261Z,1747118519.261 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-13T06:41:59.319Z,1747118519.319 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-13T06:41:59.634Z,1747118519.634 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-13T06:41:59.634Z,1747118519.634 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2025-05-13T06:42:01.655Z,1747118521.655 [DataOverHttps](INFO): Sending 284 bytes from file Logs/20250513T060140/Express0023.lzma
2025-05-13T06:42:02.446Z,1747118522.446 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2025-05-13T06:42:02.519Z,1747118522.519 [NAL9602](ERROR): received:
+CSQ:0
OK161, 2, 0, 0, 0
OK
2025-05-13T06:42:02.657Z,1747118522.657 [DataOverHttps](INFO): Moved sent file to Logs/20250513T060140/Express0023.lzma.bak
2025-05-13T06:42:02.657Z,1747118522.657 [DataOverHttps](INFO): SBD MOMSN=24858669
2025-05-13T06:42:04.109Z,1747118524.109 [Default:CheckIn:Read_Iridium] Stopped
2025-05-13T06:42:04.109Z,1747118524.109 [Default:CheckIn:C.Wait] Running Loop=1
2025-05-13T06:42:04.109Z,1747118524.109 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-05-13T06:45:00.255Z,1747118700.255 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2025-05-13T06:45:00.256Z,1747118700.256 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-13T06:45:00.302Z,1747118700.302 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-13T06:45:00.619Z,1747118700.619 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-13T06:45:00.619Z,1747118700.619 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2025-05-13T06:46:28.324Z,1747118788.324 [CBIT](INFO): Clearing failed state for component BPC1
2025-05-13T06:46:28.324Z,1747118788.324 [BPC1] No Fault, FailCount= 4
2025-05-13T06:46:34.304Z,1747118794.304 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-05-13T06:46:40.426Z,1747118800.426 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for bottom velocity. Device response is::BS,-3268,-32768,V
2025-05-13T06:47:04.712Z,1747118824.712 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-05-13T06:47:04.712Z,1747118824.712 [Default:CheckIn:C.Wait] Stopped
2025-05-13T06:47:04.712Z,1747118824.712 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-05-13T06:47:04.712Z,1747118824.712 [Default:CheckIn:D] Running Loop=1
2025-05-13T06:47:05.072Z,1747118825.072 [NAL9602](INFO): Not Powering down - fast GPS
2025-05-13T06:47:05.111Z,1747118825.111 [Default:CheckIn:D] Stopped
2025-05-13T06:47:05.111Z,1747118825.111 [Default:CheckIn:E] Running Loop=1
2025-05-13T06:47:05.516Z,1747118825.516 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 41.632992 min
2025-05-13T06:47:05.516Z,1747118825.516 [Default:CheckIn:E] Stopped
2025-05-13T06:47:05.516Z,1747118825.516 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-05-13T06:47:05.517Z,1747118825.517 [Default:CheckIn] Stopped
2025-05-13T06:47:05.517Z,1747118825.517 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-05-13T06:47:05.517Z,1747118825.517 [Default:CheckIn](INFO): Running loop #8
2025-05-13T06:47:05.517Z,1747118825.517 [Default:CheckIn] Running Loop=8
2025-05-13T06:47:05.517Z,1747118825.517 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-13T06:47:05.517Z,1747118825.517 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-13T06:47:07.519Z,1747118827.519 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,064706.00,A,3648.17144,N,12147.28536,W,0.078,317.06,130525,,,D*73
2025-05-13T06:47:07.521Z,1747118827.521 [NAL9602](INFO): GPS fix at 20250513T064706: (36.802857, -121.788089)
2025-05-13T06:47:07.534Z,1747118827.534 [Default:CheckIn:Read_GPS] Stopped
2025-05-13T06:47:07.534Z,1747118827.534 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-05-13T06:47:18.090Z,1747118838.090 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250513T060140/Courier0025.lzma
2025-05-13T06:47:19.093Z,1747118839.093 [DataOverHttps](INFO): Moved sent file to Logs/20250513T060140/Courier0025.lzma.bak
2025-05-13T06:47:19.093Z,1747118839.093 [DataOverHttps](INFO): SBD MOMSN=24858681
2025-05-13T06:47:35.834Z,1747118855.834 [BPC1](ERROR): BPC1B: No match for serial number 012A in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:47:35.836Z,1747118855.836 [BPC1](ERROR): BPC1B: No match for serial number 0121 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:47:35.837Z,1747118855.837 [BPC1](ERROR): BPC1B: No match for serial number 009E in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:47:35.840Z,1747118855.840 [BPC1](ERROR): BPC1B: No match for serial number 014C in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:47:35.842Z,1747118855.842 [BPC1](ERROR): BPC1B: No match for serial number 0111 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:47:35.843Z,1747118855.843 [BPC1](ERROR): BPC1B: No match for serial number 0110 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:47:35.845Z,1747118855.845 [BPC1](ERROR): BPC1B: No match for serial number 0132 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:47:35.846Z,1747118855.846 [BPC1](ERROR): BPC1B: No match for serial number 0148 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:47:36.221Z,1747118856.221 [BPC1](ERROR): BPC1A: No match for serial number 0102 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:47:36.223Z,1747118856.223 [BPC1](ERROR): BPC1A: No match for serial number 0108 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:47:36.224Z,1747118856.224 [BPC1](ERROR): BPC1A: No match for serial number 0093 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:47:36.225Z,1747118856.225 [BPC1](ERROR): BPC1A: No match for serial number 00AA in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:47:36.226Z,1747118856.226 [BPC1](ERROR): BPC1A: No match for serial number 00B8 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:47:36.236Z,1747118856.236 [BPC1](ERROR): BPC1A: No match for serial number 00D8 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:47:36.237Z,1747118856.237 [BPC1](ERROR): BPC1A: No match for serial number 00DB in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:47:36.239Z,1747118856.239 [BPC1](ERROR): BPC1A: No match for serial number 015C in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:47:36.255Z,1747118856.255 [BPC1](FAULT): Failed to parse data from all battery packs.
2025-05-13T06:47:36.255Z,1747118856.255 [BPC1] Data Fault, FailCount= 5
2025-05-13T06:47:36.255Z,1747118856.255 [BPC1](ERROR): Data Fault
2025-05-13T06:47:36.416Z,1747118856.416 [CBIT](ERROR): Data Fault in component: BPC1
2025-05-13T06:47:38.242Z,1747118858.242 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2025-05-13T06:47:38.315Z,1747118858.315 [NAL9602](ERROR): received:
+CSQ:0
OK161, 2, 0, 0, 0
OK
2025-05-13T06:47:42.600Z,1747118862.600 [DataOverHttps](INFO): Sending 247 bytes from file Logs/20250513T060140/Express0026.lzma
2025-05-13T06:47:43.601Z,1747118863.601 [DataOverHttps](INFO): Moved sent file to Logs/20250513T060140/Express0026.lzma.bak
2025-05-13T06:47:43.601Z,1747118863.601 [DataOverHttps](INFO): SBD MOMSN=24858684
2025-05-13T06:47:44.752Z,1747118864.752 [Default:CheckIn:Read_Iridium] Stopped
2025-05-13T06:47:44.753Z,1747118864.753 [Default:CheckIn:C.Wait] Running Loop=1
2025-05-13T06:47:44.753Z,1747118864.753 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-05-13T06:48:50.283Z,1747118930.283 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. Device response is::WD, +0. +1.78, -0.54, 20.00,134.98
2025-05-13T06:48:50.325Z,1747118930.325 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2025-05-13T06:48:50.325Z,1747118930.325 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-13T06:48:50.363Z,1747118930.363 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-13T06:48:50.660Z,1747118930.660 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-13T06:48:50.660Z,1747118930.660 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2025-05-13T06:50:17.547Z,1747119017.547 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for water velocity. Device response is::WS,-32768,-3 -0.54, 20.00,222.27
2025-05-13T06:51:51.316Z,1747119111.316 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2025-05-13T06:51:51.316Z,1747119111.316 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-13T06:51:51.370Z,1747119111.370 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-13T06:51:51.765Z,1747119111.765 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-13T06:51:51.765Z,1747119111.765 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2025-05-13T06:52:09.068Z,1747119129.068 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-05-13T06:52:39.840Z,1747119159.840 [NAL9602](INFO): Not Powering down - fast GPS
2025-05-13T06:52:40.267Z,1747119160.267 [RDI_Pathfinder](ERROR): DVL uart error: serial timeout
2025-05-13T06:52:40.267Z,1747119160.267 [RDI_Pathfinder] Communications Fault, FailCount= 1
2025-05-13T06:52:40.267Z,1747119160.267 [RDI_Pathfinder](ERROR): Communications Fault
2025-05-13T06:52:40.290Z,1747119160.290 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2025-05-13T06:52:40.696Z,1747119160.696 [RDI_Pathfinder](INFO): Powering down
2025-05-13T06:52:41.479Z,1747119161.479 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2025-05-13T06:52:41.479Z,1747119161.479 [RDI_Pathfinder] No Fault, FailCount= 1
2025-05-13T06:52:41.865Z,1747119161.865 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2025-05-13T06:52:45.498Z,1747119165.498 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-05-13T06:52:45.498Z,1747119165.498 [Default:CheckIn:C.Wait] Stopped
2025-05-13T06:52:45.498Z,1747119165.498 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-05-13T06:52:45.498Z,1747119165.498 [Default:CheckIn:D] Running Loop=1
2025-05-13T06:52:45.881Z,1747119165.881 [Default:CheckIn:D] Stopped
2025-05-13T06:52:45.881Z,1747119165.881 [Default:CheckIn:E] Running Loop=1
2025-05-13T06:52:46.289Z,1747119166.289 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 47.312496 min
2025-05-13T06:52:46.289Z,1747119166.289 [Default:CheckIn:E] Stopped
2025-05-13T06:52:46.290Z,1747119166.290 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-05-13T06:52:46.290Z,1747119166.290 [Default:CheckIn] Stopped
2025-05-13T06:52:46.290Z,1747119166.290 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-05-13T06:52:46.290Z,1747119166.290 [Default:CheckIn](INFO): Running loop #9
2025-05-13T06:52:46.290Z,1747119166.290 [Default:CheckIn] Running Loop=9
2025-05-13T06:52:46.290Z,1747119166.290 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-13T06:52:46.290Z,1747119166.290 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-13T06:52:48.298Z,1747119168.298 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,065247.00,A,3648.16588,N,12147.28197,W,0.175,306.40,130525,,,D*76
2025-05-13T06:52:48.313Z,1747119168.313 [NAL9602](INFO): GPS fix at 20250513T065247: (36.802765, -121.788033)
2025-05-13T06:52:48.326Z,1747119168.326 [Default:CheckIn:Read_GPS] Stopped
2025-05-13T06:52:48.326Z,1747119168.326 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-05-13T06:52:57.300Z,1747119177.300 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250513T060140/Courier0028.lzma
2025-05-13T06:52:58.576Z,1747119178.576 [DataOverHttps](INFO): Moved sent file to Logs/20250513T060140/Courier0028.lzma.bak
2025-05-13T06:52:58.576Z,1747119178.576 [DataOverHttps](INFO): SBD MOMSN=24858694
2025-05-13T06:53:19.084Z,1747119199.084 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2025-05-13T06:53:19.163Z,1747119199.163 [NAL9602](ERROR): received:
+CSQ:0
OK161, 2, 0, 0, 0
OK
2025-05-13T06:53:23.012Z,1747119203.012 [DataOverHttps](INFO): Sending 340 bytes from file Logs/20250513T060140/Express0029.lzma
2025-05-13T06:53:24.018Z,1747119204.018 [DataOverHttps](INFO): Moved sent file to Logs/20250513T060140/Express0029.lzma.bak
2025-05-13T06:53:24.018Z,1747119204.018 [DataOverHttps](INFO): SBD MOMSN=24858697
2025-05-13T06:53:25.685Z,1747119205.685 [Default:CheckIn:Read_Iridium] Stopped
2025-05-13T06:53:25.685Z,1747119205.685 [Default:CheckIn:C.Wait] Running Loop=1
2025-05-13T06:53:25.685Z,1747119205.685 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-05-13T06:55:05.960Z,1747119305.960 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for bottom velocity. Device response is::BS, +22, -22,
2025-05-13T06:55:05.986Z,1747119305.986 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2025-05-13T06:55:05.986Z,1747119305.986 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-13T06:55:06.068Z,1747119306.068 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-13T06:55:06.406Z,1747119306.406 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-13T06:55:06.406Z,1747119306.406 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2025-05-13T06:55:31.626Z,1747119331.626 [NAL9602](INFO): SBD MO Status=2, MOMSN=10161, MT Status=2, MTMSN=0
2025-05-13T06:55:31.626Z,1747119331.626 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-05-13T06:57:37.252Z,1747119457.252 [CBIT](INFO): Clearing failed state for component BPC1
2025-05-13T06:57:37.263Z,1747119457.263 [BPC1] No Fault, FailCount= 5
2025-05-13T06:57:50.088Z,1747119470.088 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-05-13T06:58:07.105Z,1747119487.105 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2025-05-13T06:58:07.105Z,1747119487.105 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-13T06:58:07.125Z,1747119487.125 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-13T06:58:07.538Z,1747119487.538 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-13T06:58:07.538Z,1747119487.538 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2025-05-13T06:58:20.812Z,1747119500.812 [NAL9602](INFO): Not Powering down - fast GPS
2025-05-13T06:58:26.105Z,1747119506.105 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-05-13T06:58:26.105Z,1747119506.105 [Default:CheckIn:C.Wait] Stopped
2025-05-13T06:58:26.105Z,1747119506.105 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-05-13T06:58:26.105Z,1747119506.105 [Default:CheckIn:D] Running Loop=1
2025-05-13T06:58:26.491Z,1747119506.491 [Default:CheckIn:D] Stopped
2025-05-13T06:58:26.491Z,1747119506.491 [Default:CheckIn:E] Running Loop=1
2025-05-13T06:58:26.931Z,1747119506.931 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 52.989319 min
2025-05-13T06:58:26.931Z,1747119506.931 [Default:CheckIn:E] Stopped
2025-05-13T06:58:26.931Z,1747119506.931 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-05-13T06:58:26.931Z,1747119506.931 [Default:CheckIn] Stopped
2025-05-13T06:58:26.931Z,1747119506.931 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-05-13T06:58:26.931Z,1747119506.931 [Default:CheckIn](INFO): Running loop #10
2025-05-13T06:58:26.932Z,1747119506.932 [Default:CheckIn] Running Loop=10
2025-05-13T06:58:26.932Z,1747119506.932 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-13T06:58:26.932Z,1747119506.932 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-13T06:58:28.886Z,1747119508.886 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,065828.00,A,3648.17024,N,12147.28290,W,0.058,306.40,130525,,,D*7D
2025-05-13T06:58:28.937Z,1747119508.937 [NAL9602](INFO): GPS fix at 20250513T065828: (36.802837, -121.788048)
2025-05-13T06:58:28.982Z,1747119508.982 [Default:CheckIn:Read_GPS] Stopped
2025-05-13T06:58:28.983Z,1747119508.983 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-05-13T06:58:36.511Z,1747119516.511 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250513T060140/Courier0031.lzma
2025-05-13T06:58:37.513Z,1747119517.513 [DataOverHttps](INFO): Moved sent file to Logs/20250513T060140/Courier0031.lzma.bak
2025-05-13T06:58:37.513Z,1747119517.513 [DataOverHttps](INFO): SBD MOMSN=24858710
2025-05-13T06:58:44.661Z,1747119524.661 [BPC1](ERROR): BPC1B: No match for serial number 012A in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:58:44.662Z,1747119524.662 [BPC1](ERROR): BPC1B: No match for serial number 0121 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:58:44.684Z,1747119524.684 [BPC1](ERROR): BPC1B: No match for serial number 009E in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:58:44.686Z,1747119524.686 [BPC1](ERROR): BPC1B: No match for serial number 014C in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:58:44.691Z,1747119524.691 [BPC1](ERROR): BPC1B: No match for serial number 0111 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:58:44.692Z,1747119524.692 [BPC1](ERROR): BPC1B: No match for serial number 0110 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:58:44.693Z,1747119524.693 [BPC1](ERROR): BPC1B: No match for serial number 0132 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:58:44.699Z,1747119524.699 [BPC1](ERROR): BPC1B: No match for serial number 0148 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-05-13T06:58:45.074Z,1747119525.074 [BPC1](ERROR): BPC1A: No match for serial number 0102 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:58:45.079Z,1747119525.079 [BPC1](ERROR): BPC1A: No match for serial number 0108 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:58:45.080Z,1747119525.080 [BPC1](ERROR): BPC1A: No match for serial number 0093 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:58:45.082Z,1747119525.082 [BPC1](ERROR): BPC1A: No match for serial number 00AA in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:58:45.087Z,1747119525.087 [BPC1](ERROR): BPC1A: No match for serial number 00B8 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:58:45.088Z,1747119525.088 [BPC1](ERROR): BPC1A: No match for serial number 00D8 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:58:45.089Z,1747119525.089 [BPC1](ERROR): BPC1A: No match for serial number 00DB in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:58:45.090Z,1747119525.090 [BPC1](ERROR): BPC1A: No match for serial number 015C in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-13T06:58:45.127Z,1747119525.127 [BPC1](FAULT): Failed to parse data from all battery packs.
2025-05-13T06:58:45.127Z,1747119525.127 [BPC1] Data Fault, FailCount= 6
2025-05-13T06:58:45.127Z,1747119525.127 [BPC1](ERROR): Data Fault
2025-05-13T06:58:45.309Z,1747119525.309 [CBIT](ERROR): Data Fault in component: BPC1
2025-05-13T06:58:56.115Z,1747119536.115 [DataOverHttps](INFO): Sending 235 bytes from file Logs/20250513T060140/Express0032.lzma
2025-05-13T06:58:57.118Z,1747119537.118 [DataOverHttps](INFO): Moved sent file to Logs/20250513T060140/Express0032.lzma.bak
2025-05-13T06:58:57.119Z,1747119537.119 [DataOverHttps](INFO): SBD MOMSN=24858713
2025-05-13T06:58:58.434Z,1747119538.434 [Default:CheckIn:Read_Iridium] Stopped
2025-05-13T06:58:58.434Z,1747119538.434 [Default:CheckIn:C.Wait] Running Loop=1
2025-05-13T06:58:58.434Z,1747119538.434 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-05-13T06:58:59.616Z,1747119539.616 [NAL9602](ERROR): Failed to receive prope