2024-01-31T00:54:03.792Z,1706662443.792 [Supervisor](DEBUG): Initializing supervisor. 2024-01-31T00:54:03.797Z,1706662443.797 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-01-31T00:54:03.798Z,1706662443.798 [SyncHandler](INFO): Protected caller Thread ID is 9354 2024-01-31T00:54:03.798Z,1706662443.798 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-01-31T00:54:03.799Z,1706662443.799 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-01-31T00:54:03.800Z,1706662443.800 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 9355 2024-01-31T00:54:03.804Z,1706662443.804 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-01-31T00:54:03.821Z,1706662443.821 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-01-31T00:54:03.822Z,1706662443.822 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-01-31T00:54:03.822Z,1706662443.822 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 9356 2024-01-31T00:54:03.826Z,1706662443.826 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-01-31T00:54:03.827Z,1706662443.827 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-01-31T00:54:03.828Z,1706662443.828 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 9357 2024-01-31T00:54:03.830Z,1706662443.830 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-01-31T00:54:03.831Z,1706662443.831 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-01-31T00:54:03.831Z,1706662443.831 [logger ThreadHandler](INFO): Protected caller Thread ID is 9358 2024-01-31T00:54:03.834Z,1706662443.834 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-01-31T00:54:03.835Z,1706662443.835 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-01-31T00:54:03.837Z,1706662443.837 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-01-31T00:54:04.140Z,1706662444.140 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-01-31T00:54:04.141Z,1706662444.141 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-01-31T00:54:04.221Z,1706662444.221 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-01-31T00:54:04.331Z,1706662444.331 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-01-31T00:54:04.332Z,1706662444.332 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-01-31T00:54:04.474Z,1706662444.474 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-01-31T00:54:04.474Z,1706662444.474 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-01-31T00:54:04.798Z,1706662444.798 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-01-31T00:54:04.799Z,1706662444.799 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-01-31T00:54:04.894Z,1706662444.894 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-01-31T00:54:04.894Z,1706662444.894 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-01-31T00:54:05.265Z,1706662445.265 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-01-31T00:54:05.266Z,1706662445.266 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-01-31T00:54:05.466Z,1706662445.466 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-01-31T00:54:05.467Z,1706662445.467 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-01-31T00:54:05.546Z,1706662445.546 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-01-31T00:54:05.761Z,1706662445.761 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-01-31T00:54:05.762Z,1706662445.762 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-01-31T00:54:05.970Z,1706662445.970 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-01-31T00:54:05.970Z,1706662445.970 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-01-31T00:54:06.450Z,1706662446.450 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-01-31T00:54:06.451Z,1706662446.451 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-01-31T00:54:06.630Z,1706662446.630 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-01-31T00:54:06.630Z,1706662446.630 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-01-31T00:54:06.899Z,1706662446.899 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-01-31T00:54:06.899Z,1706662446.899 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-01-31T00:54:07.685Z,1706662447.685 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-01-31T00:54:07.685Z,1706662447.685 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-01-31T00:54:08.176Z,1706662448.176 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-01-31T00:54:08.178Z,1706662448.178 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/ 2024-01-31T00:54:08.179Z,1706662448.179 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Control.cfg 2024-01-31T00:54:08.275Z,1706662448.275 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Science.cfg 2024-01-31T00:54:08.392Z,1706662448.392 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/secure.cfg 2024-01-31T00:54:08.477Z,1706662448.477 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Servo.cfg 2024-01-31T00:54:08.583Z,1706662448.583 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/BIT.cfg 2024-01-31T00:54:08.683Z,1706662448.683 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Battery.cfg 2024-01-31T00:54:08.940Z,1706662448.940 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-01-31T00:54:08.940Z,1706662448.940 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/vehicle.cfg 2024-01-31T00:54:09.053Z,1706662449.053 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/logger.cfg 2024-01-31T00:54:09.146Z,1706662449.146 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Navigation.cfg 2024-01-31T00:54:09.248Z,1706662449.248 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Sensor.cfg 2024-01-31T00:54:09.385Z,1706662449.385 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Simulator.cfg 2024-01-31T00:54:09.483Z,1706662449.483 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/root/ 2024-01-31T00:54:09.484Z,1706662449.484 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2024-01-31T00:54:09.494Z,1706662449.494 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-01-31T00:54:09.593Z,1706662449.593 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-01-31T00:54:09.593Z,1706662449.593 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-01-31T00:54:09.643Z,1706662449.643 [VerticalControl](DEBUG): Construct VerticalControl. 2024-01-31T00:54:09.701Z,1706662449.701 [VerticalControl] Loaded 2024-01-31T00:54:09.701Z,1706662449.701 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-01-31T00:54:09.704Z,1706662449.704 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-01-31T00:54:09.744Z,1706662449.744 [HorizontalControl] Loaded 2024-01-31T00:54:09.744Z,1706662449.744 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-01-31T00:54:09.747Z,1706662449.747 [SpeedControl](DEBUG): Construct SpeedControl. 2024-01-31T00:54:09.750Z,1706662449.750 [SpeedControl] Loaded 2024-01-31T00:54:09.750Z,1706662449.750 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-01-31T00:54:09.752Z,1706662449.752 [LoopControl](DEBUG): Construct LoopControl. 2024-01-31T00:54:09.753Z,1706662449.753 [LoopControl] Loaded 2024-01-31T00:54:09.753Z,1706662449.753 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-01-31T00:54:09.753Z,1706662449.753 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-01-31T00:54:09.754Z,1706662449.754 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-01-31T00:54:09.808Z,1706662449.808 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-01-31T00:54:09.808Z,1706662449.808 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-01-31T00:54:10.241Z,1706662450.241 [AHRS_M2] Loaded 2024-01-31T00:54:10.241Z,1706662450.241 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-01-31T00:54:10.276Z,1706662450.276 [BackseatComponent] Loaded 2024-01-31T00:54:10.276Z,1706662450.276 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-01-31T00:54:10.277Z,1706662450.277 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408844E0 2024-01-31T00:54:10.278Z,1706662450.278 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 9440 2024-01-31T00:54:10.280Z,1706662450.280 [LcmUniversalReporter] Loaded 2024-01-31T00:54:10.281Z,1706662450.281 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-01-31T00:54:11.085Z,1706662451.085 [BPC1] Loaded 2024-01-31T00:54:11.085Z,1706662451.085 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-01-31T00:54:11.162Z,1706662451.162 [DataOverHttps] Loaded 2024-01-31T00:54:11.162Z,1706662451.162 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-01-31T00:54:11.163Z,1706662451.163 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408B44E0 2024-01-31T00:54:11.163Z,1706662451.163 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 9441 2024-01-31T00:54:11.183Z,1706662451.183 [Depth_Keller] Loaded 2024-01-31T00:54:11.184Z,1706662451.184 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-01-31T00:54:11.189Z,1706662451.189 [DropWeight] Loaded 2024-01-31T00:54:11.189Z,1706662451.189 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2024-01-31T00:54:11.251Z,1706662451.251 [NAL9602] Loaded 2024-01-31T00:54:11.251Z,1706662451.251 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-01-31T00:54:11.279Z,1706662451.279 [Onboard] Loaded 2024-01-31T00:54:11.280Z,1706662451.280 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-01-31T00:54:11.281Z,1706662451.281 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408E44E0 2024-01-31T00:54:11.281Z,1706662451.281 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 9442 2024-01-31T00:54:11.293Z,1706662451.293 [Power24vConverter] Loaded 2024-01-31T00:54:11.293Z,1706662451.293 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-01-31T00:54:11.306Z,1706662451.306 [Radio_Surface] Loaded 2024-01-31T00:54:11.306Z,1706662451.306 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-01-31T00:54:11.307Z,1706662451.307 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409144E0 2024-01-31T00:54:11.307Z,1706662451.307 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 9443 2024-01-31T00:54:11.321Z,1706662451.321 [Sonardyne_Nano] Loaded 2024-01-31T00:54:11.321Z,1706662451.321 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-01-31T00:54:11.410Z,1706662451.410 [DAT] Loaded 2024-01-31T00:54:11.410Z,1706662451.410 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2024-01-31T00:54:11.411Z,1706662451.411 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 409444E0 2024-01-31T00:54:11.411Z,1706662451.411 [DAT ThreadHandler](INFO): Protected caller Thread ID is 9444 2024-01-31T00:54:11.434Z,1706662451.434 [Waterlinked] Loaded 2024-01-31T00:54:11.434Z,1706662451.434 [ComponentRegistry](DEBUG): SyncComponent "Waterlinked" handled in the control thread. 2024-01-31T00:54:11.434Z,1706662451.434 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-01-31T00:54:11.435Z,1706662451.435 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-01-31T00:54:11.445Z,1706662451.445 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-01-31T00:54:11.445Z,1706662451.445 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-01-31T00:54:11.471Z,1706662451.471 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-01-31T00:54:11.472Z,1706662451.472 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-01-31T00:54:11.606Z,1706662451.606 [SBIT](DEBUG): Construct Startup Built In Test. 2024-01-31T00:54:11.615Z,1706662451.615 [SBIT] Loaded 2024-01-31T00:54:11.615Z,1706662451.615 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-01-31T00:54:11.618Z,1706662451.618 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-01-31T00:54:11.631Z,1706662451.631 [IBIT] Loaded 2024-01-31T00:54:11.631Z,1706662451.631 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-01-31T00:54:11.637Z,1706662451.637 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-01-31T00:54:11.738Z,1706662451.738 [CBIT] Loaded 2024-01-31T00:54:11.738Z,1706662451.738 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-01-31T00:54:11.739Z,1706662451.739 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-01-31T00:54:11.739Z,1706662451.739 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-01-31T00:54:12.032Z,1706662452.032 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-01-31T00:54:12.032Z,1706662452.032 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-01-31T00:54:12.081Z,1706662452.081 [DepthRateCalculator] Loaded 2024-01-31T00:54:12.081Z,1706662452.081 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-01-31T00:54:12.086Z,1706662452.086 [PitchRateCalculator] Loaded 2024-01-31T00:54:12.086Z,1706662452.086 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-01-31T00:54:12.096Z,1706662452.096 [SpeedCalculator] Loaded 2024-01-31T00:54:12.096Z,1706662452.096 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-01-31T00:54:12.100Z,1706662452.100 [YawRateCalculator] Loaded 2024-01-31T00:54:12.101Z,1706662452.101 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-01-31T00:54:12.119Z,1706662452.119 [ElevatorOffsetCalculator] Loaded 2024-01-31T00:54:12.119Z,1706662452.119 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-01-31T00:54:12.120Z,1706662452.120 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-01-31T00:54:12.120Z,1706662452.120 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-01-31T00:54:12.261Z,1706662452.261 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-01-31T00:54:12.261Z,1706662452.261 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-01-31T00:54:12.370Z,1706662452.370 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-01-31T00:54:12.370Z,1706662452.370 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-01-31T00:54:12.411Z,1706662452.411 [DeadReckonUsingSpeedCalculator] Loaded 2024-01-31T00:54:12.412Z,1706662452.412 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2024-01-31T00:54:12.453Z,1706662452.453 [DeadReckonWithRespectToSeafloor] Loaded 2024-01-31T00:54:12.454Z,1706662452.454 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread. 2024-01-31T00:54:12.467Z,1706662452.467 [NavChart] Loaded 2024-01-31T00:54:12.467Z,1706662452.467 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-01-31T00:54:12.473Z,1706662452.473 [UniversalFixResidualReporter] Loaded 2024-01-31T00:54:12.473Z,1706662452.473 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-01-31T00:54:12.473Z,1706662452.473 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-01-31T00:54:12.474Z,1706662452.474 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-01-31T00:54:12.599Z,1706662452.599 [BuoyancyServo] Loaded 2024-01-31T00:54:12.599Z,1706662452.599 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-01-31T00:54:12.620Z,1706662452.620 [ElevatorServo] Loaded 2024-01-31T00:54:12.620Z,1706662452.620 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-01-31T00:54:12.639Z,1706662452.639 [MassServo] Loaded 2024-01-31T00:54:12.640Z,1706662452.640 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-01-31T00:54:12.658Z,1706662452.658 [RudderServo] Loaded 2024-01-31T00:54:12.658Z,1706662452.658 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-01-31T00:54:12.673Z,1706662452.673 [ThrusterHE] Loaded 2024-01-31T00:54:12.673Z,1706662452.673 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2024-01-31T00:54:12.673Z,1706662452.673 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-01-31T00:54:12.674Z,1706662452.674 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-01-31T00:54:12.841Z,1706662452.841 [CTD_Seabird] Loaded 2024-01-31T00:54:12.841Z,1706662452.841 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-01-31T00:54:12.842Z,1706662452.842 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B9E4E0 2024-01-31T00:54:12.842Z,1706662452.842 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 9445 2024-01-31T00:54:12.875Z,1706662452.875 [ESPComponent] Loaded 2024-01-31T00:54:12.876Z,1706662452.876 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2024-01-31T00:54:12.895Z,1706662452.895 [PAR_Licor] Loaded 2024-01-31T00:54:12.896Z,1706662452.896 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-01-31T00:54:12.935Z,1706662452.935 [WetLabsBB2FL] Loaded 2024-01-31T00:54:12.936Z,1706662452.936 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-01-31T00:54:12.937Z,1706662452.937 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40BCE4E0 2024-01-31T00:54:12.937Z,1706662452.937 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 9446 2024-01-31T00:54:12.938Z,1706662452.938 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-01-31T00:54:12.944Z,1706662452.944 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-01-31T00:54:12.947Z,1706662452.947 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-01-31T00:54:12.958Z,1706662452.958 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-01-31T00:54:12.959Z,1706662452.959 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BFE4E0 2024-01-31T00:54:12.959Z,1706662452.959 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 9447 2024-01-31T00:54:12.963Z,1706662452.963 [Supervisor](INFO): Main Thread ID is 9210 2024-01-31T00:54:12.963Z,1706662452.963 [Supervisor](DEBUG): Running supervisor. 2024-01-31T00:54:12.964Z,1706662452.964 [CommandExec ThreadHandler](INFO): Handler Thread ID is 9448 2024-01-31T00:54:12.965Z,1706662452.965 [CommandExec](INFO): Initializing the command executive. 2024-01-31T00:54:12.966Z,1706662452.966 [CommandLine ThreadHandler](INFO): Handler Thread ID is 9449 2024-01-31T00:54:12.968Z,1706662452.968 [controlThread ThreadHandler](INFO): Handler Thread ID is 9450 2024-01-31T00:54:12.969Z,1706662452.969 [controlThread](DEBUG): Initializing ControlThread 2024-01-31T00:54:12.970Z,1706662452.970 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-01-31T00:54:12.971Z,1706662452.971 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-01-31T00:54:12.972Z,1706662452.972 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-01-31T00:54:12.973Z,1706662452.973 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-01-31T00:54:12.978Z,1706662452.978 [SBIT](INFO): Initialize SBIT Component. 2024-01-31T00:54:12.979Z,1706662452.979 [SBIT](IMPORTANT): git: 2023-10-24_A 2024-01-31T00:54:12.979Z,1706662452.979 [SBIT](INFO): git hash: dfa22713be92246460bd2ec0e2f51182051bcc4a 2024-01-31T00:54:12.979Z,1706662452.979 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-01-31T00:54:12.981Z,1706662452.981 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #639 PREEMPT Wed Mar 12 12:53:33 PDT 2014 Kernel Reported: #1 PREEMPT Tue Nov 28 15:04:22 PST 2023 2024-01-31T00:54:12.982Z,1706662452.982 [SBIT](INFO): Beginning SBIT in 74.000000 seconds. 2024-01-31T00:54:12.982Z,1706662452.982 [IBIT](INFO): Initialize IBIT Component. 2024-01-31T00:54:12.983Z,1706662452.983 [CBIT](DEBUG): Initialize CBIT Component. 2024-01-31T00:54:12.984Z,1706662452.984 [logger ThreadHandler](INFO): Handler Thread ID is 9451 2024-01-31T00:54:12.996Z,1706662452.996 [CBIT](DEBUG): Initialized mux pins. 2024-01-31T00:54:12.996Z,1706662452.996 [CBIT](DEBUG): Initializing the watchdog timer. 2024-01-31T00:54:13.004Z,1706662453.004 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 9452 2024-01-31T00:54:13.016Z,1706662453.016 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 9453 2024-01-31T00:54:13.018Z,1706662453.018 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-01-31T00:54:13.020Z,1706662453.020 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-01-31T00:54:13.020Z,1706662453.020 [CBIT](DEBUG): Initializing heartbeat. 2024-01-31T00:54:13.029Z,1706662453.029 [Onboard ThreadHandler](INFO): Handler Thread ID is 9454 2024-01-31T00:54:13.046Z,1706662453.046 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 9455 2024-01-31T00:54:13.069Z,1706662453.069 [DAT ThreadHandler](INFO): Handler Thread ID is 9456 2024-01-31T00:54:13.069Z,1706662453.069 [DAT](INFO): Powering up 2024-01-31T00:54:13.070Z,1706662453.070 [DAT](DEBUG): Initializing DAT. 2024-01-31T00:54:13.073Z,1706662453.073 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 9458 2024-01-31T00:54:13.074Z,1706662453.074 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-01-31T00:54:13.077Z,1706662453.077 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 9460 2024-01-31T00:54:13.080Z,1706662453.080 [WetLabsBB2FL](INFO): Powering up 2024-01-31T00:54:13.082Z,1706662453.082 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 9462 2024-01-31T00:54:13.085Z,1706662453.085 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2HA05M.000 2024-01-31T00:54:13.085Z,1706662453.085 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2HA05M.000 2024-01-31T00:54:13.085Z,1706662453.085 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3HA20M.000 2024-01-31T00:54:13.085Z,1706662453.085 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3HA20M.000 2024-01-31T00:54:13.086Z,1706662453.086 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000 2024-01-31T00:54:13.086Z,1706662453.086 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000 2024-01-31T00:54:13.086Z,1706662453.086 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000 2024-01-31T00:54:13.086Z,1706662453.086 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000 2024-01-31T00:54:13.086Z,1706662453.086 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA53M.000 2024-01-31T00:54:13.086Z,1706662453.086 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA53M.000 2024-01-31T00:54:13.087Z,1706662453.087 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA55M.000 2024-01-31T00:54:13.087Z,1706662453.087 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA55M.000 2024-01-31T00:54:13.092Z,1706662453.092 [CBIT](DEBUG): Deactivating GF circuits. 2024-01-31T00:54:13.093Z,1706662453.093 [CBIT](DEBUG): Deactivating emergency mode. 2024-01-31T00:54:13.132Z,1706662453.132 [CBIT](DEBUG): Backplane powered. 2024-01-31T00:54:13.132Z,1706662453.132 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-01-31T00:54:13.133Z,1706662453.133 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-01-31T00:54:13.133Z,1706662453.133 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-01-31T00:54:13.133Z,1706662453.133 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-01-31T00:54:13.134Z,1706662453.134 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-01-31T00:54:13.135Z,1706662453.135 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-01-31T00:54:13.136Z,1706662453.136 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-01-31T00:54:13.136Z,1706662453.136 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-01-31T00:54:13.141Z,1706662453.141 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml 2024-01-31T00:54:13.162Z,1706662453.162 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-01-31T00:54:13.218Z,1706662453.218 [MissionManager](DEBUG): 2024-01-31T00:54:13.219Z,1706662453.219 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml 2024-01-31T00:54:13.297Z,1706662453.297 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-01-31T00:54:13.298Z,1706662453.298 [Default:A.Wait](DEBUG): Construct Wait. 2024-01-31T00:54:13.321Z,1706662453.321 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-01-31T00:54:13.353Z,1706662453.353 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-01-31T00:54:13.355Z,1706662453.355 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-01-31T00:54:13.377Z,1706662453.377 [Default:E.Execute](DEBUG): Construct Execute. 2024-01-31T00:54:13.393Z,1706662453.393 [MissionManager](DEBUG): 0 Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2024-01-31T00:54:13.398Z,1706662453.398 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,Waterlinked,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,LcmUniversalReporter,Reporter,LogSplitter, 2024-01-31T00:54:13.428Z,1706662453.428 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-01-31T00:54:13.452Z,1706662453.452 [Radio_Surface](INFO): Powering up 2024-01-31T00:54:13.514Z,1706662453.514 [Depth_Keller](ERROR): Pressure or depth reading out of range: -1.140412 decibar, -1.132002 m 2024-01-31T00:54:13.515Z,1706662453.515 [Power24vConverter](INFO): Powering up. 2024-01-31T00:54:13.515Z,1706662453.515 [Sonardyne_Nano](INFO): Initializing. 2024-01-31T00:54:13.546Z,1706662453.546 [DepthRateCalculator](ERROR): Depth measurement is not active 2024-01-31T00:54:13.594Z,1706662453.594 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-01-31T00:54:13.600Z,1706662453.600 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-01-31T00:54:13.601Z,1706662453.601 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-01-31T00:54:13.608Z,1706662453.608 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-01-31T00:54:13.609Z,1706662453.609 [MassServo](DEBUG): Initializing EZServoServo. 2024-01-31T00:54:13.617Z,1706662453.617 [MassServo](DEBUG): Initializing MassServo. 2024-01-31T00:54:13.618Z,1706662453.618 [RudderServo](DEBUG): Initializing EZServoServo. 2024-01-31T00:54:13.624Z,1706662453.624 [RudderServo](DEBUG): Initializing RudderServo. 2024-01-31T00:54:13.625Z,1706662453.625 [ThrusterHE](DEBUG): Initializing EZServoServo. 2024-01-31T00:54:13.632Z,1706662453.632 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2024-01-31T00:54:13.858Z,1706662453.858 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2024-01-31T00:54:13.858Z,1706662453.858 [DropWeight] Hardware Fault, FailCount= 1 2024-01-31T00:54:13.858Z,1706662453.858 [DropWeight](ERROR): Hardware Fault 2024-01-31T00:54:13.896Z,1706662453.896 [CommandExec](FAULT): Scheduling is paused 2024-01-31T00:54:13.897Z,1706662453.897 [CBIT](INFO): Critical error at 20240131T005413 2024-01-31T00:54:13.897Z,1706662453.897 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2024-01-31T00:54:13.899Z,1706662453.899 [CBIT](ERROR): Hardware Fault in component: DropWeight 2024-01-31T00:54:13.908Z,1706662453.908 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2024-01-31T00:54:14.243Z,1706662454.243 [CBIT](INFO): Critical error at 20240131T005413 2024-01-31T00:54:15.188Z,1706662455.188 [WetLabsBB2FL](INFO): Powering down 2024-01-31T00:54:15.830Z,1706662455.830 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2024-01-31T00:54:17.069Z,1706662457.069 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2311 2024-01-31T00:54:19.305Z,1706662459.305 [ThrusterHE](ERROR): Zero Speed Commanded. 2024-01-31T00:54:23.154Z,1706662463.154 [CBIT](CRITICAL): Environmental Failure. Press:14.766734 PSI. Humidity:42%. Temp:26 C. ABORTING MISSION 2024-01-31T00:54:23.594Z,1706662463.594 [CBIT](INFO): Critical error at 20240131T005423 2024-01-31T00:54:40.908Z,1706662480.908 [Waterlinked](ERROR): only read 3 of 5 data items 2024-01-31T00:54:41.286Z,1706662481.286 [NAL9602](INFO): Powering up NAL9602 2024-01-31T00:54:43.383Z,1706662483.383 [Waterlinked](ERROR): only read 2 of 5 data items 2024-01-31T00:54:47.824Z,1706662487.824 [Waterlinked](INFO): Powering down 2024-01-31T00:54:52.198Z,1706662492.198 [NAL9602](INFO): NAL9602 initialized 2024-01-31T00:55:13.317Z,1706662513.317 [DAT](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2024-01-31T00:55:13.317Z,1706662513.317 [DAT] Communications Fault, FailCount= 1 2024-01-31T00:55:13.317Z,1706662513.317 [DAT](ERROR): Communications Fault 2024-01-31T00:55:13.640Z,1706662513.640 [CBIT](ERROR): Communications Fault in component: DAT 2024-01-31T00:55:13.721Z,1706662513.721 [DAT](INFO): Powering down 2024-01-31T00:55:14.841Z,1706662514.841 [CBIT](INFO): Clearing failed state for component DAT 2024-01-31T00:55:14.841Z,1706662514.841 [DAT] No Fault, FailCount= 1 2024-01-31T00:55:16.768Z,1706662516.768 [DAT](INFO): Powering up 2024-01-31T00:55:16.768Z,1706662516.768 [DAT](DEBUG): Initializing DAT. 2024-01-31T00:55:16.871Z,1706662516.871 [CBIT](FAULT): WATER ALARM STERN. 2024-01-31T00:55:16.872Z,1706662516.872 [CBIT](ERROR): WATER DETECTED IN PRESSURE HULL. Alarm Count: 1 2024-01-31T00:55:17.285Z,1706662517.285 [CBIT](FAULT): WATER ALARM STERN. 2024-01-31T00:55:17.286Z,1706662517.286 [CBIT](ERROR): WATER DETECTED IN PRESSURE HULL. Alarm Count: 2 2024-01-31T00:55:25.225Z,1706662525.225 [CommandExec](IMPORTANT): got command failComponent 2024-01-31T00:55:25.225Z,1706662525.225 [CommandExec](IMPORTANT): Failed components: 2024-01-31T00:55:25.225Z,1706662525.225 [CommandExec](IMPORTANT): DropWeight: Hardware Fault 2024-01-31T00:55:27.418Z,1706662527.418 [SBIT](IMPORTANT): Beginning Startup BIT 2024-01-31T00:55:27.428Z,1706662527.428 [CBIT](IMPORTANT): Beginning ground fault scan 2024-01-31T00:55:38.440Z,1706662538.440 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.000447 CHAN A1 (24V): 0.000101 CHAN A2 (12V): 0.000613 CHAN A3 (5V): -0.001654 CHAN B0 (3.3V): -0.000102 CHAN B1 (3.15aV): -0.000338 CHAN B2 (3.15bV): -0.000332 CHAN B3 (GND): -0.000589 OPEN: 0.007072 Full Scale: +/- 1 mA 2024-01-31T00:56:07.396Z,1706662567.396 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-01-31T00:56:16.777Z,1706662576.777 [DAT](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2024-01-31T00:56:16.777Z,1706662576.777 [DAT] Communications Fault, FailCount= 2 2024-01-31T00:56:16.777Z,1706662576.777 [DAT](ERROR): Communications Fault 2024-01-31T00:56:17.109Z,1706662577.109 [CBIT](ERROR): Communications Fault in component: DAT 2024-01-31T00:56:17.180Z,1706662577.180 [DAT](INFO): Powering down 2024-01-31T00:56:18.333Z,1706662578.333 [CBIT](INFO): Clearing failed state for component DAT 2024-01-31T00:56:18.333Z,1706662578.333 [DAT] No Fault, FailCount= 2 2024-01-31T00:56:20.224Z,1706662580.224 [DAT](INFO): Powering up 2024-01-31T00:56:20.224Z,1706662580.224 [DAT](DEBUG): Initializing DAT. 2024-01-31T00:56:20.321Z,1706662580.321 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-01-31T00:56:21.149Z,1706662581.149 [SBIT](IMPORTANT): SBIT PASSED 2024-01-31T00:56:21.149Z,1706662581.149 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-01-31T00:56:21.150Z,1706662581.150 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=25 count; 2024-01-31T00:56:21.150Z,1706662581.150 [SBIT](IMPORTANT): Express mostRecent BPC1.platform_battery_voltage; 2024-01-31T00:56:21.150Z,1706662581.150 [SBIT](IMPORTANT): Express none CTD_Seabird.bin_median_sea_water_salinity; 2024-01-31T00:56:21.150Z,1706662581.150 [SBIT](IMPORTANT): Express linearApproximation _.planktivore_LM_AvgRois 10.000000 count_per_second; 2024-01-31T00:56:21.150Z,1706662581.150 [SBIT](IMPORTANT): Express none platform_pitch_angle 5.000000 degree; 2024-01-31T00:56:21.151Z,1706662581.151 [SBIT](IMPORTANT): Express none platform_roll_angle 1.000000 degree; 2024-01-31T00:56:21.151Z,1706662581.151 [SBIT](IMPORTANT): IBIT.batteryCapacityThreshold=20 ampere_hour; 2024-01-31T00:56:21.151Z,1706662581.151 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=12 volt; 2024-01-31T00:56:21.151Z,1706662581.151 [SBIT](IMPORTANT): PowerOnly.sampleTime1=1 second; 2024-01-31T00:56:21.151Z,1706662581.151 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=185.760373 cubic_centimeter; 2024-01-31T00:56:21.151Z,1706662581.151 [SBIT](IMPORTANT): VerticalControl.massDefault=13.630082 millimeter; 2024-01-31T00:56:21.566Z,1706662581.566 [MissionManager](IMPORTANT): Started mission Startup 2024-01-31T00:56:21.566Z,1706662581.566 [Startup] Running Loop=1 2024-01-31T00:56:21.566Z,1706662581.566 [Startup](DEBUG): Aggregate::initialize Startup 2024-01-31T00:56:21.567Z,1706662581.567 [Startup:A.GoToSurface] Running Loop=1 2024-01-31T00:56:21.567Z,1706662581.567 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-01-31T00:56:21.567Z,1706662581.567 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-01-31T00:56:21.568Z,1706662581.568 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-01-31T00:56:21.568Z,1706662581.568 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-01-31T00:56:21.569Z,1706662581.569 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-01-31T00:56:21.569Z,1706662581.569 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-01-31T00:56:21.570Z,1706662581.570 [Startup:StartupSatComms] Running Loop=1 2024-01-31T00:56:21.570Z,1706662581.570 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2024-01-31T00:56:21.571Z,1706662581.571 [Startup:StartupSatComms:A] Running Loop=1 2024-01-31T00:56:21.898Z,1706662581.898 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2024-01-31T00:56:56.067Z,1706662616.067 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004786 2024-01-31T00:57:13.233Z,1706662633.233 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-01-31T00:57:13.233Z,1706662633.233 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-01-31T00:57:13.234Z,1706662633.234 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1 2024-01-31T00:57:13.235Z,1706662633.235 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-01-31T00:57:13.236Z,1706662633.236 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-01-31T00:57:13.236Z,1706662633.236 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-01-31T00:57:13.321Z,1706662633.321 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-01-31T00:57:13.321Z,1706662633.321 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-01-31T00:57:13.322Z,1706662633.322 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-01-31T00:57:13.680Z,1706662633.680 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-01-31T00:57:13.680Z,1706662633.680 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-01-31T00:57:13.681Z,1706662633.681 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-01-31T00:57:13.681Z,1706662633.681 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1 2024-01-31T00:57:13.681Z,1706662633.681 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-01-31T00:57:13.681Z,1706662633.681 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-01-31T00:57:14.008Z,1706662634.008 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-01-31T00:57:20.477Z,1706662640.477 [DAT](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2024-01-31T00:57:20.477Z,1706662640.477 [DAT] Communications Fault, FailCount= 3 2024-01-31T00:57:20.477Z,1706662640.477 [DAT](ERROR): Communications Fault 2024-01-31T00:57:20.564Z,1706662640.564 [CBIT](ERROR): Communications Fault in component: DAT 2024-01-31T00:57:20.880Z,1706662640.880 [DAT](INFO): Powering down 2024-01-31T00:57:21.688Z,1706662641.688 [Startup:StartupSatComms:A](INFO): Timed out from 2024-01-31T00:56:21.6Z 2024-01-31T00:57:21.688Z,1706662641.688 [Startup:StartupSatComms:A] Stopped 2024-01-31T00:57:21.688Z,1706662641.688 [Startup:StartupSatComms:B] Running Loop=1 2024-01-31T00:57:22.099Z,1706662642.099 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-01-31T00:57:22.184Z,1706662642.184 [CBIT](INFO): Clearing failed state for component DAT 2024-01-31T00:57:22.184Z,1706662642.184 [DAT] No Fault, FailCount= 3 2024-01-31T00:57:24.080Z,1706662644.080 [DAT](INFO): Powering up 2024-01-31T00:57:24.081Z,1706662644.081 [DAT](DEBUG): Initializing DAT. 2024-01-31T00:57:49.276Z,1706662669.276 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-01-31T00:58:05.772Z,1706662685.772 [DataOverHttps](INFO): Sending 81 bytes from file Logs/20240130T231742/Courier0019.lzma 2024-01-31T00:58:06.774Z,1706662686.774 [DataOverHttps](INFO): Moved sent file to Logs/20240130T231742/Courier0019.lzma.bak 2024-01-31T00:58:06.775Z,1706662686.775 [DataOverHttps](INFO): SBD MOMSN=19252157 2024-01-31T00:58:22.106Z,1706662702.106 [Startup:StartupSatComms:B](INFO): Timed out from 2024-01-31T00:57:21.7Z 2024-01-31T00:58:22.106Z,1706662702.106 [Startup:StartupSatComms:B] Stopped 2024-01-31T00:58:22.106Z,1706662702.106 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2024-01-31T00:58:22.106Z,1706662702.106 [Startup:StartupSatComms] Stopped 2024-01-31T00:58:22.107Z,1706662702.107 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2024-01-31T00:58:22.107Z,1706662702.107 [Startup](INFO): Completed Startup 2024-01-31T00:58:22.107Z,1706662702.107 [MissionManager](INFO): Startup is completed. 2024-01-31T00:58:22.108Z,1706662702.108 [MissionManager](INFO): Uninitializing Mission Startup 2024-01-31T00:58:22.108Z,1706662702.108 [Startup] Stopped 2024-01-31T00:58:22.108Z,1706662702.108 [Startup](DEBUG): Aggregate::uninitialize Startup 2024-01-31T00:58:22.108Z,1706662702.108 [Startup:A.GoToSurface] Stopped 2024-01-31T00:58:22.108Z,1706662702.108 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-01-31T00:58:22.453Z,1706662702.453 [MissionManager](IMPORTANT): Started mission Default 2024-01-31T00:58:22.453Z,1706662702.453 [Default] Running Loop=1 2024-01-31T00:58:22.454Z,1706662702.454 [Default](DEBUG): Aggregate::initialize Default 2024-01-31T00:58:22.454Z,1706662702.454 [Default:B.GoToSurface] Running Loop=1 2024-01-31T00:58:22.454Z,1706662702.454 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-01-31T00:58:22.454Z,1706662702.454 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-01-31T00:58:22.454Z,1706662702.454 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-01-31T00:58:22.455Z,1706662702.455 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-01-31T00:58:22.455Z,1706662702.455 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-01-31T00:58:22.455Z,1706662702.455 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-01-31T00:58:22.456Z,1706662702.456 [Default:A.Wait] Running Loop=1 2024-01-31T00:58:22.456Z,1706662702.456 [Default:A.Wait](DEBUG): Initialize Wait Component. 2024-01-31T00:58:22.727Z,1706662702.727 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240130T231742/Courier0022.lzma 2024-01-31T00:58:23.730Z,1706662703.730 [DataOverHttps](INFO): Moved sent file to Logs/20240130T231742/Courier0022.lzma.bak 2024-01-31T00:58:23.730Z,1706662703.730 [DataOverHttps](INFO): SBD MOMSN=19252160 2024-01-31T00:58:24.121Z,1706662704.121 [DAT](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2024-01-31T00:58:24.121Z,1706662704.121 [DAT] Communications Fault, FailCount= 4 2024-01-31T00:58:24.121Z,1706662704.121 [DAT](ERROR): Communications Fault 2024-01-31T00:58:24.152Z,1706662704.152 [CBIT](ERROR): Communications Fault in component: DAT 2024-01-31T00:58:24.524Z,1706662704.524 [DAT](INFO): Powering down 2024-01-31T00:58:25.780Z,1706662705.780 [CBIT](INFO): Clearing failed state for component DAT 2024-01-31T00:58:25.780Z,1706662705.780 [DAT] No Fault, FailCount= 4 2024-01-31T00:58:27.592Z,1706662707.592 [DAT](INFO): Powering up 2024-01-31T00:58:27.592Z,1706662707.592 [DAT](DEBUG): Initializing DAT. 2024-01-31T00:58:35.884Z,1706662715.884 [Default:A.Wait](INFO): Done Waiting. 2024-01-31T00:58:35.884Z,1706662715.884 [Default:A.Wait] Stopped 2024-01-31T00:58:35.885Z,1706662715.885 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2024-01-31T00:58:36.253Z,1706662716.253 [Default:CheckIn] Running Loop=1 2024-01-31T00:58:36.253Z,1706662716.253 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-01-31T00:58:36.253Z,1706662716.253 [Default:CheckIn:Read_GPS] Running Loop=1 2024-01-31T00:58:36.646Z,1706662716.646 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2024-01-31T00:58:42.645Z,1706662722.645 [BPC1](INFO): Calculating totals. Valid battery stick count: 35. Valid reserve battery stick count: 4. 2024-01-31T00:58:42.648Z,1706662722.648 [BPC1](INFO): Received data from all battery sticks. 2024-01-31T00:59:27.640Z,1706662767.640 [DAT](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2024-01-31T00:59:27.640Z,1706662767.640 [DAT] Communications Fault, FailCount= 5 2024-01-31T00:59:27.640Z,1706662767.640 [DAT](ERROR): Communications Fault 2024-01-31T00:59:27.928Z,1706662767.928 [CBIT](ERROR): Communications Fault in component: DAT 2024-01-31T00:59:28.056Z,1706662768.056 [DAT](INFO): Powering down 2024-01-31T00:59:29.177Z,1706662769.177 [CBIT](INFO): Clearing failed state for component DAT 2024-01-31T00:59:29.177Z,1706662769.177 [DAT] No Fault, FailCount= 5 2024-01-31T00:59:31.112Z,1706662771.112 [DAT](INFO): Powering up 2024-01-31T00:59:31.112Z,1706662771.112 [DAT](DEBUG): Initializing DAT. 2024-01-31T00:59:56.169Z,1706662796.169 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-01-31T01:00:14.389Z,1706662814.389 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2024-01-31T01:00:14.390Z,1706662814.390 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-01-31T01:00:14.391Z,1706662814.391 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2 2024-01-31T01:00:14.391Z,1706662814.391 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-01-31T01:00:14.392Z,1706662814.392 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-01-31T01:00:14.392Z,1706662814.392 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-01-31T01:00:14.403Z,1706662814.403 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-01-31T01:00:14.403Z,1706662814.403 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-01-31T01:00:14.403Z,1706662814.403 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-01-31T01:00:14.787Z,1706662814.787 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-01-31T01:00:14.787Z,1706662814.787 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2024-01-31T01:00:14.788Z,1706662814.788 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-01-31T01:00:14.788Z,1706662814.788 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2 2024-01-31T01:00:14.789Z,1706662814.789 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-01-31T01:00:14.789Z,1706662814.789 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-01-31T01:00:15.176Z,1706662815.176 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-01-31T01:00:31.117Z,1706662831.117 [DAT](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2024-01-31T01:00:31.117Z,1706662831.117 [DAT] Communications Fault, FailCount= 6 2024-01-31T01:00:31.117Z,1706662831.117 [DAT](ERROR): Communications Fault 2024-01-31T01:00:31.381Z,1706662831.381 [CBIT](ERROR): Communications Fault in component: DAT 2024-01-31T01:00:31.520Z,1706662831.520 [DAT](INFO): Powering down 2024-01-31T01:00:32.577Z,1706662832.577 [CBIT](INFO): Clearing failed state for component DAT 2024-01-31T01:00:32.577Z,1706662832.577 [DAT] No Fault, FailCount= 6 2024-01-31T01:00:34.580Z,1706662834.580 [DAT](INFO): Powering up 2024-01-31T01:00:34.580Z,1706662834.580 [DAT](DEBUG): Initializing DAT. 2024-01-31T01:01:31.919Z,1706662891.919 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010130.00,A,3648.17302,N,12147.28329,W,0.117,357.05,310124,,,A*74 2024-01-31T01:01:31.922Z,1706662891.922 [NAL9602](INFO): GPS fix at 20240131T010130: (36.802884, -121.788055) 2024-01-31T01:01:31.998Z,1706662891.998 [Default:CheckIn:Read_GPS] Stopped 2024-01-31T01:01:31.998Z,1706662891.998 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-01-31T01:01:32.377Z,1706662892.377 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-01-31T01:01:33.844Z,1706662893.844 [DataOverHttps](INFO): Sending 369 bytes from file Logs/20240131T005042/Courier0000.lzma 2024-01-31T01:01:34.230Z,1706662894.230 [DataOverHttps](INFO): Moved sent file to Logs/20240131T005042/Courier0000.lzma.bak 2024-01-31T01:01:34.230Z,1706662894.230 [DataOverHttps](INFO): SBD MOMSN=19252162 2024-01-31T01:01:34.593Z,1706662894.593 [DAT](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2024-01-31T01:01:34.593Z,1706662894.593 [DAT] Communications Fault, FailCount= 7 2024-01-31T01:01:34.593Z,1706662894.593 [DAT](ERROR): Communications Fault 2024-01-31T01:01:34.902Z,1706662894.902 [CBIT](ERROR): Communications Fault in component: DAT 2024-01-31T01:01:34.996Z,1706662894.996 [DAT](INFO): Powering down 2024-01-31T01:01:36.124Z,1706662896.124 [CBIT](INFO): Clearing failed state for component DAT 2024-01-31T01:01:36.124Z,1706662896.124 [DAT] No Fault, FailCount= 7 2024-01-31T01:01:38.044Z,1706662898.044 [DAT](INFO): Powering up 2024-01-31T01:01:38.044Z,1706662898.044 [DAT](DEBUG): Initializing DAT. 2024-01-31T01:01:50.164Z,1706662910.164 [DataOverHttps](INFO): Sending 317 bytes from file Logs/20240131T005403/Courier0000.lzma 2024-01-31T01:01:51.166Z,1706662911.166 [DataOverHttps](INFO): Moved sent file to Logs/20240131T005403/Courier0000.lzma.bak 2024-01-31T01:01:51.166Z,1706662911.166 [DataOverHttps](IMPORTANT): SBD MOMSN=19252170, MTMSN=20240131T010150 2024-01-31T01:01:58.564Z,1706662918.564 [DataOverHttps](INFO): Received command: ibit 2024-01-31T01:01:58.570Z,1706662918.570 [CommandExec](IMPORTANT): got command ibit 2024-01-31T01:01:58.737Z,1706662918.737 [IBIT](IMPORTANT): Beginning Initiated BIT 2024-01-31T01:01:58.737Z,1706662918.737 [IBIT](IMPORTANT): Beginning control surface checks. 2024-01-31T01:01:58.745Z,1706662918.745 [CBIT](IMPORTANT): Beginning ground fault scan 2024-01-31T01:02:00.319Z,1706662920.319 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010158.00,A,3648.17415,N,12147.28347,W,0.078,357.05,310124,,,A*7B 2024-01-31T01:02:00.321Z,1706662920.321 [NAL9602](INFO): GPS fix at 20240131T010158: (36.802903, -121.788058) 2024-01-31T01:02:02.739Z,1706662922.739 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010201.00,A,3648.17417,N,12147.28346,W,0.039,357.05,310124,,,A*72 2024-01-31T01:02:02.742Z,1706662922.742 [NAL9602](INFO): GPS fix at 20240131T010201: (36.802903, -121.788058) 2024-01-31T01:02:05.971Z,1706662925.971 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010204.00,A,3648.17417,N,12147.28350,W,0.019,357.05,310124,,,A*72 2024-01-31T01:02:05.974Z,1706662925.974 [NAL9602](INFO): GPS fix at 20240131T010204: (36.802903, -121.788058) 2024-01-31T01:02:08.798Z,1706662928.798 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010207.00,A,3648.17416,N,12147.28351,W,0.039,357.05,310124,,,A*73 2024-01-31T01:02:08.800Z,1706662928.800 [NAL9602](INFO): GPS fix at 20240131T010207: (36.802903, -121.788059) 2024-01-31T01:02:09.264Z,1706662929.264 [DataOverHttps](INFO): Sending 288 bytes from file Logs/20240131T005403/Courier0004.lzma 2024-01-31T01:02:09.752Z,1706662929.752 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.000461 CHAN A1 (24V): 0.000076 CHAN A2 (12V): 0.000096 CHAN A3 (5V): -0.001269 CHAN B0 (3.3V): 0.000204 CHAN B1 (3.15aV): 0.000431 CHAN B2 (3.15bV): -0.000413 CHAN B3 (GND): -0.000510 OPEN: 0.007072 Full Scale: +/- 1 mA 2024-01-31T01:02:10.266Z,1706662930.266 [DataOverHttps](INFO): Moved sent file to Logs/20240131T005403/Courier0004.lzma.bak 2024-01-31T01:02:10.266Z,1706662930.266 [DataOverHttps](INFO): SBD MOMSN=19252177 2024-01-31T01:02:12.036Z,1706662932.036 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010210.00,A,3648.17413,N,12147.28355,W,0.019,357.05,310124,,,A*76 2024-01-31T01:02:12.038Z,1706662932.038 [NAL9602](INFO): GPS fix at 20240131T010210: (36.802902, -121.788059) 2024-01-31T01:02:14.863Z,1706662934.863 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010213.00,A,3648.17413,N,12147.28360,W,0.019,357.05,310124,,,A*73 2024-01-31T01:02:14.865Z,1706662934.865 [NAL9602](INFO): GPS fix at 20240131T010213: (36.802902, -121.788060) 2024-01-31T01:02:17.686Z,1706662937.686 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010215.00,A,3648.17414,N,12147.28362,W,0.019,357.05,310124,,,A*70 2024-01-31T01:02:17.688Z,1706662937.688 [NAL9602](INFO): GPS fix at 20240131T010215: (36.802902, -121.788060) 2024-01-31T01:02:20.918Z,1706662940.918 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010219.00,A,3648.17411,N,12147.28368,W,0.019,357.05,310124,,,A*73 2024-01-31T01:02:20.921Z,1706662940.921 [NAL9602](INFO): GPS fix at 20240131T010219: (36.802902, -121.788061) 2024-01-31T01:02:23.751Z,1706662943.751 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010222.00,A,3648.17410,N,12147.28373,W,0.019,357.05,310124,,,A*70 2024-01-31T01:02:23.762Z,1706662943.762 [NAL9602](INFO): GPS fix at 20240131T010222: (36.802902, -121.788062) 2024-01-31T01:02:26.983Z,1706662946.983 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010225.00,A,3648.17414,N,12147.28379,W,0.058,357.05,310124,,,A*7C 2024-01-31T01:02:26.985Z,1706662946.985 [NAL9602](INFO): GPS fix at 20240131T010225: (36.802902, -121.788063) 2024-01-31T01:02:27.383Z,1706662947.383 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240131T005403/Courier0007.lzma 2024-01-31T01:02:28.386Z,1706662948.386 [DataOverHttps](INFO): Moved sent file to Logs/20240131T005403/Courier0007.lzma.bak 2024-01-31T01:02:28.386Z,1706662948.386 [DataOverHttps](INFO): SBD MOMSN=19252180 2024-01-31T01:02:29.811Z,1706662949.811 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010228.00,A,3648.17416,N,12147.28388,W,0.019,357.05,310124,,,A*78 2024-01-31T01:02:29.813Z,1706662949.813 [NAL9602](INFO): GPS fix at 20240131T010228: (36.802903, -121.788065) 2024-01-31T01:02:33.043Z,1706662953.043 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010231.00,A,3648.17420,N,12147.28398,W,0.039,357.05,310124,,,A*76 2024-01-31T01:02:33.045Z,1706662953.045 [NAL9602](INFO): GPS fix at 20240131T010231: (36.802903, -121.788066) 2024-01-31T01:02:35.867Z,1706662955.867 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010234.00,A,3648.17425,N,12147.28407,W,0.058,357.05,310124,,,A*70 2024-01-31T01:02:35.870Z,1706662955.870 [NAL9602](INFO): GPS fix at 20240131T010234: (36.802904, -121.788068) 2024-01-31T01:02:38.077Z,1706662958.077 [DAT](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2024-01-31T01:02:38.077Z,1706662958.077 [DAT] Communications Fault, FailCount= 8 2024-01-31T01:02:38.077Z,1706662958.077 [DAT](ERROR): Communications Fault 2024-01-31T01:02:38.326Z,1706662958.326 [CBIT](ERROR): Communications Fault in component: DAT 2024-01-31T01:02:38.326Z,1706662958.326 [CBIT](FAULT): Communications Fault in component: DAT 2024-01-31T01:02:38.480Z,1706662958.480 [DAT](INFO): Powering down 2024-01-31T01:02:38.699Z,1706662958.699 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010236.00,A,3648.17426,N,12147.28413,W,0.039,357.05,310124,,,A*73 2024-01-31T01:02:38.702Z,1706662958.702 [NAL9602](INFO): GPS fix at 20240131T010236: (36.802904, -121.788069) 2024-01-31T01:02:41.931Z,1706662961.931 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010240.00,A,3648.17428,N,12147.28431,W,0.019,357.05,310124,,,A*7E 2024-01-31T01:02:41.933Z,1706662961.933 [NAL9602](INFO): GPS fix at 20240131T010240: (36.802905, -121.788072) 2024-01-31T01:02:44.755Z,1706662964.755 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010243.00,A,3648.17427,N,12147.28447,W,0.058,357.05,310124,,,A*76 2024-01-31T01:02:44.758Z,1706662964.758 [NAL9602](INFO): GPS fix at 20240131T010243: (36.802904, -121.788074) 2024-01-31T01:02:45.652Z,1706662965.652 [DataOverHttps](INFO): Sending 333 bytes from file Logs/20240130T231742/Express0020.lzma 2024-01-31T01:02:46.654Z,1706662966.654 [DataOverHttps](INFO): Moved sent file to Logs/20240130T231742/Express0020.lzma.bak 2024-01-31T01:02:46.654Z,1706662966.654 [DataOverHttps](INFO): SBD MOMSN=19252182 2024-01-31T01:02:48.015Z,1706662968.015 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010246.00,A,3648.17428,N,12147.28463,W,0.019,357.05,310124,,,A*7F 2024-01-31T01:02:48.021Z,1706662968.021 [NAL9602](INFO): GPS fix at 20240131T010246: (36.802905, -121.788077) 2024-01-31T01:02:50.819Z,1706662970.819 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010249.00,A,3648.17429,N,12147.28483,W,0.039,357.05,310124,,,A*7D 2024-01-31T01:02:50.822Z,1706662970.822 [NAL9602](INFO): GPS fix at 20240131T010249: (36.802905, -121.788081) 2024-01-31T01:02:53.676Z,1706662973.676 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010251.00,A,3648.17426,N,12147.28495,W,0.058,357.05,310124,,,A*7B 2024-01-31T01:02:53.678Z,1706662973.678 [NAL9602](INFO): GPS fix at 20240131T010251: (36.802904, -121.788083) 2024-01-31T01:02:56.939Z,1706662976.939 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010255.00,A,3648.17419,N,12147.28512,W,0.058,357.05,310124,,,A*7D 2024-01-31T01:02:56.941Z,1706662976.941 [NAL9602](INFO): GPS fix at 20240131T010255: (36.802903, -121.788085) 2024-01-31T01:02:59.759Z,1706662979.759 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010258.00,A,3648.17412,N,12147.28523,W,0.039,357.05,310124,,,A*7E 2024-01-31T01:02:59.761Z,1706662979.761 [NAL9602](INFO): GPS fix at 20240131T010258: (36.802902, -121.788087) 2024-01-31T01:03:02.999Z,1706662982.999 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010301.00,A,3648.17406,N,12147.28533,W,0.019,357.05,310124,,,A*75 2024-01-31T01:03:03.005Z,1706662983.005 [NAL9602](INFO): GPS fix at 20240131T010301: (36.802901, -121.788089) 2024-01-31T01:03:05.815Z,1706662985.815 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010304.00,A,3648.17401,N,12147.28540,W,0.078,357.05,310124,,,A*74 2024-01-31T01:03:05.817Z,1706662985.817 [NAL9602](INFO): GPS fix at 20240131T010304: (36.802900, -121.788090) 2024-01-31T01:03:07.319Z,1706662987.319 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20240130T231742/Express0023.lzma 2024-01-31T01:03:08.322Z,1706662988.322 [DataOverHttps](INFO): Moved sent file to Logs/20240130T231742/Express0023.lzma.bak 2024-01-31T01:03:08.322Z,1706662988.322 [DataOverHttps](INFO): SBD MOMSN=19252196 2024-01-31T01:03:08.644Z,1706662988.644 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010306.00,A,3648.17400,N,12147.28544,W,0.019,357.05,310124,,,A*74 2024-01-31T01:03:08.646Z,1706662988.646 [NAL9602](INFO): GPS fix at 20240131T010306: (36.802900, -121.788091) 2024-01-31T01:03:11.879Z,1706662991.879 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010310.00,A,3648.17398,N,12147.28550,W,0.039,357.05,310124,,,A*72 2024-01-31T01:03:11.882Z,1706662991.882 [NAL9602](INFO): GPS fix at 20240131T010310: (36.802900, -121.788092) 2024-01-31T01:03:14.703Z,1706662994.703 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010312.00,A,3648.17398,N,12147.28550,W,0.058,357.05,310124,,,A*77 2024-01-31T01:03:14.705Z,1706662994.705 [NAL9602](INFO): GPS fix at 20240131T010312: (36.802900, -121.788092) 2024-01-31T01:03:15.537Z,1706662995.537 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-01-31T01:03:15.537Z,1706662995.537 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-01-31T01:03:15.588Z,1706662995.588 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-01-31T01:03:15.942Z,1706662995.942 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-01-31T01:03:15.942Z,1706662995.942 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-01-31T01:03:17.939Z,1706662997.939 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010316.00,A,3648.17395,N,12147.28549,W,0.078,357.05,310124,,,A*74 2024-01-31T01:03:17.941Z,1706662997.941 [NAL9602](INFO): GPS fix at 20240131T010316: (36.802899, -121.788091) 2024-01-31T01:03:20.772Z,1706663000.772 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010319.00,A,3648.17398,N,12147.28545,W,0.058,357.05,310124,,,A*78 2024-01-31T01:03:20.774Z,1706663000.774 [NAL9602](INFO): GPS fix at 20240131T010319: (36.802900, -121.788091) 2024-01-31T01:03:23.995Z,1706663003.995 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010322.00,A,3648.17393,N,12147.28548,W,0.019,357.05,310124,,,A*73 2024-01-31T01:03:23.997Z,1706663003.997 [NAL9602](INFO): GPS fix at 20240131T010322: (36.802899, -121.788091) 2024-01-31T01:03:25.282Z,1706663005.282 [DataOverHttps](INFO): Sending 1195 bytes from file Logs/20240131T005042/Express0001.lzma 2024-01-31T01:03:26.282Z,1706663006.282 [DataOverHttps](INFO): Moved sent file to Logs/20240131T005042/Express0001.lzma.bak 2024-01-31T01:03:26.282Z,1706663006.282 [DataOverHttps](INFO): SBD MOMSN=19252199 2024-01-31T01:03:26.831Z,1706663006.831 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010325.00,A,3648.17392,N,12147.28553,W,0.097,357.05,310124,,,A*79 2024-01-31T01:03:26.834Z,1706663006.834 [NAL9602](INFO): GPS fix at 20240131T010325: (36.802899, -121.788092) 2024-01-31T01:03:29.655Z,1706663009.655 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010327.00,A,3648.17393,N,12147.28559,W,0.039,357.05,310124,,,A*74 2024-01-31T01:03:29.657Z,1706663009.657 [NAL9602](INFO): GPS fix at 20240131T010327: (36.802899, -121.788093) 2024-01-31T01:03:32.883Z,1706663012.883 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010331.00,A,3648.17390,N,12147.28572,W,0.078,357.05,310124,,,A*7C 2024-01-31T01:03:32.885Z,1706663012.885 [NAL9602](INFO): GPS fix at 20240131T010331: (36.802898, -121.788095) 2024-01-31T01:03:35.715Z,1706663015.715 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010334.00,A,3648.17389,N,12147.28580,W,0.058,357.05,310124,,,A*7E 2024-01-31T01:03:35.717Z,1706663015.717 [NAL9602](INFO): GPS fix at 20240131T010334: (36.802898, -121.788097) 2024-01-31T01:03:38.943Z,1706663018.943 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010338.00,A,3648.17387,N,12147.28584,W,0.039,357.05,310124,,,A*7F 2024-01-31T01:03:38.945Z,1706663018.945 [NAL9602](INFO): GPS fix at 20240131T010338: (36.802898, -121.788097) 2024-01-31T01:03:41.771Z,1706663021.771 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010341.00,A,3648.17384,N,12147.28589,W,0.058,357.05,310124,,,A*78 2024-01-31T01:03:41.773Z,1706663021.773 [NAL9602](INFO): GPS fix at 20240131T010341: (36.802897, -121.788098) 2024-01-31T01:03:43.127Z,1706663023.127 [DataOverHttps](INFO): Sending 38 bytes from file Logs/20240131T005042/Express0005.lzma 2024-01-31T01:03:44.130Z,1706663024.130 [DataOverHttps](INFO): Moved sent file to Logs/20240131T005042/Express0005.lzma.bak 2024-01-31T01:03:44.130Z,1706663024.130 [DataOverHttps](INFO): SBD MOMSN=19252235 2024-01-31T01:03:45.012Z,1706663025.012 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010344.00,A,3648.17390,N,12147.28583,W,0.019,357.05,310124,,,A*77 2024-01-31T01:03:45.014Z,1706663025.014 [NAL9602](INFO): GPS fix at 20240131T010344: (36.802898, -121.788097) 2024-01-31T01:03:47.831Z,1706663027.831 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010347.00,A,3648.17394,N,12147.28580,W,0.078,357.05,310124,,,A*74 2024-01-31T01:03:47.834Z,1706663027.834 [NAL9602](INFO): GPS fix at 20240131T010347: (36.802899, -121.788097) 2024-01-31T01:03:49.518Z,1706663029.518 [IBIT](FAULT): Error acquiring IBIT communications status. Timeout expired. 2024-01-31T01:03:49.905Z,1706663029.905 [IBIT](IMPORTANT): Battery Status: Battery Charge (AH): 0.000000 Voltage: 14.312000 2024-01-31T01:03:49.905Z,1706663029.905 [IBIT](IMPORTANT): batteryCapacityThreshold: 20.000000 Ah 2024-01-31T01:03:49.906Z,1706663029.906 [IBIT](IMPORTANT): batteryVoltageThreshold: 12.000000 V 2024-01-31T01:03:50.316Z,1706663030.316 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 % 2024-01-31T01:03:50.316Z,1706663030.316 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi 2024-01-31T01:03:50.317Z,1706663030.317 [IBIT](ERROR): Pressure failed. Onboard reading:14.713098 PSI 2024-01-31T01:03:50.317Z,1706663030.317 [IBIT](IMPORTANT): Humidity:48.101574 % 2024-01-31T01:03:50.667Z,1706663030.667 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010349.00,A,3648.17396,N,12147.28578,W,0.039,357.05,310124,,,A*7A 2024-01-31T01:03:50.669Z,1706663030.669 [NAL9602](INFO): GPS fix at 20240131T010349: (36.802899, -121.788096) 2024-01-31T01:03:50.706Z,1706663030.706 [IBIT](IMPORTANT): Vehicle Pitch:-1.352831 degrees 2024-01-31T01:03:50.707Z,1706663030.707 [IBIT](IMPORTANT): Vehicle Roll:0.353949 degrees 2024-01-31T01:03:50.707Z,1706663030.707 [IBIT](IMPORTANT): Vehicle Heading:308.996002 degrees 2024-01-31T01:03:51.129Z,1706663031.129 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m 2024-01-31T01:03:51.129Z,1706663031.129 [IBIT](IMPORTANT): buoyancyNeutral: 185.760376 cc 2024-01-31T01:03:51.129Z,1706663031.129 [IBIT](IMPORTANT): massDefault: 1.363008 cm 2024-01-31T01:03:51.130Z,1706663031.130 [IBIT](IMPORTANT): stopDepth: 112.000000 m 2024-01-31T01:03:51.130Z,1706663031.130 [IBIT](IMPORTANT): abortDepth: 130.000000 m 2024-01-31T01:03:51.130Z,1706663031.130 [IBIT](IMPORTANT): IBIT FAILED 2024-01-31T01:04:01.177Z,1706663041.177 [DataOverHttps](INFO): Sending 1139 bytes from file Logs/20240131T005403/Express0001.lzma 2024-01-31T01:04:02.178Z,1706663042.178 [DataOverHttps](INFO): Moved sent file to Logs/20240131T005403/Express0001.lzma.bak 2024-01-31T01:04:02.178Z,1706663042.178 [DataOverHttps](INFO): SBD MOMSN=19252237 2024-01-31T01:04:19.020Z,1706663059.020 [DataOverHttps](INFO): Sending 441 bytes from file Logs/20240131T005403/Express0005.lzma 2024-01-31T01:04:20.022Z,1706663060.022 [DataOverHttps](INFO): Moved sent file to Logs/20240131T005403/Express0005.lzma.bak 2024-01-31T01:04:20.022Z,1706663060.022 [DataOverHttps](INFO): SBD MOMSN=19252269 2024-01-31T01:04:23.379Z,1706663063.379 [NAL9602](INFO): Not Powering down - fast GPS 2024-01-31T01:04:28.181Z,1706663068.181 [CommandLine](INFO): End of History 2024-01-31T01:04:28.185Z,1706663068.185 [CommandLine](INFO): End of History 2024-01-31T01:04:28.189Z,1706663068.189 [CommandLine](INFO): End of History 2024-01-31T01:04:28.191Z,1706663068.191 [CommandLine](INFO): End of History 2024-01-31T01:04:28.192Z,1706663068.192 [CommandLine](INFO): End of History 2024-01-31T01:04:28.193Z,1706663068.193 [CommandLine](INFO): End of History 2024-01-31T01:04:28.194Z,1706663068.194 [CommandLine](INFO): End of History 2024-01-31T01:04:28.195Z,1706663068.195 [CommandLine](INFO): End of History 2024-01-31T01:04:28.195Z,1706663068.195 [CommandLine](INFO): End of History 2024-01-31T01:04:36.752Z,1706663076.752 [DataOverHttps](INFO): Sending 303 bytes from file Logs/20240131T005403/Express0008.lzma 2024-01-31T01:04:37.754Z,1706663077.754 [DataOverHttps](INFO): Moved sent file to Logs/20240131T005403/Express0008.lzma.bak 2024-01-31T01:04:37.754Z,1706663077.754 [DataOverHttps](INFO): SBD MOMSN=19252276 2024-01-31T01:04:39.974Z,1706663079.974 [Default:CheckIn:Read_Iridium] Stopped 2024-01-31T01:04:39.974Z,1706663079.974 [Default:CheckIn:C.Wait] Running Loop=1 2024-01-31T01:04:39.975Z,1706663079.975 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-01-31T01:05:14.739Z,1706663114.739 [Power24vConverter](INFO): Powering down. 2024-01-31T01:06:16.562Z,1706663176.562 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-01-31T01:06:16.562Z,1706663176.562 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-01-31T01:06:16.573Z,1706663176.573 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-01-31T01:06:16.985Z,1706663176.985 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-01-31T01:06:16.985Z,1706663176.985 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-01-31T01:07:38.216Z,1706663258.216 [CBIT](INFO): Clearing failed state for component DAT 2024-01-31T01:07:38.216Z,1706663258.216 [DAT] No Fault, FailCount= 8 2024-01-31T01:07:38.488Z,1706663258.488 [DAT](INFO): Powering up 2024-01-31T01:07:38.488Z,1706663258.488 [DAT](DEBUG): Initializing DAT. 2024-01-31T01:07:38.601Z,1706663258.602 [Power24vConverter](INFO): Powering up. 2024-01-31T01:08:38.737Z,1706663318.737 [DAT](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2024-01-31T01:08:38.737Z,1706663318.737 [DAT] Communications Fault, FailCount= 1 2024-01-31T01:08:38.737Z,1706663318.737 [DAT](ERROR): Communications Fault 2024-01-31T01:08:38.859Z,1706663318.859 [CBIT](ERROR): Communications Fault in component: DAT 2024-01-31T01:08:39.140Z,1706663319.140 [DAT](INFO): Powering down 2024-01-31T01:08:40.038Z,1706663320.038 [CBIT](INFO): Clearing failed state for component DAT 2024-01-31T01:08:40.039Z,1706663320.039 [DAT] No Fault, FailCount= 1 2024-01-31T01:08:42.200Z,1706663322.200 [DAT](INFO): Powering up 2024-01-31T01:08:42.200Z,1706663322.200 [DAT](DEBUG): Initializing DAT. 2024-01-31T01:08:46.802Z,1706663326.802 [CommandLine](INFO): End of History 2024-01-31T01:08:46.806Z,1706663326.806 [CommandLine](INFO): End of History 2024-01-31T01:08:46.809Z,1706663326.809 [CommandLine](INFO): End of History 2024-01-31T01:08:46.840Z,1706663326.840 [CommandLine](INFO): End of History 2024-01-31T01:08:46.841Z,1706663326.841 [CommandLine](INFO): End of History 2024-01-31T01:08:46.842Z,1706663326.842 [CommandLine](INFO): End of History 2024-01-31T01:08:46.843Z,1706663326.843 [CommandLine](INFO): End of History 2024-01-31T01:08:46.844Z,1706663326.844 [CommandLine](INFO): End of History 2024-01-31T01:09:13.974Z,1706663353.974 [CBIT](INFO): Clearing failed state for component DropWeight 2024-01-31T01:09:13.974Z,1706663353.974 [DropWeight] No Fault, FailCount= 1 2024-01-31T01:09:17.588Z,1706663357.588 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-01-31T01:09:17.588Z,1706663357.588 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-01-31T01:09:17.612Z,1706663357.612 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-01-31T01:09:18.008Z,1706663358.008 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-01-31T01:09:18.009Z,1706663358.009 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-01-31T01:09:40.617Z,1706663380.617 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-01-31T01:09:40.617Z,1706663380.617 [Default:CheckIn:C.Wait] Stopped 2024-01-31T01:09:40.617Z,1706663380.617 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-01-31T01:09:40.618Z,1706663380.618 [Default:CheckIn:D] Running Loop=1 2024-01-31T01:09:41.030Z,1706663381.030 [Default:CheckIn:D] Stopped 2024-01-31T01:09:41.030Z,1706663381.030 [Default:CheckIn:E] Running Loop=1 2024-01-31T01:09:41.434Z,1706663381.434 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 11.309607 min 2024-01-31T01:09:41.434Z,1706663381.434 [Default:CheckIn:E] Stopped 2024-01-31T01:09:41.434Z,1706663381.434 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-01-31T01:09:41.434Z,1706663381.434 [Default:CheckIn] Stopped 2024-01-31T01:09:41.434Z,1706663381.434 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-01-31T01:09:41.435Z,1706663381.435 [Default:CheckIn](INFO): Running loop #2 2024-01-31T01:09:41.435Z,1706663381.435 [Default:CheckIn] Running Loop=2 2024-01-31T01:09:41.435Z,1706663381.435 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-01-31T01:09:41.435Z,1706663381.435 [Default:CheckIn:Read_GPS] Running Loop=1 2024-01-31T01:09:42.269Z,1706663382.269 [DAT](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2024-01-31T01:09:42.269Z,1706663382.269 [DAT] Communications Fault, FailCount= 2 2024-01-31T01:09:42.269Z,1706663382.269 [DAT](ERROR): Communications Fault 2024-01-31T01:09:42.660Z,1706663382.660 [CBIT](ERROR): Communications Fault in component: DAT 2024-01-31T01:09:42.672Z,1706663382.672 [DAT](INFO): Powering down 2024-01-31T01:09:43.439Z,1706663383.439 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010942.00,A,3648.17469,N,12147.28409,W,0.136,357.05,310124,,,A*75 2024-01-31T01:09:43.441Z,1706663383.441 [NAL9602](INFO): GPS fix at 20240131T010942: (36.802912, -121.788068) 2024-01-31T01:09:43.481Z,1706663383.481 [Default:CheckIn:Read_GPS] Stopped 2024-01-31T01:09:43.481Z,1706663383.481 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-01-31T01:09:43.903Z,1706663383.903 [CBIT](INFO): Clearing failed state for component DAT 2024-01-31T01:09:43.903Z,1706663383.903 [DAT] No Fault, FailCount= 2 2024-01-31T01:09:45.720Z,1706663385.720 [DAT](INFO): Powering up 2024-01-31T01:09:45.720Z,1706663385.720 [DAT](DEBUG): Initializing DAT. 2024-01-31T01:09:50.871Z,1706663390.871 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20240131T005403/Courier0010.lzma 2024-01-31T01:09:51.874Z,1706663391.874 [DataOverHttps](INFO): Moved sent file to Logs/20240131T005403/Courier0010.lzma.bak 2024-01-31T01:09:51.874Z,1706663391.874 [DataOverHttps](INFO): SBD MOMSN=19252284 2024-01-31T01:10:08.817Z,1706663408.817 [DataOverHttps](INFO): Sending 752 bytes from file Logs/20240131T005403/Express0011.lzma 2024-01-31T01:10:09.818Z,1706663409.818 [DataOverHttps](INFO): Moved sent file to Logs/20240131T005403/Express0011.lzma.bak 2024-01-31T01:10:09.818Z,1706663409.818 [DataOverHttps](INFO): SBD MOMSN=19252287 2024-01-31T01:10:12.150Z,1706663412.150 [Default:CheckIn:Read_Iridium] Stopped 2024-01-31T01:10:12.150Z,1706663412.150 [Default:CheckIn:C.Wait] Running Loop=1 2024-01-31T01:10:12.151Z,1706663412.151 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-01-31T01:10:14.137Z,1706663414.137 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2024-01-31T01:10:14.656Z,1706663414.656 [NAL9602](ERROR): received: 2024-01-31T01:10:31.727Z,1706663431.727 [NAL9602](INFO): SBD MO Status=0, MOMSN=9444, MT Status=0, MTMSN=0 2024-01-31T01:10:31.728Z,1706663431.728 [NAL9602](INFO): No messages in MT queue 2024-01-31T01:10:45.753Z,1706663445.753 [DAT](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2024-01-31T01:10:45.753Z,1706663445.753 [DAT] Communications Fault, FailCount= 3 2024-01-31T01:10:45.753Z,1706663445.753 [DAT](ERROR): Communications Fault 2024-01-31T01:10:45.891Z,1706663445.891 [CBIT](ERROR): Communications Fault in component: DAT 2024-01-31T01:10:46.157Z,1706663446.157 [DAT](INFO): Powering down 2024-01-31T01:10:47.127Z,1706663447.127 [CBIT](INFO): Clearing failed state for component DAT 2024-01-31T01:10:47.127Z,1706663447.127 [DAT] No Fault, FailCount= 3 2024-01-31T01:10:49.212Z,1706663449.212 [DAT](INFO): Powering up 2024-01-31T01:10:49.213Z,1706663449.213 [DAT](DEBUG): Initializing DAT. 2024-01-31T01:11:02.445Z,1706663462.445 [NAL9602](INFO): Not Powering down - fast GPS 2024-01-31T01:11:27.669Z,1706663487.669 [CommandExec](IMPORTANT): got command ibit 2024-01-31T01:11:27.933Z,1706663487.933 [IBIT](IMPORTANT): Beginning Initiated BIT 2024-01-31T01:11:27.933Z,1706663487.933 [IBIT](IMPORTANT): Beginning control surface checks. 2024-01-31T01:11:27.940Z,1706663487.940 [CBIT](IMPORTANT): Beginning ground fault scan 2024-01-31T01:11:29.507Z,1706663489.507 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011128.00,A,3648.17462,N,12147.28361,W,0.058,357.05,310124,,,A*7B 2024-01-31T01:11:29.509Z,1706663489.509 [NAL9602](INFO): GPS fix at 20240131T011128: (36.802910, -121.788060) 2024-01-31T01:11:38.936Z,1706663498.936 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.000414 CHAN A1 (24V): 0.000718 CHAN A2 (12V): 0.000190 CHAN A3 (5V): -0.001703 CHAN B0 (3.3V): 0.000322 CHAN B1 (3.15aV): -0.000293 CHAN B2 (3.15bV): 0.000283 CHAN B3 (GND): -0.000279 OPEN: 0.006957 Full Scale: +/- 1 mA 2024-01-31T01:11:49.253Z,1706663509.253 [DAT](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2024-01-31T01:11:49.253Z,1706663509.253 [DAT] Communications Fault, FailCount= 4 2024-01-31T01:11:49.253Z,1706663509.253 [DAT](ERROR): Communications Fault 2024-01-31T01:11:49.529Z,1706663509.529 [CBIT](ERROR): Communications Fault in component: DAT 2024-01-31T01:11:49.657Z,1706663509.657 [DAT](INFO): Powering down 2024-01-31T01:11:50.584Z,1706663510.584 [CBIT](INFO): Clearing failed state for component DAT 2024-01-31T01:11:50.585Z,1706663510.585 [DAT] No Fault, FailCount= 4 2024-01-31T01:11:50.919Z,1706663510.919 [NAL9602](INFO): SBD MO Status=0, MOMSN=9445, MT Status=0, MTMSN=0 2024-01-31T01:11:50.919Z,1706663510.919 [NAL9602](INFO): No messages in MT queue 2024-01-31T01:11:52.130Z,1706663512.130 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011151.00,A,3648.17465,N,12147.28380,W,0.097,357.05,310124,,,A*7E 2024-01-31T01:11:52.133Z,1706663512.133 [NAL9602](INFO): GPS fix at 20240131T011151: (36.802911, -121.788063) 2024-01-31T01:11:52.704Z,1706663512.704 [DAT](INFO): Powering up 2024-01-31T01:11:52.704Z,1706663512.704 [DAT](DEBUG): Initializing DAT. 2024-01-31T01:11:54.959Z,1706663514.959 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011154.00,A,3648.17459,N,12147.28385,W,0.078,357.05,310124,,,A*70 2024-01-31T01:11:54.961Z,1706663514.961 [NAL9602](INFO): GPS fix at 20240131T011154: (36.802910, -121.788064) 2024-01-31T01:11:57.787Z,1706663517.787 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011157.00,A,3648.17452,N,12147.28390,W,0.117,357.05,310124,,,A*74 2024-01-31T01:11:57.790Z,1706663517.790 [NAL9602](INFO): GPS fix at 20240131T011157: (36.802909, -121.788065) 2024-01-31T01:12:01.020Z,1706663521.020 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011200.00,A,3648.17447,N,12147.28394,W,0.097,357.05,310124,,,A*7C 2024-01-31T01:12:01.022Z,1706663521.022 [NAL9602](INFO): GPS fix at 20240131T011200: (36.802908, -121.788066) 2024-01-31T01:12:03.846Z,1706663523.846 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011203.00,A,3648.17441,N,12147.28399,W,0.058,357.05,310124,,,A*77 2024-01-31T01:12:03.848Z,1706663523.848 [NAL9602](INFO): GPS fix at 20240131T011203: (36.802907, -121.788066) 2024-01-31T01:12:06.680Z,1706663526.680 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011205.00,A,3648.17434,N,12147.28403,W,0.039,357.05,310124,,,A*70 2024-01-31T01:12:06.682Z,1706663526.682 [NAL9602](INFO): GPS fix at 20240131T011205: (36.802906, -121.788067) 2024-01-31T01:12:09.911Z,1706663529.911 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011209.00,A,3648.17425,N,12147.28403,W,0.078,357.05,310124,,,A*79 2024-01-31T01:12:09.914Z,1706663529.914 [NAL9602](INFO): GPS fix at 20240131T011209: (36.802904, -121.788067) 2024-01-31T01:12:12.734Z,1706663532.734 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011212.00,A,3648.17420,N,12147.28403,W,0.039,357.05,310124,,,A*73 2024-01-31T01:12:12.747Z,1706663532.747 [NAL9602](INFO): GPS fix at 20240131T011212: (36.802903, -121.788067) 2024-01-31T01:12:13.969Z,1706663533.969 [IBIT](IMPORTANT): Communications Status: Fix Status: 1 Iridium Signal Strength: 2 Latitude: 36.802902 Longitude: -121.788071 2024-01-31T01:12:14.393Z,1706663534.393 [IBIT](IMPORTANT): Battery Status: Battery Charge (AH): 0.000000 Voltage: 14.312000 2024-01-31T01:12:14.393Z,1706663534.393 [IBIT](IMPORTANT): batteryCapacityThreshold: 20.000000 Ah 2024-01-31T01:12:14.394Z,1706663534.394 [IBIT](IMPORTANT): batteryVoltageThreshold: 12.000000 V 2024-01-31T01:12:14.780Z,1706663534.780 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 % 2024-01-31T01:12:14.780Z,1706663534.780 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi 2024-01-31T01:12:14.781Z,1706663534.781 [IBIT](ERROR): Pressure failed. Onboard reading:14.713590 PSI 2024-01-31T01:12:14.781Z,1706663534.781 [IBIT](FAULT): Humidity failed. Onboard reading:57.666950 % 2024-01-31T01:12:15.187Z,1706663535.187 [IBIT](IMPORTANT): Vehicle Pitch:-1.292899 degrees 2024-01-31T01:12:15.187Z,1706663535.187 [IBIT](IMPORTANT): Vehicle Roll:0.358516 degrees 2024-01-31T01:12:15.187Z,1706663535.187 [IBIT](IMPORTANT): Vehicle Heading:309.064087 degrees 2024-01-31T01:12:15.604Z,1706663535.604 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m 2024-01-31T01:12:15.605Z,1706663535.605 [IBIT](IMPORTANT): buoyancyNeutral: 185.760376 cc 2024-01-31T01:12:15.605Z,1706663535.605 [IBIT](IMPORTANT): massDefault: 1.363008 cm 2024-01-31T01:12:15.605Z,1706663535.605 [IBIT](IMPORTANT): stopDepth: 112.000000 m 2024-01-31T01:12:15.605Z,1706663535.605 [IBIT](IMPORTANT): abortDepth: 130.000000 m 2024-01-31T01:12:15.605Z,1706663535.605 [IBIT](IMPORTANT): IBIT FAILED 2024-01-31T01:12:18.401Z,1706663538.401 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-01-31T01:12:18.401Z,1706663538.401 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-01-31T01:12:18.429Z,1706663538.429 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-01-31T01:12:18.815Z,1706663538.815 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-01-31T01:12:18.815Z,1706663538.815 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-01-31T01:12:45.457Z,1706663565.457 [NAL9602](INFO): Not Powering down - fast GPS 2024-01-31T01:12:52.757Z,1706663572.757 [DAT](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2024-01-31T01:12:52.757Z,1706663572.757 [DAT] Communications Fault, FailCount= 5 2024-01-31T01:12:52.757Z,1706663572.757 [DAT](ERROR): Communications Fault 2024-01-31T01:12:52.769Z,1706663572.769 [CBIT](ERROR): Communications Fault in component: DAT 2024-01-31T01:12:53.160Z,1706663573.160 [DAT](INFO): Powering down 2024-01-31T01:12:54.419Z,1706663574.419 [CBIT](INFO): Clearing failed state for component DAT 2024-01-31T01:12:54.419Z,1706663574.419 [DAT] No Fault, FailCount= 5 2024-01-31T01:12:56.220Z,1706663576.220 [DAT](INFO): Powering up 2024-01-31T01:12:56.220Z,1706663576.220 [DAT](DEBUG): Initializing DAT. 2024-01-31T01:13:56.237Z,1706663636.237 [DAT](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2024-01-31T01:13:56.237Z,1706663636.237 [DAT] Communications Fault, FailCount= 6 2024-01-31T01:13:56.237Z,1706663636.237 [DAT](ERROR): Communications Fault 2024-01-31T01:13:56.627Z,1706663636.627 [CBIT](ERROR): Communications Fault in component: DAT 2024-01-31T01:13:56.640Z,1706663636.640 [DAT](INFO): Powering down 2024-01-31T01:13:57.849Z,1706663637.849 [CBIT](INFO): Clearing failed state for component DAT 2024-01-31T01:13:57.849Z,1706663637.849 [DAT] No Fault, FailCount= 6 2024-01-31T01:13:59.704Z,1706663639.704 [DAT](INFO): Powering up 2024-01-31T01:13:59.704Z,1706663639.704 [DAT](DEBUG): Initializing DAT. 2024-01-31T01:14:59.773Z,1706663699.773 [DAT](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2024-01-31T01:14:59.773Z,1706663699.773 [DAT] Communications Fault, FailCount= 7 2024-01-31T01:14:59.773Z,1706663699.773 [DAT](ERROR): Communications Fault 2024-01-31T01:15:00.048Z,1706663700.048 [CBIT](ERROR): Communications Fault in component: DAT 2024-01-31T01:15:00.176Z,1706663700.176 [DAT](INFO): Powering down 2024-01-31T01:15:01.232Z,1706663701.232 [CBIT](INFO): Clearing failed state for component DAT 2024-01-31T01:15:01.233Z,1706663701.233 [DAT] No Fault, FailCount= 7 2024-01-31T01:15:03.224Z,1706663703.224 [DAT](INFO): Powering up 2024-01-31T01:15:03.225Z,1706663703.225 [DAT](DEBUG): Initializing DAT. 2024-01-31T01:15:12.949Z,1706663712.949 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-01-31T01:15:12.949Z,1706663712.949 [Default:CheckIn:C.Wait] Stopped 2024-01-31T01:15:12.949Z,1706663712.949 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-01-31T01:15:12.949Z,1706663712.949 [Default:CheckIn:D] Running Loop=1 2024-01-31T01:15:13.338Z,1706663713.338 [Default:CheckIn:D] Stopped 2024-01-31T01:15:13.338Z,1706663713.338 [Default:CheckIn:E] Running Loop=1 2024-01-31T01:15:13.746Z,1706663713.746 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 16.848076 min 2024-01-31T01:15:13.747Z,1706663713.747 [Default:CheckIn:E] Stopped 2024-01-31T01:15:13.747Z,1706663713.747 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-01-31T01:15:13.747Z,1706663713.747 [Default:CheckIn] Stopped 2024-01-31T01:15:13.747Z,1706663713.747 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-01-31T01:15:13.747Z,1706663713.747 [Default:CheckIn](INFO): Running loop #3 2024-01-31T01:15:13.747Z,1706663713.747 [Default:CheckIn] Running Loop=3 2024-01-31T01:15:13.747Z,1706663713.747 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-01-31T01:15:13.747Z,1706663713.747 [Default:CheckIn:Read_GPS] Running Loop=1 2024-01-31T01:15:19.412Z,1706663719.412 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-01-31T01:15:19.412Z,1706663719.412 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-01-31T01:15:19.423Z,1706663719.423 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-01-31T01:15:19.842Z,1706663719.842 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-01-31T01:15:19.842Z,1706663719.842 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-01-31T01:16:03.261Z,1706663763.261 [DAT](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2024-01-31T01:16:03.261Z,1706663763.261 [DAT] Communications Fault, FailCount= 8 2024-01-31T01:16:03.261Z,1706663763.261 [DAT](ERROR): Communications Fault 2024-01-31T01:16:03.483Z,1706663763.483 [CBIT](ERROR): Communications Fault in component: DAT 2024-01-31T01:16:03.484Z,1706663763.484 [CBIT](FAULT): Communications Fault in component: DAT 2024-01-31T01:16:03.664Z,1706663763.664 [DAT](INFO): Powering down 2024-01-31T01:18:20.468Z,1706663900.468 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 3 2024-01-31T01:18:20.468Z,1706663900.468 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-01-31T01:18:20.504Z,1706663900.504 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-01-31T01:18:20.884Z,1706663900.884 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-01-31T01:18:20.884Z,1706663900.884 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 3 2024-01-31T01:18:40.234Z,1706663920.234 [Power24vConverter](INFO): Powering down. 2024-01-31T01:19:24.921Z,1706663964.921 [CommandExec](IMPORTANT): got command quit 2024-01-31T01:19:25.924Z,1706663965.924 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-01-31T01:19:25.924Z,1706663965.924 [CommandExec](INFO): Uninitializing the command executive. 2024-01-31T01:19:25.925Z,1706663965.925 [CommandExec](INFO): Uninitializing the command scheduler. 2024-01-31T01:19:25.925Z,1706663965.925 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-01-31T01:19:26.004Z,1706663966.004 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-01-31T01:19:26.004Z,1706663966.004 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-01-31T01:19:26.004Z,1706663966.004 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-01-31T01:19:26.005Z,1706663966.005 [NavChartDb](INFO): Join timeout helper Thread ID is 9563 2024-01-31T01:19:26.252Z,1706663966.252 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-01-31T01:19:26.252Z,1706663966.252 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-01-31T01:19:26.264Z,1706663966.264 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-01-31T01:19:26.264Z,1706663966.264 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-01-31T01:19:26.265Z,1706663966.265 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 9564 2024-01-31T01:19:26.481Z,1706663966.481 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-01-31T01:19:26.481Z,1706663966.481 [WetLabsBB2FL](INFO): Powering down 2024-01-31T01:19:26.481Z,1706663966.481 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-01-31T01:19:26.492Z,1706663966.492 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-01-31T01:19:26.492Z,1706663966.492 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-01-31T01:19:26.492Z,1706663966.492 [CTD_Seabird](INFO): Join timeout helper Thread ID is 9565 2024-01-31T01:19:26.660Z,1706663966.660 [CTD_Seabird](INFO): Powering down 2024-01-31T01:19:26.672Z,1706663966.672 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-01-31T01:19:26.673Z,1706663966.673 [CTD_Seabird](INFO): Powering down 2024-01-31T01:19:26.684Z,1706663966.684 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-01-31T01:19:26.700Z,1706663966.700 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2024-01-31T01:19:26.700Z,1706663966.700 [DAT ThreadHandler](INFO): Thread cancelled. 2024-01-31T01:19:26.701Z,1706663966.701 [DAT](INFO): Join timeout helper Thread ID is 9566 2024-01-31T01:19:27.008Z,1706663967.008 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-01-31T01:19:27.008Z,1706663967.008 [DAT](INFO): Powering down 2024-01-31T01:19:27.009Z,1706663967.009 [DAT ThreadHandler](INFO): Thread cancelled. 2024-01-31T01:19:27.028Z,1706663967.028 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-01-31T01:19:27.028Z,1706663967.028 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-01-31T01:19:27.028Z,1706663967.028 [Radio_Surface](INFO): Join timeout helper Thread ID is 9567 2024-01-31T01:19:27.229Z,1706663967.229 [Radio_Surface](INFO): Powering down 2024-01-31T01:19:27.229Z,1706663967.229 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-01-31T01:19:27.230Z,1706663967.230 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-01-31T01:19:27.233Z,1706663967.233 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-01-31T01:19:27.233Z,1706663967.233 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-01-31T01:19:27.233Z,1706663967.233 [Onboard](INFO): Join timeout helper Thread ID is 9568 2024-01-31T01:19:27.676Z,1706663967.676 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2024-01-31T01:19:29.332Z,1706663969.332 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-01-31T01:19:29.332Z,1706663969.332 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-01-31T01:19:29.349Z,1706663969.349 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-01-31T01:19:29.349Z,1706663969.349 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-01-31T01:19:29.349Z,1706663969.349 [DataOverHttps](INFO): Join timeout helper Thread ID is 9569 2024-01-31T01:19:29.685Z,1706663969.685 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-01-31T01:19:29.685Z,1706663969.685 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-01-31T01:19:29.693Z,1706663969.693 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-01-31T01:19:29.693Z,1706663969.693 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-01-31T01:19:29.693Z,1706663969.693 [BackseatComponent](INFO): Join timeout helper Thread ID is 9570 2024-01-31T01:19:29.789Z,1706663969.789 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-01-31T01:19:29.789Z,1706663969.789 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-01-31T01:19:29.793Z,1706663969.793 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-01-31T01:19:29.793Z,1706663969.793 [logger ThreadHandler](INFO): Thread cancelled. 2024-01-31T01:19:29.793Z,1706663969.793 [logger](INFO): Join timeout helper Thread ID is 9571 2024-01-31T01:19:29.840Z,1706663969.840 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-01-31T01:19:29.840Z,1706663969.840 [logger ThreadHandler](INFO): Thread cancelled. 2024-01-31T01:19:29.853Z,1706663969.853 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-01-31T01:19:29.853Z,1706663969.853 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-01-31T01:19:29.853Z,1706663969.853 [CommandLine](INFO): Join timeout helper Thread ID is 9572 2024-01-31T01:19:29.932Z,1706663969.932 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-01-31T01:19:29.933Z,1706663969.933 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-01-31T01:19:29.953Z,1706663969.953 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-01-31T01:19:29.953Z,1706663969.953 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-01-31T01:19:29.953Z,1706663969.953 [CommandExec](INFO): Join timeout helper Thread ID is 9573 2024-01-31T01:19:29.962Z,1706663969.962 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-01-31T01:19:29.962Z,1706663969.962 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-01-31T01:19:29.962Z,1706663969.962 [controlThread](INFO): Join timeout helper Thread ID is 9574 2024-01-31T01:19:30.320Z,1706663970.320 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-01-31T01:19:30.320Z,1706663970.320 [controlThread](DEBUG): Uninitializing ControlThread 2024-01-31T01:19:30.321Z,1706663970.321 [AHRS_M2](INFO): Powering down 2024-01-31T01:19:30.393Z,1706663970.393 [NAL9602](INFO): Powering down 2024-01-31T01:19:30.394Z,1706663970.394 [Sonardyne_Nano](INFO): Powering down 2024-01-31T01:19:30.512Z,1706663970.512 [Waterlinked](INFO): Powering down 2024-01-31T01:19:30.515Z,1706663970.515 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-01-31T01:19:30.516Z,1706663970.516 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-01-31T01:19:30.517Z,1706663970.517 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-01-31T01:19:30.517Z,1706663970.517 [MissionManager](INFO): Uninitializing Mission Default 2024-01-31T01:19:30.517Z,1706663970.517 [Default] Stopped 2024-01-31T01:19:30.517Z,1706663970.517 [Default](DEBUG): Aggregate::uninitialize Default 2024-01-31T01:19:30.517Z,1706663970.517 [Default:B.GoToSurface] Stopped 2024-01-31T01:19:30.518Z,1706663970.518 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-01-31T01:19:30.518Z,1706663970.518 [Default:CheckIn] Stopped 2024-01-31T01:19:30.518Z,1706663970.518 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-01-31T01:19:30.518Z,1706663970.518 [Default:CheckIn:Read_GPS] Stopped 2024-01-31T01:19:30.521Z,1706663970.521 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-01-31T01:19:30.521Z,1706663970.521 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-01-31T01:19:30.521Z,1706663970.521 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-01-31T01:19:30.522Z,1706663970.522 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-01-31T01:19:30.522Z,1706663970.522 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-01-31T01:19:30.522Z,1706663970.522 [BuoyancyServo](INFO): Powering down 2024-01-31T01:19:30.536Z,1706663970.536 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-01-31T01:19:30.536Z,1706663970.536 [ElevatorServo](INFO): Powering down 2024-01-31T01:19:30.537Z,1706663970.537 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-01-31T01:19:30.537Z,1706663970.537 [MassServo](INFO): Powering down 2024-01-31T01:19:30.538Z,1706663970.538 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-01-31T01:19:30.538Z,1706663970.538 [RudderServo](INFO): Powering down 2024-01-31T01:19:30.539Z,1706663970.539 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-01-31T01:19:30.539Z,1706663970.539 [ThrusterHE](INFO): Powering down 2024-01-31T01:19:30.540Z,1706663970.540 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-01-31T01:19:30.540Z,1706663970.540 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-01-31T01:19:30.541Z,1706663970.541 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-01-31T01:19:30.541Z,1706663970.541 [CBIT](DEBUG): Powering off loads. 2024-01-31T01:19:30.552Z,1706663970.552 [CBIT](DEBUG): Disabling WDT. 2024-01-31T01:19:30.564Z,1706663970.564 [CBIT](DEBUG): Opening all GF detection circuits. 2024-01-31T01:19:30.565Z,1706663970.565 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-01-31T01:19:30.601Z,1706663970.601 [DAT ThreadHandler](INFO): Thread cancelled. 2024-01-31T01:19:30.606Z,1706663970.606 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-01-31T01:19:30.608Z,1706663970.608 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-01-31T01:19:30.614Z,1706663970.614 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-01-31T01:19:30.657Z,1706663970.657 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-01-31T01:19:30.743Z,1706663970.743 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-01-31T01:19:30.749Z,1706663970.749 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-01-31T01:19:30.757Z,1706663970.757 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-01-31T01:19:30.806Z,1706663970.806 [logger ThreadHandler](INFO): Thread cancelled.