2025-04-25T22:33:32.303Z,1745620412.303 [Supervisor](DEBUG): Initializing supervisor.
2025-04-25T22:33:32.308Z,1745620412.308 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2025-04-25T22:33:32.308Z,1745620412.308 [SyncHandler](INFO): Protected caller Thread ID is 834
2025-04-25T22:33:32.309Z,1745620412.309 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2025-04-25T22:33:32.310Z,1745620412.310 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2025-04-25T22:33:32.310Z,1745620412.310 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 835
2025-04-25T22:33:32.314Z,1745620412.314 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2025-04-25T22:33:32.334Z,1745620412.334 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2025-04-25T22:33:32.335Z,1745620412.335 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2025-04-25T22:33:32.336Z,1745620412.336 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 836
2025-04-25T22:33:32.340Z,1745620412.340 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2025-04-25T22:33:32.341Z,1745620412.341 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2025-04-25T22:33:32.341Z,1745620412.341 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 837
2025-04-25T22:33:32.343Z,1745620412.343 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2025-04-25T22:33:32.344Z,1745620412.344 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2025-04-25T22:33:32.345Z,1745620412.345 [logger ThreadHandler](INFO): Protected caller Thread ID is 838
2025-04-25T22:33:32.349Z,1745620412.349 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2025-04-25T22:33:32.349Z,1745620412.349 [Supervisor](INFO): Looking for Config files in directory: Config/
2025-04-25T22:33:32.353Z,1745620412.353 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2025-04-25T22:33:32.702Z,1745620412.702 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2025-04-25T22:33:32.703Z,1745620412.703 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2025-04-25T22:33:32.983Z,1745620412.983 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2025-04-25T22:33:32.984Z,1745620412.984 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2025-04-25T22:33:33.579Z,1745620413.579 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2025-04-25T22:33:33.581Z,1745620413.581 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2025-04-25T22:33:33.829Z,1745620413.829 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2025-04-25T22:33:33.830Z,1745620413.830 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2025-04-25T22:33:34.065Z,1745620414.065 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2025-04-25T22:33:34.066Z,1745620414.066 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2025-04-25T22:33:34.891Z,1745620414.891 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2025-04-25T22:33:34.893Z,1745620414.893 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2025-04-25T22:33:35.252Z,1745620415.252 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2025-04-25T22:33:35.253Z,1745620415.253 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2025-04-25T22:33:35.375Z,1745620415.375 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2025-04-25T22:33:35.376Z,1745620415.376 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2025-04-25T22:33:35.466Z,1745620415.466 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2025-04-25T22:33:36.082Z,1745620416.082 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2025-04-25T22:33:36.082Z,1745620416.082 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2025-04-25T22:33:36.420Z,1745620416.420 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2025-04-25T22:33:36.421Z,1745620416.421 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2025-04-25T22:33:36.655Z,1745620416.655 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2025-04-25T22:33:36.656Z,1745620416.656 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2025-04-25T22:33:36.806Z,1745620416.806 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2025-04-25T22:33:36.806Z,1745620416.806 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2025-04-25T22:33:36.898Z,1745620416.898 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2025-04-25T22:33:37.339Z,1745620417.339 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2025-04-25T22:33:37.340Z,1745620417.340 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2025-04-25T22:33:37.913Z,1745620417.913 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2025-04-25T22:33:37.915Z,1745620417.915 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-opah/
2025-04-25T22:33:37.919Z,1745620417.919 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Science.cfg
2025-04-25T22:33:38.033Z,1745620418.033 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Battery.cfg
2025-04-25T22:33:38.310Z,1745620418.310 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2025-04-25T22:33:38.310Z,1745620418.310 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Navigation.cfg
2025-04-25T22:33:38.425Z,1745620418.425 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/vehicle.cfg
2025-04-25T22:33:38.533Z,1745620418.533 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/BIT.cfg
2025-04-25T22:33:38.654Z,1745620418.654 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Sensor.cfg
2025-04-25T22:33:38.797Z,1745620418.797 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Control.cfg
2025-04-25T22:33:38.905Z,1745620418.905 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/logger.cfg
2025-04-25T22:33:39.024Z,1745620419.024 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/secure.cfg
2025-04-25T22:33:39.118Z,1745620419.118 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Servo.cfg
2025-04-25T22:33:39.237Z,1745620419.237 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Simulator.cfg
2025-04-25T22:33:39.333Z,1745620419.333 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-opah/root/
2025-04-25T22:33:39.334Z,1745620419.334 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2025-04-25T22:33:39.343Z,1745620419.343 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2025-04-25T22:33:39.359Z,1745620419.359 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2025-04-25T22:33:39.360Z,1745620419.360 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2025-04-25T22:33:39.500Z,1745620419.500 [DeadReckonUsingMultipleVelocitySources] Loaded
2025-04-25T22:33:39.501Z,1745620419.501 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2025-04-25T22:33:39.541Z,1745620419.541 [DeadReckonWithRespectToSeafloor] Loaded
2025-04-25T22:33:39.541Z,1745620419.541 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2025-04-25T22:33:39.554Z,1745620419.554 [NavChart] Loaded
2025-04-25T22:33:39.554Z,1745620419.554 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2025-04-25T22:33:39.560Z,1745620419.560 [UniversalFixResidualReporter] Loaded
2025-04-25T22:33:39.560Z,1745620419.560 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2025-04-25T22:33:39.561Z,1745620419.561 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2025-04-25T22:33:39.561Z,1745620419.561 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2025-04-25T22:33:40.419Z,1745620420.419 [AHRS_M2] Loaded
2025-04-25T22:33:40.419Z,1745620420.419 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2025-04-25T22:33:40.672Z,1745620420.672 [BackseatComponent](INFO): Found secondary power supply at: /dev/loadC3
2025-04-25T22:33:40.673Z,1745620420.673 [BackseatComponent] Loaded
2025-04-25T22:33:40.673Z,1745620420.673 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2025-04-25T22:33:40.674Z,1745620420.674 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4085D4E0
2025-04-25T22:33:40.675Z,1745620420.675 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 921
2025-04-25T22:33:40.677Z,1745620420.677 [LcmUniversalReporter] Loaded
2025-04-25T22:33:40.678Z,1745620420.678 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2025-04-25T22:33:40.772Z,1745620420.772 [DAT] Loaded
2025-04-25T22:33:40.772Z,1745620420.772 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2025-04-25T22:33:40.773Z,1745620420.773 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 4088D4E0
2025-04-25T22:33:40.774Z,1745620420.774 [DAT ThreadHandler](INFO): Protected caller Thread ID is 922
2025-04-25T22:33:40.915Z,1745620420.915 [DataOverHttps] Loaded
2025-04-25T22:33:40.915Z,1745620420.915 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2025-04-25T22:33:40.916Z,1745620420.916 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408BD4E0
2025-04-25T22:33:40.917Z,1745620420.917 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 923
2025-04-25T22:33:40.938Z,1745620420.938 [DepthKeller33X] Loaded
2025-04-25T22:33:40.938Z,1745620420.938 [ComponentRegistry](DEBUG): SyncComponent "DepthKeller33X" handled in the control thread.
2025-04-25T22:33:41.042Z,1745620421.042 [NAL9602] Loaded
2025-04-25T22:33:41.042Z,1745620421.042 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2025-04-25T22:33:41.075Z,1745620421.075 [Onboard] Loaded
2025-04-25T22:33:41.075Z,1745620421.075 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2025-04-25T22:33:41.076Z,1745620421.076 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408ED4E0
2025-04-25T22:33:41.077Z,1745620421.077 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 925
2025-04-25T22:33:41.090Z,1745620421.090 [Power24vConverter] Loaded
2025-04-25T22:33:41.091Z,1745620421.091 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2025-04-25T22:33:41.107Z,1745620421.107 [Radio_Surface] Loaded
2025-04-25T22:33:41.108Z,1745620421.108 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2025-04-25T22:33:41.109Z,1745620421.109 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4091D4E0
2025-04-25T22:33:41.109Z,1745620421.109 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 926
2025-04-25T22:33:41.155Z,1745620421.155 [RDI_Pathfinder] Loaded
2025-04-25T22:33:41.155Z,1745620421.155 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2025-04-25T22:33:41.156Z,1745620421.156 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2025-04-25T22:33:41.157Z,1745620421.157 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2025-04-25T22:33:41.678Z,1745620421.678 [DepthRateCalculator] Loaded
2025-04-25T22:33:41.679Z,1745620421.679 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2025-04-25T22:33:41.696Z,1745620421.696 [PitchRateCalculator] Loaded
2025-04-25T22:33:41.696Z,1745620421.696 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2025-04-25T22:33:41.714Z,1745620421.714 [SpeedCalculator] Loaded
2025-04-25T22:33:41.714Z,1745620421.714 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2025-04-25T22:33:41.719Z,1745620421.719 [YawRateCalculator] Loaded
2025-04-25T22:33:41.719Z,1745620421.719 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2025-04-25T22:33:41.825Z,1745620421.825 [ElevatorOffsetCalculator] Loaded
2025-04-25T22:33:41.825Z,1745620421.825 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2025-04-25T22:33:41.826Z,1745620421.826 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2025-04-25T22:33:41.826Z,1745620421.826 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2025-04-25T22:33:42.136Z,1745620422.136 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2025-04-25T22:33:42.137Z,1745620422.137 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2025-04-25T22:33:42.306Z,1745620422.306 [BuoyancyServo] Loaded
2025-04-25T22:33:42.306Z,1745620422.306 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2025-04-25T22:33:42.330Z,1745620422.330 [ElevatorServo] Loaded
2025-04-25T22:33:42.330Z,1745620422.330 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2025-04-25T22:33:42.353Z,1745620422.353 [MassServo] Loaded
2025-04-25T22:33:42.354Z,1745620422.354 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2025-04-25T22:33:42.376Z,1745620422.376 [RudderServo] Loaded
2025-04-25T22:33:42.376Z,1745620422.376 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2025-04-25T22:33:42.395Z,1745620422.395 [ThrusterHE] Loaded
2025-04-25T22:33:42.395Z,1745620422.395 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2025-04-25T22:33:42.395Z,1745620422.395 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2025-04-25T22:33:42.396Z,1745620422.396 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2025-04-25T22:33:42.615Z,1745620422.615 [CTD_Seabird] Loaded
2025-04-25T22:33:42.616Z,1745620422.616 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2025-04-25T22:33:42.617Z,1745620422.617 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A4E4E0
2025-04-25T22:33:42.617Z,1745620422.617 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 927
2025-04-25T22:33:42.618Z,1745620422.618 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2025-04-25T22:33:42.619Z,1745620422.619 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2025-04-25T22:33:42.784Z,1745620422.784 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2025-04-25T22:33:42.784Z,1745620422.784 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2025-04-25T22:33:43.005Z,1745620423.005 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2025-04-25T22:33:43.006Z,1745620423.006 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2025-04-25T22:33:43.422Z,1745620423.422 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2025-04-25T22:33:43.423Z,1745620423.423 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2025-04-25T22:33:43.495Z,1745620423.495 [VerticalControl](DEBUG): Construct VerticalControl.
2025-04-25T22:33:43.547Z,1745620423.547 [VerticalControl] Loaded
2025-04-25T22:33:43.548Z,1745620423.548 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2025-04-25T22:33:43.551Z,1745620423.551 [HorizontalControl](DEBUG): Construct HorizontalControl.
2025-04-25T22:33:43.597Z,1745620423.597 [HorizontalControl] Loaded
2025-04-25T22:33:43.597Z,1745620423.597 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2025-04-25T22:33:43.600Z,1745620423.600 [SpeedControl](DEBUG): Construct SpeedControl.
2025-04-25T22:33:43.601Z,1745620423.601 [SpeedControl] Loaded
2025-04-25T22:33:43.602Z,1745620423.602 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2025-04-25T22:33:43.604Z,1745620423.604 [LoopControl](DEBUG): Construct LoopControl.
2025-04-25T22:33:43.605Z,1745620423.605 [LoopControl] Loaded
2025-04-25T22:33:43.605Z,1745620423.605 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2025-04-25T22:33:43.605Z,1745620423.605 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2025-04-25T22:33:43.606Z,1745620423.606 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2025-04-25T22:33:43.806Z,1745620423.806 [SBIT](DEBUG): Construct Startup Built In Test.
2025-04-25T22:33:43.816Z,1745620423.816 [SBIT] Loaded
2025-04-25T22:33:43.816Z,1745620423.816 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2025-04-25T22:33:43.819Z,1745620423.819 [IBIT](DEBUG): Construct Initiated Built In Test.
2025-04-25T22:33:43.832Z,1745620423.832 [IBIT] Loaded
2025-04-25T22:33:43.832Z,1745620423.832 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2025-04-25T22:33:43.838Z,1745620423.838 [CBIT](DEBUG): Construct Continuous Built In Test.
2025-04-25T22:33:44.039Z,1745620424.039 [CBIT] Loaded
2025-04-25T22:33:44.039Z,1745620424.039 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2025-04-25T22:33:44.071Z,1745620424.071 [GFScanner] Loaded
2025-04-25T22:33:44.071Z,1745620424.071 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread.
2025-04-25T22:33:44.072Z,1745620424.072 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2025-04-25T22:33:44.072Z,1745620424.072 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2025-04-25T22:33:44.121Z,1745620424.121 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2025-04-25T22:33:44.127Z,1745620424.127 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2025-04-25T22:33:44.130Z,1745620424.130 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2025-04-25T22:33:44.141Z,1745620424.141 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2025-04-25T22:33:44.142Z,1745620424.142 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C354E0
2025-04-25T22:33:44.142Z,1745620424.142 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 928
2025-04-25T22:33:44.147Z,1745620424.147 [Supervisor](INFO): Main Thread ID is 825
2025-04-25T22:33:44.147Z,1745620424.147 [Supervisor](DEBUG): Running supervisor.
2025-04-25T22:33:44.148Z,1745620424.148 [CommandExec ThreadHandler](INFO): Handler Thread ID is 929
2025-04-25T22:33:44.148Z,1745620424.148 [CommandExec](INFO): Initializing the command executive.
2025-04-25T22:33:44.150Z,1745620424.150 [CommandLine ThreadHandler](INFO): Handler Thread ID is 930
2025-04-25T22:33:44.152Z,1745620424.152 [controlThread ThreadHandler](INFO): Handler Thread ID is 931
2025-04-25T22:33:44.152Z,1745620424.152 [controlThread](DEBUG): Initializing ControlThread
2025-04-25T22:33:44.154Z,1745620424.154 [NavChart](DEBUG): Initialize NavChart Navigation.
2025-04-25T22:33:44.155Z,1745620424.155 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2025-04-25T22:33:44.156Z,1745620424.156 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2025-04-25T22:33:44.157Z,1745620424.157 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2025-04-25T22:33:44.157Z,1745620424.157 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2025-04-25T22:33:44.157Z,1745620424.157 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2025-04-25T22:33:44.158Z,1745620424.158 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2025-04-25T22:33:44.159Z,1745620424.159 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2025-04-25T22:33:44.161Z,1745620424.161 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2025-04-25T22:33:44.161Z,1745620424.161 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2025-04-25T22:33:44.162Z,1745620424.162 [LoopControl](DEBUG): Initialize LoopControlComponent.
2025-04-25T22:33:44.162Z,1745620424.162 [SBIT](INFO): Initialize SBIT Component.
2025-04-25T22:33:44.163Z,1745620424.163 [SBIT](IMPORTANT): git: 2025-04-24
2025-04-25T22:33:44.163Z,1745620424.163 [SBIT](INFO): git hash: ed8b2699e10264a13705e958152987274a27a0ee
2025-04-25T22:33:44.163Z,1745620424.163 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2025-04-25T22:33:44.164Z,1745620424.164 [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-04-25T22:33:44.165Z,1745620424.165 [SBIT](INFO): Beginning SBIT in 39.000000 seconds.
2025-04-25T22:33:44.166Z,1745620424.166 [IBIT](INFO): Initialize IBIT Component.
2025-04-25T22:33:44.167Z,1745620424.167 [CBIT](DEBUG): Initialize CBIT Component.
2025-04-25T22:33:44.167Z,1745620424.167 [logger ThreadHandler](INFO): Handler Thread ID is 932
2025-04-25T22:33:44.180Z,1745620424.180 [CBIT](DEBUG): Initialized mux pins.
2025-04-25T22:33:44.180Z,1745620424.180 [CBIT](DEBUG): Initializing the watchdog timer.
2025-04-25T22:33:44.188Z,1745620424.188 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 933
2025-04-25T22:33:44.204Z,1745620424.204 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2025-04-25T22:33:44.204Z,1745620424.204 [CBIT](DEBUG): Initializing heartbeat.
2025-04-25T22:33:44.205Z,1745620424.205 [DAT ThreadHandler](INFO): Handler Thread ID is 934
2025-04-25T22:33:44.206Z,1745620424.206 [DAT](INFO): Powering up
2025-04-25T22:33:44.206Z,1745620424.206 [DAT](DEBUG): Initializing DAT.
2025-04-25T22:33:44.209Z,1745620424.209 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 936
2025-04-25T22:33:44.211Z,1745620424.211 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2025-04-25T22:33:44.232Z,1745620424.232 [Onboard ThreadHandler](INFO): Handler Thread ID is 937
2025-04-25T22:33:44.250Z,1745620424.250 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 938
2025-04-25T22:33:44.265Z,1745620424.265 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 939
2025-04-25T22:33:44.265Z,1745620424.265 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2025-04-25T22:33:44.269Z,1745620424.269 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 941
2025-04-25T22:33:44.276Z,1745620424.276 [CBIT](DEBUG): Deactivating emergency mode.
2025-04-25T22:33:44.280Z,1745620424.280 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2025-04-25T22:33:44.281Z,1745620424.281 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2025-04-25T22:33:44.281Z,1745620424.281 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2025-04-25T22:33:44.281Z,1745620424.281 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2025-04-25T22:33:44.281Z,1745620424.281 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2025-04-25T22:33:44.281Z,1745620424.281 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2025-04-25T22:33:44.281Z,1745620424.281 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2025-04-25T22:33:44.281Z,1745620424.281 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2025-04-25T22:33:44.316Z,1745620424.316 [CBIT](DEBUG): Backplane powered.
2025-04-25T22:33:44.316Z,1745620424.316 [GFScanner](DEBUG): Initializing GFScanner
2025-04-25T22:33:44.316Z,1745620424.316 [GFScanner](DEBUG): Deactivating GF circuits.
2025-04-25T22:33:44.321Z,1745620424.321 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2025-04-25T22:33:44.322Z,1745620424.322 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2025-04-25T22:33:44.322Z,1745620424.322 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2025-04-25T22:33:44.327Z,1745620424.327 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2025-04-25T22:33:44.403Z,1745620424.403 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
2025-04-25T22:33:44.411Z,1745620424.411 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2025-04-25T22:33:44.447Z,1745620424.447 [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-04-25T22:33:44.462Z,1745620424.462 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2025-04-25T22:33:44.462Z,1745620424.462 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2025-04-25T22:33:44.476Z,1745620424.476 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2025-04-25T22:33:44.668Z,1745620424.668 [Radio_Surface](INFO): Powering up
2025-04-25T22:33:44.793Z,1745620424.793 [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-04-25T22:33:44.799Z,1745620424.799 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2025-04-25T22:33:44.816Z,1745620424.816 [Default:A.Wait](DEBUG): Construct Wait.
2025-04-25T22:33:44.828Z,1745620424.828 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2025-04-25T22:33:44.842Z,1745620424.842 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2025-04-25T22:33:44.864Z,1745620424.864 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2025-04-25T22:33:44.870Z,1745620424.870 [Default:E.Execute](DEBUG): Construct Execute.
2025-04-25T22:33:44.889Z,1745620424.889 [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-04-25T22:33:44.894Z,1745620424.894 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,DepthKeller33X,NAL9602,Power24vConverter,RDI_Pathfinder,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-04-25T22:33:44.917Z,1745620424.917 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2025-04-25T22:33:45.051Z,1745620425.051 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:33:45.068Z,1745620425.068 [Power24vConverter](INFO): Powering up.
2025-04-25T22:33:45.069Z,1745620425.069 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2025-04-25T22:33:45.077Z,1745620425.077 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-25T22:33:45.109Z,1745620425.109 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2025-04-25T22:33:45.116Z,1745620425.116 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2025-04-25T22:33:45.117Z,1745620425.117 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-04-25T22:33:45.124Z,1745620425.124 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-04-25T22:33:45.125Z,1745620425.125 [MassServo](DEBUG): Initializing EZServoServo.
2025-04-25T22:33:45.132Z,1745620425.132 [MassServo](DEBUG): Initializing MassServo.
2025-04-25T22:33:45.133Z,1745620425.133 [RudderServo](DEBUG): Initializing EZServoServo.
2025-04-25T22:33:45.140Z,1745620425.140 [RudderServo](DEBUG): Initializing RudderServo.
2025-04-25T22:33:45.141Z,1745620425.141 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-04-25T22:33:45.148Z,1745620425.148 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-04-25T22:33:45.352Z,1745620425.352 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-25T22:33:45.707Z,1745620425.707 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-25T22:33:46.113Z,1745620426.113 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-25T22:33:46.515Z,1745620426.515 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-25T22:33:46.941Z,1745620426.941 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-25T22:33:48.233Z,1745620428.233 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:33:48.233Z,1745620428.233 [Power24vConverter] Hardware Fault, FailCount= 1
2025-04-25T22:33:48.234Z,1745620428.234 [Power24vConverter](ERROR): Hardware Fault
2025-04-25T22:33:48.234Z,1745620428.234 [Power24vConverter](INFO): Powering down.
2025-04-25T22:33:48.235Z,1745620428.235 [Power24vConverter](FAULT): 24V Power is reporting not powering/powered.
2025-04-25T22:33:48.246Z,1745620428.246 [CBIT](ERROR): Hardware Fault in component: Power24vConverter
2025-04-25T22:33:48.601Z,1745620428.601 [Power24vConverter](INFO): Powering down.
2025-04-25T22:33:48.968Z,1745620428.968 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:33:49.443Z,1745620429.443 [Power24vConverter](INFO): Powering down.
2025-04-25T22:33:49.792Z,1745620429.792 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:33:50.205Z,1745620430.205 [Power24vConverter](INFO): Powering down.
2025-04-25T22:33:50.621Z,1745620430.621 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:33:50.657Z,1745620430.657 [ThrusterHE](ERROR): Zero Speed Commanded.
2025-04-25T22:33:51.029Z,1745620431.029 [Power24vConverter](INFO): Powering down.
2025-04-25T22:33:51.404Z,1745620431.404 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:33:51.808Z,1745620431.808 [Power24vConverter](INFO): Powering down.
2025-04-25T22:33:52.229Z,1745620432.229 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:33:52.633Z,1745620432.633 [Power24vConverter](INFO): Powering down.
2025-04-25T22:33:53.022Z,1745620433.022 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:33:53.418Z,1745620433.418 [Power24vConverter](INFO): Powering down.
2025-04-25T22:33:54.199Z,1745620434.199 [Power24vConverter](INFO): Powering up.
2025-04-25T22:33:54.291Z,1745620434.291 [CBIT](INFO): Clearing failed state for component Power24vConverter
2025-04-25T22:33:54.291Z,1745620434.291 [Power24vConverter] No Fault, FailCount= 1
2025-04-25T22:34:03.900Z,1745620443.900 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:03.900Z,1745620443.900 [Power24vConverter] Hardware Fault, FailCount= 1
2025-04-25T22:34:03.900Z,1745620443.900 [Power24vConverter](ERROR): Hardware Fault
2025-04-25T22:34:03.900Z,1745620443.900 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:03.901Z,1745620443.901 [Power24vConverter](FAULT): 24V Power is reporting not powering/powered.
2025-04-25T22:34:03.914Z,1745620443.914 [CBIT](ERROR): Hardware Fault in component: Power24vConverter
2025-04-25T22:34:04.313Z,1745620444.313 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:04.730Z,1745620444.730 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:05.138Z,1745620445.138 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:05.515Z,1745620445.515 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:05.919Z,1745620445.919 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:06.323Z,1745620446.323 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:06.727Z,1745620446.727 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:07.141Z,1745620447.141 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:07.557Z,1745620447.557 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:07.558Z,1745620447.558 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2025-04-25T22:34:07.558Z,1745620447.558 [RDI_Pathfinder] Communications Fault, FailCount= 1
2025-04-25T22:34:07.558Z,1745620447.558 [RDI_Pathfinder](ERROR): Communications Fault
2025-04-25T22:34:07.576Z,1745620447.576 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2025-04-25T22:34:07.961Z,1745620447.961 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:08.032Z,1745620448.032 [RDI_Pathfinder](INFO): Powering down
2025-04-25T22:34:08.339Z,1745620448.339 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:08.746Z,1745620448.746 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:08.759Z,1745620448.759 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2025-04-25T22:34:08.759Z,1745620448.759 [RDI_Pathfinder] No Fault, FailCount= 1
2025-04-25T22:34:09.148Z,1745620449.148 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:09.149Z,1745620449.149 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2025-04-25T22:34:09.565Z,1745620449.565 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:09.965Z,1745620449.965 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:10.377Z,1745620450.377 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:10.760Z,1745620450.760 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:11.166Z,1745620451.166 [NAL9602](INFO): Powering up NAL9602
2025-04-25T22:34:11.167Z,1745620451.167 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:11.571Z,1745620451.571 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:11.979Z,1745620451.979 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:12.394Z,1745620452.394 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:12.807Z,1745620452.807 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:13.185Z,1745620453.185 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:13.596Z,1745620453.596 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:13.995Z,1745620453.995 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:14.409Z,1745620454.409 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:14.829Z,1745620454.829 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:15.233Z,1745620455.233 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:15.645Z,1745620455.645 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:16.013Z,1745620456.013 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:16.418Z,1745620456.418 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:16.828Z,1745620456.828 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:17.227Z,1745620457.227 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:17.653Z,1745620457.653 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:18.057Z,1745620458.057 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:18.437Z,1745620458.437 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:18.843Z,1745620458.843 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:19.257Z,1745620459.257 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:19.669Z,1745620459.669 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:20.077Z,1745620460.077 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:20.456Z,1745620460.456 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:20.863Z,1745620460.863 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:21.270Z,1745620461.270 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:21.692Z,1745620461.692 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:21.889Z,1745620461.889 [CommandExec](IMPORTANT): got command strobe off
2025-04-25T22:34:21.889Z,1745620461.889 [CommandExec](IMPORTANT): Deactivating strobe
2025-04-25T22:34:22.098Z,1745620462.098 [NAL9602](INFO): NAL9602 initialized
2025-04-25T22:34:22.098Z,1745620462.098 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:22.478Z,1745620462.478 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:22.896Z,1745620462.896 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:23.305Z,1745620463.305 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:23.704Z,1745620463.704 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:23.727Z,1745620463.727 [SBIT](IMPORTANT): Beginning Startup BIT
2025-04-25T22:34:23.733Z,1745620463.733 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-04-25T22:34:24.105Z,1745620464.105 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:24.514Z,1745620464.514 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:24.926Z,1745620464.926 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:24.982Z,1745620464.982 [GFScanner](ERROR): Error reading 24V bus power status. Assuming off for scan purposes.
2025-04-25T22:34:25.334Z,1745620465.334 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:25.760Z,1745620465.760 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:26.181Z,1745620466.181 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:26.548Z,1745620466.548 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:26.942Z,1745620466.942 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:27.773Z,1745620467.773 [Power24vConverter](INFO): Powering up.
2025-04-25T22:34:27.871Z,1745620467.871 [CBIT](INFO): Clearing failed state for component Power24vConverter
2025-04-25T22:34:27.871Z,1745620467.871 [Power24vConverter] No Fault, FailCount= 1
2025-04-25T22:34:28.233Z,1745620468.233 [CommandExec](IMPORTANT): got command strobe off
2025-04-25T22:34:28.233Z,1745620468.233 [CommandExec](IMPORTANT): Deactivating strobe
2025-04-25T22:34:28.280Z,1745620468.280 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.003373
CHAN A1 (24V) N/A reporting off
CHAN A2 (12V): -0.000301
CHAN A3 (5V): -0.021898
CHAN B0 (3.3V): 0.000242
CHAN B1 (3.15aV): -0.000576
CHAN B2 (3.15bV): -0.000993
CHAN B3 (GND): -0.000010
OPEN: 0.004415
Full Scale: +/- 1 mA
2025-04-25T22:34:31.397Z,1745620471.397 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:31.397Z,1745620471.397 [Power24vConverter] Hardware Fault, FailCount= 1
2025-04-25T22:34:31.397Z,1745620471.397 [Power24vConverter](ERROR): Hardware Fault
2025-04-25T22:34:31.397Z,1745620471.397 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:31.398Z,1745620471.398 [Power24vConverter](FAULT): 24V Power is reporting not powering/powered.
2025-04-25T22:34:31.399Z,1745620471.399 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2025-04-25T22:34:31.399Z,1745620471.399 [RDI_Pathfinder] Communications Fault, FailCount= 2
2025-04-25T22:34:31.399Z,1745620471.399 [RDI_Pathfinder](ERROR): Communications Fault
2025-04-25T22:34:31.441Z,1745620471.441 [CBIT](ERROR): Hardware Fault in component: Power24vConverter
2025-04-25T22:34:31.441Z,1745620471.441 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2025-04-25T22:34:31.800Z,1745620471.800 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:31.872Z,1745620471.872 [RDI_Pathfinder](INFO): Powering down
2025-04-25T22:34:32.202Z,1745620472.202 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-25T22:34:32.605Z,1745620472.605 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:32.621Z,1745620472.621 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2025-04-25T22:34:32.621Z,1745620472.621 [RDI_Pathfinder] No Fault, FailCount= 2
2025-04-25T22:34:33.022Z,1745620473.022 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-25T22:34:33.022Z,1745620473.022 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2025-04-25T22:34:33.402Z,1745620473.402 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:33.806Z,1745620473.806 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-25T22:34:34.217Z,1745620474.217 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:34.626Z,1745620474.626 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-25T22:34:35.050Z,1745620475.050 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:35.450Z,1745620475.450 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-25T22:34:35.840Z,1745620475.840 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:36.248Z,1745620476.248 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-25T22:34:36.666Z,1745620476.666 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:37.060Z,1745620477.060 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-25T22:34:37.469Z,1745620477.469 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:37.874Z,1745620477.874 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-25T22:34:38.250Z,1745620478.250 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:38.656Z,1745620478.656 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-25T22:34:39.069Z,1745620479.069 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:39.535Z,1745620479.535 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-25T22:34:39.597Z,1745620479.597 [CommandExec](IMPORTANT): got command strobe off
2025-04-25T22:34:39.597Z,1745620479.597 [CommandExec](IMPORTANT): Deactivating strobe
2025-04-25T22:34:39.934Z,1745620479.934 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:40.346Z,1745620480.346 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-25T22:34:40.722Z,1745620480.722 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:41.544Z,1745620481.544 [Power24vConverter](INFO): Powering up.
2025-04-25T22:34:41.641Z,1745620481.641 [CBIT](INFO): Clearing failed state for component Power24vConverter
2025-04-25T22:34:41.641Z,1745620481.641 [Power24vConverter] No Fault, FailCount= 1
2025-04-25T22:34:44.216Z,1745620484.216 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2025-04-25T22:34:44.216Z,1745620484.216 [DAT] Communications Fault, FailCount= 1
2025-04-25T22:34:44.216Z,1745620484.216 [DAT](ERROR): Communications Fault
2025-04-25T22:34:44.620Z,1745620484.620 [DAT](INFO): Powering down
2025-04-25T22:34:44.672Z,1745620484.672 [CBIT](ERROR): Communications Fault in component: DAT
2025-04-25T22:34:45.613Z,1745620485.613 [CBIT](INFO): Clearing failed state for component DAT
2025-04-25T22:34:45.613Z,1745620485.613 [DAT] No Fault, FailCount= 1
2025-04-25T22:34:47.629Z,1745620487.629 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-25T22:34:47.629Z,1745620487.629 [Power24vConverter] Hardware Fault, FailCount= 1
2025-04-25T22:34:47.629Z,1745620487.629 [Power24vConverter](ERROR): Hardware Fault
2025-04-25T22:34:47.629Z,1745620487.629 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:47.629Z,1745620487.629 [Power24vConverter](FAULT): 24V Power is reporting not powering/powered.
2025-04-25T22:34:47.664Z,1745620487.664 [DAT](INFO): Powering up
2025-04-25T22:34:47.664Z,1745620487.664 [DAT](DEBUG): Initializing DAT.
2025-04-25T22:34:47.682Z,1745620487.682 [CBIT](ERROR): Hardware Fault in component: Power24vConverter
2025-04-25T22:34:47.993Z,1745620487.993 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:48.398Z,1745620488.398 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-25T22:34:48.804Z,1745620488.804 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:49.222Z,1745620489.222 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-25T22:34:49.501Z,1745620489.501 [CommandExec](IMPORTANT): got command strobe off
2025-04-25T22:34:49.501Z,1745620489.501 [CommandExec](IMPORTANT): Deactivating strobe
2025-04-25T22:34:49.625Z,1745620489.625 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:50.042Z,1745620490.042 [Power24vConverter](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-25T22:34:50.417Z,1745620490.417 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:51.229Z,1745620491.229 [Power24vConverter](INFO): Powering up.
2025-04-25T22:34:51.284Z,1745620491.284 [CBIT](INFO): Clearing failed state for component Power24vConverter
2025-04-25T22:34:51.284Z,1745620491.284 [Power24vConverter] No Fault, FailCount= 1
2025-04-25T22:34:54.862Z,1745620494.862 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:54.862Z,1745620494.862 [Power24vConverter] Hardware Fault, FailCount= 1
2025-04-25T22:34:54.862Z,1745620494.862 [Power24vConverter](ERROR): Hardware Fault
2025-04-25T22:34:54.862Z,1745620494.862 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:54.863Z,1745620494.863 [Power24vConverter](FAULT): 24V Power is reporting not powering/powered.
2025-04-25T22:34:54.913Z,1745620494.913 [CBIT](ERROR): Hardware Fault in component: Power24vConverter
2025-04-25T22:34:55.267Z,1745620495.267 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:55.268Z,1745620495.268 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2025-04-25T22:34:55.268Z,1745620495.268 [RDI_Pathfinder] Communications Fault, FailCount= 3
2025-04-25T22:34:55.268Z,1745620495.268 [RDI_Pathfinder](ERROR): Communications Fault
2025-04-25T22:34:55.313Z,1745620495.313 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2025-04-25T22:34:55.313Z,1745620495.313 [CBIT](CRITICAL): Communications Fault in component: RDI_Pathfinder
2025-04-25T22:34:55.672Z,1745620495.672 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:55.740Z,1745620495.740 [RDI_Pathfinder](INFO): Powering down
2025-04-25T22:34:55.875Z,1745620495.875 [CommandExec](FAULT): Scheduling is paused
2025-04-25T22:34:55.877Z,1745620495.877 [CBIT](INFO): Critical error at 20250425T223455
2025-04-25T22:34:55.877Z,1745620495.877 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2025-04-25T22:34:56.093Z,1745620496.093 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:56.506Z,1745620496.506 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:56.892Z,1745620496.892 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:57.300Z,1745620497.300 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:57.708Z,1745620497.708 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:58.120Z,1745620498.120 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:58.528Z,1745620498.528 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:58.942Z,1745620498.942 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:34:59.350Z,1745620499.350 [Power24vConverter](INFO): Powering down.
2025-04-25T22:34:59.711Z,1745620499.711 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:35:00.115Z,1745620500.115 [Power24vConverter](INFO): Powering down.
2025-04-25T22:35:00.530Z,1745620500.530 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:35:00.946Z,1745620500.946 [Power24vConverter](INFO): Powering down.
2025-04-25T22:35:01.354Z,1745620501.354 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:35:01.729Z,1745620501.729 [Power24vConverter](INFO): Powering down.
2025-04-25T22:35:02.148Z,1745620502.148 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:35:02.560Z,1745620502.560 [Power24vConverter](INFO): Powering down.
2025-04-25T22:35:02.958Z,1745620502.958 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:35:03.377Z,1745620503.377 [Power24vConverter](INFO): Powering down.
2025-04-25T22:35:03.774Z,1745620503.774 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:35:04.178Z,1745620504.178 [Power24vConverter](INFO): Powering down.
2025-04-25T22:35:04.559Z,1745620504.559 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:35:04.963Z,1745620504.963 [Power24vConverter](INFO): Powering down.
2025-04-25T22:35:05.367Z,1745620505.367 [CommandExec](IMPORTANT): got command strobe off
2025-04-25T22:35:05.367Z,1745620505.367 [CommandExec](IMPORTANT): Deactivating strobe
2025-04-25T22:35:05.370Z,1745620505.370 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:35:05.793Z,1745620505.793 [Power24vConverter](INFO): Powering down.
2025-04-25T22:35:06.200Z,1745620506.200 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:35:06.610Z,1745620506.610 [Power24vConverter](INFO): Powering down.
2025-04-25T22:35:07.025Z,1745620507.025 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2025-04-25T22:35:07.416Z,1745620507.416 [Power24vConverter](INFO): Powering down.
2025-04-25T22:35:08.224Z,1745620508.224 [Power24vConverter](INFO): Powering up.
2025-04-25T22:35:08.326Z,1745620508.326 [CBIT](INFO): Clearing failed state for component Power24vConverter
2025-04-25T22:35:08.326Z,1745620508.326 [Power24vConverter] No Fault, FailCount= 1
2025-04-25T22:35:17.525Z,1745620517.525 [SBIT](IMPORTANT): SBIT PASSED
2025-04-25T22:35:17.525Z,1745620517.525 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2025-04-25T22:35:17.526Z,1745620517.526 [SBIT](IMPORTANT): BPC1.loadAtStartup=0 bool;
2025-04-25T22:35:17.526Z,1745620517.526 [SBIT](IMPORTANT): DepthKeller33X.maxPressBound=2500 decibar;
2025-04-25T22:35:17.526Z,1745620517.526 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool;
2025-04-25T22:35:17.526Z,1745620517.526 [SBIT](IMPORTANT): GFScanner.simulateHardware=0 bool;
2025-04-25T22:35:17.526Z,1745620517.526 [SBIT](IMPORTANT): MassServo.limitLo=-700000 count;
2025-04-25T22:35:17.527Z,1745620517.527 [SBIT](IMPORTANT): VerticalControl.massPositionLimitAft=-5.5 centimeter;
2025-04-25T22:35:17.950Z,1745620517.950 [MissionManager](IMPORTANT): Started mission Startup
2025-04-25T22:35:17.951Z,1745620517.951 [Startup] Running Loop=1
2025-04-25T22:35:17.951Z,1745620517.951 [Startup](DEBUG): Aggregate::initialize Startup
2025-04-25T22:35:17.951Z,1745620517.951 [Startup:A.GoToSurface] Running Loop=1
2025-04-25T22:35:17.951Z,1745620517.951 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-04-25T22:35:17.952Z,1745620517.952 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-04-25T22:35:17.952Z,1745620517.952 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-04-25T22:35:17.952Z,1745620517.952 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-04-25T22:35:17.953Z,1745620517.953 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-04-25T22:35:17.953Z,1745620517.953 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-04-25T22:35:17.953Z,1745620517.953 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-04-25T22:35:17.955Z,1745620517.955 [Startup:StartupSatComms] Running Loop=1
2025-04-25T22:35:17.955Z,1745620517.955 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2025-04-25T22:35:17.955Z,1745620517.955 [Startup:StartupSatComms:A] Running Loop=1
2025-04-25T22:35:18.352Z,1745620518.352 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2025-04-25T22:35:35.967Z,1745620535.967 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005232
2025-04-25T22:35:47.782Z,1745620547.782 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2025-04-25T22:35:47.782Z,1745620547.782 [DAT] Communications Fault, FailCount= 2
2025-04-25T22:35:47.782Z,1745620547.782 [DAT](ERROR): Communications Fault
2025-04-25T22:35:47.793Z,1745620547.793 [CBIT](ERROR): Communications Fault in component: DAT
2025-04-25T22:35:48.186Z,1745620548.186 [DAT](INFO): Powering down
2025-04-25T22:35:48.663Z,1745620548.663 [DAT](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-25T22:35:48.663Z,1745620548.663 [DAT] Hardware Fault, FailCount= 2
2025-04-25T22:35:48.663Z,1745620548.663 [DAT](ERROR): Hardware Fault
2025-04-25T22:35:49.426Z,1745620549.426 [CBIT](INFO): Clearing failed state for component DAT
2025-04-25T22:35:49.426Z,1745620549.426 [DAT] No Fault, FailCount= 2
2025-04-25T22:35:51.246Z,1745620551.246 [DAT](INFO): Powering up
2025-04-25T22:35:51.246Z,1745620551.246 [DAT](DEBUG): Initializing DAT.
2025-04-25T22:36:02.610Z,1745620562.610 [DAT](INFO): DAT read:
2025-04-25T22:36:02.612Z,1745620562.612 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series
2025-04-25T22:36:04.123Z,1745620564.123 [DAT](INFO): DAT read: MF Frequency Band
2025-04-25T22:36:04.124Z,1745620564.124 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.14.0
2025-04-25T22:36:04.124Z,1745620564.124 [DAT](INFO): DAT read: Apr 25 2025 22:35:58
2025-04-25T22:36:05.131Z,1745620565.131 [DAT](INFO): DAT read: Features enabled [Bearing]
2025-04-25T22:36:05.132Z,1745620565.132 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
2025-04-25T22:36:05.133Z,1745620565.133 [DAT](INFO): commRate: 800
2025-04-25T22:36:07.214Z,1745620567.214 [DAT](INFO): entering command mode
2025-04-25T22:36:07.398Z,1745620567.398 [DAT](INFO): DAT read:
2025-04-25T22:36:07.399Z,1745620567.399 [DAT](INFO): DAT read: user:1>
2025-04-25T22:36:07.399Z,1745620567.399 [DAT](INFO): setting verbose to 3
2025-04-25T22:36:07.651Z,1745620567.651 [DAT](INFO): DAT read: user:1>
2025-04-25T22:36:07.652Z,1745620567.652 [DAT](INFO): DAT read: Verbose | 3
2025-04-25T22:36:07.652Z,1745620567.652 [DAT](INFO): set verbose to 3
2025-04-25T22:36:07.653Z,1745620567.653 [DAT](INFO): setting DatVerbose to 27440
2025-04-25T22:36:07.902Z,1745620567.902 [DAT](INFO): DAT read: user:2>
2025-04-25T22:36:07.903Z,1745620567.903 [DAT](INFO): DAT read: DatVerbose | 27440
2025-04-25T22:36:07.904Z,1745620567.904 [DAT](INFO): set DatVerbose to 27440
2025-04-25T22:36:07.904Z,1745620567.904 [DAT](INFO): setting transmit power to 8
2025-04-25T22:36:08.155Z,1745620568.155 [DAT](INFO): DAT read: user:3>
2025-04-25T22:36:08.156Z,1745620568.156 [DAT](INFO): DAT read: TxPower | 8 (Max)
2025-04-25T22:36:08.156Z,1745620568.156 [DAT](INFO): set transmit power to 8
2025-04-25T22:36:08.157Z,1745620568.157 [DAT](INFO): setting local address to 3
2025-04-25T22:36:08.406Z,1745620568.406 [DAT](INFO): DAT read: user:4>
2025-04-25T22:36:08.407Z,1745620568.407 [DAT](INFO): DAT read: LocalAddr | 3
2025-04-25T22:36:08.408Z,1745620568.408 [DAT](INFO): set local address to 3
2025-04-25T22:36:08.409Z,1745620568.409 [DAT](INFO): Setting time to: 22:36:8 And date to:4/25/2025
2025-04-25T22:36:08.659Z,1745620568.659 [DAT](INFO): DAT read: user:5>
2025-04-25T22:36:08.659Z,1745620568.659 [DAT](INFO): DAT read: Fri Apr 25, 2025 22:36:08
2025-04-25T22:36:08.660Z,1745620568.660 [DAT](INFO): Local DAT time set to Fri Apr 25, 2025 22:36:08
2025-04-25T22:36:18.075Z,1745620578.075 [Startup:StartupSatComms:A](INFO): Timed out from 2025-04-25T22:35:17.0Z
2025-04-25T22:36:18.075Z,1745620578.075 [Startup:StartupSatComms:A] Stopped
2025-04-25T22:36:18.075Z,1745620578.075 [Startup:StartupSatComms:B] Running Loop=1
2025-04-25T22:36:18.490Z,1745620578.490 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-04-25T22:36:25.409Z,1745620585.409 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20250425T205023/Courier0031.lzma
2025-04-25T22:36:26.412Z,1745620586.412 [DataOverHttps](INFO): Moved sent file to Logs/20250425T205023/Courier0031.lzma.bak
2025-04-25T22:36:26.412Z,1745620586.412 [DataOverHttps](INFO): SBD MOMSN=24733036
2025-04-25T22:36:42.206Z,1745620602.206 [DataOverHttps](INFO): Sending 216 bytes from file Logs/20250425T223332/Courier0000.lzma
2025-04-25T22:36:43.208Z,1745620603.208 [DataOverHttps](INFO): Moved sent file to Logs/20250425T223332/Courier0000.lzma.bak
2025-04-25T22:36:43.208Z,1745620603.208 [DataOverHttps](INFO): SBD MOMSN=24733039
2025-04-25T22:36:44.352Z,1745620604.352 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2025-04-25T22:36:44.353Z,1745620604.353 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-25T22:36:44.363Z,1745620604.363 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2025-04-25T22:36:44.363Z,1745620604.363 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-04-25T22:36:44.373Z,1745620604.373 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-25T22:36:44.378Z,1745620604.378 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-04-25T22:36:44.810Z,1745620604.810 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-25T22:36:44.810Z,1745620604.810 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2025-04-25T22:36:44.811Z,1745620604.811 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-04-25T22:36:44.811Z,1745620604.811 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2025-04-25T22:36:49.590Z,1745620609.590 [DepthKeller33X](FAULT): Failed to receive valid data within the specified timeout.
2025-04-25T22:36:49.590Z,1745620609.590 [DepthKeller33X] Communications Fault, FailCount= 1
2025-04-25T22:36:49.590Z,1745620609.590 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:36:49.622Z,1745620609.622 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:36:49.992Z,1745620609.992 [DepthKeller33X](INFO): Powering down
2025-04-25T22:36:51.041Z,1745620611.041 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:36:51.042Z,1745620611.042 [DepthKeller33X] No Fault, FailCount= 1
2025-04-25T22:36:51.191Z,1745620611.191 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:36:52.874Z,1745620612.874 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:36:52.874Z,1745620612.874 [DepthKeller33X] Communications Fault, FailCount= 2
2025-04-25T22:36:52.874Z,1745620612.874 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:36:52.970Z,1745620612.970 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:36:53.219Z,1745620613.219 [DepthKeller33X](INFO): Powering down
2025-04-25T22:36:54.203Z,1745620614.203 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:36:54.203Z,1745620614.203 [DepthKeller33X] No Fault, FailCount= 2
2025-04-25T22:36:54.428Z,1745620614.428 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:36:56.058Z,1745620616.058 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:36:56.058Z,1745620616.058 [DepthKeller33X] Communications Fault, FailCount= 3
2025-04-25T22:36:56.058Z,1745620616.058 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:36:56.106Z,1745620616.106 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:36:56.451Z,1745620616.451 [DepthKeller33X](INFO): Powering down
2025-04-25T22:36:57.295Z,1745620617.295 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:36:57.295Z,1745620617.295 [DepthKeller33X] No Fault, FailCount= 3
2025-04-25T22:36:57.659Z,1745620617.659 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:36:59.286Z,1745620619.286 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:36:59.286Z,1745620619.286 [DepthKeller33X] Communications Fault, FailCount= 4
2025-04-25T22:36:59.286Z,1745620619.286 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:36:59.361Z,1745620619.361 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:36:59.678Z,1745620619.678 [DepthKeller33X](INFO): Powering down
2025-04-25T22:36:59.765Z,1745620619.765 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20250425T205023/Express0032.lzma
2025-04-25T22:37:00.523Z,1745620620.523 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:37:00.523Z,1745620620.523 [DepthKeller33X] No Fault, FailCount= 4
2025-04-25T22:37:00.769Z,1745620620.769 [DataOverHttps](INFO): Moved sent file to Logs/20250425T205023/Express0032.lzma.bak
2025-04-25T22:37:00.769Z,1745620620.769 [DataOverHttps](INFO): SBD MOMSN=24733044
2025-04-25T22:37:00.887Z,1745620620.887 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:37:02.514Z,1745620622.514 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:37:02.514Z,1745620622.514 [DepthKeller33X] Communications Fault, FailCount= 5
2025-04-25T22:37:02.514Z,1745620622.514 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:37:02.567Z,1745620622.567 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:37:02.567Z,1745620622.567 [CBIT](CRITICAL): Communications Fault in component: DepthKeller33X
2025-04-25T22:37:02.907Z,1745620622.907 [DepthKeller33X](INFO): Powering down
2025-04-25T22:37:03.056Z,1745620623.056 [CBIT](INFO): Critical error at 20250425T223702
2025-04-25T22:37:07.455Z,1745620627.455 [CTD_Seabird](ERROR): Failed to parse device response:
2025-04-25T22:37:16.749Z,1745620636.749 [DataOverHttps](INFO): Sending 1421 bytes from file Logs/20250425T223332/Express0001.lzma
2025-04-25T22:37:17.747Z,1745620637.747 [DataOverHttps](INFO): Moved sent file to Logs/20250425T223332/Express0001.lzma.bak
2025-04-25T22:37:17.748Z,1745620637.748 [DataOverHttps](INFO): SBD MOMSN=24733052
2025-04-25T22:37:18.315Z,1745620638.315 [Startup:StartupSatComms:B](INFO): Timed out from 2025-04-25T22:36:18.1Z
2025-04-25T22:37:18.315Z,1745620638.315 [Startup:StartupSatComms:B] Stopped
2025-04-25T22:37:18.316Z,1745620638.316 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2025-04-25T22:37:18.316Z,1745620638.316 [Startup:StartupSatComms] Stopped
2025-04-25T22:37:18.316Z,1745620638.316 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2025-04-25T22:37:18.317Z,1745620638.317 [Startup](INFO): Completed Startup
2025-04-25T22:37:18.317Z,1745620638.317 [MissionManager](INFO): Startup is completed.
2025-04-25T22:37:18.317Z,1745620638.317 [MissionManager](INFO): Uninitializing Mission Startup
2025-04-25T22:37:18.317Z,1745620638.317 [Startup] Stopped
2025-04-25T22:37:18.317Z,1745620638.317 [Startup](DEBUG): Aggregate::uninitialize Startup
2025-04-25T22:37:18.317Z,1745620638.317 [Startup:A.GoToSurface] Stopped
2025-04-25T22:37:18.317Z,1745620638.317 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-04-25T22:37:18.683Z,1745620638.683 [MissionManager](IMPORTANT): Started mission Default
2025-04-25T22:37:18.684Z,1745620638.684 [Default] Running Loop=1
2025-04-25T22:37:18.684Z,1745620638.684 [Default](DEBUG): Aggregate::initialize Default
2025-04-25T22:37:18.684Z,1745620638.684 [Default:B.GoToSurface] Running Loop=1
2025-04-25T22:37:18.684Z,1745620638.684 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-04-25T22:37:18.684Z,1745620638.684 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-04-25T22:37:18.684Z,1745620638.684 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-04-25T22:37:18.685Z,1745620638.685 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-04-25T22:37:18.685Z,1745620638.685 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-04-25T22:37:18.685Z,1745620638.685 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-04-25T22:37:18.686Z,1745620638.686 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-04-25T22:37:18.686Z,1745620638.686 [Default:A.Wait] Running Loop=1
2025-04-25T22:37:18.686Z,1745620638.686 [Default:A.Wait](DEBUG): Initialize Wait Component.
2025-04-25T22:37:32.003Z,1745620652.003 [Default:A.Wait](INFO): Done Waiting.
2025-04-25T22:37:32.003Z,1745620652.003 [Default:A.Wait] Stopped
2025-04-25T22:37:32.003Z,1745620652.003 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2025-04-25T22:37:32.406Z,1745620652.406 [Default:CheckIn] Running Loop=1
2025-04-25T22:37:32.406Z,1745620652.406 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-04-25T22:37:32.406Z,1745620652.406 [Default:CheckIn:Read_GPS] Running Loop=1
2025-04-25T22:37:32.814Z,1745620652.814 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-04-25T22:37:32.825Z,1745620652.825 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:37:32.825Z,1745620652.825 [DepthKeller33X] No Fault, FailCount= 5
2025-04-25T22:37:33.207Z,1745620653.207 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:37:34.850Z,1745620654.850 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:37:34.850Z,1745620654.850 [DepthKeller33X] Communications Fault, FailCount= 1
2025-04-25T22:37:34.850Z,1745620654.850 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:37:35.131Z,1745620655.131 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:37:35.227Z,1745620655.227 [DepthKeller33X](INFO): Powering down
2025-04-25T22:37:36.106Z,1745620656.106 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:37:36.106Z,1745620656.106 [DepthKeller33X] No Fault, FailCount= 1
2025-04-25T22:37:36.440Z,1745620656.440 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:37:38.070Z,1745620658.070 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:37:38.070Z,1745620658.070 [DepthKeller33X] Communications Fault, FailCount= 2
2025-04-25T22:37:38.070Z,1745620658.070 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:37:38.234Z,1745620658.234 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:37:38.460Z,1745620658.460 [DepthKeller33X](INFO): Powering down
2025-04-25T22:37:39.314Z,1745620659.314 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:37:39.314Z,1745620659.314 [DepthKeller33X] No Fault, FailCount= 2
2025-04-25T22:37:39.672Z,1745620659.672 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:37:41.302Z,1745620661.302 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:37:41.302Z,1745620661.302 [DepthKeller33X] Communications Fault, FailCount= 3
2025-04-25T22:37:41.302Z,1745620661.302 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:37:41.350Z,1745620661.350 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:37:41.691Z,1745620661.691 [DepthKeller33X](INFO): Powering down
2025-04-25T22:37:42.546Z,1745620662.546 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:37:42.546Z,1745620662.546 [DepthKeller33X] No Fault, FailCount= 3
2025-04-25T22:37:42.903Z,1745620662.903 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:37:44.534Z,1745620664.534 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:37:44.534Z,1745620664.534 [DepthKeller33X] Communications Fault, FailCount= 4
2025-04-25T22:37:44.534Z,1745620664.534 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:37:44.578Z,1745620664.578 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:37:44.923Z,1745620664.923 [DepthKeller33X](INFO): Powering down
2025-04-25T22:37:45.790Z,1745620665.790 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:37:45.790Z,1745620665.790 [DepthKeller33X] No Fault, FailCount= 4
2025-04-25T22:37:46.135Z,1745620666.135 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:37:47.766Z,1745620667.766 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:37:47.766Z,1745620667.766 [DepthKeller33X] Communications Fault, FailCount= 5
2025-04-25T22:37:47.766Z,1745620667.766 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:37:47.815Z,1745620667.815 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:37:47.815Z,1745620667.815 [CBIT](CRITICAL): Communications Fault in component: DepthKeller33X
2025-04-25T22:37:48.155Z,1745620668.155 [DepthKeller33X](INFO): Powering down
2025-04-25T22:37:48.296Z,1745620668.296 [CBIT](INFO): Critical error at 20250425T223747
2025-04-25T22:37:52.639Z,1745620672.639 [CTD_Seabird](ERROR): Failed to parse device response:
2025-04-25T22:37:55.598Z,1745620675.598 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2025-04-25T22:37:55.598Z,1745620675.598 [RDI_Pathfinder] No Fault, FailCount= 3
2025-04-25T22:37:55.847Z,1745620675.847 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2025-04-25T22:38:08.356Z,1745620688.356 [RDI_Pathfinder](FAULT): DVL failed to acquire valid data within timeout.
2025-04-25T22:38:08.356Z,1745620688.356 [RDI_Pathfinder] Data Fault, FailCount= 1
2025-04-25T22:38:08.356Z,1745620688.356 [RDI_Pathfinder](ERROR): Data Fault
2025-04-25T22:38:08.406Z,1745620688.406 [CBIT](ERROR): Data Fault in component: RDI_Pathfinder
2025-04-25T22:38:08.830Z,1745620688.830 [RDI_Pathfinder](INFO): Powering down
2025-04-25T22:38:09.615Z,1745620689.615 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2025-04-25T22:38:09.615Z,1745620689.615 [RDI_Pathfinder] No Fault, FailCount= 1
2025-04-25T22:38:09.972Z,1745620689.972 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2025-04-25T22:38:18.067Z,1745620698.067 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:38:18.067Z,1745620698.067 [DepthKeller33X] No Fault, FailCount= 5
2025-04-25T22:38:18.456Z,1745620698.456 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:38:20.086Z,1745620700.086 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:38:20.086Z,1745620700.086 [DepthKeller33X] Communications Fault, FailCount= 1
2025-04-25T22:38:20.086Z,1745620700.086 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:38:20.330Z,1745620700.330 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:38:20.475Z,1745620700.475 [DepthKeller33X](INFO): Powering down
2025-04-25T22:38:21.362Z,1745620701.362 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:38:21.362Z,1745620701.362 [DepthKeller33X] No Fault, FailCount= 1
2025-04-25T22:38:21.688Z,1745620701.688 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:38:23.318Z,1745620703.318 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:38:23.318Z,1745620703.318 [DepthKeller33X] Communications Fault, FailCount= 2
2025-04-25T22:38:23.318Z,1745620703.318 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:38:23.474Z,1745620703.474 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:38:23.709Z,1745620703.709 [DepthKeller33X](INFO): Powering down
2025-04-25T22:38:24.554Z,1745620704.554 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:38:24.554Z,1745620704.554 [DepthKeller33X] No Fault, FailCount= 2
2025-04-25T22:38:24.922Z,1745620704.922 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:38:26.550Z,1745620706.550 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:38:26.550Z,1745620706.550 [DepthKeller33X] Communications Fault, FailCount= 3
2025-04-25T22:38:26.550Z,1745620706.550 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:38:26.595Z,1745620706.595 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:38:26.939Z,1745620706.939 [DepthKeller33X](INFO): Powering down
2025-04-25T22:38:27.810Z,1745620707.810 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:38:27.810Z,1745620707.810 [DepthKeller33X] No Fault, FailCount= 3
2025-04-25T22:38:28.152Z,1745620708.152 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:38:29.782Z,1745620709.782 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:38:29.782Z,1745620709.782 [DepthKeller33X] Communications Fault, FailCount= 4
2025-04-25T22:38:29.782Z,1745620709.782 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:38:29.834Z,1745620709.834 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:38:30.171Z,1745620710.171 [DepthKeller33X](INFO): Powering down
2025-04-25T22:38:31.037Z,1745620711.037 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:38:31.038Z,1745620711.038 [DepthKeller33X] No Fault, FailCount= 4
2025-04-25T22:38:31.385Z,1745620711.385 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:38:32.206Z,1745620712.206 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2025-04-25T22:38:32.206Z,1745620712.206 [RDI_Pathfinder] Communications Fault, FailCount= 2
2025-04-25T22:38:32.206Z,1745620712.206 [RDI_Pathfinder](ERROR): Communications Fault
2025-04-25T22:38:32.270Z,1745620712.270 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2025-04-25T22:38:32.682Z,1745620712.682 [RDI_Pathfinder](INFO): Powering down
2025-04-25T22:38:33.014Z,1745620713.014 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:38:33.014Z,1745620713.014 [DepthKeller33X] Communications Fault, FailCount= 5
2025-04-25T22:38:33.014Z,1745620713.014 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:38:33.077Z,1745620713.077 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:38:33.077Z,1745620713.077 [CBIT](CRITICAL): Communications Fault in component: DepthKeller33X
2025-04-25T22:38:33.403Z,1745620713.403 [DepthKeller33X](INFO): Powering down
2025-04-25T22:38:33.544Z,1745620713.544 [CBIT](INFO): Critical error at 20250425T223833
2025-04-25T22:38:33.547Z,1745620713.547 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2025-04-25T22:38:33.547Z,1745620713.547 [RDI_Pathfinder] No Fault, FailCount= 2
2025-04-25T22:38:33.808Z,1745620713.808 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2025-04-25T22:38:37.827Z,1745620717.827 [CTD_Seabird](ERROR): Failed to parse device response:
2025-04-25T22:38:56.028Z,1745620736.028 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2025-04-25T22:38:56.029Z,1745620736.029 [RDI_Pathfinder] Communications Fault, FailCount= 3
2025-04-25T22:38:56.029Z,1745620736.029 [RDI_Pathfinder](ERROR): Communications Fault
2025-04-25T22:38:56.076Z,1745620736.076 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2025-04-25T22:38:56.076Z,1745620736.076 [CBIT](CRITICAL): Communications Fault in component: RDI_Pathfinder
2025-04-25T22:38:56.502Z,1745620736.502 [RDI_Pathfinder](INFO): Powering down
2025-04-25T22:38:56.548Z,1745620736.548 [CBIT](INFO): Critical error at 20250425T223856
2025-04-25T22:39:03.325Z,1745620743.325 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:39:03.325Z,1745620743.325 [DepthKeller33X] No Fault, FailCount= 5
2025-04-25T22:39:03.703Z,1745620743.703 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:39:05.330Z,1745620745.330 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:39:05.330Z,1745620745.330 [DepthKeller33X] Communications Fault, FailCount= 1
2025-04-25T22:39:05.330Z,1745620745.330 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:39:05.594Z,1745620745.594 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:39:05.723Z,1745620745.723 [DepthKeller33X](INFO): Powering down
2025-04-25T22:39:06.602Z,1745620746.602 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:39:06.602Z,1745620746.602 [DepthKeller33X] No Fault, FailCount= 1
2025-04-25T22:39:06.936Z,1745620746.936 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:39:08.566Z,1745620748.566 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:39:08.566Z,1745620748.566 [DepthKeller33X] Communications Fault, FailCount= 2
2025-04-25T22:39:08.566Z,1745620748.566 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:39:08.702Z,1745620748.702 [DAT](INFO): DAT read: user:6>Lowpower
2025-04-25T22:39:08.703Z,1745620748.703 [DAT](DEBUG): Re-entering command mode due to deviceResponse_: user:6>Lowpower
2025-04-25T22:39:08.738Z,1745620748.738 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:39:08.957Z,1745620748.957 [DepthKeller33X](INFO): Powering down
2025-04-25T22:39:09.822Z,1745620749.822 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:39:09.822Z,1745620749.822 [DepthKeller33X] No Fault, FailCount= 2
2025-04-25T22:39:10.169Z,1745620750.169 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:39:11.794Z,1745620751.794 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:39:11.794Z,1745620751.794 [DepthKeller33X] Communications Fault, FailCount= 3
2025-04-25T22:39:11.794Z,1745620751.794 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:39:11.851Z,1745620751.851 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:39:12.187Z,1745620752.187 [DepthKeller33X](INFO): Powering down
2025-04-25T22:39:13.046Z,1745620753.046 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:39:13.046Z,1745620753.046 [DepthKeller33X] No Fault, FailCount= 3
2025-04-25T22:39:13.402Z,1745620753.402 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:39:15.030Z,1745620755.030 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:39:15.030Z,1745620755.030 [DepthKeller33X] Communications Fault, FailCount= 4
2025-04-25T22:39:15.030Z,1745620755.030 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:39:15.090Z,1745620755.090 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:39:15.419Z,1745620755.419 [DepthKeller33X](INFO): Powering down
2025-04-25T22:39:16.278Z,1745620756.278 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:39:16.278Z,1745620756.278 [DepthKeller33X] No Fault, FailCount= 4
2025-04-25T22:39:16.633Z,1745620756.633 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:39:18.262Z,1745620758.262 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:39:18.262Z,1745620758.262 [DepthKeller33X] Communications Fault, FailCount= 5
2025-04-25T22:39:18.262Z,1745620758.262 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:39:18.402Z,1745620758.402 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:39:18.402Z,1745620758.402 [CBIT](CRITICAL): Communications Fault in component: DepthKeller33X
2025-04-25T22:39:18.651Z,1745620758.651 [DepthKeller33X](INFO): Powering down
2025-04-25T22:39:18.786Z,1745620758.786 [CBIT](INFO): Critical error at 20250425T223918
2025-04-25T22:39:20.014Z,1745620760.014 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-04-25T22:39:23.007Z,1745620763.007 [CTD_Seabird](ERROR): Failed to parse device response:
2025-04-25T22:39:25.924Z,1745620765.924 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-04-25T22:39:45.319Z,1745620785.319 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2025-04-25T22:39:45.319Z,1745620785.319 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-25T22:39:45.321Z,1745620785.321 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2025-04-25T22:39:45.321Z,1745620785.321 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-04-25T22:39:45.340Z,1745620785.340 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-25T22:39:45.340Z,1745620785.340 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-04-25T22:39:45.733Z,1745620785.733 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-25T22:39:45.733Z,1745620785.733 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2025-04-25T22:39:45.733Z,1745620785.733 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-04-25T22:39:45.733Z,1745620785.733 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2025-04-25T22:39:48.573Z,1745620788.573 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:39:48.573Z,1745620788.573 [DepthKeller33X] No Fault, FailCount= 5
2025-04-25T22:39:48.951Z,1745620788.951 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:39:50.582Z,1745620790.582 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:39:50.582Z,1745620790.582 [DepthKeller33X] Communications Fault, FailCount= 1
2025-04-25T22:39:50.582Z,1745620790.582 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:39:50.849Z,1745620790.849 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:39:50.972Z,1745620790.972 [DepthKeller33X](INFO): Powering down
2025-04-25T22:39:51.138Z,1745620791.138 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-04-25T22:39:51.862Z,1745620791.862 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:39:51.862Z,1745620791.862 [DepthKeller33X] No Fault, FailCount= 1
2025-04-25T22:39:52.183Z,1745620792.183 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:39:53.810Z,1745620793.810 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:39:53.810Z,1745620793.810 [DepthKeller33X] Communications Fault, FailCount= 2
2025-04-25T22:39:53.810Z,1745620793.810 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:39:53.967Z,1745620793.967 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:39:54.204Z,1745620794.204 [DepthKeller33X](INFO): Powering down
2025-04-25T22:39:55.054Z,1745620795.054 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:39:55.054Z,1745620795.054 [DepthKeller33X] No Fault, FailCount= 2
2025-04-25T22:39:55.415Z,1745620795.415 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:39:57.046Z,1745620797.046 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:39:57.046Z,1745620797.046 [DepthKeller33X] Communications Fault, FailCount= 3
2025-04-25T22:39:57.046Z,1745620797.046 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:39:57.103Z,1745620797.103 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:39:57.435Z,1745620797.435 [DepthKeller33X](INFO): Powering down
2025-04-25T22:39:58.286Z,1745620798.286 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:39:58.286Z,1745620798.286 [DepthKeller33X] No Fault, FailCount= 3
2025-04-25T22:39:58.648Z,1745620798.648 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:40:00.274Z,1745620800.274 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:40:00.274Z,1745620800.274 [DepthKeller33X] Communications Fault, FailCount= 4
2025-04-25T22:40:00.274Z,1745620800.274 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:40:00.342Z,1745620800.342 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:40:00.668Z,1745620800.668 [DepthKeller33X](INFO): Powering down
2025-04-25T22:40:01.550Z,1745620801.550 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:40:01.550Z,1745620801.550 [DepthKeller33X] No Fault, FailCount= 4
2025-04-25T22:40:01.879Z,1745620801.879 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:40:03.194Z,1745620803.194 [NAL9602](ERROR): getFix uart error: serial timeout
2025-04-25T22:40:03.679Z,1745620803.679 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:40:03.679Z,1745620803.679 [DepthKeller33X] Communications Fault, FailCount= 5
2025-04-25T22:40:03.679Z,1745620803.679 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:40:03.734Z,1745620803.734 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:40:03.734Z,1745620803.734 [CBIT](CRITICAL): Communications Fault in component: DepthKeller33X
2025-04-25T22:40:04.071Z,1745620804.071 [DepthKeller33X](INFO): Powering down
2025-04-25T22:40:04.205Z,1745620804.205 [CBIT](INFO): Critical error at 20250425T224003
2025-04-25T22:40:08.187Z,1745620808.187 [CTD_Seabird](ERROR): Failed to parse device response:
2025-04-25T22:40:22.262Z,1745620822.262 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-04-25T22:40:33.564Z,1745620833.564 [NAL9602](ERROR): parseGSV uart error: serial timeout
2025-04-25T22:40:33.983Z,1745620833.983 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:40:33.983Z,1745620833.983 [DepthKeller33X] No Fault, FailCount= 5
2025-04-25T22:40:34.373Z,1745620834.373 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:40:36.002Z,1745620836.002 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:40:36.002Z,1745620836.002 [DepthKeller33X] Communications Fault, FailCount= 1
2025-04-25T22:40:36.002Z,1745620836.002 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:40:36.182Z,1745620836.182 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:40:36.391Z,1745620836.391 [DepthKeller33X](INFO): Powering down
2025-04-25T22:40:37.274Z,1745620837.274 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:40:37.274Z,1745620837.274 [DepthKeller33X] No Fault, FailCount= 1
2025-04-25T22:40:37.605Z,1745620837.605 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:40:39.234Z,1745620839.234 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:40:39.234Z,1745620839.234 [DepthKeller33X] Communications Fault, FailCount= 2
2025-04-25T22:40:39.234Z,1745620839.234 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:40:39.286Z,1745620839.286 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:40:39.623Z,1745620839.623 [DepthKeller33X](INFO): Powering down
2025-04-25T22:40:40.482Z,1745620840.482 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:40:40.482Z,1745620840.482 [DepthKeller33X] No Fault, FailCount= 2
2025-04-25T22:40:40.835Z,1745620840.835 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:40:42.466Z,1745620842.466 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:40:42.466Z,1745620842.466 [DepthKeller33X] Communications Fault, FailCount= 3
2025-04-25T22:40:42.466Z,1745620842.466 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:40:42.518Z,1745620842.518 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:40:42.855Z,1745620842.855 [DepthKeller33X](INFO): Powering down
2025-04-25T22:40:43.714Z,1745620843.714 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:40:43.714Z,1745620843.714 [DepthKeller33X] No Fault, FailCount= 3
2025-04-25T22:40:44.068Z,1745620844.068 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:40:45.698Z,1745620845.698 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:40:45.698Z,1745620845.698 [DepthKeller33X] Communications Fault, FailCount= 4
2025-04-25T22:40:45.698Z,1745620845.698 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:40:45.742Z,1745620845.742 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:40:46.089Z,1745620846.089 [DepthKeller33X](INFO): Powering down
2025-04-25T22:40:46.939Z,1745620846.939 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:40:46.939Z,1745620846.939 [DepthKeller33X] No Fault, FailCount= 4
2025-04-25T22:40:47.300Z,1745620847.300 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:40:48.934Z,1745620848.934 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:40:48.934Z,1745620848.934 [DepthKeller33X] Communications Fault, FailCount= 5
2025-04-25T22:40:48.934Z,1745620848.934 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:40:49.008Z,1745620849.008 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:40:49.008Z,1745620849.008 [CBIT](CRITICAL): Communications Fault in component: DepthKeller33X
2025-04-25T22:40:49.319Z,1745620849.319 [DepthKeller33X](INFO): Powering down
2025-04-25T22:40:49.456Z,1745620849.456 [CBIT](INFO): Critical error at 20250425T224049
2025-04-25T22:40:53.371Z,1745620853.371 [CTD_Seabird](ERROR): Failed to parse device response:
2025-04-25T22:40:53.406Z,1745620853.406 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-04-25T22:41:05.174Z,1745620865.174 [NAL9602](ERROR): getFix uart error: serial timeout
2025-04-25T22:41:18.994Z,1745620878.994 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:41:18.994Z,1745620878.994 [DepthKeller33X] No Fault, FailCount= 5
2025-04-25T22:41:19.386Z,1745620879.386 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:41:21.014Z,1745620881.014 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:41:21.014Z,1745620881.014 [DepthKeller33X] Communications Fault, FailCount= 1
2025-04-25T22:41:21.014Z,1745620881.014 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:41:21.266Z,1745620881.266 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:41:21.404Z,1745620881.404 [DepthKeller33X](INFO): Powering down
2025-04-25T22:41:22.282Z,1745620882.282 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:41:22.282Z,1745620882.282 [DepthKeller33X] No Fault, FailCount= 1
2025-04-25T22:41:22.617Z,1745620882.617 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:41:24.246Z,1745620884.246 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:41:24.246Z,1745620884.246 [DepthKeller33X] Communications Fault, FailCount= 2
2025-04-25T22:41:24.246Z,1745620884.246 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:41:24.408Z,1745620884.408 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:41:24.636Z,1745620884.636 [DepthKeller33X](INFO): Powering down
2025-04-25T22:41:25.494Z,1745620885.494 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:41:25.494Z,1745620885.494 [DepthKeller33X] No Fault, FailCount= 2
2025-04-25T22:41:25.850Z,1745620885.850 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:41:27.478Z,1745620887.478 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:41:27.478Z,1745620887.478 [DepthKeller33X] Communications Fault, FailCount= 3
2025-04-25T22:41:27.478Z,1745620887.478 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:41:27.542Z,1745620887.542 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:41:27.867Z,1745620887.867 [DepthKeller33X](INFO): Powering down
2025-04-25T22:41:28.730Z,1745620888.730 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:41:28.730Z,1745620888.730 [DepthKeller33X] No Fault, FailCount= 3
2025-04-25T22:41:29.084Z,1745620889.084 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:41:30.710Z,1745620890.710 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:41:30.710Z,1745620890.710 [DepthKeller33X] Communications Fault, FailCount= 4
2025-04-25T22:41:30.710Z,1745620890.710 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:41:30.770Z,1745620890.770 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:41:31.099Z,1745620891.099 [DepthKeller33X](INFO): Powering down
2025-04-25T22:41:31.958Z,1745620891.958 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:41:31.958Z,1745620891.958 [DepthKeller33X] No Fault, FailCount= 4
2025-04-25T22:41:32.311Z,1745620892.311 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:41:33.942Z,1745620893.942 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:41:33.942Z,1745620893.942 [DepthKeller33X] Communications Fault, FailCount= 5
2025-04-25T22:41:33.942Z,1745620893.942 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:41:34.008Z,1745620894.008 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:41:34.008Z,1745620894.008 [CBIT](CRITICAL): Communications Fault in component: DepthKeller33X
2025-04-25T22:41:34.331Z,1745620894.331 [DepthKeller33X](INFO): Powering down
2025-04-25T22:41:34.460Z,1745620894.460 [CBIT](INFO): Critical error at 20250425T224134
2025-04-25T22:41:35.546Z,1745620895.546 [NAL9602](ERROR): parseGSV uart error: serial timeout
2025-04-25T22:41:38.551Z,1745620898.551 [CTD_Seabird](ERROR): Failed to parse device response:
2025-04-25T22:41:56.190Z,1745620916.190 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2025-04-25T22:41:56.190Z,1745620916.190 [RDI_Pathfinder] No Fault, FailCount= 3
2025-04-25T22:41:56.553Z,1745620916.553 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2025-04-25T22:42:00.491Z,1745620920.491 [CommandExec](IMPORTANT): got command strobe on
2025-04-25T22:42:00.492Z,1745620920.492 [CommandExec](IMPORTANT): Activating strobe
2025-04-25T22:42:04.255Z,1745620924.255 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:42:04.256Z,1745620924.256 [DepthKeller33X] No Fault, FailCount= 5
2025-04-25T22:42:04.631Z,1745620924.631 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:42:06.262Z,1745620926.262 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:42:06.262Z,1745620926.262 [DepthKeller33X] Communications Fault, FailCount= 1
2025-04-25T22:42:06.262Z,1745620926.262 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:42:06.466Z,1745620926.466 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:42:06.652Z,1745620926.652 [DepthKeller33X](INFO): Powering down
2025-04-25T22:42:07.246Z,1745620927.246 [NAL9602](ERROR): getFix uart error: serial timeout
2025-04-25T22:42:07.832Z,1745620927.832 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:42:07.832Z,1745620927.832 [DepthKeller33X] No Fault, FailCount= 1
2025-04-25T22:42:08.160Z,1745620928.160 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:42:08.969Z,1745620928.969 [RDI_Pathfinder](FAULT): DVL failed to acquire valid data within timeout.
2025-04-25T22:42:08.969Z,1745620928.969 [RDI_Pathfinder] Data Fault, FailCount= 1
2025-04-25T22:42:08.969Z,1745620928.969 [RDI_Pathfinder](ERROR): Data Fault
2025-04-25T22:42:09.146Z,1745620929.146 [CBIT](ERROR): Data Fault in component: RDI_Pathfinder
2025-04-25T22:42:09.442Z,1745620929.442 [RDI_Pathfinder](INFO): Powering down
2025-04-25T22:42:09.790Z,1745620929.790 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:42:09.790Z,1745620929.790 [DepthKeller33X] Communications Fault, FailCount= 2
2025-04-25T22:42:09.790Z,1745620929.790 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:42:09.846Z,1745620929.846 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:42:10.180Z,1745620930.180 [DepthKeller33X](INFO): Powering down
2025-04-25T22:42:10.318Z,1745620930.318 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2025-04-25T22:42:10.318Z,1745620930.318 [RDI_Pathfinder] No Fault, FailCount= 1
2025-04-25T22:42:10.585Z,1745620930.585 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2025-04-25T22:42:11.027Z,1745620931.027 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:42:11.027Z,1745620931.027 [DepthKeller33X] No Fault, FailCount= 2
2025-04-25T22:42:11.391Z,1745620931.391 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:42:13.022Z,1745620933.022 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:42:13.022Z,1745620933.022 [DepthKeller33X] Communications Fault, FailCount= 3
2025-04-25T22:42:13.022Z,1745620933.022 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:42:13.068Z,1745620933.068 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:42:13.414Z,1745620933.414 [DepthKeller33X](INFO): Powering down
2025-04-25T22:42:14.266Z,1745620934.266 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:42:14.266Z,1745620934.266 [DepthKeller33X] No Fault, FailCount= 3
2025-04-25T22:42:14.624Z,1745620934.624 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:42:16.254Z,1745620936.254 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:42:16.254Z,1745620936.254 [DepthKeller33X] Communications Fault, FailCount= 4
2025-04-25T22:42:16.254Z,1745620936.254 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:42:16.303Z,1745620936.303 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:42:16.645Z,1745620936.645 [DepthKeller33X](INFO): Powering down
2025-04-25T22:42:16.647Z,1745620936.647 [CommandExec](IMPORTANT): got command strobe on
2025-04-25T22:42:16.647Z,1745620936.647 [CommandExec](IMPORTANT): Activating strobe
2025-04-25T22:42:17.498Z,1745620937.498 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-25T22:42:17.498Z,1745620937.498 [DepthKeller33X] No Fault, FailCount= 4
2025-04-25T22:42:17.855Z,1745620937.855 [DepthKeller33X](INFO): Initializing.
2025-04-25T22:42:19.486Z,1745620939.486 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-25T22:42:19.486Z,1745620939.486 [DepthKeller33X] Communications Fault, FailCount= 5
2025-04-25T22:42:19.486Z,1745620939.486 [DepthKeller33X](ERROR): Communications Fault
2025-04-25T22:42:19.532Z,1745620939.532 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-25T22:42:19.533Z,1745620939.533 [CBIT](CRITICAL): Communications Fault in component: DepthKeller33X
2025-04-25T22:42:19.875Z,1745620939.875 [DepthKeller33X](INFO): Powering down
2025-04-25T22:42:20.028Z,1745620940.028 [CBIT](INFO): Critical error at 20250425T224219
2025-04-25T22:42:23.731Z,1745620943.731 [CTD_Seabird](ERROR): Failed to parse device response:
2025-04-25T22:42:25.595Z,1745620945.595 [CommandExec](IMPORTANT): got command restart application
2025-04-25T22:42:26.598Z,1745620946.598 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-25T22:42:26.598Z,1745620946.598 [CommandExec](INFO): Uninitializing the command executive.
2025-04-25T22:42:26.598Z,1745620946.598 [CommandExec](INFO): Uninitializing the command scheduler.
2025-04-25T22:42:26.598Z,1745620946.598 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-04-25T22:42:26.622Z,1745620946.622 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2025-04-25T22:42:26.623Z,1745620946.623 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2025-04-25T22:42:26.623Z,1745620946.623 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-04-25T22:42:26.623Z,1745620946.623 [NavChartDb](INFO): Join timeout helper Thread ID is 1077
2025-04-25T22:42:26.742Z,1745620946.742 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-25T22:42:26.742Z,1745620946.742 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-04-25T22:42:26.762Z,1745620946.762 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2025-04-25T22:42:26.762Z,1745620946.762 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-04-25T22:42:26.762Z,1745620946.762 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1078
2025-04-25T22:42:27.747Z,1745620947.747 [CTD_Seabird](INFO): Powering down
2025-04-25T22:42:27.874Z,1745620947.874 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-25T22:42:27.874Z,1745620947.874 [CTD_Seabird](INFO): Powering down
2025-04-25T22:42:27.886Z,1745620947.886 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-04-25T22:42:27.902Z,1745620947.902 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2025-04-25T22:42:27.903Z,1745620947.903 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-04-25T22:42:27.904Z,1745620947.904 [Radio_Surface](INFO): Join timeout helper Thread ID is 1079
2025-04-25T22:42:28.238Z,1745620948.238 [Radio_Surface](INFO): Powering down
2025-04-25T22:42:28.239Z,1745620948.239 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-25T22:42:28.239Z,1745620948.239 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-04-25T22:42:28.254Z,1745620948.254 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2025-04-25T22:42:28.254Z,1745620948.254 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-04-25T22:42:28.254Z,1745620948.254 [Onboard](INFO): Join timeout helper Thread ID is 1080
2025-04-25T22:42:30.046Z,1745620950.046 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-25T22:42:30.046Z,1745620950.046 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-04-25T22:42:30.062Z,1745620950.062 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2025-04-25T22:42:30.062Z,1745620950.062 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-04-25T22:42:30.062Z,1745620950.062 [DataOverHttps](INFO): Join timeout helper Thread ID is 1081
2025-04-25T22:42:31.327Z,1745620951.327 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-25T22:42:31.330Z,1745620951.330 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-04-25T22:42:31.339Z,1745620951.339 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2025-04-25T22:42:31.339Z,1745620951.339 [DAT ThreadHandler](INFO): Thread cancelled.
2025-04-25T22:42:31.339Z,1745620951.339 [DAT](INFO): Join timeout helper Thread ID is 1082
2025-04-25T22:42:31.486Z,1745620951.486 [DAT](INFO): Powering down
2025-04-25T22:42:31.559Z,1745620951.559 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-25T22:42:31.559Z,1745620951.559 [DAT](INFO): Powering down
2025-04-25T22:42:31.560Z,1745620951.560 [DAT ThreadHandler](INFO): Thread cancelled.
2025-04-25T22:42:31.570Z,1745620951.570 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2025-04-25T22:42:31.571Z,1745620951.571 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-04-25T22:42:31.571Z,1745620951.571 [BackseatComponent](INFO): Join timeout helper Thread ID is 1083
2025-04-25T22:42:31.578Z,1745620951.578 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-25T22:42:31.578Z,1745620951.578 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-04-25T22:42:31.598Z,1745620951.598 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2025-04-25T22:42:31.599Z,1745620951.599 [logger ThreadHandler](INFO): Thread cancelled.
2025-04-25T22:42:31.599Z,1745620951.599 [logger](INFO): Join timeout helper Thread ID is 1084
2025-04-25T22:42:31.607Z,1745620951.607 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-25T22:42:31.608Z,1745620951.608 [logger ThreadHandler](INFO): Thread cancelled.
2025-04-25T22:42:31.627Z,1745620951.627 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2025-04-25T22:42:31.627Z,1745620951.627 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-04-25T22:42:31.627Z,1745620951.627 [CommandLine](INFO): Join timeout helper Thread ID is 1085
2025-04-25T22:42:31.654Z,1745620951.654 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-25T22:42:31.654Z,1745620951.654 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-04-25T22:42:31.666Z,1745620951.666 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2025-04-25T22:42:31.667Z,1745620951.667 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-04-25T22:42:31.667Z,1745620951.667 [CommandExec](INFO): Join timeout helper Thread ID is 1086
2025-04-25T22:42:31.668Z,1745620951.668 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2025-04-25T22:42:31.668Z,1745620951.668 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-04-25T22:42:31.669Z,1745620951.669 [controlThread](INFO): Join timeout helper Thread ID is 1087
2025-04-25T22:42:31.986Z,1745620951.986 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-25T22:42:31.986Z,1745620951.986 [controlThread](DEBUG): Uninitializing ControlThread
2025-04-25T22:42:31.986Z,1745620951.986 [AHRS_M2](INFO): Powering down
2025-04-25T22:42:32.058Z,1745620952.058 [DepthKeller33X](INFO): Powering down
2025-04-25T22:42:32.059Z,1745620952.059 [NAL9602](INFO): Powering down
2025-04-25T22:42:32.130Z,1745620952.130 [RDI_Pathfinder](INFO): Powering down
2025-04-25T22:42:32.131Z,1745620952.131 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2025-04-25T22:42:32.131Z,1745620952.131 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2025-04-25T22:42:32.132Z,1745620952.132 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2025-04-25T22:42:32.133Z,1745620952.133 [MissionManager](INFO): Uninitializing Mission Default
2025-04-25T22:42:32.133Z,1745620952.133 [Default] Stopped
2025-04-25T22:42:32.133Z,1745620952.133 [Default](DEBUG): Aggregate::uninitialize Default
2025-04-25T22:42:32.133Z,1745620952.133 [Default:B.GoToSurface] Stopped
2025-04-25T22:42:32.133Z,1745620952.133 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-04-25T22:42:32.133Z,1745620952.133 [Default:CheckIn] Stopped
2025-04-25T22:42:32.133Z,1745620952.133 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-04-25T22:42:32.133Z,1745620952.133 [Default:CheckIn:Read_GPS] Stopped
2025-04-25T22:42:32.136Z,1745620952.136 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2025-04-25T22:42:32.137Z,1745620952.137 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2025-04-25T22:42:32.137Z,1745620952.137 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2025-04-25T22:42:32.137Z,1745620952.137 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2025-04-25T22:42:32.138Z,1745620952.138 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2025-04-25T22:42:32.138Z,1745620952.138 [BuoyancyServo](INFO): Powering down
2025-04-25T22:42:32.150Z,1745620952.150 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-04-25T22:42:32.150Z,1745620952.150 [ElevatorServo](INFO): Powering down
2025-04-25T22:42:32.151Z,1745620952.151 [MassServo](DEBUG): Uninitialize Mass Servo.
2025-04-25T22:42:32.151Z,1745620952.151 [MassServo](INFO): Powering down
2025-04-25T22:42:32.152Z,1745620952.152 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-04-25T22:42:32.152Z,1745620952.152 [RudderServo](INFO): Powering down
2025-04-25T22:42:32.153Z,1745620952.153 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2025-04-25T22:42:32.153Z,1745620952.153 [ThrusterHE](INFO): Powering down
2025-04-25T22:42:32.154Z,1745620952.154 [SBIT](DEBUG): Uninitialize SBIT Component.
2025-04-25T22:42:32.154Z,1745620952.154 [IBIT](DEBUG): Uninitialize IBIT Component.
2025-04-25T22:42:32.154Z,1745620952.154 [CBIT](DEBUG): Uninitialize CBIT Component.
2025-04-25T22:42:32.154Z,1745620952.154 [CBIT](DEBUG): Powering off loads.
2025-04-25T22:42:32.166Z,1745620952.166 [CBIT](DEBUG): Disabling WDT.
2025-04-25T22:42:32.178Z,1745620952.178 [GFScanner](DEBUG): Uninitialize GFScanner component.
2025-04-25T22:42:32.178Z,1745620952.178 [GFScanner](DEBUG): Opening all GF detection circuits.
2025-04-25T22:42:32.179Z,1745620952.179 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-04-25T22:42:32.201Z,1745620952.201 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-04-25T22:42:32.204Z,1745620952.204 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-04-25T22:42:32.210Z,1745620952.210 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-04-25T22:42:32.217Z,1745620952.217 [DAT ThreadHandler](INFO): Thread cancelled.
2025-04-25T22:42:32.222Z,1745620952.222 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-04-25T22:42:32.509Z,1745620952.509 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-04-25T22:42:32.554Z,1745620952.554 [GFScanner](DEBUG): Uninitialize GFScanner component.
2025-04-25T22:42:32.554Z,1745620952.554 [GFScanner](DEBUG): Opening all GF detection circuits.
2025-04-25T22:42:32.572Z,1745620952.572 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-04-25T22:42:32.629Z,1745620952.629 [logger ThreadHandler](INFO): Thread cancelled.