2025-02-28T22:50:05.013Z,1740783005.013 [Supervisor](DEBUG): Initializing supervisor. 2025-02-28T22:50:05.017Z,1740783005.017 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2025-02-28T22:50:05.018Z,1740783005.018 [SyncHandler](INFO): Protected caller Thread ID is 4296 2025-02-28T22:50:05.018Z,1740783005.018 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2025-02-28T22:50:05.019Z,1740783005.019 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2025-02-28T22:50:05.019Z,1740783005.019 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 4297 2025-02-28T22:50:05.023Z,1740783005.023 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2025-02-28T22:50:05.040Z,1740783005.040 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2025-02-28T22:50:05.041Z,1740783005.041 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2025-02-28T22:50:05.041Z,1740783005.041 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 4298 2025-02-28T22:50:05.045Z,1740783005.045 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2025-02-28T22:50:05.046Z,1740783005.046 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2025-02-28T22:50:05.047Z,1740783005.047 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 4299 2025-02-28T22:50:05.049Z,1740783005.049 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2025-02-28T22:50:05.050Z,1740783005.050 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2025-02-28T22:50:05.050Z,1740783005.050 [logger ThreadHandler](INFO): Protected caller Thread ID is 4300 2025-02-28T22:50:05.054Z,1740783005.054 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2025-02-28T22:50:05.054Z,1740783005.054 [Supervisor](INFO): Looking for Config files in directory: Config/ 2025-02-28T22:50:05.056Z,1740783005.056 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2025-02-28T22:50:05.164Z,1740783005.164 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2025-02-28T22:50:05.165Z,1740783005.165 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2025-02-28T22:50:05.415Z,1740783005.415 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2025-02-28T22:50:05.415Z,1740783005.415 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2025-02-28T22:50:05.697Z,1740783005.697 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2025-02-28T22:50:05.698Z,1740783005.698 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2025-02-28T22:50:05.819Z,1740783005.819 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2025-02-28T22:50:05.820Z,1740783005.820 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2025-02-28T22:50:06.643Z,1740783006.643 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2025-02-28T22:50:06.644Z,1740783006.644 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2025-02-28T22:50:07.207Z,1740783007.207 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2025-02-28T22:50:07.208Z,1740783007.208 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2025-02-28T22:50:07.770Z,1740783007.770 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2025-02-28T22:50:07.771Z,1740783007.771 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2025-02-28T22:50:08.211Z,1740783008.211 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2025-02-28T22:50:08.212Z,1740783008.212 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2025-02-28T22:50:08.590Z,1740783008.590 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2025-02-28T22:50:08.590Z,1740783008.590 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2025-02-28T22:50:09.360Z,1740783009.360 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2025-02-28T22:50:09.360Z,1740783009.360 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2025-02-28T22:50:09.738Z,1740783009.738 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2025-02-28T22:50:09.739Z,1740783009.739 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2025-02-28T22:50:09.958Z,1740783009.958 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2025-02-28T22:50:09.959Z,1740783009.959 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2025-02-28T22:50:10.123Z,1740783010.123 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2025-02-28T22:50:10.694Z,1740783010.694 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2025-02-28T22:50:11.002Z,1740783011.002 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2025-02-28T22:50:11.003Z,1740783011.003 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2025-02-28T22:50:11.368Z,1740783011.368 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2025-02-28T22:50:11.370Z,1740783011.370 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/ 2025-02-28T22:50:11.370Z,1740783011.370 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg 2025-02-28T22:50:11.512Z,1740783011.512 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg 2025-02-28T22:50:11.919Z,1740783011.919 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2025-02-28T22:50:11.920Z,1740783011.920 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg 2025-02-28T22:50:12.082Z,1740783012.082 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg 2025-02-28T22:50:12.352Z,1740783012.352 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg 2025-02-28T22:50:12.520Z,1740783012.520 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg 2025-02-28T22:50:12.706Z,1740783012.706 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg 2025-02-28T22:50:12.897Z,1740783012.897 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg 2025-02-28T22:50:13.072Z,1740783013.072 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg 2025-02-28T22:50:13.336Z,1740783013.336 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Derivation.cfg 2025-02-28T22:50:13.498Z,1740783013.498 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/workSite.cfg 2025-02-28T22:50:13.642Z,1740783013.642 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg 2025-02-28T22:50:13.809Z,1740783013.809 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg 2025-02-28T22:50:13.960Z,1740783013.960 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/ 2025-02-28T22:50:13.961Z,1740783013.961 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2025-02-28T22:50:13.987Z,1740783013.987 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2025-02-28T22:50:14.244Z,1740783014.244 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2025-02-28T22:50:14.245Z,1740783014.245 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2025-02-28T22:50:14.441Z,1740783014.441 [BuoyancyServo] Loaded 2025-02-28T22:50:14.442Z,1740783014.442 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2025-02-28T22:50:14.481Z,1740783014.481 [ElevatorServo] Loaded 2025-02-28T22:50:14.481Z,1740783014.481 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2025-02-28T22:50:14.511Z,1740783014.511 [MassServo] Loaded 2025-02-28T22:50:14.511Z,1740783014.511 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2025-02-28T22:50:14.541Z,1740783014.541 [RudderServo] Loaded 2025-02-28T22:50:14.541Z,1740783014.541 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2025-02-28T22:50:14.566Z,1740783014.566 [ThrusterHE] Loaded 2025-02-28T22:50:14.566Z,1740783014.566 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2025-02-28T22:50:14.567Z,1740783014.567 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2025-02-28T22:50:14.567Z,1740783014.567 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2025-02-28T22:50:14.775Z,1740783014.775 [SBIT](DEBUG): Construct Startup Built In Test. 2025-02-28T22:50:14.797Z,1740783014.797 [SBIT] Loaded 2025-02-28T22:50:14.798Z,1740783014.798 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2025-02-28T22:50:14.800Z,1740783014.800 [IBIT](DEBUG): Construct Initiated Built In Test. 2025-02-28T22:50:14.829Z,1740783014.829 [IBIT] Loaded 2025-02-28T22:50:14.829Z,1740783014.829 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2025-02-28T22:50:14.834Z,1740783014.834 [CBIT](DEBUG): Construct Continuous Built In Test. 2025-02-28T22:50:15.165Z,1740783015.165 [CBIT] Loaded 2025-02-28T22:50:15.165Z,1740783015.165 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2025-02-28T22:50:15.165Z,1740783015.165 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2025-02-28T22:50:15.166Z,1740783015.166 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2025-02-28T22:50:16.030Z,1740783016.030 [CTD_Seabird] Loaded 2025-02-28T22:50:16.030Z,1740783016.030 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2025-02-28T22:50:16.031Z,1740783016.031 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406784E0 2025-02-28T22:50:16.032Z,1740783016.032 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 4392 2025-02-28T22:50:16.090Z,1740783016.090 [ESPComponent] Loaded 2025-02-28T22:50:16.090Z,1740783016.090 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2025-02-28T22:50:16.119Z,1740783016.119 [PAR_Licor] Loaded 2025-02-28T22:50:16.119Z,1740783016.119 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2025-02-28T22:50:16.186Z,1740783016.186 [WetLabsBB2FL] Loaded 2025-02-28T22:50:16.187Z,1740783016.187 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2025-02-28T22:50:16.188Z,1740783016.188 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406A84E0 2025-02-28T22:50:16.188Z,1740783016.188 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 4393 2025-02-28T22:50:16.189Z,1740783016.189 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2025-02-28T22:50:16.189Z,1740783016.189 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2025-02-28T22:50:16.263Z,1740783016.263 [DepthRateCalculator] Loaded 2025-02-28T22:50:16.263Z,1740783016.263 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2025-02-28T22:50:16.269Z,1740783016.269 [PitchRateCalculator] Loaded 2025-02-28T22:50:16.269Z,1740783016.269 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2025-02-28T22:50:16.287Z,1740783016.287 [SpeedCalculator] Loaded 2025-02-28T22:50:16.287Z,1740783016.287 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2025-02-28T22:50:16.292Z,1740783016.292 [YawRateCalculator] Loaded 2025-02-28T22:50:16.292Z,1740783016.292 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2025-02-28T22:50:16.319Z,1740783016.319 [ElevatorOffsetCalculator] Loaded 2025-02-28T22:50:16.319Z,1740783016.319 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2025-02-28T22:50:16.320Z,1740783016.320 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2025-02-28T22:50:16.320Z,1740783016.320 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2025-02-28T22:50:16.483Z,1740783016.483 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2025-02-28T22:50:16.483Z,1740783016.483 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2025-02-28T22:50:16.526Z,1740783016.526 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2025-02-28T22:50:16.526Z,1740783016.526 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2025-02-28T22:50:16.683Z,1740783016.683 [DeadReckonUsingMultipleVelocitySources] Loaded 2025-02-28T22:50:16.683Z,1740783016.683 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2025-02-28T22:50:16.705Z,1740783016.705 [NavChart] Loaded 2025-02-28T22:50:16.705Z,1740783016.705 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2025-02-28T22:50:16.719Z,1740783016.719 [UniversalFixResidualReporter] Loaded 2025-02-28T22:50:16.719Z,1740783016.719 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2025-02-28T22:50:16.719Z,1740783016.719 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2025-02-28T22:50:16.720Z,1740783016.720 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2025-02-28T22:50:17.397Z,1740783017.397 [AHRS_M2] Loaded 2025-02-28T22:50:17.397Z,1740783017.397 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2025-02-28T22:50:17.459Z,1740783017.459 [BackseatComponent] Loaded 2025-02-28T22:50:17.460Z,1740783017.460 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2025-02-28T22:50:17.461Z,1740783017.461 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 40A694E0 2025-02-28T22:50:17.461Z,1740783017.461 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 4394 2025-02-28T22:50:17.464Z,1740783017.464 [LcmUniversalReporter] Loaded 2025-02-28T22:50:17.464Z,1740783017.464 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2025-02-28T22:50:18.567Z,1740783018.567 [BPC1] Loaded 2025-02-28T22:50:18.567Z,1740783018.567 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2025-02-28T22:50:18.705Z,1740783018.705 [DATMMP] Loaded 2025-02-28T22:50:18.705Z,1740783018.705 [ComponentRegistry](DEBUG): Component "DATMMP" handled in its own thread. 2025-02-28T22:50:18.706Z,1740783018.706 [DATMMP ThreadHandler](DEBUG): Created PCaller Thread at 40A9A4E0 2025-02-28T22:50:18.707Z,1740783018.707 [DATMMP ThreadHandler](INFO): Protected caller Thread ID is 4395 2025-02-28T22:50:18.810Z,1740783018.810 [DataOverHttps] Loaded 2025-02-28T22:50:18.811Z,1740783018.811 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2025-02-28T22:50:18.812Z,1740783018.812 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40ACA4E0 2025-02-28T22:50:18.812Z,1740783018.812 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 4396 2025-02-28T22:50:18.843Z,1740783018.843 [Depth_Keller] Loaded 2025-02-28T22:50:18.843Z,1740783018.843 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2025-02-28T22:50:18.917Z,1740783018.917 [DVL_micro] Loaded 2025-02-28T22:50:18.917Z,1740783018.917 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread. 2025-02-28T22:50:19.003Z,1740783019.003 [NAL9602] Loaded 2025-02-28T22:50:19.003Z,1740783019.003 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2025-02-28T22:50:19.044Z,1740783019.044 [Onboard] Loaded 2025-02-28T22:50:19.045Z,1740783019.045 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2025-02-28T22:50:19.046Z,1740783019.046 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40AFA4E0 2025-02-28T22:50:19.046Z,1740783019.046 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 4397 2025-02-28T22:50:19.068Z,1740783019.068 [Power24vConverter] Loaded 2025-02-28T22:50:19.068Z,1740783019.068 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2025-02-28T22:50:19.083Z,1740783019.083 [Radio_Surface] Loaded 2025-02-28T22:50:19.092Z,1740783019.092 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2025-02-28T22:50:19.093Z,1740783019.093 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40B2A4E0 2025-02-28T22:50:19.093Z,1740783019.093 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 4398 2025-02-28T22:50:19.117Z,1740783019.117 [Sonardyne_Nano] Loaded 2025-02-28T22:50:19.117Z,1740783019.117 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2025-02-28T22:50:19.117Z,1740783019.117 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2025-02-28T22:50:19.118Z,1740783019.118 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2025-02-28T22:50:19.218Z,1740783019.218 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2025-02-28T22:50:19.218Z,1740783019.218 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2025-02-28T22:50:19.293Z,1740783019.293 [VerticalControl](DEBUG): Construct VerticalControl. 2025-02-28T22:50:19.367Z,1740783019.367 [VerticalControl] Loaded 2025-02-28T22:50:19.367Z,1740783019.367 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2025-02-28T22:50:19.378Z,1740783019.378 [HorizontalControl](DEBUG): Construct HorizontalControl. 2025-02-28T22:50:19.437Z,1740783019.437 [HorizontalControl] Loaded 2025-02-28T22:50:19.437Z,1740783019.437 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2025-02-28T22:50:19.448Z,1740783019.448 [SpeedControl](DEBUG): Construct SpeedControl. 2025-02-28T22:50:19.449Z,1740783019.449 [SpeedControl] Loaded 2025-02-28T22:50:19.450Z,1740783019.450 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2025-02-28T22:50:19.453Z,1740783019.453 [LoopControl](DEBUG): Construct LoopControl. 2025-02-28T22:50:19.453Z,1740783019.453 [LoopControl] Loaded 2025-02-28T22:50:19.453Z,1740783019.453 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2025-02-28T22:50:19.454Z,1740783019.454 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2025-02-28T22:50:19.454Z,1740783019.454 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2025-02-28T22:50:19.472Z,1740783019.472 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2025-02-28T22:50:19.473Z,1740783019.473 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2025-02-28T22:50:19.963Z,1740783019.963 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2025-02-28T22:50:19.969Z,1740783019.969 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2025-02-28T22:50:19.972Z,1740783019.972 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2025-02-28T22:50:19.991Z,1740783019.991 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2025-02-28T22:50:19.000Z,1740783020.000 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C524E0 2025-02-28T22:50:20.000Z,1740783020.000 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 4399 2025-02-28T22:50:20.005Z,1740783020.005 [Supervisor](INFO): Main Thread ID is 4295 2025-02-28T22:50:20.005Z,1740783020.005 [Supervisor](DEBUG): Running supervisor. 2025-02-28T22:50:20.005Z,1740783020.005 [CommandExec ThreadHandler](INFO): Handler Thread ID is 4400 2025-02-28T22:50:20.006Z,1740783020.006 [CommandExec](INFO): Initializing the command executive. 2025-02-28T22:50:20.007Z,1740783020.007 [CommandLine ThreadHandler](INFO): Handler Thread ID is 4401 2025-02-28T22:50:20.010Z,1740783020.010 [controlThread ThreadHandler](INFO): Handler Thread ID is 4402 2025-02-28T22:50:20.010Z,1740783020.010 [controlThread](DEBUG): Initializing ControlThread 2025-02-28T22:50:20.020Z,1740783020.020 [SBIT](INFO): Initialize SBIT Component. 2025-02-28T22:50:20.020Z,1740783020.020 [SBIT](IMPORTANT): git: 2024-09-17 2025-02-28T22:50:20.021Z,1740783020.021 [SBIT](INFO): git hash: 40e9ce87bff78b617219447905233bfcf6062b37 2025-02-28T22:50:20.021Z,1740783020.021 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2025-02-28T22:50:20.022Z,1740783020.022 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2025-02-28T22:50:20.023Z,1740783020.023 [SBIT](INFO): Beginning SBIT in 68.000000 seconds. 2025-02-28T22:50:20.024Z,1740783020.024 [IBIT](INFO): Initialize IBIT Component. 2025-02-28T22:50:20.025Z,1740783020.025 [CBIT](DEBUG): Initialize CBIT Component. 2025-02-28T22:50:20.026Z,1740783020.026 [logger ThreadHandler](INFO): Handler Thread ID is 4403 2025-02-28T22:50:20.044Z,1740783020.044 [CBIT](DEBUG): Initialized mux pins. 2025-02-28T22:50:20.044Z,1740783020.044 [CBIT](DEBUG): Initializing the watchdog timer. 2025-02-28T22:50:20.052Z,1740783020.052 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 4404 2025-02-28T22:50:20.056Z,1740783020.056 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-02-28T22:50:20.068Z,1740783020.068 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2025-02-28T22:50:20.068Z,1740783020.068 [CBIT](DEBUG): Initializing heartbeat. 2025-02-28T22:50:20.069Z,1740783020.069 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 4406 2025-02-28T22:50:20.073Z,1740783020.073 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 4408 2025-02-28T22:50:20.074Z,1740783020.074 [WetLabsBB2FL](INFO): Powering up 2025-02-28T22:50:20.076Z,1740783020.076 [DATMMP ThreadHandler](INFO): Handler Thread ID is 4409 2025-02-28T22:50:20.077Z,1740783020.077 [DATMMP](INFO): Start 2025-02-28T22:50:20.077Z,1740783020.077 [DATMMP](INFO): Powering up 2025-02-28T22:50:20.077Z,1740783020.077 [DATMMP](DEBUG): Initializing DATMMP. 2025-02-28T22:50:20.081Z,1740783020.081 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 4411 2025-02-28T22:50:20.082Z,1740783020.082 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2025-02-28T22:50:20.104Z,1740783020.104 [Onboard ThreadHandler](INFO): Handler Thread ID is 4412 2025-02-28T22:50:20.140Z,1740783020.140 [CBIT](DEBUG): Deactivating GF circuits. 2025-02-28T22:50:20.140Z,1740783020.140 [CBIT](DEBUG): Deactivating emergency mode. 2025-02-28T22:50:20.140Z,1740783020.140 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 4413 2025-02-28T22:50:20.152Z,1740783020.152 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 4414 2025-02-28T22:50:20.155Z,1740783020.155 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2025-02-28T22:50:20.155Z,1740783020.155 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2025-02-28T22:50:20.155Z,1740783020.155 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2025-02-28T22:50:20.155Z,1740783020.155 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2025-02-28T22:50:20.155Z,1740783020.155 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2025-02-28T22:50:20.164Z,1740783020.164 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2025-02-28T22:50:20.164Z,1740783020.164 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2025-02-28T22:50:20.164Z,1740783020.164 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2025-02-28T22:50:20.188Z,1740783020.188 [CBIT](DEBUG): Backplane powered. 2025-02-28T22:50:20.192Z,1740783020.192 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2025-02-28T22:50:20.193Z,1740783020.193 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2025-02-28T22:50:20.193Z,1740783020.193 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2025-02-28T22:50:20.193Z,1740783020.193 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2025-02-28T22:50:20.194Z,1740783020.194 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2025-02-28T22:50:20.195Z,1740783020.195 [NavChart](DEBUG): Initialize NavChart Navigation. 2025-02-28T22:50:20.195Z,1740783020.195 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2025-02-28T22:50:20.198Z,1740783020.198 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2025-02-28T22:50:20.216Z,1740783020.216 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2025-02-28T22:50:20.217Z,1740783020.217 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2025-02-28T22:50:20.217Z,1740783020.217 [LoopControl](DEBUG): Initialize LoopControlComponent. 2025-02-28T22:50:20.218Z,1740783020.218 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2025-02-28T22:50:20.219Z,1740783020.219 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2025-02-28T22:50:20.219Z,1740783020.219 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2025-02-28T22:50:20.236Z,1740783020.236 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2025-02-28T22:50:20.332Z,1740783020.332 [DATMMP](INFO): Starting 2025-02-28T22:50:20.356Z,1740783020.356 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2025-02-28T22:50:20.360Z,1740783020.360 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2025-02-28T22:50:20.417Z,1740783020.417 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Startup { behavior Guidance:GoToSurface { run in progression } aggregate StartupSatComms { run in sequence readDatum { timeout duration=P1M Universal:latitude_fix } readDatum { timeout duration=P1M Universal:platform_communications } } } 2025-02-28T22:50:20.418Z,1740783020.418 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2025-02-28T22:50:20.418Z,1740783020.418 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2025-02-28T22:50:20.419Z,1740783020.419 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2025-02-28T22:50:20.548Z,1740783020.548 [Radio_Surface](INFO): Powering up 2025-02-28T22:50:20.584Z,1740783020.584 [DATMMP](INFO): Starting 2025-02-28T22:50:20.836Z,1740783020.836 [DATMMP](INFO): Starting 2025-02-28T22:50:20.854Z,1740783020.854 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into: 0 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2025-02-28T22:50:20.900Z,1740783020.900 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2025-02-28T22:50:20.901Z,1740783020.901 [Default:A.Wait](DEBUG): Construct Wait. 2025-02-28T22:50:20.903Z,1740783020.903 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2025-02-28T22:50:20.968Z,1740783020.968 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2025-02-28T22:50:20.970Z,1740783020.970 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2025-02-28T22:50:21.009Z,1740783021.009 [Default:E.Execute](DEBUG): Construct Execute. 2025-02-28T22:50:21.039Z,1740783021.039 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Default { arguments { ElapsedSinceDefaultStarted = 0 minute } behavior Guidance:Wait { """ Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. """ run in sequence set duration = 13 second } behavior Guidance:GoToSurface { run in progression } aggregate CheckIn { run in sequence repeat=288 readDatum id="Read_GPS" { timeout duration=P5M Universal:time_fix } readDatum id="Read_Iridium" { timeout duration=P4H { behavior Guidance:Execute { run in sequence set command = "Burn on" } syslog critical "Dropped weight due to communications timeout." } Universal:platform_communications } behavior Guidance:Wait { run in sequence set duration = 5 minute } assign in sequence ElapsedSinceDefaultStarted = elapsed ( Universal:mission_started ) syslog important "Default mission has been running for " + ElapsedSinceDefaultStarted~minute } syslog important "Restarting logs and Default mission." behavior Guidance:Execute { run in sequence set command = "restart logs" } } 2025-02-28T22:50:21.052Z,1740783021.052 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DVL_micro,NAL9602,Power24vConverter,Sonardyne_Nano,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2025-02-28T22:50:21.067Z,1740783021.067 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-02-28T22:50:21.088Z,1740783021.088 [DATMMP](INFO): Starting 2025-02-28T22:50:21.185Z,1740783021.185 [Depth_Keller](ERROR): Pressure or depth reading out of range: 1895.444336 decibar, 0.000000 m 2025-02-28T22:50:21.197Z,1740783021.197 [Power24vConverter](INFO): Powering up. 2025-02-28T22:50:21.198Z,1740783021.198 [Sonardyne_Nano](INFO): Initializing. 2025-02-28T22:50:21.256Z,1740783021.256 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-02-28T22:50:21.274Z,1740783021.274 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2025-02-28T22:50:21.280Z,1740783021.280 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2025-02-28T22:50:21.281Z,1740783021.281 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-02-28T22:50:21.296Z,1740783021.296 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-02-28T22:50:21.297Z,1740783021.297 [MassServo](DEBUG): Initializing EZServoServo. 2025-02-28T22:50:21.305Z,1740783021.305 [MassServo](DEBUG): Initializing MassServo. 2025-02-28T22:50:21.305Z,1740783021.305 [RudderServo](DEBUG): Initializing EZServoServo. 2025-02-28T22:50:21.320Z,1740783021.320 [RudderServo](DEBUG): Initializing RudderServo. 2025-02-28T22:50:21.321Z,1740783021.321 [ThrusterHE](DEBUG): Initializing EZServoServo. 2025-02-28T22:50:21.328Z,1740783021.328 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2025-02-28T22:50:21.340Z,1740783021.340 [DATMMP](INFO): Starting 2025-02-28T22:50:21.592Z,1740783021.592 [DATMMP](INFO): Starting 2025-02-28T22:50:21.848Z,1740783021.848 [DATMMP](INFO): Starting 2025-02-28T22:50:22.108Z,1740783022.108 [DATMMP](INFO): Starting 2025-02-28T22:50:22.360Z,1740783022.360 [DATMMP](INFO): Starting 2025-02-28T22:50:22.612Z,1740783022.612 [DATMMP](INFO): Starting 2025-02-28T22:50:22.864Z,1740783022.864 [DATMMP](INFO): Starting 2025-02-28T22:50:23.116Z,1740783023.116 [DATMMP](INFO): Starting 2025-02-28T22:50:23.368Z,1740783023.368 [DATMMP](INFO): Starting 2025-02-28T22:50:23.620Z,1740783023.620 [DATMMP](INFO): Starting 2025-02-28T22:50:23.872Z,1740783023.872 [DATMMP](INFO): Starting 2025-02-28T22:50:24.124Z,1740783024.124 [DATMMP](INFO): Starting 2025-02-28T22:50:24.399Z,1740783024.399 [DATMMP](INFO): Starting 2025-02-28T22:50:24.652Z,1740783024.652 [DATMMP](INFO): Starting 2025-02-28T22:50:24.664Z,1740783024.664 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:24.904Z,1740783024.904 [DATMMP](INFO): Starting 2025-02-28T22:50:25.132Z,1740783025.132 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:25.156Z,1740783025.156 [DATMMP](INFO): Starting 2025-02-28T22:50:25.396Z,1740783025.396 [WetLabsBB2FL] Communications Fault, FailCount= 1 2025-02-28T22:50:25.397Z,1740783025.397 [WetLabsBB2FL](ERROR): Communications Fault 2025-02-28T22:50:25.424Z,1740783025.424 [DATMMP](INFO): Starting 2025-02-28T22:50:25.676Z,1740783025.676 [DATMMP](INFO): Starting 2025-02-28T22:50:25.696Z,1740783025.696 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:25.816Z,1740783025.816 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-02-28T22:50:25.928Z,1740783025.928 [WetLabsBB2FL](INFO): Powering down 2025-02-28T22:50:25.929Z,1740783025.929 [DATMMP](INFO): Starting 2025-02-28T22:50:26.164Z,1740783026.164 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:26.180Z,1740783026.180 [DATMMP](INFO): Starting 2025-02-28T22:50:26.432Z,1740783026.432 [DATMMP](INFO): Starting 2025-02-28T22:50:26.604Z,1740783026.604 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:26.684Z,1740783026.684 [DATMMP](INFO): Starting 2025-02-28T22:50:26.767Z,1740783026.767 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-02-28T22:50:26.767Z,1740783026.767 [WetLabsBB2FL] No Fault, FailCount= 1 2025-02-28T22:50:26.936Z,1740783026.936 [DATMMP](INFO): Starting 2025-02-28T22:50:27.096Z,1740783027.096 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:27.159Z,1740783027.159 [WetLabsBB2FL](INFO): Powering up 2025-02-28T22:50:27.188Z,1740783027.188 [DATMMP](INFO): Starting 2025-02-28T22:50:27.440Z,1740783027.440 [DATMMP](INFO): Starting 2025-02-28T22:50:27.692Z,1740783027.692 [DATMMP](INFO): Starting 2025-02-28T22:50:27.708Z,1740783027.708 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:27.944Z,1740783027.944 [DATMMP](INFO): Starting 2025-02-28T22:50:28.102Z,1740783028.102 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit. 2025-02-28T22:50:28.196Z,1740783028.196 [DATMMP](INFO): Starting 2025-02-28T22:50:28.380Z,1740783028.380 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:28.448Z,1740783028.448 [DATMMP](INFO): Starting 2025-02-28T22:50:28.700Z,1740783028.700 [DATMMP](INFO): Starting 2025-02-28T22:50:28.832Z,1740783028.832 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:28.977Z,1740783028.977 [DATMMP](INFO): Starting 2025-02-28T22:50:29.228Z,1740783029.228 [DATMMP](INFO): Starting 2025-02-28T22:50:29.256Z,1740783029.256 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:29.480Z,1740783029.480 [DATMMP](INFO): Starting 2025-02-28T22:50:29.708Z,1740783029.708 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:29.733Z,1740783029.733 [DATMMP](INFO): Starting 2025-02-28T22:50:29.984Z,1740783029.984 [DATMMP](INFO): Starting 2025-02-28T22:50:30.124Z,1740783030.124 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:30.213Z,1740783030.213 [CBIT](CRITICAL): Environmental Failure. Press:14.703908 PSI. Humidity:39%. Temp:26 C. ABORTING MISSION 2025-02-28T22:50:30.213Z,1740783030.213 [Supervisor](INFO): Stop Mission called by CBIT::monitorEnvironmentals 2025-02-28T22:50:30.236Z,1740783030.236 [DATMMP](INFO): Starting 2025-02-28T22:50:30.488Z,1740783030.488 [DATMMP](INFO): Starting 2025-02-28T22:50:30.556Z,1740783030.556 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:30.639Z,1740783030.639 [CommandExec](FAULT): Scheduling is paused 2025-02-28T22:50:30.644Z,1740783030.644 [CBIT](INFO): Critical error at 20250228T225030 2025-02-28T22:50:30.740Z,1740783030.740 [DATMMP](INFO): Starting 2025-02-28T22:50:30.992Z,1740783030.992 [DATMMP](INFO): Starting 2025-02-28T22:50:30.000Z,1740783031.000 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:31.244Z,1740783031.244 [DATMMP](INFO): Starting 2025-02-28T22:50:31.428Z,1740783031.428 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:31.496Z,1740783031.496 [DATMMP](INFO): Starting 2025-02-28T22:50:31.748Z,1740783031.748 [DATMMP](INFO): Starting 2025-02-28T22:50:31.852Z,1740783031.852 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:32.002Z,1740783032.002 [DATMMP](INFO): Starting 2025-02-28T22:50:32.252Z,1740783032.252 [DATMMP](INFO): Starting 2025-02-28T22:50:32.292Z,1740783032.292 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:32.432Z,1740783032.432 [WetLabsBB2FL] Communications Fault, FailCount= 2 2025-02-28T22:50:32.433Z,1740783032.433 [WetLabsBB2FL](ERROR): Communications Fault 2025-02-28T22:50:32.504Z,1740783032.504 [DATMMP](INFO): Starting 2025-02-28T22:50:32.732Z,1740783032.732 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:32.756Z,1740783032.756 [DATMMP](INFO): Starting 2025-02-28T22:50:32.825Z,1740783032.825 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-02-28T22:50:32.932Z,1740783032.932 [WetLabsBB2FL](INFO): Powering down 2025-02-28T22:50:33.008Z,1740783033.008 [DATMMP](INFO): Starting 2025-02-28T22:50:33.180Z,1740783033.180 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:33.260Z,1740783033.260 [DATMMP](INFO): Starting 2025-02-28T22:50:33.512Z,1740783033.512 [DATMMP](INFO): Starting 2025-02-28T22:50:33.652Z,1740783033.652 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:33.764Z,1740783033.764 [DATMMP](INFO): Starting 2025-02-28T22:50:34.016Z,1740783034.016 [DATMMP](INFO): Starting 2025-02-28T22:50:34.096Z,1740783034.096 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:34.096Z,1740783034.096 [AHRS_M2](FAULT): Failed to initialize within timeout. 2025-02-28T22:50:34.096Z,1740783034.096 [AHRS_M2] Communications Fault, FailCount= 1 2025-02-28T22:50:34.096Z,1740783034.096 [AHRS_M2](ERROR): Communications Fault 2025-02-28T22:50:34.188Z,1740783034.188 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-02-28T22:50:34.188Z,1740783034.188 [WetLabsBB2FL] No Fault, FailCount= 2 2025-02-28T22:50:34.189Z,1740783034.189 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2025-02-28T22:50:34.229Z,1740783034.229 [AHRS_M2](INFO): Powering down 2025-02-28T22:50:34.268Z,1740783034.268 [DATMMP](INFO): Starting 2025-02-28T22:50:34.520Z,1740783034.520 [DATMMP](INFO): Starting 2025-02-28T22:50:34.568Z,1740783034.568 [WetLabsBB2FL](INFO): Powering up 2025-02-28T22:50:34.772Z,1740783034.772 [DATMMP](INFO): Starting 2025-02-28T22:50:35.024Z,1740783035.024 [DATMMP](INFO): Starting 2025-02-28T22:50:35.025Z,1740783035.025 [DATMMP](INFO): DAT read: 2025-02-28T22:50:35.026Z,1740783035.026 [DATMMP](INFO): DAT read: Teledyne Benthos DAT-900 Series 2025-02-28T22:50:35.118Z,1740783035.118 [CBIT](INFO): Clearing failed state for component AHRS_M2 2025-02-28T22:50:35.119Z,1740783035.119 [AHRS_M2] No Fault, FailCount= 1 2025-02-28T22:50:35.276Z,1740783035.276 [DATMMP](INFO): Starting 2025-02-28T22:50:35.426Z,1740783035.426 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-02-28T22:50:35.528Z,1740783035.528 [DATMMP](INFO): Starting 2025-02-28T22:50:35.780Z,1740783035.780 [DATMMP](INFO): Starting 2025-02-28T22:50:36.032Z,1740783036.032 [DATMMP](INFO): Starting 2025-02-28T22:50:36.284Z,1740783036.284 [DATMMP](INFO): Starting 2025-02-28T22:50:36.536Z,1740783036.536 [DATMMP](INFO): Starting 2025-02-28T22:50:36.788Z,1740783036.788 [DATMMP](INFO): Starting 2025-02-28T22:50:36.789Z,1740783036.789 [DATMMP](INFO): DAT read: MF Frequency Band 2025-02-28T22:50:36.790Z,1740783036.790 [DATMMP](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2025-02-28T22:50:36.790Z,1740783036.790 [DATMMP](INFO): DAT read: Jan 27 2000 23:45:42 2025-02-28T22:50:37.040Z,1740783037.040 [DATMMP](INFO): Starting 2025-02-28T22:50:37.292Z,1740783037.292 [DATMMP](INFO): Starting 2025-02-28T22:50:37.544Z,1740783037.544 [DATMMP](INFO): Starting 2025-02-28T22:50:37.796Z,1740783037.796 [DATMMP](INFO): Starting 2025-02-28T22:50:37.797Z,1740783037.797 [DATMMP](INFO): DAT read: Features enabled [Bearing] 2025-02-28T22:50:37.798Z,1740783037.798 [DATMMP](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC 2025-02-28T22:50:37.798Z,1740783037.798 [DATMMP](INFO): commRate: 1200 2025-02-28T22:50:38.048Z,1740783038.048 [DATMMP](INFO): Starting 2025-02-28T22:50:38.066Z,1740783038.066 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004687 2025-02-28T22:50:38.300Z,1740783038.300 [DATMMP](INFO): Starting 2025-02-28T22:50:38.552Z,1740783038.552 [DATMMP](INFO): Starting 2025-02-28T22:50:38.805Z,1740783038.805 [DATMMP](INFO): Starting 2025-02-28T22:50:38.964Z,1740783038.964 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:38.969Z,1740783038.969 [DVL_micro](FAULT): Failed to initialize within timeout. 2025-02-28T22:50:38.969Z,1740783038.969 [DVL_micro] Communications Fault, FailCount= 1 2025-02-28T22:50:38.969Z,1740783038.969 [DVL_micro](ERROR): Communications Fault 2025-02-28T22:50:39.056Z,1740783039.056 [DATMMP](INFO): Starting 2025-02-28T22:50:39.057Z,1740783039.057 [CBIT](ERROR): Communications Fault in component: DVL_micro 2025-02-28T22:50:39.308Z,1740783039.308 [DATMMP](INFO): Starting 2025-02-28T22:50:39.440Z,1740783039.440 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:39.540Z,1740783039.540 [DVL_micro](INFO): Powering down 2025-02-28T22:50:39.560Z,1740783039.560 [DATMMP](INFO): Starting 2025-02-28T22:50:39.812Z,1740783039.812 [DATMMP](INFO): Starting 2025-02-28T22:50:39.844Z,1740783039.844 [WetLabsBB2FL] Communications Fault, FailCount= 3 2025-02-28T22:50:39.844Z,1740783039.844 [WetLabsBB2FL](ERROR): Communications Fault 2025-02-28T22:50:39.864Z,1740783039.864 [DATMMP](INFO): entering command mode 2025-02-28T22:50:39.944Z,1740783039.944 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:40.064Z,1740783040.064 [DATMMP](INFO): Starting 2025-02-28T22:50:40.065Z,1740783040.065 [DATMMP](INFO): DAT read: 2025-02-28T22:50:40.065Z,1740783040.065 [DATMMP](INFO): DAT read: user:1> 2025-02-28T22:50:40.065Z,1740783040.065 [DATMMP](DEBUG): read user prompt 1: user:1> 2025-02-28T22:50:40.066Z,1740783040.066 [DATMMP](INFO): entering MMP mode 2025-02-28T22:50:40.084Z,1740783040.084 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-02-28T22:50:40.316Z,1740783040.316 [DATMMP](INFO): Starting 2025-02-28T22:50:40.317Z,1740783040.317 [DATMMP](INFO): GSXN notify for xid: 0 2025-02-28T22:50:40.318Z,1740783040.318 [DATMMP](INFO): status rx: x1 2025-02-28T22:50:40.319Z,1740783040.319 [DATMMP](INFO): MMP status: 1: started 2025-02-28T22:50:40.319Z,1740783040.319 [DATMMP](INFO): Received message type: status 2025-02-28T22:50:40.319Z,1740783040.319 [DATMMP](INFO): Handled 2025-02-28T22:50:40.344Z,1740783040.344 [WetLabsBB2FL](INFO): Powering down 2025-02-28T22:50:40.440Z,1740783040.440 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:40.532Z,1740783040.532 [CBIT](INFO): Clearing failed state for component DVL_micro 2025-02-28T22:50:40.532Z,1740783040.532 [DVL_micro] No Fault, FailCount= 1 2025-02-28T22:50:40.568Z,1740783040.568 [DATMMP](INFO): Starting 2025-02-28T22:50:40.569Z,1740783040.569 [DATMMP](INFO): Sent Tx Power Config 8 2025-02-28T22:50:40.569Z,1740783040.569 [DATMMP](INFO): Setting local address: 5 2025-02-28T22:50:40.571Z,1740783040.571 [DATMMP](INFO): Setting time to: 22:50:40 And date to:2/28/2025 2025-02-28T22:50:40.820Z,1740783040.820 [DATMMP](INFO): Starting 2025-02-28T22:50:40.820Z,1740783040.820 [DATMMP](INFO): GSXN notify for xid: 0 2025-02-28T22:50:40.821Z,1740783040.821 [DATMMP](INFO): mdmpower rx: x8 x0 x5 x0 2025-02-28T22:50:40.821Z,1740783040.821 [DATMMP](INFO): Received message type: mdmpower 2025-02-28T22:50:40.822Z,1740783040.822 [DATMMP](INFO): Handled 2025-02-28T22:50:40.912Z,1740783040.912 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:41.072Z,1740783041.072 [DATMMP](INFO): Starting 2025-02-28T22:50:41.072Z,1740783041.072 [DATMMP](INFO): GSXN notify for xid: 10 2025-02-28T22:50:41.073Z,1740783041.073 [DATMMP](INFO): sreg_txpower rx: x8 2025-02-28T22:50:41.073Z,1740783041.073 [DATMMP](INFO): Received message type: sreg_txpower 2025-02-28T22:50:41.073Z,1740783041.073 [DATMMP](INFO): Match for : sreg_txpower 2025-02-28T22:50:41.073Z,1740783041.073 [DATMMP](INFO): ACK 2025-02-28T22:50:41.324Z,1740783041.324 [DATMMP](INFO): Starting 2025-02-28T22:50:41.325Z,1740783041.325 [DATMMP](INFO): GSXN notify for xid: 0 2025-02-28T22:50:41.325Z,1740783041.325 [DATMMP](INFO): mdmlocal rx: x5 x0 x0 x0 2025-02-28T22:50:41.326Z,1740783041.326 [DATMMP](INFO): Received message type: mdmlocal 2025-02-28T22:50:41.326Z,1740783041.326 [DATMMP](INFO): Handled 2025-02-28T22:50:41.344Z,1740783041.344 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:41.453Z,1740783041.453 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-02-28T22:50:41.453Z,1740783041.453 [WetLabsBB2FL] No Fault, FailCount= 3 2025-02-28T22:50:41.576Z,1740783041.576 [DATMMP](INFO): Starting 2025-02-28T22:50:41.576Z,1740783041.576 [DATMMP](INFO): GSXN notify for xid: 11 2025-02-28T22:50:41.577Z,1740783041.577 [DATMMP](INFO): sreg_locaddr rx: x5 2025-02-28T22:50:41.577Z,1740783041.577 [DATMMP](INFO): Received message type: sreg_locaddr 2025-02-28T22:50:41.577Z,1740783041.577 [DATMMP](INFO): Match for : sreg_locaddr 2025-02-28T22:50:41.578Z,1740783041.578 [DATMMP](INFO): ACK 2025-02-28T22:50:41.605Z,1740783041.605 [WetLabsBB2FL](INFO): Powering up 2025-02-28T22:50:41.828Z,1740783041.828 [DATMMP](INFO): Starting 2025-02-28T22:50:41.829Z,1740783041.829 [DATMMP](INFO): GSXN notify for xid: 12 2025-02-28T22:50:41.830Z,1740783041.830 [DATMMP](INFO): timedate rx: x0 x16 x32 x28 x1 x1C x7D x0 2025-02-28T22:50:41.830Z,1740783041.830 [DATMMP](INFO): Received message type: timedate 2025-02-28T22:50:41.830Z,1740783041.830 [DATMMP](INFO): Match for : timedate 2025-02-28T22:50:41.830Z,1740783041.830 [DATMMP](INFO): ACK 2025-02-28T22:50:41.832Z,1740783041.832 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:42.080Z,1740783042.080 [DATMMP](INFO): Starting 2025-02-28T22:50:42.080Z,1740783042.080 [DATMMP](INFO): GSXN notify for xid: 0 2025-02-28T22:50:42.081Z,1740783042.081 [DATMMP](INFO): sys_verb rx: x0 x0 x0 x0 2025-02-28T22:50:42.082Z,1740783042.082 [DATMMP](INFO): Received message type: sys_verb 2025-02-28T22:50:42.082Z,1740783042.082 [DATMMP](INFO): Handled 2025-02-28T22:50:42.276Z,1740783042.276 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:42.332Z,1740783042.332 [DATMMP](INFO): Starting 2025-02-28T22:50:42.332Z,1740783042.332 [DATMMP](INFO): GSXN notify for xid: 13 2025-02-28T22:50:42.333Z,1740783042.333 [DATMMP](INFO): sreg_verbosity rx: x0 2025-02-28T22:50:42.333Z,1740783042.333 [DATMMP](INFO): Received message type: sreg_verbosity 2025-02-28T22:50:42.333Z,1740783042.333 [DATMMP](INFO): Match for : sreg_verbosity 2025-02-28T22:50:42.333Z,1740783042.333 [DATMMP](INFO): ACK 2025-02-28T22:50:42.584Z,1740783042.584 [DATMMP](INFO): Starting 2025-02-28T22:50:42.584Z,1740783042.584 [DATMMP](INFO): GSXN notify for xid: 14 2025-02-28T22:50:42.585Z,1740783042.585 [DATMMP](INFO): version rx: x2 x5 2025-02-28T22:50:42.585Z,1740783042.585 [DATMMP](INFO): DatMMPVersion: 2.5 2025-02-28T22:50:42.586Z,1740783042.586 [DATMMP](INFO): Received message type: version 2025-02-28T22:50:42.586Z,1740783042.586 [DATMMP](INFO): Match for : version 2025-02-28T22:50:42.586Z,1740783042.586 [DATMMP](INFO): ACK 2025-02-28T22:50:42.586Z,1740783042.586 [DATMMP](INFO): in MMP mode: config complete going to runnable 2025-02-28T22:50:42.708Z,1740783042.708 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:43.168Z,1740783043.168 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:43.600Z,1740783043.600 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:44.036Z,1740783044.036 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:44.456Z,1740783044.456 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:44.892Z,1740783044.892 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:45.316Z,1740783045.316 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:45.760Z,1740783045.760 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:46.188Z,1740783046.188 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:46.640Z,1740783046.640 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:46.849Z,1740783046.849 [WetLabsBB2FL] Communications Fault, FailCount= 4 2025-02-28T22:50:46.849Z,1740783046.849 [WetLabsBB2FL](ERROR): Communications Fault 2025-02-28T22:50:47.144Z,1740783047.144 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:47.213Z,1740783047.213 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-02-28T22:50:47.348Z,1740783047.348 [WetLabsBB2FL](INFO): Powering down 2025-02-28T22:50:47.560Z,1740783047.560 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:47.000Z,1740783048.000 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:48.432Z,1740783048.432 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:48.432Z,1740783048.432 [AHRS_M2](FAULT): Failed to initialize within timeout. 2025-02-28T22:50:48.432Z,1740783048.432 [AHRS_M2] Communications Fault, FailCount= 2 2025-02-28T22:50:48.432Z,1740783048.432 [AHRS_M2](ERROR): Communications Fault 2025-02-28T22:50:48.516Z,1740783048.516 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-02-28T22:50:48.516Z,1740783048.516 [WetLabsBB2FL] No Fault, FailCount= 4 2025-02-28T22:50:48.517Z,1740783048.517 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2025-02-28T22:50:48.552Z,1740783048.552 [AHRS_M2](INFO): Powering down 2025-02-28T22:50:48.562Z,1740783048.562 [WetLabsBB2FL](INFO): Powering up 2025-02-28T22:50:49.346Z,1740783049.346 [NAL9602](INFO): Powering up NAL9602 2025-02-28T22:50:49.420Z,1740783049.420 [CBIT](INFO): Clearing failed state for component AHRS_M2 2025-02-28T22:50:49.420Z,1740783049.420 [AHRS_M2] No Fault, FailCount= 2 2025-02-28T22:50:49.737Z,1740783049.737 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-02-28T22:50:53.296Z,1740783053.296 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:53.740Z,1740783053.740 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:53.874Z,1740783053.874 [WetLabsBB2FL] Communications Fault, FailCount= 5 2025-02-28T22:50:53.874Z,1740783053.874 [WetLabsBB2FL](ERROR): Communications Fault 2025-02-28T22:50:54.160Z,1740783054.160 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:54.240Z,1740783054.240 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-02-28T22:50:54.241Z,1740783054.241 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL 2025-02-28T22:50:54.388Z,1740783054.388 [WetLabsBB2FL](INFO): Powering down 2025-02-28T22:50:54.572Z,1740783054.572 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:55.012Z,1740783055.012 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:55.448Z,1740783055.448 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:55.888Z,1740783055.888 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:56.328Z,1740783056.328 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:56.740Z,1740783056.740 [DATMMP](INFO): GSXN notify for xid: 0 2025-02-28T22:50:56.741Z,1740783056.741 [DATMMP](INFO): timesync rx: x0 x1 x1 x0 2025-02-28T22:50:56.742Z,1740783056.742 [DATMMP](INFO): Received message type: timesync 2025-02-28T22:50:56.742Z,1740783056.742 [DATMMP](INFO): Handled 2025-02-28T22:50:56.828Z,1740783056.828 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:57.272Z,1740783057.272 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:57.696Z,1740783057.696 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:58.116Z,1740783058.116 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:58.121Z,1740783058.121 [DVL_micro](FAULT): Failed to initialize within timeout. 2025-02-28T22:50:58.121Z,1740783058.121 [DVL_micro] Communications Fault, FailCount= 2 2025-02-28T22:50:58.121Z,1740783058.121 [DVL_micro](ERROR): Communications Fault 2025-02-28T22:50:58.196Z,1740783058.196 [CBIT](ERROR): Communications Fault in component: DVL_micro 2025-02-28T22:50:58.572Z,1740783058.572 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:58.672Z,1740783058.672 [DVL_micro](INFO): Powering down 2025-02-28T22:50:59.072Z,1740783059.072 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:59.492Z,1740783059.492 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:50:59.567Z,1740783059.567 [CBIT](INFO): Clearing failed state for component DVL_micro 2025-02-28T22:50:59.567Z,1740783059.567 [DVL_micro] No Fault, FailCount= 2 2025-02-28T22:50:59.940Z,1740783059.940 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:00.388Z,1740783060.388 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:00.394Z,1740783060.394 [NAL9602](INFO): NAL9602 initialized 2025-02-28T22:51:00.804Z,1740783060.804 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:01.216Z,1740783061.216 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:01.644Z,1740783061.644 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:02.080Z,1740783062.080 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:02.528Z,1740783062.528 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:02.936Z,1740783062.936 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:02.936Z,1740783062.936 [AHRS_M2](FAULT): Failed to initialize within timeout. 2025-02-28T22:51:02.936Z,1740783062.936 [AHRS_M2] Communications Fault, FailCount= 3 2025-02-28T22:51:02.936Z,1740783062.936 [AHRS_M2](ERROR): Communications Fault 2025-02-28T22:51:02.991Z,1740783062.991 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2025-02-28T22:51:03.054Z,1740783063.054 [AHRS_M2](INFO): Powering down 2025-02-28T22:51:03.873Z,1740783063.873 [CBIT](INFO): Clearing failed state for component AHRS_M2 2025-02-28T22:51:03.873Z,1740783063.873 [AHRS_M2] No Fault, FailCount= 3 2025-02-28T22:51:04.228Z,1740783064.228 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-02-28T22:51:06.824Z,1740783066.824 [DATMMP](INFO): GSXN notify for xid: 0 2025-02-28T22:51:06.825Z,1740783066.825 [DATMMP](INFO): timesync rx: x1 x0 x1 x0 2025-02-28T22:51:06.826Z,1740783066.826 [DATMMP](INFO): Received message type: timesync 2025-02-28T22:51:06.826Z,1740783066.826 [DATMMP](INFO): Handled 2025-02-28T22:51:07.788Z,1740783067.788 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:08.228Z,1740783068.228 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:08.648Z,1740783068.648 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:09.080Z,1740783069.080 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:09.532Z,1740783069.532 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:09.960Z,1740783069.960 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:10.376Z,1740783070.376 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:10.804Z,1740783070.804 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:11.220Z,1740783071.220 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:11.636Z,1740783071.636 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:12.052Z,1740783072.052 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:12.468Z,1740783072.468 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:12.880Z,1740783072.880 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:13.308Z,1740783073.308 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:13.760Z,1740783073.760 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:14.220Z,1740783074.220 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:14.652Z,1740783074.652 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:15.072Z,1740783075.072 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:15.492Z,1740783075.492 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:15.916Z,1740783075.916 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:16.316Z,1740783076.316 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:16.732Z,1740783076.732 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:17.144Z,1740783077.144 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:17.144Z,1740783077.144 [AHRS_M2](FAULT): Failed to initialize within timeout. 2025-02-28T22:51:17.144Z,1740783077.144 [AHRS_M2] Communications Fault, FailCount= 4 2025-02-28T22:51:17.144Z,1740783077.144 [AHRS_M2](ERROR): Communications Fault 2025-02-28T22:51:17.146Z,1740783077.146 [DVL_micro](FAULT): Failed to initialize within timeout. 2025-02-28T22:51:17.146Z,1740783077.146 [DVL_micro] Communications Fault, FailCount= 3 2025-02-28T22:51:17.146Z,1740783077.146 [DVL_micro](ERROR): Communications Fault 2025-02-28T22:51:17.191Z,1740783077.191 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2025-02-28T22:51:17.191Z,1740783077.191 [CBIT](ERROR): Communications Fault in component: DVL_micro 2025-02-28T22:51:17.191Z,1740783077.191 [CBIT](CRITICAL): Communications Fault in component: DVL_micro 2025-02-28T22:51:17.240Z,1740783077.240 [AHRS_M2](INFO): Powering down 2025-02-28T22:51:17.424Z,1740783077.424 [DVL_micro](INFO): Powering down 2025-02-28T22:51:17.454Z,1740783077.454 [CBIT](INFO): Critical error at 20250228T225117 2025-02-28T22:51:18.046Z,1740783078.046 [CBIT](INFO): Clearing failed state for component AHRS_M2 2025-02-28T22:51:18.046Z,1740783078.046 [AHRS_M2] No Fault, FailCount= 4 2025-02-28T22:51:18.417Z,1740783078.417 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-02-28T22:51:21.972Z,1740783081.972 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:22.205Z,1740783082.205 [CommandExec](IMPORTANT): got command failComponent 2025-02-28T22:51:22.205Z,1740783082.205 [CommandExec](IMPORTANT): Failed components: 2025-02-28T22:51:22.205Z,1740783082.205 [CommandExec](IMPORTANT): WetLabsBB2FL: Communications Fault 2025-02-28T22:51:22.205Z,1740783082.205 [CommandExec](IMPORTANT): DVL_micro: Communications Fault 2025-02-28T22:51:22.412Z,1740783082.412 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:22.880Z,1740783082.880 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:23.296Z,1740783083.296 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:23.728Z,1740783083.728 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:23.928Z,1740783083.928 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:24.296Z,1740783084.296 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:24.928Z,1740783084.928 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:25.340Z,1740783085.340 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:25.760Z,1740783085.760 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:26.188Z,1740783086.188 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:26.380Z,1740783086.380 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:26.960Z,1740783086.960 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:27.372Z,1740783087.372 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:27.800Z,1740783087.800 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:28.220Z,1740783088.220 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:28.672Z,1740783088.672 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:28.753Z,1740783088.753 [SBIT](IMPORTANT): Beginning Startup BIT 2025-02-28T22:51:28.764Z,1740783088.764 [CBIT](IMPORTANT): Beginning ground fault scan 2025-02-28T22:51:29.128Z,1740783089.128 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:29.572Z,1740783089.572 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:30.028Z,1740783090.028 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:30.460Z,1740783090.460 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:31.004Z,1740783091.004 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:31.492Z,1740783091.492 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:51:31.492Z,1740783091.492 [AHRS_M2](FAULT): Failed to initialize within timeout. 2025-02-28T22:51:31.492Z,1740783091.492 [AHRS_M2] Communications Fault, FailCount= 5 2025-02-28T22:51:31.492Z,1740783091.492 [AHRS_M2](ERROR): Communications Fault 2025-02-28T22:51:31.601Z,1740783091.601 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2025-02-28T22:51:31.602Z,1740783091.602 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2 2025-02-28T22:51:31.614Z,1740783091.614 [AHRS_M2](INFO): Powering down 2025-02-28T22:51:31.795Z,1740783091.795 [CBIT](INFO): Critical error at 20250228T225131 2025-02-28T22:51:33.864Z,1740783093.864 [CommandExec](IMPORTANT): got command failComponent 2025-02-28T22:51:33.865Z,1740783093.865 [CommandExec](IMPORTANT): Failed components: 2025-02-28T22:51:33.865Z,1740783093.865 [CommandExec](IMPORTANT): WetLabsBB2FL: Communications Fault 2025-02-28T22:51:33.865Z,1740783093.865 [CommandExec](IMPORTANT): AHRS_M2: Communications Fault 2025-02-28T22:51:33.865Z,1740783093.865 [CommandExec](IMPORTANT): DVL_micro: Communications Fault 2025-02-28T22:51:39.817Z,1740783099.817 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.014762 CHAN A1 (24V): -0.030831 CHAN A2 (12V): -0.004849 CHAN A3 (5V): -0.002458 CHAN B0 (3.3V): -0.001072 CHAN B1 (3.15aV): -0.001309 CHAN B2 (3.15bV): -0.000996 CHAN B3 (GND): 0.000014 OPEN: 0.007154 Full Scale: +/- 1 mA 2025-02-28T22:52:20.508Z,1740783140.508 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2025-02-28T22:52:20.508Z,1740783140.508 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2025-02-28T22:52:20.508Z,1740783140.508 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-02-28T22:52:20.519Z,1740783140.519 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-02-28T22:52:20.923Z,1740783140.923 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-02-28T22:52:20.923Z,1740783140.923 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2025-02-28T22:52:22.573Z,1740783142.573 [SBIT](IMPORTANT): SBIT PASSED 2025-02-28T22:52:22.574Z,1740783142.574 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2025-02-28T22:52:22.574Z,1740783142.574 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=5 count; 2025-02-28T22:52:22.574Z,1740783142.574 [SBIT](IMPORTANT): CBIT.gf24Offset=180 microampere; 2025-02-28T22:52:22.575Z,1740783142.575 [SBIT](IMPORTANT): CBIT.runNavErrorCritical=0 bool; 2025-02-28T22:52:22.575Z,1740783142.575 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool; 2025-02-28T22:52:22.575Z,1740783142.575 [SBIT](IMPORTANT): DATMMP.loadAtStartup=1 bool; 2025-02-28T22:52:22.575Z,1740783142.575 [SBIT](IMPORTANT): DATMMP.simulateHardware=0 bool; 2025-02-28T22:52:22.575Z,1740783142.575 [SBIT](IMPORTANT): DVL_micro.loadAtStartup=1 bool; 2025-02-28T22:52:22.575Z,1740783142.575 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool; 2025-02-28T22:52:22.575Z,1740783142.575 [SBIT](IMPORTANT): ESPComponent.loadAtStartup=1 bool; 2025-02-28T22:52:22.575Z,1740783142.575 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=30 minute; 2025-02-28T22:52:22.575Z,1740783142.575 [SBIT](IMPORTANT): ESPComponent.simulateHardware=0 bool; 2025-02-28T22:52:22.575Z,1740783142.575 [SBIT](IMPORTANT): Express none CTD_Seabird.bin_median_sea_water_salinity; 2025-02-28T22:52:22.576Z,1740783142.576 [SBIT](IMPORTANT): Express none CTD_Seabird.bin_median_sea_water_temperature; 2025-02-28T22:52:22.576Z,1740783142.576 [SBIT](IMPORTANT): Express none DATMMP.acoustic_contact_range; 2025-02-28T22:52:22.576Z,1740783142.576 [SBIT](IMPORTANT): Express none WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water; 2025-02-28T22:52:22.576Z,1740783142.576 [SBIT](IMPORTANT): Express none depth; 2025-02-28T22:52:22.576Z,1740783142.576 [SBIT](IMPORTANT): Express none platform_average_current; 2025-02-28T22:52:22.576Z,1740783142.576 [SBIT](IMPORTANT): IBIT.batteryCapacityThreshold=-0.1 ampere_hour; 2025-02-28T22:52:22.577Z,1740783142.577 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=11.5 volt; 2025-02-28T22:52:22.577Z,1740783142.577 [SBIT](IMPORTANT): NAL9602.fastGPSFix=0 bool; 2025-02-28T22:52:22.577Z,1740783142.577 [SBIT](IMPORTANT): Normal all depth; 2025-02-28T22:52:22.577Z,1740783142.577 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=214.355421 cubic_centimeter; 2025-02-28T22:52:22.577Z,1740783142.577 [SBIT](IMPORTANT): VerticalControl.massDefault=12.200269 millimeter; 2025-02-28T22:52:22.947Z,1740783142.947 [MissionManager](IMPORTANT): Started mission Startup 2025-02-28T22:52:22.947Z,1740783142.947 [Startup] Running Loop=1 2025-02-28T22:52:22.947Z,1740783142.947 [Startup](DEBUG): Aggregate::initialize Startup 2025-02-28T22:52:22.948Z,1740783142.948 [Startup:A.GoToSurface] Running Loop=1 2025-02-28T22:52:22.948Z,1740783142.948 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-02-28T22:52:22.948Z,1740783142.948 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-02-28T22:52:22.949Z,1740783142.949 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-02-28T22:52:22.949Z,1740783142.949 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-02-28T22:52:22.949Z,1740783142.949 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-02-28T22:52:22.950Z,1740783142.950 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-02-28T22:52:22.950Z,1740783142.950 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-02-28T22:52:22.952Z,1740783142.952 [Startup:StartupSatComms] Running Loop=1 2025-02-28T22:52:22.952Z,1740783142.952 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2025-02-28T22:52:22.952Z,1740783142.952 [Startup:StartupSatComms:A] Running Loop=1 2025-02-28T22:52:23.393Z,1740783143.393 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2025-02-28T22:53:23.153Z,1740783203.153 [Startup:StartupSatComms:A](INFO): Timed out from 2025-02-28T22:52:22.0Z 2025-02-28T22:53:23.153Z,1740783203.153 [Startup:StartupSatComms:A] Stopped 2025-02-28T22:53:23.153Z,1740783203.153 [Startup:StartupSatComms:B] Running Loop=1 2025-02-28T22:53:23.557Z,1740783203.557 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-02-28T22:53:24.004Z,1740783204.004 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-02-28T22:53:24.005Z,1740783204.005 [WetLabsBB2FL] No Fault, FailCount= 5 2025-02-28T22:53:24.297Z,1740783204.297 [WetLabsBB2FL](INFO): Powering up 2025-02-28T22:53:28.663Z,1740783208.663 [DataOverHttps](INFO): Sending 91 bytes from file Logs/20250227T222820/Courier0019.lzma 2025-02-28T22:53:29.588Z,1740783209.588 [WetLabsBB2FL] Communications Fault, FailCount= 1 2025-02-28T22:53:29.588Z,1740783209.588 [WetLabsBB2FL](ERROR): Communications Fault 2025-02-28T22:53:29.666Z,1740783209.666 [DataOverHttps](INFO): Moved sent file to Logs/20250227T222820/Courier0019.lzma.bak 2025-02-28T22:53:29.666Z,1740783209.666 [DataOverHttps](INFO): SBD MOMSN=23981626 2025-02-28T22:53:29.691Z,1740783209.691 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-02-28T22:53:30.091Z,1740783210.091 [WetLabsBB2FL](INFO): Powering down 2025-02-28T22:53:31.244Z,1740783211.244 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-02-28T22:53:31.244Z,1740783211.244 [WetLabsBB2FL] No Fault, FailCount= 1 2025-02-28T22:53:31.305Z,1740783211.305 [WetLabsBB2FL](INFO): Powering up 2025-02-28T22:53:36.596Z,1740783216.596 [WetLabsBB2FL] Communications Fault, FailCount= 2 2025-02-28T22:53:36.596Z,1740783216.596 [WetLabsBB2FL](ERROR): Communications Fault 2025-02-28T22:53:36.898Z,1740783216.898 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-02-28T22:53:37.096Z,1740783217.096 [WetLabsBB2FL](INFO): Powering down 2025-02-28T22:53:38.116Z,1740783218.116 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-02-28T22:53:38.116Z,1740783218.116 [WetLabsBB2FL] No Fault, FailCount= 2 2025-02-28T22:53:38.309Z,1740783218.309 [WetLabsBB2FL](INFO): Powering up 2025-02-28T22:53:43.604Z,1740783223.604 [WetLabsBB2FL] Communications Fault, FailCount= 3 2025-02-28T22:53:43.604Z,1740783223.604 [WetLabsBB2FL](ERROR): Communications Fault 2025-02-28T22:53:43.801Z,1740783223.801 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-02-28T22:53:44.104Z,1740783224.104 [WetLabsBB2FL](INFO): Powering down 2025-02-28T22:53:44.998Z,1740783224.998 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-02-28T22:53:44.998Z,1740783224.998 [WetLabsBB2FL] No Fault, FailCount= 3 2025-02-28T22:53:45.129Z,1740783225.129 [DataOverHttps](INFO): Sending 305 bytes from file Logs/20250228T225004/Courier0000.lzma 2025-02-28T22:53:45.317Z,1740783225.317 [WetLabsBB2FL](INFO): Powering up 2025-02-28T22:53:46.130Z,1740783226.130 [DataOverHttps](INFO): Moved sent file to Logs/20250228T225004/Courier0000.lzma.bak 2025-02-28T22:53:46.130Z,1740783226.130 [DataOverHttps](INFO): SBD MOMSN=23981629 2025-02-28T22:53:50.612Z,1740783230.612 [WetLabsBB2FL] Communications Fault, FailCount= 4 2025-02-28T22:53:50.612Z,1740783230.612 [WetLabsBB2FL](ERROR): Communications Fault 2025-02-28T22:53:50.692Z,1740783230.692 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-02-28T22:53:51.108Z,1740783231.108 [WetLabsBB2FL](INFO): Powering down 2025-02-28T22:53:52.278Z,1740783232.278 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-02-28T22:53:52.278Z,1740783232.278 [WetLabsBB2FL] No Fault, FailCount= 4 2025-02-28T22:53:52.322Z,1740783232.322 [WetLabsBB2FL](INFO): Powering up 2025-02-28T22:53:57.640Z,1740783237.640 [WetLabsBB2FL] Communications Fault, FailCount= 5 2025-02-28T22:53:57.640Z,1740783237.640 [WetLabsBB2FL](ERROR): Communications Fault 2025-02-28T22:53:57.908Z,1740783237.908 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-02-28T22:53:57.909Z,1740783237.909 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL 2025-02-28T22:53:58.140Z,1740783238.140 [WetLabsBB2FL](INFO): Powering down 2025-02-28T22:54:03.427Z,1740783243.427 [DataOverHttps](INFO): Sending 162 bytes from file Logs/20250227T222820/Express0020.lzma 2025-02-28T22:54:04.430Z,1740783244.430 [DataOverHttps](INFO): Moved sent file to Logs/20250227T222820/Express0020.lzma.bak 2025-02-28T22:54:04.430Z,1740783244.430 [DataOverHttps](INFO): SBD MOMSN=23981635 2025-02-28T22:54:17.322Z,1740783257.322 [CBIT](INFO): Clearing failed state for component DVL_micro 2025-02-28T22:54:17.322Z,1740783257.322 [DVL_micro] No Fault, FailCount= 3 2025-02-28T22:54:20.905Z,1740783260.905 [DataOverHttps](INFO): Sending 1252 bytes from file Logs/20250228T225004/Express0001.lzma 2025-02-28T22:54:21.351Z,1740783261.351 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2025-02-28T22:54:21.351Z,1740783261.351 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2025-02-28T22:54:21.351Z,1740783261.351 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-02-28T22:54:21.362Z,1740783261.362 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-02-28T22:54:21.773Z,1740783261.773 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-02-28T22:54:21.773Z,1740783261.773 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2025-02-28T22:54:21.906Z,1740783261.906 [DataOverHttps](INFO): Moved sent file to Logs/20250228T225004/Express0001.lzma.bak 2025-02-28T22:54:21.906Z,1740783261.906 [DataOverHttps](INFO): SBD MOMSN=23981644 2025-02-28T22:54:23.461Z,1740783263.461 [Startup:StartupSatComms:B](INFO): Timed out from 2025-02-28T22:53:23.2Z 2025-02-28T22:54:23.461Z,1740783263.461 [Startup:StartupSatComms:B] Stopped 2025-02-28T22:54:23.461Z,1740783263.461 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2025-02-28T22:54:23.461Z,1740783263.461 [Startup:StartupSatComms] Stopped 2025-02-28T22:54:23.461Z,1740783263.461 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2025-02-28T22:54:23.462Z,1740783263.462 [Startup](INFO): Completed Startup 2025-02-28T22:54:23.462Z,1740783263.462 [MissionManager](INFO): Startup is completed. 2025-02-28T22:54:23.462Z,1740783263.462 [MissionManager](INFO): Uninitializing Mission Startup 2025-02-28T22:54:23.462Z,1740783263.462 [Startup] Stopped 2025-02-28T22:54:23.463Z,1740783263.463 [Startup](DEBUG): Aggregate::uninitialize Startup 2025-02-28T22:54:23.463Z,1740783263.463 [Startup:A.GoToSurface] Stopped 2025-02-28T22:54:23.463Z,1740783263.463 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-02-28T22:54:23.812Z,1740783263.812 [MissionManager](IMPORTANT): Started mission Default 2025-02-28T22:54:23.812Z,1740783263.812 [Default] Running Loop=1 2025-02-28T22:54:23.812Z,1740783263.812 [Default](DEBUG): Aggregate::initialize Default 2025-02-28T22:54:23.812Z,1740783263.812 [Default:B.GoToSurface] Running Loop=1 2025-02-28T22:54:23.812Z,1740783263.812 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-02-28T22:54:23.813Z,1740783263.813 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-02-28T22:54:23.813Z,1740783263.813 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-02-28T22:54:23.813Z,1740783263.813 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-02-28T22:54:23.813Z,1740783263.813 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-02-28T22:54:23.814Z,1740783263.814 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-02-28T22:54:23.814Z,1740783263.814 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-02-28T22:54:23.814Z,1740783263.814 [Default:A.Wait] Running Loop=1 2025-02-28T22:54:23.814Z,1740783263.814 [Default:A.Wait](DEBUG): Initialize Wait Component. 2025-02-28T22:54:35.063Z,1740783275.063 [DVL_micro](FAULT): Failed to initialize within timeout. 2025-02-28T22:54:35.063Z,1740783275.063 [DVL_micro] Communications Fault, FailCount= 1 2025-02-28T22:54:35.063Z,1740783275.063 [DVL_micro](ERROR): Communications Fault 2025-02-28T22:54:35.104Z,1740783275.104 [CBIT](ERROR): Communications Fault in component: DVL_micro 2025-02-28T22:54:35.564Z,1740783275.564 [DVL_micro](INFO): Powering down 2025-02-28T22:54:36.296Z,1740783276.296 [CBIT](INFO): Clearing failed state for component DVL_micro 2025-02-28T22:54:36.296Z,1740783276.296 [DVL_micro] No Fault, FailCount= 1 2025-02-28T22:54:37.133Z,1740783277.133 [Default:A.Wait](INFO): Done Waiting. 2025-02-28T22:54:37.133Z,1740783277.133 [Default:A.Wait] Stopped 2025-02-28T22:54:37.133Z,1740783277.133 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2025-02-28T22:54:37.537Z,1740783277.537 [Default:CheckIn] Running Loop=1 2025-02-28T22:54:37.537Z,1740783277.537 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-02-28T22:54:37.537Z,1740783277.537 [Default:CheckIn:Read_GPS] Running Loop=1 2025-02-28T22:54:37.930Z,1740783277.930 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2025-02-28T22:54:54.051Z,1740783294.051 [DVL_micro](FAULT): Failed to initialize within timeout. 2025-02-28T22:54:54.051Z,1740783294.051 [DVL_micro] Communications Fault, FailCount= 2 2025-02-28T22:54:54.051Z,1740783294.051 [DVL_micro](ERROR): Communications Fault 2025-02-28T22:54:54.071Z,1740783294.071 [CBIT](ERROR): Communications Fault in component: DVL_micro 2025-02-28T22:54:54.612Z,1740783294.612 [DVL_micro](INFO): Powering down 2025-02-28T22:54:55.296Z,1740783295.296 [CBIT](INFO): Clearing failed state for component DVL_micro 2025-02-28T22:54:55.296Z,1740783295.296 [DVL_micro] No Fault, FailCount= 2 2025-02-28T22:55:13.040Z,1740783313.040 [DVL_micro](FAULT): Failed to initialize within timeout. 2025-02-28T22:55:13.040Z,1740783313.040 [DVL_micro] Communications Fault, FailCount= 3 2025-02-28T22:55:13.040Z,1740783313.040 [DVL_micro](ERROR): Communications Fault 2025-02-28T22:55:13.061Z,1740783313.061 [CBIT](ERROR): Communications Fault in component: DVL_micro 2025-02-28T22:55:13.061Z,1740783313.061 [CBIT](CRITICAL): Communications Fault in component: DVL_micro 2025-02-28T22:55:13.540Z,1740783313.540 [DVL_micro](INFO): Powering down 2025-02-28T22:55:13.588Z,1740783313.588 [CBIT](INFO): Critical error at 20250228T225513 2025-02-28T22:56:03.143Z,1740783363.143 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-02-28T22:56:22.556Z,1740783382.556 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2025-02-28T22:56:22.556Z,1740783382.556 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2025-02-28T22:56:22.556Z,1740783382.556 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-02-28T22:56:22.568Z,1740783382.568 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-02-28T22:56:22.961Z,1740783382.961 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-02-28T22:56:22.961Z,1740783382.961 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2025-02-28T22:56:27.844Z,1740783387.844 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-02-28T22:56:27.844Z,1740783387.844 [WetLabsBB2FL] No Fault, FailCount= 5 2025-02-28T22:56:28.025Z,1740783388.025 [WetLabsBB2FL](INFO): Powering up 2025-02-28T22:56:31.862Z,1740783391.862 [CBIT](INFO): Clearing failed state for component AHRS_M2 2025-02-28T22:56:31.862Z,1740783391.862 [AHRS_M2] No Fault, FailCount= 5 2025-02-28T22:56:32.225Z,1740783392.225 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-02-28T22:56:33.316Z,1740783393.316 [WetLabsBB2FL] Communications Fault, FailCount= 1 2025-02-28T22:56:33.316Z,1740783393.316 [WetLabsBB2FL](ERROR): Communications Fault 2025-02-28T22:56:33.475Z,1740783393.475 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-02-28T22:56:33.816Z,1740783393.816 [WetLabsBB2FL](INFO): Powering down 2025-02-28T22:56:34.676Z,1740783394.676 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-02-28T22:56:34.676Z,1740783394.676 [WetLabsBB2FL] No Fault, FailCount= 1 2025-02-28T22:56:35.029Z,1740783395.029 [WetLabsBB2FL](INFO): Powering up 2025-02-28T22:56:35.792Z,1740783395.792 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:36.208Z,1740783396.208 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:36.640Z,1740783396.640 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:37.064Z,1740783397.064 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:37.496Z,1740783397.496 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:37.984Z,1740783397.984 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:38.428Z,1740783398.428 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:38.848Z,1740783398.848 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:39.276Z,1740783399.276 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:39.692Z,1740783399.692 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:40.148Z,1740783400.148 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:40.324Z,1740783400.324 [WetLabsBB2FL] Communications Fault, FailCount= 2 2025-02-28T22:56:40.324Z,1740783400.324 [WetLabsBB2FL](ERROR): Communications Fault 2025-02-28T22:56:40.588Z,1740783400.588 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:40.637Z,1740783400.637 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-02-28T22:56:40.824Z,1740783400.824 [WetLabsBB2FL](INFO): Powering down 2025-02-28T22:56:41.028Z,1740783401.028 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:41.444Z,1740783401.444 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:41.868Z,1740783401.868 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:41.959Z,1740783401.959 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-02-28T22:56:41.959Z,1740783401.959 [WetLabsBB2FL] No Fault, FailCount= 2 2025-02-28T22:56:42.037Z,1740783402.037 [WetLabsBB2FL](INFO): Powering up 2025-02-28T22:56:42.344Z,1740783402.344 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:42.780Z,1740783402.780 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:43.224Z,1740783403.224 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:43.676Z,1740783403.676 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:44.100Z,1740783404.100 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:44.520Z,1740783404.520 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:44.936Z,1740783404.936 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:45.352Z,1740783405.352 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:45.352Z,1740783405.352 [AHRS_M2](FAULT): Failed to initialize within timeout. 2025-02-28T22:56:45.352Z,1740783405.352 [AHRS_M2] Communications Fault, FailCount= 1 2025-02-28T22:56:45.352Z,1740783405.352 [AHRS_M2](ERROR): Communications Fault 2025-02-28T22:56:45.373Z,1740783405.373 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2025-02-28T22:56:45.445Z,1740783405.445 [AHRS_M2](INFO): Powering down 2025-02-28T22:56:46.240Z,1740783406.240 [CBIT](INFO): Clearing failed state for component AHRS_M2 2025-02-28T22:56:46.240Z,1740783406.240 [AHRS_M2] No Fault, FailCount= 1 2025-02-28T22:56:46.608Z,1740783406.608 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-02-28T22:56:47.328Z,1740783407.328 [WetLabsBB2FL] Communications Fault, FailCount= 3 2025-02-28T22:56:47.328Z,1740783407.328 [WetLabsBB2FL](ERROR): Communications Fault 2025-02-28T22:56:47.470Z,1740783407.470 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-02-28T22:56:47.828Z,1740783407.828 [WetLabsBB2FL](INFO): Powering down 2025-02-28T22:56:48.651Z,1740783408.651 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-02-28T22:56:48.651Z,1740783408.651 [WetLabsBB2FL] No Fault, FailCount= 3 2025-02-28T22:56:49.296Z,1740783409.296 [WetLabsBB2FL](INFO): Powering up 2025-02-28T22:56:50.164Z,1740783410.164 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:50.592Z,1740783410.592 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:51.024Z,1740783411.024 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:51.500Z,1740783411.500 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:51.952Z,1740783411.952 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:52.372Z,1740783412.372 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:52.800Z,1740783412.800 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:53.240Z,1740783413.240 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:53.680Z,1740783413.680 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:54.104Z,1740783414.104 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:54.336Z,1740783414.336 [WetLabsBB2FL] Communications Fault, FailCount= 4 2025-02-28T22:56:54.336Z,1740783414.336 [WetLabsBB2FL](ERROR): Communications Fault 2025-02-28T22:56:54.508Z,1740783414.508 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:54.554Z,1740783414.554 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-02-28T22:56:54.836Z,1740783414.836 [WetLabsBB2FL](INFO): Powering down 2025-02-28T22:56:54.916Z,1740783414.916 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:55.336Z,1740783415.336 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:55.816Z,1740783415.816 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:55.875Z,1740783415.875 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-02-28T22:56:55.875Z,1740783415.875 [WetLabsBB2FL] No Fault, FailCount= 4 2025-02-28T22:56:56.049Z,1740783416.049 [WetLabsBB2FL](INFO): Powering up 2025-02-28T22:56:56.260Z,1740783416.260 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:56.704Z,1740783416.704 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:57.152Z,1740783417.152 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:57.560Z,1740783417.560 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:57.980Z,1740783417.980 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:58.420Z,1740783418.420 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:58.836Z,1740783418.836 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:59.276Z,1740783419.276 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:59.720Z,1740783419.720 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:56:59.720Z,1740783419.720 [AHRS_M2](FAULT): Failed to initialize within timeout. 2025-02-28T22:56:59.720Z,1740783419.720 [AHRS_M2] Communications Fault, FailCount= 2 2025-02-28T22:56:59.720Z,1740783419.720 [AHRS_M2](ERROR): Communications Fault 2025-02-28T22:56:59.809Z,1740783419.809 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2025-02-28T22:56:59.873Z,1740783419.873 [AHRS_M2](INFO): Powering down 2025-02-28T22:57:00.702Z,1740783420.702 [CBIT](INFO): Clearing failed state for component AHRS_M2 2025-02-28T22:57:00.702Z,1740783420.702 [AHRS_M2] No Fault, FailCount= 2 2025-02-28T22:57:01.028Z,1740783421.028 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-02-28T22:57:01.356Z,1740783421.356 [WetLabsBB2FL] Communications Fault, FailCount= 5 2025-02-28T22:57:01.356Z,1740783421.356 [WetLabsBB2FL](ERROR): Communications Fault 2025-02-28T22:57:01.477Z,1740783421.477 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-02-28T22:57:01.477Z,1740783421.477 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL 2025-02-28T22:57:01.856Z,1740783421.856 [WetLabsBB2FL](INFO): Powering down 2025-02-28T22:57:04.592Z,1740783424.592 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:05.008Z,1740783425.008 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:05.504Z,1740783425.504 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:05.972Z,1740783425.972 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:06.416Z,1740783426.416 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:06.844Z,1740783426.844 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:07.260Z,1740783427.260 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:07.676Z,1740783427.676 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:08.112Z,1740783428.112 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:08.556Z,1740783428.556 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:08.976Z,1740783428.976 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:09.452Z,1740783429.452 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:09.880Z,1740783429.880 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:10.312Z,1740783430.312 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:10.744Z,1740783430.744 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:11.180Z,1740783431.180 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:11.620Z,1740783431.620 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:12.048Z,1740783432.048 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:12.460Z,1740783432.460 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:12.880Z,1740783432.880 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:13.308Z,1740783433.308 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:13.737Z,1740783433.737 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:14.176Z,1740783434.176 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:14.176Z,1740783434.176 [AHRS_M2](FAULT): Failed to initialize within timeout. 2025-02-28T22:57:14.176Z,1740783434.176 [AHRS_M2] Communications Fault, FailCount= 3 2025-02-28T22:57:14.176Z,1740783434.176 [AHRS_M2](ERROR): Communications Fault 2025-02-28T22:57:14.241Z,1740783434.241 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2025-02-28T22:57:14.292Z,1740783434.292 [AHRS_M2](INFO): Powering down 2025-02-28T22:57:15.082Z,1740783435.082 [CBIT](INFO): Clearing failed state for component AHRS_M2 2025-02-28T22:57:15.082Z,1740783435.082 [AHRS_M2] No Fault, FailCount= 3 2025-02-28T22:57:15.467Z,1740783435.467 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-02-28T22:57:19.020Z,1740783439.020 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:19.444Z,1740783439.444 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:19.876Z,1740783439.876 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:20.324Z,1740783440.324 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:20.764Z,1740783440.764 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:21.196Z,1740783441.196 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:21.616Z,1740783441.616 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:22.032Z,1740783442.032 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:22.456Z,1740783442.456 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:22.956Z,1740783442.956 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:23.384Z,1740783443.384 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:23.840Z,1740783443.840 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:24.268Z,1740783444.268 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:24.684Z,1740783444.684 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:25.108Z,1740783445.108 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:25.524Z,1740783445.524 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:25.948Z,1740783445.948 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:26.388Z,1740783446.388 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:26.820Z,1740783446.820 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:27.236Z,1740783447.236 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:27.660Z,1740783447.660 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:28.080Z,1740783448.080 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:28.496Z,1740783448.496 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:28.496Z,1740783448.496 [AHRS_M2](FAULT): Failed to initialize within timeout. 2025-02-28T22:57:28.496Z,1740783448.496 [AHRS_M2] Communications Fault, FailCount= 4 2025-02-28T22:57:28.496Z,1740783448.496 [AHRS_M2](ERROR): Communications Fault 2025-02-28T22:57:28.581Z,1740783448.581 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2025-02-28T22:57:28.629Z,1740783448.629 [AHRS_M2](INFO): Powering down 2025-02-28T22:57:29.439Z,1740783449.439 [CBIT](INFO): Clearing failed state for component AHRS_M2 2025-02-28T22:57:29.439Z,1740783449.439 [AHRS_M2] No Fault, FailCount= 4 2025-02-28T22:57:29.800Z,1740783449.800 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-02-28T22:57:33.360Z,1740783453.360 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:33.788Z,1740783453.788 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:34.220Z,1740783454.220 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:34.664Z,1740783454.664 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:35.112Z,1740783455.112 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:35.528Z,1740783455.528 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:36.012Z,1740783456.012 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:36.444Z,1740783456.444 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:36.884Z,1740783456.884 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:37.340Z,1740783457.340 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:37.768Z,1740783457.768 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:38.184Z,1740783458.184 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:38.608Z,1740783458.608 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:39.036Z,1740783459.036 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:39.464Z,1740783459.464 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:39.896Z,1740783459.896 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:40.328Z,1740783460.328 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:40.764Z,1740783460.764 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:41.176Z,1740783461.176 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:41.588Z,1740783461.588 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:42.016Z,1740783462.016 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:42.432Z,1740783462.432 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:42.864Z,1740783462.864 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-02-28T22:57:42.864Z,1740783462.864 [AHRS_M2](FAULT): Failed to initialize within timeout. 2025-02-28T22:57:42.864Z,1740783462.864 [AHRS_M2] Communications Fault, FailCount= 5 2025-02-28T22:57:42.864Z,1740783462.864 [AHRS_M2](ERROR): Communications Fault 2025-02-28T22:57:42.926Z,1740783462.926 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2025-02-28T22:57:42.926Z,1740783462.926 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2 2025-02-28T22:57:42.985Z,1740783462.985 [AHRS_M2](INFO): Powering down 2025-02-28T22:57:43.105Z,1740783463.105 [CBIT](INFO): Critical error at 20250228T225742 2025-02-28T22:57:46.432Z,1740783466.432 [CommandExec](IMPORTANT): got command quit 2025-02-28T22:57:47.436Z,1740783467.436 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2025-02-28T22:57:47.436Z,1740783467.436 [CommandExec](INFO): Uninitializing the command executive. 2025-02-28T22:57:47.436Z,1740783467.436 [CommandExec](INFO): Uninitializing the command scheduler. 2025-02-28T22:57:47.436Z,1740783467.436 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-02-28T22:57:47.448Z,1740783467.448 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2025-02-28T22:57:47.448Z,1740783467.448 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2025-02-28T22:57:47.448Z,1740783467.448 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-02-28T22:57:47.449Z,1740783467.449 [NavChartDb](INFO): Join timeout helper Thread ID is 4462 2025-02-28T22:57:47.476Z,1740783467.476 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2025-02-28T22:57:47.476Z,1740783467.476 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-02-28T22:57:47.495Z,1740783467.495 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2025-02-28T22:57:47.495Z,1740783467.495 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-02-28T22:57:47.496Z,1740783467.496 [Radio_Surface](INFO): Join timeout helper Thread ID is 4463 2025-02-28T22:57:47.892Z,1740783467.892 [Radio_Surface](INFO): Powering down 2025-02-28T22:57:47.893Z,1740783467.893 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2025-02-28T22:57:47.893Z,1740783467.893 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-02-28T22:57:47.912Z,1740783467.912 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2025-02-28T22:57:47.912Z,1740783467.912 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-02-28T22:57:47.912Z,1740783467.912 [Onboard](INFO): Join timeout helper Thread ID is 4464 2025-02-28T22:57:48.316Z,1740783468.316 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2025-02-28T22:57:50.492Z,1740783470.492 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2025-02-28T22:57:50.492Z,1740783470.492 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-02-28T22:57:50.504Z,1740783470.504 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2025-02-28T22:57:50.504Z,1740783470.504 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-02-28T22:57:50.504Z,1740783470.504 [DataOverHttps](INFO): Join timeout helper Thread ID is 4465 2025-02-28T22:57:51.328Z,1740783471.328 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2025-02-28T22:57:51.328Z,1740783471.328 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-02-28T22:57:51.340Z,1740783471.340 [ComponentRegistry](INFO): Shutting down DATMMP ThreadHandler 2025-02-28T22:57:51.340Z,1740783471.340 [DATMMP ThreadHandler](INFO): Thread cancelled. 2025-02-28T22:57:51.340Z,1740783471.340 [DATMMP](INFO): Join timeout helper Thread ID is 4466 2025-02-28T22:57:51.560Z,1740783471.560 [DATMMP](INFO): Stop 2025-02-28T22:57:51.560Z,1740783471.560 [DATMMP](INFO): uninitialize 2025-02-28T22:57:51.560Z,1740783471.560 [DATMMP](INFO): Powering down 2025-02-28T22:57:51.633Z,1740783471.633 [DATMMP ThreadHandler](INFO): Uninitializing protected caller thread. 2025-02-28T22:57:51.633Z,1740783471.633 [DATMMP](INFO): uninitialize 2025-02-28T22:57:51.633Z,1740783471.633 [DATMMP](INFO): Powering down 2025-02-28T22:57:51.634Z,1740783471.634 [DATMMP ThreadHandler](INFO): Thread cancelled. 2025-02-28T22:57:51.645Z,1740783471.645 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2025-02-28T22:57:51.645Z,1740783471.645 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-02-28T22:57:51.646Z,1740783471.646 [BackseatComponent](INFO): Join timeout helper Thread ID is 4467 2025-02-28T22:57:51.740Z,1740783471.740 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2025-02-28T22:57:51.740Z,1740783471.740 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-02-28T22:57:51.745Z,1740783471.745 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2025-02-28T22:57:51.745Z,1740783471.745 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-02-28T22:57:51.745Z,1740783471.745 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 4468 2025-02-28T22:57:51.976Z,1740783471.976 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2025-02-28T22:57:51.976Z,1740783471.976 [WetLabsBB2FL](INFO): Powering down 2025-02-28T22:57:51.977Z,1740783471.977 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-02-28T22:57:51.993Z,1740783471.993 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2025-02-28T22:57:51.993Z,1740783471.993 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-02-28T22:57:51.993Z,1740783471.993 [CTD_Seabird](INFO): Join timeout helper Thread ID is 4469 2025-02-28T22:57:52.968Z,1740783472.968 [CTD_Seabird](INFO): Powering down 2025-02-28T22:57:52.980Z,1740783472.980 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2025-02-28T22:57:52.980Z,1740783472.980 [CTD_Seabird](INFO): Powering down 2025-02-28T22:57:52.992Z,1740783472.992 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-02-28T22:57:53.001Z,1740783473.001 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2025-02-28T22:57:53.001Z,1740783473.001 [logger ThreadHandler](INFO): Thread cancelled. 2025-02-28T22:57:53.001Z,1740783473.001 [logger](INFO): Join timeout helper Thread ID is 4470 2025-02-28T22:57:53.023Z,1740783473.023 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2025-02-28T22:57:53.023Z,1740783473.023 [logger ThreadHandler](INFO): Thread cancelled. 2025-02-28T22:57:53.037Z,1740783473.037 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2025-02-28T22:57:53.037Z,1740783473.037 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-02-28T22:57:53.037Z,1740783473.037 [CommandLine](INFO): Join timeout helper Thread ID is 4471 2025-02-28T22:57:53.136Z,1740783473.136 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2025-02-28T22:57:53.136Z,1740783473.136 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-02-28T22:57:53.141Z,1740783473.141 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2025-02-28T22:57:53.141Z,1740783473.141 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-02-28T22:57:53.141Z,1740783473.141 [CommandExec](INFO): Join timeout helper Thread ID is 4472 2025-02-28T22:57:53.142Z,1740783473.142 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2025-02-28T22:57:53.143Z,1740783473.143 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-02-28T22:57:53.143Z,1740783473.143 [controlThread](INFO): Join timeout helper Thread ID is 4473 2025-02-28T22:57:53.432Z,1740783473.432 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2025-02-28T22:57:53.432Z,1740783473.432 [controlThread](DEBUG): Uninitializing ControlThread 2025-02-28T22:57:53.434Z,1740783473.434 [AHRS_M2](INFO): Powering down 2025-02-28T22:57:53.435Z,1740783473.435 [DVL_micro](INFO): Powering down 2025-02-28T22:57:53.436Z,1740783473.436 [NAL9602](INFO): Powering down 2025-02-28T22:57:53.438Z,1740783473.438 [Sonardyne_Nano](INFO): Powering down 2025-02-28T22:57:53.556Z,1740783473.556 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2025-02-28T22:57:53.557Z,1740783473.557 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2025-02-28T22:57:53.558Z,1740783473.558 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2025-02-28T22:57:53.558Z,1740783473.558 [MissionManager](INFO): Uninitializing Mission Default 2025-02-28T22:57:53.558Z,1740783473.558 [Default] Stopped 2025-02-28T22:57:53.558Z,1740783473.558 [Default](DEBUG): Aggregate::uninitialize Default 2025-02-28T22:57:53.558Z,1740783473.558 [Default:B.GoToSurface] Stopped 2025-02-28T22:57:53.559Z,1740783473.559 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-02-28T22:57:53.559Z,1740783473.559 [Default:CheckIn] Stopped 2025-02-28T22:57:53.559Z,1740783473.559 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-02-28T22:57:53.559Z,1740783473.559 [Default:CheckIn:Read_GPS] Stopped 2025-02-28T22:57:53.562Z,1740783473.562 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2025-02-28T22:57:53.562Z,1740783473.562 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2025-02-28T22:57:53.562Z,1740783473.562 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2025-02-28T22:57:53.562Z,1740783473.562 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2025-02-28T22:57:53.563Z,1740783473.563 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2025-02-28T22:57:53.563Z,1740783473.563 [BuoyancyServo](INFO): Powering down 2025-02-28T22:57:53.576Z,1740783473.576 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-02-28T22:57:53.576Z,1740783473.576 [ElevatorServo](INFO): Powering down 2025-02-28T22:57:53.577Z,1740783473.577 [MassServo](DEBUG): Uninitialize Mass Servo. 2025-02-28T22:57:53.577Z,1740783473.577 [MassServo](INFO): Powering down 2025-02-28T22:57:53.578Z,1740783473.578 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-02-28T22:57:53.578Z,1740783473.578 [RudderServo](INFO): Powering down 2025-02-28T22:57:53.579Z,1740783473.579 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2025-02-28T22:57:53.579Z,1740783473.579 [ThrusterHE](INFO): Powering down 2025-02-28T22:57:53.580Z,1740783473.580 [SBIT](DEBUG): Uninitialize SBIT Component. 2025-02-28T22:57:53.580Z,1740783473.580 [IBIT](DEBUG): Uninitialize IBIT Component. 2025-02-28T22:57:53.580Z,1740783473.580 [CBIT](DEBUG): Uninitialize CBIT Component. 2025-02-28T22:57:53.581Z,1740783473.581 [CBIT](DEBUG): Powering off loads. 2025-02-28T22:57:53.592Z,1740783473.592 [CBIT](DEBUG): Disabling WDT. 2025-02-28T22:57:53.604Z,1740783473.604 [CBIT](DEBUG): Opening all GF detection circuits. 2025-02-28T22:57:53.605Z,1740783473.605 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-02-28T22:57:53.651Z,1740783473.651 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-02-28T22:57:53.658Z,1740783473.658 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-02-28T22:57:53.688Z,1740783473.688 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-02-28T22:57:53.690Z,1740783473.690 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-02-28T22:57:53.697Z,1740783473.697 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-02-28T22:57:53.703Z,1740783473.703 [DATMMP ThreadHandler](INFO): Thread cancelled. 2025-02-28T22:57:53.744Z,1740783473.744 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-02-28T22:57:53.797Z,1740783473.797 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-02-28T22:57:53.863Z,1740783473.863 [logger ThreadHandler](INFO): Thread cancelled.