2024-09-09T18:09:18.264Z,1725905358.264 [Supervisor](DEBUG): Initializing supervisor. 2024-09-09T18:09:18.269Z,1725905358.269 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-09-09T18:09:18.269Z,1725905358.269 [SyncHandler](INFO): Protected caller Thread ID is 841 2024-09-09T18:09:18.270Z,1725905358.270 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-09-09T18:09:18.270Z,1725905358.270 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-09-09T18:09:18.271Z,1725905358.271 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 842 2024-09-09T18:09:18.275Z,1725905358.275 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-09-09T18:09:18.292Z,1725905358.292 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-09-09T18:09:18.294Z,1725905358.294 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-09-09T18:09:18.294Z,1725905358.294 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 843 2024-09-09T18:09:18.298Z,1725905358.298 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-09-09T18:09:18.299Z,1725905358.299 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-09-09T18:09:18.299Z,1725905358.299 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 844 2024-09-09T18:09:18.301Z,1725905358.301 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-09-09T18:09:18.302Z,1725905358.302 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-09-09T18:09:18.303Z,1725905358.303 [logger ThreadHandler](INFO): Protected caller Thread ID is 845 2024-09-09T18:09:18.306Z,1725905358.306 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-09-09T18:09:18.307Z,1725905358.307 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-09-09T18:09:18.311Z,1725905358.311 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-09-09T18:09:18.420Z,1725905358.420 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-09-09T18:09:18.422Z,1725905358.422 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-09-09T18:09:19.233Z,1725905359.233 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-09-09T18:09:19.234Z,1725905359.234 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-09-09T18:09:19.486Z,1725905359.486 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-09-09T18:09:19.488Z,1725905359.488 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-09-09T18:09:19.580Z,1725905359.580 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-09-09T18:09:19.726Z,1725905359.726 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-09-09T18:09:19.727Z,1725905359.727 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-09-09T18:09:19.822Z,1725905359.822 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-09-09T18:09:19.943Z,1725905359.943 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-09-09T18:09:19.943Z,1725905359.943 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-09-09T18:09:20.375Z,1725905360.375 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-09-09T18:09:20.377Z,1725905360.377 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-09-09T18:09:20.948Z,1725905360.948 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-09-09T18:09:20.950Z,1725905360.950 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-09-09T18:09:21.190Z,1725905361.190 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-09-09T18:09:21.192Z,1725905361.192 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-09-09T18:09:21.398Z,1725905361.398 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-09-09T18:09:21.400Z,1725905361.400 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-09-09T18:09:21.978Z,1725905361.978 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-09-09T18:09:22.466Z,1725905362.466 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-09-09T18:09:22.821Z,1725905362.821 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-09-09T18:09:22.823Z,1725905362.823 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-09-09T18:09:23.074Z,1725905363.074 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-09-09T18:09:23.076Z,1725905363.076 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-09-09T18:09:23.481Z,1725905363.481 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-09-09T18:09:23.482Z,1725905363.482 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-09-09T18:09:23.866Z,1725905363.866 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-09-09T18:09:23.868Z,1725905363.868 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/ 2024-09-09T18:09:23.870Z,1725905363.870 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg 2024-09-09T18:09:23.967Z,1725905363.967 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg 2024-09-09T18:09:24.154Z,1725905364.154 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Dock.cfg 2024-09-09T18:09:24.303Z,1725905364.303 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/workSite.cfg 2024-09-09T18:09:24.411Z,1725905364.411 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg 2024-09-09T18:09:24.532Z,1725905364.532 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg 2024-09-09T18:09:24.630Z,1725905364.630 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg 2024-09-09T18:09:24.738Z,1725905364.738 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg 2024-09-09T18:09:24.864Z,1725905364.864 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg 2024-09-09T18:09:25.147Z,1725905365.147 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-09-09T18:09:25.148Z,1725905365.148 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg 2024-09-09T18:09:25.255Z,1725905365.255 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg 2024-09-09T18:09:25.361Z,1725905365.361 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg 2024-09-09T18:09:25.518Z,1725905365.518 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg 2024-09-09T18:09:25.630Z,1725905365.630 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2024-09-09T18:09:25.644Z,1725905365.644 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-09-09T18:09:25.794Z,1725905365.794 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-09-09T18:09:25.795Z,1725905365.795 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-09-09T18:09:25.870Z,1725905365.870 [VerticalControl](DEBUG): Construct VerticalControl. 2024-09-09T18:09:25.931Z,1725905365.931 [VerticalControl] Loaded 2024-09-09T18:09:25.931Z,1725905365.931 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-09-09T18:09:25.934Z,1725905365.934 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-09-09T18:09:25.982Z,1725905365.982 [HorizontalControl] Loaded 2024-09-09T18:09:25.983Z,1725905365.983 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-09-09T18:09:25.985Z,1725905365.985 [SpeedControl](DEBUG): Construct SpeedControl. 2024-09-09T18:09:25.988Z,1725905365.988 [SpeedControl] Loaded 2024-09-09T18:09:25.988Z,1725905365.988 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-09-09T18:09:25.991Z,1725905365.991 [LoopControl](DEBUG): Construct LoopControl. 2024-09-09T18:09:25.992Z,1725905365.992 [LoopControl] Loaded 2024-09-09T18:09:25.992Z,1725905365.992 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-09-09T18:09:25.992Z,1725905365.992 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-09-09T18:09:25.993Z,1725905365.993 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-09-09T18:09:26.065Z,1725905366.065 [DepthRateCalculator] Loaded 2024-09-09T18:09:26.065Z,1725905366.065 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-09-09T18:09:26.070Z,1725905366.070 [PitchRateCalculator] Loaded 2024-09-09T18:09:26.071Z,1725905366.071 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-09-09T18:09:26.081Z,1725905366.081 [SpeedCalculator] Loaded 2024-09-09T18:09:26.081Z,1725905366.081 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-09-09T18:09:26.086Z,1725905366.086 [YawRateCalculator] Loaded 2024-09-09T18:09:26.086Z,1725905366.086 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-09-09T18:09:26.147Z,1725905366.147 [ElevatorOffsetCalculator] Loaded 2024-09-09T18:09:26.148Z,1725905366.148 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-09-09T18:09:26.148Z,1725905366.148 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-09-09T18:09:26.150Z,1725905366.150 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-09-09T18:09:26.194Z,1725905366.194 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-09-09T18:09:26.194Z,1725905366.194 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-09-09T18:09:26.297Z,1725905366.297 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-09-09T18:09:26.298Z,1725905366.298 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-09-09T18:09:26.720Z,1725905366.720 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-09-09T18:09:26.721Z,1725905366.721 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-09-09T18:09:26.948Z,1725905366.948 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-09-09T18:09:26.948Z,1725905366.948 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-09-09T18:09:28.604Z,1725905368.604 [AHRS_M2] Loaded 2024-09-09T18:09:28.604Z,1725905368.604 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-09-09T18:09:28.858Z,1725905368.858 [BackseatComponent] Loaded 2024-09-09T18:09:28.858Z,1725905368.858 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-09-09T18:09:28.859Z,1725905368.859 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409DD4E0 2024-09-09T18:09:28.860Z,1725905368.860 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 934 2024-09-09T18:09:28.863Z,1725905368.863 [LcmUniversalReporter] Loaded 2024-09-09T18:09:28.863Z,1725905368.863 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-09-09T18:09:29.704Z,1725905369.704 [BPC1] Loaded 2024-09-09T18:09:29.704Z,1725905369.704 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-09-09T18:09:29.791Z,1725905369.791 [DATMMP] Loaded 2024-09-09T18:09:29.792Z,1725905369.792 [ComponentRegistry](DEBUG): Component "DATMMP" handled in its own thread. 2024-09-09T18:09:29.793Z,1725905369.793 [DATMMP ThreadHandler](DEBUG): Created PCaller Thread at 40A0E4E0 2024-09-09T18:09:29.793Z,1725905369.793 [DATMMP ThreadHandler](INFO): Protected caller Thread ID is 935 2024-09-09T18:09:29.937Z,1725905369.937 [DataOverHttps] Loaded 2024-09-09T18:09:29.937Z,1725905369.937 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-09-09T18:09:29.938Z,1725905369.938 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40A3E4E0 2024-09-09T18:09:29.939Z,1725905369.939 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 936 2024-09-09T18:09:29.962Z,1725905369.962 [Depth_Keller] Loaded 2024-09-09T18:09:29.963Z,1725905369.963 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-09-09T18:09:30.029Z,1725905370.029 [NAL9602] Loaded 2024-09-09T18:09:30.029Z,1725905370.029 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-09-09T18:09:30.059Z,1725905370.059 [Onboard] Loaded 2024-09-09T18:09:30.060Z,1725905370.060 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-09-09T18:09:30.061Z,1725905370.061 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A6E4E0 2024-09-09T18:09:30.061Z,1725905370.061 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 937 2024-09-09T18:09:30.075Z,1725905370.075 [Power24vConverter] Loaded 2024-09-09T18:09:30.076Z,1725905370.076 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-09-09T18:09:30.091Z,1725905370.091 [Radio_Surface] Loaded 2024-09-09T18:09:30.091Z,1725905370.091 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-09-09T18:09:30.092Z,1725905370.092 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A9E4E0 2024-09-09T18:09:30.092Z,1725905370.092 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 938 2024-09-09T18:09:30.141Z,1725905370.141 [RDI_Pathfinder] Loaded 2024-09-09T18:09:30.141Z,1725905370.141 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread. 2024-09-09T18:09:30.156Z,1725905370.156 [Sonardyne_Nano] Loaded 2024-09-09T18:09:30.157Z,1725905370.157 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-09-09T18:09:30.157Z,1725905370.157 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-09-09T18:09:30.158Z,1725905370.158 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-09-09T18:09:30.300Z,1725905370.300 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-09-09T18:09:30.301Z,1725905370.301 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-09-09T18:09:30.315Z,1725905370.315 [NavChart] Loaded 2024-09-09T18:09:30.315Z,1725905370.315 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-09-09T18:09:30.321Z,1725905370.321 [UniversalFixResidualReporter] Loaded 2024-09-09T18:09:30.321Z,1725905370.321 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-09-09T18:09:30.321Z,1725905370.321 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-09-09T18:09:30.322Z,1725905370.322 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-09-09T18:09:30.503Z,1725905370.503 [SBIT](DEBUG): Construct Startup Built In Test. 2024-09-09T18:09:30.512Z,1725905370.512 [SBIT] Loaded 2024-09-09T18:09:30.512Z,1725905370.512 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-09-09T18:09:30.515Z,1725905370.515 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-09-09T18:09:30.528Z,1725905370.528 [IBIT] Loaded 2024-09-09T18:09:30.528Z,1725905370.528 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-09-09T18:09:30.534Z,1725905370.534 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-09-09T18:09:30.643Z,1725905370.643 [CBIT] Loaded 2024-09-09T18:09:30.643Z,1725905370.643 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-09-09T18:09:30.643Z,1725905370.643 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-09-09T18:09:30.644Z,1725905370.644 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-09-09T18:09:30.817Z,1725905370.817 [BuoyancyServo] Loaded 2024-09-09T18:09:30.818Z,1725905370.818 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-09-09T18:09:30.841Z,1725905370.841 [ElevatorServo] Loaded 2024-09-09T18:09:30.842Z,1725905370.842 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-09-09T18:09:30.864Z,1725905370.864 [MassServo] Loaded 2024-09-09T18:09:30.864Z,1725905370.864 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-09-09T18:09:30.885Z,1725905370.885 [RudderServo] Loaded 2024-09-09T18:09:30.885Z,1725905370.885 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-09-09T18:09:30.904Z,1725905370.904 [ThrusterServo] Loaded 2024-09-09T18:09:30.905Z,1725905370.905 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2024-09-09T18:09:30.905Z,1725905370.905 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-09-09T18:09:30.906Z,1725905370.906 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-09-09T18:09:30.922Z,1725905370.922 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-09-09T18:09:30.923Z,1725905370.923 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-09-09T18:09:31.159Z,1725905371.159 [CTD_Seabird] Loaded 2024-09-09T18:09:31.159Z,1725905371.159 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-09-09T18:09:31.161Z,1725905371.161 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40BF24E0 2024-09-09T18:09:31.161Z,1725905371.161 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 939 2024-09-09T18:09:31.184Z,1725905371.184 [PAR_Licor] Loaded 2024-09-09T18:09:31.185Z,1725905371.185 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-09-09T18:09:31.230Z,1725905371.230 [WetLabsBB2FL] Loaded 2024-09-09T18:09:31.231Z,1725905371.231 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-09-09T18:09:31.232Z,1725905371.232 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40C224E0 2024-09-09T18:09:31.232Z,1725905371.232 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 940 2024-09-09T18:09:31.254Z,1725905371.254 [WetLabsUBAT] Loaded 2024-09-09T18:09:31.254Z,1725905371.254 [ComponentRegistry](DEBUG): Component "WetLabsUBAT" handled in its own thread. 2024-09-09T18:09:31.255Z,1725905371.255 [WetLabsUBAT ThreadHandler](DEBUG): Created PCaller Thread at 40C524E0 2024-09-09T18:09:31.256Z,1725905371.256 [WetLabsUBAT ThreadHandler](INFO): Protected caller Thread ID is 941 2024-09-09T18:09:31.256Z,1725905371.256 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-09-09T18:09:31.263Z,1725905371.263 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-09-09T18:09:31.265Z,1725905371.265 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-09-09T18:09:31.277Z,1725905371.277 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-09-09T18:09:31.278Z,1725905371.278 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C824E0 2024-09-09T18:09:31.278Z,1725905371.278 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 942 2024-09-09T18:09:31.282Z,1725905371.282 [Supervisor](INFO): Main Thread ID is 832 2024-09-09T18:09:31.282Z,1725905371.282 [Supervisor](DEBUG): Running supervisor. 2024-09-09T18:09:31.283Z,1725905371.283 [CommandExec ThreadHandler](INFO): Handler Thread ID is 943 2024-09-09T18:09:31.284Z,1725905371.284 [CommandExec](INFO): Initializing the command executive. 2024-09-09T18:09:31.285Z,1725905371.285 [CommandLine ThreadHandler](INFO): Handler Thread ID is 944 2024-09-09T18:09:31.287Z,1725905371.287 [controlThread ThreadHandler](INFO): Handler Thread ID is 945 2024-09-09T18:09:31.287Z,1725905371.287 [controlThread](DEBUG): Initializing ControlThread 2024-09-09T18:09:31.288Z,1725905371.288 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-09-09T18:09:31.290Z,1725905371.290 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-09-09T18:09:31.291Z,1725905371.291 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-09-09T18:09:31.292Z,1725905371.292 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-09-09T18:09:31.292Z,1725905371.292 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-09-09T18:09:31.292Z,1725905371.292 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-09-09T18:09:31.293Z,1725905371.293 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-09-09T18:09:31.293Z,1725905371.293 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-09-09T18:09:31.293Z,1725905371.293 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-09-09T18:09:31.298Z,1725905371.298 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-09-09T18:09:31.299Z,1725905371.299 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-09-09T18:09:31.299Z,1725905371.299 [SBIT](INFO): Initialize SBIT Component. 2024-09-09T18:09:31.299Z,1725905371.299 [SBIT](IMPORTANT): git: 2024-09-05 2024-09-09T18:09:31.300Z,1725905371.300 [SBIT](INFO): git hash: dce0dc62070cf863068ea7da7140e449252762ed 2024-09-09T18:09:31.300Z,1725905371.300 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-09-09T18:09:31.301Z,1725905371.301 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2024-09-09T18:09:31.302Z,1725905371.302 [SBIT](INFO): Beginning SBIT in 116.000000 seconds. 2024-09-09T18:09:31.303Z,1725905371.303 [IBIT](INFO): Initialize IBIT Component. 2024-09-09T18:09:31.303Z,1725905371.303 [CBIT](DEBUG): Initialize CBIT Component. 2024-09-09T18:09:31.304Z,1725905371.304 [logger ThreadHandler](INFO): Handler Thread ID is 946 2024-09-09T18:09:31.317Z,1725905371.317 [CBIT](DEBUG): Initialized mux pins. 2024-09-09T18:09:31.317Z,1725905371.317 [CBIT](DEBUG): Initializing the watchdog timer. 2024-09-09T18:09:31.321Z,1725905371.321 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 947 2024-09-09T18:09:31.330Z,1725905371.330 [DATMMP ThreadHandler](INFO): Handler Thread ID is 948 2024-09-09T18:09:31.330Z,1725905371.330 [DATMMP](INFO): Start 2024-09-09T18:09:31.330Z,1725905371.330 [DATMMP](INFO): Powering up 2024-09-09T18:09:31.331Z,1725905371.331 [DATMMP](DEBUG): Initializing DATMMP. 2024-09-09T18:09:31.334Z,1725905371.334 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 950 2024-09-09T18:09:31.336Z,1725905371.336 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-09-09T18:09:31.341Z,1725905371.341 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-09-09T18:09:31.341Z,1725905371.341 [CBIT](DEBUG): Initializing heartbeat. 2024-09-09T18:09:31.349Z,1725905371.349 [Onboard ThreadHandler](INFO): Handler Thread ID is 951 2024-09-09T18:09:31.367Z,1725905371.367 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 952 2024-09-09T18:09:31.397Z,1725905371.397 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 953 2024-09-09T18:09:31.398Z,1725905371.398 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-09-09T18:09:31.405Z,1725905371.405 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 955 2024-09-09T18:09:31.409Z,1725905371.409 [WetLabsBB2FL](INFO): Powering up 2024-09-09T18:09:31.411Z,1725905371.411 [WetLabsUBAT ThreadHandler](INFO): Handler Thread ID is 957 2024-09-09T18:09:31.413Z,1725905371.413 [CBIT](DEBUG): Deactivating GF circuits. 2024-09-09T18:09:31.413Z,1725905371.413 [CBIT](DEBUG): Deactivating emergency mode. 2024-09-09T18:09:31.414Z,1725905371.414 [WetLabsUBAT](INFO): Powering up 2024-09-09T18:09:31.415Z,1725905371.415 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 959 2024-09-09T18:09:31.426Z,1725905371.426 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2024-09-09T18:09:31.426Z,1725905371.426 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2024-09-09T18:09:31.426Z,1725905371.426 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2024-09-09T18:09:31.427Z,1725905371.427 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2024-09-09T18:09:31.427Z,1725905371.427 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2024-09-09T18:09:31.427Z,1725905371.427 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2024-09-09T18:09:31.427Z,1725905371.427 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2024-09-09T18:09:31.427Z,1725905371.427 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2024-09-09T18:09:31.453Z,1725905371.453 [CBIT](DEBUG): Backplane powered. 2024-09-09T18:09:31.458Z,1725905371.458 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-09-09T18:09:31.458Z,1725905371.458 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-09-09T18:09:31.459Z,1725905371.459 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2024-09-09T18:09:31.470Z,1725905371.470 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2024-09-09T18:09:31.532Z,1725905371.532 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2024-09-09T18:09:31.553Z,1725905371.553 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-09-09T18:09:31.581Z,1725905371.581 [DATMMP](INFO): Starting 2024-09-09T18:09:31.601Z,1725905371.601 [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-09T18:09:31.602Z,1725905371.602 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-09-09T18:09:31.602Z,1725905371.602 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2024-09-09T18:09:31.605Z,1725905371.605 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2024-09-09T18:09:31.773Z,1725905371.773 [Radio_Surface](INFO): Powering up 2024-09-09T18:09:31.833Z,1725905371.833 [DATMMP](INFO): Starting 2024-09-09T18:09:31.881Z,1725905371.881 [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-09T18:09:31.907Z,1725905371.907 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-09-09T18:09:31.908Z,1725905371.908 [Default:A.Wait](DEBUG): Construct Wait. 2024-09-09T18:09:31.918Z,1725905371.918 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-09-09T18:09:31.956Z,1725905371.956 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-09-09T18:09:31.966Z,1725905371.966 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-09-09T18:09:31.980Z,1725905371.980 [Default:E.Execute](DEBUG): Construct Execute. 2024-09-09T18:09:31.987Z,1725905371.987 [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-09T18:09:31.992Z,1725905371.992 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,Power24vConverter,RDI_Pathfinder,Sonardyne_Nano,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-09-09T18:09:32.018Z,1725905372.018 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-09-09T18:09:32.085Z,1725905372.085 [DATMMP](INFO): Starting 2024-09-09T18:09:32.171Z,1725905372.171 [Depth_Keller](ERROR): Pressure or depth reading out of range: -1.000394 decibar, -0.993022 m 2024-09-09T18:09:32.171Z,1725905372.171 [Power24vConverter](INFO): Powering up. 2024-09-09T18:09:32.172Z,1725905372.172 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format 2024-09-09T18:09:32.182Z,1725905372.182 [Sonardyne_Nano](INFO): Initializing. 2024-09-09T18:09:32.233Z,1725905372.233 [DepthRateCalculator](ERROR): Depth measurement is not active 2024-09-09T18:09:32.259Z,1725905372.259 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-09-09T18:09:32.265Z,1725905372.265 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-09-09T18:09:32.266Z,1725905372.266 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-09-09T18:09:32.273Z,1725905372.273 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-09-09T18:09:32.274Z,1725905372.274 [MassServo](DEBUG): Initializing EZServoServo. 2024-09-09T18:09:32.281Z,1725905372.281 [MassServo](DEBUG): Initializing MassServo. 2024-09-09T18:09:32.282Z,1725905372.282 [RudderServo](DEBUG): Initializing EZServoServo. 2024-09-09T18:09:32.290Z,1725905372.290 [RudderServo](DEBUG): Initializing RudderServo. 2024-09-09T18:09:32.291Z,1725905372.291 [ThrusterServo](DEBUG): Initializing EZServoServo. 2024-09-09T18:09:32.297Z,1725905372.297 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2024-09-09T18:09:32.337Z,1725905372.337 [DATMMP](INFO): Starting 2024-09-09T18:09:32.589Z,1725905372.589 [DATMMP](INFO): Starting 2024-09-09T18:09:32.841Z,1725905372.841 [DATMMP](INFO): Starting 2024-09-09T18:09:33.093Z,1725905373.093 [DATMMP](INFO): Starting 2024-09-09T18:09:33.345Z,1725905373.345 [DATMMP](INFO): Starting 2024-09-09T18:09:33.597Z,1725905373.597 [DATMMP](INFO): Starting 2024-09-09T18:09:33.849Z,1725905373.849 [DATMMP](INFO): Starting 2024-09-09T18:09:34.025Z,1725905374.025 [WetLabsBB2FL](INFO): Powering down 2024-09-09T18:09:34.101Z,1725905374.101 [DATMMP](INFO): Starting 2024-09-09T18:09:34.353Z,1725905374.353 [DATMMP](INFO): Starting 2024-09-09T18:09:34.428Z,1725905374.428 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2024-09-09T18:09:34.605Z,1725905374.605 [DATMMP](INFO): Starting 2024-09-09T18:09:34.857Z,1725905374.857 [DATMMP](INFO): Starting 2024-09-09T18:09:35.109Z,1725905375.109 [DATMMP](INFO): Starting 2024-09-09T18:09:35.361Z,1725905375.361 [DATMMP](INFO): Starting 2024-09-09T18:09:35.613Z,1725905375.613 [DATMMP](INFO): Starting 2024-09-09T18:09:35.671Z,1725905375.671 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2103 2024-09-09T18:09:35.865Z,1725905375.865 [DATMMP](INFO): Starting 2024-09-09T18:09:36.077Z,1725905376.077 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2024-09-09T18:09:36.118Z,1725905376.118 [DATMMP](INFO): Starting 2024-09-09T18:09:36.372Z,1725905376.372 [DATMMP](INFO): Starting 2024-09-09T18:09:36.622Z,1725905376.622 [DATMMP](INFO): Starting 2024-09-09T18:09:36.873Z,1725905376.873 [DATMMP](INFO): Starting 2024-09-09T18:09:37.125Z,1725905377.125 [DATMMP](INFO): Starting 2024-09-09T18:09:37.377Z,1725905377.377 [DATMMP](INFO): Starting 2024-09-09T18:09:37.629Z,1725905377.629 [DATMMP](INFO): Starting 2024-09-09T18:09:37.881Z,1725905377.881 [DATMMP](INFO): Starting 2024-09-09T18:09:38.133Z,1725905378.133 [DATMMP](INFO): Starting 2024-09-09T18:09:38.385Z,1725905378.385 [DATMMP](INFO): Starting 2024-09-09T18:09:38.637Z,1725905378.637 [DATMMP](INFO): Starting 2024-09-09T18:09:38.889Z,1725905378.889 [DATMMP](INFO): Starting 2024-09-09T18:09:39.141Z,1725905379.141 [DATMMP](INFO): Starting 2024-09-09T18:09:39.394Z,1725905379.394 [DATMMP](INFO): Starting 2024-09-09T18:09:39.645Z,1725905379.645 [DATMMP](INFO): Starting 2024-09-09T18:09:39.898Z,1725905379.898 [DATMMP](INFO): Starting 2024-09-09T18:09:40.149Z,1725905380.149 [DATMMP](INFO): Starting 2024-09-09T18:09:40.401Z,1725905380.401 [DATMMP](INFO): Starting 2024-09-09T18:09:40.653Z,1725905380.653 [DATMMP](INFO): Starting 2024-09-09T18:09:40.713Z,1725905380.713 [WetLabsUBAT](INFO): Powering down 2024-09-09T18:09:40.905Z,1725905380.905 [DATMMP](INFO): Starting 2024-09-09T18:09:41.157Z,1725905381.157 [DATMMP](INFO): Starting 2024-09-09T18:09:41.409Z,1725905381.409 [DATMMP](INFO): Starting 2024-09-09T18:09:41.661Z,1725905381.661 [DATMMP](INFO): Starting 2024-09-09T18:09:41.913Z,1725905381.913 [DATMMP](INFO): Starting 2024-09-09T18:09:42.165Z,1725905382.165 [DATMMP](INFO): Starting 2024-09-09T18:09:42.417Z,1725905382.417 [DATMMP](INFO): Starting 2024-09-09T18:09:42.669Z,1725905382.669 [DATMMP](INFO): Starting 2024-09-09T18:09:42.921Z,1725905382.921 [DATMMP](INFO): Starting 2024-09-09T18:09:43.173Z,1725905383.173 [DATMMP](INFO): Starting 2024-09-09T18:09:43.425Z,1725905383.425 [DATMMP](INFO): Starting 2024-09-09T18:09:43.677Z,1725905383.677 [DATMMP](INFO): Starting 2024-09-09T18:09:43.929Z,1725905383.929 [DATMMP](INFO): Starting 2024-09-09T18:09:44.181Z,1725905384.181 [DATMMP](INFO): Starting 2024-09-09T18:09:44.433Z,1725905384.433 [DATMMP](INFO): Starting 2024-09-09T18:09:44.685Z,1725905384.685 [DATMMP](INFO): Starting 2024-09-09T18:09:44.937Z,1725905384.937 [DATMMP](INFO): Starting 2024-09-09T18:09:44.938Z,1725905384.938 [DATMMP](INFO): DAT read: 2024-09-09T18:09:44.938Z,1725905384.938 [DATMMP](INFO): DAT read: Teledyne Benthos DAT-900 Series 2024-09-09T18:09:45.189Z,1725905385.189 [DATMMP](INFO): Starting 2024-09-09T18:09:45.441Z,1725905385.441 [DATMMP](INFO): Starting 2024-09-09T18:09:45.693Z,1725905385.693 [DATMMP](INFO): Starting 2024-09-09T18:09:45.949Z,1725905385.949 [DATMMP](INFO): Starting 2024-09-09T18:09:46.197Z,1725905386.197 [DATMMP](INFO): Starting 2024-09-09T18:09:46.449Z,1725905386.449 [DATMMP](INFO): Starting 2024-09-09T18:09:46.701Z,1725905386.701 [DATMMP](INFO): Starting 2024-09-09T18:09:46.702Z,1725905386.702 [DATMMP](INFO): DAT read: MF Frequency Band 2024-09-09T18:09:46.703Z,1725905386.703 [DATMMP](INFO): DAT read: Directional Acoustic Transponder version 8.17.2 2024-09-09T18:09:46.703Z,1725905386.703 [DATMMP](INFO): DAT read: Aug 9 2000 18:08:41 2024-09-09T18:09:46.953Z,1725905386.953 [DATMMP](INFO): Starting 2024-09-09T18:09:47.206Z,1725905387.206 [DATMMP](INFO): Starting 2024-09-09T18:09:47.457Z,1725905387.457 [DATMMP](INFO): Starting 2024-09-09T18:09:47.709Z,1725905387.709 [DATMMP](INFO): Starting 2024-09-09T18:09:47.710Z,1725905387.710 [DATMMP](INFO): DAT read: Features enabled [Bearing] 2024-09-09T18:09:47.711Z,1725905387.711 [DATMMP](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2024-09-09T18:09:47.711Z,1725905387.711 [DATMMP](INFO): commRate: 800 2024-09-09T18:09:47.961Z,1725905387.961 [DATMMP](INFO): Starting 2024-09-09T18:09:48.213Z,1725905388.213 [DATMMP](INFO): Starting 2024-09-09T18:09:48.465Z,1725905388.465 [DATMMP](INFO): Starting 2024-09-09T18:09:48.717Z,1725905388.717 [DATMMP](INFO): Starting 2024-09-09T18:09:48.969Z,1725905388.969 [DATMMP](INFO): Starting 2024-09-09T18:09:49.221Z,1725905389.221 [DATMMP](INFO): Starting 2024-09-09T18:09:49.473Z,1725905389.473 [DATMMP](INFO): Starting 2024-09-09T18:09:49.726Z,1725905389.726 [DATMMP](INFO): Starting 2024-09-09T18:09:49.778Z,1725905389.778 [DATMMP](INFO): entering command mode 2024-09-09T18:09:49.977Z,1725905389.977 [DATMMP](INFO): Starting 2024-09-09T18:09:49.977Z,1725905389.977 [DATMMP](INFO): DAT read: 2024-09-09T18:09:49.978Z,1725905389.978 [DATMMP](INFO): DAT read: user:1> 2024-09-09T18:09:49.978Z,1725905389.978 [DATMMP](DEBUG): read user prompt 1: user:1> 2024-09-09T18:09:49.978Z,1725905389.978 [DATMMP](INFO): entering MMP mode 2024-09-09T18:09:50.229Z,1725905390.229 [DATMMP](INFO): Starting 2024-09-09T18:09:50.230Z,1725905390.230 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-09T18:09:50.232Z,1725905390.232 [DATMMP](INFO): status rx: x1 2024-09-09T18:09:50.233Z,1725905390.233 [DATMMP](INFO): MMP status: 1: started 2024-09-09T18:09:50.233Z,1725905390.233 [DATMMP](INFO): Received message type: status 2024-09-09T18:09:50.234Z,1725905390.234 [DATMMP](INFO): Handled 2024-09-09T18:09:50.481Z,1725905390.481 [DATMMP](INFO): Starting 2024-09-09T18:09:50.489Z,1725905390.489 [DATMMP](INFO): Sent Tx Power Config 8 2024-09-09T18:09:50.489Z,1725905390.489 [DATMMP](INFO): Setting local address: 10 2024-09-09T18:09:50.491Z,1725905390.491 [DATMMP](INFO): Setting time to: 18:9:50 And date to:9/9/2024 2024-09-09T18:09:50.733Z,1725905390.733 [DATMMP](INFO): Starting 2024-09-09T18:09:50.734Z,1725905390.734 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-09T18:09:50.734Z,1725905390.734 [DATMMP](INFO): mdmpower rx: x8 x0 x5 x0 2024-09-09T18:09:50.735Z,1725905390.735 [DATMMP](INFO): Received message type: mdmpower 2024-09-09T18:09:50.735Z,1725905390.735 [DATMMP](INFO): Handled 2024-09-09T18:09:50.985Z,1725905390.985 [DATMMP](INFO): Starting 2024-09-09T18:09:50.985Z,1725905390.985 [DATMMP](INFO): GSXN notify for xid: 10 2024-09-09T18:09:50.986Z,1725905390.986 [DATMMP](INFO): sreg_txpower rx: x8 2024-09-09T18:09:50.986Z,1725905390.986 [DATMMP](INFO): Received message type: sreg_txpower 2024-09-09T18:09:50.986Z,1725905390.986 [DATMMP](INFO): Match for : sreg_txpower 2024-09-09T18:09:50.987Z,1725905390.987 [DATMMP](INFO): ACK 2024-09-09T18:09:51.237Z,1725905391.237 [DATMMP](INFO): Starting 2024-09-09T18:09:51.237Z,1725905391.237 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-09T18:09:51.238Z,1725905391.238 [DATMMP](INFO): mdmlocal rx: xA x0 x0 x0 2024-09-09T18:09:51.238Z,1725905391.238 [DATMMP](INFO): Received message type: mdmlocal 2024-09-09T18:09:51.239Z,1725905391.239 [DATMMP](INFO): Handled 2024-09-09T18:09:51.489Z,1725905391.489 [DATMMP](INFO): Starting 2024-09-09T18:09:51.490Z,1725905391.490 [DATMMP](INFO): GSXN notify for xid: 11 2024-09-09T18:09:51.490Z,1725905391.490 [DATMMP](INFO): sreg_locaddr rx: xA 2024-09-09T18:09:51.490Z,1725905391.490 [DATMMP](INFO): Received message type: sreg_locaddr 2024-09-09T18:09:51.491Z,1725905391.491 [DATMMP](INFO): Match for : sreg_locaddr 2024-09-09T18:09:51.491Z,1725905391.491 [DATMMP](INFO): ACK 2024-09-09T18:09:51.741Z,1725905391.741 [DATMMP](INFO): Starting 2024-09-09T18:09:51.742Z,1725905391.742 [DATMMP](INFO): GSXN notify for xid: 12 2024-09-09T18:09:51.743Z,1725905391.743 [DATMMP](INFO): timedate rx: x0 x12 x9 x32 x8 x9 x7C x0 2024-09-09T18:09:51.743Z,1725905391.743 [DATMMP](INFO): Received message type: timedate 2024-09-09T18:09:51.743Z,1725905391.743 [DATMMP](INFO): Match for : timedate 2024-09-09T18:09:51.743Z,1725905391.743 [DATMMP](INFO): ACK 2024-09-09T18:09:51.993Z,1725905391.993 [DATMMP](INFO): Starting 2024-09-09T18:09:51.994Z,1725905391.994 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-09T18:09:51.994Z,1725905391.994 [DATMMP](INFO): sys_verb rx: x0 x0 x0 x0 2024-09-09T18:09:51.995Z,1725905391.995 [DATMMP](INFO): Received message type: sys_verb 2024-09-09T18:09:51.995Z,1725905391.995 [DATMMP](INFO): Handled 2024-09-09T18:09:52.245Z,1725905392.245 [DATMMP](INFO): Starting 2024-09-09T18:09:52.246Z,1725905392.246 [DATMMP](INFO): GSXN notify for xid: 13 2024-09-09T18:09:52.247Z,1725905392.247 [DATMMP](INFO): sreg_verbosity rx: x0 2024-09-09T18:09:52.247Z,1725905392.247 [DATMMP](INFO): Received message type: sreg_verbosity 2024-09-09T18:09:52.247Z,1725905392.247 [DATMMP](INFO): Match for : sreg_verbosity 2024-09-09T18:09:52.247Z,1725905392.247 [DATMMP](INFO): ACK 2024-09-09T18:09:52.497Z,1725905392.497 [DATMMP](INFO): Starting 2024-09-09T18:09:52.497Z,1725905392.497 [DATMMP](INFO): GSXN notify for xid: 14 2024-09-09T18:09:52.498Z,1725905392.498 [DATMMP](INFO): version rx: x2 x5 2024-09-09T18:09:52.498Z,1725905392.498 [DATMMP](INFO): DatMMPVersion: 2.5 2024-09-09T18:09:52.498Z,1725905392.498 [DATMMP](INFO): Received message type: version 2024-09-09T18:09:52.499Z,1725905392.499 [DATMMP](INFO): Match for : version 2024-09-09T18:09:52.499Z,1725905392.499 [DATMMP](INFO): ACK 2024-09-09T18:09:52.499Z,1725905392.499 [DATMMP](INFO): in MMP mode: config complete going to runnable 2024-09-09T18:10:00.282Z,1725905400.282 [NAL9602](INFO): Powering up NAL9602 2024-09-09T18:10:07.113Z,1725905407.113 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-09T18:10:07.114Z,1725905407.114 [DATMMP](INFO): timesync rx: x0 x1 x1 x0 2024-09-09T18:10:07.114Z,1725905407.114 [DATMMP](INFO): Received message type: timesync 2024-09-09T18:10:07.115Z,1725905407.115 [DATMMP](INFO): Handled 2024-09-09T18:10:11.190Z,1725905411.190 [NAL9602](INFO): NAL9602 initialized 2024-09-09T18:10:17.194Z,1725905417.194 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-09T18:10:17.194Z,1725905417.194 [DATMMP](INFO): timesync rx: x1 x0 x1 x0 2024-09-09T18:10:17.195Z,1725905417.195 [DATMMP](INFO): Received message type: timesync 2024-09-09T18:10:17.195Z,1725905417.195 [DATMMP](INFO): Handled 2024-09-09T18:10:38.272Z,1725905438.272 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:10:42.765Z,1725905442.765 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:10:49.242Z,1725905449.242 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:10:53.267Z,1725905453.267 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:10:59.737Z,1725905459.737 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:11:04.179Z,1725905464.179 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:11:11.053Z,1725905471.053 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:11:15.490Z,1725905475.490 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:11:21.556Z,1725905481.556 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:11:26.398Z,1725905486.398 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:11:28.005Z,1725905488.005 [SBIT](IMPORTANT): Beginning Startup BIT 2024-09-09T18:11:28.009Z,1725905488.009 [CBIT](IMPORTANT): Beginning ground fault scan 2024-09-09T18:11:32.464Z,1725905492.464 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:11:37.308Z,1725905497.308 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:11:38.953Z,1725905498.953 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.081185 CHAN A1 (24V): 0.084052 CHAN A2 (12V): 0.029837 CHAN A3 (5V): 0.007940 CHAN B0 (3.3V): 0.005853 CHAN B1 (3.15aV): 0.005137 CHAN B2 (3.15bV): 0.005307 CHAN B3 (GND): -0.003405 OPEN: -0.000541 Full Scale: +/- 1 mA 2024-09-09T18:11:43.367Z,1725905503.367 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:11:48.217Z,1725905508.217 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:11:54.279Z,1725905514.279 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:12:05.184Z,1725905525.184 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:12:06.784Z,1725905526.784 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:12:08.055Z,1725905528.055 [SBIT](FAULT): Rudder: EXPECTED:-15.000000 ACTUAL:-14.799875 2024-09-09T18:12:08.055Z,1725905528.055 [SBIT](FAULT): Control surface position failure. 2024-09-09T18:12:20.552Z,1725905540.552 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005032 2024-09-09T18:12:22.139Z,1725905542.139 [SBIT](CRITICAL): SBIT FAILED 2024-09-09T18:12:22.140Z,1725905542.140 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-09-09T18:12:22.140Z,1725905542.140 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool; 2024-09-09T18:12:22.140Z,1725905542.140 [SBIT](IMPORTANT): DATMMP.loadAtStartup=1 bool; 2024-09-09T18:12:22.141Z,1725905542.141 [SBIT](IMPORTANT): DATMMP.simulateHardware=0 bool; 2024-09-09T18:12:22.145Z,1725905542.145 [SBIT](IMPORTANT): DockingStepper.loadAtStartup=0 bool; 2024-09-09T18:12:22.145Z,1725905542.145 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool; 2024-09-09T18:12:22.145Z,1725905542.145 [SBIT](IMPORTANT): Express linearApproximation DATMMP.acoustic_contact_range 15.000000 meter; 2024-09-09T18:12:22.145Z,1725905542.145 [SBIT](IMPORTANT): Express linearApproximation TrackAcousticContact.range_to_contact 5.000000 meter; 2024-09-09T18:12:22.145Z,1725905542.145 [SBIT](IMPORTANT): Radio_Surface.manageDockNetwork=0 bool; 2024-09-09T18:12:22.146Z,1725905542.146 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=314.8 cubic_centimeter; 2024-09-09T18:12:22.146Z,1725905542.146 [SBIT](IMPORTANT): VerticalControl.massDefault=24.11 millimeter; 2024-09-09T18:12:22.147Z,1725905542.147 [CommandExec](FAULT): Scheduling is paused 2024-09-09T18:12:22.147Z,1725905542.147 [CBIT](INFO): Critical error at 20240909T181222 2024-09-09T18:12:22.148Z,1725905542.148 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2024-09-09T18:12:22.897Z,1725905542.897 [MissionManager](IMPORTANT): Started mission Startup 2024-09-09T18:12:22.898Z,1725905542.898 [Startup] Running Loop=1 2024-09-09T18:12:22.898Z,1725905542.898 [Startup](DEBUG): Aggregate::initialize Startup 2024-09-09T18:12:22.898Z,1725905542.898 [Startup:A.GoToSurface] Running Loop=1 2024-09-09T18:12:22.898Z,1725905542.898 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-09-09T18:12:22.899Z,1725905542.899 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-09-09T18:12:22.899Z,1725905542.899 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-09-09T18:12:22.899Z,1725905542.899 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-09-09T18:12:22.900Z,1725905542.900 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-09-09T18:12:22.900Z,1725905542.900 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-09-09T18:12:22.900Z,1725905542.900 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-09-09T18:12:22.902Z,1725905542.902 [Startup:StartupSatComms] Running Loop=1 2024-09-09T18:12:22.902Z,1725905542.902 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2024-09-09T18:12:22.903Z,1725905542.903 [Startup:StartupSatComms:A] Running Loop=1 2024-09-09T18:12:23.303Z,1725905543.303 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2024-09-09T18:12:31.411Z,1725905551.411 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-09-09T18:12:31.411Z,1725905551.411 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-09-09T18:12:31.444Z,1725905551.444 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-09-09T18:12:31.809Z,1725905551.809 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-09-09T18:12:31.809Z,1725905551.809 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-09-09T18:13:23.081Z,1725905603.081 [Startup:StartupSatComms:A](INFO): Timed out from 2024-09-09T18:12:22.9Z 2024-09-09T18:13:23.081Z,1725905603.081 [Startup:StartupSatComms:A] Stopped 2024-09-09T18:13:23.081Z,1725905603.081 [Startup:StartupSatComms:B] Running Loop=1 2024-09-09T18:13:23.489Z,1725905603.489 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-09-09T18:13:29.167Z,1725905609.167 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240909T175216/Courier0007.lzma 2024-09-09T18:13:30.157Z,1725905610.157 [DataOverHttps](INFO): Moved sent file to Logs/20240909T175216/Courier0007.lzma.bak 2024-09-09T18:13:30.157Z,1725905610.157 [DataOverHttps](INFO): SBD MOMSN=23148282 2024-09-09T18:13:46.271Z,1725905626.271 [DataOverHttps](INFO): Sending 185 bytes from file Logs/20240909T180918/Courier0000.lzma 2024-09-09T18:13:46.387Z,1725905626.387 [CommandExec](IMPORTANT): got command strobe off 2024-09-09T18:13:46.388Z,1725905626.388 [CommandExec](IMPORTANT): Deactivating strobe 2024-09-09T18:13:47.272Z,1725905627.272 [DataOverHttps](INFO): Moved sent file to Logs/20240909T180918/Courier0000.lzma.bak 2024-09-09T18:13:47.272Z,1725905627.272 [DataOverHttps](INFO): SBD MOMSN=23148284 2024-09-09T18:14:03.084Z,1725905643.084 [DataOverHttps](INFO): Sending 507 bytes from file Logs/20240909T175216/Express0008.lzma 2024-09-09T18:14:04.084Z,1725905644.084 [DataOverHttps](INFO): Moved sent file to Logs/20240909T175216/Express0008.lzma.bak 2024-09-09T18:14:04.084Z,1725905644.084 [DataOverHttps](INFO): SBD MOMSN=23148288 2024-09-09T18:14:04.328Z,1725905644.328 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:14:16.814Z,1725905656.814 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:14:20.164Z,1725905660.164 [DataOverHttps](INFO): Sending 1023 bytes from file Logs/20240909T180918/Express0001.lzma 2024-09-09T18:14:21.152Z,1725905661.152 [DataOverHttps](INFO): Moved sent file to Logs/20240909T180918/Express0001.lzma.bak 2024-09-09T18:14:21.152Z,1725905661.152 [DataOverHttps](INFO): SBD MOMSN=23148315 2024-09-09T18:14:22.509Z,1725905662.509 [Startup:StartupSatComms:B] Stopped 2024-09-09T18:14:22.510Z,1725905662.510 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2024-09-09T18:14:22.510Z,1725905662.510 [Startup:StartupSatComms] Stopped 2024-09-09T18:14:22.510Z,1725905662.510 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2024-09-09T18:14:22.511Z,1725905662.511 [Startup](INFO): Completed Startup 2024-09-09T18:14:22.511Z,1725905662.511 [MissionManager](INFO): Startup is completed. 2024-09-09T18:14:22.511Z,1725905662.511 [MissionManager](INFO): Uninitializing Mission Startup 2024-09-09T18:14:22.511Z,1725905662.511 [Startup] Stopped 2024-09-09T18:14:22.512Z,1725905662.512 [Startup](DEBUG): Aggregate::uninitialize Startup 2024-09-09T18:14:22.512Z,1725905662.512 [Startup:A.GoToSurface] Stopped 2024-09-09T18:14:22.512Z,1725905662.512 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-09-09T18:14:22.885Z,1725905662.885 [MissionManager](IMPORTANT): Started mission Default 2024-09-09T18:14:22.886Z,1725905662.886 [Default] Running Loop=1 2024-09-09T18:14:22.886Z,1725905662.886 [Default](DEBUG): Aggregate::initialize Default 2024-09-09T18:14:22.886Z,1725905662.886 [Default:B.GoToSurface] Running Loop=1 2024-09-09T18:14:22.886Z,1725905662.886 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-09-09T18:14:22.886Z,1725905662.886 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-09-09T18:14:22.887Z,1725905662.887 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-09-09T18:14:22.887Z,1725905662.887 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-09-09T18:14:22.887Z,1725905662.887 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-09-09T18:14:22.888Z,1725905662.888 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-09-09T18:14:22.888Z,1725905662.888 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-09-09T18:14:22.888Z,1725905662.888 [Default:A.Wait] Running Loop=1 2024-09-09T18:14:22.888Z,1725905662.888 [Default:A.Wait](DEBUG): Initialize Wait Component. 2024-09-09T18:14:28.231Z,1725905668.231 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:14:34.589Z,1725905674.589 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:14:36.238Z,1725905676.238 [Default:A.Wait](INFO): Done Waiting. 2024-09-09T18:14:36.238Z,1725905676.238 [Default:A.Wait] Stopped 2024-09-09T18:14:36.238Z,1725905676.238 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2024-09-09T18:14:36.629Z,1725905676.629 [Default:CheckIn] Running Loop=1 2024-09-09T18:14:36.630Z,1725905676.630 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-09-09T18:14:36.630Z,1725905676.630 [Default:CheckIn:Read_GPS] Running Loop=1 2024-09-09T18:14:37.047Z,1725905677.047 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2024-09-09T18:14:39.526Z,1725905679.526 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:14:45.957Z,1725905685.957 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:14:49.335Z,1725905689.335 [CommandExec](IMPORTANT): got command maintain control HorizontalControl.rudderAngleAction -15 degree 2024-09-09T18:14:49.339Z,1725905689.339 [ComponentRegistry](DEBUG): SyncComponent "Maintain_HorizontalControl.rudderAngleAction" handled in the control thread. 2024-09-09T18:14:49.566Z,1725905689.566 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,Power24vConverter,RDI_Pathfinder,Sonardyne_Nano,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_HorizontalControl.rudderAngleAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-09-09T18:14:50.396Z,1725905690.396 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:14:56.865Z,1725905696.865 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:15:01.355Z,1725905701.355 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:15:07.770Z,1725905707.770 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:15:12.297Z,1725905712.297 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:15:14.981Z,1725905714.981 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-09-09T18:15:18.683Z,1725905718.683 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:15:23.185Z,1725905723.185 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:15:23.992Z,1725905723.992 [CommandExec](IMPORTANT): got command show variable rudderservo 2024-09-09T18:15:24.051Z,1725905724.051 [CommandExec](IMPORTANT): RudderServo.loadAtStartup (bool) 2024-09-09T18:15:24.051Z,1725905724.051 [CommandExec](IMPORTANT): RudderServo.simulateHardware (bool) 2024-09-09T18:15:24.052Z,1725905724.052 [CommandExec](IMPORTANT): RudderServo.countsPerDeg (count_per_angular_degree) 2024-09-09T18:15:24.052Z,1725905724.052 [CommandExec](IMPORTANT): RudderServo.currLimit (percent) 2024-09-09T18:15:24.052Z,1725905724.052 [CommandExec](IMPORTANT): RudderServo.deviationAngle (angular_degree) 2024-09-09T18:15:24.053Z,1725905724.053 [CommandExec](IMPORTANT): RudderServo.limitHi (count) 2024-09-09T18:15:24.053Z,1725905724.053 [CommandExec](IMPORTANT): RudderServo.limitLo (count) 2024-09-09T18:15:24.053Z,1725905724.053 [CommandExec](IMPORTANT): RudderServo.mtrCenter (count) 2024-09-09T18:15:24.054Z,1725905724.054 [CommandExec](IMPORTANT): RudderServo.offsetAngle (degree) 2024-09-09T18:15:24.054Z,1725905724.054 [CommandExec](IMPORTANT): RudderServo.pidW (count) 2024-09-09T18:15:24.055Z,1725905724.055 [CommandExec](IMPORTANT): RudderServo.pidX (count) 2024-09-09T18:15:24.055Z,1725905724.055 [CommandExec](IMPORTANT): RudderServo.pidY (count) 2024-09-09T18:15:24.055Z,1725905724.055 [CommandExec](IMPORTANT): RudderServo.powerOnTimeout (second) 2024-09-09T18:15:24.150Z,1725905724.150 [CommandExec](IMPORTANT): RudderServo.loadControl (none) 2024-09-09T18:15:24.155Z,1725905724.155 [CommandExec](IMPORTANT): RudderServo.uart (none) 2024-09-09T18:15:24.156Z,1725905724.156 [CommandExec](IMPORTANT): RudderServo.baud (bit_per_second) 2024-09-09T18:15:24.398Z,1725905724.398 [CommandExec](IMPORTANT): RudderServo.enableBroadcast (bool) 2024-09-09T18:15:24.399Z,1725905724.399 [CommandExec](IMPORTANT): RudderServo.component_voltage (volt) 2024-09-09T18:15:24.399Z,1725905724.399 [CommandExec](IMPORTANT): RudderServo.component_avgVoltage (volt) 2024-09-09T18:15:24.400Z,1725905724.400 [CommandExec](IMPORTANT): RudderServo.component_current (milliampere) 2024-09-09T18:15:24.400Z,1725905724.400 [CommandExec](IMPORTANT): RudderServo.component_avgCurrent (milliampere) 2024-09-09T18:15:24.401Z,1725905724.401 [CommandExec](IMPORTANT): RudderServo.component_discreteIn (bool) 2024-09-09T18:15:24.401Z,1725905724.401 [CommandExec](IMPORTANT): RudderServo.platform_rudder_angle (radian) 2024-09-09T18:15:29.600Z,1725905729.600 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:15:32.423Z,1725905732.423 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2024-09-09T18:15:32.423Z,1725905732.423 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-09-09T18:15:32.495Z,1725905732.495 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-09-09T18:15:32.850Z,1725905732.850 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-09-09T18:15:32.850Z,1725905732.850 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2024-09-09T18:15:32.879Z,1725905732.879 [CommandExec](IMPORTANT): got command get RudderServo.offsetAngle 2024-09-09T18:15:32.880Z,1725905732.880 [CommandExec](IMPORTANT): RudderServo.offsetAngle 0.000000 arcdeg 2024-09-09T18:15:34.474Z,1725905734.474 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:15:40.963Z,1725905740.963 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:15:43.477Z,1725905743.477 [CommandExec](IMPORTANT): got command get RudderServo.platform_rudder_angle degree 2024-09-09T18:15:43.477Z,1725905743.477 [CommandExec](IMPORTANT): RudderServo.platform_rudder_angle -14.727295 arcdeg 2024-09-09T18:15:45.348Z,1725905745.348 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:15:52.248Z,1725905752.248 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:15:56.292Z,1725905756.292 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:16:03.529Z,1725905763.529 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:16:05.749Z,1725905765.749 [CommandExec](IMPORTANT): got command maintain control HorizontalControl.rudderAngleAction 0 degree 2024-09-09T18:16:07.179Z,1725905767.179 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:16:14.469Z,1725905774.469 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:16:18.064Z,1725905778.064 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:16:25.340Z,1725905785.340 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:16:28.972Z,1725905788.972 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:16:35.846Z,1725905795.846 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:16:39.882Z,1725905799.882 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:16:47.233Z,1725905807.233 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:16:51.193Z,1725905811.193 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:17:00.477Z,1725905820.477 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:17:02.104Z,1725905822.104 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:17:05.678Z,1725905825.678 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:17:13.046Z,1725905833.046 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:17:17.862Z,1725905837.862 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:17:22.100Z,1725905842.100 [CommandExec](IMPORTANT): got command maintain control HorizontalControl.rudderAngleAction 15 degree 2024-09-09T18:17:24.364Z,1725905844.364 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:17:30.368Z,1725905850.368 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:17:34.897Z,1725905854.897 [CommandExec](IMPORTANT): got command get platform_rudder_angle degree 2024-09-09T18:17:34.898Z,1725905854.898 [CommandExec](IMPORTANT): platform_rudder_angle 14.969231 arcdeg 2024-09-09T18:17:35.632Z,1725905855.632 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:17:42.499Z,1725905862.499 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:17:42.543Z,1725905862.543 [RDI_Pathfinder](ERROR): DVL uart error: serial timeout 2024-09-09T18:17:42.543Z,1725905862.543 [RDI_Pathfinder] Communications Fault, FailCount= 1 2024-09-09T18:17:42.543Z,1725905862.543 [RDI_Pathfinder](ERROR): Communications Fault 2024-09-09T18:17:42.608Z,1725905862.608 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2024-09-09T18:17:42.943Z,1725905862.943 [RDI_Pathfinder](INFO): Powering down 2024-09-09T18:17:43.698Z,1725905863.698 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2024-09-09T18:17:43.698Z,1725905863.698 [RDI_Pathfinder] No Fault, FailCount= 1 2024-09-09T18:17:44.070Z,1725905864.070 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format 2024-09-09T18:17:46.558Z,1725905866.558 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:17:55.477Z,1725905875.477 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:17:57.052Z,1725905877.052 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:18:05.156Z,1725905885.156 [CommandExec](IMPORTANT): got command configSet RudderServo.offsetAngle .2 degree persist 2024-09-09T18:18:05.161Z,1725905885.161 [CommandExec](IMPORTANT): got command failComponent hardware RudderServo 2024-09-09T18:18:05.161Z,1725905885.161 [RudderServo] Hardware Fault, FailCount= 1 2024-09-09T18:18:05.161Z,1725905885.161 [RudderServo](ERROR): Hardware Fault 2024-09-09T18:18:05.161Z,1725905885.161 [CommandExec](IMPORTANT): RudderServo failureMode is Hardware Fault 2024-09-09T18:18:05.537Z,1725905885.537 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-09-09T18:18:05.537Z,1725905885.537 [RudderServo](INFO): Powering down 2024-09-09T18:18:05.542Z,1725905885.542 [CBIT](ERROR): Hardware Fault in component: RudderServo 2024-09-09T18:18:06.329Z,1725905886.329 [CBIT](INFO): Clearing failed state for component RudderServo 2024-09-09T18:18:06.329Z,1725905886.329 [RudderServo] No Fault, FailCount= 1 2024-09-09T18:18:06.706Z,1725905886.706 [RudderServo](DEBUG): Initializing EZServoServo. 2024-09-09T18:18:06.707Z,1725905886.707 [RudderServo](DEBUG): Initializing RudderServo. 2024-09-09T18:18:07.540Z,1725905887.540 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:18:07.614Z,1725905887.614 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:18:18.877Z,1725905898.877 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:18:20.096Z,1725905900.096 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:18:20.780Z,1725905900.780 [CommandExec](IMPORTANT): got command maintain control HorizontalControl.rudderAngleAction 0 degree 2024-09-09T18:18:29.782Z,1725905909.782 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:18:31.377Z,1725905911.377 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:18:33.391Z,1725905913.391 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2024-09-09T18:18:33.391Z,1725905913.391 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-09-09T18:18:33.435Z,1725905913.435 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-09-09T18:18:33.847Z,1725905913.847 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-09-09T18:18:33.847Z,1725905913.847 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2024-09-09T18:18:40.690Z,1725905920.690 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:18:44.308Z,1725905924.308 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:18:51.070Z,1725905931.070 [CommandExec](IMPORTANT): got command maintain control HorizontalControl.rudderAngleAction -15 degree 2024-09-09T18:18:51.596Z,1725905931.596 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:18:56.835Z,1725905936.835 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:19:01.975Z,1725905941.975 [CommandExec](IMPORTANT): got command get platform_rudder_angle 2024-09-09T18:19:01.975Z,1725905941.975 [CommandExec](IMPORTANT): platform_rudder_angle -0.259340 rad 2024-09-09T18:19:02.505Z,1725905942.505 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:19:07.791Z,1725905947.791 [CommandExec](IMPORTANT): got command get platform_rudder_angle degree 2024-09-09T18:19:07.792Z,1725905947.792 [CommandExec](IMPORTANT): platform_rudder_angle -14.856914 arcdeg 2024-09-09T18:19:09.390Z,1725905949.390 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:19:13.449Z,1725905953.449 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:19:21.069Z,1725905961.069 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:19:24.321Z,1725905964.321 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-09T18:19:26.692Z,1725905966.692 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-09T18:19:29.099Z,1725905969.099 [BPC1](ERROR): Failed to receive data from all battery packs. 2024-09-09T18:19:29.099Z,1725905969.099 [BPC1] Communications Fault, FailCount= 1 2024-09-09T18:19:29.099Z,1725905969.099 [BPC1](ERROR): Communications Fault 2024-09-09T18:19:29.214Z,1725905969.214 [CBIT](ERROR): Communications Fault in component: BPC1 2024-09-09T18:19:36.792Z,1725905976.792 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-09T18:14:36.6Z 2024-09-09T18:19:36.792Z,1725905976.792 [Default:CheckIn:Read_GPS] Stopped 2024-09-09T18:19:36.792Z,1725905976.792 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-09-09T18:19:37.197Z,1725905977.197 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-09-09T18:19:44.558Z,1725905984.558 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240909T180918/Courier0004.lzma 2024-09-09T18:19:45.560Z,1725905985.560 [DataOverHttps](INFO): Moved sent file to Logs/20240909T180918/Courier0004.lzma.bak 2024-09-09T18:19:45.560Z,1725905985.560 [DataOverHttps](INFO): SBD MOMSN=23148374 2024-09-09T18:19:52.341Z,1725905992.341 [CommandExec](IMPORTANT): got command maintain control HorizontalControl.rudderAngleAction 15 degree 2024-09-09T18:20:03.732Z,1725906003.732 [DataOverHttps](INFO): Sending 900 bytes from file Logs/20240909T180918/Express0005.lzma 2024-09-09T18:20:04.741Z,1725906004.741 [DataOverHttps](INFO): Moved sent file to Logs/20240909T180918/Express0005.lzma.bak 2024-09-09T18:20:04.741Z,1725906004.741 [DataOverHttps](INFO): SBD MOMSN=23148376 2024-09-09T18:20:05.888Z,1725906005.888 [Default:CheckIn:Read_Iridium] Stopped 2024-09-09T18:20:05.888Z,1725906005.888 [Default:CheckIn:C.Wait] Running Loop=1 2024-09-09T18:20:05.888Z,1725906005.888 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-09-09T18:20:13.552Z,1725906013.552 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-09-09T18:20:13.552Z,1725906013.552 [NAL9602] Data Fault, FailCount= 1 2024-09-09T18:20:13.552Z,1725906013.552 [NAL9602](ERROR): Data Fault 2024-09-09T18:20:13.591Z,1725906013.591 [CBIT](ERROR): Data Fault in component: NAL9602 2024-09-09T18:20:13.952Z,1725906013.952 [NAL9602](INFO): Powering down 2024-09-09T18:20:14.814Z,1725906014.814 [CBIT](INFO): Clearing failed state for component NAL9602 2024-09-09T18:20:14.814Z,1725906014.814 [NAL9602] No Fault, FailCount= 1 2024-09-09T18:20:15.481Z,1725906015.481 [CommandExec](IMPORTANT): got command get platform_rudder_angle degree 2024-09-09T18:20:15.482Z,1725906015.482 [CommandExec](IMPORTANT): platform_rudder_angle 14.973777 arcdeg 2024-09-09T18:20:28.508Z,1725906028.508 [CommandExec](IMPORTANT): got command restart application 2024-09-09T18:20:29.510Z,1725906029.510 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-09T18:20:29.511Z,1725906029.511 [CommandExec](INFO): Uninitializing the command executive. 2024-09-09T18:20:29.511Z,1725906029.511 [CommandExec](INFO): Uninitializing the command scheduler. 2024-09-09T18:20:29.511Z,1725906029.511 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:29.606Z,1725906029.606 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-09-09T18:20:29.606Z,1725906029.606 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-09-09T18:20:29.607Z,1725906029.607 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:29.607Z,1725906029.607 [NavChartDb](INFO): Join timeout helper Thread ID is 994 2024-09-09T18:20:29.622Z,1725906029.622 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-09T18:20:29.623Z,1725906029.623 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:29.626Z,1725906029.626 [ComponentRegistry](INFO): Shutting down WetLabsUBAT ThreadHandler 2024-09-09T18:20:29.626Z,1725906029.626 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:29.627Z,1725906029.627 [WetLabsUBAT](INFO): Join timeout helper Thread ID is 995 2024-09-09T18:20:29.883Z,1725906029.883 [WetLabsUBAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-09T18:20:29.883Z,1725906029.883 [WetLabsUBAT](INFO): Powering down 2024-09-09T18:20:29.884Z,1725906029.884 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:29.890Z,1725906029.890 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-09-09T18:20:29.890Z,1725906029.890 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:29.891Z,1725906029.891 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 996 2024-09-09T18:20:30.295Z,1725906030.295 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-09T18:20:30.295Z,1725906030.295 [WetLabsBB2FL](INFO): Powering down 2024-09-09T18:20:30.295Z,1725906030.295 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:30.314Z,1725906030.314 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-09-09T18:20:30.314Z,1725906030.314 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:30.315Z,1725906030.315 [CTD_Seabird](INFO): Join timeout helper Thread ID is 997 2024-09-09T18:20:30.482Z,1725906030.482 [CTD_Seabird](INFO): Powering down 2024-09-09T18:20:30.494Z,1725906030.494 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-09T18:20:30.495Z,1725906030.495 [CTD_Seabird](INFO): Powering down 2024-09-09T18:20:30.511Z,1725906030.511 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:30.518Z,1725906030.518 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-09-09T18:20:30.519Z,1725906030.519 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:30.519Z,1725906030.519 [Radio_Surface](INFO): Join timeout helper Thread ID is 998 2024-09-09T18:20:30.706Z,1725906030.706 [Radio_Surface](INFO): Powering down 2024-09-09T18:20:30.707Z,1725906030.707 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-09T18:20:30.708Z,1725906030.708 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:30.719Z,1725906030.719 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-09-09T18:20:30.719Z,1725906030.719 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:30.720Z,1725906030.720 [Onboard](INFO): Join timeout helper Thread ID is 999 2024-09-09T18:20:31.171Z,1725906031.171 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2024-09-09T18:20:32.290Z,1725906032.290 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-09T18:20:32.291Z,1725906032.291 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:32.303Z,1725906032.303 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-09-09T18:20:32.303Z,1725906032.303 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:32.304Z,1725906032.304 [DataOverHttps](INFO): Join timeout helper Thread ID is 1000 2024-09-09T18:20:33.179Z,1725906033.179 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-09T18:20:33.179Z,1725906033.179 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:33.191Z,1725906033.191 [ComponentRegistry](INFO): Shutting down DATMMP ThreadHandler 2024-09-09T18:20:33.191Z,1725906033.191 [DATMMP ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:33.191Z,1725906033.191 [DATMMP](INFO): Join timeout helper Thread ID is 1001 2024-09-09T18:20:33.214Z,1725906033.214 [DATMMP](INFO): Stop 2024-09-09T18:20:33.214Z,1725906033.214 [DATMMP](INFO): uninitialize 2024-09-09T18:20:33.214Z,1725906033.214 [DATMMP](INFO): Powering down 2024-09-09T18:20:33.287Z,1725906033.287 [DATMMP ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-09T18:20:33.287Z,1725906033.287 [DATMMP](INFO): uninitialize 2024-09-09T18:20:33.287Z,1725906033.287 [DATMMP](INFO): Powering down 2024-09-09T18:20:33.288Z,1725906033.288 [DATMMP ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:33.291Z,1725906033.291 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-09-09T18:20:33.291Z,1725906033.291 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:33.292Z,1725906033.292 [BackseatComponent](INFO): Join timeout helper Thread ID is 1002 2024-09-09T18:20:33.456Z,1725906033.456 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-09T18:20:33.456Z,1725906033.456 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:33.464Z,1725906033.464 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-09-09T18:20:33.465Z,1725906033.465 [logger ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:33.465Z,1725906033.465 [logger](INFO): Join timeout helper Thread ID is 1003 2024-09-09T18:20:33.490Z,1725906033.490 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-09T18:20:33.491Z,1725906033.491 [logger ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:33.511Z,1725906033.511 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-09-09T18:20:33.511Z,1725906033.511 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:33.512Z,1725906033.512 [CommandLine](INFO): Join timeout helper Thread ID is 1004 2024-09-09T18:20:33.519Z,1725906033.519 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-09T18:20:33.519Z,1725906033.519 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:33.535Z,1725906033.535 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-09-09T18:20:33.536Z,1725906033.536 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:33.536Z,1725906033.536 [CommandExec](INFO): Join timeout helper Thread ID is 1005 2024-09-09T18:20:33.537Z,1725906033.537 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-09-09T18:20:33.537Z,1725906033.537 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:33.538Z,1725906033.538 [controlThread](INFO): Join timeout helper Thread ID is 1006 2024-09-09T18:20:33.730Z,1725906033.730 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-09T18:20:33.731Z,1725906033.731 [controlThread](DEBUG): Uninitializing ControlThread 2024-09-09T18:20:33.731Z,1725906033.731 [AHRS_M2](INFO): Powering down 2024-09-09T18:20:33.803Z,1725906033.803 [NAL9602](INFO): Powering down 2024-09-09T18:20:33.874Z,1725906033.874 [RDI_Pathfinder](INFO): Powering down 2024-09-09T18:20:33.875Z,1725906033.875 [Sonardyne_Nano](INFO): Powering down 2024-09-09T18:20:33.995Z,1725906033.995 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-09-09T18:20:33.996Z,1725906033.996 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-09-09T18:20:33.996Z,1725906033.996 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-09-09T18:20:33.997Z,1725906033.997 [MissionManager](INFO): Uninitializing Mission Default 2024-09-09T18:20:33.997Z,1725906033.997 [Default] Stopped 2024-09-09T18:20:33.997Z,1725906033.997 [Default](DEBUG): Aggregate::uninitialize Default 2024-09-09T18:20:33.997Z,1725906033.997 [Default:B.GoToSurface] Stopped 2024-09-09T18:20:33.997Z,1725906033.997 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-09-09T18:20:33.997Z,1725906033.997 [Default:CheckIn] Stopped 2024-09-09T18:20:33.997Z,1725906033.997 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-09-09T18:20:33.997Z,1725906033.997 [Default:CheckIn:C.Wait] Stopped 2024-09-09T18:20:33.997Z,1725906033.997 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-09-09T18:20:34.000Z,1725906034.000 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-09-09T18:20:34.001Z,1725906034.001 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-09-09T18:20:34.001Z,1725906034.001 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-09-09T18:20:34.001Z,1725906034.001 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-09-09T18:20:34.001Z,1725906034.001 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-09-09T18:20:34.002Z,1725906034.002 [BuoyancyServo](INFO): Powering down 2024-09-09T18:20:34.014Z,1725906034.014 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-09-09T18:20:34.014Z,1725906034.014 [ElevatorServo](INFO): Powering down 2024-09-09T18:20:34.015Z,1725906034.015 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-09-09T18:20:34.015Z,1725906034.015 [MassServo](INFO): Powering down 2024-09-09T18:20:34.016Z,1725906034.016 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-09-09T18:20:34.016Z,1725906034.016 [RudderServo](INFO): Powering down 2024-09-09T18:20:34.017Z,1725906034.017 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2024-09-09T18:20:34.017Z,1725906034.017 [ThrusterServo](INFO): Powering down 2024-09-09T18:20:34.018Z,1725906034.018 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-09-09T18:20:34.018Z,1725906034.018 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-09-09T18:20:34.019Z,1725906034.019 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-09-09T18:20:34.019Z,1725906034.019 [CBIT](DEBUG): Powering off loads. 2024-09-09T18:20:34.030Z,1725906034.030 [CBIT](DEBUG): Disabling WDT. 2024-09-09T18:20:34.042Z,1725906034.042 [CBIT](DEBUG): Opening all GF detection circuits. 2024-09-09T18:20:34.043Z,1725906034.043 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:34.095Z,1725906034.095 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:34.098Z,1725906034.098 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:34.104Z,1725906034.104 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:34.110Z,1725906034.110 [DATMMP ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:34.150Z,1725906034.150 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:34.210Z,1725906034.210 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:34.212Z,1725906034.212 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:34.216Z,1725906034.216 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:34.225Z,1725906034.225 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-09-09T18:20:34.288Z,1725906034.288 [logger ThreadHandler](INFO): Thread cancelled.