2025-08-15T15:26:19.714Z,1755271579.714 [Supervisor](DEBUG): Initializing supervisor.
2025-08-15T15:26:19.718Z,1755271579.718 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2025-08-15T15:26:19.719Z,1755271579.719 [SyncHandler](INFO): Protected caller Thread ID is 5727
2025-08-15T15:26:19.719Z,1755271579.719 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2025-08-15T15:26:19.720Z,1755271579.720 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2025-08-15T15:26:19.721Z,1755271579.721 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 5728
2025-08-15T15:26:19.725Z,1755271579.725 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2025-08-15T15:26:19.745Z,1755271579.745 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2025-08-15T15:26:19.746Z,1755271579.746 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2025-08-15T15:26:19.746Z,1755271579.746 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 5729
2025-08-15T15:26:19.750Z,1755271579.750 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2025-08-15T15:26:19.751Z,1755271579.751 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2025-08-15T15:26:19.752Z,1755271579.752 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 5730
2025-08-15T15:26:19.754Z,1755271579.754 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2025-08-15T15:26:19.755Z,1755271579.755 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2025-08-15T15:26:19.755Z,1755271579.755 [logger ThreadHandler](INFO): Protected caller Thread ID is 5731
2025-08-15T15:26:19.759Z,1755271579.759 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2025-08-15T15:26:19.760Z,1755271579.760 [Supervisor](INFO): Looking for Config files in directory: Config/
2025-08-15T15:26:19.765Z,1755271579.765 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2025-08-15T15:26:19.927Z,1755271579.927 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2025-08-15T15:26:19.928Z,1755271579.928 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2025-08-15T15:26:20.169Z,1755271580.169 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2025-08-15T15:26:20.170Z,1755271580.170 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2025-08-15T15:26:20.452Z,1755271580.452 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2025-08-15T15:26:20.452Z,1755271580.452 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2025-08-15T15:26:20.573Z,1755271580.573 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2025-08-15T15:26:20.574Z,1755271580.574 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2025-08-15T15:26:21.364Z,1755271581.364 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2025-08-15T15:26:21.364Z,1755271581.364 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2025-08-15T15:26:21.901Z,1755271581.901 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2025-08-15T15:26:21.901Z,1755271581.901 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2025-08-15T15:26:22.491Z,1755271582.491 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2025-08-15T15:26:22.491Z,1755271582.491 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2025-08-15T15:26:23.569Z,1755271583.569 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2025-08-15T15:26:23.570Z,1755271583.570 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2025-08-15T15:26:23.946Z,1755271583.946 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2025-08-15T15:26:23.947Z,1755271583.947 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2025-08-15T15:26:24.347Z,1755271584.347 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2025-08-15T15:26:24.348Z,1755271584.348 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2025-08-15T15:26:24.590Z,1755271584.590 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2025-08-15T15:26:24.590Z,1755271584.590 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2025-08-15T15:26:24.747Z,1755271584.747 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2025-08-15T15:26:24.748Z,1755271584.748 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2025-08-15T15:26:24.856Z,1755271584.856 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Guidance
2025-08-15T15:26:24.857Z,1755271584.857 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2025-08-15T15:26:24.950Z,1755271584.950 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2025-08-15T15:26:25.154Z,1755271585.154 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2025-08-15T15:26:25.155Z,1755271585.155 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2025-08-15T15:26:25.431Z,1755271585.431 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2025-08-15T15:26:25.433Z,1755271585.433 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2025-08-15T15:26:25.435Z,1755271585.435 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2025-08-15T15:26:25.533Z,1755271585.533 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2025-08-15T15:26:25.814Z,1755271585.814 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2025-08-15T15:26:25.815Z,1755271585.815 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2025-08-15T15:26:25.913Z,1755271585.913 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2025-08-15T15:26:26.106Z,1755271586.106 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2025-08-15T15:26:26.222Z,1755271586.222 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2025-08-15T15:26:26.348Z,1755271586.348 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2025-08-15T15:26:26.476Z,1755271586.476 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2025-08-15T15:26:26.585Z,1755271586.585 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2025-08-15T15:26:26.764Z,1755271586.764 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Derivation.cfg
2025-08-15T15:26:26.876Z,1755271586.876 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/workSite.cfg
2025-08-15T15:26:26.976Z,1755271586.976 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2025-08-15T15:26:27.088Z,1755271587.088 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2025-08-15T15:26:27.189Z,1755271587.189 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2025-08-15T15:26:27.199Z,1755271587.199 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2025-08-15T15:26:27.385Z,1755271587.385 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2025-08-15T15:26:27.386Z,1755271587.386 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2025-08-15T15:26:27.556Z,1755271587.556 [BuoyancyServo] Loaded
2025-08-15T15:26:27.556Z,1755271587.556 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2025-08-15T15:26:27.580Z,1755271587.580 [ElevatorServo] Loaded
2025-08-15T15:26:27.580Z,1755271587.580 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2025-08-15T15:26:27.603Z,1755271587.603 [MassServo] Loaded
2025-08-15T15:26:27.603Z,1755271587.603 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2025-08-15T15:26:27.625Z,1755271587.625 [RudderServo] Loaded
2025-08-15T15:26:27.625Z,1755271587.625 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2025-08-15T15:26:27.643Z,1755271587.643 [ThrusterHE] Loaded
2025-08-15T15:26:27.644Z,1755271587.644 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2025-08-15T15:26:27.644Z,1755271587.644 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2025-08-15T15:26:27.645Z,1755271587.645 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2025-08-15T15:26:28.216Z,1755271588.216 [SBIT](DEBUG): Construct Startup Built In Test.
2025-08-15T15:26:28.275Z,1755271588.275 [SBIT] Loaded
2025-08-15T15:26:28.275Z,1755271588.275 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2025-08-15T15:26:28.278Z,1755271588.278 [IBIT](DEBUG): Construct Initiated Built In Test.
2025-08-15T15:26:28.455Z,1755271588.455 [IBIT] Loaded
2025-08-15T15:26:28.455Z,1755271588.455 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2025-08-15T15:26:28.460Z,1755271588.460 [CBIT](DEBUG): Construct Continuous Built In Test.
2025-08-15T15:26:28.875Z,1755271588.875 [CBIT] Loaded
2025-08-15T15:26:28.876Z,1755271588.876 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2025-08-15T15:26:28.907Z,1755271588.907 [GFScanner] Loaded
2025-08-15T15:26:28.907Z,1755271588.907 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread.
2025-08-15T15:26:28.907Z,1755271588.907 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2025-08-15T15:26:28.908Z,1755271588.908 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2025-08-15T15:26:29.082Z,1755271589.082 [CTD_Seabird] Loaded
2025-08-15T15:26:29.082Z,1755271589.082 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2025-08-15T15:26:29.084Z,1755271589.084 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406864E0
2025-08-15T15:26:29.084Z,1755271589.084 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 5819
2025-08-15T15:26:29.119Z,1755271589.119 [ESPComponent] Loaded
2025-08-15T15:26:29.119Z,1755271589.119 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2025-08-15T15:26:29.141Z,1755271589.141 [PAR_Licor] Loaded
2025-08-15T15:26:29.141Z,1755271589.141 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2025-08-15T15:26:29.187Z,1755271589.187 [WetLabsBB2FL] Loaded
2025-08-15T15:26:29.187Z,1755271589.187 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2025-08-15T15:26:29.188Z,1755271589.188 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406B64E0
2025-08-15T15:26:29.189Z,1755271589.189 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 5820
2025-08-15T15:26:29.189Z,1755271589.189 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2025-08-15T15:26:29.190Z,1755271589.190 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2025-08-15T15:26:29.243Z,1755271589.243 [DepthRateCalculator] Loaded
2025-08-15T15:26:29.243Z,1755271589.243 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2025-08-15T15:26:29.248Z,1755271589.248 [PitchRateCalculator] Loaded
2025-08-15T15:26:29.249Z,1755271589.249 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2025-08-15T15:26:29.259Z,1755271589.259 [SpeedCalculator] Loaded
2025-08-15T15:26:29.259Z,1755271589.259 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2025-08-15T15:26:29.264Z,1755271589.264 [YawRateCalculator] Loaded
2025-08-15T15:26:29.264Z,1755271589.264 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2025-08-15T15:26:29.284Z,1755271589.284 [ElevatorOffsetCalculator] Loaded
2025-08-15T15:26:29.284Z,1755271589.284 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2025-08-15T15:26:29.285Z,1755271589.285 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2025-08-15T15:26:29.285Z,1755271589.285 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2025-08-15T15:26:29.428Z,1755271589.428 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2025-08-15T15:26:29.428Z,1755271589.428 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2025-08-15T15:26:29.459Z,1755271589.459 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2025-08-15T15:26:29.460Z,1755271589.460 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2025-08-15T15:26:29.576Z,1755271589.576 [DeadReckonUsingMultipleVelocitySources] Loaded
2025-08-15T15:26:29.576Z,1755271589.576 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2025-08-15T15:26:29.590Z,1755271589.590 [NavChart] Loaded
2025-08-15T15:26:29.591Z,1755271589.591 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2025-08-15T15:26:29.596Z,1755271589.596 [UniversalFixResidualReporter] Loaded
2025-08-15T15:26:29.597Z,1755271589.597 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2025-08-15T15:26:29.597Z,1755271589.597 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2025-08-15T15:26:29.598Z,1755271589.598 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2025-08-15T15:26:30.099Z,1755271590.099 [AHRS_M2] Loaded
2025-08-15T15:26:30.099Z,1755271590.099 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2025-08-15T15:26:30.139Z,1755271590.139 [BackseatComponent] Loaded
2025-08-15T15:26:30.139Z,1755271590.139 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2025-08-15T15:26:30.140Z,1755271590.140 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 40A824E0
2025-08-15T15:26:30.140Z,1755271590.140 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 5821
2025-08-15T15:26:30.143Z,1755271590.143 [LcmUniversalReporter] Loaded
2025-08-15T15:26:30.143Z,1755271590.143 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2025-08-15T15:26:30.892Z,1755271590.892 [BPC1] Loaded
2025-08-15T15:26:30.892Z,1755271590.892 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2025-08-15T15:26:30.994Z,1755271590.994 [DAT] Loaded
2025-08-15T15:26:30.995Z,1755271590.995 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2025-08-15T15:26:30.996Z,1755271590.996 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40AB24E0
2025-08-15T15:26:30.996Z,1755271590.996 [DAT ThreadHandler](INFO): Protected caller Thread ID is 5822
2025-08-15T15:26:31.069Z,1755271591.069 [DataOverHttps] Loaded
2025-08-15T15:26:31.069Z,1755271591.069 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2025-08-15T15:26:31.070Z,1755271591.070 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40AE24E0
2025-08-15T15:26:31.071Z,1755271591.071 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 5823
2025-08-15T15:26:31.094Z,1755271591.094 [Depth_Keller] Loaded
2025-08-15T15:26:31.095Z,1755271591.095 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2025-08-15T15:26:31.137Z,1755271591.137 [DVL_micro] Loaded
2025-08-15T15:26:31.137Z,1755271591.137 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread.
2025-08-15T15:26:31.200Z,1755271591.200 [NAL9602] Loaded
2025-08-15T15:26:31.200Z,1755271591.200 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2025-08-15T15:26:31.227Z,1755271591.227 [Onboard] Loaded
2025-08-15T15:26:31.227Z,1755271591.227 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2025-08-15T15:26:31.228Z,1755271591.228 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40B124E0
2025-08-15T15:26:31.229Z,1755271591.229 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 5824
2025-08-15T15:26:31.235Z,1755271591.235 [PowerOnly](INFO): Adding load control power supply at /dev/loadC1
2025-08-15T15:26:31.249Z,1755271591.249 [PowerOnly] Loaded
2025-08-15T15:26:31.249Z,1755271591.249 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread.
2025-08-15T15:26:31.263Z,1755271591.263 [Power24vConverter] Loaded
2025-08-15T15:26:31.263Z,1755271591.263 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2025-08-15T15:26:31.280Z,1755271591.280 [Radio_Surface] Loaded
2025-08-15T15:26:31.280Z,1755271591.280 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2025-08-15T15:26:31.281Z,1755271591.281 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40B424E0
2025-08-15T15:26:31.282Z,1755271591.282 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 5825
2025-08-15T15:26:31.298Z,1755271591.298 [Sonardyne_Nano] Loaded
2025-08-15T15:26:31.298Z,1755271591.298 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2025-08-15T15:26:31.299Z,1755271591.299 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2025-08-15T15:26:31.299Z,1755271591.299 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2025-08-15T15:26:31.361Z,1755271591.361 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2025-08-15T15:26:31.362Z,1755271591.362 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2025-08-15T15:26:31.418Z,1755271591.418 [VerticalControl](DEBUG): Construct VerticalControl.
2025-08-15T15:26:31.471Z,1755271591.471 [VerticalControl] Loaded
2025-08-15T15:26:31.472Z,1755271591.472 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2025-08-15T15:26:31.475Z,1755271591.475 [HorizontalControl](DEBUG): Construct HorizontalControl.
2025-08-15T15:26:31.519Z,1755271591.519 [HorizontalControl] Loaded
2025-08-15T15:26:31.519Z,1755271591.519 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2025-08-15T15:26:31.522Z,1755271591.522 [SpeedControl](DEBUG): Construct SpeedControl.
2025-08-15T15:26:31.524Z,1755271591.524 [SpeedControl] Loaded
2025-08-15T15:26:31.524Z,1755271591.524 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2025-08-15T15:26:31.527Z,1755271591.527 [LoopControl](DEBUG): Construct LoopControl.
2025-08-15T15:26:31.527Z,1755271591.527 [LoopControl] Loaded
2025-08-15T15:26:31.528Z,1755271591.528 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2025-08-15T15:26:31.528Z,1755271591.528 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2025-08-15T15:26:31.528Z,1755271591.528 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2025-08-15T15:26:31.539Z,1755271591.539 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2025-08-15T15:26:31.540Z,1755271591.540 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2025-08-15T15:26:31.905Z,1755271591.905 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2025-08-15T15:26:31.912Z,1755271591.912 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2025-08-15T15:26:31.915Z,1755271591.915 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2025-08-15T15:26:31.926Z,1755271591.926 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2025-08-15T15:26:31.927Z,1755271591.927 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C684E0
2025-08-15T15:26:31.927Z,1755271591.927 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 5826
2025-08-15T15:26:31.932Z,1755271591.932 [Supervisor](INFO): Main Thread ID is 3603
2025-08-15T15:26:31.932Z,1755271591.932 [Supervisor](DEBUG): Running supervisor.
2025-08-15T15:26:31.933Z,1755271591.933 [CommandExec ThreadHandler](INFO): Handler Thread ID is 5827
2025-08-15T15:26:31.933Z,1755271591.933 [CommandExec](INFO): Initializing the command executive.
2025-08-15T15:26:31.935Z,1755271591.935 [CommandLine ThreadHandler](INFO): Handler Thread ID is 5828
2025-08-15T15:26:31.937Z,1755271591.937 [controlThread ThreadHandler](INFO): Handler Thread ID is 5829
2025-08-15T15:26:31.937Z,1755271591.937 [controlThread](DEBUG): Initializing ControlThread
2025-08-15T15:26:31.939Z,1755271591.939 [SBIT](INFO): Initialize SBIT Component.
2025-08-15T15:26:31.940Z,1755271591.940 [SBIT](IMPORTANT): git: 2025-05-29
2025-08-15T15:26:31.940Z,1755271591.940 [SBIT](INFO): git hash: c78c975c7bb2a66b27244d2837f68dff299fa024
2025-08-15T15:26:31.940Z,1755271591.940 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2025-08-15T15:26:31.942Z,1755271591.942 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2025-08-15T15:26:31.943Z,1755271591.943 [SBIT](INFO): Beginning SBIT in 147.000000 seconds.
2025-08-15T15:26:31.943Z,1755271591.943 [IBIT](INFO): Initialize IBIT Component.
2025-08-15T15:26:31.944Z,1755271591.944 [CBIT](DEBUG): Initialize CBIT Component.
2025-08-15T15:26:31.945Z,1755271591.945 [logger ThreadHandler](INFO): Handler Thread ID is 5830
2025-08-15T15:26:31.958Z,1755271591.958 [CBIT](DEBUG): Initialized mux pins.
2025-08-15T15:26:31.959Z,1755271591.959 [CBIT](DEBUG): Initializing the watchdog timer.
2025-08-15T15:26:31.971Z,1755271591.971 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 5831
2025-08-15T15:26:31.972Z,1755271591.972 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2025-08-15T15:26:31.976Z,1755271591.976 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 5833
2025-08-15T15:26:31.979Z,1755271591.979 [WetLabsBB2FL](INFO): Powering up
2025-08-15T15:26:31.980Z,1755271591.980 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 5835
2025-08-15T15:26:31.983Z,1755271591.983 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2025-08-15T15:26:31.983Z,1755271591.983 [CBIT](DEBUG): Initializing heartbeat.
2025-08-15T15:26:31.997Z,1755271591.997 [DAT ThreadHandler](INFO): Handler Thread ID is 5836
2025-08-15T15:26:31.997Z,1755271591.997 [DAT](INFO): Powering up
2025-08-15T15:26:31.998Z,1755271591.998 [DAT](DEBUG): Initializing DAT.
2025-08-15T15:26:32.004Z,1755271592.004 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 5838
2025-08-15T15:26:32.005Z,1755271592.005 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2025-08-15T15:26:32.019Z,1755271592.019 [Onboard ThreadHandler](INFO): Handler Thread ID is 5839
2025-08-15T15:26:32.037Z,1755271592.037 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 5840
2025-08-15T15:26:32.054Z,1755271592.054 [CBIT](DEBUG): Deactivating emergency mode.
2025-08-15T15:26:32.067Z,1755271592.067 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 5841
2025-08-15T15:26:32.074Z,1755271592.074 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2025-08-15T15:26:32.074Z,1755271592.074 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2025-08-15T15:26:32.074Z,1755271592.074 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2025-08-15T15:26:32.074Z,1755271592.074 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2025-08-15T15:26:32.074Z,1755271592.074 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2025-08-15T15:26:32.075Z,1755271592.075 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2025-08-15T15:26:32.075Z,1755271592.075 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2025-08-15T15:26:32.075Z,1755271592.075 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2025-08-15T15:26:32.094Z,1755271592.094 [CBIT](DEBUG): Backplane powered.
2025-08-15T15:26:32.095Z,1755271592.095 [GFScanner](DEBUG): Initializing GFScanner
2025-08-15T15:26:32.095Z,1755271592.095 [GFScanner](DEBUG): Deactivating GF circuits.
2025-08-15T15:26:32.103Z,1755271592.103 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2025-08-15T15:26:32.103Z,1755271592.103 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2025-08-15T15:26:32.104Z,1755271592.104 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2025-08-15T15:26:32.104Z,1755271592.104 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2025-08-15T15:26:32.104Z,1755271592.104 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2025-08-15T15:26:32.105Z,1755271592.105 [NavChart](DEBUG): Initialize NavChart Navigation.
2025-08-15T15:26:32.106Z,1755271592.106 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2025-08-15T15:26:32.108Z,1755271592.108 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2025-08-15T15:26:32.110Z,1755271592.110 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2025-08-15T15:26:32.119Z,1755271592.119 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2025-08-15T15:26:32.119Z,1755271592.119 [LoopControl](DEBUG): Initialize LoopControlComponent.
2025-08-15T15:26:32.120Z,1755271592.120 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2025-08-15T15:26:32.121Z,1755271592.121 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2025-08-15T15:26:32.121Z,1755271592.121 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2025-08-15T15:26:32.127Z,1755271592.127 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2025-08-15T15:26:32.197Z,1755271592.197 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
2025-08-15T15:26:32.217Z,1755271592.217 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2025-08-15T15:26:32.270Z,1755271592.270 [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-08-15T15:26:32.275Z,1755271592.275 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2025-08-15T15:26:32.275Z,1755271592.275 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2025-08-15T15:26:32.284Z,1755271592.284 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2025-08-15T15:26:32.443Z,1755271592.443 [Radio_Surface](INFO): Powering up
2025-08-15T15:26:32.606Z,1755271592.606 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into:
0
13
Burn on
Dropped weight due to communications timeout.
5
Default mission has been running for
Restarting logs and Default mission.
restart logs
2025-08-15T15:26:32.632Z,1755271592.632 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2025-08-15T15:26:32.634Z,1755271592.634 [Default:A.Wait](DEBUG): Construct Wait.
2025-08-15T15:26:32.636Z,1755271592.636 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2025-08-15T15:26:32.677Z,1755271592.677 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2025-08-15T15:26:32.680Z,1755271592.680 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2025-08-15T15:26:32.697Z,1755271592.697 [Default:E.Execute](DEBUG): Construct Execute.
2025-08-15T15:26:32.724Z,1755271592.724 [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-08-15T15:26:32.729Z,1755271592.729 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DVL_micro,NAL9602,PowerOnly,Power24vConverter,Sonardyne_Nano,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter,
2025-08-15T15:26:32.780Z,1755271592.780 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2025-08-15T15:26:32.843Z,1755271592.843 [Depth_Keller](INFO): Initializing.
2025-08-15T15:26:32.846Z,1755271592.846 [PowerOnly](INFO): Powering up loadControl
2025-08-15T15:26:32.863Z,1755271592.863 [Power24vConverter](INFO): Powering up.
2025-08-15T15:26:32.864Z,1755271592.864 [Sonardyne_Nano](INFO): Initializing.
2025-08-15T15:26:32.891Z,1755271592.891 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-08-15T15:26:32.913Z,1755271592.913 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2025-08-15T15:26:32.919Z,1755271592.919 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2025-08-15T15:26:32.920Z,1755271592.920 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-08-15T15:26:32.927Z,1755271592.927 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-08-15T15:26:32.928Z,1755271592.928 [MassServo](DEBUG): Initializing EZServoServo.
2025-08-15T15:26:32.935Z,1755271592.935 [MassServo](DEBUG): Initializing MassServo.
2025-08-15T15:26:32.936Z,1755271592.936 [RudderServo](DEBUG): Initializing EZServoServo.
2025-08-15T15:26:32.943Z,1755271592.943 [RudderServo](DEBUG): Initializing RudderServo.
2025-08-15T15:26:32.944Z,1755271592.944 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-08-15T15:26:32.951Z,1755271592.951 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-08-15T15:26:34.591Z,1755271594.591 [WetLabsBB2FL](INFO): Powering down
2025-08-15T15:26:35.166Z,1755271595.166 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART
2025-08-15T15:26:36.404Z,1755271596.404 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2213
2025-08-15T15:26:38.151Z,1755271598.151 [RudderServo](FAULT): Overload Error
2025-08-15T15:26:38.151Z,1755271598.151 [RudderServo] Hardware Fault, FailCount= 1
2025-08-15T15:26:38.151Z,1755271598.151 [RudderServo](ERROR): Hardware Fault
2025-08-15T15:26:38.274Z,1755271598.274 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-08-15T15:26:38.631Z,1755271598.631 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-08-15T15:26:38.631Z,1755271598.631 [RudderServo](INFO): Powering down
2025-08-15T15:26:39.313Z,1755271599.313 [RudderServo](DEBUG): Initializing EZServoServo.
2025-08-15T15:26:39.431Z,1755271599.431 [RudderServo](DEBUG): Initializing RudderServo.
2025-08-15T15:26:39.435Z,1755271599.435 [CBIT](INFO): Clearing failed state for component RudderServo
2025-08-15T15:26:39.436Z,1755271599.436 [RudderServo] No Fault, FailCount= 1
2025-08-15T15:26:44.099Z,1755271604.099 [DAT](INFO): DAT read:
2025-08-15T15:26:44.101Z,1755271604.101 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series
2025-08-15T15:26:44.567Z,1755271604.567 [RudderServo](FAULT): Overload Error
2025-08-15T15:26:44.567Z,1755271604.567 [RudderServo] Hardware Fault, FailCount= 2
2025-08-15T15:26:44.567Z,1755271604.567 [RudderServo](ERROR): Hardware Fault
2025-08-15T15:26:44.679Z,1755271604.679 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-08-15T15:26:44.991Z,1755271604.991 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-08-15T15:26:44.991Z,1755271604.991 [RudderServo](INFO): Powering down
2025-08-15T15:26:45.771Z,1755271605.771 [RudderServo](DEBUG): Initializing EZServoServo.
2025-08-15T15:26:45.863Z,1755271605.863 [DAT](INFO): DAT read: MF Frequency Band
2025-08-15T15:26:45.865Z,1755271605.865 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0
2025-08-15T15:26:45.865Z,1755271605.865 [DAT](INFO): DAT read: Aug 15 2025 15:26:40
2025-08-15T15:26:45.891Z,1755271605.891 [RudderServo](DEBUG): Initializing RudderServo.
2025-08-15T15:26:45.895Z,1755271605.895 [CBIT](INFO): Clearing failed state for component RudderServo
2025-08-15T15:26:45.895Z,1755271605.895 [RudderServo] No Fault, FailCount= 2
2025-08-15T15:26:47.124Z,1755271607.124 [DAT](INFO): DAT read: Features enabled [Bearing]
2025-08-15T15:26:47.125Z,1755271607.125 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC
2025-08-15T15:26:47.125Z,1755271607.125 [DAT](INFO): commRate: 1200
2025-08-15T15:26:49.191Z,1755271609.191 [DAT](INFO): entering command mode
2025-08-15T15:26:49.391Z,1755271609.391 [DAT](INFO): DAT read:
2025-08-15T15:26:49.392Z,1755271609.392 [DAT](INFO): DAT read: user:1>
2025-08-15T15:26:49.392Z,1755271609.392 [DAT](INFO): setting verbose to 3
2025-08-15T15:26:49.643Z,1755271609.643 [DAT](INFO): DAT read: user:1>
2025-08-15T15:26:49.644Z,1755271609.644 [DAT](INFO): DAT read: Verbose | 3
2025-08-15T15:26:49.645Z,1755271609.645 [DAT](INFO): set verbose to 3
2025-08-15T15:26:49.645Z,1755271609.645 [DAT](INFO): setting DatVerbose to 27440
2025-08-15T15:26:49.895Z,1755271609.895 [DAT](INFO): DAT read: user:2>
2025-08-15T15:26:49.896Z,1755271609.896 [DAT](INFO): DAT read: DatVerbose | 27440
2025-08-15T15:26:49.897Z,1755271609.897 [DAT](INFO): set DatVerbose to 27440
2025-08-15T15:26:49.897Z,1755271609.897 [DAT](INFO): setting transmit power to 8
2025-08-15T15:26:50.147Z,1755271610.147 [DAT](INFO): DAT read: user:3>
2025-08-15T15:26:50.148Z,1755271610.148 [DAT](INFO): DAT read: TxPower | 8 (Max)
2025-08-15T15:26:50.148Z,1755271610.148 [DAT](INFO): set transmit power to 8
2025-08-15T15:26:50.149Z,1755271610.149 [DAT](INFO): setting local address to 5
2025-08-15T15:26:50.399Z,1755271610.399 [DAT](INFO): DAT read: user:4>
2025-08-15T15:26:50.400Z,1755271610.400 [DAT](INFO): DAT read: LocalAddr | 5
2025-08-15T15:26:50.401Z,1755271610.401 [DAT](INFO): set local address to 5
2025-08-15T15:26:50.402Z,1755271610.402 [DAT](INFO): Setting time to: 15:26:50 And date to:8/15/2025
2025-08-15T15:26:50.652Z,1755271610.652 [DAT](INFO): DAT read: user:5>
2025-08-15T15:26:50.654Z,1755271610.654 [DAT](INFO): DAT read: Fri Aug 15, 2025 15:26:50
2025-08-15T15:26:50.655Z,1755271610.655 [DAT](INFO): Local DAT time set to Fri Aug 15, 2025 15:26:50
2025-08-15T15:26:51.031Z,1755271611.031 [RudderServo](FAULT): Overload Error
2025-08-15T15:26:51.031Z,1755271611.031 [RudderServo] Hardware Fault, FailCount= 3
2025-08-15T15:26:51.031Z,1755271611.031 [RudderServo](ERROR): Hardware Fault
2025-08-15T15:26:51.143Z,1755271611.143 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-08-15T15:26:51.143Z,1755271611.143 [CBIT](CRITICAL): Hardware Fault in component: RudderServo
2025-08-15T15:26:51.399Z,1755271611.399 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-08-15T15:26:51.399Z,1755271611.399 [RudderServo](INFO): Powering down
2025-08-15T15:26:51.401Z,1755271611.401 [CommandExec](FAULT): Scheduling is paused
2025-08-15T15:26:51.402Z,1755271611.402 [CBIT](INFO): Critical error at 20250815T152651
2025-08-15T15:26:51.402Z,1755271611.402 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2025-08-15T15:26:52.191Z,1755271612.191 [RudderServo](DEBUG): Initializing EZServoServo.
2025-08-15T15:26:52.311Z,1755271612.311 [RudderServo](DEBUG): Initializing RudderServo.
2025-08-15T15:27:01.438Z,1755271621.438 [NAL9602](INFO): Powering up NAL9602
2025-08-15T15:27:12.334Z,1755271632.334 [NAL9602](INFO): NAL9602 initialized
2025-08-15T15:27:53.196Z,1755271673.196 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-08-15T15:28:13.807Z,1755271693.807 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-08-15T15:28:43.981Z,1755271723.981 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004683
2025-08-15T15:28:59.410Z,1755271739.410 [SBIT](IMPORTANT): Beginning Startup BIT
2025-08-15T15:28:59.415Z,1755271739.415 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-08-15T15:29:01.206Z,1755271741.206 [ElevatorServo](FAULT): Overload Error
2025-08-15T15:29:01.207Z,1755271741.207 [ElevatorServo] Hardware Fault, FailCount= 1
2025-08-15T15:29:01.207Z,1755271741.207 [ElevatorServo](ERROR): Hardware Fault
2025-08-15T15:29:01.315Z,1755271741.315 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-08-15T15:29:01.448Z,1755271741.448 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-08-15T15:29:01.448Z,1755271741.448 [ElevatorServo](INFO): Powering down
2025-08-15T15:29:02.252Z,1755271742.252 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-08-15T15:29:02.371Z,1755271742.371 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-08-15T15:29:02.403Z,1755271742.403 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-08-15T15:29:02.403Z,1755271742.403 [ElevatorServo] No Fault, FailCount= 1
2025-08-15T15:29:03.914Z,1755271743.914 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.010950
CHAN A1 (24V): 0.005110
CHAN A2 (12V): -0.003910
CHAN A3 (5V): -0.002096
CHAN B0 (3.3V): -0.000995
CHAN B1 (3.15aV): -0.001120
CHAN B2 (3.15bV): -0.001397
CHAN B3 (GND): -0.000450
OPEN: 0.007019
Full Scale: +/- 1 mA
2025-08-15T15:29:07.519Z,1755271747.519 [ElevatorServo](FAULT): Overload Error
2025-08-15T15:29:07.519Z,1755271747.519 [ElevatorServo] Hardware Fault, FailCount= 2
2025-08-15T15:29:07.519Z,1755271747.519 [ElevatorServo](ERROR): Hardware Fault
2025-08-15T15:29:07.663Z,1755271747.663 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-08-15T15:29:07.904Z,1755271747.904 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-08-15T15:29:07.904Z,1755271747.904 [ElevatorServo](INFO): Powering down
2025-08-15T15:29:08.729Z,1755271748.729 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-08-15T15:29:08.847Z,1755271748.847 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-08-15T15:29:08.879Z,1755271748.879 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-08-15T15:29:08.879Z,1755271748.879 [ElevatorServo] No Fault, FailCount= 2
2025-08-15T15:29:12.496Z,1755271752.496 [SBIT](ERROR): Could not read rudderAngleReader_.
2025-08-15T15:29:13.616Z,1755271753.616 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-08-15T15:29:13.774Z,1755271753.774 [ElevatorServo](FAULT): Overload Error
2025-08-15T15:29:13.775Z,1755271753.775 [ElevatorServo] Hardware Fault, FailCount= 3
2025-08-15T15:29:13.775Z,1755271753.775 [ElevatorServo](ERROR): Hardware Fault
2025-08-15T15:29:13.780Z,1755271753.780 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-08-15T15:29:13.780Z,1755271753.780 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo
2025-08-15T15:29:13.977Z,1755271753.977 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-08-15T15:29:13.978Z,1755271753.978 [ElevatorServo](INFO): Powering down
2025-08-15T15:29:13.981Z,1755271753.981 [CBIT](INFO): Critical error at 20250815T152913
2025-08-15T15:29:14.784Z,1755271754.784 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-08-15T15:29:14.904Z,1755271754.904 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-08-15T15:29:26.932Z,1755271766.932 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-08-15T15:29:32.201Z,1755271772.201 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2025-08-15T15:29:32.202Z,1755271772.202 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-08-15T15:29:32.212Z,1755271772.212 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-08-15T15:29:32.577Z,1755271772.577 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-08-15T15:29:32.578Z,1755271772.578 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2025-08-15T15:29:39.003Z,1755271779.003 [SBIT](ERROR): Could not read elevatorAngleReader_.
2025-08-15T15:29:39.003Z,1755271779.003 [SBIT](ERROR): Could not read rudderAngleReader_.
2025-08-15T15:29:39.004Z,1755271779.004 [SBIT](FAULT): Control surface position failure.
2025-08-15T15:29:52.758Z,1755271792.758 [SBIT](ERROR): Could not read elevatorAngleReader_.
2025-08-15T15:29:52.758Z,1755271792.758 [SBIT](ERROR): Could not read rudderAngleReader_.
2025-08-15T15:29:52.767Z,1755271792.767 [SBIT](FAULT): Control surface position failure.
2025-08-15T15:29:53.182Z,1755271793.182 [SBIT](CRITICAL): SBIT FAILED
2025-08-15T15:29:53.203Z,1755271793.203 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2025-08-15T15:29:53.204Z,1755271793.204 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=5 count;
2025-08-15T15:29:53.204Z,1755271793.204 [SBIT](IMPORTANT): CBIT.runNavErrorCritical=0 bool;
2025-08-15T15:29:53.204Z,1755271793.204 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool;
2025-08-15T15:29:53.205Z,1755271793.205 [SBIT](IMPORTANT): ElevatorServo.currLimit=50 percent;
2025-08-15T15:29:53.205Z,1755271793.205 [SBIT](IMPORTANT): ThrusterHE.bestEffortMode=1 bool;
2025-08-15T15:29:53.205Z,1755271793.205 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=264.941384 cubic_centimeter;
2025-08-15T15:29:53.205Z,1755271793.205 [SBIT](IMPORTANT): VerticalControl.massDefault=31.919755 millimeter;
2025-08-15T15:29:53.218Z,1755271793.218 [CBIT](INFO): Critical error at 20250815T152953
2025-08-15T15:29:53.695Z,1755271793.695 [MissionManager](IMPORTANT): Started mission Startup
2025-08-15T15:29:53.696Z,1755271793.696 [Startup] Running Loop=1
2025-08-15T15:29:53.696Z,1755271793.696 [Startup](DEBUG): Aggregate::initialize Startup
2025-08-15T15:29:53.696Z,1755271793.696 [Startup:A.GoToSurface] Running Loop=1
2025-08-15T15:29:53.696Z,1755271793.696 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-08-15T15:29:53.696Z,1755271793.696 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-08-15T15:29:53.697Z,1755271793.697 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-08-15T15:29:53.697Z,1755271793.697 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-08-15T15:29:53.698Z,1755271793.698 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-08-15T15:29:53.698Z,1755271793.698 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-08-15T15:29:53.698Z,1755271793.698 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-08-15T15:29:53.700Z,1755271793.700 [Startup:StartupSatComms] Running Loop=1
2025-08-15T15:29:53.700Z,1755271793.700 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2025-08-15T15:29:53.700Z,1755271793.700 [Startup:StartupSatComms:A] Running Loop=1
2025-08-15T15:29:54.017Z,1755271794.017 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2025-08-15T15:30:53.797Z,1755271853.797 [Startup:StartupSatComms:A](INFO): Timed out from 2025-08-15T15:29:53.7Z
2025-08-15T15:30:53.797Z,1755271853.797 [Startup:StartupSatComms:A] Stopped
2025-08-15T15:30:53.797Z,1755271853.797 [Startup:StartupSatComms:B] Running Loop=1
2025-08-15T15:30:54.257Z,1755271854.257 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-08-15T15:31:01.055Z,1755271861.055 [DataOverHttps](INFO): Sending 40 bytes from file Logs/20250814T235622/Courier0268.lzma
2025-08-15T15:31:02.059Z,1755271862.059 [DataOverHttps](INFO): Moved sent file to Logs/20250814T235622/Courier0268.lzma.bak
2025-08-15T15:31:02.059Z,1755271862.059 [DataOverHttps](INFO): SBD MOMSN=25852028
2025-08-15T15:31:18.971Z,1755271878.971 [DataOverHttps](INFO): Sending 247 bytes from file Logs/20250815T152619/Courier0000.lzma
2025-08-15T15:31:19.972Z,1755271879.972 [DataOverHttps](INFO): Moved sent file to Logs/20250815T152619/Courier0000.lzma.bak
2025-08-15T15:31:19.973Z,1755271879.973 [DataOverHttps](INFO): SBD MOMSN=25852034
2025-08-15T15:31:34.261Z,1755271894.261 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-08-15T15:31:38.159Z,1755271898.159 [DataOverHttps](INFO): Sending 234 bytes from file Logs/20250814T235622/Express0269.lzma
2025-08-15T15:31:39.162Z,1755271899.162 [DataOverHttps](INFO): Moved sent file to Logs/20250814T235622/Express0269.lzma.bak
2025-08-15T15:31:39.162Z,1755271899.162 [DataOverHttps](INFO): SBD MOMSN=25852040
2025-08-15T15:31:54.004Z,1755271914.004 [Startup:StartupSatComms:B](INFO): Timed out from 2025-08-15T15:30:53.8Z
2025-08-15T15:31:54.005Z,1755271914.005 [Startup:StartupSatComms:B] Stopped
2025-08-15T15:31:54.005Z,1755271914.005 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2025-08-15T15:31:54.005Z,1755271914.005 [Startup:StartupSatComms] Stopped
2025-08-15T15:31:54.005Z,1755271914.005 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2025-08-15T15:31:54.006Z,1755271914.006 [Startup](INFO): Completed Startup
2025-08-15T15:31:54.006Z,1755271914.006 [MissionManager](INFO): Startup is completed.
2025-08-15T15:31:54.010Z,1755271914.010 [MissionManager](INFO): Uninitializing Mission Startup
2025-08-15T15:31:54.010Z,1755271914.010 [Startup] Stopped
2025-08-15T15:31:54.011Z,1755271914.011 [Startup](DEBUG): Aggregate::uninitialize Startup
2025-08-15T15:31:54.011Z,1755271914.011 [Startup:A.GoToSurface] Stopped
2025-08-15T15:31:54.011Z,1755271914.011 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-08-15T15:31:54.416Z,1755271914.416 [MissionManager](IMPORTANT): Started mission Default
2025-08-15T15:31:54.416Z,1755271914.416 [Default] Running Loop=1
2025-08-15T15:31:54.416Z,1755271914.416 [Default](DEBUG): Aggregate::initialize Default
2025-08-15T15:31:54.416Z,1755271914.416 [Default:B.GoToSurface] Running Loop=1
2025-08-15T15:31:54.416Z,1755271914.416 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-08-15T15:31:54.417Z,1755271914.417 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-08-15T15:31:54.417Z,1755271914.417 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-08-15T15:31:54.417Z,1755271914.417 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-08-15T15:31:54.418Z,1755271914.418 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-08-15T15:31:54.418Z,1755271914.418 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-08-15T15:31:54.422Z,1755271914.422 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-08-15T15:31:54.423Z,1755271914.423 [Default:A.Wait] Running Loop=1
2025-08-15T15:31:54.423Z,1755271914.423 [Default:A.Wait](DEBUG): Initialize Wait Component.
2025-08-15T15:31:56.781Z,1755271916.781 [DataOverHttps](INFO): Sending 988 bytes from file Logs/20250815T152619/Express0001.lzma
2025-08-15T15:31:57.781Z,1755271917.781 [DataOverHttps](INFO): Moved sent file to Logs/20250815T152619/Express0001.lzma.bak
2025-08-15T15:31:57.781Z,1755271917.781 [DataOverHttps](INFO): SBD MOMSN=25852048
2025-08-15T15:32:07.730Z,1755271927.730 [Default:A.Wait](INFO): Done Waiting.
2025-08-15T15:32:07.731Z,1755271927.731 [Default:A.Wait] Stopped
2025-08-15T15:32:07.731Z,1755271927.731 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2025-08-15T15:32:08.177Z,1755271928.177 [Default:CheckIn] Running Loop=1
2025-08-15T15:32:08.177Z,1755271928.177 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-08-15T15:32:08.177Z,1755271928.177 [Default:CheckIn:Read_GPS] Running Loop=1
2025-08-15T15:32:08.569Z,1755271928.569 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-08-15T15:32:15.801Z,1755271935.801 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-08-15T15:32:22.764Z,1755271942.764 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-08-15T15:32:33.231Z,1755271953.231 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2025-08-15T15:32:33.231Z,1755271953.231 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-08-15T15:32:33.282Z,1755271953.282 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-08-15T15:32:33.660Z,1755271953.660 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-08-15T15:32:33.660Z,1755271953.660 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2025-08-15T15:33:52.890Z,1755272032.890 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-08-15T15:34:11.476Z,1755272051.476 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-08-15T15:34:19.557Z,1755272059.557 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-08-15T15:34:32.504Z,1755272072.504 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-08-15T15:34:38.096Z,1755272078.096 [BPC1](ERROR): Battery stick #2 (s/n: 0124) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-08-15T15:34:38.096Z,1755272078.096 [BPC1](ERROR): Battery stick #4 (s/n: 017A) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0.
2025-08-15T15:34:38.097Z,1755272078.097 [BPC1](INFO): Calculating totals. Valid battery stick count: 53. Valid reserve battery stick count: 6.
2025-08-15T15:34:38.101Z,1755272078.101 [BPC1](INFO): Received data from all battery sticks.
2025-08-15T15:35:34.267Z,1755272134.267 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2025-08-15T15:35:34.267Z,1755272134.267 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-08-15T15:35:34.308Z,1755272134.308 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-08-15T15:35:34.719Z,1755272134.719 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-08-15T15:35:34.719Z,1755272134.719 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2025-08-15T15:37:08.400Z,1755272228.400 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-08-15T15:32:08.2Z
2025-08-15T15:37:08.400Z,1755272228.400 [Default:CheckIn:Read_GPS] Stopped
2025-08-15T15:37:08.400Z,1755272228.400 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-08-15T15:37:08.808Z,1755272228.808 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-08-15T15:37:09.988Z,1755272229.988 [DataOverHttps](INFO): Sending 170 bytes from file Logs/20250815T152619/Courier0004.lzma
2025-08-15T15:37:10.352Z,1755272230.352 [DataOverHttps](INFO): Moved sent file to Logs/20250815T152619/Courier0004.lzma.bak
2025-08-15T15:37:10.352Z,1755272230.352 [DataOverHttps](INFO): SBD MOMSN=25852119
2025-08-15T15:37:13.677Z,1755272233.677 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-08-15T15:37:13.677Z,1755272233.677 [NAL9602] Data Fault, FailCount= 1
2025-08-15T15:37:13.677Z,1755272233.677 [NAL9602](ERROR): Data Fault
2025-08-15T15:37:13.706Z,1755272233.706 [CBIT](ERROR): Data Fault in component: NAL9602
2025-08-15T15:37:14.084Z,1755272234.084 [NAL9602](INFO): Powering down
2025-08-15T15:37:14.933Z,1755272234.933 [CBIT](INFO): Clearing failed state for component NAL9602
2025-08-15T15:37:14.933Z,1755272234.933 [NAL9602] No Fault, FailCount= 1
2025-08-15T15:37:27.382Z,1755272247.382 [DataOverHttps](INFO): Sending 189 bytes from file Logs/20250815T152619/Express0005.lzma
2025-08-15T15:37:28.386Z,1755272248.386 [DataOverHttps](INFO): Moved sent file to Logs/20250815T152619/Express0005.lzma.bak
2025-08-15T15:37:28.388Z,1755272248.388 [DataOverHttps](INFO): SBD MOMSN=25852121
2025-08-15T15:37:31.101Z,1755272251.101 [Default:CheckIn:Read_Iridium] Stopped
2025-08-15T15:37:31.101Z,1755272251.101 [Default:CheckIn:C.Wait] Running Loop=1
2025-08-15T15:37:31.101Z,1755272251.101 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-08-15T15:37:44.406Z,1755272264.406 [NAL9602](INFO): Powering up NAL9602
2025-08-15T15:37:55.296Z,1755272275.296 [NAL9602](INFO): NAL9602 initialized
2025-08-15T15:38:35.295Z,1755272315.295 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2025-08-15T15:38:35.295Z,1755272315.295 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-08-15T15:38:35.306Z,1755272315.306 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-08-15T15:38:35.728Z,1755272315.728 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-08-15T15:38:35.728Z,1755272315.728 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2025-08-15T15:40:35.373Z,1755272435.373 [CommandExec](IMPORTANT): got command maintain sensor NAL9602.latitude_fix 37.8 degree
2025-08-15T15:40:35.377Z,1755272435.377 [ComponentRegistry](DEBUG): SyncComponent "Maintain_NAL9602.latitude_fix" handled in the control thread.
2025-08-15T15:40:35.398Z,1755272435.398 [CommandExec](IMPORTANT): got command maintain sensor NAL9602.longitude_fix -121 degree
2025-08-15T15:40:35.402Z,1755272435.402 [ComponentRegistry](DEBUG): SyncComponent "Maintain_NAL9602.longitude_fix" handled in the control thread.
2025-08-15T15:40:35.402Z,1755272435.402 [CommandExec](IMPORTANT): got command set NAL9602.time_fix 1755272315 second
2025-08-15T15:40:35.728Z,1755272435.728 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DVL_micro,NAL9602,PowerOnly,Power24vConverter,Sonardyne_Nano,PAR_Licor,Depth_Keller,Maintain_NAL9602.latitude_fix,Maintain_NAL9602.longitude_fix,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter,
2025-08-15T15:41:08.808Z,1755272468.808 [NAL9602](INFO): Not Powering down - fast GPS
2025-08-15T15:41:20.701Z,1755272480.701 [DataOverHttps](IMPORTANT): SBD MTMSN=20250815T154119
2025-08-15T15:41:28.251Z,1755272488.251 [DataOverHttps](INFO): Received command: sched asap "load Transport/keepstation.tl;set keepstation.NeedCommsTime 4 min;set keepstation.Depth 0.01 m;set keepstation.Speed 0 m/s;set keepstation.MinOffshore 0.00001 km;set keepstation:NeedComms.GPSTimeout 2 min" szkr 1 2
2025-08-15T15:41:28.256Z,1755272488.256 [CommandExec](IMPORTANT): got command schedule asap "load Transport/keepstation.tl;set keepstation.NeedCommsTime 4 min;set keepstation.Depth 0.01 m;set keepstation.Speed 0 m/s;set keepstation.MinOffshore 0.00001 km;set keepstation:NeedComms.GPSTimeout 2 min" szkr 1 2.000000
2025-08-15T15:41:28.256Z,1755272488.256 [CommandExec](IMPORTANT): Scheduling command #1 of 2 with id=szkr
2025-08-15T15:41:28.258Z,1755272488.258 [CommandExec](IMPORTANT): Scheduled #1 (#1 of 2 with id='szkr'): "load Transport/keepstation.tl;set keepstation.NeedCommsTime 4 min;set keepstation.Depth 0.01 m;set keepstation.Speed 0 m/s;set keepstation.MinOffshore 0.00001 km;set keepstation:NeedComms.GPSTimeout 2 min", ASAP
2025-08-15T15:41:29.254Z,1755272489.254 [DataOverHttps](IMPORTANT): SBD MTMSN=20250815T154128
2025-08-15T15:41:36.731Z,1755272496.731 [DataOverHttps](INFO): Received command: sched asap "set keepstation:NeedComms.CommsTimeout 0.5 min;set keepstation:BackseatDriver.EnableBackseat 1 bool;run" szkr 2 2
2025-08-15T15:41:36.818Z,1755272496.818 [CommandExec](IMPORTANT): got command schedule asap "set keepstation:NeedComms.CommsTimeout 0.5 min;set keepstation:BackseatDriver.EnableBackseat 1 bool;run" szkr 2 2.000000
2025-08-15T15:41:36.819Z,1755272496.819 [CommandExec](IMPORTANT): Scheduling command #2 of 2 with id=szkr
2025-08-15T15:41:36.820Z,1755272496.820 [CommandExec](IMPORTANT): Scheduled #2 (#2 of 2 with id='szkr'): "set keepstation:NeedComms.CommsTimeout 0.5 min;set keepstation:BackseatDriver.EnableBackseat 1 bool;run", ASAP
2025-08-15T15:41:36.936Z,1755272496.936 [CommandExec](IMPORTANT): got command load ./Missions/Transport/keepstation.tl
2025-08-15T15:41:36.937Z,1755272496.937 [MissionManager](INFO): Loading Mission from file: ./Missions/Transport/keepstation.tl
2025-08-15T15:41:36.937Z,1755272496.937 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Transport/keepstation.tl
2025-08-15T15:41:36.940Z,1755272496.940 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Transport/keepstation.tl
2025-08-15T15:41:38.177Z,1755272498.177 [MissionManager](DEBUG): TethyslAPI: ./Missions/Transport/keepstation.tl translated into:
4
45
NaN
NaN
30
15
4
0.75
200
10
10
45
2
0
0
1
2
3
NaN
0
Sinking to
Timed out while trying to reach target sink depth at current depth of
2025-08-15T15:41:38.185Z,1755272498.185 [MissionManager](INFO): DefineArg keepstation.MissionTimeout = 4.000000 h
2025-08-15T15:41:38.190Z,1755272498.190 [MissionManager](INFO): DefineArg keepstation.NeedCommsTime = 45.000000 min
2025-08-15T15:41:38.193Z,1755272498.193 [MissionManager](INFO): DefineArg keepstation.Latitude = nan arcdeg
2025-08-15T15:41:38.196Z,1755272498.196 [MissionManager](INFO): DefineArg keepstation.Longitude = nan arcdeg
2025-08-15T15:41:38.199Z,1755272498.199 [MissionManager](INFO): DefineArg keepstation.Depth = 30.000000 m
2025-08-15T15:41:38.202Z,1755272498.202 [MissionManager](INFO): DefineArg keepstation.ApproachDepth = 15.000000 m
2025-08-15T15:41:38.205Z,1755272498.205 [MissionManager](INFO): DefineArg keepstation.DepthDeadband = 4.000000 m
2025-08-15T15:41:38.208Z,1755272498.208 [MissionManager](INFO): DefineArg keepstation.Speed = 0.750000 m/s
2025-08-15T15:41:38.235Z,1755272498.235 [MissionManager](INFO): DefineArg keepstation.Radius = 200.000000 m
2025-08-15T15:41:38.238Z,1755272498.238 [MissionManager](INFO): DefineArg keepstation.SinkOffSurface = 0 bool
2025-08-15T15:41:38.253Z,1755272498.253 [MissionManager](INFO): DefineArg keepstation.SinkDepth = 10.000000 m
2025-08-15T15:41:38.261Z,1755272498.261 [MissionManager](INFO): DefineArg keepstation.SinkDepthTimeout = 10.000000 min
2025-08-15T15:41:38.265Z,1755272498.265 [MissionManager](INFO): DefineArg keepstation.MaxDepth = 45.000000 m
2025-08-15T15:41:38.312Z,1755272498.312 [MissionManager](INFO): DefineArg keepstation.MinOffshore = 2.000000 km
2025-08-15T15:41:38.331Z,1755272498.331 [MissionManager](INFO): DefineOutput keepstation.DiveMode = 0.000000 count
2025-08-15T15:41:38.339Z,1755272498.339 [MissionManager](INFO): DefineOutput keepstation.DoingComms = 0.000000 count
2025-08-15T15:41:38.355Z,1755272498.355 [MissionManager](INFO): DefineOutput keepstation.SurfaceSink = 1.000000 count
2025-08-15T15:41:38.358Z,1755272498.358 [MissionManager](INFO): DefineOutput keepstation.TransitToStation = 2.000000 count
2025-08-15T15:41:38.389Z,1755272498.389 [MissionManager](INFO): DefineOutput keepstation.StationKeep = 3.000000 count
2025-08-15T15:41:38.392Z,1755272498.392 [MissionManager](INFO): DefineOutput keepstation.OnStation = 0 bool
2025-08-15T15:41:38.393Z,1755272498.393 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/NeedComms.tl
2025-08-15T15:41:38.393Z,1755272498.393 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/NeedComms.tl
2025-08-15T15:41:38.394Z,1755272498.394 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/NeedComms.tl
2025-08-15T15:41:38.908Z,1755272498.908 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/NeedComms.tl translated into:
1
10
20
NaN
1
1000
7
30
0
last time_fix was:
first GPS update timeout
Comms timed out after
minutes
second GPS update timeout
2025-08-15T15:41:38.914Z,1755272498.914 [MissionManager](INFO): DefineArg keepstation:NeedComms.DiveInterval = 1.000000 h
2025-08-15T15:41:38.917Z,1755272498.917 [MissionManager](INFO): DefineArg keepstation:NeedComms.WaitForPitchUp = 10.000000 min
2025-08-15T15:41:38.920Z,1755272498.920 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfacePitch = 20.000000 arcdeg
2025-08-15T15:41:38.923Z,1755272498.923 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfaceDepthRate = nan m/s
2025-08-15T15:41:38.926Z,1755272498.926 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfaceSpeed = 1.000000 m/s
2025-08-15T15:41:38.929Z,1755272498.929 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfacingTimeout = 1000.000000 s
2025-08-15T15:41:38.933Z,1755272498.933 [MissionManager](INFO): DefineArg keepstation:NeedComms.GPSTimeout = 7.000000 min
2025-08-15T15:41:38.936Z,1755272498.936 [MissionManager](INFO): DefineArg keepstation:NeedComms.CommsTimeout = 30.000000 min
2025-08-15T15:41:38.944Z,1755272498.944 [keepstation:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface.
2025-08-15T15:41:39.024Z,1755272499.024 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.tl
2025-08-15T15:41:39.024Z,1755272499.024 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/StandardEnvelopes.tl
2025-08-15T15:41:39.025Z,1755272499.025 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/StandardEnvelopes.tl
2025-08-15T15:41:39.247Z,1755272499.247 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/StandardEnvelopes.tl translated into:
5
1.5
200
2000
2025-08-15T15:41:39.252Z,1755272499.252 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MinAltitude = 5.000000 m
2025-08-15T15:41:39.263Z,1755272499.263 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MaxDepthIgnore = 1.500000 m
2025-08-15T15:41:39.270Z,1755272499.270 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MaxDepth = 200.000000 m
2025-08-15T15:41:39.274Z,1755272499.274 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MinOffshore = 2000.000000 m
2025-08-15T15:41:39.287Z,1755272499.287 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2025-08-15T15:41:39.305Z,1755272499.305 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2025-08-15T15:41:39.322Z,1755272499.322 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope.
2025-08-15T15:41:39.345Z,1755272499.345 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl
2025-08-15T15:41:39.346Z,1755272499.346 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl
2025-08-15T15:41:39.351Z,1755272499.351 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl
2025-08-15T15:41:39.403Z,1755272499.403 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into:
2025-08-15T15:41:39.419Z,1755272499.419 [MissionManager](INFO): DefineArg keepstation:BackseatDriver.EnableBackseat = 0 bool
2025-08-15T15:41:39.422Z,1755272499.422 [keepstation:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver.
2025-08-15T15:41:39.429Z,1755272499.429 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/PowerOnly.tl
2025-08-15T15:41:39.429Z,1755272499.429 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/PowerOnly.tl
2025-08-15T15:41:39.443Z,1755272499.443 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/PowerOnly.tl
2025-08-15T15:41:39.720Z,1755272499.720 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/PowerOnly.tl translated into:
99999
2025-08-15T15:41:39.729Z,1755272499.729 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleAll = 0 bool
2025-08-15T15:41:39.733Z,1755272499.733 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleLoad1 = 0 bool
2025-08-15T15:41:39.744Z,1755272499.744 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleLoad2 = 0 bool
2025-08-15T15:41:39.751Z,1755272499.751 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleLoad3 = 0 bool
2025-08-15T15:41:39.754Z,1755272499.754 [MissionManager](INFO): DefineArg keepstation:PowerOnly.EnabledPowerOnly = 1 bool
2025-08-15T15:41:39.784Z,1755272499.784 [keepstation:PowerOnly:E.Wait](DEBUG): Construct Wait.
2025-08-15T15:41:39.792Z,1755272499.792 [keepstation:H.Pitch](DEBUG): Construct.
2025-08-15T15:41:39.976Z,1755272499.976 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Construct Buoyancy.
2025-08-15T15:41:39.985Z,1755272499.985 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Construct.
2025-08-15T15:41:40.007Z,1755272500.007 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch](DEBUG): Construct.
2025-08-15T15:41:40.040Z,1755272500.040 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy](DEBUG): Construct Buoyancy.
2025-08-15T15:41:40.048Z,1755272500.048 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch](DEBUG): Construct.
2025-08-15T15:41:40.064Z,1755272500.064 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed](DEBUG): Construct.
2025-08-15T15:41:40.074Z,1755272500.074 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Construct.
2025-08-15T15:41:40.084Z,1755272500.084 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Construct KeepStation.
2025-08-15T15:41:40.106Z,1755272500.106 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Construct Waypoint.
2025-08-15T15:41:40.137Z,1755272500.137 [keepstation:KeepStation:B.Wait](DEBUG): Construct Wait.
2025-08-15T15:41:40.168Z,1755272500.168 [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 keepstation {
"""
Vehicle transits to desired waypoint (or stays put if none is commanded)
and stays within the specified radius.
"""
arguments {
MissionTimeout = 4 hour
"""
Maximum duration of mission
"""
NeedCommsTime = 45 minute
"""
How often to surface for communications
"""
Latitude = NaN degree
"""
Latitude of waypoint to hold. If NaN, hold the latitude at start of
mission.
"""
Longitude = NaN degree
"""
Longitude of waypoint to hold. If NaN, hold the longitude at start of
mission.
"""
Depth = 30 meter
"""
Depth held during drift mode
"""
ApproachDepth = 15 meter
"""
Depth for initial approach to station.
"""
DepthDeadband = 4 meter
"""
How much vertical drift from the specified depth is allowed in drift
mode
"""
Speed = 0.75 meter_per_second
"""
Vehicle transit speed.
"""
Radius = 200 meter
"""
Radius of circle around waypoint to hold.
"""
SinkOffSurface = false
"""
If true, use buoyancy only to decend to SinkDepth before driving to first target depth
"""
SinkDepth = 10 meter
"""
Initial depth to decend using only buoyancy before driving
"""
SinkDepthTimeout = 10 minute
"""
Max wait time for the vehicle to reach the target depth
"""
MaxDepth = 45 meter
"""
Maximum allowable depth during the mission.
"""
MinOffshore = 2 kilometer
"""
Minimum distance from the shoreline to maintain
"""
}
output {
DiveMode = 0 count
"""
Mission variable (don't change). The mission sets this variable to
switch between dive modes. Initialized to DoingComms.
"""
DoingComms = 0 count
"""
Mission variable (don't change). The mission will run in this mode
when doing surface comms.
"""
SurfaceSink = 1 count
"""
Mission variable (don't change). The mission will run in this mode
when sinking from the surface using only buoyancy.
"""
TransitToStation = 2 count
"""
Mission variable (don't change). The mission will run in this mode
when performing the transit to station
"""
StationKeep = 3 count
"""
Mission variable (don't change). The mission will run in this mode
when keeping station
"""
OnStation = false
"""
Mission variable (don't change). Determines last mode (Transit or StationKeep)
to resume after needcomms
"""
}
timeout duration=MissionTimeout
insert id="NeedComms" Insert/NeedComms.tl
assign in sequence NeedComms:DiveInterval = NeedCommsTime
insert Insert/StandardEnvelopes.tl
assign in sequence StandardEnvelopes:MaxDepth = MaxDepth
assign in sequence StandardEnvelopes:MinOffshore = MinOffshore
insert Insert/BackseatDriver.tl
insert Insert/PowerOnly.tl
behavior Guidance:Pitch {
run in parallel
set massPosition = Control:VerticalControl.massDefault
}
aggregate SurfaceComms {
run when (
called
or ( elapsed ( Universal:time_fix ) > NeedCommsTime )
)
assign in sequence DiveMode = DoingComms
call priorityHere=false refId="NeedComms"
aggregate setTransit {
run in sequence
break if (
SinkOffSurface
or OnStation
)
assign in sequence DiveMode = TransitToStation
}
aggregate setStation {
run in sequence
break if (
SinkOffSurface
or not OnStation
)
assign in sequence DiveMode = StationKeep
}
aggregate setSink {
run in sequence
break if ( not SinkOffSurface )
assign in sequence DiveMode = SurfaceSink
}
}
call id="StartingMission" priorityHere=false refId="SurfaceComms"
aggregate DiveCmd {
run when ( called )
aggregate SurfaceSink {
run while ( DiveMode == SurfaceSink )
aggregate sink {
run in sequence
behavior Guidance:Buoyancy id="BuoyancyHold" {
run in parallel
set position = NaN cc
}
behavior Guidance:SetSpeed {
run in parallel
set speed = 0 m/s
}
syslog info "Sinking to " + SinkDepth~meter
behavior Guidance:Pitch {
run in sequence
timeout duration=SinkDepthTimeout {
syslog important "Timed out while trying to reach target sink depth at current depth of "
+ Universal:depth~meter
}
set depth = SinkDepth
}
# Once we've sunk, either resume transit or station keeping depths and speeds
aggregate sinkToTransit {
run in sequence
break if ( OnStation )
assign in sequence DiveMode = TransitToStation
}
aggregate sinkToStation {
run in sequence
break if ( not OnStation )
assign in sequence DiveMode = StationKeep
}
}
}
aggregate TransitToStation {
run while ( DiveMode == TransitToStation )
aggregate dive {
run in sequence
behavior Guidance:Buoyancy {
run in parallel
set position = Control:VerticalControl.buoyancyNeutral
}
behavior Guidance:Pitch {
run in parallel
set depth = ApproachDepth
}
behavior Guidance:SetSpeed {
run in parallel
set speed = Speed
}
}
}
aggregate StationKeep {
run while ( DiveMode == StationKeep )
assign in parallel Control:VerticalControl.depthDeadband = DepthDeadband
behavior Guidance:Pitch {
run in parallel
set depth = Depth
}
behavior Guidance:KeepStation {
run in parallel
set latitude = Latitude
set longitude = Longitude
set radius = Radius
set speed = Speed
}
}
}
aggregate TransitToStation {
"""
Need a separate aggregate for transit if we want to specify a
different depth for the approach.
"""
run in sequence
aggregate Dive {
run while ( not ( DiveMode == DoingComms ) )
call priorityHere=false refId="DiveCmd"
}
behavior Guidance:Waypoint id="Wpt1" {
run in sequence
set latitude = Latitude
set longitude = Longitude
}
assign in sequence DiveMode = StationKeep
assign in sequence OnStation = true
}
call id="OnStation" priorityHere=false refId="NeedComms"
aggregate KeepStation {
run in sequence
aggregate Dive {
run while ( not ( DiveMode == DoingComms ) )
call priorityHere=false refId="DiveCmd"
}
behavior Guidance:Wait {
"""
Due to the way the KeepStation behavior is currently
implemented, we must run it in parallel and use a Wait to keep
from completing the mission before the timeout expires. However,
this new version of the mission uses a top-level timeout so that
the entire mission will not run for longer then MissionTimeout.
"""
run in sequence
set duration = MissionTimeout
}
}
}
2025-08-15T15:41:40.169Z,1755272500.169 [CommandExec](IMPORTANT): Loaded ./Missions/Transport/keepstation.tl id=keepstation
2025-08-15T15:41:51.270Z,1755272511.270 [CBIT](INFO): Clearing failed state for component RudderServo
2025-08-15T15:41:51.270Z,1755272511.270 [RudderServo] No Fault, FailCount= 3
2025-08-15T15:41:55.646Z,1755272515.646 [CommandExec](IMPORTANT): got command set keepstation.NeedCommsTime 4 minute
2025-08-15T15:41:55.647Z,1755272515.647 [CommandExec](IMPORTANT): got command set keepstation.Depth 0.01 meter
2025-08-15T15:41:55.648Z,1755272515.648 [CommandExec](IMPORTANT): got command set keepstation.Speed 0 meter_per_second
2025-08-15T15:41:55.649Z,1755272515.649 [CommandExec](IMPORTANT): got command set keepstation.MinOffshore 0.00001 kilometer
2025-08-15T15:41:55.649Z,1755272515.649 [CommandExec](IMPORTANT): got command set keepstation:NeedComms.GPSTimeout 2 minute
2025-08-15T15:41:55.915Z,1755272515.915 [RudderServo](FAULT): Overload Error
2025-08-15T15:41:55.915Z,1755272515.915 [RudderServo] Hardware Fault, FailCount= 1
2025-08-15T15:41:55.915Z,1755272515.915 [RudderServo](ERROR): Hardware Fault
2025-08-15T15:41:56.019Z,1755272516.019 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-08-15T15:41:56.144Z,1755272516.144 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-08-15T15:41:56.144Z,1755272516.144 [RudderServo](INFO): Powering down
2025-08-15T15:41:56.928Z,1755272516.928 [RudderServo](DEBUG): Initializing EZServoServo.
2025-08-15T15:41:57.047Z,1755272517.047 [RudderServo](DEBUG): Initializing RudderServo.
2025-08-15T15:41:57.054Z,1755272517.054 [CBIT](INFO): Clearing failed state for component RudderServo
2025-08-15T15:41:57.054Z,1755272517.054 [RudderServo] No Fault, FailCount= 1
2025-08-15T15:42:02.212Z,1755272522.212 [RudderServo](FAULT): Overload Error
2025-08-15T15:42:02.212Z,1755272522.212 [RudderServo] Hardware Fault, FailCount= 2
2025-08-15T15:42:02.212Z,1755272522.212 [RudderServo](ERROR): Hardware Fault
2025-08-15T15:42:02.323Z,1755272522.323 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-08-15T15:42:02.563Z,1755272522.563 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-08-15T15:42:02.563Z,1755272522.563 [RudderServo](INFO): Powering down
2025-08-15T15:42:03.396Z,1755272523.396 [RudderServo](DEBUG): Initializing EZServoServo.
2025-08-15T15:42:03.515Z,1755272523.515 [RudderServo](DEBUG): Initializing RudderServo.
2025-08-15T15:42:03.520Z,1755272523.520 [CBIT](INFO): Clearing failed state for component RudderServo
2025-08-15T15:42:03.520Z,1755272523.520 [RudderServo] No Fault, FailCount= 2
2025-08-15T15:42:08.691Z,1755272528.691 [RudderServo](FAULT): Overload Error
2025-08-15T15:42:08.691Z,1755272528.691 [RudderServo] Hardware Fault, FailCount= 3
2025-08-15T15:42:08.691Z,1755272528.691 [RudderServo](ERROR): Hardware Fault
2025-08-15T15:42:08.795Z,1755272528.795 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-08-15T15:42:08.796Z,1755272528.796 [CBIT](CRITICAL): Hardware Fault in component: RudderServo
2025-08-15T15:42:09.140Z,1755272529.140 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-08-15T15:42:09.140Z,1755272529.140 [RudderServo](INFO): Powering down
2025-08-15T15:42:09.175Z,1755272529.175 [CBIT](INFO): Critical error at 20250815T154208
2025-08-15T15:42:09.175Z,1755272529.175 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2025-08-15T15:42:09.859Z,1755272529.859 [RudderServo](DEBUG): Initializing EZServoServo.
2025-08-15T15:42:09.906Z,1755272529.906 [CommandExec](IMPORTANT): got command set keepstation:NeedComms.CommsTimeout 0.5 minute
2025-08-15T15:42:09.911Z,1755272529.911 [CommandExec](IMPORTANT): got command set keepstation:BackseatDriver.EnableBackseat 1 bool
2025-08-15T15:42:09.911Z,1755272529.911 [CommandExec](IMPORTANT): got command run
2025-08-15T15:42:09.913Z,1755272529.913 [CommandExec](IMPORTANT): Running
2025-08-15T15:42:09.979Z,1755272529.979 [RudderServo](DEBUG): Initializing RudderServo.
2025-08-15T15:42:10.238Z,1755272530.238 [Default] Stopped
2025-08-15T15:42:10.238Z,1755272530.238 [Default](DEBUG): Aggregate::uninitialize Default
2025-08-15T15:42:10.238Z,1755272530.238 [Default:B.GoToSurface] Stopped
2025-08-15T15:42:10.238Z,1755272530.238 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-08-15T15:42:10.238Z,1755272530.238 [Default:CheckIn] Stopped
2025-08-15T15:42:10.238Z,1755272530.238 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-08-15T15:42:10.238Z,1755272530.238 [Default:CheckIn:C.Wait] Stopped
2025-08-15T15:42:10.239Z,1755272530.239 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-08-15T15:42:10.239Z,1755272530.239 [MissionManager](IMPORTANT): Started mission keepstation
2025-08-15T15:42:10.239Z,1755272530.239 [keepstation] Running Loop=1
2025-08-15T15:42:10.239Z,1755272530.239 [keepstation](DEBUG): Aggregate::initialize keepstation
2025-08-15T15:42:10.239Z,1755272530.239 [keepstation:StandardEnvelopes] Running Loop=1
2025-08-15T15:42:10.239Z,1755272530.239 [keepstation:StandardEnvelopes](DEBUG): Aggregate::initialize keepstation:StandardEnvelopes
2025-08-15T15:42:10.239Z,1755272530.239 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2025-08-15T15:42:10.239Z,1755272530.239 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2025-08-15T15:42:10.240Z,1755272530.240 [keepstation:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2025-08-15T15:42:10.240Z,1755272530.240 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2025-08-15T15:42:10.240Z,1755272530.240 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2025-08-15T15:42:10.240Z,1755272530.240 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent.
2025-08-15T15:42:10.240Z,1755272530.240 [keepstation:BackseatDriver] Running Loop=1
2025-08-15T15:42:10.240Z,1755272530.240 [keepstation:BackseatDriver](DEBUG): Aggregate::initialize keepstation:BackseatDriver
2025-08-15T15:42:10.240Z,1755272530.240 [keepstation:BackseatDriver:A.BackseatDriver] Running Loop=1
2025-08-15T15:42:10.241Z,1755272530.241 [keepstation:PowerOnly] Running Loop=1
2025-08-15T15:42:10.241Z,1755272530.241 [keepstation:PowerOnly](DEBUG): Aggregate::initialize keepstation:PowerOnly
2025-08-15T15:42:10.241Z,1755272530.241 [keepstation:PowerOnly:A] Running Loop=1
2025-08-15T15:42:10.241Z,1755272530.241 [keepstation:PowerOnly:B] Running Loop=1
2025-08-15T15:42:10.241Z,1755272530.241 [keepstation:PowerOnly:C] Running Loop=1
2025-08-15T15:42:10.241Z,1755272530.241 [keepstation:PowerOnly:D] Running Loop=1
2025-08-15T15:42:10.241Z,1755272530.241 [keepstation:PowerOnly:E.Wait] Running Loop=1
2025-08-15T15:42:10.241Z,1755272530.241 [keepstation:PowerOnly:E.Wait](DEBUG): Initialize Wait Component.
2025-08-15T15:42:10.241Z,1755272530.241 [keepstation:H.Pitch] Running Loop=1
2025-08-15T15:42:10.241Z,1755272530.241 [keepstation:H.Pitch](DEBUG): Initialize.
2025-08-15T15:42:10.242Z,1755272530.242 [keepstation:B] Running Loop=1
2025-08-15T15:42:10.243Z,1755272530.243 [keepstation:H.Pitch] Running Loop=1
2025-08-15T15:42:10.243Z,1755272530.243 [keepstation:PowerOnly] Running Loop=1
2025-08-15T15:42:10.244Z,1755272530.244 [keepstation:PowerOnly:D] Stopped
2025-08-15T15:42:10.244Z,1755272530.244 [keepstation:PowerOnly:C] Stopped
2025-08-15T15:42:10.244Z,1755272530.244 [keepstation:PowerOnly:B] Stopped
2025-08-15T15:42:10.244Z,1755272530.244 [keepstation:PowerOnly:A] Stopped
2025-08-15T15:42:10.244Z,1755272530.244 [keepstation:BackseatDriver] Running Loop=1
2025-08-15T15:42:10.244Z,1755272530.244 [keepstation:BackseatDriver:A.BackseatDriver](INFO): Initializing backseat
2025-08-15T15:42:10.355Z,1755272530.355 [keepstation:StandardEnvelopes] Running Loop=1
2025-08-15T15:42:10.355Z,1755272530.355 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2025-08-15T15:42:10.356Z,1755272530.356 [keepstation:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2025-08-15T15:42:10.356Z,1755272530.356 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2025-08-15T15:42:10.357Z,1755272530.357 [keepstation:B] Stopped
2025-08-15T15:42:10.357Z,1755272530.357 [keepstation:D] Running Loop=1
2025-08-15T15:42:10.357Z,1755272530.357 [MissionManager](INFO): MissionManager is completed.
2025-08-15T15:42:10.357Z,1755272530.357 [MissionManager](INFO): Uninitializing Mission keepstation
2025-08-15T15:42:10.357Z,1755272530.357 [keepstation] Stopped
2025-08-15T15:42:10.357Z,1755272530.357 [keepstation](DEBUG): Aggregate::uninitialize keepstation
2025-08-15T15:42:10.358Z,1755272530.358 [keepstation:StandardEnvelopes] Stopped
2025-08-15T15:42:10.358Z,1755272530.358 [keepstation:StandardEnvelopes](DEBUG): Aggregate::uninitialize keepstation:StandardEnvelopes
2025-08-15T15:42:10.358Z,1755272530.358 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Stopped
2025-08-15T15:42:10.358Z,1755272530.358 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2025-08-15T15:42:10.358Z,1755272530.358 [keepstation:StandardEnvelopes:B.DepthEnvelope] Stopped
2025-08-15T15:42:10.358Z,1755272530.358 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize.
2025-08-15T15:42:10.358Z,1755272530.358 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Stopped
2025-08-15T15:42:10.358Z,1755272530.358 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent.
2025-08-15T15:42:10.358Z,1755272530.358 [keepstation:D] Stopped
2025-08-15T15:42:10.360Z,1755272530.360 [keepstation:BackseatDriver] Stopped
2025-08-15T15:42:10.360Z,1755272530.360 [keepstation:BackseatDriver](DEBUG): Aggregate::uninitialize keepstation:BackseatDriver
2025-08-15T15:42:10.360Z,1755272530.360 [keepstation:BackseatDriver:A.BackseatDriver] Stopped
2025-08-15T15:42:10.361Z,1755272530.361 [keepstation:PowerOnly] Stopped
2025-08-15T15:42:10.361Z,1755272530.361 [keepstation:PowerOnly](DEBUG): Aggregate::uninitialize keepstation:PowerOnly
2025-08-15T15:42:10.361Z,1755272530.361 [keepstation:PowerOnly:E.Wait] Stopped
2025-08-15T15:42:10.361Z,1755272530.361 [keepstation:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component.
2025-08-15T15:42:10.361Z,1755272530.361 [keepstation:H.Pitch] Stopped
2025-08-15T15:42:10.641Z,1755272530.641 [MissionManager](IMPORTANT): Started mission Default
2025-08-15T15:42:10.641Z,1755272530.641 [Default] Running Loop=1
2025-08-15T15:42:10.641Z,1755272530.641 [Default](DEBUG): Aggregate::initialize Default
2025-08-15T15:42:10.641Z,1755272530.641 [Default:B.GoToSurface] Running Loop=1
2025-08-15T15:42:10.641Z,1755272530.641 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-08-15T15:42:10.642Z,1755272530.642 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-08-15T15:42:10.642Z,1755272530.642 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-08-15T15:42:10.643Z,1755272530.643 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-08-15T15:42:10.643Z,1755272530.643 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-08-15T15:42:10.643Z,1755272530.643 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-08-15T15:42:10.644Z,1755272530.644 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-08-15T15:42:10.644Z,1755272530.644 [Default:A.Wait] Running Loop=1
2025-08-15T15:42:10.644Z,1755272530.644 [Default:A.Wait](DEBUG): Initialize Wait Component.
2025-08-15T15:42:12.040Z,1755272532.040 [DataOverHttps](IMPORTANT): SBD MTMSN=20250815T154211
2025-08-15T15:42:20.415Z,1755272540.415 [DataOverHttps](INFO): Received command: sched 20250815T1555 "set keepstation:backseatdriver.enablebackseat 0 bool"
2025-08-15T15:42:20.471Z,1755272540.471 [CommandExec](IMPORTANT): got command schedule 20250815T155500 "set keepstation:backseatdriver.enablebackseat 0 bool"
2025-08-15T15:42:20.471Z,1755272540.471 [CommandExec](IMPORTANT): Scheduled #3: "set keepstation:backseatdriver.enablebackseat 0 bool", AT TIME: 2025-08-15T15:55:00Z
2025-08-15T15:42:20.472Z,1755272540.472 [CommandExec](FAULT): Scheduling was paused by an error at 2025-08-15T15:42:08Z
2025-08-15T15:42:23.984Z,1755272543.984 [Default:A.Wait](INFO): Done Waiting.
2025-08-15T15:42:23.985Z,1755272543.985 [Default:A.Wait] Stopped
2025-08-15T15:42:23.985Z,1755272543.985 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2025-08-15T15:42:24.405Z,1755272544.405 [Default:CheckIn] Running Loop=1
2025-08-15T15:42:24.405Z,1755272544.405 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-08-15T15:42:24.405Z,1755272544.405 [Default:CheckIn:Read_GPS] Running Loop=1
2025-08-15T15:42:51.172Z,1755272571.172 [DataOverHttps](IMPORTANT): SBD MTMSN=20250815T154250
2025-08-15T15:42:58.738Z,1755272578.738 [DataOverHttps](INFO): Received command: sched 20250815T1605 "set keepstation:backseatdriver.enablebackseat 1 bool"
2025-08-15T15:42:58.774Z,1755272578.774 [CommandExec](IMPORTANT): got command schedule 20250815T160500 "set keepstation:backseatdriver.enablebackseat 1 bool"
2025-08-15T15:42:58.775Z,1755272578.775 [CommandExec](IMPORTANT): Scheduled #4: "set keepstation:backseatdriver.enablebackseat 1 bool", AT TIME: 2025-08-15T16:05:00Z
2025-08-15T15:42:58.775Z,1755272578.775 [CommandExec](FAULT): Scheduling was paused by an error at 2025-08-15T15:42:08Z
2025-08-15T15:43:30.428Z,1755272610.428 [DataOverHttps](IMPORTANT): SBD MTMSN=20250815T154329
2025-08-15T15:43:37.974Z,1755272617.974 [DataOverHttps](INFO): Received command: sched 20250815T1615 "restart sys"
2025-08-15T15:43:38.058Z,1755272618.058 [CommandExec](IMPORTANT): got command schedule 20250815T161500 "restart sys"
2025-08-15T15:43:38.059Z,1755272618.059 [CommandExec](IMPORTANT): Scheduled #5: "restart sys", AT TIME: 2025-08-15T16:15:00Z
2025-08-15T15:43:38.059Z,1755272618.059 [CommandExec](FAULT): Scheduling was paused by an error at 2025-08-15T15:42:08Z
2025-08-15T15:43:38.977Z,1755272618.977 [DataOverHttps](IMPORTANT): SBD MTMSN=20250815T154338
2025-08-15T15:43:46.462Z,1755272626.462 [DataOverHttps](INFO): Received command: schedule resume
2025-08-15T15:43:46.528Z,1755272626.528 [CommandExec](IMPORTANT): got command schedule resume
2025-08-15T15:43:46.529Z,1755272626.529 [CommandExec](IMPORTANT): Scheduling is resumed
2025-08-15T15:44:13.931Z,1755272653.931 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-08-15T15:44:13.931Z,1755272653.931 [ElevatorServo] No Fault, FailCount= 3
2025-08-15T15:44:18.379Z,1755272658.379 [ElevatorServo](FAULT): Overload Error
2025-08-15T15:44:18.379Z,1755272658.379 [ElevatorServo] Hardware Fault, FailCount= 1
2025-08-15T15:44:18.379Z,1755272658.379 [ElevatorServo](ERROR): Hardware Fault
2025-08-15T15:44:18.492Z,1755272658.492 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-08-15T15:44:18.771Z,1755272658.771 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-08-15T15:44:18.771Z,1755272658.771 [ElevatorServo](INFO): Powering down
2025-08-15T15:44:19.525Z,1755272659.525 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-08-15T15:44:19.642Z,1755272659.642 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-08-15T15:44:19.647Z,1755272659.647 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-08-15T15:44:19.647Z,1755272659.647 [ElevatorServo] No Fault, FailCount= 1
2025-08-15T15:44:24.803Z,1755272664.803 [ElevatorServo](FAULT): Overload Error
2025-08-15T15:44:24.803Z,1755272664.803 [ElevatorServo] Hardware Fault, FailCount= 2
2025-08-15T15:44:24.803Z,1755272664.803 [ElevatorServo](ERROR): Hardware Fault
2025-08-15T15:44:24.907Z,1755272664.907 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-08-15T15:44:25.179Z,1755272665.179 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-08-15T15:44:25.179Z,1755272665.179 [ElevatorServo](INFO): Powering down
2025-08-15T15:44:26.001Z,1755272666.001 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-08-15T15:44:26.119Z,1755272666.119 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-08-15T15:44:26.124Z,1755272666.124 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-08-15T15:44:26.124Z,1755272666.124 [ElevatorServo] No Fault, FailCount= 2
2025-08-15T15:44:31.271Z,1755272671.271 [ElevatorServo](FAULT): Overload Error
2025-08-15T15:44:31.271Z,1755272671.271 [ElevatorServo] Hardware Fault, FailCount= 3
2025-08-15T15:44:31.271Z,1755272671.271 [ElevatorServo](ERROR): Hardware Fault
2025-08-15T15:44:31.387Z,1755272671.387 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-08-15T15:44:31.387Z,1755272671.387 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo
2025-08-15T15:44:31.643Z,1755272671.643 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-08-15T15:44:31.643Z,1755272671.643 [ElevatorServo](INFO): Powering down
2025-08-15T15:44:31.646Z,1755272671.646 [CommandExec](FAULT): Scheduling is paused for 3 commands
2025-08-15T15:44:31.646Z,1755272671.646 [CBIT](INFO): Critical error at 20250815T154431
2025-08-15T15:44:32.449Z,1755272672.449 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-08-15T15:44:32.569Z,1755272672.569 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-08-15T15:47:24.553Z,1755272844.553 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-08-15T15:42:24.4Z
2025-08-15T15:47:24.553Z,1755272844.553 [Default:CheckIn:Read_GPS] Stopped
2025-08-15T15:47:24.553Z,1755272844.553 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-08-15T15:47:28.584Z,1755272848.584 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-08-15T15:47:32.435Z,1755272852.435 [DataOverHttps](INFO): Sending 220 bytes from file Logs/20250815T152619/Courier0007.lzma
2025-08-15T15:47:33.436Z,1755272853.436 [DataOverHttps](INFO): Moved sent file to Logs/20250815T152619/Courier0007.lzma.bak
2025-08-15T15:47:33.437Z,1755272853.437 [DataOverHttps](INFO): SBD MOMSN=25852137
2025-08-15T15:47:52.329Z,1755272872.329 [DataOverHttps](INFO): Sending 1135 bytes from file Logs/20250815T152619/Express0008.lzma
2025-08-15T15:47:53.328Z,1755272873.328 [DataOverHttps](INFO): Moved sent file to Logs/20250815T152619/Express0008.lzma.bak
2025-08-15T15:47:53.329Z,1755272873.329 [DataOverHttps](INFO): SBD MOMSN=25852141
2025-08-15T15:47:59.292Z,1755272879.292 [NAL9602](INFO): Not Powering down - fast GPS
2025-08-15T15:48:08.646Z,1755272888.646 [DataOverHttps](INFO): Sending 62 bytes from file Logs/20250815T152619/Express0011.lzma
2025-08-15T15:48:09.648Z,1755272889.648 [DataOverHttps](INFO): Moved sent file to Logs/20250815T152619/Express0011.lzma.bak
2025-08-15T15:48:09.649Z,1755272889.649 [DataOverHttps](INFO): SBD MOMSN=25852190
2025-08-15T15:48:12.246Z,1755272892.246 [Default:CheckIn:Read_Iridium] Stopped
2025-08-15T15:48:12.246Z,1755272892.246 [Default:CheckIn:C.Wait] Running Loop=1
2025-08-15T15:48:12.246Z,1755272892.246 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-08-15T15:53:12.869Z,1755273192.869 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-08-15T15:53:12.869Z,1755273192.869 [Default:CheckIn:C.Wait] Stopped
2025-08-15T15:53:12.869Z,1755273192.869 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-08-15T15:53:12.870Z,1755273192.870 [Default:CheckIn:D] Running Loop=1
2025-08-15T15:53:13.282Z,1755273193.282 [Default:CheckIn:D] Stopped
2025-08-15T15:53:13.282Z,1755273193.282 [Default:CheckIn:E] Running Loop=1
2025-08-15T15:53:13.682Z,1755273193.682 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 11.044009 min
2025-08-15T15:53:13.683Z,1755273193.683 [Default:CheckIn:E] Stopped
2025-08-15T15:53:13.683Z,1755273193.683 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-08-15T15:53:13.683Z,1755273193.683 [Default:CheckIn] Stopped
2025-08-15T15:53:13.683Z,1755273193.683 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-08-15T15:53:13.683Z,1755273193.683 [Default:CheckIn](INFO): Running loop #2
2025-08-15T15:53:13.683Z,1755273193.683 [Default:CheckIn] Running Loop=2
2025-08-15T15:53:13.683Z,1755273193.683 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-08-15T15:53:13.683Z,1755273193.683 [Default:CheckIn:Read_GPS] Running Loop=1
2025-08-15T15:53:15.286Z,1755273195.286 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-08-15T15:53:15.287Z,1755273195.287 [NAL9602] Data Fault, FailCount= 2
2025-08-15T15:53:15.287Z,1755273195.287 [NAL9602](ERROR): Data Fault
2025-08-15T15:53:15.306Z,1755273195.306 [CBIT](ERROR): Data Fault in component: NAL9602
2025-08-15T15:53:15.691Z,1755273195.691 [NAL9602](INFO): Powering down
2025-08-15T15:53:16.521Z,1755273196.521 [CBIT](INFO): Clearing failed state for component NAL9602
2025-08-15T15:53:16.521Z,1755273196.521 [NAL9602] No Fault, FailCount= 2
2025-08-15T15:53:45.991Z,1755273225.991 [NAL9602](INFO): Powering up NAL9602
2025-08-15T15:53:56.900Z,1755273236.900 [NAL9602](INFO): NAL9602 initialized
2025-08-15T15:55:00.055Z,1755273300.055 [CommandExec](FAULT): Schedule is paused. Ignoring time-scheduled command: set keepstation:backseatdriver.enablebackseat 0 bool
2025-08-15T15:57:08.871Z,1755273428.871 [CBIT](INFO): Clearing failed state for component RudderServo
2025-08-15T15:57:08.871Z,1755273428.871 [RudderServo] No Fault, FailCount= 3
2025-08-15T15:57:13.295Z,1755273433.295 [RudderServo](FAULT): Overload Error
2025-08-15T15:57:13.295Z,1755273433.295 [RudderServo] Hardware Fault, FailCount= 1
2025-08-15T15:57:13.295Z,1755273433.295 [RudderServo](ERROR): Hardware Fault
2025-08-15T15:57:13.412Z,1755273433.412 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-08-15T15:57:13.687Z,1755273433.687 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-08-15T15:57:13.687Z,1755273433.687 [RudderServo](INFO): Powering down
2025-08-15T15:57:14.499Z,1755273434.499 [RudderServo](DEBUG): Initializing EZServoServo.
2025-08-15T15:57:14.619Z,1755273434.619 [RudderServo](DEBUG): Initializing RudderServo.
2025-08-15T15:57:14.624Z,1755273434.624 [CBIT](INFO): Clearing failed state for component RudderServo
2025-08-15T15:57:14.624Z,1755273434.624 [RudderServo] No Fault, FailCount= 1
2025-08-15T15:57:19.787Z,1755273439.787 [RudderServo](FAULT): Overload Error
2025-08-15T15:57:19.787Z,1755273439.787 [RudderServo] Hardware Fault, FailCount= 2
2025-08-15T15:57:19.787Z,1755273439.787 [RudderServo](ERROR): Hardware Fault
2025-08-15T15:57:19.895Z,1755273439.895 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-08-15T15:57:20.152Z,1755273440.152 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-08-15T15:57:20.152Z,1755273440.152 [RudderServo](INFO): Powering down
2025-08-15T15:57:20.931Z,1755273440.931 [RudderServo](DEBUG): Initializing EZServoServo.
2025-08-15T15:57:21.048Z,1755273441.048 [RudderServo](DEBUG): Initializing RudderServo.
2025-08-15T15:57:21.052Z,1755273441.052 [CBIT](INFO): Clearing failed state for component RudderServo
2025-08-15T15:57:21.052Z,1755273441.052 [RudderServo] No Fault, FailCount= 2
2025-08-15T15:57:26.215Z,1755273446.215 [RudderServo](FAULT): Overload Error
2025-08-15T15:57:26.215Z,1755273446.215 [RudderServo] Hardware Fault, FailCount= 3
2025-08-15T15:57:26.215Z,1755273446.215 [RudderServo](ERROR): Hardware Fault
2025-08-15T15:57:26.323Z,1755273446.323 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-08-15T15:57:26.323Z,1755273446.323 [CBIT](CRITICAL): Hardware Fault in component: RudderServo
2025-08-15T15:57:26.601Z,1755273446.601 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-08-15T15:57:26.602Z,1755273446.602 [RudderServo](INFO): Powering down
2025-08-15T15:57:26.604Z,1755273446.604 [CBIT](INFO): Critical error at 20250815T155726
2025-08-15T15:57:27.406Z,1755273447.406 [RudderServo](DEBUG): Initializing EZServoServo.
2025-08-15T15:57:27.519Z,1755273447.519 [RudderServo](DEBUG): Initializing RudderServo.
2025-08-15T15:58:13.854Z,1755273493.854 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-08-15T15:53:13.7Z
2025-08-15T15:58:13.854Z,1755273493.854 [Default:CheckIn:Read_GPS] Stopped
2025-08-15T15:58:13.855Z,1755273493.855 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-08-15T15:58:21.006Z,1755273501.006 [DataOverHttps](INFO): Sending 88 bytes from file Logs/20250815T152619/Courier0013.lzma
2025-08-15T15:58:22.008Z,1755273502.008 [DataOverHttps](INFO): Moved sent file to Logs/20250815T152619/Courier0013.lzma.bak
2025-08-15T15:58:22.008Z,1755273502.008 [DataOverHttps](INFO): SBD MOMSN=25852192
2025-08-15T15:58:39.603Z,1755273519.603 [DataOverHttps](INFO): Sending 367 bytes from file Logs/20250815T152619/Express0014.lzma
2025-08-15T15:58:40.604Z,1755273520.604 [DataOverHttps](INFO): Moved sent file to Logs/20250815T152619/Express0014.lzma.bak
2025-08-15T15:58:40.605Z,1755273520.605 [DataOverHttps](INFO): SBD MOMSN=25852195
2025-08-15T15:58:42.970Z,1755273522.970 [Default:CheckIn:Read_Iridium] Stopped
2025-08-15T15:58:42.970Z,1755273522.970 [Default:CheckIn:C.Wait] Running Loop=1
2025-08-15T15:58:42.970Z,1755273522.970 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-08-15T15:59:00.312Z,1755273540.312 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-08-15T15:59:31.012Z,1755273571.012 [NAL9602](INFO): Not Powering down - fast GPS
2025-08-15T15:59:31.431Z,1755273571.431 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-08-15T15:59:31.431Z,1755273571.431 [ElevatorServo] No Fault, FailCount= 3
2025-08-15T15:59:35.895Z,1755273575.895 [ElevatorServo](FAULT): Overload Error
2025-08-15T15:59:35.895Z,1755273575.895 [ElevatorServo] Hardware Fault, FailCount= 1
2025-08-15T15:59:35.895Z,1755273575.895 [ElevatorServo](ERROR): Hardware Fault
2025-08-15T15:59:36.003Z,1755273576.003 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-08-15T15:59:36.270Z,1755273576.270 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-08-15T15:59:36.271Z,1755273576.271 [ElevatorServo](INFO): Powering down
2025-08-15T15:59:37.107Z,1755273577.107 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-08-15T15:59:37.227Z,1755273577.227 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-08-15T15:59:37.232Z,1755273577.232 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-08-15T15:59:37.232Z,1755273577.232 [ElevatorServo] No Fault, FailCount= 1
2025-08-15T15:59:42.391Z,1755273582.391 [ElevatorServo](FAULT): Overload Error
2025-08-15T15:59:42.391Z,1755273582.391 [ElevatorServo] Hardware Fault, FailCount= 2
2025-08-15T15:59:42.391Z,1755273582.391 [ElevatorServo](ERROR): Hardware Fault
2025-08-15T15:59:42.499Z,1755273582.499 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-08-15T15:59:42.739Z,1755273582.739 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-08-15T15:59:42.739Z,1755273582.739 [ElevatorServo](INFO): Powering down
2025-08-15T15:59:43.550Z,1755273583.550 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-08-15T15:59:43.663Z,1755273583.663 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-08-15T15:59:43.668Z,1755273583.668 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-08-15T15:59:43.668Z,1755273583.668 [ElevatorServo] No Fault, FailCount= 2
2025-08-15T15:59:48.839Z,1755273588.839 [ElevatorServo](FAULT): Overload Error
2025-08-15T15:59:48.839Z,1755273588.839 [ElevatorServo] Hardware Fault, FailCount= 3
2025-08-15T15:59:48.839Z,1755273588.839 [ElevatorServo](ERROR): Hardware Fault
2025-08-15T15:59:48.952Z,1755273588.952 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-08-15T15:59:48.952Z,1755273588.952 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo
2025-08-15T15:59:49.197Z,1755273589.197 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-08-15T15:59:49.197Z,1755273589.197 [ElevatorServo](INFO): Powering down
2025-08-15T15:59:49.200Z,1755273589.200 [CBIT](INFO): Critical error at 20250815T155948
2025-08-15T15:59:50.012Z,1755273590.012 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-08-15T15:59:50.132Z,1755273590.132 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-08-15T16:00:33.874Z,1755273633.874 [CommandExec](IMPORTANT): got command configSet RudderServo.loadAtStartup 0 bool persist
2025-08-15T16:00:33.875Z,1755273633.875 [CommandExec](IMPORTANT): configSet RudderServo.loadAtStartup requires a restart to take effect.
2025-08-15T16:00:33.878Z,1755273633.878 [CommandExec](IMPORTANT): got command configSet ElevatorServo.loadAtStartup 0 bool persist
2025-08-15T16:00:33.878Z,1755273633.878 [CommandExec](IMPORTANT): configSet ElevatorServo.loadAtStartup requires a restart to take effect.
2025-08-15T16:00:33.880Z,1755273633.880 [CommandExec](IMPORTANT): got command restart application
2025-08-15T16:00:34.891Z,1755273634.891 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-15T16:00:34.891Z,1755273634.891 [CommandExec](INFO): Uninitializing the command executive.
2025-08-15T16:00:34.891Z,1755273634.891 [CommandExec](INFO): Uninitializing the command scheduler.
2025-08-15T16:00:34.891Z,1755273634.891 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-08-15T16:00:34.915Z,1755273634.915 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2025-08-15T16:00:34.915Z,1755273634.915 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2025-08-15T16:00:34.915Z,1755273634.915 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-08-15T16:00:34.916Z,1755273634.916 [NavChartDb](INFO): Join timeout helper Thread ID is 5924
2025-08-15T16:00:35.011Z,1755273635.011 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-15T16:00:35.011Z,1755273635.011 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-08-15T16:00:35.035Z,1755273635.035 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2025-08-15T16:00:35.035Z,1755273635.035 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-08-15T16:00:35.035Z,1755273635.035 [Radio_Surface](INFO): Join timeout helper Thread ID is 5925
2025-08-15T16:00:35.036Z,1755273635.036 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-15T16:00:35.036Z,1755273635.036 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-08-15T16:00:35.036Z,1755273635.036 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2025-08-15T16:00:35.036Z,1755273635.036 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-08-15T16:00:35.037Z,1755273635.037 [Onboard](INFO): Join timeout helper Thread ID is 5926
2025-08-15T16:00:38.715Z,1755273638.715 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-15T16:00:38.715Z,1755273638.715 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-08-15T16:00:38.735Z,1755273638.735 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2025-08-15T16:00:38.735Z,1755273638.735 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-08-15T16:00:38.735Z,1755273638.735 [DataOverHttps](INFO): Join timeout helper Thread ID is 5927
2025-08-15T16:00:39.189Z,1755273639.189 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-15T16:00:39.190Z,1755273639.190 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-08-15T16:00:39.191Z,1755273639.191 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2025-08-15T16:00:39.191Z,1755273639.191 [DAT ThreadHandler](INFO): Thread cancelled.
2025-08-15T16:00:39.192Z,1755273639.192 [DAT](INFO): Join timeout helper Thread ID is 5928
2025-08-15T16:00:39.225Z,1755273639.225 [DAT](INFO): Powering down
2025-08-15T16:00:39.295Z,1755273639.295 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-15T16:00:39.295Z,1755273639.295 [DAT](INFO): Powering down
2025-08-15T16:00:39.299Z,1755273639.299 [DAT ThreadHandler](INFO): Thread cancelled.
2025-08-15T16:00:39.300Z,1755273639.300 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2025-08-15T16:00:39.300Z,1755273639.300 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-08-15T16:00:39.301Z,1755273639.301 [BackseatComponent](INFO): Join timeout helper Thread ID is 5929
2025-08-15T16:00:39.475Z,1755273639.475 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-15T16:00:39.475Z,1755273639.475 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-08-15T16:00:39.491Z,1755273639.491 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2025-08-15T16:00:39.492Z,1755273639.492 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-08-15T16:00:39.492Z,1755273639.492 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 5932
2025-08-15T16:00:39.555Z,1755273639.555 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-15T16:00:39.555Z,1755273639.555 [WetLabsBB2FL](INFO): Powering down
2025-08-15T16:00:39.556Z,1755273639.556 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-08-15T16:00:39.571Z,1755273639.571 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2025-08-15T16:00:39.572Z,1755273639.572 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-08-15T16:00:39.572Z,1755273639.572 [CTD_Seabird](INFO): Join timeout helper Thread ID is 5933
2025-08-15T16:00:39.675Z,1755273639.675 [CTD_Seabird](INFO): Powering down
2025-08-15T16:00:39.687Z,1755273639.687 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-15T16:00:39.687Z,1755273639.687 [CTD_Seabird](INFO): Powering down
2025-08-15T16:00:39.699Z,1755273639.699 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-08-15T16:00:39.707Z,1755273639.707 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2025-08-15T16:00:39.708Z,1755273639.708 [logger ThreadHandler](INFO): Thread cancelled.
2025-08-15T16:00:39.708Z,1755273639.708 [logger](INFO): Join timeout helper Thread ID is 5934
2025-08-15T16:00:39.715Z,1755273639.715 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-15T16:00:39.715Z,1755273639.715 [logger ThreadHandler](INFO): Thread cancelled.
2025-08-15T16:00:39.716Z,1755273639.716 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2025-08-15T16:00:39.716Z,1755273639.716 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-08-15T16:00:39.717Z,1755273639.717 [CommandLine](INFO): Join timeout helper Thread ID is 5935
2025-08-15T16:00:39.791Z,1755273639.791 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-15T16:00:39.791Z,1755273639.791 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-08-15T16:00:39.803Z,1755273639.803 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2025-08-15T16:00:39.804Z,1755273639.804 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-08-15T16:00:39.804Z,1755273639.804 [CommandExec](INFO): Join timeout helper Thread ID is 5936
2025-08-15T16:00:39.815Z,1755273639.815 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2025-08-15T16:00:39.815Z,1755273639.815 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-08-15T16:00:39.816Z,1755273639.816 [controlThread](INFO): Join timeout helper Thread ID is 5937
2025-08-15T16:00:40.123Z,1755273640.123 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-15T16:00:40.123Z,1755273640.123 [controlThread](DEBUG): Uninitializing ControlThread
2025-08-15T16:00:40.123Z,1755273640.123 [AHRS_M2](INFO): Powering down
2025-08-15T16:00:40.291Z,1755273640.291 [DVL_micro](INFO): Powering down
2025-08-15T16:00:40.292Z,1755273640.292 [NAL9602](INFO): Powering down
2025-08-15T16:00:40.293Z,1755273640.293 [Sonardyne_Nano](INFO): Powering down
2025-08-15T16:00:40.503Z,1755273640.503 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2025-08-15T16:00:40.504Z,1755273640.504 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2025-08-15T16:00:40.504Z,1755273640.504 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2025-08-15T16:00:40.505Z,1755273640.505 [MissionManager](INFO): Uninitializing Mission Default
2025-08-15T16:00:40.505Z,1755273640.505 [Default] Stopped
2025-08-15T16:00:40.505Z,1755273640.505 [Default](DEBUG): Aggregate::uninitialize Default
2025-08-15T16:00:40.505Z,1755273640.505 [Default:B.GoToSurface] Stopped
2025-08-15T16:00:40.505Z,1755273640.505 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-08-15T16:00:40.505Z,1755273640.505 [Default:CheckIn] Stopped
2025-08-15T16:00:40.505Z,1755273640.505 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-08-15T16:00:40.505Z,1755273640.505 [Default:CheckIn:C.Wait] Stopped
2025-08-15T16:00:40.506Z,1755273640.506 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-08-15T16:00:40.509Z,1755273640.509 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2025-08-15T16:00:40.509Z,1755273640.509 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2025-08-15T16:00:40.509Z,1755273640.509 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2025-08-15T16:00:40.510Z,1755273640.510 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2025-08-15T16:00:40.510Z,1755273640.510 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2025-08-15T16:00:40.510Z,1755273640.510 [BuoyancyServo](INFO): Powering down
2025-08-15T16:00:40.523Z,1755273640.523 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-08-15T16:00:40.523Z,1755273640.523 [ElevatorServo](INFO): Powering down
2025-08-15T16:00:40.525Z,1755273640.525 [MassServo](DEBUG): Uninitialize Mass Servo.
2025-08-15T16:00:40.525Z,1755273640.525 [MassServo](INFO): Powering down
2025-08-15T16:00:40.526Z,1755273640.526 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-08-15T16:00:40.527Z,1755273640.527 [RudderServo](INFO): Powering down
2025-08-15T16:00:40.527Z,1755273640.527 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2025-08-15T16:00:40.527Z,1755273640.527 [ThrusterHE](INFO): Powering down
2025-08-15T16:00:40.528Z,1755273640.528 [SBIT](DEBUG): Uninitialize SBIT Component.
2025-08-15T16:00:40.529Z,1755273640.529 [IBIT](DEBUG): Uninitialize IBIT Component.
2025-08-15T16:00:40.529Z,1755273640.529 [CBIT](DEBUG): Uninitialize CBIT Component.
2025-08-15T16:00:40.529Z,1755273640.529 [CBIT](DEBUG): Powering off loads.
2025-08-15T16:00:40.543Z,1755273640.543 [CBIT](DEBUG): Disabling WDT.
2025-08-15T16:00:40.556Z,1755273640.556 [GFScanner](DEBUG): Uninitialize GFScanner component.
2025-08-15T16:00:40.556Z,1755273640.556 [GFScanner](DEBUG): Opening all GF detection circuits.
2025-08-15T16:00:40.557Z,1755273640.557 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-08-15T16:00:40.827Z,1755273640.827 [GFScanner](DEBUG): Uninitialize GFScanner component.
2025-08-15T16:00:40.827Z,1755273640.827 [GFScanner](DEBUG): Opening all GF detection circuits.
2025-08-15T16:00:40.843Z,1755273640.843 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-08-15T16:00:40.857Z,1755273640.857 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-08-15T16:00:40.956Z,1755273640.956 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-08-15T16:00:40.959Z,1755273640.959 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-08-15T16:00:40.967Z,1755273640.967 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-08-15T16:00:40.982Z,1755273640.982 [DAT ThreadHandler](INFO): Thread cancelled.
2025-08-15T16:00:41.079Z,1755273641.079 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-08-15T16:00:41.231Z,1755273641.231 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-08-15T16:00:41.394Z,1755273641.394 [logger ThreadHandler](INFO): Thread cancelled.