2025-04-28T16:58:34.294Z,1745859514.294 [Supervisor](DEBUG): Initializing supervisor.
2025-04-28T16:58:34.298Z,1745859514.298 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2025-04-28T16:58:34.298Z,1745859514.298 [SyncHandler](INFO): Protected caller Thread ID is 4362
2025-04-28T16:58:34.299Z,1745859514.299 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2025-04-28T16:58:34.299Z,1745859514.299 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2025-04-28T16:58:34.300Z,1745859514.300 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 4363
2025-04-28T16:58:34.304Z,1745859514.304 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2025-04-28T16:58:34.324Z,1745859514.324 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2025-04-28T16:58:34.325Z,1745859514.325 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2025-04-28T16:58:34.325Z,1745859514.325 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 4364
2025-04-28T16:58:34.329Z,1745859514.329 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2025-04-28T16:58:34.330Z,1745859514.330 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2025-04-28T16:58:34.331Z,1745859514.331 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 4365
2025-04-28T16:58:34.333Z,1745859514.333 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2025-04-28T16:58:34.334Z,1745859514.334 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2025-04-28T16:58:34.334Z,1745859514.334 [logger ThreadHandler](INFO): Protected caller Thread ID is 4366
2025-04-28T16:58:34.338Z,1745859514.338 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2025-04-28T16:58:34.338Z,1745859514.338 [Supervisor](INFO): Looking for Config files in directory: Config/
2025-04-28T16:58:34.340Z,1745859514.340 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2025-04-28T16:58:34.685Z,1745859514.685 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2025-04-28T16:58:34.686Z,1745859514.686 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2025-04-28T16:58:34.964Z,1745859514.964 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2025-04-28T16:58:34.964Z,1745859514.964 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2025-04-28T16:58:35.471Z,1745859515.471 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2025-04-28T16:58:35.471Z,1745859515.471 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2025-04-28T16:58:35.714Z,1745859515.714 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2025-04-28T16:58:35.714Z,1745859515.714 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2025-04-28T16:58:35.950Z,1745859515.950 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2025-04-28T16:58:35.951Z,1745859515.951 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2025-04-28T16:58:36.846Z,1745859516.846 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2025-04-28T16:58:36.846Z,1745859516.846 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2025-04-28T16:58:37.203Z,1745859517.203 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2025-04-28T16:58:37.204Z,1745859517.204 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2025-04-28T16:58:37.326Z,1745859517.326 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2025-04-28T16:58:37.327Z,1745859517.327 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2025-04-28T16:58:37.417Z,1745859517.417 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2025-04-28T16:58:37.612Z,1745859517.612 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2025-04-28T16:58:37.613Z,1745859517.613 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2025-04-28T16:58:37.720Z,1745859517.720 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2025-04-28T16:58:37.721Z,1745859517.721 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2025-04-28T16:58:37.953Z,1745859517.953 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2025-04-28T16:58:37.954Z,1745859517.954 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2025-04-28T16:58:38.103Z,1745859518.103 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2025-04-28T16:58:38.103Z,1745859518.103 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2025-04-28T16:58:38.195Z,1745859518.195 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2025-04-28T16:58:38.647Z,1745859518.647 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2025-04-28T16:58:38.647Z,1745859518.647 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2025-04-28T16:58:39.867Z,1745859519.867 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2025-04-28T16:58:39.869Z,1745859519.869 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-opah/
2025-04-28T16:58:39.870Z,1745859519.870 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Science.cfg
2025-04-28T16:58:39.983Z,1745859519.983 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Battery.cfg
2025-04-28T16:58:40.259Z,1745859520.259 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2025-04-28T16:58:40.259Z,1745859520.259 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Navigation.cfg
2025-04-28T16:58:40.372Z,1745859520.372 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/vehicle.cfg
2025-04-28T16:58:40.480Z,1745859520.480 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/BIT.cfg
2025-04-28T16:58:40.599Z,1745859520.599 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Sensor.cfg
2025-04-28T16:58:40.742Z,1745859520.742 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Control.cfg
2025-04-28T16:58:40.852Z,1745859520.852 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/logger.cfg
2025-04-28T16:58:40.971Z,1745859520.971 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/secure.cfg
2025-04-28T16:58:41.066Z,1745859521.066 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Servo.cfg
2025-04-28T16:58:41.192Z,1745859521.192 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Simulator.cfg
2025-04-28T16:58:41.290Z,1745859521.290 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-opah/root/
2025-04-28T16:58:41.290Z,1745859521.290 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2025-04-28T16:58:41.297Z,1745859521.297 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2025-04-28T16:58:41.307Z,1745859521.307 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2025-04-28T16:58:41.308Z,1745859521.308 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2025-04-28T16:58:41.420Z,1745859521.420 [DeadReckonUsingMultipleVelocitySources] Loaded
2025-04-28T16:58:41.420Z,1745859521.420 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2025-04-28T16:58:41.460Z,1745859521.460 [DeadReckonWithRespectToSeafloor] Loaded
2025-04-28T16:58:41.460Z,1745859521.460 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2025-04-28T16:58:41.473Z,1745859521.473 [NavChart] Loaded
2025-04-28T16:58:41.473Z,1745859521.473 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2025-04-28T16:58:41.479Z,1745859521.479 [UniversalFixResidualReporter] Loaded
2025-04-28T16:58:41.479Z,1745859521.479 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2025-04-28T16:58:41.479Z,1745859521.479 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2025-04-28T16:58:41.480Z,1745859521.480 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2025-04-28T16:58:41.954Z,1745859521.954 [AHRS_M2] Loaded
2025-04-28T16:58:41.955Z,1745859521.955 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2025-04-28T16:58:41.992Z,1745859521.992 [BackseatComponent](INFO): Found secondary power supply at: /dev/loadC3
2025-04-28T16:58:41.993Z,1745859521.993 [BackseatComponent] Loaded
2025-04-28T16:58:41.993Z,1745859521.993 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2025-04-28T16:58:41.994Z,1745859521.994 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4085D4E0
2025-04-28T16:58:41.995Z,1745859521.995 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 4449
2025-04-28T16:58:41.997Z,1745859521.997 [LcmUniversalReporter] Loaded
2025-04-28T16:58:41.998Z,1745859521.998 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2025-04-28T16:58:42.092Z,1745859522.092 [DAT] Loaded
2025-04-28T16:58:42.092Z,1745859522.092 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2025-04-28T16:58:42.093Z,1745859522.093 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 4088D4E0
2025-04-28T16:58:42.093Z,1745859522.093 [DAT ThreadHandler](INFO): Protected caller Thread ID is 4450
2025-04-28T16:58:42.167Z,1745859522.167 [DataOverHttps] Loaded
2025-04-28T16:58:42.167Z,1745859522.167 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2025-04-28T16:58:42.168Z,1745859522.168 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408BD4E0
2025-04-28T16:58:42.168Z,1745859522.168 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 4451
2025-04-28T16:58:42.190Z,1745859522.190 [DepthKeller33X] Loaded
2025-04-28T16:58:42.190Z,1745859522.190 [ComponentRegistry](DEBUG): SyncComponent "DepthKeller33X" handled in the control thread.
2025-04-28T16:58:42.252Z,1745859522.252 [NAL9602] Loaded
2025-04-28T16:58:42.253Z,1745859522.253 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2025-04-28T16:58:42.282Z,1745859522.282 [Onboard] Loaded
2025-04-28T16:58:42.282Z,1745859522.282 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2025-04-28T16:58:42.283Z,1745859522.283 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408ED4E0
2025-04-28T16:58:42.284Z,1745859522.284 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 4452
2025-04-28T16:58:42.297Z,1745859522.297 [Power24vConverter] Loaded
2025-04-28T16:58:42.298Z,1745859522.298 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2025-04-28T16:58:42.314Z,1745859522.314 [Radio_Surface] Loaded
2025-04-28T16:58:42.315Z,1745859522.315 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2025-04-28T16:58:42.316Z,1745859522.316 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4091D4E0
2025-04-28T16:58:42.316Z,1745859522.316 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 4453
2025-04-28T16:58:42.361Z,1745859522.361 [RDI_Pathfinder] Loaded
2025-04-28T16:58:42.362Z,1745859522.362 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2025-04-28T16:58:42.363Z,1745859522.363 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2025-04-28T16:58:42.363Z,1745859522.363 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2025-04-28T16:58:42.414Z,1745859522.414 [DepthRateCalculator] Loaded
2025-04-28T16:58:42.415Z,1745859522.415 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2025-04-28T16:58:42.420Z,1745859522.420 [PitchRateCalculator] Loaded
2025-04-28T16:58:42.420Z,1745859522.420 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2025-04-28T16:58:42.429Z,1745859522.429 [SpeedCalculator] Loaded
2025-04-28T16:58:42.430Z,1745859522.430 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2025-04-28T16:58:42.434Z,1745859522.434 [YawRateCalculator] Loaded
2025-04-28T16:58:42.434Z,1745859522.434 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2025-04-28T16:58:42.456Z,1745859522.456 [ElevatorOffsetCalculator] Loaded
2025-04-28T16:58:42.457Z,1745859522.457 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2025-04-28T16:58:42.457Z,1745859522.457 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2025-04-28T16:58:42.458Z,1745859522.458 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2025-04-28T16:58:42.516Z,1745859522.516 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2025-04-28T16:58:42.516Z,1745859522.516 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2025-04-28T16:58:42.653Z,1745859522.653 [BuoyancyServo] Loaded
2025-04-28T16:58:42.654Z,1745859522.654 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2025-04-28T16:58:42.677Z,1745859522.677 [ElevatorServo] Loaded
2025-04-28T16:58:42.678Z,1745859522.678 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2025-04-28T16:58:42.700Z,1745859522.700 [MassServo] Loaded
2025-04-28T16:58:42.701Z,1745859522.701 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2025-04-28T16:58:42.723Z,1745859522.723 [RudderServo] Loaded
2025-04-28T16:58:42.723Z,1745859522.723 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2025-04-28T16:58:42.740Z,1745859522.740 [ThrusterHE] Loaded
2025-04-28T16:58:42.741Z,1745859522.741 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2025-04-28T16:58:42.741Z,1745859522.741 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2025-04-28T16:58:42.742Z,1745859522.742 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2025-04-28T16:58:42.909Z,1745859522.909 [CTD_Seabird] Loaded
2025-04-28T16:58:42.909Z,1745859522.909 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2025-04-28T16:58:42.910Z,1745859522.910 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A4E4E0
2025-04-28T16:58:42.911Z,1745859522.911 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 4454
2025-04-28T16:58:42.912Z,1745859522.912 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2025-04-28T16:58:42.912Z,1745859522.912 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2025-04-28T16:58:43.042Z,1745859523.042 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2025-04-28T16:58:43.043Z,1745859523.043 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2025-04-28T16:58:43.220Z,1745859523.220 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2025-04-28T16:58:43.221Z,1745859523.221 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2025-04-28T16:58:43.567Z,1745859523.567 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2025-04-28T16:58:43.567Z,1745859523.567 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2025-04-28T16:58:43.620Z,1745859523.620 [VerticalControl](DEBUG): Construct VerticalControl.
2025-04-28T16:58:43.672Z,1745859523.672 [VerticalControl] Loaded
2025-04-28T16:58:43.672Z,1745859523.672 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2025-04-28T16:58:43.675Z,1745859523.675 [HorizontalControl](DEBUG): Construct HorizontalControl.
2025-04-28T16:58:43.721Z,1745859523.721 [HorizontalControl] Loaded
2025-04-28T16:58:43.721Z,1745859523.721 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2025-04-28T16:58:43.723Z,1745859523.723 [SpeedControl](DEBUG): Construct SpeedControl.
2025-04-28T16:58:43.725Z,1745859523.725 [SpeedControl] Loaded
2025-04-28T16:58:43.725Z,1745859523.725 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2025-04-28T16:58:43.728Z,1745859523.728 [LoopControl](DEBUG): Construct LoopControl.
2025-04-28T16:58:43.728Z,1745859523.728 [LoopControl] Loaded
2025-04-28T16:58:43.729Z,1745859523.729 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2025-04-28T16:58:43.729Z,1745859523.729 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2025-04-28T16:58:43.730Z,1745859523.730 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2025-04-28T16:58:43.891Z,1745859523.891 [SBIT](DEBUG): Construct Startup Built In Test.
2025-04-28T16:58:43.900Z,1745859523.900 [SBIT] Loaded
2025-04-28T16:58:43.901Z,1745859523.901 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2025-04-28T16:58:43.904Z,1745859523.904 [IBIT](DEBUG): Construct Initiated Built In Test.
2025-04-28T16:58:43.917Z,1745859523.917 [IBIT] Loaded
2025-04-28T16:58:43.917Z,1745859523.917 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2025-04-28T16:58:43.922Z,1745859523.922 [CBIT](DEBUG): Construct Continuous Built In Test.
2025-04-28T16:58:44.122Z,1745859524.122 [CBIT] Loaded
2025-04-28T16:58:44.122Z,1745859524.122 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2025-04-28T16:58:44.153Z,1745859524.153 [GFScanner] Loaded
2025-04-28T16:58:44.154Z,1745859524.154 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread.
2025-04-28T16:58:44.154Z,1745859524.154 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2025-04-28T16:58:44.155Z,1745859524.155 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2025-04-28T16:58:44.184Z,1745859524.184 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2025-04-28T16:58:44.190Z,1745859524.190 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2025-04-28T16:58:44.193Z,1745859524.193 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2025-04-28T16:58:44.204Z,1745859524.204 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2025-04-28T16:58:44.205Z,1745859524.205 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C354E0
2025-04-28T16:58:44.205Z,1745859524.205 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 4455
2025-04-28T16:58:44.210Z,1745859524.210 [Supervisor](INFO): Main Thread ID is 4361
2025-04-28T16:58:44.210Z,1745859524.210 [Supervisor](DEBUG): Running supervisor.
2025-04-28T16:58:44.210Z,1745859524.210 [CommandExec ThreadHandler](INFO): Handler Thread ID is 4456
2025-04-28T16:58:44.211Z,1745859524.211 [CommandExec](INFO): Initializing the command executive.
2025-04-28T16:58:44.213Z,1745859524.213 [CommandLine ThreadHandler](INFO): Handler Thread ID is 4457
2025-04-28T16:58:44.215Z,1745859524.215 [controlThread ThreadHandler](INFO): Handler Thread ID is 4458
2025-04-28T16:58:44.215Z,1745859524.215 [controlThread](DEBUG): Initializing ControlThread
2025-04-28T16:58:44.217Z,1745859524.217 [NavChart](DEBUG): Initialize NavChart Navigation.
2025-04-28T16:58:44.217Z,1745859524.217 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2025-04-28T16:58:44.219Z,1745859524.219 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2025-04-28T16:58:44.219Z,1745859524.219 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2025-04-28T16:58:44.220Z,1745859524.220 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2025-04-28T16:58:44.220Z,1745859524.220 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2025-04-28T16:58:44.220Z,1745859524.220 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2025-04-28T16:58:44.222Z,1745859524.222 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2025-04-28T16:58:44.224Z,1745859524.224 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2025-04-28T16:58:44.224Z,1745859524.224 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2025-04-28T16:58:44.225Z,1745859524.225 [LoopControl](DEBUG): Initialize LoopControlComponent.
2025-04-28T16:58:44.225Z,1745859524.225 [SBIT](INFO): Initialize SBIT Component.
2025-04-28T16:58:44.226Z,1745859524.226 [SBIT](IMPORTANT): git: 2025-04-24
2025-04-28T16:58:44.226Z,1745859524.226 [SBIT](INFO): git hash: ed8b2699e10264a13705e958152987274a27a0ee
2025-04-28T16:58:44.226Z,1745859524.226 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2025-04-28T16:58:44.227Z,1745859524.227 [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-28T16:58:44.228Z,1745859524.228 [SBIT](INFO): Beginning SBIT in 39.000000 seconds.
2025-04-28T16:58:44.229Z,1745859524.229 [IBIT](INFO): Initialize IBIT Component.
2025-04-28T16:58:44.230Z,1745859524.230 [CBIT](DEBUG): Initialize CBIT Component.
2025-04-28T16:58:44.231Z,1745859524.231 [logger ThreadHandler](INFO): Handler Thread ID is 4459
2025-04-28T16:58:44.242Z,1745859524.242 [CBIT](DEBUG): Initialized mux pins.
2025-04-28T16:58:44.242Z,1745859524.242 [CBIT](DEBUG): Initializing the watchdog timer.
2025-04-28T16:58:44.250Z,1745859524.250 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 4460
2025-04-28T16:58:44.266Z,1745859524.266 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2025-04-28T16:58:44.266Z,1745859524.266 [CBIT](DEBUG): Initializing heartbeat.
2025-04-28T16:58:44.267Z,1745859524.267 [DAT ThreadHandler](INFO): Handler Thread ID is 4461
2025-04-28T16:58:44.267Z,1745859524.267 [DAT](INFO): Powering up
2025-04-28T16:58:44.268Z,1745859524.268 [DAT](DEBUG): Initializing DAT.
2025-04-28T16:58:44.271Z,1745859524.271 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 4463
2025-04-28T16:58:44.273Z,1745859524.273 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2025-04-28T16:58:44.294Z,1745859524.294 [Onboard ThreadHandler](INFO): Handler Thread ID is 4464
2025-04-28T16:58:44.311Z,1745859524.311 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 4465
2025-04-28T16:58:44.327Z,1745859524.327 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 4466
2025-04-28T16:58:44.328Z,1745859524.328 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2025-04-28T16:58:44.335Z,1745859524.335 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 4468
2025-04-28T16:58:44.338Z,1745859524.338 [CBIT](DEBUG): Deactivating emergency mode.
2025-04-28T16:58:44.338Z,1745859524.338 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2025-04-28T16:58:44.338Z,1745859524.338 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2025-04-28T16:58:44.338Z,1745859524.338 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2025-04-28T16:58:44.338Z,1745859524.338 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2025-04-28T16:58:44.339Z,1745859524.339 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2025-04-28T16:58:44.339Z,1745859524.339 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2025-04-28T16:58:44.339Z,1745859524.339 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2025-04-28T16:58:44.339Z,1745859524.339 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2025-04-28T16:58:44.378Z,1745859524.378 [CBIT](DEBUG): Backplane powered.
2025-04-28T16:58:44.378Z,1745859524.378 [GFScanner](DEBUG): Initializing GFScanner
2025-04-28T16:58:44.378Z,1745859524.378 [GFScanner](DEBUG): Deactivating GF circuits.
2025-04-28T16:58:44.383Z,1745859524.383 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2025-04-28T16:58:44.383Z,1745859524.383 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2025-04-28T16:58:44.384Z,1745859524.384 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2025-04-28T16:58:44.385Z,1745859524.385 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2025-04-28T16:58:44.467Z,1745859524.467 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
<?xml version="1.0" encoding="UTF-8" ?>
<!--generated by tl2xml-->
<Mission Id="Startup">
    <Guidance:GoToSurface>
        <Progression />
    </Guidance:GoToSurface>
    <Aggregate Id="StartupSatComms">
        <Sequence />
        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:latitude_fix />
        </ReadDatum>
        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:platform_communications />
        </ReadDatum>
    </Aggregate>
</Mission>

2025-04-28T16:58:44.495Z,1745859524.495 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2025-04-28T16:58:44.630Z,1745859524.630 [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-28T16:58:44.631Z,1745859524.631 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2025-04-28T16:58:44.631Z,1745859524.631 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2025-04-28T16:58:44.632Z,1745859524.632 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2025-04-28T16:58:44.718Z,1745859524.718 [Radio_Surface](INFO): Powering up
2025-04-28T16:58:45.072Z,1745859525.072 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into:
<?xml version="1.0" encoding="UTF-8" ?>
<!--generated by tl2xml-->
<Mission Id="Default">
    <DefineArg Name="ElapsedSinceDefaultStarted">
        <Units:minute />
        <Value>0</Value>
    </DefineArg>
    <Guidance:Wait>
        <Sequence />
        <Setting>
            <Guidance:Wait.duration />
            <Units:second />
            <Value>13</Value>
        </Setting>
    </Guidance:Wait>
    <Guidance:GoToSurface>
        <Progression />
    </Guidance:GoToSurface>
    <Aggregate Id="CheckIn">
        <Sequence Repeat="288" />
        <ReadDatum Id="Read_GPS">
            <Timeout Duration="P5M" />
            <Universal:time_fix />
        </ReadDatum>
        <ReadDatum Id="Read_Iridium">
            <Timeout Duration="P4H">
                <Guidance:Execute>
                    <Sequence />
                    <Setting>
                        <Guidance:Execute.command />
                        <String>Burn on</String>
                    </Setting>
                </Guidance:Execute>
                <Syslog Severity="Critical">Dropped weight due to communications timeout.</Syslog>
            </Timeout>
            <Universal:platform_communications />
        </ReadDatum>
        <Guidance:Wait>
            <Sequence />
            <Setting>
                <Guidance:Wait.duration />
                <Units:minute />
                <Value>5</Value>
            </Setting>
        </Guidance:Wait>
        <Assign>
            <Sequence />
            <Arg Name="ElapsedSinceDefaultStarted" />
            <Elapsed>
                <Universal:mission_started />
            </Elapsed>
        </Assign>
        <Syslog Severity="Important">
            Default mission has been running for 
            <Arg Name="ElapsedSinceDefaultStarted" />
            <Units:minute />
        </Syslog>
    </Aggregate>
    <Syslog Severity="Important">Restarting logs and Default mission.</Syslog>
    <Guidance:Execute>
        <Sequence />
        <Setting>
            <Guidance:Execute.command />
            <String>restart logs</String>
        </Setting>
    </Guidance:Execute>
</Mission>

2025-04-28T16:58:45.094Z,1745859525.094 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2025-04-28T16:58:45.095Z,1745859525.095 [Default:A.Wait](DEBUG): Construct Wait.
2025-04-28T16:58:45.114Z,1745859525.114 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2025-04-28T16:58:45.151Z,1745859525.151 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2025-04-28T16:58:45.178Z,1745859525.178 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2025-04-28T16:58:45.184Z,1745859525.184 [Default:E.Execute](DEBUG): Construct Execute.
2025-04-28T16:58:45.199Z,1745859525.199 [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-28T16:58:45.203Z,1745859525.203 [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-28T16:58:45.231Z,1745859525.231 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2025-04-28T16:58:45.266Z,1745859525.266 [DepthKeller33X](INFO): Initializing.
2025-04-28T16:58:45.302Z,1745859525.302 [Power24vConverter](INFO): Powering up.
2025-04-28T16:58:45.303Z,1745859525.303 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2025-04-28T16:58:45.310Z,1745859525.310 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-28T16:58:45.338Z,1745859525.338 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2025-04-28T16:58:45.346Z,1745859525.346 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2025-04-28T16:58:45.347Z,1745859525.347 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-04-28T16:58:45.355Z,1745859525.355 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-04-28T16:58:45.355Z,1745859525.355 [MassServo](DEBUG): Initializing EZServoServo.
2025-04-28T16:58:45.362Z,1745859525.362 [MassServo](DEBUG): Initializing MassServo.
2025-04-28T16:58:45.363Z,1745859525.363 [RudderServo](DEBUG): Initializing EZServoServo.
2025-04-28T16:58:45.370Z,1745859525.370 [RudderServo](DEBUG): Initializing RudderServo.
2025-04-28T16:58:45.372Z,1745859525.372 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-04-28T16:58:45.378Z,1745859525.378 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-04-28T16:58:45.654Z,1745859525.654 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-28T16:58:46.017Z,1745859526.017 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-28T16:58:46.424Z,1745859526.424 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-28T16:58:46.847Z,1745859526.847 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-28T16:58:47.649Z,1745859527.649 [ThrusterHE](FAULT): Thruster failed to initialize
2025-04-28T16:58:47.650Z,1745859527.650 [ThrusterHE] Communications Fault, FailCount= 1
2025-04-28T16:58:47.650Z,1745859527.650 [ThrusterHE](ERROR): Communications Fault
2025-04-28T16:58:47.653Z,1745859527.653 [CBIT](ERROR): Communications Fault in component: ThrusterHE
2025-04-28T16:58:48.171Z,1745859528.171 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2025-04-28T16:58:48.171Z,1745859528.171 [ThrusterHE](INFO): Powering down
2025-04-28T16:58:48.543Z,1745859528.543 [Power24vConverter](FAULT): LCB fault:  Current Limiter Activated.
2025-04-28T16:58:48.544Z,1745859528.544 [Power24vConverter] Hardware Fault, FailCount= 1
2025-04-28T16:58:48.544Z,1745859528.544 [Power24vConverter](ERROR): Hardware Fault
2025-04-28T16:58:48.544Z,1745859528.544 [Power24vConverter](INFO): Powering down.
2025-04-28T16:58:48.545Z,1745859528.545 [Power24vConverter](FAULT): 24V Power is reporting not powering/powered.
2025-04-28T16:58:48.558Z,1745859528.558 [CBIT](ERROR): Hardware Fault in component: Power24vConverter
2025-04-28T16:58:48.911Z,1745859528.911 [Power24vConverter](INFO): Powering down.
2025-04-28T16:58:49.229Z,1745859529.229 [CBIT](INFO): Clearing failed state for component ThrusterHE
2025-04-28T16:58:49.229Z,1745859529.229 [ThrusterHE] No Fault, FailCount= 1
2025-04-28T16:58:49.279Z,1745859529.279 [Power24vConverter](FAULT):  LCB fault:  Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-28T16:58:49.347Z,1745859529.347 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-04-28T16:58:49.348Z,1745859529.348 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-04-28T16:58:49.750Z,1745859529.750 [Power24vConverter](INFO): Powering down.
2025-04-28T16:58:50.098Z,1745859530.098 [Power24vConverter](FAULT):  LCB fault:  Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-28T16:58:50.515Z,1745859530.515 [Power24vConverter](INFO): Powering down.
2025-04-28T16:58:50.931Z,1745859530.931 [Power24vConverter](FAULT):  LCB fault:  Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-28T16:58:51.311Z,1745859531.311 [Power24vConverter](INFO): Powering down.
2025-04-28T16:58:51.372Z,1745859531.372 [ThrusterHE](FAULT): Thruster failed to initialize
2025-04-28T16:58:51.372Z,1745859531.372 [ThrusterHE] Communications Fault, FailCount= 2
2025-04-28T16:58:51.372Z,1745859531.372 [ThrusterHE](ERROR): Communications Fault
2025-04-28T16:58:51.376Z,1745859531.376 [CBIT](ERROR): Communications Fault in component: ThrusterHE
2025-04-28T16:58:51.718Z,1745859531.718 [Power24vConverter](FAULT):  LCB fault:  Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-28T16:58:51.755Z,1745859531.755 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2025-04-28T16:58:51.755Z,1745859531.755 [ThrusterHE](INFO): Powering down
2025-04-28T16:58:52.122Z,1745859532.122 [Power24vConverter](INFO): Powering down.
2025-04-28T16:58:52.527Z,1745859532.527 [Power24vConverter](FAULT):  LCB fault:  Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-28T16:58:52.713Z,1745859532.713 [CBIT](INFO): Clearing failed state for component ThrusterHE
2025-04-28T16:58:52.713Z,1745859532.713 [ThrusterHE] No Fault, FailCount= 2
2025-04-28T16:58:52.943Z,1745859532.943 [Power24vConverter](INFO): Powering down.
2025-04-28T16:58:53.014Z,1745859533.014 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-04-28T16:58:53.030Z,1745859533.030 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-04-28T16:58:53.356Z,1745859533.356 [Power24vConverter](FAULT):  LCB fault:  Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-28T16:58:53.738Z,1745859533.738 [Power24vConverter](INFO): Powering down.
2025-04-28T16:58:54.139Z,1745859534.139 [Power24vConverter](FAULT):  LCB fault:  Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-28T16:58:54.507Z,1745859534.507 [Power24vConverter](INFO): Powering down.
2025-04-28T16:58:54.914Z,1745859534.914 [Power24vConverter](FAULT):  LCB fault:  Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-28T16:58:55.327Z,1745859535.327 [Power24vConverter](INFO): Powering down.
2025-04-28T16:58:55.395Z,1745859535.395 [ThrusterHE](FAULT): Thruster failed to initialize
2025-04-28T16:58:55.395Z,1745859535.395 [ThrusterHE] Communications Fault, FailCount= 3
2025-04-28T16:58:55.395Z,1745859535.395 [ThrusterHE](ERROR): Communications Fault
2025-04-28T16:58:55.399Z,1745859535.399 [CBIT](ERROR): Communications Fault in component: ThrusterHE
2025-04-28T16:58:55.743Z,1745859535.743 [Power24vConverter](FAULT):  LCB fault:  Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-28T16:58:55.806Z,1745859535.806 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2025-04-28T16:58:55.807Z,1745859535.807 [ThrusterHE](INFO): Powering down
2025-04-28T16:58:55.937Z,1745859535.937 [CommandExec](IMPORTANT): got command report mod platform_buoyancy_position
2025-04-28T16:58:56.124Z,1745859536.124 [Power24vConverter](INFO): Powering down.
2025-04-28T16:58:56.347Z,1745859536.347 [Reporter](INFO): platform_buoyancy_position 2012.903320 cc
2025-04-28T16:58:56.713Z,1745859536.713 [CBIT](INFO): Clearing failed state for component ThrusterHE
2025-04-28T16:58:56.713Z,1745859536.713 [ThrusterHE] No Fault, FailCount= 3
2025-04-28T16:58:56.716Z,1745859536.716 [Reporter](INFO): platform_buoyancy_position 1999.798218 cc
2025-04-28T16:58:56.933Z,1745859536.933 [Power24vConverter](INFO): Powering up.
2025-04-28T16:58:56.995Z,1745859536.995 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-04-28T16:58:57.006Z,1745859537.006 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-04-28T16:58:57.009Z,1745859537.009 [CBIT](INFO): Clearing failed state for component Power24vConverter
2025-04-28T16:58:57.010Z,1745859537.010 [Power24vConverter] No Fault, FailCount= 1
2025-04-28T16:58:57.012Z,1745859537.012 [Reporter](INFO): platform_buoyancy_position 1996.572632 cc
2025-04-28T16:58:57.421Z,1745859537.421 [Reporter](INFO): platform_buoyancy_position 1996.774170 cc
2025-04-28T16:58:57.832Z,1745859537.832 [Reporter](INFO): platform_buoyancy_position 1993.548340 cc
2025-04-28T16:58:58.240Z,1745859538.240 [Reporter](INFO): platform_buoyancy_position 1990.322510 cc
2025-04-28T16:58:59.023Z,1745859539.023 [ThrusterHE](FAULT): Thruster failed to initialize
2025-04-28T16:58:59.023Z,1745859539.023 [ThrusterHE] Communications Fault, FailCount= 4
2025-04-28T16:58:59.023Z,1745859539.023 [ThrusterHE](ERROR): Communications Fault
2025-04-28T16:58:59.027Z,1745859539.027 [CBIT](ERROR): Communications Fault in component: ThrusterHE
2025-04-28T16:58:59.029Z,1745859539.029 [Reporter](INFO): platform_buoyancy_position 1987.096680 cc
2025-04-28T16:58:59.435Z,1745859539.435 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2025-04-28T16:58:59.435Z,1745859539.435 [ThrusterHE](INFO): Powering down
2025-04-28T16:58:59.442Z,1745859539.442 [Reporter](INFO): platform_buoyancy_position 1986.895264 cc
2025-04-28T16:58:59.856Z,1745859539.856 [Reporter](INFO): platform_buoyancy_position 1983.870728 cc
2025-04-28T16:59:00.493Z,1745859540.493 [CBIT](INFO): Clearing failed state for component ThrusterHE
2025-04-28T16:59:00.493Z,1745859540.493 [ThrusterHE] No Fault, FailCount= 4
2025-04-28T16:59:00.496Z,1745859540.496 [Reporter](INFO): platform_buoyancy_position 1980.645386 cc
2025-04-28T16:59:00.568Z,1745859540.568 [Power24vConverter](FAULT): LCB fault:  Current Limiter Activated.
2025-04-28T16:59:00.568Z,1745859540.568 [Power24vConverter] Hardware Fault, FailCount= 1
2025-04-28T16:59:00.568Z,1745859540.568 [Power24vConverter](ERROR): Hardware Fault
2025-04-28T16:59:00.568Z,1745859540.568 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:00.569Z,1745859540.569 [Power24vConverter](FAULT): 24V Power is reporting not powering/powered.
2025-04-28T16:59:00.644Z,1745859540.644 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004830
2025-04-28T16:59:00.755Z,1745859540.755 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-04-28T16:59:00.757Z,1745859540.757 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-04-28T16:59:00.763Z,1745859540.763 [CBIT](ERROR): Hardware Fault in component: Power24vConverter
2025-04-28T16:59:00.974Z,1745859540.974 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:01.157Z,1745859541.157 [Reporter](INFO): platform_buoyancy_position 1977.217896 cc
2025-04-28T16:59:01.387Z,1745859541.387 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:01.807Z,1745859541.807 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:01.984Z,1745859541.984 [Reporter](INFO): platform_buoyancy_position 1974.193604 cc
2025-04-28T16:59:02.219Z,1745859542.219 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:02.397Z,1745859542.397 [Reporter](INFO): platform_buoyancy_position 1972.983765 cc
2025-04-28T16:59:02.587Z,1745859542.587 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:02.777Z,1745859542.777 [ThrusterHE](FAULT): Thruster failed to initialize
2025-04-28T16:59:02.777Z,1745859542.777 [ThrusterHE] Communications Fault, FailCount= 5
2025-04-28T16:59:02.777Z,1745859542.777 [ThrusterHE](ERROR): Communications Fault
2025-04-28T16:59:02.781Z,1745859542.781 [CBIT](ERROR): Communications Fault in component: ThrusterHE
2025-04-28T16:59:02.782Z,1745859542.782 [CBIT](CRITICAL): Communications Fault in component: ThrusterHE
2025-04-28T16:59:02.784Z,1745859542.784 [Reporter](INFO): platform_buoyancy_position 1970.766113 cc
2025-04-28T16:59:02.999Z,1745859542.999 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:03.171Z,1745859543.171 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2025-04-28T16:59:03.171Z,1745859543.171 [ThrusterHE](INFO): Powering down
2025-04-28T16:59:03.173Z,1745859543.173 [CommandExec](FAULT): Scheduling is paused
2025-04-28T16:59:03.173Z,1745859543.173 [CBIT](INFO): Critical error at 20250428T165902
2025-04-28T16:59:03.173Z,1745859543.173 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2025-04-28T16:59:03.179Z,1745859543.179 [Reporter](INFO): platform_buoyancy_position 1967.741821 cc
2025-04-28T16:59:03.407Z,1745859543.407 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:03.819Z,1745859543.819 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:04.087Z,1745859544.087 [Reporter](INFO): platform_buoyancy_position 1964.919556 cc
2025-04-28T16:59:04.231Z,1745859544.231 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:04.368Z,1745859544.368 [Reporter](INFO): platform_buoyancy_position 1964.314331 cc
2025-04-28T16:59:04.612Z,1745859544.612 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:04.773Z,1745859544.773 [Reporter](INFO): platform_buoyancy_position 1961.290405 cc
2025-04-28T16:59:05.024Z,1745859545.024 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:05.186Z,1745859545.186 [Reporter](INFO): platform_buoyancy_position 1961.088745 cc
2025-04-28T16:59:05.423Z,1745859545.423 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:05.574Z,1745859545.574 [Reporter](INFO): platform_buoyancy_position 1958.064453 cc
2025-04-28T16:59:05.839Z,1745859545.839 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:06.259Z,1745859546.259 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:06.633Z,1745859546.633 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:07.038Z,1745859547.038 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:07.442Z,1745859547.442 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:07.443Z,1745859547.443 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2025-04-28T16:59:07.444Z,1745859547.444 [RDI_Pathfinder] Communications Fault, FailCount= 1
2025-04-28T16:59:07.444Z,1745859547.444 [RDI_Pathfinder](ERROR): Communications Fault
2025-04-28T16:59:07.586Z,1745859547.586 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2025-04-28T16:59:07.859Z,1745859547.859 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:07.926Z,1745859547.926 [RDI_Pathfinder](INFO): Powering down
2025-04-28T16:59:08.284Z,1745859548.284 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:08.652Z,1745859548.652 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:08.726Z,1745859548.726 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2025-04-28T16:59:08.726Z,1745859548.726 [RDI_Pathfinder] No Fault, FailCount= 1
2025-04-28T16:59:09.057Z,1745859549.057 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:09.058Z,1745859549.058 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2025-04-28T16:59:09.462Z,1745859549.462 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:09.875Z,1745859549.875 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:10.291Z,1745859550.291 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:10.673Z,1745859550.673 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:11.075Z,1745859551.075 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:11.481Z,1745859551.481 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:11.895Z,1745859551.895 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:12.311Z,1745859552.311 [NAL9602](INFO): Powering up NAL9602
2025-04-28T16:59:12.312Z,1745859552.312 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:12.689Z,1745859552.689 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:13.092Z,1745859553.092 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:13.497Z,1745859553.497 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:13.919Z,1745859553.919 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:14.330Z,1745859554.330 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:14.707Z,1745859554.707 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:15.112Z,1745859555.112 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:15.518Z,1745859555.518 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:15.931Z,1745859555.931 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:16.348Z,1745859556.348 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:16.727Z,1745859556.727 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:17.133Z,1745859557.133 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:17.537Z,1745859557.537 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:17.955Z,1745859557.955 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:18.367Z,1745859558.367 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:18.775Z,1745859558.775 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:19.151Z,1745859559.151 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:19.558Z,1745859559.558 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:19.971Z,1745859559.971 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:20.379Z,1745859560.379 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:20.795Z,1745859560.795 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:21.171Z,1745859561.171 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:21.578Z,1745859561.578 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:21.983Z,1745859561.983 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:22.395Z,1745859562.395 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:22.826Z,1745859562.826 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:23.191Z,1745859563.191 [NAL9602](INFO): NAL9602 initialized
2025-04-28T16:59:23.192Z,1745859563.192 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:23.599Z,1745859563.599 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:24.014Z,1745859564.014 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:24.026Z,1745859564.026 [SBIT](IMPORTANT): Beginning Startup BIT
2025-04-28T16:59:24.035Z,1745859564.035 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-04-28T16:59:24.430Z,1745859564.430 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:25.240Z,1745859565.240 [Power24vConverter](INFO): Powering up.
2025-04-28T16:59:25.282Z,1745859565.282 [CBIT](INFO): Clearing failed state for component Power24vConverter
2025-04-28T16:59:25.282Z,1745859565.282 [Power24vConverter] No Fault, FailCount= 1
2025-04-28T16:59:26.492Z,1745859566.492 [CommandExec](IMPORTANT): got command strobe off
2025-04-28T16:59:26.492Z,1745859566.492 [CommandExec](IMPORTANT): Deactivating strobe
2025-04-28T16:59:28.675Z,1745859568.675 [GFScanner](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.001441
CHAN A1 (24V): -0.130361
CHAN A2 (12V): -0.000177
CHAN A3 (5V): -0.022213
CHAN B0 (3.3V): -0.000319
CHAN B1 (3.15aV): -0.000861
CHAN B2 (3.15bV): -0.000328
CHAN B3 (GND): -0.000472
OPEN: 0.004711
Full Scale: +/- 1 mA
2025-04-28T16:59:30.064Z,1745859570.064 [Power24vConverter](FAULT): LCB fault:  Current Limiter Activated.
2025-04-28T16:59:30.064Z,1745859570.064 [Power24vConverter] Hardware Fault, FailCount= 1
2025-04-28T16:59:30.064Z,1745859570.064 [Power24vConverter](ERROR): Hardware Fault
2025-04-28T16:59:30.064Z,1745859570.064 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:30.065Z,1745859570.065 [Power24vConverter](FAULT): 24V Power is reporting not powering/powered.
2025-04-28T16:59:30.246Z,1745859570.246 [CBIT](ERROR): Hardware Fault in component: Power24vConverter
2025-04-28T16:59:30.466Z,1745859570.466 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:30.880Z,1745859570.880 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:31.295Z,1745859571.295 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:31.296Z,1745859571.296 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2025-04-28T16:59:31.297Z,1745859571.297 [RDI_Pathfinder] Communications Fault, FailCount= 2
2025-04-28T16:59:31.297Z,1745859571.297 [RDI_Pathfinder](ERROR): Communications Fault
2025-04-28T16:59:31.482Z,1745859571.482 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2025-04-28T16:59:31.690Z,1745859571.690 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:31.758Z,1745859571.758 [RDI_Pathfinder](INFO): Powering down
2025-04-28T16:59:32.094Z,1745859572.094 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:32.498Z,1745859572.498 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:32.778Z,1745859572.778 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2025-04-28T16:59:32.778Z,1745859572.778 [RDI_Pathfinder] No Fault, FailCount= 2
2025-04-28T16:59:32.910Z,1745859572.910 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:32.911Z,1745859572.911 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2025-04-28T16:59:33.319Z,1745859573.319 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:33.695Z,1745859573.695 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:34.101Z,1745859574.101 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:34.506Z,1745859574.506 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:34.920Z,1745859574.920 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:35.340Z,1745859575.340 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:35.717Z,1745859575.717 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:36.120Z,1745859576.120 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:36.528Z,1745859576.528 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:36.954Z,1745859576.954 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:37.370Z,1745859577.370 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:37.750Z,1745859577.750 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:38.154Z,1745859578.154 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:38.545Z,1745859578.545 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:38.960Z,1745859578.960 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:39.379Z,1745859579.379 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:40.160Z,1745859580.160 [Power24vConverter](INFO): Powering up.
2025-04-28T16:59:40.275Z,1745859580.275 [CBIT](INFO): Clearing failed state for component Power24vConverter
2025-04-28T16:59:40.275Z,1745859580.275 [Power24vConverter] No Fault, FailCount= 1
2025-04-28T16:59:44.510Z,1745859584.510 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2025-04-28T16:59:44.510Z,1745859584.510 [DAT] Communications Fault, FailCount= 1
2025-04-28T16:59:44.510Z,1745859584.510 [DAT](ERROR): Communications Fault
2025-04-28T16:59:44.775Z,1745859584.775 [CBIT](ERROR): Communications Fault in component: DAT
2025-04-28T16:59:44.915Z,1745859584.915 [DAT](INFO): Powering down
2025-04-28T16:59:45.020Z,1745859585.020 [Power24vConverter](FAULT): LCB fault:  Current Limiter Activated.
2025-04-28T16:59:45.020Z,1745859585.020 [Power24vConverter] Hardware Fault, FailCount= 1
2025-04-28T16:59:45.020Z,1745859585.020 [Power24vConverter](ERROR): Hardware Fault
2025-04-28T16:59:45.020Z,1745859585.020 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:45.021Z,1745859585.021 [Power24vConverter](FAULT): 24V Power is reporting not powering/powered.
2025-04-28T16:59:45.091Z,1745859585.091 [CBIT](ERROR): Hardware Fault in component: Power24vConverter
2025-04-28T16:59:45.386Z,1745859585.386 [DAT](FAULT): LCB fault:  Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-28T16:59:45.386Z,1745859585.386 [DAT] Hardware Fault, FailCount= 1
2025-04-28T16:59:45.386Z,1745859585.386 [DAT](ERROR): Hardware Fault
2025-04-28T16:59:45.435Z,1745859585.435 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:45.844Z,1745859585.844 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:45.891Z,1745859585.891 [CBIT](INFO): Clearing failed state for component DAT
2025-04-28T16:59:45.892Z,1745859585.892 [DAT] No Fault, FailCount= 1
2025-04-28T16:59:46.220Z,1745859586.220 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:46.625Z,1745859586.625 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:47.029Z,1745859587.029 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:47.874Z,1745859587.874 [Power24vConverter](INFO): Powering up.
2025-04-28T16:59:47.914Z,1745859587.914 [CBIT](INFO): Clearing failed state for component Power24vConverter
2025-04-28T16:59:47.915Z,1745859587.915 [Power24vConverter] No Fault, FailCount= 1
2025-04-28T16:59:47.915Z,1745859587.915 [CBIT](INFO): Clearing failed state for component ThrusterHE
2025-04-28T16:59:47.915Z,1745859587.915 [ThrusterHE] No Fault, FailCount= 5
2025-04-28T16:59:47.958Z,1745859587.958 [DAT](INFO): Powering up
2025-04-28T16:59:47.958Z,1745859587.958 [DAT](DEBUG): Initializing DAT.
2025-04-28T16:59:48.291Z,1745859588.291 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-04-28T16:59:48.298Z,1745859588.298 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-04-28T16:59:49.053Z,1745859589.053 [Power24vConverter](FAULT): LCB fault:  Current Limiter Activated.
2025-04-28T16:59:49.053Z,1745859589.053 [Power24vConverter] Hardware Fault, FailCount= 1
2025-04-28T16:59:49.053Z,1745859589.053 [Power24vConverter](ERROR): Hardware Fault
2025-04-28T16:59:49.053Z,1745859589.053 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:49.054Z,1745859589.054 [Power24vConverter](FAULT): 24V Power is reporting not powering/powered.
2025-04-28T16:59:49.133Z,1745859589.133 [CBIT](ERROR): Hardware Fault in component: Power24vConverter
2025-04-28T16:59:49.463Z,1745859589.463 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:49.880Z,1745859589.880 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:50.260Z,1745859590.260 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:50.319Z,1745859590.319 [ThrusterHE](FAULT): Thruster failed to initialize
2025-04-28T16:59:50.319Z,1745859590.319 [ThrusterHE] Communications Fault, FailCount= 1
2025-04-28T16:59:50.319Z,1745859590.319 [ThrusterHE](ERROR): Communications Fault
2025-04-28T16:59:50.323Z,1745859590.323 [CBIT](ERROR): Communications Fault in component: ThrusterHE
2025-04-28T16:59:50.664Z,1745859590.664 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:50.703Z,1745859590.703 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2025-04-28T16:59:50.703Z,1745859590.703 [ThrusterHE](INFO): Powering down
2025-04-28T16:59:51.070Z,1745859591.070 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:51.484Z,1745859591.484 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T16:59:51.650Z,1745859591.650 [CBIT](INFO): Clearing failed state for component ThrusterHE
2025-04-28T16:59:51.650Z,1745859591.650 [ThrusterHE] No Fault, FailCount= 1
2025-04-28T16:59:51.895Z,1745859591.895 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:51.938Z,1745859591.938 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-04-28T16:59:51.939Z,1745859591.939 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-04-28T16:59:52.698Z,1745859592.698 [Power24vConverter](INFO): Powering up.
2025-04-28T16:59:52.763Z,1745859592.763 [CBIT](INFO): Clearing failed state for component Power24vConverter
2025-04-28T16:59:52.763Z,1745859592.763 [Power24vConverter] No Fault, FailCount= 1
2025-04-28T16:59:53.960Z,1745859593.960 [ThrusterHE](FAULT): Thruster failed to initialize
2025-04-28T16:59:53.960Z,1745859593.960 [ThrusterHE] Communications Fault, FailCount= 2
2025-04-28T16:59:53.960Z,1745859593.960 [ThrusterHE](ERROR): Communications Fault
2025-04-28T16:59:53.973Z,1745859593.973 [CBIT](ERROR): Communications Fault in component: ThrusterHE
2025-04-28T16:59:54.377Z,1745859594.377 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2025-04-28T16:59:54.379Z,1745859594.379 [ThrusterHE](INFO): Powering down
2025-04-28T16:59:55.111Z,1745859595.111 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2025-04-28T16:59:55.112Z,1745859595.112 [RDI_Pathfinder] Communications Fault, FailCount= 3
2025-04-28T16:59:55.112Z,1745859595.112 [RDI_Pathfinder](ERROR): Communications Fault
2025-04-28T16:59:55.366Z,1745859595.366 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2025-04-28T16:59:55.366Z,1745859595.366 [CBIT](CRITICAL): Communications Fault in component: RDI_Pathfinder
2025-04-28T16:59:55.367Z,1745859595.367 [CBIT](INFO): Clearing failed state for component ThrusterHE
2025-04-28T16:59:55.367Z,1745859595.367 [ThrusterHE] No Fault, FailCount= 2
2025-04-28T16:59:55.594Z,1745859595.594 [RDI_Pathfinder](INFO): Powering down
2025-04-28T16:59:55.605Z,1745859595.605 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-04-28T16:59:55.606Z,1745859595.606 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-04-28T16:59:55.608Z,1745859595.608 [CBIT](INFO): Critical error at 20250428T165955
2025-04-28T16:59:56.348Z,1745859596.348 [Power24vConverter](FAULT): LCB fault:  Current Limiter Activated.
2025-04-28T16:59:56.348Z,1745859596.348 [Power24vConverter] Hardware Fault, FailCount= 1
2025-04-28T16:59:56.348Z,1745859596.348 [Power24vConverter](ERROR): Hardware Fault
2025-04-28T16:59:56.348Z,1745859596.348 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:56.349Z,1745859596.349 [Power24vConverter](FAULT): 24V Power is reporting not powering/powered.
2025-04-28T16:59:56.377Z,1745859596.377 [CBIT](ERROR): Hardware Fault in component: Power24vConverter
2025-04-28T16:59:56.723Z,1745859596.723 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:57.131Z,1745859597.131 [Power24vConverter](FAULT):  LCB fault:  Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-28T16:59:57.545Z,1745859597.545 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:57.974Z,1745859597.974 [Power24vConverter](FAULT):  LCB fault:  Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-28T16:59:57.986Z,1745859597.986 [ThrusterHE](FAULT): Thruster failed to initialize
2025-04-28T16:59:57.986Z,1745859597.986 [ThrusterHE] Communications Fault, FailCount= 3
2025-04-28T16:59:57.986Z,1745859597.986 [ThrusterHE](ERROR): Communications Fault
2025-04-28T16:59:57.990Z,1745859597.990 [CBIT](ERROR): Communications Fault in component: ThrusterHE
2025-04-28T16:59:58.390Z,1745859598.390 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:58.402Z,1745859598.402 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2025-04-28T16:59:58.402Z,1745859598.402 [ThrusterHE](INFO): Powering down
2025-04-28T16:59:58.758Z,1745859598.758 [Power24vConverter](FAULT):  LCB fault:  Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-28T16:59:59.162Z,1745859599.162 [Power24vConverter](INFO): Powering down.
2025-04-28T16:59:59.295Z,1745859599.295 [CBIT](INFO): Clearing failed state for component ThrusterHE
2025-04-28T16:59:59.295Z,1745859599.295 [ThrusterHE] No Fault, FailCount= 3
2025-04-28T16:59:59.564Z,1745859599.564 [Power24vConverter](FAULT):  LCB fault:  Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-28T16:59:59.593Z,1745859599.593 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-04-28T16:59:59.594Z,1745859599.594 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-04-28T16:59:59.979Z,1745859599.979 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:00.365Z,1745859600.365 [Power24vConverter](FAULT):  LCB fault:  Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-28T17:00:00.765Z,1745859600.765 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:01.170Z,1745859601.170 [Power24vConverter](FAULT):  LCB fault:  Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-28T17:00:01.583Z,1745859601.583 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:02.004Z,1745859602.004 [Power24vConverter](FAULT):  LCB fault:  Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-28T17:00:02.380Z,1745859602.380 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:02.785Z,1745859602.785 [Power24vConverter](FAULT):  LCB fault:  Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-28T17:00:03.202Z,1745859603.202 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:03.614Z,1745859603.614 [Power24vConverter](FAULT):  LCB fault:  Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-28T17:00:04.034Z,1745859604.034 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:04.414Z,1745859604.414 [Power24vConverter](FAULT):  LCB fault:  Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-28T17:00:04.804Z,1745859604.804 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:05.212Z,1745859605.212 [Power24vConverter](FAULT):  LCB fault:  Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-28T17:00:05.626Z,1745859605.626 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:06.159Z,1745859606.159 [Power24vConverter](FAULT):  LCB fault:  Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-28T17:00:06.561Z,1745859606.561 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:07.380Z,1745859607.380 [Power24vConverter](INFO): Powering up.
2025-04-28T17:00:07.497Z,1745859607.497 [CBIT](INFO): Clearing failed state for component Power24vConverter
2025-04-28T17:00:07.497Z,1745859607.497 [Power24vConverter] No Fault, FailCount= 1
2025-04-28T17:00:11.006Z,1745859611.006 [Power24vConverter](FAULT): LCB fault:  Current Limiter Activated.
2025-04-28T17:00:11.006Z,1745859611.006 [Power24vConverter] Hardware Fault, FailCount= 1
2025-04-28T17:00:11.006Z,1745859611.006 [Power24vConverter](ERROR): Hardware Fault
2025-04-28T17:00:11.006Z,1745859611.006 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:11.007Z,1745859611.007 [Power24vConverter](FAULT): 24V Power is reporting not powering/powered.
2025-04-28T17:00:11.056Z,1745859611.056 [CBIT](ERROR): Hardware Fault in component: Power24vConverter
2025-04-28T17:00:11.419Z,1745859611.419 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:11.828Z,1745859611.828 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:12.239Z,1745859612.239 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:12.620Z,1745859612.620 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:13.031Z,1745859613.031 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:13.445Z,1745859613.445 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:13.858Z,1745859613.858 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:14.278Z,1745859614.278 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:14.654Z,1745859614.654 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:15.045Z,1745859615.045 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:15.452Z,1745859615.452 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:15.864Z,1745859615.864 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:16.283Z,1745859616.283 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:16.660Z,1745859616.660 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:17.063Z,1745859617.063 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:17.469Z,1745859617.469 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:17.505Z,1745859617.505 [SBIT](IMPORTANT): SBIT PASSED
2025-04-28T17:00:17.505Z,1745859617.505 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2025-04-28T17:00:17.514Z,1745859617.514 [SBIT](IMPORTANT): BPC1.loadAtStartup=0 bool;

2025-04-28T17:00:17.514Z,1745859617.514 [SBIT](IMPORTANT): DepthKeller33X.maxPressBound=2500 decibar;

2025-04-28T17:00:17.514Z,1745859617.514 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool;

2025-04-28T17:00:17.514Z,1745859617.514 [SBIT](IMPORTANT): GFScanner.simulateHardware=0 bool;

2025-04-28T17:00:17.514Z,1745859617.514 [SBIT](IMPORTANT): MassServo.limitLo=-700000 count;

2025-04-28T17:00:17.514Z,1745859617.514 [SBIT](IMPORTANT): VerticalControl.massPositionLimitAft=-5.5 centimeter;

2025-04-28T17:00:17.883Z,1745859617.883 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:17.889Z,1745859617.889 [MissionManager](IMPORTANT): Started mission Startup
2025-04-28T17:00:17.889Z,1745859617.889 [Startup] Running Loop=1
2025-04-28T17:00:17.889Z,1745859617.889 [Startup](DEBUG): Aggregate::initialize Startup
2025-04-28T17:00:17.889Z,1745859617.889 [Startup:A.GoToSurface] Running Loop=1
2025-04-28T17:00:17.889Z,1745859617.889 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-04-28T17:00:17.890Z,1745859617.890 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-04-28T17:00:17.891Z,1745859617.891 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-04-28T17:00:17.891Z,1745859617.891 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-04-28T17:00:17.891Z,1745859617.891 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-04-28T17:00:17.891Z,1745859617.891 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-04-28T17:00:17.892Z,1745859617.892 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-04-28T17:00:17.894Z,1745859617.894 [Startup:StartupSatComms] Running Loop=1
2025-04-28T17:00:17.894Z,1745859617.894 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2025-04-28T17:00:17.894Z,1745859617.894 [Startup:StartupSatComms:A] Running Loop=1
2025-04-28T17:00:18.292Z,1745859618.292 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:18.298Z,1745859618.298 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2025-04-28T17:00:18.726Z,1745859618.726 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:19.094Z,1745859619.094 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:19.502Z,1745859619.502 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:19.695Z,1745859619.695 [Reporter](INFO): platform_buoyancy_position 1967.741821 cc
2025-04-28T17:00:19.918Z,1745859619.918 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:19.998Z,1745859619.998 [Reporter](INFO): platform_buoyancy_position 1970.564453 cc
2025-04-28T17:00:20.320Z,1745859620.320 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:20.724Z,1745859620.724 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:20.904Z,1745859620.904 [Reporter](INFO): platform_buoyancy_position 1967.943481 cc
2025-04-28T17:00:21.104Z,1745859621.104 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:21.155Z,1745859621.155 [Reporter](INFO): platform_buoyancy_position 1970.766113 cc
2025-04-28T17:00:21.510Z,1745859621.510 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:21.565Z,1745859621.565 [Reporter](INFO): platform_buoyancy_position 1973.790405 cc
2025-04-28T17:00:21.913Z,1745859621.913 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:21.962Z,1745859621.962 [Reporter](INFO): platform_buoyancy_position 1961.290405 cc
2025-04-28T17:00:22.328Z,1745859622.328 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:22.393Z,1745859622.393 [Reporter](INFO): platform_buoyancy_position 1967.943481 cc
2025-04-28T17:00:22.740Z,1745859622.740 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:22.800Z,1745859622.800 [Reporter](INFO): platform_buoyancy_position 1971.169434 cc
2025-04-28T17:00:23.152Z,1745859623.152 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:23.310Z,1745859623.310 [Reporter](INFO): platform_buoyancy_position 1977.217896 cc
2025-04-28T17:00:23.528Z,1745859623.528 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:23.699Z,1745859623.699 [Reporter](INFO): platform_buoyancy_position 1980.645386 cc
2025-04-28T17:00:23.946Z,1745859623.946 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:24.096Z,1745859624.096 [Reporter](INFO): platform_buoyancy_position 1983.870728 cc
2025-04-28T17:00:24.358Z,1745859624.358 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:24.520Z,1745859624.520 [Reporter](INFO): platform_buoyancy_position 1987.096680 cc
2025-04-28T17:00:24.770Z,1745859624.770 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:24.928Z,1745859624.928 [Reporter](INFO): platform_buoyancy_position 1990.120850 cc
2025-04-28T17:00:25.157Z,1745859625.157 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:25.549Z,1745859625.549 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:25.953Z,1745859625.953 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:26.368Z,1745859626.368 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:26.783Z,1745859626.783 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:27.163Z,1745859627.163 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:27.570Z,1745859627.570 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:27.979Z,1745859627.979 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:28.391Z,1745859628.391 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:28.811Z,1745859628.811 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:29.198Z,1745859629.198 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:29.606Z,1745859629.606 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:30.009Z,1745859630.009 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:30.422Z,1745859630.422 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:30.823Z,1745859630.823 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:31.231Z,1745859631.231 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:31.607Z,1745859631.607 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:32.013Z,1745859632.013 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:32.427Z,1745859632.427 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:32.840Z,1745859632.840 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:33.251Z,1745859633.251 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:33.628Z,1745859633.628 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:34.033Z,1745859634.033 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:34.454Z,1745859634.454 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:34.866Z,1745859634.866 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:35.286Z,1745859635.286 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:35.662Z,1745859635.662 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:36.058Z,1745859636.058 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:36.457Z,1745859636.457 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:36.872Z,1745859636.872 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:37.291Z,1745859637.291 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:37.676Z,1745859637.676 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:38.073Z,1745859638.073 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:38.518Z,1745859638.518 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:38.903Z,1745859638.903 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:39.316Z,1745859639.316 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:39.550Z,1745859639.550 [CommandExec](IMPORTANT): got command failComponent
2025-04-28T17:00:39.551Z,1745859639.551 [CommandExec](IMPORTANT): Failed components:
2025-04-28T17:00:39.551Z,1745859639.551 [CommandExec](IMPORTANT): Power24vConverter: Hardware Fault
2025-04-28T17:00:39.551Z,1745859639.551 [CommandExec](IMPORTANT): RDI_Pathfinder: Communications Fault
2025-04-28T17:00:39.702Z,1745859639.702 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:40.106Z,1745859640.106 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:40.518Z,1745859640.518 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:40.926Z,1745859640.926 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:41.339Z,1745859641.339 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:41.707Z,1745859641.707 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:42.113Z,1745859642.113 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:42.528Z,1745859642.528 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:42.943Z,1745859642.943 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:43.352Z,1745859643.352 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:43.729Z,1745859643.729 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:44.137Z,1745859644.137 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:44.555Z,1745859644.555 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:44.982Z,1745859644.982 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:45.382Z,1745859645.382 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:45.762Z,1745859645.762 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:46.166Z,1745859646.166 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:46.571Z,1745859646.571 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:46.984Z,1745859646.984 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:47.396Z,1745859647.396 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:47.768Z,1745859647.768 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:48.018Z,1745859648.018 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2025-04-28T17:00:48.019Z,1745859648.019 [DAT] Communications Fault, FailCount= 2
2025-04-28T17:00:48.019Z,1745859648.019 [DAT](ERROR): Communications Fault
2025-04-28T17:00:48.173Z,1745859648.173 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:48.187Z,1745859648.187 [CBIT](ERROR): Communications Fault in component: DAT
2025-04-28T17:00:48.422Z,1745859648.422 [DAT](INFO): Powering down
2025-04-28T17:00:48.592Z,1745859648.592 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:48.898Z,1745859648.898 [DAT](FAULT): LCB fault:  Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-28T17:00:48.898Z,1745859648.898 [DAT] Hardware Fault, FailCount= 2
2025-04-28T17:00:48.898Z,1745859648.898 [DAT](ERROR): Hardware Fault
2025-04-28T17:00:48.997Z,1745859648.997 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:49.411Z,1745859649.411 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:49.499Z,1745859649.499 [CBIT](INFO): Clearing failed state for component DAT
2025-04-28T17:00:49.499Z,1745859649.499 [DAT] No Fault, FailCount= 2
2025-04-28T17:00:49.788Z,1745859649.788 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:50.206Z,1745859650.206 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:50.624Z,1745859650.624 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:51.034Z,1745859651.034 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:51.450Z,1745859651.450 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:51.470Z,1745859651.470 [DAT](INFO): Powering up
2025-04-28T17:00:51.470Z,1745859651.470 [DAT](DEBUG): Initializing DAT.
2025-04-28T17:00:51.808Z,1745859651.808 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:52.214Z,1745859652.214 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:52.623Z,1745859652.623 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:53.043Z,1745859653.043 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:53.449Z,1745859653.449 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:53.747Z,1745859653.747 [CommandExec](IMPORTANT): got command strobe off
2025-04-28T17:00:53.747Z,1745859653.747 [CommandExec](IMPORTANT): Deactivating strobe
2025-04-28T17:00:53.828Z,1745859653.828 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:54.279Z,1745859654.279 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:54.637Z,1745859654.637 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:55.052Z,1745859655.052 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:55.485Z,1745859655.485 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:55.901Z,1745859655.901 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:56.266Z,1745859656.266 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:56.351Z,1745859656.351 [CommandExec](IMPORTANT): got command strobe on
2025-04-28T17:00:56.351Z,1745859656.351 [CommandExec](IMPORTANT): Activating strobe
2025-04-28T17:00:56.671Z,1745859656.671 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:57.061Z,1745859657.061 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:57.475Z,1745859657.475 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:57.892Z,1745859657.892 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:58.271Z,1745859658.271 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:58.676Z,1745859658.676 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:59.055Z,1745859659.055 [CommandExec](IMPORTANT): got command strobe off
2025-04-28T17:00:59.055Z,1745859659.055 [CommandExec](IMPORTANT): Deactivating strobe
2025-04-28T17:00:59.096Z,1745859659.096 [Power24vConverter](INFO): Powering down.
2025-04-28T17:00:59.495Z,1745859659.495 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:00:59.911Z,1745859659.911 [Power24vConverter](INFO): Powering down.
2025-04-28T17:01:00.295Z,1745859660.295 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:01:00.710Z,1745859660.710 [Power24vConverter](INFO): Powering down.
2025-04-28T17:01:01.114Z,1745859661.114 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:01:01.526Z,1745859661.526 [Power24vConverter](INFO): Powering down.
2025-04-28T17:01:01.944Z,1745859661.944 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:01:02.312Z,1745859662.312 [Power24vConverter](INFO): Powering down.
2025-04-28T17:01:02.717Z,1745859662.717 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:01:03.122Z,1745859663.122 [Power24vConverter](INFO): Powering down.
2025-04-28T17:01:03.540Z,1745859663.540 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:01:03.955Z,1745859663.955 [Power24vConverter](INFO): Powering down.
2025-04-28T17:01:04.332Z,1745859664.332 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:01:04.735Z,1745859664.735 [Power24vConverter](INFO): Powering down.
2025-04-28T17:01:05.147Z,1745859665.147 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:01:05.556Z,1745859665.556 [Power24vConverter](INFO): Powering down.
2025-04-28T17:01:05.986Z,1745859665.986 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:01:06.366Z,1745859666.366 [Power24vConverter](INFO): Powering down.
2025-04-28T17:01:06.770Z,1745859666.770 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:01:07.178Z,1745859667.178 [Power24vConverter](INFO): Powering down.
2025-04-28T17:01:07.575Z,1745859667.575 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:01:07.997Z,1745859667.997 [Power24vConverter](INFO): Powering down.
2025-04-28T17:01:08.408Z,1745859668.408 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:01:08.775Z,1745859668.775 [Power24vConverter](INFO): Powering down.
2025-04-28T17:01:09.181Z,1745859669.181 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:01:09.595Z,1745859669.595 [Power24vConverter](INFO): Powering down.
2025-04-28T17:01:10.003Z,1745859670.003 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:01:10.417Z,1745859670.417 [Power24vConverter](INFO): Powering down.
2025-04-28T17:01:10.795Z,1745859670.795 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:01:11.214Z,1745859671.214 [Power24vConverter](INFO): Powering down.
2025-04-28T17:01:11.626Z,1745859671.626 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:01:12.034Z,1745859672.034 [Power24vConverter](INFO): Powering down.
2025-04-28T17:01:12.446Z,1745859672.446 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:01:12.817Z,1745859672.817 [Power24vConverter](INFO): Powering down.
2025-04-28T17:01:13.224Z,1745859673.224 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:01:13.625Z,1745859673.625 [Power24vConverter](INFO): Powering down.
2025-04-28T17:01:14.044Z,1745859674.044 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:01:14.461Z,1745859674.461 [Power24vConverter](INFO): Powering down.
2025-04-28T17:01:14.879Z,1745859674.879 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:01:15.241Z,1745859675.241 [Power24vConverter](INFO): Powering down.
2025-04-28T17:01:15.645Z,1745859675.645 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:01:16.061Z,1745859676.061 [Power24vConverter](INFO): Powering down.
2025-04-28T17:01:16.490Z,1745859676.490 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:01:16.867Z,1745859676.867 [Power24vConverter](INFO): Powering down.
2025-04-28T17:01:17.342Z,1745859677.342 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:01:17.690Z,1745859677.690 [Power24vConverter](INFO): Powering down.
2025-04-28T17:01:18.077Z,1745859678.077 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:01:18.083Z,1745859678.083 [Startup:StartupSatComms:A](INFO): Timed out from 2025-04-28T17:00:17.9Z
2025-04-28T17:01:18.083Z,1745859678.083 [Startup:StartupSatComms:A] Stopped
2025-04-28T17:01:18.083Z,1745859678.083 [Startup:StartupSatComms:B] Running Loop=1
2025-04-28T17:01:18.483Z,1745859678.483 [Power24vConverter](INFO): Powering down.
2025-04-28T17:01:18.489Z,1745859678.489 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-04-28T17:01:19.111Z,1745859679.111 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:01:19.503Z,1745859679.503 [Power24vConverter](INFO): Powering down.
2025-04-28T17:01:19.906Z,1745859679.906 [DepthKeller33X](FAULT): Failed to receive valid data within the specified timeout.
2025-04-28T17:01:19.906Z,1745859679.906 [DepthKeller33X] Communications Fault, FailCount= 1
2025-04-28T17:01:19.906Z,1745859679.906 [DepthKeller33X](ERROR): Communications Fault
2025-04-28T17:01:19.954Z,1745859679.954 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-28T17:01:20.297Z,1745859680.297 [DepthKeller33X](INFO): Powering down
2025-04-28T17:01:20.387Z,1745859680.387 [Power24vConverter](INFO): Powering up.
2025-04-28T17:01:20.406Z,1745859680.406 [CommandExec](IMPORTANT): got command failComponent
2025-04-28T17:01:20.406Z,1745859680.406 [CommandExec](IMPORTANT): Failed components:
2025-04-28T17:01:20.407Z,1745859680.407 [CommandExec](IMPORTANT): DepthKeller33X: Communications Fault
2025-04-28T17:01:20.407Z,1745859680.407 [CommandExec](IMPORTANT): Power24vConverter: Hardware Fault
2025-04-28T17:01:20.407Z,1745859680.407 [CommandExec](IMPORTANT): RDI_Pathfinder: Communications Fault
2025-04-28T17:01:20.441Z,1745859680.441 [CBIT](INFO): Clearing failed state for component Power24vConverter
2025-04-28T17:01:20.462Z,1745859680.462 [Power24vConverter] No Fault, FailCount= 1
2025-04-28T17:01:21.369Z,1745859681.369 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-28T17:01:21.369Z,1745859681.369 [DepthKeller33X] No Fault, FailCount= 1
2025-04-28T17:01:21.514Z,1745859681.514 [DepthKeller33X](INFO): Initializing.
2025-04-28T17:01:22.301Z,1745859682.301 [DataOverHttps](INFO): Sending 135 bytes from file Logs/20250425T233104/Courier0004.lzma
2025-04-28T17:01:22.904Z,1745859682.904 [DataOverHttps](INFO): Moved sent file to Logs/20250425T233104/Courier0004.lzma.bak
2025-04-28T17:01:22.904Z,1745859682.904 [DataOverHttps](INFO): SBD MOMSN=24738796
2025-04-28T17:01:23.138Z,1745859683.138 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-28T17:01:23.138Z,1745859683.138 [DepthKeller33X] Communications Fault, FailCount= 2
2025-04-28T17:01:23.138Z,1745859683.138 [DepthKeller33X](ERROR): Communications Fault
2025-04-28T17:01:23.219Z,1745859683.219 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-28T17:01:23.528Z,1745859683.528 [DepthKeller33X](INFO): Powering down
2025-04-28T17:01:23.983Z,1745859683.983 [Power24vConverter](FAULT): LCB fault:  Current Limiter Activated.
2025-04-28T17:01:23.984Z,1745859683.984 [Power24vConverter] Hardware Fault, FailCount= 1
2025-04-28T17:01:23.984Z,1745859683.984 [Power24vConverter](ERROR): Hardware Fault
2025-04-28T17:01:23.985Z,1745859683.985 [Power24vConverter](INFO): Powering down.
2025-04-28T17:01:23.994Z,1745859683.994 [Power24vConverter](FAULT): 24V Power is reporting not powering/powered.
2025-04-28T17:01:24.227Z,1745859684.227 [CBIT](ERROR): Hardware Fault in component: Power24vConverter
2025-04-28T17:01:24.336Z,1745859684.336 [Power24vConverter](INFO): Powering down.
2025-04-28T17:01:24.498Z,1745859684.498 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-28T17:01:24.498Z,1745859684.498 [DepthKeller33X] No Fault, FailCount= 2
2025-04-28T17:01:24.739Z,1745859684.739 [DepthKeller33X](INFO): Initializing.
2025-04-28T17:01:24.763Z,1745859684.763 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:01:25.144Z,1745859685.144 [Power24vConverter](INFO): Powering down.
2025-04-28T17:01:25.550Z,1745859685.550 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:01:25.952Z,1745859685.952 [Power24vConverter](INFO): Powering down.
2025-04-28T17:01:26.390Z,1745859686.390 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-28T17:01:26.786Z,1745859686.786 [Power24vConverter](INFO): Powering down.
2025-04-28T17:01:27.594Z,1745859687.594 [Power24vConverter](INFO): Powering up.
2025-04-28T17:01:27.799Z,1745859687.799 [CBIT](INFO): Clearing failed state for component Power24vConverter
2025-04-28T17:01:27.799Z,1745859687.799 [Power24vConverter] No Fault, FailCount= 1
2025-04-28T17:01:29.598Z,1745859689.598 [DepthKeller33X](FAULT): Failed to receive valid data within the specified timeout.
2025-04-28T17:01:29.598Z,1745859689.598 [DepthKeller33X] Communications Fault, FailCount= 3
2025-04-28T17:01:29.598Z,1745859689.598 [DepthKeller33X](ERROR): Communications Fault
2025-04-28T17:01:29.782Z,1745859689.782 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-28T17:01:29.992Z,1745859689.992 [DepthKeller33X](INFO): Powering down
2025-04-28T17:01:30.976Z,1745859690.976 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-28T17:01:30.976Z,1745859690.976 [DepthKeller33X] No Fault, FailCount= 3
2025-04-28T17:01:31.207Z,1745859691.207 [DepthKeller33X](INFO): Initializing.
2025-04-28T17:01:32.886Z,1745859692.886 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-28T17:01:32.886Z,1745859692.886 [DepthKeller33X] Communications Fault, FailCount= 4
2025-04-28T17:01:32.886Z,1745859692.886 [DepthKeller33X](ERROR): Communications Fault
2025-04-28T17:01:32.967Z,1745859692.967 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-28T17:01:33.223Z,1745859693.223 [DepthKeller33X](INFO): Powering down
2025-04-28T17:01:34.194Z,1745859694.194 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-28T17:01:34.194Z,1745859694.194 [DepthKeller33X] No Fault, FailCount= 4
2025-04-28T17:01:34.456Z,1745859694.456 [DepthKeller33X](INFO): Initializing.
2025-04-28T17:01:36.070Z,1745859696.070 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-28T17:01:36.070Z,1745859696.070 [DepthKeller33X] Communications Fault, FailCount= 5
2025-04-28T17:01:36.070Z,1745859696.070 [DepthKeller33X](ERROR): Communications Fault
2025-04-28T17:01:36.126Z,1745859696.126 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-28T17:01:36.127Z,1745859696.127 [CBIT](CRITICAL): Communications Fault in component: DepthKeller33X
2025-04-28T17:01:36.455Z,1745859696.455 [DepthKeller33X](INFO): Powering down
2025-04-28T17:01:36.600Z,1745859696.600 [CBIT](INFO): Critical error at 20250428T170136
2025-04-28T17:01:38.574Z,1745859698.574 [DataOverHttps](INFO): Sending 234 bytes from file Logs/20250428T165834/Courier0000.lzma
2025-04-28T17:01:39.575Z,1745859699.575 [DataOverHttps](INFO): Moved sent file to Logs/20250428T165834/Courier0000.lzma.bak
2025-04-28T17:01:39.576Z,1745859699.576 [DataOverHttps](INFO): SBD MOMSN=24738804
2025-04-28T17:01:41.061Z,1745859701.061 [CTD_Seabird](ERROR): Failed to parse device response: <!--startlogging-->
2025-04-28T17:01:42.883Z,1745859702.883 [CommandExec](IMPORTANT): got command failComponent
2025-04-28T17:01:42.884Z,1745859702.884 [CommandExec](IMPORTANT): Failed components:
2025-04-28T17:01:42.884Z,1745859702.884 [CommandExec](IMPORTANT): DepthKeller33X: Communications Fault
2025-04-28T17:01:42.884Z,1745859702.884 [CommandExec](IMPORTANT): RDI_Pathfinder: Communications Fault
2025-04-28T17:01:44.549Z,1745859704.549 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2025-04-28T17:01:44.549Z,1745859704.549 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-28T17:01:44.550Z,1745859704.550 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2025-04-28T17:01:44.550Z,1745859704.550 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-04-28T17:01:44.618Z,1745859704.618 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-28T17:01:44.618Z,1745859704.618 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-04-28T17:01:45.014Z,1745859705.014 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-28T17:01:45.014Z,1745859705.014 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2025-04-28T17:01:45.014Z,1745859705.014 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-04-28T17:01:45.015Z,1745859705.015 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2025-04-28T17:01:47.466Z,1745859707.466 [CommandExec](IMPORTANT): got command failComponent hardware DAT
2025-04-28T17:01:47.466Z,1745859707.466 [DAT] Hardware Fault, FailCount= 3
2025-04-28T17:01:47.466Z,1745859707.466 [DAT](ERROR): Hardware Fault
2025-04-28T17:01:47.466Z,1745859707.466 [CommandExec](IMPORTANT): DAT failureMode is Hardware Fault
2025-04-28T17:01:47.698Z,1745859707.698 [DAT](INFO): Powering down
2025-04-28T17:01:47.831Z,1745859707.831 [CBIT](ERROR): Hardware Fault in component: DAT
2025-04-28T17:01:48.174Z,1745859708.174 [DAT](FAULT): LCB fault:  Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-28T17:01:48.626Z,1745859708.626 [CBIT](INFO): Clearing failed state for component DAT
2025-04-28T17:01:48.626Z,1745859708.626 [DAT] No Fault, FailCount= 3
2025-04-28T17:01:50.746Z,1745859710.746 [DAT](INFO): Powering up
2025-04-28T17:01:50.746Z,1745859710.746 [DAT](DEBUG): Initializing DAT.
2025-04-28T17:01:56.027Z,1745859716.027 [DataOverHttps](INFO): Sending 762 bytes from file Logs/20250425T233104/Express0005.lzma
2025-04-28T17:01:57.028Z,1745859717.028 [DataOverHttps](INFO): Moved sent file to Logs/20250425T233104/Express0005.lzma.bak
2025-04-28T17:01:57.028Z,1745859717.028 [DataOverHttps](INFO): SBD MOMSN=24738815
2025-04-28T17:02:02.094Z,1745859722.094 [DAT](INFO): DAT read: 

2025-04-28T17:02:02.096Z,1745859722.096 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series

2025-04-28T17:02:03.607Z,1745859723.607 [DAT](INFO): DAT read: MF Frequency Band

2025-04-28T17:02:03.608Z,1745859723.608 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.14.0

2025-04-28T17:02:03.608Z,1745859723.608 [DAT](INFO): DAT read: Apr 25 2025 23:36:58 

2025-04-28T17:02:04.619Z,1745859724.619 [DAT](INFO): DAT read: Features enabled [Bearing]

2025-04-28T17:02:04.620Z,1745859724.620 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP

2025-04-28T17:02:04.621Z,1745859724.621 [DAT](INFO): commRate: 800
2025-04-28T17:02:06.379Z,1745859726.379 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-28T17:02:06.379Z,1745859726.379 [DepthKeller33X] No Fault, FailCount= 5
2025-04-28T17:02:06.686Z,1745859726.686 [DAT](INFO): entering command mode
2025-04-28T17:02:06.756Z,1745859726.756 [DepthKeller33X](INFO): Initializing.
2025-04-28T17:02:06.886Z,1745859726.886 [DAT](INFO): DAT read: 

2025-04-28T17:02:06.887Z,1745859726.887 [DAT](INFO): DAT read: user:1>

2025-04-28T17:02:06.887Z,1745859726.887 [DAT](INFO): setting verbose to 3
2025-04-28T17:02:07.138Z,1745859727.138 [DAT](INFO): DAT read: user:1>

2025-04-28T17:02:07.139Z,1745859727.139 [DAT](INFO): DAT read: Verbose         | 3           

2025-04-28T17:02:07.140Z,1745859727.140 [DAT](INFO): set verbose to 3
2025-04-28T17:02:07.140Z,1745859727.140 [DAT](INFO): setting DatVerbose to 27440
2025-04-28T17:02:07.390Z,1745859727.390 [DAT](INFO): DAT read: user:2>

2025-04-28T17:02:07.391Z,1745859727.391 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:07.642Z,1745859727.642 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:07.895Z,1745859727.895 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:08.146Z,1745859728.146 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:08.399Z,1745859728.399 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:08.650Z,1745859728.650 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:08.805Z,1745859728.805 [DepthKeller33X](INFO): Failure count cleared after critical for DepthKeller33X
2025-04-28T17:02:08.903Z,1745859728.903 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:09.154Z,1745859729.154 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:09.406Z,1745859729.406 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:09.658Z,1745859729.658 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:09.910Z,1745859729.910 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:10.162Z,1745859730.162 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:10.422Z,1745859730.422 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:10.674Z,1745859730.674 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:10.926Z,1745859730.926 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:11.178Z,1745859731.178 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:11.430Z,1745859731.430 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:11.682Z,1745859731.682 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:11.934Z,1745859731.934 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:12.186Z,1745859732.186 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:12.438Z,1745859732.438 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:12.690Z,1745859732.690 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:12.863Z,1745859732.863 [DataOverHttps](INFO): Sending 1843 bytes from file Logs/20250428T165834/Express0001.lzma
2025-04-28T17:02:12.942Z,1745859732.942 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:13.194Z,1745859733.194 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:13.446Z,1745859733.446 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:13.702Z,1745859733.702 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:13.859Z,1745859733.859 [DataOverHttps](INFO): Moved sent file to Logs/20250428T165834/Express0001.lzma.bak
2025-04-28T17:02:13.860Z,1745859733.860 [DataOverHttps](INFO): SBD MOMSN=24738886
2025-04-28T17:02:13.954Z,1745859733.954 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:14.206Z,1745859734.206 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:14.458Z,1745859734.458 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:14.710Z,1745859734.710 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:14.962Z,1745859734.962 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:15.214Z,1745859735.214 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:15.466Z,1745859735.466 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:15.718Z,1745859735.718 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:15.970Z,1745859735.970 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:16.066Z,1745859736.066 [Startup:StartupSatComms:B] Stopped
2025-04-28T17:02:16.066Z,1745859736.066 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2025-04-28T17:02:16.066Z,1745859736.066 [Startup:StartupSatComms] Stopped
2025-04-28T17:02:16.066Z,1745859736.066 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2025-04-28T17:02:16.067Z,1745859736.067 [Startup](INFO): Completed Startup
2025-04-28T17:02:16.067Z,1745859736.067 [MissionManager](INFO): Startup is completed.
2025-04-28T17:02:16.067Z,1745859736.067 [MissionManager](INFO): Uninitializing Mission Startup
2025-04-28T17:02:16.067Z,1745859736.067 [Startup] Stopped
2025-04-28T17:02:16.068Z,1745859736.068 [Startup](DEBUG): Aggregate::uninitialize Startup
2025-04-28T17:02:16.068Z,1745859736.068 [Startup:A.GoToSurface] Stopped
2025-04-28T17:02:16.068Z,1745859736.068 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-04-28T17:02:16.222Z,1745859736.222 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:16.226Z,1745859736.226 [CommandExec](IMPORTANT): got command failComponent
2025-04-28T17:02:16.227Z,1745859736.227 [CommandExec](IMPORTANT): Failed components:
2025-04-28T17:02:16.227Z,1745859736.227 [CommandExec](IMPORTANT): RDI_Pathfinder: Communications Fault
2025-04-28T17:02:16.472Z,1745859736.472 [MissionManager](IMPORTANT): Started mission Default
2025-04-28T17:02:16.473Z,1745859736.473 [Default] Running Loop=1
2025-04-28T17:02:16.473Z,1745859736.473 [Default](DEBUG): Aggregate::initialize Default
2025-04-28T17:02:16.473Z,1745859736.473 [Default:B.GoToSurface] Running Loop=1
2025-04-28T17:02:16.473Z,1745859736.473 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-04-28T17:02:16.473Z,1745859736.473 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-04-28T17:02:16.474Z,1745859736.474 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:16.473Z,1745859736.473 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-04-28T17:02:16.475Z,1745859736.475 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-04-28T17:02:16.475Z,1745859736.475 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-04-28T17:02:16.475Z,1745859736.475 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-04-28T17:02:16.476Z,1745859736.476 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-04-28T17:02:16.476Z,1745859736.476 [Default:A.Wait] Running Loop=1
2025-04-28T17:02:16.476Z,1745859736.476 [Default:A.Wait](DEBUG): Initialize Wait Component.
2025-04-28T17:02:16.726Z,1745859736.726 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:16.978Z,1745859736.978 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:17.231Z,1745859737.231 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:17.482Z,1745859737.482 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:17.734Z,1745859737.734 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:17.986Z,1745859737.986 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:18.238Z,1745859738.238 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:18.490Z,1745859738.490 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:18.742Z,1745859738.742 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:18.995Z,1745859738.995 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:19.246Z,1745859739.246 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:19.498Z,1745859739.498 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:19.750Z,1745859739.750 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:20.002Z,1745859740.002 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:20.254Z,1745859740.254 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:20.506Z,1745859740.506 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:20.758Z,1745859740.758 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:20.830Z,1745859740.830 [CommandExec](IMPORTANT): got command failComponent none RDI_Pathfinder
2025-04-28T17:02:20.831Z,1745859740.831 [RDI_Pathfinder] No Fault, FailCount= 3
2025-04-28T17:02:20.831Z,1745859740.831 [CommandExec](IMPORTANT): RDI_Pathfinder failureMode is No Fault
2025-04-28T17:02:20.924Z,1745859740.924 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2025-04-28T17:02:21.011Z,1745859741.011 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:21.262Z,1745859741.262 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:21.514Z,1745859741.514 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:21.766Z,1745859741.766 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:22.018Z,1745859742.018 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:22.270Z,1745859742.270 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:22.270Z,1745859742.270 [DAT](FAULT): failed to set DatVerbose
2025-04-28T17:02:22.522Z,1745859742.522 [DAT](INFO): setting DatVerbose to 27440
2025-04-28T17:02:22.775Z,1745859742.775 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:23.026Z,1745859743.026 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:23.278Z,1745859743.278 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:23.530Z,1745859743.530 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:23.782Z,1745859743.782 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:24.035Z,1745859744.035 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:24.286Z,1745859744.286 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:24.538Z,1745859744.538 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:24.790Z,1745859744.790 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:25.042Z,1745859745.042 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:25.294Z,1745859745.294 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:25.548Z,1745859745.548 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:25.798Z,1745859745.798 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:26.050Z,1745859746.050 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:26.302Z,1745859746.302 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:26.555Z,1745859746.555 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:26.806Z,1745859746.806 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:27.058Z,1745859747.058 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:27.310Z,1745859747.310 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:27.562Z,1745859747.562 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:27.814Z,1745859747.814 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:28.066Z,1745859748.066 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:28.318Z,1745859748.318 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:28.523Z,1745859748.523 [CommandExec](IMPORTANT): got command failComponent
2025-04-28T17:02:28.523Z,1745859748.523 [CommandExec](IMPORTANT): Failed components:
2025-04-28T17:02:28.523Z,1745859748.523 [CommandExec](IMPORTANT): No failed Components.
2025-04-28T17:02:28.570Z,1745859748.570 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:28.822Z,1745859748.822 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:29.075Z,1745859749.075 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:29.326Z,1745859749.326 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:29.578Z,1745859749.578 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:29.812Z,1745859749.812 [Default:A.Wait](INFO): Done Waiting.
2025-04-28T17:02:29.812Z,1745859749.812 [Default:A.Wait] Stopped
2025-04-28T17:02:29.812Z,1745859749.812 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2025-04-28T17:02:29.830Z,1745859749.830 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:30.082Z,1745859750.082 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:30.215Z,1745859750.215 [Default:CheckIn] Running Loop=1
2025-04-28T17:02:30.215Z,1745859750.215 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-04-28T17:02:30.216Z,1745859750.216 [Default:CheckIn:Read_GPS] Running Loop=1
2025-04-28T17:02:30.334Z,1745859750.334 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:30.590Z,1745859750.590 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:30.615Z,1745859750.615 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-04-28T17:02:30.842Z,1745859750.842 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:31.095Z,1745859751.095 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:31.347Z,1745859751.347 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:31.598Z,1745859751.598 [DAT](DEBUG): checking for DatVerbose setting acknowledgment
2025-04-28T17:02:31.754Z,1745859751.754 [CommandExec](IMPORTANT): got command failComponent hardware DAT
2025-04-28T17:02:31.754Z,1745859751.754 [DAT] Hardware Fault, FailCount= 4
2025-04-28T17:02:31.754Z,1745859751.754 [DAT](ERROR): Hardware Fault
2025-04-28T17:02:31.755Z,1745859751.755 [CommandExec](IMPORTANT): DAT failureMode is Hardware Fault
2025-04-28T17:02:31.831Z,1745859751.831 [CBIT](ERROR): Hardware Fault in component: DAT
2025-04-28T17:02:31.850Z,1745859751.850 [DAT](INFO): Powering down
2025-04-28T17:02:33.051Z,1745859753.051 [CBIT](INFO): Clearing failed state for component DAT
2025-04-28T17:02:33.051Z,1745859753.051 [DAT] No Fault, FailCount= 4
2025-04-28T17:02:33.448Z,1745859753.448 [RDI_Pathfinder](FAULT): DVL failed to acquire valid data within timeout.
2025-04-28T17:02:33.448Z,1745859753.448 [RDI_Pathfinder] Data Fault, FailCount= 4
2025-04-28T17:02:33.448Z,1745859753.448 [RDI_Pathfinder](ERROR): Data Fault
2025-04-28T17:02:33.465Z,1745859753.465 [CBIT](ERROR): Data Fault in component: RDI_Pathfinder
2025-04-28T17:02:33.466Z,1745859753.466 [CBIT](CRITICAL): Data Fault in component: RDI_Pathfinder
2025-04-28T17:02:33.898Z,1745859753.898 [RDI_Pathfinder](INFO): Powering down
2025-04-28T17:02:33.913Z,1745859753.913 [CBIT](INFO): Critical error at 20250428T170233
2025-04-28T17:02:34.898Z,1745859754.898 [DAT](INFO): Powering up
2025-04-28T17:02:34.898Z,1745859754.898 [DAT](DEBUG): Initializing DAT.
2025-04-28T17:02:39.242Z,1745859759.242 [CommandExec](IMPORTANT): got command failComponent
2025-04-28T17:02:39.242Z,1745859759.242 [CommandExec](IMPORTANT): Failed components:
2025-04-28T17:02:39.243Z,1745859759.243 [CommandExec](IMPORTANT): RDI_Pathfinder: Data Fault
2025-04-28T17:02:45.299Z,1745859765.299 [CommandExec](IMPORTANT): got command failComponent none RDI_Pathfinder
2025-04-28T17:02:45.299Z,1745859765.299 [RDI_Pathfinder] No Fault, FailCount= 4
2025-04-28T17:02:45.300Z,1745859765.300 [CommandExec](IMPORTANT): RDI_Pathfinder failureMode is No Fault
2025-04-28T17:02:45.558Z,1745859765.558 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2025-04-28T17:02:54.097Z,1745859774.097 [CommandExec](IMPORTANT): got command get depth
2025-04-28T17:02:54.098Z,1745859774.098 [CommandExec](IMPORTANT): depth 0.223241 m
2025-04-28T17:02:54.831Z,1745859774.831 [DAT](INFO): DAT read: à
2025-04-28T17:02:54.831Z,1745859774.831 [DAT](INFO): unknown deviceResponse_: à
2025-04-28T17:02:54.832Z,1745859774.832 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series

2025-04-28T17:02:56.343Z,1745859776.343 [DAT](INFO): DAT read: MF Frequency Band

2025-04-28T17:02:56.344Z,1745859776.344 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.14.0

2025-04-28T17:02:56.344Z,1745859776.344 [DAT](INFO): DAT read: Apr 25 2025 23:37:43 

2025-04-28T17:02:56.605Z,1745859776.605 [CommandExec](IMPORTANT): got command show best depth
2025-04-28T17:02:56.605Z,1745859776.605 [CommandExec](IMPORTANT): depth best is DepthKeller33X.depth
2025-04-28T17:02:57.351Z,1745859777.351 [DAT](INFO): DAT read: Features enabled [Bearing]

2025-04-28T17:02:57.352Z,1745859777.352 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP

2025-04-28T17:02:57.352Z,1745859777.352 [DAT](INFO): commRate: 800
2025-04-28T17:02:59.418Z,1745859779.418 [DAT](INFO): entering command mode
2025-04-28T17:02:59.618Z,1745859779.618 [DAT](INFO): DAT read: 

2025-04-28T17:02:59.619Z,1745859779.619 [DAT](INFO): DAT read: user:1>

2025-04-28T17:02:59.619Z,1745859779.619 [DAT](INFO): setting verbose to 3
2025-04-28T17:02:59.870Z,1745859779.870 [DAT](INFO): DAT read: user:1>

2025-04-28T17:02:59.871Z,1745859779.871 [DAT](INFO): DAT read: Verbose         | 3           

2025-04-28T17:02:59.872Z,1745859779.872 [DAT](INFO): set verbose to 3
2025-04-28T17:02:59.872Z,1745859779.872 [DAT](INFO): setting DatVerbose to 27440
2025-04-28T17:03:00.037Z,1745859780.037 [CommandExec](IMPORTANT): got command show best depth
2025-04-28T17:03:00.037Z,1745859780.037 [CommandExec](IMPORTANT): depth best is DepthKeller33X.depth
2025-04-28T17:03:00.122Z,1745859780.122 [DAT](INFO): DAT read: user:2>

2025-04-28T17:03:00.123Z,1745859780.123 [DAT](INFO): DAT read: DatVerbose      | 27440       

2025-04-28T17:03:00.124Z,1745859780.124 [DAT](INFO): set DatVerbose to 27440
2025-04-28T17:03:00.124Z,1745859780.124 [DAT](INFO): setting transmit power to 8
2025-04-28T17:03:00.375Z,1745859780.375 [DAT](INFO): DAT read: user:3>

2025-04-28T17:03:00.376Z,1745859780.376 [DAT](INFO): DAT read: TxPower         | 8 (Max)     

2025-04-28T17:03:00.377Z,1745859780.377 [DAT](INFO): set transmit power to 8
2025-04-28T17:03:00.377Z,1745859780.377 [DAT](INFO): setting local address to 3
2025-04-28T17:03:00.626Z,1745859780.626 [DAT](INFO): DAT read: user:4>

2025-04-28T17:03:00.627Z,1745859780.627 [DAT](INFO): DAT read: LocalAddr       | 3           

2025-04-28T17:03:00.628Z,1745859780.628 [DAT](INFO): set local address to 3
2025-04-28T17:03:00.629Z,1745859780.629 [DAT](INFO): Setting time to: 17:3:0 And date to:4/28/2025
2025-04-28T17:03:00.878Z,1745859780.878 [DAT](INFO): DAT read: user:5>

2025-04-28T17:03:00.879Z,1745859780.879 [DAT](INFO): DAT read: Mon Apr 28, 2025  17:03:00  

2025-04-28T17:03:00.880Z,1745859780.880 [DAT](INFO): Local DAT time set to Mon Apr 28, 2025  17:03:00  

2025-04-28T17:03:06.719Z,1745859786.719 [CommandExec](IMPORTANT): got command strobe off
2025-04-28T17:03:06.719Z,1745859786.719 [CommandExec](IMPORTANT): Deactivating strobe
2025-04-28T17:03:07.780Z,1745859787.780 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2025-04-28T17:03:07.780Z,1745859787.780 [RDI_Pathfinder] Communications Fault, FailCount= 5
2025-04-28T17:03:07.780Z,1745859787.780 [RDI_Pathfinder](ERROR): Communications Fault
2025-04-28T17:03:07.812Z,1745859787.812 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2025-04-28T17:03:07.813Z,1745859787.813 [CBIT](CRITICAL): Communications Fault in component: RDI_Pathfinder
2025-04-28T17:03:08.262Z,1745859788.262 [RDI_Pathfinder](INFO): Powering down
2025-04-28T17:03:08.277Z,1745859788.277 [CBIT](INFO): Critical error at 20250428T170307
2025-04-28T17:03:31.294Z,1745859811.294 [CommandExec](IMPORTANT): got command failComponent none RDI_Pathfinder
2025-04-28T17:03:31.295Z,1745859811.295 [RDI_Pathfinder] No Fault, FailCount= 5
2025-04-28T17:03:31.295Z,1745859811.295 [CommandExec](IMPORTANT): RDI_Pathfinder failureMode is No Fault
2025-04-28T17:03:31.604Z,1745859811.604 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2025-04-28T17:03:53.850Z,1745859833.850 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2025-04-28T17:03:53.851Z,1745859833.851 [RDI_Pathfinder] Communications Fault, FailCount= 6
2025-04-28T17:03:53.851Z,1745859833.851 [RDI_Pathfinder](ERROR): Communications Fault
2025-04-28T17:03:53.868Z,1745859833.868 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2025-04-28T17:03:53.868Z,1745859833.868 [CBIT](CRITICAL): Communications Fault in component: RDI_Pathfinder
2025-04-28T17:03:54.338Z,1745859834.338 [RDI_Pathfinder](INFO): Powering down
2025-04-28T17:03:54.353Z,1745859834.353 [CBIT](INFO): Critical error at 20250428T170353
2025-04-28T17:04:13.107Z,1745859853.107 [CommandExec](IMPORTANT): got command get RDI_Pathfinder.loadControl
2025-04-28T17:04:13.107Z,1745859853.107 [CommandExec](IMPORTANT): RDI_Pathfinder.loadControl /dev/loadB4
2025-04-28T17:04:20.428Z,1745859860.428 [CommandExec](IMPORTANT): got command get RDI_Pathfinder.baud
2025-04-28T17:04:20.429Z,1745859860.429 [CommandExec](IMPORTANT): RDI_Pathfinder.baud 115200.000000 bps
2025-04-28T17:04:26.967Z,1745859866.967 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-04-28T17:04:45.541Z,1745859885.541 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2025-04-28T17:04:45.541Z,1745859885.541 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-28T17:04:45.543Z,1745859885.543 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2025-04-28T17:04:45.543Z,1745859885.543 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-04-28T17:04:45.571Z,1745859885.571 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-28T17:04:45.571Z,1745859885.571 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-04-28T17:04:45.984Z,1745859885.984 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-28T17:04:45.984Z,1745859885.984 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2025-04-28T17:04:45.984Z,1745859885.984 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-04-28T17:04:45.984Z,1745859885.984 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2025-04-28T17:06:00.935Z,1745859960.935 [DAT](INFO): DAT read: user:6>Lowpower

2025-04-28T17:06:00.935Z,1745859960.935 [DAT](DEBUG): Re-entering command mode due to deviceResponse_: user:6>Lowpower

2025-04-28T17:06:54.057Z,1745860014.057 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2025-04-28T17:06:54.057Z,1745860014.057 [RDI_Pathfinder] No Fault, FailCount= 6
2025-04-28T17:06:54.419Z,1745860014.419 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2025-04-28T17:07:06.958Z,1745860026.958 [RDI_Pathfinder](FAULT): DVL failed to acquire valid data within timeout.
2025-04-28T17:07:06.958Z,1745860026.958 [RDI_Pathfinder] Data Fault, FailCount= 1
2025-04-28T17:07:06.959Z,1745860026.959 [RDI_Pathfinder](ERROR): Data Fault
2025-04-28T17:07:07.004Z,1745860027.004 [CBIT](ERROR): Data Fault in component: RDI_Pathfinder
2025-04-28T17:07:07.370Z,1745860027.370 [RDI_Pathfinder](INFO): Powering down
2025-04-28T17:07:08.188Z,1745860028.188 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2025-04-28T17:07:08.188Z,1745860028.188 [RDI_Pathfinder] No Fault, FailCount= 1
2025-04-28T17:07:08.557Z,1745860028.557 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2025-04-28T17:07:23.239Z,1745860043.239 [CommandExec](IMPORTANT): got command quit
2025-04-28T17:07:24.242Z,1745860044.242 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-28T17:07:24.242Z,1745860044.242 [CommandExec](INFO): Uninitializing the command executive.
2025-04-28T17:07:24.242Z,1745860044.242 [CommandExec](INFO): Uninitializing the command scheduler.
2025-04-28T17:07:24.242Z,1745860044.242 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:07:24.286Z,1745860044.286 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2025-04-28T17:07:24.286Z,1745860044.286 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2025-04-28T17:07:24.286Z,1745860044.286 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:07:24.287Z,1745860044.287 [NavChartDb](INFO): Join timeout helper Thread ID is 4546
2025-04-28T17:07:24.594Z,1745860044.594 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-28T17:07:24.594Z,1745860044.594 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:07:24.606Z,1745860044.606 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2025-04-28T17:07:24.606Z,1745860044.606 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:07:24.606Z,1745860044.606 [CTD_Seabird](INFO): Join timeout helper Thread ID is 4547
2025-04-28T17:07:25.486Z,1745860045.486 [CTD_Seabird](INFO): Powering down
2025-04-28T17:07:25.498Z,1745860045.498 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-28T17:07:25.498Z,1745860045.498 [CTD_Seabird](INFO): Powering down
2025-04-28T17:07:25.510Z,1745860045.510 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:07:25.526Z,1745860045.526 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2025-04-28T17:07:25.526Z,1745860045.526 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:07:25.527Z,1745860045.527 [Radio_Surface](INFO): Join timeout helper Thread ID is 4548
2025-04-28T17:07:25.882Z,1745860045.882 [Radio_Surface](INFO): Powering down
2025-04-28T17:07:25.883Z,1745860045.883 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-28T17:07:25.883Z,1745860045.883 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:07:25.894Z,1745860045.894 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2025-04-28T17:07:25.894Z,1745860045.894 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:07:25.894Z,1745860045.894 [Onboard](INFO): Join timeout helper Thread ID is 4549
2025-04-28T17:07:25.946Z,1745860045.946 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2025-04-28T17:07:29.734Z,1745860049.734 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-28T17:07:29.734Z,1745860049.734 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:07:29.743Z,1745860049.743 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2025-04-28T17:07:29.743Z,1745860049.743 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:07:29.744Z,1745860049.744 [DataOverHttps](INFO): Join timeout helper Thread ID is 4550
2025-04-28T17:07:29.963Z,1745860049.963 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-28T17:07:29.963Z,1745860049.963 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:07:29.972Z,1745860049.972 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2025-04-28T17:07:29.973Z,1745860049.973 [DAT ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:07:29.973Z,1745860049.973 [DAT](INFO): Join timeout helper Thread ID is 4551
2025-04-28T17:07:30.214Z,1745860050.214 [DAT](INFO): Powering down
2025-04-28T17:07:30.287Z,1745860050.287 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-28T17:07:30.287Z,1745860050.287 [DAT](INFO): Powering down
2025-04-28T17:07:30.288Z,1745860050.288 [DAT ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:07:30.302Z,1745860050.302 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2025-04-28T17:07:30.302Z,1745860050.302 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:07:30.303Z,1745860050.303 [BackseatComponent](INFO): Join timeout helper Thread ID is 4552
2025-04-28T17:07:30.318Z,1745860050.318 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-28T17:07:30.318Z,1745860050.318 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:07:30.323Z,1745860050.323 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2025-04-28T17:07:30.323Z,1745860050.323 [logger ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:07:30.323Z,1745860050.323 [logger](INFO): Join timeout helper Thread ID is 4553
2025-04-28T17:07:30.375Z,1745860050.375 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-28T17:07:30.375Z,1745860050.375 [logger ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:07:30.379Z,1745860050.379 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2025-04-28T17:07:30.379Z,1745860050.379 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:07:30.379Z,1745860050.379 [CommandLine](INFO): Join timeout helper Thread ID is 4554
2025-04-28T17:07:30.394Z,1745860050.394 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-04-28T17:02:30.2Z
2025-04-28T17:07:30.395Z,1745860050.395 [Default:CheckIn:Read_GPS] Stopped
2025-04-28T17:07:30.395Z,1745860050.395 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-04-28T17:07:30.474Z,1745860050.474 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-28T17:07:30.474Z,1745860050.474 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:07:30.487Z,1745860050.487 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2025-04-28T17:07:30.487Z,1745860050.487 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:07:30.488Z,1745860050.488 [CommandExec](INFO): Join timeout helper Thread ID is 4555
2025-04-28T17:07:30.490Z,1745860050.490 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2025-04-28T17:07:30.490Z,1745860050.490 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:07:30.491Z,1745860050.491 [controlThread](INFO): Join timeout helper Thread ID is 4556
2025-04-28T17:07:30.762Z,1745860050.762 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-28T17:07:30.762Z,1745860050.762 [controlThread](DEBUG): Uninitializing ControlThread
2025-04-28T17:07:30.763Z,1745860050.763 [AHRS_M2](INFO): Powering down
2025-04-28T17:07:30.834Z,1745860050.834 [DepthKeller33X](INFO): Powering down
2025-04-28T17:07:30.930Z,1745860050.930 [NAL9602](INFO): Powering down
2025-04-28T17:07:30.931Z,1745860050.931 [RDI_Pathfinder](INFO): Powering down
2025-04-28T17:07:30.932Z,1745860050.932 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2025-04-28T17:07:30.933Z,1745860050.933 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2025-04-28T17:07:30.934Z,1745860050.934 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2025-04-28T17:07:30.934Z,1745860050.934 [MissionManager](INFO): Uninitializing Mission Default
2025-04-28T17:07:30.934Z,1745860050.934 [Default] Stopped
2025-04-28T17:07:30.935Z,1745860050.935 [Default](DEBUG): Aggregate::uninitialize Default
2025-04-28T17:07:30.935Z,1745860050.935 [Default:B.GoToSurface] Stopped
2025-04-28T17:07:30.935Z,1745860050.935 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-04-28T17:07:30.935Z,1745860050.935 [Default:CheckIn] Stopped
2025-04-28T17:07:30.935Z,1745860050.935 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-04-28T17:07:30.935Z,1745860050.935 [Default:CheckIn:Read_Iridium] Stopped
2025-04-28T17:07:30.938Z,1745860050.938 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2025-04-28T17:07:30.938Z,1745860050.938 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2025-04-28T17:07:30.939Z,1745860050.939 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2025-04-28T17:07:30.939Z,1745860050.939 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2025-04-28T17:07:30.939Z,1745860050.939 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2025-04-28T17:07:30.939Z,1745860050.939 [BuoyancyServo](INFO): Powering down
2025-04-28T17:07:30.954Z,1745860050.954 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-04-28T17:07:30.954Z,1745860050.954 [ElevatorServo](INFO): Powering down
2025-04-28T17:07:30.955Z,1745860050.955 [MassServo](DEBUG): Uninitialize Mass Servo.
2025-04-28T17:07:30.955Z,1745860050.955 [MassServo](INFO): Powering down
2025-04-28T17:07:30.956Z,1745860050.956 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-04-28T17:07:30.956Z,1745860050.956 [RudderServo](INFO): Powering down
2025-04-28T17:07:30.957Z,1745860050.957 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2025-04-28T17:07:30.957Z,1745860050.957 [ThrusterHE](INFO): Powering down
2025-04-28T17:07:30.958Z,1745860050.958 [SBIT](DEBUG): Uninitialize SBIT Component.
2025-04-28T17:07:30.958Z,1745860050.958 [IBIT](DEBUG): Uninitialize IBIT Component.
2025-04-28T17:07:30.958Z,1745860050.958 [CBIT](DEBUG): Uninitialize CBIT Component.
2025-04-28T17:07:30.958Z,1745860050.958 [CBIT](DEBUG): Powering off loads.
2025-04-28T17:07:30.970Z,1745860050.970 [CBIT](DEBUG): Disabling WDT.
2025-04-28T17:07:30.982Z,1745860050.982 [GFScanner](DEBUG): Uninitialize GFScanner component.
2025-04-28T17:07:30.982Z,1745860050.982 [GFScanner](DEBUG): Opening all GF detection circuits.
2025-04-28T17:07:30.983Z,1745860050.983 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:07:31.005Z,1745860051.005 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:07:31.008Z,1745860051.008 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:07:31.014Z,1745860051.014 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:07:31.021Z,1745860051.021 [DAT ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:07:31.025Z,1745860051.025 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:07:31.076Z,1745860051.076 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:07:31.116Z,1745860051.116 [GFScanner](DEBUG): Uninitialize GFScanner component.
2025-04-28T17:07:31.116Z,1745860051.116 [GFScanner](DEBUG): Opening all GF detection circuits.
2025-04-28T17:07:31.134Z,1745860051.134 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:07:31.198Z,1745860051.198 [logger ThreadHandler](INFO): Thread cancelled.