2025-05-27T21:52:11.442Z,1748382731.442 [Supervisor](DEBUG): Initializing supervisor.
2025-05-27T21:52:11.446Z,1748382731.446 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2025-05-27T21:52:11.447Z,1748382731.447 [SyncHandler](INFO): Protected caller Thread ID is 837
2025-05-27T21:52:11.447Z,1748382731.447 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2025-05-27T21:52:11.448Z,1748382731.448 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2025-05-27T21:52:11.449Z,1748382731.449 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 838
2025-05-27T21:52:11.453Z,1748382731.453 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2025-05-27T21:52:11.473Z,1748382731.473 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2025-05-27T21:52:11.474Z,1748382731.474 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2025-05-27T21:52:11.474Z,1748382731.474 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 839
2025-05-27T21:52:11.478Z,1748382731.478 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2025-05-27T21:52:11.479Z,1748382731.479 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2025-05-27T21:52:11.480Z,1748382731.480 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 840
2025-05-27T21:52:11.482Z,1748382731.482 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2025-05-27T21:52:11.483Z,1748382731.483 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2025-05-27T21:52:11.483Z,1748382731.483 [logger ThreadHandler](INFO): Protected caller Thread ID is 841
2025-05-27T21:52:11.487Z,1748382731.487 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2025-05-27T21:52:11.488Z,1748382731.488 [Supervisor](INFO): Looking for Config files in directory: Config/
2025-05-27T21:52:11.492Z,1748382731.492 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2025-05-27T21:52:11.900Z,1748382731.900 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2025-05-27T21:52:11.902Z,1748382731.902 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2025-05-27T21:52:12.182Z,1748382732.182 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2025-05-27T21:52:12.182Z,1748382732.182 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2025-05-27T21:52:12.702Z,1748382732.702 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2025-05-27T21:52:12.703Z,1748382732.703 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2025-05-27T21:52:12.948Z,1748382732.948 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2025-05-27T21:52:12.950Z,1748382732.950 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2025-05-27T21:52:13.191Z,1748382733.191 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2025-05-27T21:52:13.193Z,1748382733.193 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2025-05-27T21:52:14.016Z,1748382734.016 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2025-05-27T21:52:14.018Z,1748382734.018 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2025-05-27T21:52:14.385Z,1748382734.385 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2025-05-27T21:52:14.387Z,1748382734.387 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2025-05-27T21:52:14.981Z,1748382734.981 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2025-05-27T21:52:14.982Z,1748382734.982 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2025-05-27T21:52:15.072Z,1748382735.072 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2025-05-27T21:52:15.276Z,1748382735.276 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2025-05-27T21:52:15.276Z,1748382735.276 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2025-05-27T21:52:15.384Z,1748382735.384 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2025-05-27T21:52:15.385Z,1748382735.385 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2025-05-27T21:52:15.619Z,1748382735.619 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2025-05-27T21:52:15.620Z,1748382735.620 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2025-05-27T21:52:15.774Z,1748382735.774 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2025-05-27T21:52:15.775Z,1748382735.775 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2025-05-27T21:52:15.877Z,1748382735.877 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Guidance
2025-05-27T21:52:15.878Z,1748382735.878 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2025-05-27T21:52:16.321Z,1748382736.321 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2025-05-27T21:52:16.322Z,1748382736.322 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2025-05-27T21:52:16.903Z,1748382736.903 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2025-05-27T21:52:16.905Z,1748382736.905 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-opah/
2025-05-27T21:52:16.908Z,1748382736.908 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Science.cfg
2025-05-27T21:52:17.022Z,1748382737.022 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Battery.cfg
2025-05-27T21:52:17.301Z,1748382737.301 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2025-05-27T21:52:17.303Z,1748382737.303 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Navigation.cfg
2025-05-27T21:52:17.419Z,1748382737.419 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/vehicle.cfg
2025-05-27T21:52:17.529Z,1748382737.529 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/BIT.cfg
2025-05-27T21:52:17.652Z,1748382737.652 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Sensor.cfg
2025-05-27T21:52:17.803Z,1748382737.803 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Control.cfg
2025-05-27T21:52:17.914Z,1748382737.914 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/logger.cfg
2025-05-27T21:52:18.037Z,1748382738.037 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/secure.cfg
2025-05-27T21:52:18.133Z,1748382738.133 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Servo.cfg
2025-05-27T21:52:18.260Z,1748382738.260 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Simulator.cfg
2025-05-27T21:52:18.358Z,1748382738.358 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2025-05-27T21:52:18.361Z,1748382738.361 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2025-05-27T21:52:18.378Z,1748382738.378 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2025-05-27T21:52:18.379Z,1748382738.379 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2025-05-27T21:52:18.524Z,1748382738.524 [DeadReckonUsingMultipleVelocitySources] Loaded
2025-05-27T21:52:18.525Z,1748382738.525 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2025-05-27T21:52:18.566Z,1748382738.566 [DeadReckonWithRespectToSeafloor] Loaded
2025-05-27T21:52:18.566Z,1748382738.566 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2025-05-27T21:52:18.580Z,1748382738.580 [NavChart] Loaded
2025-05-27T21:52:18.580Z,1748382738.580 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2025-05-27T21:52:18.586Z,1748382738.586 [UniversalFixResidualReporter] Loaded
2025-05-27T21:52:18.586Z,1748382738.586 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2025-05-27T21:52:18.587Z,1748382738.587 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2025-05-27T21:52:18.588Z,1748382738.588 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2025-05-27T21:52:19.745Z,1748382739.745 [AHRS_M2] Loaded
2025-05-27T21:52:19.745Z,1748382739.745 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2025-05-27T21:52:20.259Z,1748382740.259 [BackseatComponent](INFO): Found secondary power supply at: /dev/loadC3
2025-05-27T21:52:20.260Z,1748382740.260 [BackseatComponent] Loaded
2025-05-27T21:52:20.260Z,1748382740.260 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2025-05-27T21:52:20.279Z,1748382740.279 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4085D4E0
2025-05-27T21:52:20.284Z,1748382740.284 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 924
2025-05-27T21:52:20.286Z,1748382740.286 [LcmUniversalReporter] Loaded
2025-05-27T21:52:20.287Z,1748382740.287 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2025-05-27T21:52:21.157Z,1748382741.157 [BPC1] Loaded
2025-05-27T21:52:21.157Z,1748382741.157 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2025-05-27T21:52:21.255Z,1748382741.255 [DAT] Loaded
2025-05-27T21:52:21.255Z,1748382741.255 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2025-05-27T21:52:21.256Z,1748382741.256 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 4088D4E0
2025-05-27T21:52:21.257Z,1748382741.257 [DAT ThreadHandler](INFO): Protected caller Thread ID is 925
2025-05-27T21:52:21.586Z,1748382741.586 [DataOverHttps] Loaded
2025-05-27T21:52:21.586Z,1748382741.586 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2025-05-27T21:52:21.587Z,1748382741.587 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408BD4E0
2025-05-27T21:52:21.588Z,1748382741.588 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 926
2025-05-27T21:52:21.610Z,1748382741.610 [DepthKeller33X] Loaded
2025-05-27T21:52:21.610Z,1748382741.610 [ComponentRegistry](DEBUG): SyncComponent "DepthKeller33X" handled in the control thread.
2025-05-27T21:52:21.615Z,1748382741.615 [DropWeight] Loaded
2025-05-27T21:52:21.616Z,1748382741.616 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2025-05-27T21:52:21.681Z,1748382741.681 [NAL9602] Loaded
2025-05-27T21:52:21.681Z,1748382741.681 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2025-05-27T21:52:21.711Z,1748382741.711 [Onboard] Loaded
2025-05-27T21:52:21.712Z,1748382741.712 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2025-05-27T21:52:21.712Z,1748382741.712 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408ED4E0
2025-05-27T21:52:21.713Z,1748382741.713 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 927
2025-05-27T21:52:21.727Z,1748382741.727 [Power24vConverter] Loaded
2025-05-27T21:52:21.728Z,1748382741.728 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2025-05-27T21:52:21.745Z,1748382741.745 [Radio_Surface] Loaded
2025-05-27T21:52:21.745Z,1748382741.745 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2025-05-27T21:52:21.746Z,1748382741.746 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4091D4E0
2025-05-27T21:52:21.747Z,1748382741.747 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 928
2025-05-27T21:52:21.795Z,1748382741.795 [RDI_Pathfinder] Loaded
2025-05-27T21:52:21.795Z,1748382741.795 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2025-05-27T21:52:21.811Z,1748382741.811 [Sonardyne_Nano] Loaded
2025-05-27T21:52:21.811Z,1748382741.811 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2025-05-27T21:52:21.812Z,1748382741.812 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2025-05-27T21:52:21.812Z,1748382741.812 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2025-05-27T21:52:21.886Z,1748382741.886 [DepthRateCalculator] Loaded
2025-05-27T21:52:21.886Z,1748382741.886 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2025-05-27T21:52:21.892Z,1748382741.892 [PitchRateCalculator] Loaded
2025-05-27T21:52:21.892Z,1748382741.892 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2025-05-27T21:52:21.901Z,1748382741.901 [SpeedCalculator] Loaded
2025-05-27T21:52:21.902Z,1748382741.902 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2025-05-27T21:52:21.906Z,1748382741.906 [YawRateCalculator] Loaded
2025-05-27T21:52:21.907Z,1748382741.907 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2025-05-27T21:52:21.930Z,1748382741.930 [ElevatorOffsetCalculator] Loaded
2025-05-27T21:52:21.930Z,1748382741.930 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2025-05-27T21:52:21.930Z,1748382741.930 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2025-05-27T21:52:21.931Z,1748382741.931 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2025-05-27T21:52:22.020Z,1748382742.020 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2025-05-27T21:52:22.022Z,1748382742.022 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2025-05-27T21:52:22.196Z,1748382742.196 [BuoyancyServo] Loaded
2025-05-27T21:52:22.196Z,1748382742.196 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2025-05-27T21:52:22.221Z,1748382742.221 [ElevatorServo] Loaded
2025-05-27T21:52:22.221Z,1748382742.221 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2025-05-27T21:52:22.245Z,1748382742.245 [MassServo] Loaded
2025-05-27T21:52:22.245Z,1748382742.245 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2025-05-27T21:52:22.268Z,1748382742.268 [RudderServo] Loaded
2025-05-27T21:52:22.268Z,1748382742.268 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2025-05-27T21:52:22.287Z,1748382742.287 [ThrusterHE] Loaded
2025-05-27T21:52:22.287Z,1748382742.287 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2025-05-27T21:52:22.288Z,1748382742.288 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2025-05-27T21:52:22.288Z,1748382742.288 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2025-05-27T21:52:22.518Z,1748382742.518 [CTD_Seabird] Loaded
2025-05-27T21:52:22.518Z,1748382742.518 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2025-05-27T21:52:22.519Z,1748382742.519 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A514E0
2025-05-27T21:52:22.520Z,1748382742.520 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 929
2025-05-27T21:52:22.541Z,1748382742.541 [RBRTridente] Loaded
2025-05-27T21:52:22.541Z,1748382742.541 [ComponentRegistry](DEBUG): Component "RBRTridente" handled in its own thread.
2025-05-27T21:52:22.542Z,1748382742.542 [RBRTridente ThreadHandler](DEBUG): Created PCaller Thread at 40A814E0
2025-05-27T21:52:22.543Z,1748382742.543 [RBRTridente ThreadHandler](INFO): Protected caller Thread ID is 930
2025-05-27T21:52:22.544Z,1748382742.544 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2025-05-27T21:52:22.544Z,1748382742.544 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2025-05-27T21:52:22.716Z,1748382742.716 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2025-05-27T21:52:22.718Z,1748382742.718 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2025-05-27T21:52:22.949Z,1748382742.949 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2025-05-27T21:52:22.949Z,1748382742.949 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2025-05-27T21:52:23.381Z,1748382743.381 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2025-05-27T21:52:23.381Z,1748382743.381 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2025-05-27T21:52:23.454Z,1748382743.454 [VerticalControl](DEBUG): Construct VerticalControl.
2025-05-27T21:52:23.510Z,1748382743.510 [VerticalControl] Loaded
2025-05-27T21:52:23.510Z,1748382743.510 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2025-05-27T21:52:23.513Z,1748382743.513 [HorizontalControl](DEBUG): Construct HorizontalControl.
2025-05-27T21:52:23.561Z,1748382743.561 [HorizontalControl] Loaded
2025-05-27T21:52:23.562Z,1748382743.562 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2025-05-27T21:52:23.564Z,1748382743.564 [SpeedControl](DEBUG): Construct SpeedControl.
2025-05-27T21:52:23.566Z,1748382743.566 [SpeedControl] Loaded
2025-05-27T21:52:23.566Z,1748382743.566 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2025-05-27T21:52:23.569Z,1748382743.569 [LoopControl](DEBUG): Construct LoopControl.
2025-05-27T21:52:23.570Z,1748382743.570 [LoopControl] Loaded
2025-05-27T21:52:23.570Z,1748382743.570 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2025-05-27T21:52:23.570Z,1748382743.570 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2025-05-27T21:52:23.571Z,1748382743.571 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2025-05-27T21:52:23.777Z,1748382743.777 [SBIT](DEBUG): Construct Startup Built In Test.
2025-05-27T21:52:23.786Z,1748382743.786 [SBIT] Loaded
2025-05-27T21:52:23.786Z,1748382743.786 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2025-05-27T21:52:23.789Z,1748382743.789 [IBIT](DEBUG): Construct Initiated Built In Test.
2025-05-27T21:52:23.804Z,1748382743.804 [IBIT] Loaded
2025-05-27T21:52:23.804Z,1748382743.804 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2025-05-27T21:52:23.809Z,1748382743.809 [CBIT](DEBUG): Construct Continuous Built In Test.
2025-05-27T21:52:23.893Z,1748382743.893 [CBIT] Loaded
2025-05-27T21:52:23.893Z,1748382743.893 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2025-05-27T21:52:23.927Z,1748382743.927 [GFScanner] Loaded
2025-05-27T21:52:23.927Z,1748382743.927 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread.
2025-05-27T21:52:23.927Z,1748382743.927 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2025-05-27T21:52:23.929Z,1748382743.929 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2025-05-27T21:52:23.978Z,1748382743.978 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2025-05-27T21:52:23.984Z,1748382743.984 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2025-05-27T21:52:23.987Z,1748382743.987 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2025-05-27T21:52:23.999Z,1748382743.999 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2025-05-27T21:52:23.000Z,1748382744.000 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C684E0
2025-05-27T21:52:24.000Z,1748382744.000 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 931
2025-05-27T21:52:24.004Z,1748382744.004 [Supervisor](INFO): Main Thread ID is 828
2025-05-27T21:52:24.005Z,1748382744.005 [Supervisor](DEBUG): Running supervisor.
2025-05-27T21:52:24.005Z,1748382744.005 [CommandExec ThreadHandler](INFO): Handler Thread ID is 932
2025-05-27T21:52:24.006Z,1748382744.006 [CommandExec](INFO): Initializing the command executive.
2025-05-27T21:52:24.007Z,1748382744.007 [CommandLine ThreadHandler](INFO): Handler Thread ID is 933
2025-05-27T21:52:24.009Z,1748382744.009 [controlThread ThreadHandler](INFO): Handler Thread ID is 934
2025-05-27T21:52:24.010Z,1748382744.010 [controlThread](DEBUG): Initializing ControlThread
2025-05-27T21:52:24.012Z,1748382744.012 [NavChart](DEBUG): Initialize NavChart Navigation.
2025-05-27T21:52:24.012Z,1748382744.012 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2025-05-27T21:52:24.015Z,1748382744.015 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2025-05-27T21:52:24.016Z,1748382744.016 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2025-05-27T21:52:24.016Z,1748382744.016 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2025-05-27T21:52:24.016Z,1748382744.016 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2025-05-27T21:52:24.017Z,1748382744.017 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2025-05-27T21:52:24.019Z,1748382744.019 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2025-05-27T21:52:24.020Z,1748382744.020 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2025-05-27T21:52:24.021Z,1748382744.021 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2025-05-27T21:52:24.021Z,1748382744.021 [LoopControl](DEBUG): Initialize LoopControlComponent.
2025-05-27T21:52:24.022Z,1748382744.022 [SBIT](INFO): Initialize SBIT Component.
2025-05-27T21:52:24.022Z,1748382744.022 [SBIT](IMPORTANT): git: 2025-05-16-18-g9c601af6d
2025-05-27T21:52:24.022Z,1748382744.022 [SBIT](INFO): git hash: 9c601af6dd40e15398b518924185b67aae63bffa
2025-05-27T21:52:24.023Z,1748382744.023 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2025-05-27T21:52:24.024Z,1748382744.024 [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-27T21:52:24.025Z,1748382744.025 [SBIT](INFO): Beginning SBIT in 39.000000 seconds.
2025-05-27T21:52:24.025Z,1748382744.025 [IBIT](INFO): Initialize IBIT Component.
2025-05-27T21:52:24.026Z,1748382744.026 [CBIT](DEBUG): Initialize CBIT Component.
2025-05-27T21:52:24.027Z,1748382744.027 [logger ThreadHandler](INFO): Handler Thread ID is 935
2025-05-27T21:52:24.039Z,1748382744.039 [CBIT](DEBUG): Initialized mux pins.
2025-05-27T21:52:24.040Z,1748382744.040 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL.
2025-05-27T21:52:24.040Z,1748382744.040 [CBIT](DEBUG): Initializing the watchdog timer.
2025-05-27T21:52:24.052Z,1748382744.052 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 936
2025-05-27T21:52:24.063Z,1748382744.063 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2025-05-27T21:52:24.066Z,1748382744.066 [CBIT](FAULT): Found backtrace file:
1748382271.573706 [CBIT]: Backtrace:
./bin/LRAUV(_ZN7PCaller20DefaultSignalHandlerEiP7siginfoPv+0x20) [0x1b3f60]
./bin/LRAUV(_ZN9Component15executeRunStateEv+0x5c) [0xef194]
./bin/LRAUV(_ZN7PCaller10PThreadRunEPv+0xc8) [0x1b39ac]
2025-05-27T21:52:24.068Z,1748382744.068 [CBIT](FAULT): Renaming backtrace file to Data/backtrace3
2025-05-27T21:52:24.068Z,1748382744.068 [CBIT](DEBUG): Initializing heartbeat.
2025-05-27T21:52:24.065Z,1748382744.065 [DAT ThreadHandler](INFO): Handler Thread ID is 937
2025-05-27T21:52:24.069Z,1748382744.069 [DAT](INFO): Powering up
2025-05-27T21:52:24.069Z,1748382744.069 [DAT](DEBUG): Initializing DAT.
2025-05-27T21:52:24.073Z,1748382744.073 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 939
2025-05-27T21:52:24.075Z,1748382744.075 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2025-05-27T21:52:24.096Z,1748382744.096 [Onboard ThreadHandler](INFO): Handler Thread ID is 940
2025-05-27T21:52:24.121Z,1748382744.121 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 941
2025-05-27T21:52:24.129Z,1748382744.129 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 942
2025-05-27T21:52:24.129Z,1748382744.129 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2025-05-27T21:52:24.133Z,1748382744.133 [RBRTridente ThreadHandler](INFO): Handler Thread ID is 944
2025-05-27T21:52:24.133Z,1748382744.133 [RBRTridente](INFO): Start
2025-05-27T21:52:24.136Z,1748382744.136 [RBRTridente](INFO): Powering up
2025-05-27T21:52:24.137Z,1748382744.137 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 946
2025-05-27T21:52:24.140Z,1748382744.140 [CBIT](DEBUG): Deactivating emergency mode.
2025-05-27T21:52:24.146Z,1748382744.146 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2025-05-27T21:52:24.146Z,1748382744.146 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2025-05-27T21:52:24.146Z,1748382744.146 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2025-05-27T21:52:24.146Z,1748382744.146 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2025-05-27T21:52:24.146Z,1748382744.146 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2025-05-27T21:52:24.147Z,1748382744.147 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2025-05-27T21:52:24.147Z,1748382744.147 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2025-05-27T21:52:24.147Z,1748382744.147 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2025-05-27T21:52:24.179Z,1748382744.179 [CBIT](DEBUG): Backplane powered.
2025-05-27T21:52:24.180Z,1748382744.180 [GFScanner](DEBUG): Initializing GFScanner
2025-05-27T21:52:24.180Z,1748382744.180 [GFScanner](DEBUG): Deactivating GF circuits.
2025-05-27T21:52:24.185Z,1748382744.185 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2025-05-27T21:52:24.185Z,1748382744.185 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2025-05-27T21:52:24.186Z,1748382744.186 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2025-05-27T21:52:24.191Z,1748382744.191 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2025-05-27T21:52:24.235Z,1748382744.235 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
2025-05-27T21:52:24.253Z,1748382744.253 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2025-05-27T21:52:24.305Z,1748382744.305 [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-27T21:52:24.306Z,1748382744.306 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2025-05-27T21:52:24.306Z,1748382744.306 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2025-05-27T21:52:24.310Z,1748382744.310 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2025-05-27T21:52:24.528Z,1748382744.528 [Radio_Surface](INFO): Powering up
2025-05-27T21:52:24.536Z,1748382744.536 [RBRTridente](INFO): Starting
2025-05-27T21:52:24.537Z,1748382744.537 [RBRTridente](ERROR): Error parsing data: à0, 0.000165921088, -0.00000679997700, -0.133483888
2025-05-27T21:52:24.624Z,1748382744.624 [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-27T21:52:24.630Z,1748382744.630 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2025-05-27T21:52:24.631Z,1748382744.631 [Default:A.Wait](DEBUG): Construct Wait.
2025-05-27T21:52:24.633Z,1748382744.633 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2025-05-27T21:52:24.678Z,1748382744.678 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2025-05-27T21:52:24.697Z,1748382744.697 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2025-05-27T21:52:24.708Z,1748382744.708 [Default:E.Execute](DEBUG): Construct Execute.
2025-05-27T21:52:24.711Z,1748382744.711 [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-27T21:52:24.723Z,1748382744.723 [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-27T21:52:24.732Z,1748382744.732 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2025-05-27T21:52:24.812Z,1748382744.812 [DepthKeller33X](INFO): Initializing.
2025-05-27T21:52:24.832Z,1748382744.832 [Power24vConverter](INFO): Powering up.
2025-05-27T21:52:24.833Z,1748382744.833 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2025-05-27T21:52:24.840Z,1748382744.840 [Sonardyne_Nano](INFO): Initializing.
2025-05-27T21:52:24.860Z,1748382744.860 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-05-27T21:52:24.901Z,1748382744.901 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2025-05-27T21:52:24.908Z,1748382744.908 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2025-05-27T21:52:24.909Z,1748382744.909 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-05-27T21:52:24.916Z,1748382744.916 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-05-27T21:52:24.917Z,1748382744.917 [MassServo](DEBUG): Initializing EZServoServo.
2025-05-27T21:52:24.924Z,1748382744.924 [MassServo](DEBUG): Initializing MassServo.
2025-05-27T21:52:24.925Z,1748382744.925 [RudderServo](DEBUG): Initializing EZServoServo.
2025-05-27T21:52:24.932Z,1748382744.932 [RudderServo](DEBUG): Initializing RudderServo.
2025-05-27T21:52:24.933Z,1748382744.933 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-05-27T21:52:24.940Z,1748382744.940 [RBRTridente](INFO): Starting
2025-05-27T21:52:24.942Z,1748382744.942 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-05-27T21:52:25.184Z,1748382745.184 [DropWeight](CRITICAL): DROP WEIGHT MISSING.
2025-05-27T21:52:25.184Z,1748382745.184 [DropWeight] Hardware Fault, FailCount= 1
2025-05-27T21:52:25.185Z,1748382745.185 [DropWeight](ERROR): Hardware Fault
2025-05-27T21:52:25.186Z,1748382745.186 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-05-27T21:52:25.210Z,1748382745.210 [CommandExec](FAULT): Scheduling is paused
2025-05-27T21:52:25.210Z,1748382745.210 [CBIT](INFO): Critical error at 20250527T215225
2025-05-27T21:52:25.211Z,1748382745.211 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2025-05-27T21:52:25.221Z,1748382745.221 [CBIT](ERROR): Hardware Fault in component: DropWeight
2025-05-27T21:52:25.222Z,1748382745.222 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2025-05-27T21:52:25.344Z,1748382745.344 [RBRTridente](INFO): Stop
2025-05-27T21:52:25.416Z,1748382745.416 [RBRTridente](INFO): Powering down
2025-05-27T21:52:25.541Z,1748382745.541 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-05-27T21:52:25.550Z,1748382745.550 [CBIT](INFO): Critical error at 20250527T215225
2025-05-27T21:52:25.748Z,1748382745.748 [RBRTridente](INFO): Stopping
2025-05-27T21:52:25.944Z,1748382745.944 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-05-27T21:52:26.369Z,1748382746.369 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-05-27T21:52:26.760Z,1748382746.760 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART
2025-05-27T21:52:28.410Z,1748382748.410 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-27T21:52:28.410Z,1748382748.410 [Power24vConverter] Hardware Fault, FailCount= 1
2025-05-27T21:52:28.410Z,1748382748.410 [Power24vConverter](ERROR): Hardware Fault
2025-05-27T21:52:28.410Z,1748382748.410 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:28.411Z,1748382748.411 [Power24vConverter](FAULT): 24V Power is reporting not powering/powered.
2025-05-27T21:52:28.414Z,1748382748.414 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2213
2025-05-27T21:52:28.624Z,1748382748.624 [CBIT](ERROR): Hardware Fault in component: Power24vConverter
2025-05-27T21:52:28.821Z,1748382748.821 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:29.289Z,1748382749.289 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-05-27T21:52:29.649Z,1748382749.649 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:30.028Z,1748382750.028 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-05-27T21:52:30.428Z,1748382750.428 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:30.473Z,1748382750.473 [ThrusterHE](ERROR): Zero Speed Commanded.
2025-05-27T21:52:30.841Z,1748382750.841 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-05-27T21:52:31.261Z,1748382751.261 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:31.669Z,1748382751.669 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-05-27T21:52:32.048Z,1748382752.048 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:32.453Z,1748382752.453 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-05-27T21:52:32.865Z,1748382752.865 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:33.273Z,1748382753.273 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-05-27T21:52:33.637Z,1748382753.637 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:34.058Z,1748382754.058 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-05-27T21:52:34.433Z,1748382754.433 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:34.838Z,1748382754.838 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-05-27T21:52:35.244Z,1748382755.244 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:35.657Z,1748382755.657 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-05-27T21:52:36.077Z,1748382756.077 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:36.453Z,1748382756.453 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-05-27T21:52:36.857Z,1748382756.857 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:37.264Z,1748382757.264 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-05-27T21:52:37.681Z,1748382757.681 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:38.097Z,1748382758.097 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-05-27T21:52:38.473Z,1748382758.473 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:38.878Z,1748382758.878 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-05-27T21:52:39.284Z,1748382759.284 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:40.105Z,1748382760.105 [Power24vConverter](INFO): Powering up.
2025-05-27T21:52:40.145Z,1748382760.145 [CBIT](INFO): Clearing failed state for component Power24vConverter
2025-05-27T21:52:40.145Z,1748382760.145 [Power24vConverter] No Fault, FailCount= 1
2025-05-27T21:52:43.732Z,1748382763.732 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-27T21:52:43.732Z,1748382763.732 [Power24vConverter] Hardware Fault, FailCount= 1
2025-05-27T21:52:43.732Z,1748382763.732 [Power24vConverter](ERROR): Hardware Fault
2025-05-27T21:52:43.733Z,1748382763.733 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:43.733Z,1748382763.733 [Power24vConverter](FAULT): 24V Power is reporting not powering/powered.
2025-05-27T21:52:43.768Z,1748382763.768 [CBIT](ERROR): Hardware Fault in component: Power24vConverter
2025-05-27T21:52:44.137Z,1748382764.137 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:44.545Z,1748382764.545 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-27T21:52:44.957Z,1748382764.957 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:45.369Z,1748382765.369 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-27T21:52:45.750Z,1748382765.750 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:46.158Z,1748382766.158 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-27T21:52:46.564Z,1748382766.564 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:46.977Z,1748382766.977 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-27T21:52:46.978Z,1748382766.978 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2025-05-27T21:52:46.978Z,1748382766.978 [RDI_Pathfinder] Communications Fault, FailCount= 1
2025-05-27T21:52:46.978Z,1748382766.978 [RDI_Pathfinder](ERROR): Communications Fault
2025-05-27T21:52:47.001Z,1748382767.001 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2025-05-27T21:52:47.387Z,1748382767.387 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:47.460Z,1748382767.460 [RDI_Pathfinder](INFO): Powering down
2025-05-27T21:52:47.772Z,1748382767.772 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-27T21:52:48.178Z,1748382768.178 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:48.203Z,1748382768.203 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2025-05-27T21:52:48.203Z,1748382768.203 [RDI_Pathfinder] No Fault, FailCount= 1
2025-05-27T21:52:48.586Z,1748382768.586 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-27T21:52:48.587Z,1748382768.587 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2025-05-27T21:52:49.002Z,1748382769.002 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:49.418Z,1748382769.418 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-27T21:52:49.793Z,1748382769.793 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:50.195Z,1748382770.195 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-27T21:52:50.613Z,1748382770.613 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:51.017Z,1748382771.017 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-27T21:52:51.433Z,1748382771.433 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:51.811Z,1748382771.811 [NAL9602](INFO): Powering up NAL9602
2025-05-27T21:52:51.812Z,1748382771.812 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-27T21:52:52.216Z,1748382772.216 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:52.622Z,1748382772.622 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-27T21:52:53.037Z,1748382773.037 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:53.453Z,1748382773.453 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-27T21:52:53.829Z,1748382773.829 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:54.240Z,1748382774.240 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-27T21:52:54.644Z,1748382774.644 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:55.053Z,1748382775.053 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-27T21:52:55.469Z,1748382775.469 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:55.881Z,1748382775.881 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-27T21:52:56.254Z,1748382776.254 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:56.660Z,1748382776.660 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-27T21:52:57.073Z,1748382777.073 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:57.493Z,1748382777.493 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-27T21:52:57.869Z,1748382777.869 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:58.275Z,1748382778.275 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-27T21:52:58.680Z,1748382778.680 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:59.093Z,1748382779.093 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-27T21:52:59.509Z,1748382779.509 [Power24vConverter](INFO): Powering down.
2025-05-27T21:52:59.890Z,1748382779.890 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-27T21:53:00.293Z,1748382780.293 [Power24vConverter](INFO): Powering down.
2025-05-27T21:53:00.700Z,1748382780.700 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-27T21:53:01.114Z,1748382781.114 [Power24vConverter](INFO): Powering down.
2025-05-27T21:53:01.529Z,1748382781.529 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-27T21:53:01.937Z,1748382781.937 [Power24vConverter](INFO): Powering down.
2025-05-27T21:53:02.332Z,1748382782.332 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-27T21:53:02.720Z,1748382782.720 [NAL9602](INFO): NAL9602 initialized
2025-05-27T21:53:02.720Z,1748382782.720 [Power24vConverter](INFO): Powering down.
2025-05-27T21:53:03.133Z,1748382783.133 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-27T21:53:03.564Z,1748382783.564 [Power24vConverter](INFO): Powering down.
2025-05-27T21:53:03.594Z,1748382783.594 [SBIT](IMPORTANT): Beginning Startup BIT
2025-05-27T21:53:03.599Z,1748382783.599 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-05-27T21:53:03.979Z,1748382783.979 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-27T21:53:04.348Z,1748382784.348 [Power24vConverter](INFO): Powering down.
2025-05-27T21:53:04.741Z,1748382784.741 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-27T21:53:04.784Z,1748382784.784 [GFScanner](ERROR): Error reading 24V bus power status. Assuming off for scan purposes.
2025-05-27T21:53:05.158Z,1748382785.158 [Power24vConverter](INFO): Powering down.
2025-05-27T21:53:05.576Z,1748382785.576 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-27T21:53:05.992Z,1748382785.992 [Power24vConverter](INFO): Powering down.
2025-05-27T21:53:06.770Z,1748382786.770 [Power24vConverter](INFO): Powering up.
2025-05-27T21:53:06.877Z,1748382786.877 [CBIT](INFO): Clearing failed state for component Power24vConverter
2025-05-27T21:53:06.877Z,1748382786.877 [Power24vConverter] No Fault, FailCount= 1
2025-05-27T21:53:08.069Z,1748382788.069 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.008602
CHAN A1 (24V) N/A reporting off
CHAN A2 (12V): -0.000094
CHAN A3 (5V): -0.010388
CHAN B0 (3.3V): -0.000039
CHAN B1 (3.15aV): -0.000647
CHAN B2 (3.15bV): -0.000565
CHAN B3 (GND): -0.000843
OPEN: 0.008452
Full Scale: +/- 1 mA
2025-05-27T21:53:10.449Z,1748382790.449 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-27T21:53:10.449Z,1748382790.449 [Power24vConverter] Hardware Fault, FailCount= 1
2025-05-27T21:53:10.449Z,1748382790.449 [Power24vConverter](ERROR): Hardware Fault
2025-05-27T21:53:10.449Z,1748382790.449 [Power24vConverter](INFO): Powering down.
2025-05-27T21:53:10.450Z,1748382790.450 [Power24vConverter](FAULT): 24V Power is reporting not powering/powered.
2025-05-27T21:53:10.493Z,1748382790.493 [CBIT](ERROR): Hardware Fault in component: Power24vConverter
2025-05-27T21:53:10.824Z,1748382790.824 [Power24vConverter](INFO): Powering down.
2025-05-27T21:53:10.825Z,1748382790.825 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2025-05-27T21:53:10.825Z,1748382790.825 [RDI_Pathfinder] Communications Fault, FailCount= 2
2025-05-27T21:53:10.825Z,1748382790.825 [RDI_Pathfinder](ERROR): Communications Fault
2025-05-27T21:53:10.868Z,1748382790.868 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2025-05-27T21:53:11.232Z,1748382791.232 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-05-27T21:53:11.300Z,1748382791.300 [RDI_Pathfinder](INFO): Powering down
2025-05-27T21:53:11.635Z,1748382791.635 [Power24vConverter](INFO): Powering down.
2025-05-27T21:53:12.061Z,1748382792.061 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2025-05-27T21:53:12.061Z,1748382792.061 [RDI_Pathfinder] No Fault, FailCount= 2
2025-05-27T21:53:12.449Z,1748382792.449 [Power24vConverter](INFO): Powering up.
2025-05-27T21:53:12.450Z,1748382792.450 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2025-05-27T21:53:12.492Z,1748382792.492 [CBIT](INFO): Clearing failed state for component Power24vConverter
2025-05-27T21:53:12.492Z,1748382792.492 [Power24vConverter] No Fault, FailCount= 1
2025-05-27T21:53:24.296Z,1748382804.296 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2025-05-27T21:53:24.296Z,1748382804.296 [DAT] Communications Fault, FailCount= 1
2025-05-27T21:53:24.296Z,1748382804.296 [DAT](ERROR): Communications Fault
2025-05-27T21:53:24.548Z,1748382804.548 [CBIT](ERROR): Communications Fault in component: DAT
2025-05-27T21:53:24.700Z,1748382804.700 [DAT](INFO): Powering down
2025-05-27T21:53:25.176Z,1748382805.176 [DAT](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-05-27T21:53:25.176Z,1748382805.176 [DAT] Hardware Fault, FailCount= 1
2025-05-27T21:53:25.176Z,1748382805.176 [DAT](ERROR): Hardware Fault
2025-05-27T21:53:25.914Z,1748382805.914 [CBIT](INFO): Clearing failed state for component DAT
2025-05-27T21:53:25.914Z,1748382805.914 [DAT] No Fault, FailCount= 1
2025-05-27T21:53:27.760Z,1748382807.760 [DAT](INFO): Powering up
2025-05-27T21:53:27.760Z,1748382807.760 [DAT](DEBUG): Initializing DAT.
2025-05-27T21:53:39.101Z,1748382819.101 [DAT](INFO): DAT read:
2025-05-27T21:53:39.102Z,1748382819.102 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series
2025-05-27T21:53:40.617Z,1748382820.617 [DAT](INFO): DAT read: MF Frequency Band
2025-05-27T21:53:40.618Z,1748382820.618 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.14.0
2025-05-27T21:53:40.618Z,1748382820.618 [DAT](INFO): DAT read: May 27 2025 21:53:36
2025-05-27T21:53:41.625Z,1748382821.625 [DAT](INFO): DAT read: Features enabled [Bearing]
2025-05-27T21:53:41.626Z,1748382821.626 [DAT](INFO): DAT read: CONNECT 00600 bits/sec 1 of 4, Rate 1/2 CC 25.00ms MGP
2025-05-27T21:53:41.626Z,1748382821.626 [DAT](INFO): commRate: 600
2025-05-27T21:53:43.704Z,1748382823.704 [DAT](INFO): entering command mode
2025-05-27T21:53:43.904Z,1748382823.904 [DAT](INFO): DAT read:
2025-05-27T21:53:43.905Z,1748382823.905 [DAT](INFO): DAT read: user:1>
2025-05-27T21:53:43.905Z,1748382823.905 [DAT](INFO): setting verbose to 3
2025-05-27T21:53:44.156Z,1748382824.156 [DAT](INFO): DAT read: user:1>
2025-05-27T21:53:44.157Z,1748382824.157 [DAT](INFO): DAT read: Verbose | 3
2025-05-27T21:53:44.158Z,1748382824.158 [DAT](INFO): set verbose to 3
2025-05-27T21:53:44.158Z,1748382824.158 [DAT](INFO): setting DatVerbose to 27440
2025-05-27T21:53:44.408Z,1748382824.408 [DAT](INFO): DAT read: user:2>
2025-05-27T21:53:44.409Z,1748382824.409 [DAT](INFO): DAT read: DatVerbose | 27440
2025-05-27T21:53:44.410Z,1748382824.410 [DAT](INFO): set DatVerbose to 27440
2025-05-27T21:53:44.410Z,1748382824.410 [DAT](INFO): setting transmit power to 8
2025-05-27T21:53:44.661Z,1748382824.661 [DAT](INFO): DAT read: user:3>
2025-05-27T21:53:44.662Z,1748382824.662 [DAT](INFO): DAT read: TxPower | 8 (Max)
2025-05-27T21:53:44.662Z,1748382824.662 [DAT](INFO): set transmit power to 8
2025-05-27T21:53:44.663Z,1748382824.663 [DAT](INFO): setting local address to 3
2025-05-27T21:53:44.912Z,1748382824.912 [DAT](INFO): DAT read: user:4>
2025-05-27T21:53:44.913Z,1748382824.913 [DAT](INFO): DAT read: LocalAddr | 3
2025-05-27T21:53:44.914Z,1748382824.914 [DAT](INFO): set local address to 3
2025-05-27T21:53:44.915Z,1748382824.915 [DAT](INFO): Setting time to: 21:53:44 And date to:5/27/2025
2025-05-27T21:53:45.164Z,1748382825.164 [DAT](INFO): DAT read: user:5>
2025-05-27T21:53:45.165Z,1748382825.165 [DAT](INFO): DAT read: Tue May 27, 2025 21:53:44
2025-05-27T21:53:45.166Z,1748382825.166 [DAT](INFO): Local DAT time set to Tue May 27, 2025 21:53:44
2025-05-27T21:53:57.373Z,1748382837.373 [SBIT](IMPORTANT): SBIT PASSED
2025-05-27T21:53:57.374Z,1748382837.374 [SBIT](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2025-05-27T21:53:57.804Z,1748382837.804 [MissionManager](IMPORTANT): Started mission Startup
2025-05-27T21:53:57.804Z,1748382837.804 [Startup] Running Loop=1
2025-05-27T21:53:57.804Z,1748382837.804 [Startup](DEBUG): Aggregate::initialize Startup
2025-05-27T21:53:57.804Z,1748382837.804 [Startup:A.GoToSurface] Running Loop=1
2025-05-27T21:53:57.804Z,1748382837.804 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-05-27T21:53:57.805Z,1748382837.805 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-05-27T21:53:57.805Z,1748382837.805 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-05-27T21:53:57.805Z,1748382837.805 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-05-27T21:53:57.806Z,1748382837.806 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-05-27T21:53:57.806Z,1748382837.806 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-05-27T21:53:57.806Z,1748382837.806 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-05-27T21:53:57.808Z,1748382837.808 [Startup:StartupSatComms] Running Loop=1
2025-05-27T21:53:57.808Z,1748382837.808 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2025-05-27T21:53:57.808Z,1748382837.808 [Startup:StartupSatComms:A] Running Loop=1
2025-05-27T21:53:58.175Z,1748382838.175 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2025-05-27T21:54:18.265Z,1748382858.265 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005002
2025-05-27T21:54:57.975Z,1748382897.975 [Startup:StartupSatComms:A](INFO): Timed out from 2025-05-27T21:53:57.8Z
2025-05-27T21:54:57.975Z,1748382897.975 [Startup:StartupSatComms:A] Stopped
2025-05-27T21:54:57.975Z,1748382897.975 [Startup:StartupSatComms:B] Running Loop=1
2025-05-27T21:54:58.391Z,1748382898.391 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-05-27T21:55:06.388Z,1748382906.388 [DataOverHttps](INFO): Sending 107 bytes from file Logs/20250527T021323/Courier0333.lzma
2025-05-27T21:55:07.389Z,1748382907.389 [DataOverHttps](INFO): Moved sent file to Logs/20250527T021323/Courier0333.lzma.bak
2025-05-27T21:55:07.389Z,1748382907.389 [DataOverHttps](INFO): SBD MOMSN=25010591
2025-05-27T21:55:23.838Z,1748382923.838 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20250527T021323/Courier0336.lzma
2025-05-27T21:55:24.221Z,1748382924.221 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2025-05-27T21:55:24.221Z,1748382924.221 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T21:55:24.223Z,1748382924.223 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2025-05-27T21:55:24.223Z,1748382924.223 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-27T21:55:24.234Z,1748382924.234 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T21:55:24.235Z,1748382924.235 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-27T21:55:24.650Z,1748382924.650 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T21:55:24.650Z,1748382924.650 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2025-05-27T21:55:24.651Z,1748382924.651 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-27T21:55:24.651Z,1748382924.651 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2025-05-27T21:55:24.838Z,1748382924.838 [DataOverHttps](INFO): Moved sent file to Logs/20250527T021323/Courier0336.lzma.bak
2025-05-27T21:55:24.838Z,1748382924.838 [DataOverHttps](INFO): SBD MOMSN=25010595
2025-05-27T21:55:42.449Z,1748382942.449 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20250527T214408/Courier0000.lzma
2025-05-27T21:55:43.452Z,1748382943.452 [DataOverHttps](INFO): Moved sent file to Logs/20250527T214408/Courier0000.lzma.bak
2025-05-27T21:55:43.453Z,1748382943.453 [DataOverHttps](INFO): SBD MOMSN=25010597
2025-05-27T21:55:58.183Z,1748382958.183 [Startup:StartupSatComms:B](INFO): Timed out from 2025-05-27T21:54:57.0Z
2025-05-27T21:55:58.183Z,1748382958.183 [Startup:StartupSatComms:B] Stopped
2025-05-27T21:55:58.183Z,1748382958.183 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2025-05-27T21:55:58.183Z,1748382958.183 [Startup:StartupSatComms] Stopped
2025-05-27T21:55:58.183Z,1748382958.183 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2025-05-27T21:55:58.184Z,1748382958.184 [Startup](INFO): Completed Startup
2025-05-27T21:55:58.184Z,1748382958.184 [MissionManager](INFO): Startup is completed.
2025-05-27T21:55:58.185Z,1748382958.185 [MissionManager](INFO): Uninitializing Mission Startup
2025-05-27T21:55:58.185Z,1748382958.185 [Startup] Stopped
2025-05-27T21:55:58.185Z,1748382958.185 [Startup](DEBUG): Aggregate::uninitialize Startup
2025-05-27T21:55:58.185Z,1748382958.185 [Startup:A.GoToSurface] Stopped
2025-05-27T21:55:58.185Z,1748382958.185 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-05-27T21:55:58.561Z,1748382958.561 [MissionManager](IMPORTANT): Started mission Default
2025-05-27T21:55:58.561Z,1748382958.561 [Default] Running Loop=1
2025-05-27T21:55:58.561Z,1748382958.561 [Default](DEBUG): Aggregate::initialize Default
2025-05-27T21:55:58.561Z,1748382958.561 [Default:B.GoToSurface] Running Loop=1
2025-05-27T21:55:58.561Z,1748382958.561 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-05-27T21:55:58.562Z,1748382958.562 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-05-27T21:55:58.562Z,1748382958.562 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-05-27T21:55:58.563Z,1748382958.563 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-05-27T21:55:58.563Z,1748382958.563 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-05-27T21:55:58.563Z,1748382958.563 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-05-27T21:55:58.564Z,1748382958.564 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-05-27T21:55:58.564Z,1748382958.564 [Default:A.Wait] Running Loop=1
2025-05-27T21:55:58.564Z,1748382958.564 [Default:A.Wait](DEBUG): Initialize Wait Component.
2025-05-27T21:55:59.850Z,1748382959.850 [DataOverHttps](INFO): Sending 243 bytes from file Logs/20250527T215211/Courier0000.lzma
2025-05-27T21:56:00.852Z,1748382960.852 [DataOverHttps](INFO): Moved sent file to Logs/20250527T215211/Courier0000.lzma.bak
2025-05-27T21:56:00.852Z,1748382960.852 [DataOverHttps](INFO): SBD MOMSN=25010600
2025-05-27T21:56:11.922Z,1748382971.922 [Default:A.Wait](INFO): Done Waiting.
2025-05-27T21:56:11.922Z,1748382971.922 [Default:A.Wait] Stopped
2025-05-27T21:56:11.923Z,1748382971.923 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2025-05-27T21:56:12.316Z,1748382972.316 [Default:CheckIn] Running Loop=1
2025-05-27T21:56:12.316Z,1748382972.316 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-27T21:56:12.316Z,1748382972.316 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-27T21:56:12.736Z,1748382972.736 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-05-27T21:57:02.162Z,1748383022.162 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-05-27T21:57:02.171Z,1748383022.171 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-05-27T21:57:14.685Z,1748383034.685 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-05-27T21:57:17.109Z,1748383037.109 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-05-27T21:57:26.805Z,1748383046.805 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-05-27T21:57:32.866Z,1748383052.866 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-05-27T21:57:38.925Z,1748383058.925 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-05-27T21:57:49.026Z,1748383069.026 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-05-27T21:57:51.449Z,1748383071.449 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-05-27T21:58:03.624Z,1748383083.624 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-05-27T21:58:03.973Z,1748383083.973 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-05-27T21:58:05.593Z,1748383085.593 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-05-27T21:58:15.689Z,1748383095.689 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-05-27T21:58:19.324Z,1748383099.324 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-05-27T21:58:25.408Z,1748383105.408 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2025-05-27T21:58:25.408Z,1748383105.408 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T21:58:25.409Z,1748383105.409 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2025-05-27T21:58:25.409Z,1748383105.409 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-27T21:58:25.421Z,1748383105.421 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T21:58:25.421Z,1748383105.421 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-27T21:58:25.845Z,1748383105.845 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T21:58:25.845Z,1748383105.845 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2025-05-27T21:58:25.845Z,1748383105.845 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-27T21:58:25.845Z,1748383105.845 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2025-05-27T21:58:28.214Z,1748383108.214 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-05-27T21:58:35.084Z,1748383115.084 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-05-27T21:58:40.736Z,1748383120.736 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-05-27T21:58:50.433Z,1748383130.433 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-05-27T21:58:53.261Z,1748383133.261 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-05-27T21:59:05.382Z,1748383145.382 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-05-27T21:59:05.799Z,1748383145.799 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-05-27T21:59:18.310Z,1748383158.310 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-05-27T21:59:20.733Z,1748383160.733 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-05-27T21:59:32.056Z,1748383172.056 [BPC1](INFO): Calculating totals. Valid battery stick count: 53. Valid reserve battery stick count: 5.
2025-05-27T21:59:32.059Z,1748383172.059 [BPC1](INFO): Received data from all battery sticks.
2025-05-27T22:01:12.660Z,1748383272.660 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-05-27T21:56:12.3Z
2025-05-27T22:01:12.660Z,1748383272.660 [Default:CheckIn:Read_GPS] Stopped
2025-05-27T22:01:12.660Z,1748383272.660 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-05-27T22:01:13.085Z,1748383273.085 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-05-27T22:01:17.119Z,1748383277.119 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20250527T215211/Courier0004.lzma
2025-05-27T22:01:17.688Z,1748383277.688 [DataOverHttps](INFO): Moved sent file to Logs/20250527T215211/Courier0004.lzma.bak
2025-05-27T22:01:17.688Z,1748383277.688 [DataOverHttps](INFO): SBD MOMSN=25010665
2025-05-27T22:01:26.343Z,1748383286.343 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2025-05-27T22:01:26.343Z,1748383286.343 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:01:26.345Z,1748383286.345 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 3
2025-05-27T22:01:26.345Z,1748383286.345 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-27T22:01:26.358Z,1748383286.358 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:01:26.358Z,1748383286.358 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-27T22:01:26.742Z,1748383286.742 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:01:26.742Z,1748383286.742 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2025-05-27T22:01:26.743Z,1748383286.743 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-27T22:01:26.743Z,1748383286.743 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 3
2025-05-27T22:01:35.887Z,1748383295.887 [DataOverHttps](INFO): Sending 596 bytes from file Logs/20250527T021323/Express0334.lzma
2025-05-27T22:01:36.889Z,1748383296.889 [DataOverHttps](INFO): Moved sent file to Logs/20250527T021323/Express0334.lzma.bak
2025-05-27T22:01:36.889Z,1748383296.889 [DataOverHttps](INFO): SBD MOMSN=25010673
2025-05-27T22:01:53.110Z,1748383313.110 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20250527T021323/Express0337.lzma
2025-05-27T22:01:54.112Z,1748383314.112 [DataOverHttps](INFO): Moved sent file to Logs/20250527T021323/Express0337.lzma.bak
2025-05-27T22:01:54.113Z,1748383314.113 [DataOverHttps](INFO): SBD MOMSN=25010739
2025-05-27T22:02:12.489Z,1748383332.489 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20250527T214408/Express0001.lzma
2025-05-27T22:02:13.495Z,1748383333.495 [DataOverHttps](INFO): Moved sent file to Logs/20250527T214408/Express0001.lzma.bak
2025-05-27T22:02:13.496Z,1748383333.496 [DataOverHttps](INFO): SBD MOMSN=25010741
2025-05-27T22:02:29.857Z,1748383349.857 [DataOverHttps](INFO): Sending 1340 bytes from file Logs/20250527T215211/Express0001.lzma
2025-05-27T22:02:30.856Z,1748383350.856 [DataOverHttps](INFO): Moved sent file to Logs/20250527T215211/Express0001.lzma.bak
2025-05-27T22:02:30.856Z,1748383350.856 [DataOverHttps](INFO): SBD MOMSN=25010743
2025-05-27T22:02:48.079Z,1748383368.079 [DataOverHttps](INFO): Sending 187 bytes from file Logs/20250527T215211/Express0005.lzma
2025-05-27T22:02:49.080Z,1748383369.080 [DataOverHttps](INFO): Moved sent file to Logs/20250527T215211/Express0005.lzma.bak
2025-05-27T22:02:49.080Z,1748383369.080 [DataOverHttps](INFO): SBD MOMSN=25010812
2025-05-27T22:02:51.141Z,1748383371.141 [Default:CheckIn:Read_Iridium] Stopped
2025-05-27T22:02:51.141Z,1748383371.141 [Default:CheckIn:C.Wait] Running Loop=1
2025-05-27T22:02:51.141Z,1748383371.141 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-05-27T22:03:05.699Z,1748383385.699 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-05-27T22:03:05.700Z,1748383385.700 [NAL9602] Data Fault, FailCount= 1
2025-05-27T22:03:05.700Z,1748383385.700 [NAL9602](ERROR): Data Fault
2025-05-27T22:03:05.772Z,1748383385.772 [CBIT](ERROR): Data Fault in component: NAL9602
2025-05-27T22:03:06.079Z,1748383386.079 [NAL9602](INFO): Powering down
2025-05-27T22:03:06.920Z,1748383386.920 [CBIT](INFO): Clearing failed state for component NAL9602
2025-05-27T22:03:06.920Z,1748383386.920 [NAL9602] No Fault, FailCount= 1
2025-05-27T22:03:36.380Z,1748383416.380 [NAL9602](INFO): Powering up NAL9602
2025-05-27T22:03:47.315Z,1748383427.315 [NAL9602](INFO): NAL9602 initialized
2025-05-27T22:04:25.696Z,1748383465.696 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for bottom velocity. Device response is::BS,-32768,-3268,V
2025-05-27T22:04:27.317Z,1748383467.317 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2025-05-27T22:04:27.317Z,1748383467.317 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:04:27.319Z,1748383467.319 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 4
2025-05-27T22:04:27.319Z,1748383467.319 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-27T22:04:27.329Z,1748383467.329 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:04:27.358Z,1748383467.358 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-27T22:04:27.734Z,1748383467.734 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:04:27.734Z,1748383467.734 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2025-05-27T22:04:27.735Z,1748383467.735 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-27T22:04:27.735Z,1748383467.735 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 4
2025-05-27T22:07:25.467Z,1748383645.467 [CBIT](INFO): Clearing failed state for component DropWeight
2025-05-27T22:07:25.467Z,1748383645.467 [DropWeight] No Fault, FailCount= 1
2025-05-27T22:07:28.292Z,1748383648.292 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2025-05-27T22:07:28.292Z,1748383648.292 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:07:28.295Z,1748383648.295 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 5
2025-05-27T22:07:28.295Z,1748383648.295 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-27T22:07:28.330Z,1748383648.330 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:07:28.330Z,1748383648.330 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-27T22:07:28.697Z,1748383648.697 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:07:28.697Z,1748383648.697 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2025-05-27T22:07:28.707Z,1748383648.707 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-27T22:07:28.707Z,1748383648.707 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 5
2025-05-27T22:07:51.751Z,1748383671.751 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-05-27T22:07:51.751Z,1748383671.751 [Default:CheckIn:C.Wait] Stopped
2025-05-27T22:07:51.751Z,1748383671.751 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-05-27T22:07:51.752Z,1748383671.752 [Default:CheckIn:D] Running Loop=1
2025-05-27T22:07:52.135Z,1748383672.135 [Default:CheckIn:D] Stopped
2025-05-27T22:07:52.135Z,1748383672.135 [Default:CheckIn:E] Running Loop=1
2025-05-27T22:07:52.543Z,1748383672.543 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 11.892889 min
2025-05-27T22:07:52.543Z,1748383672.543 [Default:CheckIn:E] Stopped
2025-05-27T22:07:52.543Z,1748383672.543 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-05-27T22:07:52.544Z,1748383672.544 [Default:CheckIn] Stopped
2025-05-27T22:07:52.544Z,1748383672.544 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-05-27T22:07:52.544Z,1748383672.544 [Default:CheckIn](INFO): Running loop #2
2025-05-27T22:07:52.544Z,1748383672.544 [Default:CheckIn] Running Loop=2
2025-05-27T22:07:52.544Z,1748383672.544 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-27T22:07:52.544Z,1748383672.544 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-27T22:10:29.335Z,1748383829.335 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2025-05-27T22:10:29.335Z,1748383829.335 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:10:29.336Z,1748383829.336 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 6
2025-05-27T22:10:29.336Z,1748383829.336 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-27T22:10:29.348Z,1748383829.348 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:10:29.348Z,1748383829.348 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-27T22:10:29.754Z,1748383829.754 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:10:29.754Z,1748383829.754 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2025-05-27T22:10:29.755Z,1748383829.755 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-27T22:10:29.755Z,1748383829.755 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 6
2025-05-27T22:12:52.797Z,1748383972.797 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-05-27T22:07:52.5Z
2025-05-27T22:12:52.797Z,1748383972.797 [Default:CheckIn:Read_GPS] Stopped
2025-05-27T22:12:52.797Z,1748383972.797 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-05-27T22:13:00.466Z,1748383980.466 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250527T215211/Courier0007.lzma
2025-05-27T22:13:01.470Z,1748383981.470 [DataOverHttps](INFO): Moved sent file to Logs/20250527T215211/Courier0007.lzma.bak
2025-05-27T22:13:01.471Z,1748383981.471 [DataOverHttps](INFO): SBD MOMSN=25010889
2025-05-27T22:13:18.564Z,1748383998.564 [DataOverHttps](INFO): Sending 208 bytes from file Logs/20250527T215211/Express0008.lzma
2025-05-27T22:13:19.560Z,1748383999.560 [DataOverHttps](INFO): Moved sent file to Logs/20250527T215211/Express0008.lzma.bak
2025-05-27T22:13:19.560Z,1748383999.560 [DataOverHttps](INFO): SBD MOMSN=25010891
2025-05-27T22:13:21.921Z,1748384001.921 [Default:CheckIn:Read_Iridium] Stopped
2025-05-27T22:13:21.921Z,1748384001.921 [Default:CheckIn:C.Wait] Running Loop=1
2025-05-27T22:13:21.921Z,1748384001.921 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-05-27T22:13:30.364Z,1748384010.364 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2025-05-27T22:13:30.364Z,1748384010.364 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:13:30.365Z,1748384010.365 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 7
2025-05-27T22:13:30.365Z,1748384010.365 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-27T22:13:30.376Z,1748384010.376 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:13:30.376Z,1748384010.376 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-27T22:13:30.792Z,1748384010.792 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:13:30.792Z,1748384010.792 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2025-05-27T22:13:30.792Z,1748384010.792 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-27T22:13:30.792Z,1748384010.792 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 7
2025-05-27T22:13:49.736Z,1748384029.736 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-05-27T22:13:49.736Z,1748384029.736 [NAL9602] Data Fault, FailCount= 2
2025-05-27T22:13:49.736Z,1748384029.736 [NAL9602](ERROR): Data Fault
2025-05-27T22:13:49.804Z,1748384029.804 [CBIT](ERROR): Data Fault in component: NAL9602
2025-05-27T22:13:50.140Z,1748384030.140 [NAL9602](INFO): Powering down
2025-05-27T22:13:50.977Z,1748384030.977 [CBIT](INFO): Clearing failed state for component NAL9602
2025-05-27T22:13:50.977Z,1748384030.977 [NAL9602] No Fault, FailCount= 2
2025-05-27T22:14:20.466Z,1748384060.466 [NAL9602](INFO): Powering up NAL9602
2025-05-27T22:14:31.349Z,1748384071.349 [NAL9602](INFO): NAL9602 initialized
2025-05-27T22:16:31.570Z,1748384191.570 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2025-05-27T22:16:31.570Z,1748384191.570 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:16:31.571Z,1748384191.571 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 8
2025-05-27T22:16:31.571Z,1748384191.571 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-27T22:16:31.585Z,1748384191.585 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:16:31.585Z,1748384191.585 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-27T22:16:31.935Z,1748384191.935 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:16:31.935Z,1748384191.935 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2025-05-27T22:16:31.935Z,1748384191.935 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-27T22:16:31.935Z,1748384191.935 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 8
2025-05-27T22:18:22.609Z,1748384302.609 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-05-27T22:18:22.631Z,1748384302.631 [Default:CheckIn:C.Wait] Stopped
2025-05-27T22:18:22.631Z,1748384302.631 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-05-27T22:18:22.631Z,1748384302.631 [Default:CheckIn:D] Running Loop=1
2025-05-27T22:18:23.035Z,1748384303.035 [Default:CheckIn:D] Stopped
2025-05-27T22:18:23.035Z,1748384303.035 [Default:CheckIn:E] Running Loop=1
2025-05-27T22:18:23.438Z,1748384303.438 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 22.407896 min
2025-05-27T22:18:23.438Z,1748384303.438 [Default:CheckIn:E] Stopped
2025-05-27T22:18:23.438Z,1748384303.438 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-05-27T22:18:23.439Z,1748384303.439 [Default:CheckIn] Stopped
2025-05-27T22:18:23.439Z,1748384303.439 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-05-27T22:18:23.439Z,1748384303.439 [Default:CheckIn](INFO): Running loop #3
2025-05-27T22:18:23.439Z,1748384303.439 [Default:CheckIn] Running Loop=3
2025-05-27T22:18:23.439Z,1748384303.439 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-27T22:18:23.439Z,1748384303.439 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-27T22:19:32.487Z,1748384372.487 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2025-05-27T22:19:32.487Z,1748384372.487 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:19:32.488Z,1748384372.488 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 9
2025-05-27T22:19:32.488Z,1748384372.488 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-27T22:19:32.517Z,1748384372.517 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:19:32.517Z,1748384372.517 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-27T22:19:32.902Z,1748384372.902 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:19:32.902Z,1748384372.902 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2025-05-27T22:19:32.903Z,1748384372.903 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-27T22:19:32.903Z,1748384372.903 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 9
2025-05-27T22:22:33.540Z,1748384553.540 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2025-05-27T22:22:33.540Z,1748384553.540 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:22:33.543Z,1748384553.543 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 10
2025-05-27T22:22:33.543Z,1748384553.543 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-27T22:22:33.557Z,1748384553.557 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:22:33.557Z,1748384553.557 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-27T22:22:33.963Z,1748384553.963 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:22:33.963Z,1748384553.963 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2025-05-27T22:22:33.963Z,1748384553.963 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-27T22:22:33.963Z,1748384553.963 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 10
2025-05-27T22:23:23.617Z,1748384603.617 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-05-27T22:18:23.4Z
2025-05-27T22:23:23.617Z,1748384603.617 [Default:CheckIn:Read_GPS] Stopped
2025-05-27T22:23:23.618Z,1748384603.618 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-05-27T22:23:25.133Z,1748384605.133 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250527T215211/Courier0010.lzma
2025-05-27T22:23:26.136Z,1748384606.136 [DataOverHttps](INFO): Moved sent file to Logs/20250527T215211/Courier0010.lzma.bak
2025-05-27T22:23:26.136Z,1748384606.136 [DataOverHttps](INFO): SBD MOMSN=25010988
2025-05-27T22:23:41.784Z,1748384621.784 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for water velocity. Device response is::WS,-32768,-3768,V
2025-05-27T22:23:49.851Z,1748384629.851 [DataOverHttps](INFO): Sending 173 bytes from file Logs/20250527T215211/Express0011.lzma
2025-05-27T22:23:50.852Z,1748384630.852 [DataOverHttps](INFO): Moved sent file to Logs/20250527T215211/Express0011.lzma.bak
2025-05-27T22:23:50.852Z,1748384630.852 [DataOverHttps](INFO): SBD MOMSN=25010990
2025-05-27T22:23:53.111Z,1748384633.111 [Default:CheckIn:Read_Iridium] Stopped
2025-05-27T22:23:53.111Z,1748384633.111 [Default:CheckIn:C.Wait] Running Loop=1
2025-05-27T22:23:53.111Z,1748384633.111 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-05-27T22:24:34.360Z,1748384674.360 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-05-27T22:24:34.360Z,1748384674.360 [NAL9602] Data Fault, FailCount= 3
2025-05-27T22:24:34.360Z,1748384674.360 [NAL9602](ERROR): Data Fault
2025-05-27T22:24:34.377Z,1748384674.377 [CBIT](ERROR): Data Fault in component: NAL9602
2025-05-27T22:24:34.716Z,1748384674.716 [NAL9602](INFO): Powering down
2025-05-27T22:24:35.621Z,1748384675.621 [CBIT](INFO): Clearing failed state for component NAL9602
2025-05-27T22:24:35.621Z,1748384675.621 [NAL9602] No Fault, FailCount= 3
2025-05-27T22:25:05.004Z,1748384705.004 [NAL9602](INFO): Powering up NAL9602
2025-05-27T22:25:15.903Z,1748384715.903 [NAL9602](INFO): NAL9602 initialized
2025-05-27T22:25:34.502Z,1748384734.502 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2025-05-27T22:25:34.503Z,1748384734.503 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:25:34.504Z,1748384734.504 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 11
2025-05-27T22:25:34.504Z,1748384734.504 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-27T22:25:34.515Z,1748384734.515 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:25:34.516Z,1748384734.516 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-27T22:25:34.946Z,1748384734.946 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:25:34.946Z,1748384734.946 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2025-05-27T22:25:34.947Z,1748384734.947 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-27T22:25:34.947Z,1748384734.947 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 11
2025-05-27T22:28:35.591Z,1748384915.591 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2025-05-27T22:28:35.592Z,1748384915.592 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:28:35.593Z,1748384915.593 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 12
2025-05-27T22:28:35.593Z,1748384915.593 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-27T22:28:35.637Z,1748384915.637 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:28:35.642Z,1748384915.642 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-27T22:28:35.980Z,1748384915.980 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:28:35.980Z,1748384915.980 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2025-05-27T22:28:35.981Z,1748384915.981 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-27T22:28:35.981Z,1748384915.981 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 12
2025-05-27T22:28:53.747Z,1748384933.747 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-05-27T22:28:53.748Z,1748384933.748 [Default:CheckIn:C.Wait] Stopped
2025-05-27T22:28:53.748Z,1748384933.748 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-05-27T22:28:53.748Z,1748384933.748 [Default:CheckIn:D] Running Loop=1
2025-05-27T22:28:54.161Z,1748384934.161 [Default:CheckIn:D] Stopped
2025-05-27T22:28:54.161Z,1748384934.161 [Default:CheckIn:E] Running Loop=1
2025-05-27T22:28:54.579Z,1748384934.579 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 32.926656 min
2025-05-27T22:28:54.579Z,1748384934.579 [Default:CheckIn:E] Stopped
2025-05-27T22:28:54.579Z,1748384934.579 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-05-27T22:28:54.579Z,1748384934.579 [Default:CheckIn] Stopped
2025-05-27T22:28:54.579Z,1748384934.579 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-05-27T22:28:54.579Z,1748384934.579 [Default:CheckIn](INFO): Running loop #4
2025-05-27T22:28:54.579Z,1748384934.579 [Default:CheckIn] Running Loop=4
2025-05-27T22:28:54.580Z,1748384934.580 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-27T22:28:54.580Z,1748384934.580 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-27T22:31:36.547Z,1748385096.547 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13
2025-05-27T22:31:36.547Z,1748385096.547 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:31:36.548Z,1748385096.548 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 13
2025-05-27T22:31:36.548Z,1748385096.548 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-27T22:31:36.560Z,1748385096.560 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:31:36.560Z,1748385096.560 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-27T22:31:36.962Z,1748385096.962 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:31:36.962Z,1748385096.962 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13
2025-05-27T22:31:36.963Z,1748385096.963 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-27T22:31:36.963Z,1748385096.963 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 13
2025-05-27T22:33:54.744Z,1748385234.744 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-05-27T22:28:54.6Z
2025-05-27T22:33:54.744Z,1748385234.744 [Default:CheckIn:Read_GPS] Stopped
2025-05-27T22:33:54.744Z,1748385234.744 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-05-27T22:34:02.873Z,1748385242.873 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250527T215211/Courier0013.lzma
2025-05-27T22:34:03.876Z,1748385243.876 [DataOverHttps](INFO): Moved sent file to Logs/20250527T215211/Courier0013.lzma.bak
2025-05-27T22:34:03.876Z,1748385243.876 [DataOverHttps](INFO): SBD MOMSN=25011064
2025-05-27T22:34:21.094Z,1748385261.094 [DataOverHttps](INFO): Sending 175 bytes from file Logs/20250527T215211/Express0014.lzma
2025-05-27T22:34:22.096Z,1748385262.096 [DataOverHttps](INFO): Moved sent file to Logs/20250527T215211/Express0014.lzma.bak
2025-05-27T22:34:22.096Z,1748385262.096 [DataOverHttps](INFO): SBD MOMSN=25011066
2025-05-27T22:34:24.307Z,1748385264.307 [Default:CheckIn:Read_Iridium] Stopped
2025-05-27T22:34:24.307Z,1748385264.307 [Default:CheckIn:C.Wait] Running Loop=1
2025-05-27T22:34:24.307Z,1748385264.307 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-05-27T22:34:37.687Z,1748385277.687 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14
2025-05-27T22:34:37.687Z,1748385277.687 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:34:37.689Z,1748385277.689 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 14
2025-05-27T22:34:37.689Z,1748385277.689 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-27T22:34:37.713Z,1748385277.713 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:34:37.713Z,1748385277.713 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-27T22:34:38.066Z,1748385278.066 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:34:38.066Z,1748385278.066 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14
2025-05-27T22:34:38.067Z,1748385278.067 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-27T22:34:38.067Z,1748385278.067 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 14
2025-05-27T22:35:16.797Z,1748385316.797 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-05-27T22:35:16.797Z,1748385316.797 [NAL9602] Data Fault, FailCount= 4
2025-05-27T22:35:16.797Z,1748385316.797 [NAL9602](ERROR): Data Fault
2025-05-27T22:35:16.826Z,1748385316.826 [CBIT](ERROR): Data Fault in component: NAL9602
2025-05-27T22:35:17.202Z,1748385317.202 [NAL9602](INFO): Powering down
2025-05-27T22:35:18.049Z,1748385318.049 [CBIT](INFO): Clearing failed state for component NAL9602
2025-05-27T22:35:18.049Z,1748385318.049 [NAL9602] No Fault, FailCount= 4
2025-05-27T22:35:47.559Z,1748385347.559 [NAL9602](INFO): Powering up NAL9602
2025-05-27T22:35:58.412Z,1748385358.412 [NAL9602](INFO): NAL9602 initialized
2025-05-27T22:37:26.890Z,1748385446.890 [DropWeight](CRITICAL): DROP WEIGHT MISSING.
2025-05-27T22:37:26.890Z,1748385446.890 [DropWeight] Hardware Fault, FailCount= 1
2025-05-27T22:37:26.890Z,1748385446.890 [DropWeight](ERROR): Hardware Fault
2025-05-27T22:37:26.908Z,1748385446.908 [CBIT](INFO): Critical error at 20250527T223726
2025-05-27T22:37:26.910Z,1748385446.910 [CBIT](ERROR): Hardware Fault in component: DropWeight
2025-05-27T22:37:26.911Z,1748385446.911 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2025-05-27T22:37:27.323Z,1748385447.323 [CBIT](INFO): Critical error at 20250527T223726
2025-05-27T22:37:38.621Z,1748385458.621 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15
2025-05-27T22:37:38.621Z,1748385458.621 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:37:38.622Z,1748385458.622 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 15
2025-05-27T22:37:38.622Z,1748385458.622 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-27T22:37:38.633Z,1748385458.633 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:37:38.634Z,1748385458.634 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-27T22:37:39.043Z,1748385459.043 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:37:39.043Z,1748385459.043 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15
2025-05-27T22:37:39.044Z,1748385459.044 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-27T22:37:39.044Z,1748385459.044 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 15
2025-05-27T22:39:24.878Z,1748385564.878 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-05-27T22:39:24.878Z,1748385564.878 [Default:CheckIn:C.Wait] Stopped
2025-05-27T22:39:24.878Z,1748385564.878 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-05-27T22:39:24.879Z,1748385564.879 [Default:CheckIn:D] Running Loop=1
2025-05-27T22:39:25.290Z,1748385565.290 [Default:CheckIn:D] Stopped
2025-05-27T22:39:25.290Z,1748385565.290 [Default:CheckIn:E] Running Loop=1
2025-05-27T22:39:25.767Z,1748385565.767 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 43.445475 min
2025-05-27T22:39:25.768Z,1748385565.768 [Default:CheckIn:E] Stopped
2025-05-27T22:39:25.768Z,1748385565.768 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-05-27T22:39:25.768Z,1748385565.768 [Default:CheckIn] Stopped
2025-05-27T22:39:25.768Z,1748385565.768 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-05-27T22:39:25.768Z,1748385565.768 [Default:CheckIn](INFO): Running loop #5
2025-05-27T22:39:25.768Z,1748385565.768 [Default:CheckIn] Running Loop=5
2025-05-27T22:39:25.768Z,1748385565.768 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-27T22:39:25.768Z,1748385565.768 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-27T22:40:39.665Z,1748385639.665 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16
2025-05-27T22:40:39.665Z,1748385639.665 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:40:39.666Z,1748385639.666 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 16
2025-05-27T22:40:39.666Z,1748385639.666 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-27T22:40:39.677Z,1748385639.677 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:40:39.677Z,1748385639.677 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-27T22:40:40.027Z,1748385640.027 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:40:40.027Z,1748385640.027 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16
2025-05-27T22:40:40.027Z,1748385640.027 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-27T22:40:40.028Z,1748385640.028 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 16
2025-05-27T22:43:07.875Z,1748385787.875 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error. Device response is::TS,00022300025677,35.0 0.0,1519.3, 0
2025-05-27T22:43:40.643Z,1748385820.643 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17
2025-05-27T22:43:40.643Z,1748385820.643 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:43:40.645Z,1748385820.645 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 17
2025-05-27T22:43:40.645Z,1748385820.645 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-27T22:43:40.671Z,1748385820.671 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:43:40.671Z,1748385820.671 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-27T22:43:41.081Z,1748385821.081 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:43:41.081Z,1748385821.081 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17
2025-05-27T22:43:41.082Z,1748385821.082 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-27T22:43:41.082Z,1748385821.082 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 17
2025-05-27T22:43:57.622Z,1748385837.622 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude. Device response is::BD, +0.00, +0.00, , 0.00,1393.96
2025-05-27T22:44:17.819Z,1748385857.819 [RDI_Pathfinder](ERROR): only read -1 of 1 data item for altitude. Device response is::BD, +0.00, +0.00,
2025-05-27T22:44:25.915Z,1748385865.915 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-05-27T22:39:25.8Z
2025-05-27T22:44:25.915Z,1748385865.915 [Default:CheckIn:Read_GPS] Stopped
2025-05-27T22:44:25.915Z,1748385865.915 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-05-27T22:44:33.443Z,1748385873.443 [DataOverHttps](INFO): Sending 115 bytes from file Logs/20250527T215211/Courier0016.lzma
2025-05-27T22:44:34.444Z,1748385874.444 [DataOverHttps](INFO): Moved sent file to Logs/20250527T215211/Courier0016.lzma.bak
2025-05-27T22:44:34.444Z,1748385874.444 [DataOverHttps](INFO): SBD MOMSN=25011146
2025-05-27T22:44:52.074Z,1748385892.074 [DataOverHttps](INFO): Sending 194 bytes from file Logs/20250527T215211/Express0017.lzma
2025-05-27T22:44:54.081Z,1748385894.081 [DataOverHttps](INFO): Moved sent file to Logs/20250527T215211/Express0017.lzma.bak
2025-05-27T22:44:54.081Z,1748385894.081 [DataOverHttps](INFO): SBD MOMSN=25011150
2025-05-27T22:44:56.181Z,1748385896.181 [Default:CheckIn:Read_Iridium] Stopped
2025-05-27T22:44:56.181Z,1748385896.181 [Default:CheckIn:C.Wait] Running Loop=1
2025-05-27T22:44:56.181Z,1748385896.181 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-05-27T22:46:01.609Z,1748385961.609 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-05-27T22:46:01.609Z,1748385961.609 [NAL9602] Data Fault, FailCount= 5
2025-05-27T22:46:01.609Z,1748385961.609 [NAL9602](ERROR): Data Fault
2025-05-27T22:46:01.687Z,1748385961.687 [CBIT](ERROR): Data Fault in component: NAL9602
2025-05-27T22:46:01.687Z,1748385961.687 [CBIT](CRITICAL): Data Fault in component: NAL9602
2025-05-27T22:46:02.012Z,1748385962.012 [NAL9602](INFO): Powering down
2025-05-27T22:46:02.028Z,1748385962.028 [CBIT](INFO): Critical error at 20250527T224601
2025-05-27T22:46:41.653Z,1748386001.653 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18
2025-05-27T22:46:41.653Z,1748386001.653 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:46:41.678Z,1748386001.678 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 18
2025-05-27T22:46:41.678Z,1748386001.678 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-27T22:46:41.710Z,1748386001.710 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:46:41.711Z,1748386001.711 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-27T22:46:42.049Z,1748386002.049 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:46:42.049Z,1748386002.049 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18
2025-05-27T22:46:42.049Z,1748386002.049 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-27T22:46:42.054Z,1748386002.054 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 18
2025-05-27T22:48:01.669Z,1748386081.669 [CBIT](INFO): Clearing failed state for component NAL9602
2025-05-27T22:48:01.669Z,1748386081.669 [NAL9602] No Fault, FailCount= 5
2025-05-27T22:48:02.035Z,1748386082.035 [NAL9602](INFO): Powering up NAL9602
2025-05-27T22:48:12.943Z,1748386092.943 [NAL9602](INFO): NAL9602 initialized
2025-05-27T22:49:42.648Z,1748386182.648 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19
2025-05-27T22:49:42.648Z,1748386182.648 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:49:42.650Z,1748386182.650 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 19
2025-05-27T22:49:42.650Z,1748386182.650 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-27T22:49:42.661Z,1748386182.661 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:49:42.661Z,1748386182.661 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-27T22:49:43.059Z,1748386183.059 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:49:43.059Z,1748386183.059 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19
2025-05-27T22:49:43.060Z,1748386183.060 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-27T22:49:43.060Z,1748386183.060 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 19
2025-05-27T22:49:56.768Z,1748386196.768 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-05-27T22:49:56.769Z,1748386196.769 [Default:CheckIn:C.Wait] Stopped
2025-05-27T22:49:56.769Z,1748386196.769 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-05-27T22:49:56.769Z,1748386196.769 [Default:CheckIn:D] Running Loop=1
2025-05-27T22:49:57.197Z,1748386197.197 [Default:CheckIn:D] Stopped
2025-05-27T22:49:57.197Z,1748386197.197 [Default:CheckIn:E] Running Loop=1
2025-05-27T22:49:57.623Z,1748386197.623 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 53.977271 min
2025-05-27T22:49:57.623Z,1748386197.624 [Default:CheckIn:E] Stopped
2025-05-27T22:49:57.624Z,1748386197.624 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-05-27T22:49:57.624Z,1748386197.624 [Default:CheckIn] Stopped
2025-05-27T22:49:57.624Z,1748386197.624 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-05-27T22:49:57.624Z,1748386197.624 [Default:CheckIn](INFO): Running loop #6
2025-05-27T22:49:57.624Z,1748386197.624 [Default:CheckIn] Running Loop=6
2025-05-27T22:49:57.624Z,1748386197.624 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-27T22:49:57.624Z,1748386197.624 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-27T22:52:27.100Z,1748386347.100 [CBIT](INFO): Clearing failed state for component DropWeight
2025-05-27T22:52:27.100Z,1748386347.100 [DropWeight] No Fault, FailCount= 1
2025-05-27T22:52:43.677Z,1748386363.677 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20
2025-05-27T22:52:43.677Z,1748386363.677 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:52:43.678Z,1748386363.678 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 20
2025-05-27T22:52:43.678Z,1748386363.678 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-27T22:52:43.689Z,1748386363.689 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:52:43.706Z,1748386363.706 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-27T22:52:44.064Z,1748386364.064 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:52:44.064Z,1748386364.064 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20
2025-05-27T22:52:44.064Z,1748386364.064 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-27T22:52:44.064Z,1748386364.064 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 20
2025-05-27T22:54:57.801Z,1748386497.801 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-05-27T22:49:57.6Z
2025-05-27T22:54:57.801Z,1748386497.801 [Default:CheckIn:Read_GPS] Stopped
2025-05-27T22:54:57.801Z,1748386497.801 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-05-27T22:55:05.085Z,1748386505.085 [DataOverHttps](INFO): Sending 81 bytes from file Logs/20250527T215211/Courier0019.lzma
2025-05-27T22:55:06.088Z,1748386506.088 [DataOverHttps](INFO): Moved sent file to Logs/20250527T215211/Courier0019.lzma.bak
2025-05-27T22:55:06.088Z,1748386506.088 [DataOverHttps](INFO): SBD MOMSN=25011231
2025-05-27T22:55:24.923Z,1748386524.923 [DataOverHttps](INFO): Sending 182 bytes from file Logs/20250527T215211/Express0020.lzma
2025-05-27T22:55:25.924Z,1748386525.924 [DataOverHttps](INFO): Moved sent file to Logs/20250527T215211/Express0020.lzma.bak
2025-05-27T22:55:25.924Z,1748386525.924 [DataOverHttps](INFO): SBD MOMSN=25011234
2025-05-27T22:55:28.073Z,1748386528.073 [Default:CheckIn:Read_Iridium] Stopped
2025-05-27T22:55:28.073Z,1748386528.073 [Default:CheckIn:C.Wait] Running Loop=1
2025-05-27T22:55:28.073Z,1748386528.073 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-05-27T22:55:44.647Z,1748386544.647 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 21
2025-05-27T22:55:44.647Z,1748386544.647 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:55:44.648Z,1748386544.648 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 21
2025-05-27T22:55:44.648Z,1748386544.648 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-27T22:55:44.667Z,1748386544.667 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:55:44.668Z,1748386544.668 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-27T22:55:45.072Z,1748386545.072 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:55:45.072Z,1748386545.072 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 21
2025-05-27T22:55:45.073Z,1748386545.073 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-27T22:55:45.073Z,1748386545.073 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 21
2025-05-27T22:58:14.943Z,1748386694.943 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-05-27T22:58:14.943Z,1748386694.943 [NAL9602] Data Fault, FailCount= 1
2025-05-27T22:58:14.944Z,1748386694.944 [NAL9602](ERROR): Data Fault
2025-05-27T22:58:14.960Z,1748386694.960 [CBIT](ERROR): Data Fault in component: NAL9602
2025-05-27T22:58:15.320Z,1748386695.320 [NAL9602](INFO): Powering down
2025-05-27T22:58:16.146Z,1748386696.146 [CBIT](INFO): Clearing failed state for component NAL9602
2025-05-27T22:58:16.146Z,1748386696.146 [NAL9602] No Fault, FailCount= 1
2025-05-27T22:58:45.631Z,1748386725.631 [NAL9602](INFO): Powering up NAL9602
2025-05-27T22:58:45.685Z,1748386725.685 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 22
2025-05-27T22:58:45.685Z,1748386725.685 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:58:45.711Z,1748386725.711 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 22
2025-05-27T22:58:45.712Z,1748386725.712 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-27T22:58:45.746Z,1748386725.746 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:58:45.747Z,1748386725.747 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-27T22:58:46.080Z,1748386726.080 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:58:46.080Z,1748386726.080 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 22
2025-05-27T22:58:46.081Z,1748386726.081 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-27T22:58:46.081Z,1748386726.081 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 22
2025-05-27T22:58:56.552Z,1748386736.552 [NAL9602](INFO): NAL9602 initialized
2025-05-27T23:00:28.669Z,1748386828.669 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-05-27T23:00:28.669Z,1748386828.669 [Default:CheckIn:C.Wait] Stopped
2025-05-27T23:00:28.669Z,1748386828.669 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-05-27T23:00:28.669Z,1748386828.669 [Default:CheckIn:D] Running Loop=1
2025-05-27T23:00:29.080Z,1748386829.080 [Default:CheckIn:D] Stopped
2025-05-27T23:00:29.080Z,1748386829.080 [Default:CheckIn:E] Running Loop=1
2025-05-27T23:00:29.533Z,1748386829.533 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 64.508651 min
2025-05-27T23:00:29.533Z,1748386829.533 [Default:CheckIn:E] Stopped
2025-05-27T23:00:29.538Z,1748386829.538 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-05-27T23:00:29.538Z,1748386829.538 [Default:CheckIn] Stopped
2025-05-27T23:00:29.538Z,1748386829.538 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-05-27T23:00:29.538Z,1748386829.538 [Default:CheckIn](INFO): Running loop #7
2025-05-27T23:00:29.538Z,1748386829.538 [Default:CheckIn] Running Loop=7
2025-05-27T23:00:29.538Z,1748386829.538 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-27T23:00:29.538Z,1748386829.538 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-27T23:01:46.681Z,1748386906.681 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 23
2025-05-27T23:01:46.681Z,1748386906.681 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T23:01:46.682Z,1748386906.682 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 23
2025-05-27T23:01:46.682Z,1748386906.682 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-27T23:01:46.693Z,1748386906.693 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T23:01:46.693Z,1748386906.693 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-27T23:01:47.069Z,1748386907.069 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T23:01:47.069Z,1748386907.069 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 23
2025-05-27T23:01:47.086Z,1748386907.086 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-27T23:01:47.086Z,1748386907.086 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 23
2025-05-27T23:02:10.077Z,1748386930.077 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-05-27T23:02:16.137Z,1748386936.137 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-05-27T23:02:25.428Z,1748386945.428 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-05-27T23:02:28.660Z,1748386948.660 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-05-27T23:02:41.241Z,1748386961.241 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-05-27T23:02:41.589Z,1748386961.589 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-05-27T23:02:53.719Z,1748386973.719 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-05-27T23:02:53.738Z,1748386973.738 [RDI_Pathfinder](ERROR): only read 3 of 4 data items for beam range. Device response is::RA, 0.00, 0.00, 0.00, 0.00
2025-05-27T23:02:56.542Z,1748386976.542 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-05-27T23:03:05.829Z,1748386985.829 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-05-27T23:03:11.889Z,1748386991.889 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-05-27T23:03:17.948Z,1748386997.948 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-05-27T23:03:27.241Z,1748387007.241 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-05-27T23:03:30.069Z,1748387010.069 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-05-27T23:03:42.593Z,1748387022.593 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-05-27T23:03:43.010Z,1748387023.010 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-05-27T23:03:55.924Z,1748387035.924 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-05-27T23:03:57.944Z,1748387037.944 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-05-27T23:04:08.448Z,1748387048.448 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-05-27T23:04:12.893Z,1748387052.893 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-05-27T23:04:20.164Z,1748387060.164 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-05-27T23:04:27.840Z,1748387067.840 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-05-27T23:04:32.285Z,1748387072.285 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-05-27T23:04:48.077Z,1748387088.077 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 24
2025-05-27T23:04:48.077Z,1748387088.077 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T23:04:48.078Z,1748387088.078 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 24
2025-05-27T23:04:48.078Z,1748387088.078 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-27T23:04:48.102Z,1748387088.102 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T23:04:48.103Z,1748387088.103 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-27T23:04:48.479Z,1748387088.479 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T23:04:48.479Z,1748387088.479 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 24
2025-05-27T23:04:48.479Z,1748387088.479 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-27T23:04:48.479Z,1748387088.479 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 24
2025-05-27T23:05:29.737Z,1748387129.737 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-05-27T23:00:29.5Z
2025-05-27T23:05:29.737Z,1748387129.737 [Default:CheckIn:Read_GPS] Stopped
2025-05-27T23:05:29.737Z,1748387129.737 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-05-27T23:05:37.954Z,1748387137.954 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250527T215211/Courier0022.lzma
2025-05-27T23:05:38.956Z,1748387138.956 [DataOverHttps](INFO): Moved sent file to Logs/20250527T215211/Courier0022.lzma.bak
2025-05-27T23:05:38.956Z,1748387138.956 [DataOverHttps](INFO): SBD MOMSN=25011314
2025-05-27T23:05:55.387Z,1748387155.387 [DataOverHttps](INFO): Sending 169 bytes from file Logs/20250527T215211/Express0023.lzma
2025-05-27T23:05:56.388Z,1748387156.388 [DataOverHttps](INFO): Moved sent file to Logs/20250527T215211/Express0023.lzma.bak
2025-05-27T23:05:56.388Z,1748387156.388 [DataOverHttps](INFO): SBD MOMSN=25011318
2025-05-27T23:05:58.616Z,1748387158.616 [Default:CheckIn:Read_Iridium] Stopped
2025-05-27T23:05:58.616Z,1748387158.616 [Default:CheckIn:C.Wait] Running Loop=1
2025-05-27T23:05:58.616Z,1748387158.616 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-05-27T23:07:04.753Z,1748387224.753 [BPC1](INFO): Calculating totals. Valid battery stick count: 53. Valid reserve battery stick count: 5.
2025-05-27T23:07:04.760Z,1748387224.760 [BPC1](INFO): Received data from all battery sticks.
2025-05-27T23:07:49.185Z,1748387269.185 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 25
2025-05-27T23:07:49.185Z,1748387269.185 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T23:07:49.187Z,1748387269.187 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 25
2025-05-27T23:07:49.187Z,1748387269.187 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-27T23:07:49.197Z,1748387269.197 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T23:07:49.198Z,1748387269.198 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-27T23:07:49.667Z,1748387269.667 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T23:07:49.667Z,1748387269.667 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 25
2025-05-27T23:07:49.667Z,1748387269.667 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-27T23:07:49.668Z,1748387269.668 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 25
2025-05-27T23:08:57.443Z,1748387337.443 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-05-27T23:08:57.443Z,1748387337.443 [NAL9602] Data Fault, FailCount= 2
2025-05-27T23:08:57.443Z,1748387337.443 [NAL9602](ERROR): Data Fault
2025-05-27T23:08:57.536Z,1748387337.536 [CBIT](ERROR): Data Fault in component: NAL9602
2025-05-27T23:08:57.846Z,1748387337.846 [NAL9602](INFO): Powering down
2025-05-27T23:08:58.691Z,1748387338.691 [CBIT](INFO): Clearing failed state for component NAL9602
2025-05-27T23:08:58.691Z,1748387338.691 [NAL9602] No Fault, FailCount= 2
2025-05-27T23:09:28.155Z,1748387368.155 [NAL9602](INFO): Powering up NAL9602
2025-05-27T23:09:39.080Z,1748387379.080 [NAL9602](INFO): NAL9602 initialized
2025-05-27T23:10:16.146Z,1748387416.146 [CommandExec](IMPORTANT): got command get Onboard.Pressure pound_per_square_inch
2025-05-27T23:10:16.147Z,1748387416.147 [CommandExec](IMPORTANT): Onboard.Pressure 9.582992 psi
2025-05-27T23:10:16.147Z,1748387416.147 [CommandExec](IMPORTANT): got command get Onboard.Temperature
2025-05-27T23:10:16.147Z,1748387416.147 [CommandExec](IMPORTANT): Onboard.Temperature 22.768885 degC
2025-05-27T23:10:50.180Z,1748387450.180 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 26
2025-05-27T23:10:50.180Z,1748387450.180 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T23:10:50.182Z,1748387450.182 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 26
2025-05-27T23:10:50.182Z,1748387450.182 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-27T23:10:50.194Z,1748387450.194 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T23:10:50.194Z,1748387450.194 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-27T23:10:50.612Z,1748387450.612 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T23:10:50.612Z,1748387450.612 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 26
2025-05-27T23:10:50.613Z,1748387450.613 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-27T23:10:50.613Z,1748387450.613 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 26
2025-05-27T23:10:59.065Z,1748387459.065 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-05-27T23:10:59.065Z,1748387459.065 [Default:CheckIn:C.Wait] Stopped
2025-05-27T23:10:59.065Z,1748387459.065 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-05-27T23:10:59.065Z,1748387459.065 [Default:CheckIn:D] Running Loop=1
2025-05-27T23:10:59.493Z,1748387459.493 [Default:CheckIn:D] Stopped
2025-05-27T23:10:59.493Z,1748387459.493 [Default:CheckIn:E] Running Loop=1
2025-05-27T23:10:59.898Z,1748387459.898 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 75.015511 min
2025-05-27T23:10:59.898Z,1748387459.898 [Default:CheckIn:E] Stopped
2025-05-27T23:10:59.898Z,1748387459.898 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-05-27T23:10:59.898Z,1748387459.898 [Default:CheckIn] Stopped
2025-05-27T23:10:59.898Z,1748387459.898 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-05-27T23:10:59.898Z,1748387459.898 [Default:CheckIn](INFO): Running loop #8
2025-05-27T23:10:59.898Z,1748387459.898 [Default:CheckIn] Running Loop=8
2025-05-27T23:10:59.899Z,1748387459.899 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-27T23:10:59.899Z,1748387459.899 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-27T23:13:51.195Z,1748387631.195 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 27
2025-05-27T23:13:51.195Z,1748387631.195 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T23:13:51.196Z,1748387631.196 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 27
2025-05-27T23:13:51.196Z,1748387631.196 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-27T23:13:51.212Z,1748387631.212 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T23:13:51.213Z,1748387631.213 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-27T23:13:51.621Z,1748387631.621 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T23:13:51.621Z,1748387631.621 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 27
2025-05-27T23:13:51.626Z,1748387631.626 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-27T23:13:51.626Z,1748387631.626 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 27
2025-05-27T23:16:00.061Z,1748387760.061 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-05-27T23:10:59.9Z
2025-05-27T23:16:00.061Z,1748387760.061 [Default:CheckIn:Read_GPS] Stopped
2025-05-27T23:16:00.061Z,1748387760.061 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-05-27T23:16:07.573Z,1748387767.573 [DataOverHttps](INFO): Sending 50 bytes from file Logs/20250527T215211/Courier0025.lzma
2025-05-27T23:16:08.576Z,1748387768.576 [DataOverHttps](INFO): Moved sent file to Logs/20250527T215211/Courier0025.lzma.bak
2025-05-27T23:16:08.576Z,1748387768.576 [DataOverHttps](INFO): SBD MOMSN=25011397
2025-05-27T23:16:25.739Z,1748387785.739 [DataOverHttps](INFO): Sending 285 bytes from file Logs/20250527T215211/Express0026.lzma
2025-05-27T23:16:26.812Z,1748387786.812 [DataOverHttps](INFO): Moved sent file to Logs/20250527T215211/Express0026.lzma.bak
2025-05-27T23:16:26.812Z,1748387786.812 [DataOverHttps](INFO): SBD MOMSN=25011399
2025-05-27T23:16:28.886Z,1748387788.886 [Default:CheckIn:Read_Iridium] Stopped
2025-05-27T23:16:28.886Z,1748387788.886 [Default:CheckIn:C.Wait] Running Loop=1
2025-05-27T23:16:28.886Z,1748387788.886 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-05-27T23:16:52.297Z,1748387812.297 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 28
2025-05-27T23:16:52.297Z,1748387812.297 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T23:16:52.299Z,1748387812.299 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 28
2025-05-27T23:16:52.299Z,1748387812.299 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-27T23:16:52.354Z,1748387812.354 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T23:16:52.355Z,1748387812.355 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-27T23:16:52.740Z,1748387812.740 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T23:16:52.740Z,1748387812.740 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 28
2025-05-27T23:16:52.740Z,1748387812.740 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-27T23:16:52.740Z,1748387812.740 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 28
2025-05-27T23:19:39.950Z,1748387979.950 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-05-27T23:19:39.950Z,1748387979.950 [NAL9602] Data Fault, FailCount= 3
2025-05-27T23:19:39.950Z,1748387979.950 [NAL9602](ERROR): Data Fault
2025-05-27T23:19:39.967Z,1748387979.967 [CBIT](ERROR): Data Fault in component: NAL9602
2025-05-27T23:19:40.353Z,1748387980.353 [NAL9602](INFO): Powering down
2025-05-27T23:19:41.206Z,1748387981.206 [CBIT](INFO): Clearing failed state for component NAL9602
2025-05-27T23:19:41.206Z,1748387981.206 [NAL9602] No Fault, FailCount= 3
2025-05-27T23:19:53.288Z,1748387993.288 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 29
2025-05-27T23:19:53.288Z,1748387993.288 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T23:19:53.290Z,1748387993.290 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 29
2025-05-27T23:19:53.290Z,1748387993.290 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-27T23:19:53.301Z,1748387993.301 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T23:19:53.301Z,1748387993.301 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-27T23:19:53.763Z,1748387993.763 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T23:19:53.763Z,1748387993.763 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 29
2025-05-27T23:19:53.764Z,1748387993.764 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-27T23:19:53.764Z,1748387993.764 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 29
2025-05-27T23:20:10.654Z,1748388010.654 [NAL9602](INFO): Powering up NAL9602
2025-05-27T23:20:21.575Z,1748388021.575 [NAL9602](INFO): NAL9602 initialized
2025-05-27T23:21:29.487Z,1748388089.487 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-05-27T23:21:29.487Z,1748388089.487 [Default:CheckIn:C.Wait] Stopped
2025-05-27T23:21:29.487Z,1748388089.487 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-05-27T23:21:29.487Z,1748388089.487 [Default:CheckIn:D] Running Loop=1
2025-05-27T23:21:29.887Z,1748388089.887 [Default:CheckIn:D] Stopped
2025-05-27T23:21:29.888Z,1748388089.888 [Default:CheckIn:E] Running Loop=1
2025-05-27T23:21:30.269Z,1748388090.269 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 85.522103 min
2025-05-27T23:21:30.269Z,1748388090.269 [Default:CheckIn:E] Stopped
2025-05-27T23:21:30.269Z,1748388090.269 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-05-27T23:21:30.270Z,1748388090.270 [Default:CheckIn] Stopped
2025-05-27T23:21:30.270Z,1748388090.270 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-05-27T23:21:30.270Z,1748388090.270 [Default:CheckIn](INFO): Running loop #9
2025-05-27T23:21:30.270Z,1748388090.270 [Default:CheckIn] Running Loop=9
2025-05-27T23:21:30.270Z,1748388090.270 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-27T23:21:30.270Z,1748388090.270 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-27T23:22:19.553Z,1748388139.553 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error. Device response is::TS,000223004208 +14.5, 0.0,1505.2, 0
2025-05-27T23:22:28.421Z,1748388148.421 [DropWeight](CRITICAL): DROP WEIGHT MISSING.
2025-05-27T23:22:28.421Z,1748388148.421 [DropWeight] Hardware Fault, FailCount= 1
2025-05-27T23:22:28.421Z,1748388148.421 [DropWeight](ERROR): Hardware Fault
2025-05-27T23:22:28.499Z,1748388148.499 [CBIT](INFO): Critical error at 20250527T232228
2025-05-27T23:22:28.514Z,1748388148.514 [CBIT](ERROR): Hardware Fault in component: DropWeight
2025-05-27T23:22:28.514Z,1748388148.514 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2025-05-27T23:22:28.849Z,1748388148.849 [CBIT](INFO): Critical error at 20250527T232228
2025-05-27T23:22:29.636Z,1748388149.636 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error. Device response is::TS,00022300421877,35.0, +14.5, 0.0,1505
2025-05-27T23:22:54.299Z,1748388174.299 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 30
2025-05-27T23:22:54.299Z,1748388174.299 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T23:22:54.301Z,1748388174.301 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 30
2025-05-27T23:22:54.301Z,1748388174.301 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-05-27T23:22:54.339Z,1748388174.339 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T23:22:54.339Z,1748388174.339 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-05-27T23:22:54.719Z,1748388174.719 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T23:22:54.719Z,1748388174.719 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 30
2025-05-27T23:22:54.720Z,1748388174.720 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-05-27T23:22:54.720Z,1748388174.720 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 30
2025-05-27T23:25:30.766Z,1748388330.766 [CommandExec](IMPORTANT): got command get Onboard.Pressure pound_per_square_inch
2025-05-27T23:25:30.767Z,1748388330.767 [CommandExec](IMPORTANT): Onboard.Pressure 9.540851 psi
2025-05-27T23:25:30.767Z,1748388330.767 [CommandExec](IMPORTANT): got command get Onboard.Temperature
2025-05-27T23:25:30.767Z,1748388330.767 [CommandExec](IMPORTANT): Onboard.Temperature 21.358820 degC