2024-09-23T15:22:30.274Z,1727104950.274 [Supervisor](DEBUG): Initializing supervisor. 2024-09-23T15:22:30.278Z,1727104950.278 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-09-23T15:22:30.279Z,1727104950.279 [SyncHandler](INFO): Protected caller Thread ID is 4667 2024-09-23T15:22:30.279Z,1727104950.279 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-09-23T15:22:30.280Z,1727104950.280 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-09-23T15:22:30.281Z,1727104950.281 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 4668 2024-09-23T15:22:30.285Z,1727104950.285 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-09-23T15:22:30.302Z,1727104950.302 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-09-23T15:22:30.303Z,1727104950.303 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-09-23T15:22:30.303Z,1727104950.303 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 4669 2024-09-23T15:22:30.307Z,1727104950.307 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-09-23T15:22:30.308Z,1727104950.308 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-09-23T15:22:30.309Z,1727104950.309 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 4670 2024-09-23T15:22:30.311Z,1727104950.311 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-09-23T15:22:30.312Z,1727104950.312 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-09-23T15:22:30.312Z,1727104950.312 [logger ThreadHandler](INFO): Protected caller Thread ID is 4671 2024-09-23T15:22:30.316Z,1727104950.316 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-09-23T15:22:30.316Z,1727104950.316 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-09-23T15:22:30.318Z,1727104950.318 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-09-23T15:22:30.563Z,1727104950.563 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-09-23T15:22:30.564Z,1727104950.564 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-09-23T15:22:30.790Z,1727104950.790 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-09-23T15:22:30.790Z,1727104950.790 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-09-23T15:22:30.900Z,1727104950.900 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-09-23T15:22:30.901Z,1727104950.901 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-09-23T15:22:31.105Z,1727104951.105 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-09-23T15:22:31.106Z,1727104951.106 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-09-23T15:22:31.686Z,1727104951.686 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-09-23T15:22:31.687Z,1727104951.687 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-09-23T15:22:31.808Z,1727104951.808 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-09-23T15:22:31.808Z,1727104951.808 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-09-23T15:22:32.098Z,1727104952.098 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-09-23T15:22:32.099Z,1727104952.099 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-09-23T15:22:32.335Z,1727104952.335 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-09-23T15:22:32.336Z,1727104952.336 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-09-23T15:22:32.910Z,1727104952.910 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-09-23T15:22:32.910Z,1727104952.910 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-09-23T15:22:33.346Z,1727104953.346 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-09-23T15:22:33.347Z,1727104953.347 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-09-23T15:22:33.438Z,1727104953.438 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-09-23T15:22:33.822Z,1727104953.822 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-09-23T15:22:33.823Z,1727104953.823 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-09-23T15:22:33.976Z,1727104953.976 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-09-23T15:22:33.976Z,1727104953.976 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-09-23T15:22:34.869Z,1727104954.869 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-09-23T15:22:34.870Z,1727104954.870 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-09-23T15:22:35.254Z,1727104955.254 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-09-23T15:22:35.255Z,1727104955.255 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-09-23T15:22:35.351Z,1727104955.351 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-aku/ 2024-09-23T15:22:35.352Z,1727104955.352 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/secure.cfg 2024-09-23T15:22:35.448Z,1727104955.448 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/logger.cfg 2024-09-23T15:22:35.568Z,1727104955.568 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/vehicle.cfg 2024-09-23T15:22:35.684Z,1727104955.684 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Navigation.cfg 2024-09-23T15:22:35.803Z,1727104955.803 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/BIT.cfg 2024-09-23T15:22:35.902Z,1727104955.902 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Simulator.cfg 2024-09-23T15:22:36.002Z,1727104956.002 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Servo.cfg 2024-09-23T15:22:36.127Z,1727104956.127 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Science.cfg 2024-09-23T15:22:36.271Z,1727104956.271 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Sensor.cfg 2024-09-23T15:22:36.448Z,1727104956.448 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Control.cfg 2024-09-23T15:22:36.558Z,1727104956.558 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Battery.cfg 2024-09-23T15:22:36.837Z,1727104956.837 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-09-23T15:22:36.837Z,1727104956.837 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2024-09-23T15:22:36.847Z,1727104956.847 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-09-23T15:22:37.197Z,1727104957.197 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-09-23T15:22:37.198Z,1727104957.198 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-09-23T15:22:37.659Z,1727104957.659 [AHRS_M2] Loaded 2024-09-23T15:22:37.659Z,1727104957.659 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-09-23T15:22:38.515Z,1727104958.515 [BPC1] Loaded 2024-09-23T15:22:38.515Z,1727104958.515 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-09-23T15:22:38.603Z,1727104958.603 [DATMMP] Loaded 2024-09-23T15:22:38.603Z,1727104958.603 [ComponentRegistry](DEBUG): Component "DATMMP" handled in its own thread. 2024-09-23T15:22:38.605Z,1727104958.605 [DATMMP ThreadHandler](DEBUG): Created PCaller Thread at 408A94E0 2024-09-23T15:22:38.605Z,1727104958.605 [DATMMP ThreadHandler](INFO): Protected caller Thread ID is 4754 2024-09-23T15:22:38.678Z,1727104958.678 [DataOverHttps] Loaded 2024-09-23T15:22:38.678Z,1727104958.678 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-09-23T15:22:38.680Z,1727104958.680 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408D94E0 2024-09-23T15:22:38.681Z,1727104958.681 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 4755 2024-09-23T15:22:38.703Z,1727104958.703 [Depth_Keller] Loaded 2024-09-23T15:22:38.703Z,1727104958.703 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-09-23T15:22:38.766Z,1727104958.766 [NAL9602] Loaded 2024-09-23T15:22:38.766Z,1727104958.766 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-09-23T15:22:38.822Z,1727104958.822 [Onboard] Loaded 2024-09-23T15:22:38.822Z,1727104958.822 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-09-23T15:22:38.826Z,1727104958.826 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409094E0 2024-09-23T15:22:38.830Z,1727104958.830 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 4756 2024-09-23T15:22:38.856Z,1727104958.856 [Power24vConverter] Loaded 2024-09-23T15:22:38.857Z,1727104958.857 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-09-23T15:22:38.873Z,1727104958.873 [Radio_Surface] Loaded 2024-09-23T15:22:38.873Z,1727104958.873 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-09-23T15:22:38.874Z,1727104958.874 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409394E0 2024-09-23T15:22:38.875Z,1727104958.875 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 4757 2024-09-23T15:22:38.909Z,1727104958.909 [Sonardyne_Nano] Loaded 2024-09-23T15:22:38.910Z,1727104958.910 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-09-23T15:22:38.910Z,1727104958.910 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-09-23T15:22:38.911Z,1727104958.911 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-09-23T15:22:39.028Z,1727104959.028 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-09-23T15:22:39.028Z,1727104959.028 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-09-23T15:22:39.078Z,1727104959.078 [VerticalControl](DEBUG): Construct VerticalControl. 2024-09-23T15:22:39.137Z,1727104959.137 [VerticalControl] Loaded 2024-09-23T15:22:39.137Z,1727104959.137 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-09-23T15:22:39.140Z,1727104959.140 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-09-23T15:22:39.187Z,1727104959.187 [HorizontalControl] Loaded 2024-09-23T15:22:39.188Z,1727104959.188 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-09-23T15:22:39.190Z,1727104959.190 [SpeedControl](DEBUG): Construct SpeedControl. 2024-09-23T15:22:39.193Z,1727104959.193 [SpeedControl] Loaded 2024-09-23T15:22:39.193Z,1727104959.193 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-09-23T15:22:39.196Z,1727104959.196 [LoopControl](DEBUG): Construct LoopControl. 2024-09-23T15:22:39.197Z,1727104959.197 [LoopControl] Loaded 2024-09-23T15:22:39.197Z,1727104959.197 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-09-23T15:22:39.197Z,1727104959.197 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-09-23T15:22:39.198Z,1727104959.198 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-09-23T15:22:39.208Z,1727104959.208 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-09-23T15:22:39.208Z,1727104959.208 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-09-23T15:22:39.235Z,1727104959.235 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-09-23T15:22:39.235Z,1727104959.235 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-09-23T15:22:39.349Z,1727104959.349 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-09-23T15:22:39.349Z,1727104959.349 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-09-23T15:22:39.391Z,1727104959.391 [DeadReckonUsingSpeedCalculator] Loaded 2024-09-23T15:22:39.391Z,1727104959.391 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2024-09-23T15:22:39.433Z,1727104959.433 [DeadReckonWithRespectToSeafloor] Loaded 2024-09-23T15:22:39.434Z,1727104959.434 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread. 2024-09-23T15:22:39.447Z,1727104959.447 [NavChart] Loaded 2024-09-23T15:22:39.448Z,1727104959.448 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-09-23T15:22:39.453Z,1727104959.453 [UniversalFixResidualReporter] Loaded 2024-09-23T15:22:39.454Z,1727104959.454 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-09-23T15:22:39.454Z,1727104959.454 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-09-23T15:22:39.455Z,1727104959.455 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-09-23T15:22:39.593Z,1727104959.593 [SBIT](DEBUG): Construct Startup Built In Test. 2024-09-23T15:22:39.602Z,1727104959.602 [SBIT] Loaded 2024-09-23T15:22:39.602Z,1727104959.602 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-09-23T15:22:39.605Z,1727104959.605 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-09-23T15:22:39.618Z,1727104959.618 [IBIT] Loaded 2024-09-23T15:22:39.618Z,1727104959.618 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-09-23T15:22:39.624Z,1727104959.624 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-09-23T15:22:39.730Z,1727104959.730 [CBIT] Loaded 2024-09-23T15:22:39.730Z,1727104959.730 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-09-23T15:22:39.730Z,1727104959.730 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-09-23T15:22:39.731Z,1727104959.731 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-09-23T15:22:39.916Z,1727104959.916 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-09-23T15:22:39.916Z,1727104959.916 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-09-23T15:22:41.766Z,1727104961.766 [BuoyancyServo] Loaded 2024-09-23T15:22:41.766Z,1727104961.766 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-09-23T15:22:41.788Z,1727104961.788 [ElevatorServo] Loaded 2024-09-23T15:22:41.789Z,1727104961.789 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-09-23T15:22:41.810Z,1727104961.810 [MassServo] Loaded 2024-09-23T15:22:41.810Z,1727104961.810 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-09-23T15:22:41.830Z,1727104961.830 [RudderServo] Loaded 2024-09-23T15:22:41.831Z,1727104961.831 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-09-23T15:22:41.847Z,1727104961.847 [ThrusterHE] Loaded 2024-09-23T15:22:41.848Z,1727104961.848 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2024-09-23T15:22:41.848Z,1727104961.848 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-09-23T15:22:41.849Z,1727104961.849 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-09-23T15:22:41.992Z,1727104961.992 [ESPComponent] Loaded 2024-09-23T15:22:41.992Z,1727104961.992 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2024-09-23T15:22:42.014Z,1727104962.014 [PAR_Licor] Loaded 2024-09-23T15:22:42.015Z,1727104962.015 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-09-23T15:22:42.016Z,1727104962.016 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-09-23T15:22:42.016Z,1727104962.016 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-09-23T15:22:42.065Z,1727104962.065 [DepthRateCalculator] Loaded 2024-09-23T15:22:42.065Z,1727104962.066 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-09-23T15:22:42.070Z,1727104962.070 [PitchRateCalculator] Loaded 2024-09-23T15:22:42.071Z,1727104962.071 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-09-23T15:22:42.079Z,1727104962.079 [SpeedCalculator] Loaded 2024-09-23T15:22:42.080Z,1727104962.080 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-09-23T15:22:42.084Z,1727104962.084 [YawRateCalculator] Loaded 2024-09-23T15:22:42.084Z,1727104962.084 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-09-23T15:22:42.103Z,1727104962.103 [ElevatorOffsetCalculator] Loaded 2024-09-23T15:22:42.103Z,1727104962.103 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-09-23T15:22:42.104Z,1727104962.104 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-09-23T15:22:42.104Z,1727104962.104 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-09-23T15:22:42.615Z,1727104962.615 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-09-23T15:22:42.621Z,1727104962.621 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-09-23T15:22:42.624Z,1727104962.624 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-09-23T15:22:42.635Z,1727104962.635 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-09-23T15:22:42.636Z,1727104962.636 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BC24E0 2024-09-23T15:22:42.636Z,1727104962.636 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 4759 2024-09-23T15:22:42.641Z,1727104962.641 [Supervisor](INFO): Main Thread ID is 4666 2024-09-23T15:22:42.641Z,1727104962.641 [Supervisor](DEBUG): Running supervisor. 2024-09-23T15:22:42.642Z,1727104962.642 [CommandExec ThreadHandler](INFO): Handler Thread ID is 4760 2024-09-23T15:22:42.642Z,1727104962.642 [CommandExec](INFO): Initializing the command executive. 2024-09-23T15:22:42.644Z,1727104962.644 [CommandLine ThreadHandler](INFO): Handler Thread ID is 4761 2024-09-23T15:22:42.647Z,1727104962.647 [controlThread ThreadHandler](INFO): Handler Thread ID is 4762 2024-09-23T15:22:42.648Z,1727104962.648 [controlThread](DEBUG): Initializing ControlThread 2024-09-23T15:22:42.653Z,1727104962.653 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-09-23T15:22:42.654Z,1727104962.654 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-09-23T15:22:42.655Z,1727104962.655 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-09-23T15:22:42.656Z,1727104962.656 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-09-23T15:22:42.657Z,1727104962.657 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-09-23T15:22:42.657Z,1727104962.657 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-09-23T15:22:42.658Z,1727104962.658 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-09-23T15:22:42.658Z,1727104962.658 [SBIT](INFO): Initialize SBIT Component. 2024-09-23T15:22:42.658Z,1727104962.658 [SBIT](IMPORTANT): git: 2024-08-12-95-g598b95f60 2024-09-23T15:22:42.658Z,1727104962.658 [SBIT](INFO): git hash: 598b95f6033d24136933a3d5d1ddac5d4570ac95 2024-09-23T15:22:42.659Z,1727104962.659 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-09-23T15:22:42.660Z,1727104962.660 [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 2024-09-23T15:22:42.661Z,1727104962.661 [SBIT](INFO): Beginning SBIT in 20.000000 seconds. 2024-09-23T15:22:42.662Z,1727104962.662 [IBIT](INFO): Initialize IBIT Component. 2024-09-23T15:22:42.662Z,1727104962.662 [CBIT](DEBUG): Initialize CBIT Component. 2024-09-23T15:22:42.663Z,1727104962.663 [logger ThreadHandler](INFO): Handler Thread ID is 4763 2024-09-23T15:22:42.676Z,1727104962.676 [CBIT](DEBUG): Initialized mux pins. 2024-09-23T15:22:42.676Z,1727104962.676 [CBIT](DEBUG): Initializing the watchdog timer. 2024-09-23T15:22:42.684Z,1727104962.684 [DATMMP ThreadHandler](INFO): Handler Thread ID is 4764 2024-09-23T15:22:42.685Z,1727104962.685 [DATMMP](INFO): Start 2024-09-23T15:22:42.685Z,1727104962.685 [DATMMP](INFO): Powering up 2024-09-23T15:22:42.685Z,1727104962.685 [DATMMP](DEBUG): Initializing DATMMP. 2024-09-23T15:22:42.689Z,1727104962.689 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 4766 2024-09-23T15:22:42.691Z,1727104962.691 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-09-23T15:22:42.700Z,1727104962.700 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-09-23T15:22:42.700Z,1727104962.700 [CBIT](DEBUG): Initializing heartbeat. 2024-09-23T15:22:42.701Z,1727104962.701 [Onboard ThreadHandler](INFO): Handler Thread ID is 4767 2024-09-23T15:22:42.721Z,1727104962.721 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 4768 2024-09-23T15:22:42.736Z,1727104962.736 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 4769 2024-09-23T15:22:42.740Z,1727104962.740 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2HA05M.000 2024-09-23T15:22:42.740Z,1727104962.740 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2HA05M.000 2024-09-23T15:22:42.740Z,1727104962.740 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3HA20M.000 2024-09-23T15:22:42.741Z,1727104962.741 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3HA20M.000 2024-09-23T15:22:42.741Z,1727104962.741 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000 2024-09-23T15:22:42.741Z,1727104962.741 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000 2024-09-23T15:22:42.741Z,1727104962.741 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000 2024-09-23T15:22:42.741Z,1727104962.741 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000 2024-09-23T15:22:42.741Z,1727104962.741 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA53M.000 2024-09-23T15:22:42.742Z,1727104962.742 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA53M.000 2024-09-23T15:22:42.742Z,1727104962.742 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA55M.000 2024-09-23T15:22:42.742Z,1727104962.742 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA55M.000 2024-09-23T15:22:42.772Z,1727104962.772 [CBIT](DEBUG): Deactivating GF circuits. 2024-09-23T15:22:42.772Z,1727104962.772 [CBIT](DEBUG): Deactivating emergency mode. 2024-09-23T15:22:42.813Z,1727104962.813 [CBIT](DEBUG): Backplane powered. 2024-09-23T15:22:42.816Z,1727104962.816 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-09-23T15:22:42.817Z,1727104962.817 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-09-23T15:22:42.817Z,1727104962.817 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-09-23T15:22:42.817Z,1727104962.817 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-09-23T15:22:42.817Z,1727104962.817 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-09-23T15:22:42.818Z,1727104962.818 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-09-23T15:22:42.819Z,1727104962.819 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-09-23T15:22:42.819Z,1727104962.819 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2024-09-23T15:22:42.820Z,1727104962.820 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2024-09-23T15:22:42.882Z,1727104962.882 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2024-09-23T15:22:42.887Z,1727104962.887 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-09-23T15:22:42.899Z,1727104962.899 [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 } } } 2024-09-23T15:22:42.900Z,1727104962.900 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-09-23T15:22:42.900Z,1727104962.900 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2024-09-23T15:22:42.901Z,1727104962.901 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2024-09-23T15:22:42.936Z,1727104962.936 [DATMMP](INFO): Starting 2024-09-23T15:22:43.124Z,1727104963.124 [Radio_Surface](INFO): Powering up 2024-09-23T15:22:43.152Z,1727104963.152 [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 2024-09-23T15:22:43.158Z,1727104963.158 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-09-23T15:22:43.159Z,1727104963.159 [Default:A.Wait](DEBUG): Construct Wait. 2024-09-23T15:22:43.173Z,1727104963.173 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-09-23T15:22:43.188Z,1727104963.188 [DATMMP](INFO): Starting 2024-09-23T15:22:43.197Z,1727104963.197 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-09-23T15:22:43.199Z,1727104963.199 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-09-23T15:22:43.217Z,1727104963.217 [Default:E.Execute](DEBUG): Construct Execute. 2024-09-23T15:22:43.220Z,1727104963.220 [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" } } 2024-09-23T15:22:43.236Z,1727104963.236 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,Power24vConverter,Sonardyne_Nano,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2024-09-23T15:22:43.242Z,1727104963.242 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-09-23T15:22:43.315Z,1727104963.315 [Power24vConverter](INFO): Powering up. 2024-09-23T15:22:43.315Z,1727104963.315 [Sonardyne_Nano](INFO): Initializing. 2024-09-23T15:22:43.369Z,1727104963.369 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-09-23T15:22:43.376Z,1727104963.376 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-09-23T15:22:43.377Z,1727104963.377 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-09-23T15:22:43.384Z,1727104963.384 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-09-23T15:22:43.385Z,1727104963.385 [MassServo](DEBUG): Initializing EZServoServo. 2024-09-23T15:22:43.392Z,1727104963.392 [MassServo](DEBUG): Initializing MassServo. 2024-09-23T15:22:43.393Z,1727104963.393 [RudderServo](DEBUG): Initializing EZServoServo. 2024-09-23T15:22:43.400Z,1727104963.400 [RudderServo](DEBUG): Initializing RudderServo. 2024-09-23T15:22:43.401Z,1727104963.401 [ThrusterHE](DEBUG): Initializing EZServoServo. 2024-09-23T15:22:43.408Z,1727104963.408 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2024-09-23T15:22:43.440Z,1727104963.440 [DATMMP](INFO): Starting 2024-09-23T15:22:43.693Z,1727104963.693 [DATMMP](INFO): Starting 2024-09-23T15:22:43.944Z,1727104963.944 [DATMMP](INFO): Starting 2024-09-23T15:22:44.196Z,1727104964.196 [DATMMP](INFO): Starting 2024-09-23T15:22:44.448Z,1727104964.448 [DATMMP](INFO): Starting 2024-09-23T15:22:44.704Z,1727104964.704 [DATMMP](INFO): Starting 2024-09-23T15:22:44.956Z,1727104964.956 [DATMMP](INFO): Starting 2024-09-23T15:22:45.208Z,1727104965.208 [DATMMP](INFO): Starting 2024-09-23T15:22:45.266Z,1727104965.266 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2024-09-23T15:22:45.460Z,1727104965.460 [DATMMP](INFO): Starting 2024-09-23T15:22:45.712Z,1727104965.712 [DATMMP](INFO): Starting 2024-09-23T15:22:45.964Z,1727104965.964 [DATMMP](INFO): Starting 2024-09-23T15:22:46.216Z,1727104966.216 [DATMMP](INFO): Starting 2024-09-23T15:22:46.468Z,1727104966.468 [DATMMP](INFO): Starting 2024-09-23T15:22:46.524Z,1727104966.524 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2409 2024-09-23T15:22:46.720Z,1727104966.720 [DATMMP](INFO): Starting 2024-09-23T15:22:46.972Z,1727104966.972 [DATMMP](INFO): Starting 2024-09-23T15:22:47.224Z,1727104967.224 [DATMMP](INFO): Starting 2024-09-23T15:22:47.476Z,1727104967.476 [DATMMP](INFO): Starting 2024-09-23T15:22:47.728Z,1727104967.728 [DATMMP](INFO): Starting 2024-09-23T15:22:47.980Z,1727104967.980 [DATMMP](INFO): Starting 2024-09-23T15:22:48.232Z,1727104968.232 [DATMMP](INFO): Starting 2024-09-23T15:22:48.484Z,1727104968.484 [DATMMP](INFO): Starting 2024-09-23T15:22:48.588Z,1727104968.588 [RudderServo](FAULT): Overload Error 2024-09-23T15:22:48.588Z,1727104968.588 [RudderServo] Hardware Fault, FailCount= 1 2024-09-23T15:22:48.588Z,1727104968.588 [RudderServo](ERROR): Hardware Fault 2024-09-23T15:22:48.627Z,1727104968.627 [CBIT](ERROR): Hardware Fault in component: RudderServo 2024-09-23T15:22:48.736Z,1727104968.736 [DATMMP](INFO): Starting 2024-09-23T15:22:48.988Z,1727104968.988 [DATMMP](INFO): Starting 2024-09-23T15:22:49.101Z,1727104969.101 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-09-23T15:22:49.101Z,1727104969.101 [RudderServo](INFO): Powering down 2024-09-23T15:22:49.102Z,1727104969.102 [ThrusterHE](ERROR): Zero Speed Commanded. 2024-09-23T15:22:49.240Z,1727104969.240 [DATMMP](INFO): Starting 2024-09-23T15:22:49.492Z,1727104969.492 [DATMMP](INFO): Starting 2024-09-23T15:22:49.744Z,1727104969.744 [DATMMP](INFO): Starting 2024-09-23T15:22:49.775Z,1727104969.775 [RudderServo](DEBUG): Initializing EZServoServo. 2024-09-23T15:22:49.893Z,1727104969.893 [RudderServo](DEBUG): Initializing RudderServo. 2024-09-23T15:22:49.897Z,1727104969.897 [CBIT](INFO): Clearing failed state for component RudderServo 2024-09-23T15:22:49.897Z,1727104969.897 [RudderServo] No Fault, FailCount= 1 2024-09-23T15:22:49.996Z,1727104969.996 [DATMMP](INFO): Starting 2024-09-23T15:22:50.248Z,1727104970.248 [DATMMP](INFO): Starting 2024-09-23T15:22:50.500Z,1727104970.500 [DATMMP](INFO): Starting 2024-09-23T15:22:50.752Z,1727104970.752 [DATMMP](INFO): Starting 2024-09-23T15:22:51.005Z,1727104971.005 [DATMMP](INFO): Starting 2024-09-23T15:22:51.256Z,1727104971.256 [DATMMP](INFO): Starting 2024-09-23T15:22:51.508Z,1727104971.508 [DATMMP](INFO): Starting 2024-09-23T15:22:51.760Z,1727104971.760 [DATMMP](INFO): Starting 2024-09-23T15:22:52.012Z,1727104972.012 [DATMMP](INFO): Starting 2024-09-23T15:22:52.264Z,1727104972.264 [DATMMP](INFO): Starting 2024-09-23T15:22:52.516Z,1727104972.516 [DATMMP](INFO): Starting 2024-09-23T15:22:52.768Z,1727104972.768 [DATMMP](INFO): Starting 2024-09-23T15:22:53.020Z,1727104973.020 [DATMMP](INFO): Starting 2024-09-23T15:22:53.271Z,1727104973.271 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005311 2024-09-23T15:22:53.272Z,1727104973.272 [DATMMP](INFO): Starting 2024-09-23T15:22:53.524Z,1727104973.524 [DATMMP](INFO): Starting 2024-09-23T15:22:53.776Z,1727104973.776 [DATMMP](INFO): Starting 2024-09-23T15:22:54.028Z,1727104974.028 [DATMMP](INFO): Starting 2024-09-23T15:22:54.280Z,1727104974.280 [DATMMP](INFO): Starting 2024-09-23T15:22:54.532Z,1727104974.532 [DATMMP](INFO): Starting 2024-09-23T15:22:54.532Z,1727104974.532 [DATMMP](INFO): DAT read: 2024-09-23T15:22:54.533Z,1727104974.533 [DATMMP](INFO): DAT read: Teledyne Benthos DAT-900 Series 2024-09-23T15:22:54.784Z,1727104974.784 [DATMMP](INFO): Starting 2024-09-23T15:22:55.036Z,1727104975.036 [DATMMP](INFO): Starting 2024-09-23T15:22:55.037Z,1727104975.037 [RudderServo](FAULT): Overload Error 2024-09-23T15:22:55.037Z,1727104975.037 [RudderServo] Hardware Fault, FailCount= 2 2024-09-23T15:22:55.037Z,1727104975.037 [RudderServo](ERROR): Hardware Fault 2024-09-23T15:22:55.068Z,1727104975.068 [CBIT](ERROR): Hardware Fault in component: RudderServo 2024-09-23T15:22:55.288Z,1727104975.288 [DATMMP](INFO): Starting 2024-09-23T15:22:55.403Z,1727104975.403 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-09-23T15:22:55.403Z,1727104975.403 [RudderServo](INFO): Powering down 2024-09-23T15:22:55.540Z,1727104975.540 [DATMMP](INFO): Starting 2024-09-23T15:22:55.792Z,1727104975.792 [DATMMP](INFO): Starting 2024-09-23T15:22:56.044Z,1727104976.044 [DATMMP](INFO): Starting 2024-09-23T15:22:56.045Z,1727104976.045 [DATMMP](INFO): DAT read: MF Frequency Band 2024-09-23T15:22:56.046Z,1727104976.046 [DATMMP](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2024-09-23T15:22:56.046Z,1727104976.046 [DATMMP](INFO): DAT read: Aug 19 2000 17:51:37 2024-09-23T15:22:56.214Z,1727104976.214 [RudderServo](DEBUG): Initializing EZServoServo. 2024-09-23T15:22:56.296Z,1727104976.296 [DATMMP](INFO): Starting 2024-09-23T15:22:56.337Z,1727104976.337 [RudderServo](DEBUG): Initializing RudderServo. 2024-09-23T15:22:56.340Z,1727104976.340 [CBIT](INFO): Clearing failed state for component RudderServo 2024-09-23T15:22:56.341Z,1727104976.341 [RudderServo] No Fault, FailCount= 2 2024-09-23T15:22:56.548Z,1727104976.548 [DATMMP](INFO): Starting 2024-09-23T15:22:56.800Z,1727104976.800 [DATMMP](INFO): Starting 2024-09-23T15:22:57.052Z,1727104977.052 [DATMMP](INFO): Starting 2024-09-23T15:22:57.053Z,1727104977.053 [DATMMP](INFO): DAT read: Features enabled [Bearing] 2024-09-23T15:22:57.054Z,1727104977.054 [DATMMP](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2024-09-23T15:22:57.054Z,1727104977.054 [DATMMP](INFO): commRate: 800 2024-09-23T15:22:57.304Z,1727104977.304 [DATMMP](INFO): Starting 2024-09-23T15:22:57.556Z,1727104977.556 [DATMMP](INFO): Starting 2024-09-23T15:22:57.808Z,1727104977.808 [DATMMP](INFO): Starting 2024-09-23T15:22:58.060Z,1727104978.060 [DATMMP](INFO): Starting 2024-09-23T15:22:58.312Z,1727104978.312 [DATMMP](INFO): Starting 2024-09-23T15:22:58.564Z,1727104978.564 [DATMMP](INFO): Starting 2024-09-23T15:22:58.816Z,1727104978.816 [DATMMP](INFO): Starting 2024-09-23T15:22:59.068Z,1727104979.068 [DATMMP](INFO): Starting 2024-09-23T15:22:59.120Z,1727104979.120 [DATMMP](INFO): entering command mode 2024-09-23T15:22:59.320Z,1727104979.320 [DATMMP](INFO): Starting 2024-09-23T15:22:59.320Z,1727104979.320 [DATMMP](INFO): DAT read: 2024-09-23T15:22:59.320Z,1727104979.320 [DATMMP](INFO): DAT read: user:1> 2024-09-23T15:22:59.321Z,1727104979.321 [DATMMP](DEBUG): read user prompt 1: user:1> 2024-09-23T15:22:59.322Z,1727104979.322 [DATMMP](INFO): entering MMP mode 2024-09-23T15:22:59.572Z,1727104979.572 [DATMMP](INFO): Starting 2024-09-23T15:22:59.573Z,1727104979.573 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-23T15:22:59.574Z,1727104979.574 [DATMMP](INFO): status rx: x1 2024-09-23T15:22:59.575Z,1727104979.575 [DATMMP](INFO): MMP status: 1: started 2024-09-23T15:22:59.575Z,1727104979.575 [DATMMP](INFO): Received message type: status 2024-09-23T15:22:59.575Z,1727104979.575 [DATMMP](INFO): Handled 2024-09-23T15:22:59.824Z,1727104979.824 [DATMMP](INFO): Starting 2024-09-23T15:22:59.825Z,1727104979.825 [DATMMP](INFO): Sent Tx Power Config 8 2024-09-23T15:22:59.825Z,1727104979.825 [DATMMP](INFO): Setting local address: 2 2024-09-23T15:22:59.827Z,1727104979.827 [DATMMP](INFO): Setting time to: 15:22:59 And date to:9/23/2024 2024-09-23T15:23:00.076Z,1727104980.076 [DATMMP](INFO): Starting 2024-09-23T15:23:00.076Z,1727104980.076 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-23T15:23:00.077Z,1727104980.077 [DATMMP](INFO): mdmpower rx: x8 x0 x5 x0 2024-09-23T15:23:00.077Z,1727104980.077 [DATMMP](INFO): Received message type: mdmpower 2024-09-23T15:23:00.078Z,1727104980.078 [DATMMP](INFO): Handled 2024-09-23T15:23:00.328Z,1727104980.328 [DATMMP](INFO): Starting 2024-09-23T15:23:00.328Z,1727104980.328 [DATMMP](INFO): GSXN notify for xid: 10 2024-09-23T15:23:00.329Z,1727104980.329 [DATMMP](INFO): sreg_txpower rx: x8 2024-09-23T15:23:00.329Z,1727104980.329 [DATMMP](INFO): Received message type: sreg_txpower 2024-09-23T15:23:00.329Z,1727104980.329 [DATMMP](INFO): Match for : sreg_txpower 2024-09-23T15:23:00.329Z,1727104980.329 [DATMMP](INFO): ACK 2024-09-23T15:23:00.580Z,1727104980.580 [DATMMP](INFO): Starting 2024-09-23T15:23:00.580Z,1727104980.580 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-23T15:23:00.581Z,1727104980.581 [DATMMP](INFO): mdmlocal rx: x2 x0 x0 x0 2024-09-23T15:23:00.581Z,1727104980.581 [DATMMP](INFO): Received message type: mdmlocal 2024-09-23T15:23:00.581Z,1727104980.581 [DATMMP](INFO): Handled 2024-09-23T15:23:00.832Z,1727104980.832 [DATMMP](INFO): Starting 2024-09-23T15:23:00.832Z,1727104980.832 [DATMMP](INFO): GSXN notify for xid: 11 2024-09-23T15:23:00.833Z,1727104980.833 [DATMMP](INFO): sreg_locaddr rx: x2 2024-09-23T15:23:00.833Z,1727104980.833 [DATMMP](INFO): Received message type: sreg_locaddr 2024-09-23T15:23:00.833Z,1727104980.833 [DATMMP](INFO): Match for : sreg_locaddr 2024-09-23T15:23:00.833Z,1727104980.833 [DATMMP](INFO): ACK 2024-09-23T15:23:01.084Z,1727104981.084 [DATMMP](INFO): Starting 2024-09-23T15:23:01.084Z,1727104981.084 [DATMMP](INFO): GSXN notify for xid: 12 2024-09-23T15:23:01.086Z,1727104981.086 [DATMMP](INFO): timedate rx: x0 xF x16 x3B x8 x17 x7C x0 2024-09-23T15:23:01.086Z,1727104981.086 [DATMMP](INFO): Received message type: timedate 2024-09-23T15:23:01.086Z,1727104981.086 [DATMMP](INFO): Match for : timedate 2024-09-23T15:23:01.086Z,1727104981.086 [DATMMP](INFO): ACK 2024-09-23T15:23:01.336Z,1727104981.336 [DATMMP](INFO): Starting 2024-09-23T15:23:01.336Z,1727104981.336 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-23T15:23:01.337Z,1727104981.337 [DATMMP](INFO): sys_verb rx: x0 x0 x0 x0 2024-09-23T15:23:01.337Z,1727104981.337 [DATMMP](INFO): Received message type: sys_verb 2024-09-23T15:23:01.337Z,1727104981.337 [DATMMP](INFO): Handled 2024-09-23T15:23:01.436Z,1727104981.436 [AHRS_M2](FAULT): Failed to acquire valid data within timeout. 2024-09-23T15:23:01.436Z,1727104981.436 [AHRS_M2] Data Fault, FailCount= 1 2024-09-23T15:23:01.436Z,1727104981.436 [AHRS_M2](ERROR): Data Fault 2024-09-23T15:23:01.498Z,1727104981.498 [RudderServo](FAULT): Overload Error 2024-09-23T15:23:01.498Z,1727104981.498 [RudderServo] Hardware Fault, FailCount= 3 2024-09-23T15:23:01.498Z,1727104981.498 [RudderServo](ERROR): Hardware Fault 2024-09-23T15:23:01.528Z,1727104981.528 [CBIT](ERROR): Data Fault in component: AHRS_M2 2024-09-23T15:23:01.528Z,1727104981.528 [CBIT](ERROR): Hardware Fault in component: RudderServo 2024-09-23T15:23:01.529Z,1727104981.529 [CBIT](CRITICAL): Hardware Fault in component: RudderServo 2024-09-23T15:23:01.588Z,1727104981.588 [DATMMP](INFO): Starting 2024-09-23T15:23:01.588Z,1727104981.588 [DATMMP](INFO): GSXN notify for xid: 13 2024-09-23T15:23:01.589Z,1727104981.589 [DATMMP](INFO): sreg_verbosity rx: x0 2024-09-23T15:23:01.589Z,1727104981.589 [DATMMP](INFO): Received message type: sreg_verbosity 2024-09-23T15:23:01.589Z,1727104981.589 [DATMMP](INFO): Match for : sreg_verbosity 2024-09-23T15:23:01.589Z,1727104981.589 [DATMMP](INFO): ACK 2024-09-23T15:23:01.825Z,1727104981.825 [AHRS_M2](INFO): Powering down 2024-09-23T15:23:01.848Z,1727104981.848 [DATMMP](INFO): Starting 2024-09-23T15:23:01.849Z,1727104981.849 [DATMMP](INFO): GSXN notify for xid: 14 2024-09-23T15:23:01.850Z,1727104981.850 [DATMMP](INFO): version rx: x2 x5 2024-09-23T15:23:01.850Z,1727104981.850 [DATMMP](INFO): DatMMPVersion: 2.5 2024-09-23T15:23:01.850Z,1727104981.850 [DATMMP](INFO): Received message type: version 2024-09-23T15:23:01.850Z,1727104981.850 [DATMMP](INFO): Match for : version 2024-09-23T15:23:01.850Z,1727104981.850 [DATMMP](INFO): ACK 2024-09-23T15:23:01.851Z,1727104981.851 [DATMMP](INFO): in MMP mode: config complete going to runnable 2024-09-23T15:23:01.965Z,1727104981.965 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-09-23T15:23:01.965Z,1727104981.965 [RudderServo](INFO): Powering down 2024-09-23T15:23:01.967Z,1727104981.967 [CommandExec](FAULT): Scheduling is paused 2024-09-23T15:23:01.972Z,1727104981.972 [CBIT](INFO): Critical error at 20240923T152301 2024-09-23T15:23:01.972Z,1727104981.972 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2024-09-23T15:23:02.653Z,1727104982.653 [RudderServo](DEBUG): Initializing EZServoServo. 2024-09-23T15:23:02.773Z,1727104982.773 [RudderServo](DEBUG): Initializing RudderServo. 2024-09-23T15:23:02.776Z,1727104982.776 [CBIT](INFO): Clearing failed state for component AHRS_M2 2024-09-23T15:23:02.776Z,1727104982.776 [AHRS_M2] No Fault, FailCount= 1 2024-09-23T15:23:03.037Z,1727104983.037 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-09-23T15:23:03.063Z,1727104983.063 [SBIT](IMPORTANT): Beginning Startup BIT 2024-09-23T15:23:03.067Z,1727104983.067 [CBIT](IMPORTANT): Beginning ground fault scan 2024-09-23T15:23:09.117Z,1727104989.117 [NAL9602](INFO): Powering up NAL9602 2024-09-23T15:23:14.021Z,1727104994.021 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.010273 CHAN A1 (24V): 0.054343 CHAN A2 (12V): 0.000515 CHAN A3 (5V): -0.001438 CHAN B0 (3.3V): -0.001134 CHAN B1 (3.15aV): -0.001103 CHAN B2 (3.15bV): -0.001225 CHAN B3 (GND): -0.002148 OPEN: 0.005009 Full Scale: +/- 1 mA 2024-09-23T15:23:16.380Z,1727104996.380 [AHRS_M2](FAULT): Failed to acquire valid data within timeout. 2024-09-23T15:23:16.380Z,1727104996.380 [AHRS_M2] Data Fault, FailCount= 2 2024-09-23T15:23:16.380Z,1727104996.380 [AHRS_M2](ERROR): Data Fault 2024-09-23T15:23:16.446Z,1727104996.446 [SBIT](ERROR): Could not read rudderAngleReader_. 2024-09-23T15:23:16.461Z,1727104996.461 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-23T15:23:16.461Z,1727104996.461 [DATMMP](INFO): timesync rx: x0 x1 x1 x0 2024-09-23T15:23:16.462Z,1727104996.462 [DATMMP](INFO): Received message type: timesync 2024-09-23T15:23:16.462Z,1727104996.462 [DATMMP](INFO): Handled 2024-09-23T15:23:16.509Z,1727104996.509 [CBIT](ERROR): Data Fault in component: AHRS_M2 2024-09-23T15:23:16.773Z,1727104996.773 [AHRS_M2](INFO): Powering down 2024-09-23T15:23:17.625Z,1727104997.625 [CBIT](INFO): Clearing failed state for component AHRS_M2 2024-09-23T15:23:17.625Z,1727104997.625 [AHRS_M2] No Fault, FailCount= 2 2024-09-23T15:23:17.985Z,1727104997.985 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-09-23T15:23:20.009Z,1727105000.009 [NAL9602](INFO): NAL9602 initialized 2024-09-23T15:23:21.540Z,1727105001.540 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:21.988Z,1727105001.988 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:22.104Z,1727105002.104 [CommandExec](IMPORTANT): got command failComponent 2024-09-23T15:23:22.105Z,1727105002.105 [CommandExec](IMPORTANT): Failed components: 2024-09-23T15:23:22.105Z,1727105002.105 [CommandExec](IMPORTANT): RudderServo: Hardware Fault 2024-09-23T15:23:22.452Z,1727105002.452 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:22.860Z,1727105002.860 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:23.272Z,1727105003.272 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:23.688Z,1727105003.688 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:24.144Z,1727105004.144 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:24.680Z,1727105004.680 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:25.080Z,1727105005.080 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:25.484Z,1727105005.484 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:25.888Z,1727105005.888 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:26.284Z,1727105006.284 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:26.288Z,1727105006.288 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-23T15:23:26.289Z,1727105006.289 [DATMMP](INFO): timesync rx: x1 x0 x1 x0 2024-09-23T15:23:26.290Z,1727105006.290 [DATMMP](INFO): Received message type: timesync 2024-09-23T15:23:26.290Z,1727105006.290 [DATMMP](INFO): Handled 2024-09-23T15:23:26.700Z,1727105006.700 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:27.096Z,1727105007.096 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:27.504Z,1727105007.504 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:27.904Z,1727105007.904 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:28.312Z,1727105008.312 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:28.720Z,1727105008.720 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:29.136Z,1727105009.136 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:29.552Z,1727105009.552 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:29.960Z,1727105009.960 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:30.360Z,1727105010.360 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:30.772Z,1727105010.772 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:31.164Z,1727105011.164 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:31.164Z,1727105011.164 [AHRS_M2](FAULT): Failed to initialize within timeout. 2024-09-23T15:23:31.164Z,1727105011.164 [AHRS_M2] Communications Fault, FailCount= 3 2024-09-23T15:23:31.164Z,1727105011.164 [AHRS_M2](ERROR): Communications Fault 2024-09-23T15:23:31.244Z,1727105011.244 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2024-09-23T15:23:31.251Z,1727105011.251 [AHRS_M2](INFO): Powering down 2024-09-23T15:23:32.119Z,1727105012.119 [CBIT](INFO): Clearing failed state for component AHRS_M2 2024-09-23T15:23:32.119Z,1727105012.119 [AHRS_M2] No Fault, FailCount= 3 2024-09-23T15:23:32.461Z,1727105012.461 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-09-23T15:23:35.788Z,1727105015.788 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:36.192Z,1727105016.192 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:36.596Z,1727105016.596 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:37.001Z,1727105017.001 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:37.404Z,1727105017.404 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:37.774Z,1727105017.774 [CommandExec](IMPORTANT): got command get platform_elevator_angle 2024-09-23T15:23:37.780Z,1727105017.780 [CommandExec](IMPORTANT): platform_elevator_angle -0.261992 rad 2024-09-23T15:23:37.824Z,1727105017.824 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:38.204Z,1727105018.204 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:38.616Z,1727105018.616 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:39.020Z,1727105019.020 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:39.424Z,1727105019.424 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:39.828Z,1727105019.828 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:40.232Z,1727105020.232 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:40.636Z,1727105020.636 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:41.040Z,1727105021.040 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:41.444Z,1727105021.444 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:41.848Z,1727105021.848 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:42.256Z,1727105022.256 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:42.656Z,1727105022.656 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:43.060Z,1727105023.060 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:43.082Z,1727105023.082 [SBIT](ERROR): Could not read rudderAngleReader_. 2024-09-23T15:23:43.083Z,1727105023.083 [SBIT](FAULT): Control surface position failure. 2024-09-23T15:23:43.464Z,1727105023.464 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:43.872Z,1727105023.872 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:44.272Z,1727105024.272 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:44.676Z,1727105024.676 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:45.080Z,1727105025.080 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:45.488Z,1727105025.488 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:45.488Z,1727105025.488 [AHRS_M2](FAULT): Failed to initialize within timeout. 2024-09-23T15:23:45.488Z,1727105025.488 [AHRS_M2] Communications Fault, FailCount= 4 2024-09-23T15:23:45.488Z,1727105025.488 [AHRS_M2](ERROR): Communications Fault 2024-09-23T15:23:45.636Z,1727105025.636 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2024-09-23T15:23:45.793Z,1727105025.793 [AHRS_M2](INFO): Powering down 2024-09-23T15:23:46.693Z,1727105026.693 [CBIT](INFO): Clearing failed state for component AHRS_M2 2024-09-23T15:23:46.693Z,1727105026.693 [AHRS_M2] No Fault, FailCount= 4 2024-09-23T15:23:47.005Z,1727105027.005 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-09-23T15:23:50.336Z,1727105030.336 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:50.736Z,1727105030.736 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:51.140Z,1727105031.140 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:51.544Z,1727105031.544 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:51.948Z,1727105031.948 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:52.352Z,1727105032.352 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:52.756Z,1727105032.756 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:53.160Z,1727105033.160 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:53.564Z,1727105033.564 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:53.968Z,1727105033.968 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:54.376Z,1727105034.376 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:54.780Z,1727105034.780 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:55.180Z,1727105035.180 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:55.584Z,1727105035.584 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:55.969Z,1727105035.969 [AHRS_M2](ERROR): Start data-stream UART error: serial buffer full 2024-09-23T15:23:56.408Z,1727105036.408 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:56.796Z,1727105036.796 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:56.834Z,1727105036.834 [SBIT](ERROR): Could not read rudderAngleReader_. 2024-09-23T15:23:56.834Z,1727105036.834 [SBIT](FAULT): Control surface position failure. 2024-09-23T15:23:57.178Z,1727105037.178 [AHRS_M2](ERROR): Start data-stream UART error: serial buffer full 2024-09-23T15:23:57.288Z,1727105037.288 [SBIT](CRITICAL): SBIT FAILED 2024-09-23T15:23:57.289Z,1727105037.289 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-09-23T15:23:57.291Z,1727105037.291 [SBIT](IMPORTANT): 2024-09-23T15:23:57.312Z,1727105037.312 [SBIT](IMPORTANT): CBIT.vehicleOpen=1 bool; 2024-09-23T15:23:57.313Z,1727105037.313 [SBIT](IMPORTANT): CTD_Seabird.loadAtStartup=0 bool; 2024-09-23T15:23:57.313Z,1727105037.313 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool; 2024-09-23T15:23:57.314Z,1727105037.314 [SBIT](IMPORTANT): DATMMP.loadAtStartup=1 bool; 2024-09-23T15:23:57.314Z,1727105037.314 [SBIT](IMPORTANT): DATMMP.simulateHardware=0 bool; 2024-09-23T15:23:57.314Z,1727105037.314 [SBIT](IMPORTANT): DATMMP.surfaceThreshold=-0.1 meter; 2024-09-23T15:23:57.315Z,1727105037.315 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool; 2024-09-23T15:23:57.315Z,1727105037.315 [SBIT](IMPORTANT): ESPComponent.loadAtStartup=1 bool; 2024-09-23T15:23:57.315Z,1727105037.315 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=3 minute; 2024-09-23T15:23:57.322Z,1727105037.322 [SBIT](IMPORTANT): ESPComponent.simulateHardware=1 bool; 2024-09-23T15:23:57.322Z,1727105037.322 [SBIT](IMPORTANT): WetLabsBB2FL.loadAtStartup=0 bool; 2024-09-23T15:23:57.331Z,1727105037.331 [CBIT](INFO): Critical error at 20240923T152357 2024-09-23T15:23:58.791Z,1727105038.791 [AHRS_M2](ERROR): Start data-stream UART error: serial buffer full 2024-09-23T15:23:58.885Z,1727105038.885 [MissionManager](IMPORTANT): Started mission Startup 2024-09-23T15:23:58.886Z,1727105038.886 [Startup] Running Loop=1 2024-09-23T15:23:58.887Z,1727105038.887 [Startup](DEBUG): Aggregate::initialize Startup 2024-09-23T15:23:58.887Z,1727105038.887 [Startup:A.GoToSurface] Running Loop=1 2024-09-23T15:23:58.887Z,1727105038.887 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-09-23T15:23:58.889Z,1727105038.889 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-09-23T15:23:58.891Z,1727105038.891 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-09-23T15:23:58.892Z,1727105038.892 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-09-23T15:23:58.893Z,1727105038.893 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-09-23T15:23:58.894Z,1727105038.894 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-09-23T15:23:58.895Z,1727105038.895 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-09-23T15:23:58.901Z,1727105038.901 [Startup:StartupSatComms] Running Loop=1 2024-09-23T15:23:58.902Z,1727105038.902 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2024-09-23T15:23:58.902Z,1727105038.902 [Startup:StartupSatComms:A] Running Loop=1 2024-09-23T15:23:59.138Z,1727105039.138 [AHRS_M2](ERROR): Start data-stream UART error: serial buffer full 2024-09-23T15:23:59.209Z,1727105039.209 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2024-09-23T15:23:59.516Z,1727105039.516 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:59.916Z,1727105039.916 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-09-23T15:23:59.916Z,1727105039.916 [AHRS_M2](FAULT): Failed to initialize within timeout. 2024-09-23T15:23:59.916Z,1727105039.916 [AHRS_M2] Communications Fault, FailCount= 5 2024-09-23T15:23:59.916Z,1727105039.916 [AHRS_M2](ERROR): Communications Fault 2024-09-23T15:23:59.988Z,1727105039.988 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2024-09-23T15:23:59.988Z,1727105039.988 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2 2024-09-23T15:24:00.221Z,1727105040.221 [AHRS_M2](INFO): Powering down 2024-09-23T15:24:00.334Z,1727105040.334 [CBIT](INFO): Critical error at 20240923T152359 2024-09-23T15:24:08.445Z,1727105048.445 [CommandExec](IMPORTANT): got command report touch platform_elevator_angle degree 2024-09-23T15:24:30.429Z,1727105070.429 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 15 degree 2024-09-23T15:24:30.446Z,1727105070.446 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.elevatorAngleAction" handled in the control thread. 2024-09-23T15:24:30.568Z,1727105070.568 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,Power24vConverter,Sonardyne_Nano,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.elevatorAngleAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2024-09-23T15:24:32.241Z,1727105072.241 [Reporter](INFO): platform_elevator_angle -0.000307 rad 2024-09-23T15:24:32.613Z,1727105072.613 [Reporter](INFO): platform_elevator_angle 0.015009 rad 2024-09-23T15:24:33.006Z,1727105073.006 [Reporter](INFO): platform_elevator_angle 0.057312 rad 2024-09-23T15:24:33.406Z,1727105073.406 [Reporter](INFO): platform_elevator_angle 0.103645 rad 2024-09-23T15:24:33.817Z,1727105073.817 [Reporter](INFO): platform_elevator_angle 0.152742 rad 2024-09-23T15:24:34.217Z,1727105074.217 [Reporter](INFO): platform_elevator_angle 0.199728 rad 2024-09-23T15:24:34.624Z,1727105074.624 [Reporter](INFO): platform_elevator_angle 0.245332 rad 2024-09-23T15:24:35.017Z,1727105075.017 [Reporter](INFO): platform_elevator_angle 0.261800 rad 2024-09-23T15:24:42.659Z,1727105082.659 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-09-23T15:24:42.659Z,1727105082.659 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-09-23T15:24:42.659Z,1727105082.659 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-09-23T15:24:42.661Z,1727105082.661 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-09-23T15:24:42.661Z,1727105082.661 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1 2024-09-23T15:24:42.661Z,1727105082.661 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-09-23T15:24:42.663Z,1727105082.663 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-09-23T15:24:42.663Z,1727105082.663 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-09-23T15:24:42.663Z,1727105082.663 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-23T15:24:42.722Z,1727105082.722 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-09-23T15:24:42.722Z,1727105082.722 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-09-23T15:24:42.723Z,1727105082.723 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-23T15:24:43.087Z,1727105083.087 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-09-23T15:24:43.087Z,1727105083.087 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-09-23T15:24:43.092Z,1727105083.092 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-09-23T15:24:43.092Z,1727105083.092 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1 2024-09-23T15:24:43.093Z,1727105083.093 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-23T15:24:43.093Z,1727105083.093 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-09-23T15:24:43.471Z,1727105083.471 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-09-23T15:24:50.052Z,1727105090.052 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction -15 degree 2024-09-23T15:24:51.637Z,1727105091.637 [Reporter](INFO): platform_elevator_angle 0.262568 rad 2024-09-23T15:24:51.994Z,1727105091.994 [Reporter](INFO): platform_elevator_angle 0.248748 rad 2024-09-23T15:24:52.393Z,1727105092.393 [Reporter](INFO): platform_elevator_angle 0.204833 rad 2024-09-23T15:24:52.801Z,1727105092.801 [Reporter](INFO): platform_elevator_angle 0.157963 rad 2024-09-23T15:24:53.197Z,1727105093.197 [Reporter](INFO): platform_elevator_angle 0.110478 rad 2024-09-23T15:24:53.610Z,1727105093.610 [Reporter](INFO): platform_elevator_angle 0.062840 rad 2024-09-23T15:24:54.009Z,1727105094.009 [Reporter](INFO): platform_elevator_angle 0.015316 rad 2024-09-23T15:24:54.417Z,1727105094.417 [Reporter](INFO): platform_elevator_angle -0.032936 rad 2024-09-23T15:24:54.818Z,1727105094.818 [Reporter](INFO): platform_elevator_angle -0.078348 rad 2024-09-23T15:24:55.225Z,1727105095.225 [Reporter](INFO): platform_elevator_angle -0.126255 rad 2024-09-23T15:24:55.625Z,1727105095.625 [Reporter](INFO): platform_elevator_angle -0.173510 rad 2024-09-23T15:24:56.059Z,1727105096.059 [Reporter](INFO): platform_elevator_angle -0.222722 rad 2024-09-23T15:24:56.453Z,1727105096.453 [Reporter](INFO): platform_elevator_angle -0.257654 rad 2024-09-23T15:24:56.886Z,1727105096.886 [Reporter](INFO): platform_elevator_angle -0.261992 rad 2024-09-23T15:24:59.230Z,1727105099.230 [Startup:StartupSatComms:A](INFO): Timed out from 2024-09-23T15:23:58.9Z 2024-09-23T15:24:59.230Z,1727105099.230 [Startup:StartupSatComms:A] Stopped 2024-09-23T15:24:59.230Z,1727105099.230 [Startup:StartupSatComms:B] Running Loop=1 2024-09-23T15:24:59.627Z,1727105099.627 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-09-23T15:25:06.654Z,1727105106.654 [DataOverHttps](INFO): Sending 271 bytes from file Logs/20240917T201945/Courier0000.lzma 2024-09-23T15:25:07.654Z,1727105107.654 [DataOverHttps](INFO): Moved sent file to Logs/20240917T201945/Courier0000.lzma.bak 2024-09-23T15:25:07.654Z,1727105107.654 [DataOverHttps](INFO): SBD MOMSN=23220069 2024-09-23T15:25:26.317Z,1727105126.317 [DataOverHttps](INFO): Sending 120 bytes from file Logs/20240917T201945/Courier0004.lzma 2024-09-23T15:25:27.322Z,1727105127.322 [DataOverHttps](INFO): Moved sent file to Logs/20240917T201945/Courier0004.lzma.bak 2024-09-23T15:25:27.322Z,1727105127.322 [DataOverHttps](INFO): SBD MOMSN=23220077 2024-09-23T15:25:38.204Z,1727105138.204 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 0 degree 2024-09-23T15:25:39.335Z,1727105139.335 [Reporter](INFO): platform_elevator_angle -0.258921 rad 2024-09-23T15:25:39.689Z,1727105139.689 [Reporter](INFO): platform_elevator_angle -0.245408 rad 2024-09-23T15:25:40.101Z,1727105140.101 [Reporter](INFO): platform_elevator_angle -0.199344 rad 2024-09-23T15:25:40.490Z,1727105140.490 [Reporter](INFO): platform_elevator_angle -0.153855 rad 2024-09-23T15:25:40.900Z,1727105140.900 [Reporter](INFO): platform_elevator_angle -0.107484 rad 2024-09-23T15:25:41.301Z,1727105141.301 [Reporter](INFO): platform_elevator_angle -0.059231 rad 2024-09-23T15:25:41.691Z,1727105141.691 [Reporter](INFO): platform_elevator_angle -0.015662 rad 2024-09-23T15:25:42.109Z,1727105142.109 [Reporter](INFO): platform_elevator_angle 0.000307 rad 2024-09-23T15:25:42.905Z,1727105142.905 [DataOverHttps](INFO): Sending 108 bytes from file Logs/20240917T201945/Courier0007.lzma 2024-09-23T15:25:43.905Z,1727105143.905 [DataOverHttps](INFO): Moved sent file to Logs/20240917T201945/Courier0007.lzma.bak 2024-09-23T15:25:43.906Z,1727105143.906 [DataOverHttps](INFO): SBD MOMSN=23220083 2024-09-23T15:25:56.424Z,1727105156.424 [CommandExec](IMPORTANT): got command quit 2024-09-23T15:25:57.428Z,1727105157.428 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-23T15:25:57.428Z,1727105157.428 [CommandExec](INFO): Uninitializing the command executive. 2024-09-23T15:25:57.428Z,1727105157.428 [CommandExec](INFO): Uninitializing the command scheduler. 2024-09-23T15:25:57.429Z,1727105157.429 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-09-23T15:25:57.484Z,1727105157.484 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-09-23T15:25:57.484Z,1727105157.484 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-09-23T15:25:57.484Z,1727105157.484 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-09-23T15:25:57.485Z,1727105157.485 [NavChartDb](INFO): Join timeout helper Thread ID is 4792 2024-09-23T15:25:57.580Z,1727105157.580 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-23T15:25:57.580Z,1727105157.580 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-09-23T15:25:57.584Z,1727105157.584 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-09-23T15:25:57.584Z,1727105157.584 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-09-23T15:25:57.585Z,1727105157.585 [Radio_Surface](INFO): Join timeout helper Thread ID is 4793 2024-09-23T15:25:57.912Z,1727105157.912 [Radio_Surface](INFO): Powering down 2024-09-23T15:25:57.913Z,1727105157.913 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-23T15:25:57.913Z,1727105157.913 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-09-23T15:25:57.916Z,1727105157.916 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-09-23T15:25:57.916Z,1727105157.916 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-09-23T15:25:57.916Z,1727105157.916 [Onboard](INFO): Join timeout helper Thread ID is 4794 2024-09-23T15:25:59.439Z,1727105159.439 [Startup:StartupSatComms:B](INFO): Timed out from 2024-09-23T15:24:59.2Z 2024-09-23T15:25:59.439Z,1727105159.439 [Startup:StartupSatComms:B] Stopped 2024-09-23T15:25:59.439Z,1727105159.439 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2024-09-23T15:25:59.439Z,1727105159.439 [Startup:StartupSatComms] Stopped 2024-09-23T15:25:59.439Z,1727105159.439 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2024-09-23T15:25:59.440Z,1727105159.440 [Startup](INFO): Completed Startup 2024-09-23T15:25:59.440Z,1727105159.440 [MissionManager](INFO): Startup is completed. 2024-09-23T15:25:59.441Z,1727105159.441 [MissionManager](INFO): Uninitializing Mission Startup 2024-09-23T15:25:59.441Z,1727105159.441 [Startup] Stopped 2024-09-23T15:25:59.441Z,1727105159.441 [Startup](DEBUG): Aggregate::uninitialize Startup 2024-09-23T15:25:59.441Z,1727105159.441 [Startup:A.GoToSurface] Stopped 2024-09-23T15:25:59.441Z,1727105159.441 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-09-23T15:25:59.834Z,1727105159.834 [MissionManager](IMPORTANT): Started mission Default 2024-09-23T15:25:59.834Z,1727105159.834 [Default] Running Loop=1 2024-09-23T15:25:59.835Z,1727105159.835 [Default](DEBUG): Aggregate::initialize Default 2024-09-23T15:25:59.835Z,1727105159.835 [Default:B.GoToSurface] Running Loop=1 2024-09-23T15:25:59.835Z,1727105159.835 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-09-23T15:25:59.835Z,1727105159.835 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-09-23T15:25:59.835Z,1727105159.835 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-09-23T15:25:59.836Z,1727105159.836 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-09-23T15:25:59.836Z,1727105159.836 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-09-23T15:25:59.836Z,1727105159.836 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-09-23T15:25:59.837Z,1727105159.837 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-09-23T15:25:59.837Z,1727105159.837 [Default:A.Wait] Running Loop=1 2024-09-23T15:25:59.837Z,1727105159.837 [Default:A.Wait](DEBUG): Initialize Wait Component. 2024-09-23T15:26:02.880Z,1727105162.880 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-23T15:26:02.880Z,1727105162.880 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-09-23T15:26:02.884Z,1727105162.884 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-09-23T15:26:02.884Z,1727105162.884 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-09-23T15:26:02.884Z,1727105162.884 [DataOverHttps](INFO): Join timeout helper Thread ID is 4795 2024-09-23T15:26:03.316Z,1727105163.316 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-23T15:26:03.319Z,1727105163.319 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-09-23T15:26:03.324Z,1727105163.324 [ComponentRegistry](INFO): Shutting down DATMMP ThreadHandler 2024-09-23T15:26:03.324Z,1727105163.324 [DATMMP ThreadHandler](INFO): Thread cancelled. 2024-09-23T15:26:03.324Z,1727105163.324 [DATMMP](INFO): Join timeout helper Thread ID is 4796 2024-09-23T15:26:03.408Z,1727105163.408 [DATMMP](INFO): Stop 2024-09-23T15:26:03.408Z,1727105163.408 [DATMMP](INFO): uninitialize 2024-09-23T15:26:03.408Z,1727105163.408 [DATMMP](INFO): Powering down 2024-09-23T15:26:03.480Z,1727105163.480 [DATMMP ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-23T15:26:03.481Z,1727105163.481 [DATMMP](INFO): uninitialize 2024-09-23T15:26:03.481Z,1727105163.481 [DATMMP](INFO): Powering down 2024-09-23T15:26:03.482Z,1727105163.482 [DATMMP ThreadHandler](INFO): Thread cancelled. 2024-09-23T15:26:03.489Z,1727105163.489 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-09-23T15:26:03.489Z,1727105163.489 [logger ThreadHandler](INFO): Thread cancelled. 2024-09-23T15:26:03.489Z,1727105163.489 [logger](INFO): Join timeout helper Thread ID is 4797 2024-09-23T15:26:03.544Z,1727105163.544 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-23T15:26:03.544Z,1727105163.544 [logger ThreadHandler](INFO): Thread cancelled. 2024-09-23T15:26:03.549Z,1727105163.549 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-09-23T15:26:03.549Z,1727105163.549 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-09-23T15:26:03.549Z,1727105163.549 [CommandLine](INFO): Join timeout helper Thread ID is 4798 2024-09-23T15:26:03.648Z,1727105163.648 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-23T15:26:03.648Z,1727105163.648 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-09-23T15:26:03.668Z,1727105163.668 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-09-23T15:26:03.669Z,1727105163.669 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-09-23T15:26:03.669Z,1727105163.669 [CommandExec](INFO): Join timeout helper Thread ID is 4799 2024-09-23T15:26:03.670Z,1727105163.670 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-09-23T15:26:03.670Z,1727105163.670 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-09-23T15:26:03.671Z,1727105163.671 [controlThread](INFO): Join timeout helper Thread ID is 4800 2024-09-23T15:26:03.840Z,1727105163.840 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-23T15:26:03.840Z,1727105163.840 [controlThread](DEBUG): Uninitializing ControlThread 2024-09-23T15:26:03.841Z,1727105163.841 [AHRS_M2](INFO): Powering down 2024-09-23T15:26:03.842Z,1727105163.842 [NAL9602](INFO): Powering down 2024-09-23T15:26:03.844Z,1727105163.844 [Sonardyne_Nano](INFO): Powering down 2024-09-23T15:26:03.965Z,1727105163.965 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-09-23T15:26:03.966Z,1727105163.966 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-09-23T15:26:03.966Z,1727105163.966 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-09-23T15:26:03.967Z,1727105163.967 [MissionManager](INFO): Uninitializing Mission Default 2024-09-23T15:26:03.967Z,1727105163.967 [Default] Stopped 2024-09-23T15:26:03.967Z,1727105163.967 [Default](DEBUG): Aggregate::uninitialize Default 2024-09-23T15:26:03.967Z,1727105163.967 [Default:A.Wait] Stopped 2024-09-23T15:26:03.967Z,1727105163.967 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2024-09-23T15:26:03.967Z,1727105163.967 [Default:B.GoToSurface] Stopped 2024-09-23T15:26:03.967Z,1727105163.967 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-09-23T15:26:03.970Z,1727105163.970 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-09-23T15:26:03.971Z,1727105163.971 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-09-23T15:26:03.971Z,1727105163.971 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-09-23T15:26:03.971Z,1727105163.971 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-09-23T15:26:03.971Z,1727105163.971 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-09-23T15:26:03.972Z,1727105163.972 [BuoyancyServo](INFO): Powering down 2024-09-23T15:26:03.984Z,1727105163.984 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-09-23T15:26:03.984Z,1727105163.984 [ElevatorServo](INFO): Powering down 2024-09-23T15:26:03.985Z,1727105163.985 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-09-23T15:26:03.985Z,1727105163.985 [MassServo](INFO): Powering down 2024-09-23T15:26:03.986Z,1727105163.986 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-09-23T15:26:03.986Z,1727105163.986 [RudderServo](INFO): Powering down 2024-09-23T15:26:03.987Z,1727105163.987 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-09-23T15:26:03.987Z,1727105163.987 [ThrusterHE](INFO): Powering down 2024-09-23T15:26:03.987Z,1727105163.987 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-09-23T15:26:03.988Z,1727105163.988 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-09-23T15:26:03.988Z,1727105163.988 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-09-23T15:26:03.988Z,1727105163.988 [CBIT](DEBUG): Powering off loads. 2024-09-23T15:26:03.000Z,1727105164.000 [CBIT](DEBUG): Disabling WDT. 2024-09-23T15:26:04.012Z,1727105164.012 [CBIT](DEBUG): Opening all GF detection circuits. 2024-09-23T15:26:04.013Z,1727105164.013 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-09-23T15:26:04.041Z,1727105164.041 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-09-23T15:26:04.044Z,1727105164.044 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-09-23T15:26:04.049Z,1727105164.049 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-09-23T15:26:04.056Z,1727105164.056 [DATMMP ThreadHandler](INFO): Thread cancelled. 2024-09-23T15:26:04.319Z,1727105164.319 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-09-23T15:26:04.366Z,1727105164.366 [logger ThreadHandler](INFO): Thread cancelled.