2022-05-09T23:48:22.825Z,1652140102.825 [Supervisor](DEBUG): Initializing supervisor. 2022-05-09T23:48:22.829Z,1652140102.829 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2022-05-09T23:48:22.830Z,1652140102.830 [SyncHandler](INFO): Protected caller Thread ID is 6588 2022-05-09T23:48:22.830Z,1652140102.830 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2022-05-09T23:48:22.831Z,1652140102.831 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2022-05-09T23:48:22.831Z,1652140102.831 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 6589 2022-05-09T23:48:22.835Z,1652140102.835 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2022-05-09T23:48:22.853Z,1652140102.853 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2022-05-09T23:48:22.854Z,1652140102.854 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2022-05-09T23:48:22.854Z,1652140102.854 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 6590 2022-05-09T23:48:22.859Z,1652140102.859 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2022-05-09T23:48:22.860Z,1652140102.860 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2022-05-09T23:48:22.860Z,1652140102.860 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 6591 2022-05-09T23:48:22.862Z,1652140102.862 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2022-05-09T23:48:22.863Z,1652140102.863 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2022-05-09T23:48:22.863Z,1652140102.863 [logger ThreadHandler](INFO): Protected caller Thread ID is 6592 2022-05-09T23:48:22.867Z,1652140102.867 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2022-05-09T23:48:22.867Z,1652140102.867 [Supervisor](INFO): Looking for Config files in directory: Config/ 2022-05-09T23:48:22.869Z,1652140102.869 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2022-05-09T23:48:22.962Z,1652140102.962 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2022-05-09T23:48:22.963Z,1652140102.963 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2022-05-09T23:48:23.176Z,1652140103.176 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2022-05-09T23:48:23.177Z,1652140103.177 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2022-05-09T23:48:23.436Z,1652140103.436 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2022-05-09T23:48:23.437Z,1652140103.437 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2022-05-09T23:48:23.542Z,1652140103.542 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2022-05-09T23:48:23.542Z,1652140103.542 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2022-05-09T23:48:24.190Z,1652140104.190 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2022-05-09T23:48:24.191Z,1652140104.191 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2022-05-09T23:48:24.718Z,1652140104.718 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2022-05-09T23:48:24.719Z,1652140104.719 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2022-05-09T23:48:25.288Z,1652140105.288 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2022-05-09T23:48:25.289Z,1652140105.289 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2022-05-09T23:48:25.668Z,1652140105.668 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2022-05-09T23:48:25.668Z,1652140105.668 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2022-05-09T23:48:25.994Z,1652140105.994 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2022-05-09T23:48:25.994Z,1652140105.994 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2022-05-09T23:48:26.364Z,1652140106.364 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2022-05-09T23:48:26.365Z,1652140106.365 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2022-05-09T23:48:26.582Z,1652140106.582 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2022-05-09T23:48:26.583Z,1652140106.583 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2022-05-09T23:48:26.711Z,1652140106.711 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2022-05-09T23:48:26.711Z,1652140106.711 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2022-05-09T23:48:26.791Z,1652140106.791 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2022-05-09T23:48:26.868Z,1652140106.868 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2022-05-09T23:48:27.053Z,1652140107.053 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2022-05-09T23:48:27.053Z,1652140107.053 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2022-05-09T23:48:27.269Z,1652140107.269 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2022-05-09T23:48:27.271Z,1652140107.271 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/ 2022-05-09T23:48:27.272Z,1652140107.272 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg 2022-05-09T23:48:27.353Z,1652140107.353 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg 2022-05-09T23:48:27.658Z,1652140107.658 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2022-05-09T23:48:27.659Z,1652140107.659 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg 2022-05-09T23:48:27.908Z,1652140107.908 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg 2022-05-09T23:48:28.206Z,1652140108.206 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg 2022-05-09T23:48:28.429Z,1652140108.429 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg 2022-05-09T23:48:28.661Z,1652140108.661 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg 2022-05-09T23:48:28.768Z,1652140108.768 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg 2022-05-09T23:48:28.872Z,1652140108.872 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg 2022-05-09T23:48:29.031Z,1652140109.031 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg 2022-05-09T23:48:29.133Z,1652140109.133 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg 2022-05-09T23:48:29.231Z,1652140109.231 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/ 2022-05-09T23:48:29.231Z,1652140109.231 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2022-05-09T23:48:29.246Z,1652140109.246 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2022-05-09T23:48:29.356Z,1652140109.356 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2022-05-09T23:48:29.357Z,1652140109.357 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2022-05-09T23:48:29.484Z,1652140109.484 [BuoyancyServo] Loaded 2022-05-09T23:48:29.484Z,1652140109.484 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2022-05-09T23:48:29.504Z,1652140109.504 [ElevatorServo] Loaded 2022-05-09T23:48:29.505Z,1652140109.505 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2022-05-09T23:48:29.524Z,1652140109.524 [MassServo] Loaded 2022-05-09T23:48:29.524Z,1652140109.524 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2022-05-09T23:48:29.544Z,1652140109.544 [RudderServo] Loaded 2022-05-09T23:48:29.544Z,1652140109.544 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2022-05-09T23:48:29.560Z,1652140109.560 [ThrusterHE] Loaded 2022-05-09T23:48:29.560Z,1652140109.560 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2022-05-09T23:48:29.560Z,1652140109.560 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2022-05-09T23:48:29.561Z,1652140109.561 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2022-05-09T23:48:29.704Z,1652140109.704 [SBIT](DEBUG): Construct Startup Built In Test. 2022-05-09T23:48:29.718Z,1652140109.718 [SBIT] Loaded 2022-05-09T23:48:29.718Z,1652140109.718 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2022-05-09T23:48:29.721Z,1652140109.721 [IBIT](DEBUG): Construct Initiated Built In Test. 2022-05-09T23:48:29.741Z,1652140109.741 [IBIT] Loaded 2022-05-09T23:48:29.741Z,1652140109.741 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2022-05-09T23:48:29.747Z,1652140109.747 [CBIT](DEBUG): Construct Continuous Built In Test. 2022-05-09T23:48:29.960Z,1652140109.960 [CBIT] Loaded 2022-05-09T23:48:29.960Z,1652140109.960 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2022-05-09T23:48:29.961Z,1652140109.961 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2022-05-09T23:48:29.961Z,1652140109.961 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2022-05-09T23:48:30.103Z,1652140110.103 [ESPComponent] Loaded 2022-05-09T23:48:30.103Z,1652140110.103 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2022-05-09T23:48:30.122Z,1652140110.122 [PAR_Licor] Loaded 2022-05-09T23:48:30.123Z,1652140110.123 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2022-05-09T23:48:30.154Z,1652140110.154 [WetLabsBB2FL] Loaded 2022-05-09T23:48:30.154Z,1652140110.154 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2022-05-09T23:48:30.155Z,1652140110.155 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406614E0 2022-05-09T23:48:30.155Z,1652140110.155 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 6675 2022-05-09T23:48:30.156Z,1652140110.156 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2022-05-09T23:48:30.157Z,1652140110.157 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2022-05-09T23:48:30.207Z,1652140110.207 [DepthRateCalculator] Loaded 2022-05-09T23:48:30.207Z,1652140110.207 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2022-05-09T23:48:30.212Z,1652140110.212 [PitchRateCalculator] Loaded 2022-05-09T23:48:30.212Z,1652140110.212 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2022-05-09T23:48:30.222Z,1652140110.222 [SpeedCalculator] Loaded 2022-05-09T23:48:30.223Z,1652140110.223 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2022-05-09T23:48:30.227Z,1652140110.227 [YawRateCalculator] Loaded 2022-05-09T23:48:30.227Z,1652140110.227 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2022-05-09T23:48:30.246Z,1652140110.246 [ElevatorOffsetCalculator] Loaded 2022-05-09T23:48:30.246Z,1652140110.246 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2022-05-09T23:48:30.262Z,1652140110.262 [ShortestDistanceToPolygonSidesCalculator] Loaded 2022-05-09T23:48:30.262Z,1652140110.262 [ComponentRegistry](DEBUG): SyncComponent "ShortestDistanceToPolygonSidesCalculator" handled in the control thread. 2022-05-09T23:48:30.263Z,1652140110.263 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2022-05-09T23:48:30.263Z,1652140110.263 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2022-05-09T23:48:30.362Z,1652140110.362 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2022-05-09T23:48:30.362Z,1652140110.362 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2022-05-09T23:48:30.389Z,1652140110.389 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2022-05-09T23:48:30.389Z,1652140110.389 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2022-05-09T23:48:30.500Z,1652140110.500 [DeadReckonUsingMultipleVelocitySources] Loaded 2022-05-09T23:48:30.500Z,1652140110.500 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2022-05-09T23:48:30.513Z,1652140110.513 [NavChart] Loaded 2022-05-09T23:48:30.513Z,1652140110.513 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2022-05-09T23:48:30.519Z,1652140110.519 [UniversalFixResidualReporter] Loaded 2022-05-09T23:48:30.519Z,1652140110.519 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2022-05-09T23:48:30.520Z,1652140110.520 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2022-05-09T23:48:30.520Z,1652140110.520 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2022-05-09T23:48:30.920Z,1652140110.920 [AHRS_M2] Loaded 2022-05-09T23:48:30.920Z,1652140110.920 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2022-05-09T23:48:31.169Z,1652140111.169 [BackseatComponent] Loaded 2022-05-09T23:48:31.169Z,1652140111.169 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2022-05-09T23:48:31.170Z,1652140111.170 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409DD4E0 2022-05-09T23:48:31.170Z,1652140111.170 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 6676 2022-05-09T23:48:31.173Z,1652140111.173 [LcmUniversalReporter] Loaded 2022-05-09T23:48:31.173Z,1652140111.173 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2022-05-09T23:48:31.244Z,1652140111.244 [DataOverHttps] Loaded 2022-05-09T23:48:31.244Z,1652140111.244 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2022-05-09T23:48:31.245Z,1652140111.245 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40A0D4E0 2022-05-09T23:48:31.246Z,1652140111.246 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 6677 2022-05-09T23:48:31.266Z,1652140111.266 [Depth_Keller] Loaded 2022-05-09T23:48:31.266Z,1652140111.266 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2022-05-09T23:48:31.303Z,1652140111.303 [DVL_micro] Loaded 2022-05-09T23:48:31.303Z,1652140111.303 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread. 2022-05-09T23:48:31.360Z,1652140111.360 [NAL9602] Loaded 2022-05-09T23:48:31.360Z,1652140111.360 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2022-05-09T23:48:31.386Z,1652140111.386 [Onboard] Loaded 2022-05-09T23:48:31.386Z,1652140111.386 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2022-05-09T23:48:31.387Z,1652140111.387 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A3D4E0 2022-05-09T23:48:31.388Z,1652140111.388 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 6678 2022-05-09T23:48:31.399Z,1652140111.399 [Power24vConverter] Loaded 2022-05-09T23:48:31.400Z,1652140111.400 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2022-05-09T23:48:31.412Z,1652140111.412 [Radio_Surface] Loaded 2022-05-09T23:48:31.413Z,1652140111.413 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2022-05-09T23:48:31.414Z,1652140111.414 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A6D4E0 2022-05-09T23:48:31.414Z,1652140111.414 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 6679 2022-05-09T23:48:31.415Z,1652140111.415 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2022-05-09T23:48:31.415Z,1652140111.415 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2022-05-09T23:48:31.474Z,1652140111.474 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2022-05-09T23:48:31.475Z,1652140111.475 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2022-05-09T23:48:31.526Z,1652140111.526 [VerticalControl](DEBUG): Construct VerticalControl. 2022-05-09T23:48:31.576Z,1652140111.576 [VerticalControl] Loaded 2022-05-09T23:48:31.577Z,1652140111.577 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2022-05-09T23:48:31.579Z,1652140111.579 [HorizontalControl](DEBUG): Construct HorizontalControl. 2022-05-09T23:48:31.614Z,1652140111.614 [HorizontalControl] Loaded 2022-05-09T23:48:31.614Z,1652140111.614 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2022-05-09T23:48:31.617Z,1652140111.617 [SpeedControl](DEBUG): Construct SpeedControl. 2022-05-09T23:48:31.619Z,1652140111.619 [SpeedControl] Loaded 2022-05-09T23:48:31.619Z,1652140111.619 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2022-05-09T23:48:31.622Z,1652140111.622 [LoopControl](DEBUG): Construct LoopControl. 2022-05-09T23:48:31.622Z,1652140111.622 [LoopControl] Loaded 2022-05-09T23:48:31.622Z,1652140111.622 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2022-05-09T23:48:31.623Z,1652140111.623 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2022-05-09T23:48:31.623Z,1652140111.623 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2022-05-09T23:48:31.634Z,1652140111.634 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2022-05-09T23:48:31.634Z,1652140111.634 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2022-05-09T23:48:31.945Z,1652140111.945 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2022-05-09T23:48:31.951Z,1652140111.951 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2022-05-09T23:48:31.953Z,1652140111.953 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2022-05-09T23:48:31.964Z,1652140111.964 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2022-05-09T23:48:31.965Z,1652140111.965 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B774E0 2022-05-09T23:48:31.966Z,1652140111.966 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 6680 2022-05-09T23:48:31.970Z,1652140111.970 [Supervisor](INFO): Main Thread ID is 6587 2022-05-09T23:48:31.970Z,1652140111.970 [Supervisor](DEBUG): Running supervisor. 2022-05-09T23:48:31.971Z,1652140111.971 [CommandExec ThreadHandler](INFO): Handler Thread ID is 6681 2022-05-09T23:48:31.971Z,1652140111.971 [CommandExec](INFO): Initializing the command executive. 2022-05-09T23:48:31.973Z,1652140111.973 [CommandLine ThreadHandler](INFO): Handler Thread ID is 6682 2022-05-09T23:48:31.975Z,1652140111.975 [controlThread ThreadHandler](INFO): Handler Thread ID is 6683 2022-05-09T23:48:31.975Z,1652140111.975 [controlThread](DEBUG): Initializing ControlThread 2022-05-09T23:48:31.977Z,1652140111.977 [SBIT](INFO): Initialize SBIT Component. 2022-05-09T23:48:31.978Z,1652140111.978 [SBIT](IMPORTANT): git: 2022-04-25-37-g2a944135f 2022-05-09T23:48:31.978Z,1652140111.978 [SBIT](INFO): git hash: 2a944135f4713de004d013a6b17eee164aec7a5a 2022-05-09T23:48:31.978Z,1652140111.978 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2022-05-09T23:48:31.979Z,1652140111.979 [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 2022-05-09T23:48:31.981Z,1652140111.981 [SBIT](INFO): Beginning SBIT in 20.000000 seconds. 2022-05-09T23:48:31.981Z,1652140111.981 [IBIT](INFO): Initialize IBIT Component. 2022-05-09T23:48:31.982Z,1652140111.982 [CBIT](DEBUG): Initialize CBIT Component. 2022-05-09T23:48:31.983Z,1652140111.983 [logger ThreadHandler](INFO): Handler Thread ID is 6684 2022-05-09T23:48:31.996Z,1652140111.996 [CBIT](DEBUG): Initialized mux pins. 2022-05-09T23:48:31.996Z,1652140111.996 [CBIT](DEBUG): Initializing the watchdog timer. 2022-05-09T23:48:32.008Z,1652140112.008 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 6685 2022-05-09T23:48:32.013Z,1652140112.013 [WetLabsBB2FL](INFO): Powering up 2022-05-09T23:48:32.014Z,1652140112.014 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 6687 2022-05-09T23:48:32.020Z,1652140112.020 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2022-05-09T23:48:32.020Z,1652140112.020 [CBIT](DEBUG): Initializing heartbeat. 2022-05-09T23:48:32.021Z,1652140112.021 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 6688 2022-05-09T23:48:32.022Z,1652140112.022 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2022-05-09T23:48:32.028Z,1652140112.028 [Onboard ThreadHandler](INFO): Handler Thread ID is 6689 2022-05-09T23:48:32.046Z,1652140112.046 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 6690 2022-05-09T23:48:32.073Z,1652140112.073 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 6691 2022-05-09T23:48:32.075Z,1652140112.075 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2022-05-09T23:48:32.075Z,1652140112.075 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2022-05-09T23:48:32.076Z,1652140112.076 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2022-05-09T23:48:32.076Z,1652140112.076 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2022-05-09T23:48:32.076Z,1652140112.076 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2022-05-09T23:48:32.076Z,1652140112.076 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2022-05-09T23:48:32.076Z,1652140112.076 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2022-05-09T23:48:32.077Z,1652140112.077 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2022-05-09T23:48:32.077Z,1652140112.077 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA69M.000 2022-05-09T23:48:32.077Z,1652140112.077 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA69M.000 2022-05-09T23:48:32.092Z,1652140112.092 [CBIT](DEBUG): Deactivating GF circuits. 2022-05-09T23:48:32.092Z,1652140112.092 [CBIT](DEBUG): Deactivating emergency mode. 2022-05-09T23:48:32.128Z,1652140112.128 [CBIT](DEBUG): Backplane powered. 2022-05-09T23:48:32.132Z,1652140112.132 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2022-05-09T23:48:32.133Z,1652140112.133 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2022-05-09T23:48:32.133Z,1652140112.133 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2022-05-09T23:48:32.133Z,1652140112.133 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2022-05-09T23:48:32.134Z,1652140112.134 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2022-05-09T23:48:32.134Z,1652140112.134 [ShortestDistanceToPolygonSidesCalculator](DEBUG): Initializing. 2022-05-09T23:48:32.136Z,1652140112.136 [NavChart](DEBUG): Initialize NavChart Navigation. 2022-05-09T23:48:32.136Z,1652140112.136 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2022-05-09T23:48:32.145Z,1652140112.145 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2022-05-09T23:48:32.147Z,1652140112.147 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2022-05-09T23:48:32.147Z,1652140112.147 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2022-05-09T23:48:32.148Z,1652140112.148 [LoopControl](DEBUG): Initialize LoopControlComponent. 2022-05-09T23:48:32.149Z,1652140112.149 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml 2022-05-09T23:48:32.185Z,1652140112.185 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2022-05-09T23:48:32.221Z,1652140112.221 [MissionManager](DEBUG): 2022-05-09T23:48:32.222Z,1652140112.222 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml 2022-05-09T23:48:32.301Z,1652140112.301 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2022-05-09T23:48:32.302Z,1652140112.302 [Default:A.Wait](DEBUG): Construct Wait. 2022-05-09T23:48:32.305Z,1652140112.305 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2022-05-09T23:48:32.358Z,1652140112.358 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2022-05-09T23:48:32.373Z,1652140112.373 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2022-05-09T23:48:32.379Z,1652140112.379 [Default:E.Execute](DEBUG): Construct Execute. 2022-05-09T23:48:32.397Z,1652140112.397 [MissionManager](DEBUG): 0 Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2022-05-09T23:48:32.416Z,1652140112.416 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,Depth_Keller,DVL_micro,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,ShortestDistanceToPolygonSidesCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2022-05-09T23:48:32.452Z,1652140112.452 [Radio_Surface](INFO): Powering up 2022-05-09T23:48:32.454Z,1652140112.454 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2022-05-09T23:48:32.574Z,1652140112.574 [Power24vConverter](INFO): Powering up. 2022-05-09T23:48:32.612Z,1652140112.612 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2022-05-09T23:48:32.620Z,1652140112.620 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2022-05-09T23:48:32.622Z,1652140112.622 [ElevatorServo](DEBUG): Initializing EZServoServo. 2022-05-09T23:48:32.628Z,1652140112.628 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2022-05-09T23:48:32.629Z,1652140112.629 [MassServo](DEBUG): Initializing EZServoServo. 2022-05-09T23:48:32.636Z,1652140112.636 [MassServo](DEBUG): Initializing MassServo. 2022-05-09T23:48:32.637Z,1652140112.637 [RudderServo](DEBUG): Initializing EZServoServo. 2022-05-09T23:48:32.644Z,1652140112.644 [RudderServo](DEBUG): Initializing RudderServo. 2022-05-09T23:48:32.645Z,1652140112.645 [ThrusterHE](DEBUG): Initializing EZServoServo. 2022-05-09T23:48:32.652Z,1652140112.652 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2022-05-09T23:48:33.564Z,1652140113.564 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2022-05-09T23:48:33.564Z,1652140113.564 [RudderServo](FAULT): Rudder failed to initialize 2022-05-09T23:48:33.564Z,1652140113.564 [RudderServo] Communications Fault, FailCount= 1 2022-05-09T23:48:33.564Z,1652140113.564 [RudderServo](ERROR): Communications Fault 2022-05-09T23:48:33.568Z,1652140113.568 [CBIT](ERROR): Communications Fault in component: RudderServo 2022-05-09T23:48:33.769Z,1652140113.769 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2022-05-09T23:48:33.769Z,1652140113.769 [RudderServo](INFO): Powering down 2022-05-09T23:48:34.498Z,1652140114.498 [RudderServo](DEBUG): Initializing EZServoServo. 2022-05-09T23:48:34.617Z,1652140114.617 [RudderServo](DEBUG): Initializing RudderServo. 2022-05-09T23:48:34.621Z,1652140114.621 [CBIT](INFO): Clearing failed state for component RudderServo 2022-05-09T23:48:34.621Z,1652140114.621 [RudderServo] No Fault, FailCount= 1 2022-05-09T23:48:35.000Z,1652140116.000 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:36.420Z,1652140116.420 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:36.876Z,1652140116.876 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:37.304Z,1652140117.304 [WetLabsBB2FL] Communications Fault, FailCount= 1 2022-05-09T23:48:37.304Z,1652140117.304 [WetLabsBB2FL](ERROR): Communications Fault 2022-05-09T23:48:37.328Z,1652140117.328 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:37.402Z,1652140117.402 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2022-05-09T23:48:37.740Z,1652140117.740 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:37.804Z,1652140117.804 [WetLabsBB2FL](INFO): Powering down 2022-05-09T23:48:38.209Z,1652140118.209 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:38.353Z,1652140118.353 [ThrusterHE](ERROR): Zero Speed Commanded. 2022-05-09T23:48:38.748Z,1652140118.748 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:39.211Z,1652140119.211 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2022-05-09T23:48:39.211Z,1652140119.211 [WetLabsBB2FL] No Fault, FailCount= 1 2022-05-09T23:48:39.432Z,1652140119.432 [WetLabsBB2FL](INFO): Powering up 2022-05-09T23:48:39.560Z,1652140119.560 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:40.016Z,1652140120.016 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:40.460Z,1652140120.460 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:40.900Z,1652140120.900 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:41.340Z,1652140121.340 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:41.772Z,1652140121.772 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:42.204Z,1652140122.204 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:42.624Z,1652140122.624 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:43.040Z,1652140123.040 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:43.484Z,1652140123.484 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:43.976Z,1652140123.976 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:44.412Z,1652140124.412 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:44.712Z,1652140124.712 [WetLabsBB2FL] Communications Fault, FailCount= 2 2022-05-09T23:48:44.712Z,1652140124.712 [WetLabsBB2FL](ERROR): Communications Fault 2022-05-09T23:48:44.844Z,1652140124.844 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:44.940Z,1652140124.940 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2022-05-09T23:48:45.212Z,1652140125.212 [WetLabsBB2FL](INFO): Powering down 2022-05-09T23:48:45.272Z,1652140125.272 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:45.272Z,1652140125.272 [AHRS_M2](FAULT): Failed to initialize within timeout. 2022-05-09T23:48:45.272Z,1652140125.272 [AHRS_M2] Communications Fault, FailCount= 1 2022-05-09T23:48:45.272Z,1652140125.272 [AHRS_M2](ERROR): Communications Fault 2022-05-09T23:48:45.376Z,1652140125.376 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2022-05-09T23:48:45.385Z,1652140125.385 [AHRS_M2](INFO): Powering down 2022-05-09T23:48:46.170Z,1652140126.170 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004634 2022-05-09T23:48:46.264Z,1652140126.264 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2022-05-09T23:48:46.264Z,1652140126.264 [WetLabsBB2FL] No Fault, FailCount= 2 2022-05-09T23:48:46.264Z,1652140126.264 [CBIT](INFO): Clearing failed state for component AHRS_M2 2022-05-09T23:48:46.264Z,1652140126.264 [AHRS_M2] No Fault, FailCount= 1 2022-05-09T23:48:46.425Z,1652140126.425 [WetLabsBB2FL](INFO): Powering up 2022-05-09T23:48:46.597Z,1652140126.597 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2022-05-09T23:48:50.152Z,1652140130.152 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:50.157Z,1652140130.157 [DVL_micro](FAULT): Failed to initialize within timeout. 2022-05-09T23:48:50.157Z,1652140130.157 [DVL_micro] Communications Fault, FailCount= 1 2022-05-09T23:48:50.157Z,1652140130.157 [DVL_micro](ERROR): Communications Fault 2022-05-09T23:48:50.252Z,1652140130.252 [CBIT](ERROR): Communications Fault in component: DVL_micro 2022-05-09T23:48:50.588Z,1652140130.588 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:50.664Z,1652140130.664 [DVL_micro](INFO): Powering down 2022-05-09T23:48:51.072Z,1652140131.072 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:51.500Z,1652140131.500 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:51.588Z,1652140131.588 [CBIT](INFO): Clearing failed state for component DVL_micro 2022-05-09T23:48:51.588Z,1652140131.588 [DVL_micro] No Fault, FailCount= 1 2022-05-09T23:48:51.725Z,1652140131.725 [WetLabsBB2FL] Communications Fault, FailCount= 3 2022-05-09T23:48:51.725Z,1652140131.725 [WetLabsBB2FL](ERROR): Communications Fault 2022-05-09T23:48:51.936Z,1652140131.936 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:52.044Z,1652140132.044 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2022-05-09T23:48:52.224Z,1652140132.224 [WetLabsBB2FL](INFO): Powering down 2022-05-09T23:48:52.412Z,1652140132.412 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:52.517Z,1652140132.517 [SBIT](IMPORTANT): Beginning Startup BIT 2022-05-09T23:48:52.521Z,1652140132.521 [CBIT](IMPORTANT): Beginning ground fault scan 2022-05-09T23:48:52.844Z,1652140132.844 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:53.368Z,1652140133.368 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:53.492Z,1652140133.492 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2022-05-09T23:48:53.493Z,1652140133.493 [WetLabsBB2FL] No Fault, FailCount= 3 2022-05-09T23:48:53.836Z,1652140133.836 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:53.844Z,1652140133.844 [WetLabsBB2FL](INFO): Powering up 2022-05-09T23:48:54.324Z,1652140134.324 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:54.908Z,1652140134.908 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:55.044Z,1652140135.044 [RudderServo](FAULT): Overload Error 2022-05-09T23:48:55.044Z,1652140135.044 [RudderServo] Hardware Fault, FailCount= 2 2022-05-09T23:48:55.045Z,1652140135.045 [RudderServo](ERROR): Hardware Fault 2022-05-09T23:48:55.077Z,1652140135.077 [CBIT](ERROR): Hardware Fault in component: RudderServo 2022-05-09T23:48:55.452Z,1652140135.452 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:55.537Z,1652140135.537 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2022-05-09T23:48:55.537Z,1652140135.537 [RudderServo](INFO): Powering down 2022-05-09T23:48:55.916Z,1652140135.916 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:56.496Z,1652140136.496 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:56.665Z,1652140136.665 [RudderServo](DEBUG): Initializing EZServoServo. 2022-05-09T23:48:56.785Z,1652140136.785 [RudderServo](DEBUG): Initializing RudderServo. 2022-05-09T23:48:56.794Z,1652140136.794 [CBIT](INFO): Clearing failed state for component RudderServo 2022-05-09T23:48:56.794Z,1652140136.794 [RudderServo] No Fault, FailCount= 2 2022-05-09T23:48:57.140Z,1652140137.140 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:57.640Z,1652140137.640 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:58.080Z,1652140138.080 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:58.496Z,1652140138.496 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:59.008Z,1652140139.008 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:59.136Z,1652140139.136 [WetLabsBB2FL] Communications Fault, FailCount= 4 2022-05-09T23:48:59.137Z,1652140139.137 [WetLabsBB2FL](ERROR): Communications Fault 2022-05-09T23:48:59.428Z,1652140139.428 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:48:59.428Z,1652140139.428 [AHRS_M2](FAULT): Failed to initialize within timeout. 2022-05-09T23:48:59.428Z,1652140139.428 [AHRS_M2] Communications Fault, FailCount= 2 2022-05-09T23:48:59.428Z,1652140139.428 [AHRS_M2](ERROR): Communications Fault 2022-05-09T23:48:59.576Z,1652140139.576 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2022-05-09T23:48:59.577Z,1652140139.577 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2022-05-09T23:48:59.585Z,1652140139.585 [AHRS_M2](INFO): Powering down 2022-05-09T23:48:59.636Z,1652140139.636 [WetLabsBB2FL](INFO): Powering down 2022-05-09T23:49:00.528Z,1652140140.528 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2022-05-09T23:49:00.528Z,1652140140.528 [WetLabsBB2FL] No Fault, FailCount= 4 2022-05-09T23:49:00.529Z,1652140140.529 [CBIT](INFO): Clearing failed state for component AHRS_M2 2022-05-09T23:49:00.529Z,1652140140.529 [AHRS_M2] No Fault, FailCount= 2 2022-05-09T23:49:00.797Z,1652140140.797 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2022-05-09T23:49:00.872Z,1652140140.872 [WetLabsBB2FL](INFO): Powering up 2022-05-09T23:49:01.610Z,1652140141.610 [NAL9602](INFO): Powering up NAL9602 2022-05-09T23:49:01.680Z,1652140141.680 [RudderServo](FAULT): Overload Error 2022-05-09T23:49:01.680Z,1652140141.680 [RudderServo] Hardware Fault, FailCount= 3 2022-05-09T23:49:01.680Z,1652140141.680 [RudderServo](ERROR): Hardware Fault 2022-05-09T23:49:01.709Z,1652140141.709 [CBIT](ERROR): Hardware Fault in component: RudderServo 2022-05-09T23:49:01.709Z,1652140141.709 [CBIT](CRITICAL): Hardware Fault in component: RudderServo 2022-05-09T23:49:02.081Z,1652140142.081 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2022-05-09T23:49:02.082Z,1652140142.082 [RudderServo](INFO): Powering down 2022-05-09T23:49:02.086Z,1652140142.086 [CommandExec](FAULT): Scheduling is paused 2022-05-09T23:49:02.086Z,1652140142.086 [CBIT](INFO): Critical error at 20220509T234901 2022-05-09T23:49:02.086Z,1652140142.086 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2022-05-09T23:49:02.319Z,1652140142.319 [CommandExec](IMPORTANT): got command maintain control VerticalControl.massPositionAction 40 millimeter 2022-05-09T23:49:02.323Z,1652140142.323 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.massPositionAction" handled in the control thread. 2022-05-09T23:49:02.491Z,1652140142.491 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,Depth_Keller,DVL_micro,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,ShortestDistanceToPolygonSidesCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.massPositionAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2022-05-09T23:49:02.885Z,1652140142.885 [RudderServo](DEBUG): Initializing EZServoServo. 2022-05-09T23:49:03.005Z,1652140143.005 [RudderServo](DEBUG): Initializing RudderServo. 2022-05-09T23:49:04.352Z,1652140144.352 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:04.900Z,1652140144.900 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:04.994Z,1652140144.994 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.015756 CHAN A1 (24V): 0.000407 CHAN A2 (12V): -0.005258 CHAN A3 (5V): -0.002472 CHAN B0 (3.3V): -0.001463 CHAN B1 (3.15aV): -0.001073 CHAN B2 (3.15bV): -0.000944 CHAN B3 (GND): -0.000054 OPEN: -0.000992 Full Scale: +/- 1 mA 2022-05-09T23:49:05.348Z,1652140145.348 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:05.784Z,1652140145.784 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:05.874Z,1652140145.874 [SBIT](ERROR): Could not read rudderAngleReader_. 2022-05-09T23:49:06.144Z,1652140146.144 [WetLabsBB2FL] Communications Fault, FailCount= 5 2022-05-09T23:49:06.144Z,1652140146.144 [WetLabsBB2FL](ERROR): Communications Fault 2022-05-09T23:49:06.208Z,1652140146.208 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:06.305Z,1652140146.305 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2022-05-09T23:49:06.306Z,1652140146.306 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL 2022-05-09T23:49:06.644Z,1652140146.644 [WetLabsBB2FL](INFO): Powering down 2022-05-09T23:49:06.645Z,1652140146.645 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:07.080Z,1652140147.080 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:07.492Z,1652140147.492 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:07.924Z,1652140147.924 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:08.388Z,1652140148.388 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:08.856Z,1652140148.856 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:09.308Z,1652140149.308 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:09.313Z,1652140149.313 [DVL_micro](FAULT): Failed to initialize within timeout. 2022-05-09T23:49:09.313Z,1652140149.313 [DVL_micro] Communications Fault, FailCount= 2 2022-05-09T23:49:09.313Z,1652140149.313 [DVL_micro](ERROR): Communications Fault 2022-05-09T23:49:09.437Z,1652140149.437 [CBIT](ERROR): Communications Fault in component: DVL_micro 2022-05-09T23:49:09.792Z,1652140149.792 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:09.868Z,1652140149.868 [DVL_micro](INFO): Powering down 2022-05-09T23:49:10.308Z,1652140150.308 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:10.752Z,1652140150.752 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:10.866Z,1652140150.866 [CBIT](INFO): Clearing failed state for component DVL_micro 2022-05-09T23:49:10.866Z,1652140150.866 [DVL_micro] No Fault, FailCount= 2 2022-05-09T23:49:11.200Z,1652140151.200 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:11.648Z,1652140151.648 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:12.069Z,1652140152.069 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:12.520Z,1652140152.520 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:12.536Z,1652140152.536 [NAL9602](INFO): NAL9602 initialized 2022-05-09T23:49:12.940Z,1652140152.940 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:13.360Z,1652140153.360 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:13.884Z,1652140153.884 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:13.884Z,1652140153.884 [AHRS_M2](FAULT): Failed to initialize within timeout. 2022-05-09T23:49:13.884Z,1652140153.884 [AHRS_M2] Communications Fault, FailCount= 3 2022-05-09T23:49:13.884Z,1652140153.884 [AHRS_M2](ERROR): Communications Fault 2022-05-09T23:49:13.953Z,1652140153.953 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2022-05-09T23:49:13.989Z,1652140153.989 [AHRS_M2](INFO): Powering down 2022-05-09T23:49:14.839Z,1652140154.839 [CBIT](INFO): Clearing failed state for component AHRS_M2 2022-05-09T23:49:14.839Z,1652140154.839 [AHRS_M2] No Fault, FailCount= 3 2022-05-09T23:49:15.185Z,1652140155.185 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2022-05-09T23:49:18.744Z,1652140158.744 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:19.168Z,1652140159.168 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:19.580Z,1652140159.580 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:19.996Z,1652140159.996 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:20.420Z,1652140160.420 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:20.844Z,1652140160.844 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:21.288Z,1652140161.288 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:21.716Z,1652140161.716 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:22.124Z,1652140162.124 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:22.548Z,1652140162.548 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:22.960Z,1652140162.960 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:23.384Z,1652140163.384 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:23.804Z,1652140163.804 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:24.216Z,1652140164.216 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:24.624Z,1652140164.624 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:25.028Z,1652140165.028 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:25.448Z,1652140165.448 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:25.880Z,1652140165.880 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:26.316Z,1652140166.316 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:26.756Z,1652140166.756 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:27.168Z,1652140167.168 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:27.592Z,1652140167.592 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:28.008Z,1652140168.008 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:28.424Z,1652140168.424 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:28.424Z,1652140168.424 [AHRS_M2](FAULT): Failed to initialize within timeout. 2022-05-09T23:49:28.424Z,1652140168.424 [AHRS_M2] Communications Fault, FailCount= 4 2022-05-09T23:49:28.424Z,1652140168.424 [AHRS_M2](ERROR): Communications Fault 2022-05-09T23:49:28.478Z,1652140168.478 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2022-05-09T23:49:28.521Z,1652140168.521 [AHRS_M2](INFO): Powering down 2022-05-09T23:49:28.898Z,1652140168.898 [DVL_micro](FAULT): Failed to initialize within timeout. 2022-05-09T23:49:28.898Z,1652140168.898 [DVL_micro] Communications Fault, FailCount= 3 2022-05-09T23:49:28.898Z,1652140168.898 [DVL_micro](ERROR): Communications Fault 2022-05-09T23:49:28.957Z,1652140168.957 [CBIT](ERROR): Communications Fault in component: DVL_micro 2022-05-09T23:49:28.957Z,1652140168.957 [CBIT](CRITICAL): Communications Fault in component: DVL_micro 2022-05-09T23:49:29.376Z,1652140169.376 [DVL_micro](INFO): Powering down 2022-05-09T23:49:29.427Z,1652140169.427 [CBIT](INFO): Critical error at 20220509T234928 2022-05-09T23:49:29.429Z,1652140169.429 [CBIT](INFO): Clearing failed state for component AHRS_M2 2022-05-09T23:49:29.429Z,1652140169.429 [AHRS_M2] No Fault, FailCount= 4 2022-05-09T23:49:29.701Z,1652140169.701 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2022-05-09T23:49:32.570Z,1652140172.570 [SBIT](ERROR): Could not read rudderAngleReader_. 2022-05-09T23:49:32.570Z,1652140172.570 [SBIT](FAULT): Control surface position failure. 2022-05-09T23:49:33.264Z,1652140173.264 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:33.684Z,1652140173.684 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:34.104Z,1652140174.104 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:34.512Z,1652140174.512 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:34.948Z,1652140174.948 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:35.404Z,1652140175.404 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:35.832Z,1652140175.832 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:36.292Z,1652140176.292 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:36.752Z,1652140176.752 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:37.188Z,1652140177.188 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:37.612Z,1652140177.612 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:38.056Z,1652140178.056 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:38.488Z,1652140178.488 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:39.004Z,1652140179.004 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:39.416Z,1652140179.416 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:39.836Z,1652140179.836 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:40.248Z,1652140180.248 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:40.660Z,1652140180.660 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:41.100Z,1652140181.100 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:41.520Z,1652140181.520 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:41.964Z,1652140181.964 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:42.408Z,1652140182.408 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:42.816Z,1652140182.816 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:49:42.816Z,1652140182.816 [AHRS_M2](FAULT): Failed to initialize within timeout. 2022-05-09T23:49:42.816Z,1652140182.816 [AHRS_M2] Communications Fault, FailCount= 5 2022-05-09T23:49:42.816Z,1652140182.816 [AHRS_M2](ERROR): Communications Fault 2022-05-09T23:49:42.893Z,1652140182.893 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2022-05-09T23:49:42.893Z,1652140182.893 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2 2022-05-09T23:49:42.907Z,1652140182.907 [AHRS_M2](INFO): Powering down 2022-05-09T23:49:43.027Z,1652140183.027 [CBIT](INFO): Critical error at 20220509T234942 2022-05-09T23:49:46.606Z,1652140186.606 [SBIT](ERROR): Could not read rudderAngleReader_. 2022-05-09T23:49:46.606Z,1652140186.606 [SBIT](FAULT): Control surface position failure. 2022-05-09T23:49:47.098Z,1652140187.098 [SBIT](CRITICAL): SBIT FAILED 2022-05-09T23:49:47.100Z,1652140187.100 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2022-05-09T23:49:47.101Z,1652140187.101 [SBIT](IMPORTANT): BPC1.loadAtStartup=0 bool; 2022-05-09T23:49:47.101Z,1652140187.101 [SBIT](IMPORTANT): CBIT.vehicleOpen=1 bool; 2022-05-09T23:49:47.101Z,1652140187.101 [SBIT](IMPORTANT): CTD_Seabird.loadAtStartup=0 bool; 2022-05-09T23:49:47.101Z,1652140187.101 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool; 2022-05-09T23:49:47.101Z,1652140187.101 [SBIT](IMPORTANT): Express linearApproximation CBIT.ampHoursUsed 1.000000 ampere_hour; 2022-05-09T23:49:47.101Z,1652140187.101 [SBIT](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.latVertex1=34.4368 degree; 2022-05-09T23:49:47.101Z,1652140187.101 [SBIT](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.latVertex2=34.267 degree; 2022-05-09T23:49:47.102Z,1652140187.102 [SBIT](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.latVertex3=34.107 degree; 2022-05-09T23:49:47.102Z,1652140187.102 [SBIT](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.latVertex4=34.37 degree; 2022-05-09T23:49:47.102Z,1652140187.102 [SBIT](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.loadAtStartup=1 bool; 2022-05-09T23:49:47.102Z,1652140187.102 [SBIT](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.lonVertex1=-120.476 degree; 2022-05-09T23:49:47.102Z,1652140187.102 [SBIT](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.lonVertex2=-119.333 degree; 2022-05-09T23:49:47.102Z,1652140187.102 [SBIT](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.lonVertex3=-119.33 degree; 2022-05-09T23:49:47.102Z,1652140187.102 [SBIT](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.lonVertex4=-120.5 degree; 2022-05-09T23:49:47.102Z,1652140187.102 [SBIT](IMPORTANT): VerticalControl.massDefault=0 centimeter; 2022-05-09T23:49:47.124Z,1652140187.124 [CBIT](INFO): Critical error at 20220509T234947 2022-05-09T23:49:47.365Z,1652140187.365 [MissionManager](IMPORTANT): Started mission Startup 2022-05-09T23:49:47.365Z,1652140187.365 [Startup] Running Loop=1 2022-05-09T23:49:47.365Z,1652140187.365 [Startup](DEBUG): Aggregate::initialize Startup 2022-05-09T23:49:47.365Z,1652140187.365 [Startup:A.GoToSurface] Running Loop=1 2022-05-09T23:49:47.365Z,1652140187.365 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2022-05-09T23:49:47.366Z,1652140187.366 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2022-05-09T23:49:47.366Z,1652140187.366 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2022-05-09T23:49:47.366Z,1652140187.366 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2022-05-09T23:49:47.367Z,1652140187.367 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2022-05-09T23:49:47.367Z,1652140187.367 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2022-05-09T23:49:47.389Z,1652140187.389 [Startup:StartupSatComms] Running Loop=1 2022-05-09T23:49:47.389Z,1652140187.389 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2022-05-09T23:49:47.389Z,1652140187.389 [Startup:StartupSatComms:A] Running Loop=1 2022-05-09T23:49:47.760Z,1652140187.760 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2022-05-09T23:50:02.397Z,1652140202.397 [CommandExec](IMPORTANT): got command maintain control VerticalControl.massPositionAction -38 millimeter 2022-05-09T23:50:32.195Z,1652140232.195 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2022-05-09T23:50:32.196Z,1652140232.196 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2022-05-09T23:50:32.196Z,1652140232.196 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2022-05-09T23:50:32.240Z,1652140232.240 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2022-05-09T23:50:32.636Z,1652140232.636 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2022-05-09T23:50:32.636Z,1652140232.636 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2022-05-09T23:50:47.610Z,1652140247.610 [Startup:StartupSatComms:A](INFO): Timed out from 2022-05-09T23:49:47.4Z 2022-05-09T23:50:47.610Z,1652140247.610 [Startup:StartupSatComms:A] Stopped 2022-05-09T23:50:47.610Z,1652140247.610 [Startup:StartupSatComms:B] Running Loop=1 2022-05-09T23:50:48.017Z,1652140248.017 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2022-05-09T23:50:54.968Z,1652140254.968 [DataOverHttps](INFO): Sending 108 bytes from file Logs/20220506T220606/Courier0010.lzma 2022-05-09T23:50:55.970Z,1652140255.970 [DataOverHttps](INFO): Moved sent file to Logs/20220506T220606/Courier0010.lzma.bak 2022-05-09T23:50:55.970Z,1652140255.970 [DataOverHttps](INFO): SBD MOMSN=16729732 2022-05-09T23:51:11.388Z,1652140271.388 [DataOverHttps](INFO): Sending 270 bytes from file Logs/20220509T234822/Courier0000.lzma 2022-05-09T23:51:12.427Z,1652140272.427 [DataOverHttps](INFO): Moved sent file to Logs/20220509T234822/Courier0000.lzma.bak 2022-05-09T23:51:12.428Z,1652140272.428 [DataOverHttps](INFO): SBD MOMSN=16729736 2022-05-09T23:51:27.696Z,1652140287.696 [DataOverHttps](INFO): Sending 473 bytes from file Logs/20220506T220606/Express0011.lzma 2022-05-09T23:51:28.698Z,1652140288.698 [DataOverHttps](INFO): Moved sent file to Logs/20220506T220606/Express0011.lzma.bak 2022-05-09T23:51:28.698Z,1652140288.698 [DataOverHttps](INFO): SBD MOMSN=16729743 2022-05-09T23:51:36.164Z,1652140296.164 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2022-05-09T23:51:36.164Z,1652140296.164 [WetLabsBB2FL] No Fault, FailCount= 5 2022-05-09T23:51:36.202Z,1652140296.202 [WetLabsBB2FL](INFO): Powering up 2022-05-09T23:51:41.496Z,1652140301.496 [WetLabsBB2FL] Communications Fault, FailCount= 1 2022-05-09T23:51:41.496Z,1652140301.496 [WetLabsBB2FL](ERROR): Communications Fault 2022-05-09T23:51:41.829Z,1652140301.829 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2022-05-09T23:51:41.996Z,1652140301.996 [WetLabsBB2FL](INFO): Powering down 2022-05-09T23:51:43.032Z,1652140303.032 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2022-05-09T23:51:43.032Z,1652140303.032 [WetLabsBB2FL] No Fault, FailCount= 1 2022-05-09T23:51:43.210Z,1652140303.210 [WetLabsBB2FL](INFO): Powering up 2022-05-09T23:51:44.097Z,1652140304.097 [DataOverHttps](INFO): Sending 1251 bytes from file Logs/20220509T234822/Express0001.lzma 2022-05-09T23:51:45.098Z,1652140305.098 [DataOverHttps](INFO): Moved sent file to Logs/20220509T234822/Express0001.lzma.bak 2022-05-09T23:51:45.098Z,1652140305.098 [DataOverHttps](INFO): SBD MOMSN=16729788 2022-05-09T23:51:46.634Z,1652140306.634 [Startup:StartupSatComms:B] Stopped 2022-05-09T23:51:46.634Z,1652140306.634 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2022-05-09T23:51:46.634Z,1652140306.634 [Startup:StartupSatComms] Stopped 2022-05-09T23:51:46.634Z,1652140306.634 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2022-05-09T23:51:46.635Z,1652140306.635 [Startup](INFO): Completed Startup 2022-05-09T23:51:46.635Z,1652140306.635 [MissionManager](INFO): Startup is completed. 2022-05-09T23:51:46.635Z,1652140306.635 [MissionManager](INFO): Uninitializing Mission Startup 2022-05-09T23:51:46.635Z,1652140306.635 [Startup] Stopped 2022-05-09T23:51:46.635Z,1652140306.635 [Startup](DEBUG): Aggregate::uninitialize Startup 2022-05-09T23:51:46.635Z,1652140306.635 [Startup:A.GoToSurface] Stopped 2022-05-09T23:51:46.636Z,1652140306.636 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2022-05-09T23:51:47.041Z,1652140307.041 [MissionManager](IMPORTANT): Started mission Default 2022-05-09T23:51:47.041Z,1652140307.041 [Default] Running Loop=1 2022-05-09T23:51:47.041Z,1652140307.041 [Default](DEBUG): Aggregate::initialize Default 2022-05-09T23:51:47.041Z,1652140307.041 [Default:B.GoToSurface] Running Loop=1 2022-05-09T23:51:47.041Z,1652140307.041 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2022-05-09T23:51:47.042Z,1652140307.042 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2022-05-09T23:51:47.042Z,1652140307.042 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2022-05-09T23:51:47.042Z,1652140307.042 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2022-05-09T23:51:47.042Z,1652140307.042 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2022-05-09T23:51:47.043Z,1652140307.043 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2022-05-09T23:51:47.043Z,1652140307.043 [Default:A.Wait] Running Loop=1 2022-05-09T23:51:47.043Z,1652140307.043 [Default:A.Wait](DEBUG): Initialize Wait Component. 2022-05-09T23:51:48.500Z,1652140308.500 [WetLabsBB2FL] Communications Fault, FailCount= 2 2022-05-09T23:51:48.500Z,1652140308.500 [WetLabsBB2FL](ERROR): Communications Fault 2022-05-09T23:51:48.670Z,1652140308.670 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2022-05-09T23:51:49.000Z,1652140309.000 [WetLabsBB2FL](INFO): Powering down 2022-05-09T23:51:49.874Z,1652140309.874 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2022-05-09T23:51:49.874Z,1652140309.874 [WetLabsBB2FL] No Fault, FailCount= 2 2022-05-09T23:51:50.221Z,1652140310.221 [WetLabsBB2FL](INFO): Powering up 2022-05-09T23:51:55.504Z,1652140315.504 [WetLabsBB2FL] Communications Fault, FailCount= 3 2022-05-09T23:51:55.504Z,1652140315.504 [WetLabsBB2FL](ERROR): Communications Fault 2022-05-09T23:51:55.513Z,1652140315.513 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2022-05-09T23:51:55.978Z,1652140315.978 [CommandExec](IMPORTANT): got command maintain clear 2022-05-09T23:51:56.008Z,1652140316.008 [WetLabsBB2FL](INFO): Powering down 2022-05-09T23:51:56.341Z,1652140316.341 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,Depth_Keller,DVL_micro,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,ShortestDistanceToPolygonSidesCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2022-05-09T23:51:57.151Z,1652140317.151 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2022-05-09T23:51:57.151Z,1652140317.151 [WetLabsBB2FL] No Fault, FailCount= 3 2022-05-09T23:51:57.221Z,1652140317.221 [WetLabsBB2FL](INFO): Powering up 2022-05-09T23:52:00.354Z,1652140320.354 [Default:A.Wait](INFO): Done Waiting. 2022-05-09T23:52:00.354Z,1652140320.354 [Default:A.Wait] Stopped 2022-05-09T23:52:00.354Z,1652140320.354 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2022-05-09T23:52:00.759Z,1652140320.759 [Default:CheckIn] Running Loop=1 2022-05-09T23:52:00.759Z,1652140320.759 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2022-05-09T23:52:00.759Z,1652140320.759 [Default:CheckIn:Read_GPS] Running Loop=1 2022-05-09T23:52:01.160Z,1652140321.160 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2022-05-09T23:52:02.512Z,1652140322.512 [WetLabsBB2FL] Communications Fault, FailCount= 4 2022-05-09T23:52:02.512Z,1652140322.512 [WetLabsBB2FL](ERROR): Communications Fault 2022-05-09T23:52:02.845Z,1652140322.845 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2022-05-09T23:52:03.012Z,1652140323.012 [WetLabsBB2FL](INFO): Powering down 2022-05-09T23:52:04.024Z,1652140324.024 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2022-05-09T23:52:04.024Z,1652140324.024 [WetLabsBB2FL] No Fault, FailCount= 4 2022-05-09T23:52:04.225Z,1652140324.225 [WetLabsBB2FL](INFO): Powering up 2022-05-09T23:52:09.516Z,1652140329.516 [WetLabsBB2FL] Communications Fault, FailCount= 5 2022-05-09T23:52:09.516Z,1652140329.516 [WetLabsBB2FL](ERROR): Communications Fault 2022-05-09T23:52:09.680Z,1652140329.680 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2022-05-09T23:52:09.680Z,1652140329.680 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL 2022-05-09T23:52:10.017Z,1652140330.017 [WetLabsBB2FL](INFO): Powering down 2022-05-09T23:52:29.096Z,1652140349.096 [CBIT](INFO): Clearing failed state for component DVL_micro 2022-05-09T23:52:29.096Z,1652140349.096 [DVL_micro] No Fault, FailCount= 3 2022-05-09T23:52:33.075Z,1652140353.075 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2022-05-09T23:52:33.075Z,1652140353.075 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2022-05-09T23:52:33.075Z,1652140353.075 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2022-05-09T23:52:33.117Z,1652140353.117 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2022-05-09T23:52:33.548Z,1652140353.548 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2022-05-09T23:52:33.548Z,1652140353.548 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2022-05-09T23:52:46.802Z,1652140366.802 [DVL_micro](FAULT): Failed to initialize within timeout. 2022-05-09T23:52:46.802Z,1652140366.802 [DVL_micro] Communications Fault, FailCount= 1 2022-05-09T23:52:46.802Z,1652140366.802 [DVL_micro](ERROR): Communications Fault 2022-05-09T23:52:46.848Z,1652140366.848 [CBIT](ERROR): Communications Fault in component: DVL_micro 2022-05-09T23:52:47.284Z,1652140367.284 [DVL_micro](INFO): Powering down 2022-05-09T23:52:48.034Z,1652140368.034 [CBIT](INFO): Clearing failed state for component DVL_micro 2022-05-09T23:52:48.035Z,1652140368.035 [DVL_micro] No Fault, FailCount= 1 2022-05-09T23:53:05.794Z,1652140385.794 [DVL_micro](FAULT): Failed to initialize within timeout. 2022-05-09T23:53:05.794Z,1652140385.794 [DVL_micro] Communications Fault, FailCount= 2 2022-05-09T23:53:05.794Z,1652140385.794 [DVL_micro](ERROR): Communications Fault 2022-05-09T23:53:05.837Z,1652140385.837 [CBIT](ERROR): Communications Fault in component: DVL_micro 2022-05-09T23:53:06.264Z,1652140386.264 [DVL_micro](INFO): Powering down 2022-05-09T23:53:07.023Z,1652140387.023 [CBIT](INFO): Clearing failed state for component DVL_micro 2022-05-09T23:53:07.023Z,1652140387.023 [DVL_micro] No Fault, FailCount= 2 2022-05-09T23:53:24.782Z,1652140404.782 [DVL_micro](FAULT): Failed to initialize within timeout. 2022-05-09T23:53:24.782Z,1652140404.782 [DVL_micro] Communications Fault, FailCount= 3 2022-05-09T23:53:24.782Z,1652140404.782 [DVL_micro](ERROR): Communications Fault 2022-05-09T23:53:24.799Z,1652140404.799 [CBIT](ERROR): Communications Fault in component: DVL_micro 2022-05-09T23:53:24.799Z,1652140404.799 [CBIT](CRITICAL): Communications Fault in component: DVL_micro 2022-05-09T23:53:25.260Z,1652140405.260 [DVL_micro](INFO): Powering down 2022-05-09T23:53:25.289Z,1652140405.289 [CBIT](INFO): Critical error at 20220509T235324 2022-05-09T23:53:50.248Z,1652140430.248 [CBIT](FAULT): Main Battery Failure. Count: 1 2022-05-09T23:53:54.287Z,1652140434.287 [CBIT](FAULT): Main Battery Failure. Count: 11 2022-05-09T23:53:58.348Z,1652140438.348 [CBIT](FAULT): Main Battery Failure. Count: 21 2022-05-09T23:54:02.367Z,1652140442.367 [CBIT](FAULT): Main Battery Failure. Count: 31 2022-05-09T23:54:15.285Z,1652140455.285 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2022-05-09T23:54:34.288Z,1652140474.288 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2022-05-09T23:54:34.289Z,1652140474.289 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2022-05-09T23:54:34.289Z,1652140474.289 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2022-05-09T23:54:34.319Z,1652140474.319 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2022-05-09T23:54:34.721Z,1652140474.721 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2022-05-09T23:54:34.721Z,1652140474.721 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2022-05-09T23:54:39.565Z,1652140479.565 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2022-05-09T23:54:39.565Z,1652140479.565 [WetLabsBB2FL] No Fault, FailCount= 5 2022-05-09T23:54:39.901Z,1652140479.901 [WetLabsBB2FL](INFO): Powering up 2022-05-09T23:54:43.194Z,1652140483.194 [CBIT](INFO): Clearing failed state for component AHRS_M2 2022-05-09T23:54:43.194Z,1652140483.194 [AHRS_M2] No Fault, FailCount= 5 2022-05-09T23:54:43.566Z,1652140483.566 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2022-05-09T23:54:45.192Z,1652140485.192 [WetLabsBB2FL] Communications Fault, FailCount= 1 2022-05-09T23:54:45.192Z,1652140485.192 [WetLabsBB2FL](ERROR): Communications Fault 2022-05-09T23:54:45.199Z,1652140485.199 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2022-05-09T23:54:45.688Z,1652140485.688 [WetLabsBB2FL](INFO): Powering down 2022-05-09T23:54:47.124Z,1652140487.124 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:54:47.148Z,1652140487.148 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2022-05-09T23:54:47.148Z,1652140487.148 [WetLabsBB2FL] No Fault, FailCount= 1 2022-05-09T23:54:47.305Z,1652140487.305 [WetLabsBB2FL](INFO): Powering up 2022-05-09T23:54:47.540Z,1652140487.540 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:54:47.960Z,1652140487.960 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:54:48.380Z,1652140488.380 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:54:48.820Z,1652140488.820 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:54:49.256Z,1652140489.256 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:54:49.688Z,1652140489.688 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:54:50.104Z,1652140490.104 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:54:50.528Z,1652140490.528 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:54:50.936Z,1652140490.936 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:54:51.356Z,1652140491.356 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:54:51.788Z,1652140491.788 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:54:52.224Z,1652140492.224 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:54:52.596Z,1652140492.596 [WetLabsBB2FL] Communications Fault, FailCount= 2 2022-05-09T23:54:52.596Z,1652140492.596 [WetLabsBB2FL](ERROR): Communications Fault 2022-05-09T23:54:52.692Z,1652140492.692 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:54:52.753Z,1652140492.753 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2022-05-09T23:54:53.096Z,1652140493.096 [WetLabsBB2FL](INFO): Powering down 2022-05-09T23:54:53.120Z,1652140493.120 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:54:53.548Z,1652140493.548 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:54:53.960Z,1652140493.960 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:54:53.995Z,1652140493.995 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2022-05-09T23:54:53.995Z,1652140493.995 [WetLabsBB2FL] No Fault, FailCount= 2 2022-05-09T23:54:54.309Z,1652140494.309 [WetLabsBB2FL](INFO): Powering up 2022-05-09T23:54:54.380Z,1652140494.380 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:54:54.792Z,1652140494.792 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:54:55.220Z,1652140495.220 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:54:55.660Z,1652140495.660 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:54:56.076Z,1652140496.076 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:54:56.492Z,1652140496.492 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:54:56.492Z,1652140496.492 [AHRS_M2](FAULT): Failed to initialize within timeout. 2022-05-09T23:54:56.492Z,1652140496.492 [AHRS_M2] Communications Fault, FailCount= 1 2022-05-09T23:54:56.492Z,1652140496.492 [AHRS_M2](ERROR): Communications Fault 2022-05-09T23:54:56.517Z,1652140496.517 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2022-05-09T23:54:56.581Z,1652140496.581 [AHRS_M2](INFO): Powering down 2022-05-09T23:54:57.383Z,1652140497.383 [CBIT](INFO): Clearing failed state for component AHRS_M2 2022-05-09T23:54:57.383Z,1652140497.383 [AHRS_M2] No Fault, FailCount= 1 2022-05-09T23:54:57.741Z,1652140497.741 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2022-05-09T23:54:59.604Z,1652140499.604 [WetLabsBB2FL] Communications Fault, FailCount= 3 2022-05-09T23:54:59.604Z,1652140499.604 [WetLabsBB2FL](ERROR): Communications Fault 2022-05-09T23:54:59.791Z,1652140499.791 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2022-05-09T23:55:00.104Z,1652140500.104 [WetLabsBB2FL](INFO): Powering down 2022-05-09T23:55:01.296Z,1652140501.296 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:01.336Z,1652140501.336 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2022-05-09T23:55:01.336Z,1652140501.336 [WetLabsBB2FL] No Fault, FailCount= 3 2022-05-09T23:55:01.720Z,1652140501.720 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:01.724Z,1652140501.724 [WetLabsBB2FL](INFO): Powering up 2022-05-09T23:55:02.136Z,1652140502.136 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:02.548Z,1652140502.548 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:02.976Z,1652140502.976 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:03.392Z,1652140503.392 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:03.820Z,1652140503.820 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:04.224Z,1652140504.224 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:04.644Z,1652140504.644 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:05.064Z,1652140505.064 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:05.480Z,1652140505.480 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:05.912Z,1652140505.912 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:06.336Z,1652140506.336 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:06.756Z,1652140506.756 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:07.016Z,1652140507.016 [WetLabsBB2FL] Communications Fault, FailCount= 4 2022-05-09T23:55:07.016Z,1652140507.016 [WetLabsBB2FL](ERROR): Communications Fault 2022-05-09T23:55:07.160Z,1652140507.160 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:07.184Z,1652140507.184 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2022-05-09T23:55:07.516Z,1652140507.516 [WetLabsBB2FL](INFO): Powering down 2022-05-09T23:55:07.572Z,1652140507.572 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:07.988Z,1652140507.988 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:08.404Z,1652140508.404 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:08.441Z,1652140508.441 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2022-05-09T23:55:08.441Z,1652140508.441 [WetLabsBB2FL] No Fault, FailCount= 4 2022-05-09T23:55:08.733Z,1652140508.733 [WetLabsBB2FL](INFO): Powering up 2022-05-09T23:55:08.836Z,1652140508.836 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:09.264Z,1652140509.264 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:09.688Z,1652140509.688 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:10.100Z,1652140510.100 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:10.512Z,1652140510.512 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:10.924Z,1652140510.924 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:10.924Z,1652140510.924 [AHRS_M2](FAULT): Failed to initialize within timeout. 2022-05-09T23:55:10.924Z,1652140510.924 [AHRS_M2] Communications Fault, FailCount= 2 2022-05-09T23:55:10.924Z,1652140510.924 [AHRS_M2](ERROR): Communications Fault 2022-05-09T23:55:10.968Z,1652140510.968 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2022-05-09T23:55:11.021Z,1652140511.021 [AHRS_M2](INFO): Powering down 2022-05-09T23:55:11.818Z,1652140511.818 [CBIT](INFO): Clearing failed state for component AHRS_M2 2022-05-09T23:55:11.818Z,1652140511.818 [AHRS_M2] No Fault, FailCount= 2 2022-05-09T23:55:12.193Z,1652140512.193 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2022-05-09T23:55:14.028Z,1652140514.028 [WetLabsBB2FL] Communications Fault, FailCount= 5 2022-05-09T23:55:14.028Z,1652140514.028 [WetLabsBB2FL](ERROR): Communications Fault 2022-05-09T23:55:14.242Z,1652140514.242 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2022-05-09T23:55:14.243Z,1652140514.243 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL 2022-05-09T23:55:14.529Z,1652140514.529 [WetLabsBB2FL](INFO): Powering down 2022-05-09T23:55:15.752Z,1652140515.752 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:16.168Z,1652140516.168 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:16.588Z,1652140516.588 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:17.012Z,1652140517.012 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:17.444Z,1652140517.444 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:17.884Z,1652140517.884 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:18.300Z,1652140518.300 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:18.712Z,1652140518.712 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:19.124Z,1652140519.124 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:19.540Z,1652140519.540 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:19.968Z,1652140519.968 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:20.404Z,1652140520.404 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:20.824Z,1652140520.824 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:21.236Z,1652140521.236 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:21.660Z,1652140521.660 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:22.092Z,1652140522.092 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:22.516Z,1652140522.516 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:22.948Z,1652140522.948 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:23.388Z,1652140523.388 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:23.820Z,1652140523.820 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:24.240Z,1652140524.240 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:24.648Z,1652140524.648 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:25.064Z,1652140525.064 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:25.064Z,1652140525.064 [AHRS_M2](FAULT): Failed to initialize within timeout. 2022-05-09T23:55:25.064Z,1652140525.064 [AHRS_M2] Communications Fault, FailCount= 3 2022-05-09T23:55:25.064Z,1652140525.064 [AHRS_M2](ERROR): Communications Fault 2022-05-09T23:55:25.081Z,1652140525.081 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2022-05-09T23:55:25.149Z,1652140525.149 [AHRS_M2](INFO): Powering down 2022-05-09T23:55:25.931Z,1652140525.931 [CBIT](INFO): Clearing failed state for component AHRS_M2 2022-05-09T23:55:25.931Z,1652140525.931 [AHRS_M2] No Fault, FailCount= 3 2022-05-09T23:55:26.305Z,1652140526.305 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2022-05-09T23:55:29.860Z,1652140529.860 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:30.268Z,1652140530.268 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:30.680Z,1652140530.680 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:31.112Z,1652140531.112 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:31.548Z,1652140531.548 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:31.980Z,1652140531.980 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:32.396Z,1652140532.396 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:32.812Z,1652140532.812 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:33.228Z,1652140533.228 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:33.644Z,1652140533.644 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:34.072Z,1652140534.072 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:34.512Z,1652140534.512 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:34.944Z,1652140534.944 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:35.352Z,1652140535.352 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:35.764Z,1652140535.764 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:36.176Z,1652140536.176 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:36.584Z,1652140536.584 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:37.024Z,1652140537.024 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:37.452Z,1652140537.452 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:37.872Z,1652140537.872 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:38.284Z,1652140538.284 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:38.692Z,1652140538.692 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:39.108Z,1652140539.108 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:39.516Z,1652140539.516 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:39.516Z,1652140539.516 [AHRS_M2](FAULT): Failed to initialize within timeout. 2022-05-09T23:55:39.517Z,1652140539.517 [AHRS_M2] Communications Fault, FailCount= 4 2022-05-09T23:55:39.517Z,1652140539.517 [AHRS_M2](ERROR): Communications Fault 2022-05-09T23:55:39.550Z,1652140539.550 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2022-05-09T23:55:39.614Z,1652140539.614 [AHRS_M2](INFO): Powering down 2022-05-09T23:55:40.389Z,1652140540.389 [CBIT](INFO): Clearing failed state for component AHRS_M2 2022-05-09T23:55:40.389Z,1652140540.389 [AHRS_M2] No Fault, FailCount= 4 2022-05-09T23:55:40.777Z,1652140540.777 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2022-05-09T23:55:44.332Z,1652140544.332 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:44.748Z,1652140544.748 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:45.180Z,1652140545.180 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:45.624Z,1652140545.624 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:46.048Z,1652140546.048 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:46.460Z,1652140546.460 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:46.876Z,1652140546.876 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:47.292Z,1652140547.292 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:47.732Z,1652140547.732 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:48.164Z,1652140548.164 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:48.592Z,1652140548.592 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:49.004Z,1652140549.004 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:49.420Z,1652140549.420 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:49.840Z,1652140549.840 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:50.252Z,1652140550.252 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:50.684Z,1652140550.684 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:51.100Z,1652140551.100 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:51.536Z,1652140551.536 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:51.956Z,1652140551.956 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:52.388Z,1652140552.388 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:52.808Z,1652140552.808 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:53.224Z,1652140553.224 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:53.648Z,1652140553.648 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-09T23:55:53.648Z,1652140553.648 [AHRS_M2](FAULT): Failed to initialize within timeout. 2022-05-09T23:55:53.648Z,1652140553.648 [AHRS_M2] Communications Fault, FailCount= 5 2022-05-09T23:55:53.648Z,1652140553.648 [AHRS_M2](ERROR): Communications Fault 2022-05-09T23:55:53.702Z,1652140553.702 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2022-05-09T23:55:53.703Z,1652140553.703 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2 2022-05-09T23:55:53.773Z,1652140553.773 [AHRS_M2](INFO): Powering down 2022-05-09T23:55:53.890Z,1652140553.890 [CBIT](INFO): Critical error at 20220509T235553 2022-05-09T23:56:24.868Z,1652140584.868 [CBIT](INFO): Clearing failed state for component DVL_micro 2022-05-09T23:56:24.868Z,1652140584.868 [DVL_micro] No Fault, FailCount= 3 2022-05-09T23:56:35.365Z,1652140595.365 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2022-05-09T23:56:35.365Z,1652140595.365 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2022-05-09T23:56:35.365Z,1652140595.365 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2022-05-09T23:56:35.376Z,1652140595.376 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2022-05-09T23:56:35.771Z,1652140595.771 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2022-05-09T23:56:35.771Z,1652140595.771 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2022-05-09T23:56:42.627Z,1652140602.627 [DVL_micro](FAULT): Failed to initialize within timeout. 2022-05-09T23:56:42.627Z,1652140602.627 [DVL_micro] Communications Fault, FailCount= 1 2022-05-09T23:56:42.627Z,1652140602.627 [DVL_micro](ERROR): Communications Fault 2022-05-09T23:56:42.671Z,1652140602.671 [CBIT](ERROR): Communications Fault in component: DVL_micro 2022-05-09T23:56:43.100Z,1652140603.100 [DVL_micro](INFO): Powering down 2022-05-09T23:56:43.858Z,1652140603.858 [CBIT](INFO): Clearing failed state for component DVL_micro 2022-05-09T23:56:43.858Z,1652140603.858 [DVL_micro] No Fault, FailCount= 1 2022-05-09T23:57:00.826Z,1652140620.826 [Default:CheckIn:Read_GPS](INFO): Timed out from 2022-05-09T23:52:00.8Z 2022-05-09T23:57:00.826Z,1652140620.826 [Default:CheckIn:Read_GPS] Stopped 2022-05-09T23:57:00.826Z,1652140620.826 [Default:CheckIn:Read_Iridium] Running Loop=1 2022-05-09T23:57:01.245Z,1652140621.245 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2022-05-09T23:57:01.607Z,1652140621.607 [DVL_micro](FAULT): Failed to initialize within timeout. 2022-05-09T23:57:01.607Z,1652140621.607 [DVL_micro] Communications Fault, FailCount= 2 2022-05-09T23:57:01.607Z,1652140621.607 [DVL_micro](ERROR): Communications Fault 2022-05-09T23:57:01.624Z,1652140621.624 [CBIT](ERROR): Communications Fault in component: DVL_micro 2022-05-09T23:57:02.092Z,1652140622.092 [DVL_micro](INFO): Powering down 2022-05-09T23:57:02.853Z,1652140622.853 [CBIT](INFO): Clearing failed state for component DVL_micro 2022-05-09T23:57:02.853Z,1652140622.853 [DVL_micro] No Fault, FailCount= 2 2022-05-09T23:57:06.930Z,1652140626.930 [DataOverHttps](INFO): Sending 108 bytes from file Logs/20220509T234822/Courier0004.lzma 2022-05-09T23:57:07.930Z,1652140627.930 [DataOverHttps](INFO): Moved sent file to Logs/20220509T234822/Courier0004.lzma.bak 2022-05-09T23:57:07.930Z,1652140627.930 [DataOverHttps](INFO): SBD MOMSN=16729831 2022-05-09T23:57:20.602Z,1652140640.602 [DVL_micro](FAULT): Failed to initialize within timeout. 2022-05-09T23:57:20.602Z,1652140640.602 [DVL_micro] Communications Fault, FailCount= 3 2022-05-09T23:57:20.602Z,1652140640.602 [DVL_micro](ERROR): Communications Fault 2022-05-09T23:57:20.626Z,1652140640.626 [CBIT](ERROR): Communications Fault in component: DVL_micro 2022-05-09T23:57:20.626Z,1652140640.626 [CBIT](CRITICAL): Communications Fault in component: DVL_micro 2022-05-09T23:57:21.076Z,1652140641.076 [DVL_micro](INFO): Powering down 2022-05-09T23:57:21.128Z,1652140641.128 [CBIT](INFO): Critical error at 20220509T235720 2022-05-09T23:57:23.060Z,1652140643.060 [DataOverHttps](INFO): Sending 466 bytes from file Logs/20220509T234822/Express0005.lzma 2022-05-09T23:57:24.062Z,1652140644.062 [DataOverHttps](INFO): Moved sent file to Logs/20220509T234822/Express0005.lzma.bak 2022-05-09T23:57:24.062Z,1652140644.062 [DataOverHttps](INFO): SBD MOMSN=16729835 2022-05-09T23:57:25.461Z,1652140645.461 [Default:CheckIn:Read_Iridium] Stopped 2022-05-09T23:57:25.461Z,1652140645.461 [Default:CheckIn:C.Wait] Running Loop=1 2022-05-09T23:57:25.461Z,1652140645.461 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2022-05-09T23:57:44.072Z,1652140664.072 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2022-05-09T23:57:44.072Z,1652140664.072 [WetLabsBB2FL] No Fault, FailCount= 5 2022-05-09T23:57:44.125Z,1652140664.125 [WetLabsBB2FL](INFO): Powering up 2022-05-09T23:57:49.428Z,1652140669.428 [WetLabsBB2FL] Communications Fault, FailCount= 1 2022-05-09T23:57:49.428Z,1652140669.428 [WetLabsBB2FL](ERROR): Communications Fault 2022-05-09T23:57:49.729Z,1652140669.729 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2022-05-09T23:57:49.928Z,1652140669.928 [WetLabsBB2FL](INFO): Powering down 2022-05-09T23:57:50.917Z,1652140670.917 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2022-05-09T23:57:50.918Z,1652140670.918 [WetLabsBB2FL] No Fault, FailCount= 1 2022-05-09T23:57:51.142Z,1652140671.142 [WetLabsBB2FL](INFO): Powering up 2022-05-09T23:57:56.432Z,1652140676.432 [WetLabsBB2FL] Communications Fault, FailCount= 2 2022-05-09T23:57:56.432Z,1652140676.432 [WetLabsBB2FL](ERROR): Communications Fault 2022-05-09T23:57:56.576Z,1652140676.576 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2022-05-09T23:57:56.932Z,1652140676.932 [WetLabsBB2FL](INFO): Powering down 2022-05-09T23:57:57.785Z,1652140677.785 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2022-05-09T23:57:57.785Z,1652140677.785 [WetLabsBB2FL] No Fault, FailCount= 2 2022-05-09T23:57:58.145Z,1652140678.145 [WetLabsBB2FL](INFO): Powering up 2022-05-09T23:58:03.444Z,1652140683.444 [WetLabsBB2FL] Communications Fault, FailCount= 3 2022-05-09T23:58:03.444Z,1652140683.444 [WetLabsBB2FL](ERROR): Communications Fault 2022-05-09T23:58:03.852Z,1652140683.852 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2022-05-09T23:58:03.944Z,1652140683.944 [WetLabsBB2FL](INFO): Powering down 2022-05-09T23:58:05.078Z,1652140685.078 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2022-05-09T23:58:05.078Z,1652140685.078 [WetLabsBB2FL] No Fault, FailCount= 3 2022-05-09T23:58:05.157Z,1652140685.157 [WetLabsBB2FL](INFO): Powering up 2022-05-09T23:58:10.448Z,1652140690.448 [WetLabsBB2FL] Communications Fault, FailCount= 4 2022-05-09T23:58:10.448Z,1652140690.448 [WetLabsBB2FL](ERROR): Communications Fault 2022-05-09T23:58:10.721Z,1652140690.721 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2022-05-09T23:58:10.948Z,1652140690.948 [WetLabsBB2FL](INFO): Powering down 2022-05-09T23:58:11.938Z,1652140691.938 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2022-05-09T23:58:11.939Z,1652140691.939 [WetLabsBB2FL] No Fault, FailCount= 4 2022-05-09T23:58:12.162Z,1652140692.162 [WetLabsBB2FL](INFO): Powering up 2022-05-09T23:58:17.456Z,1652140697.456 [WetLabsBB2FL] Communications Fault, FailCount= 5 2022-05-09T23:58:17.456Z,1652140697.456 [WetLabsBB2FL](ERROR): Communications Fault 2022-05-09T23:58:17.606Z,1652140697.606 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2022-05-09T23:58:17.607Z,1652140697.607 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL 2022-05-09T23:58:17.956Z,1652140697.956 [WetLabsBB2FL](INFO): Powering down 2022-05-09T23:58:36.556Z,1652140716.556 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2022-05-09T23:58:36.556Z,1652140716.556 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2022-05-09T23:58:36.556Z,1652140716.556 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2022-05-09T23:58:36.567Z,1652140716.567 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2022-05-09T23:58:36.967Z,1652140716.967 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2022-05-09T23:58:36.967Z,1652140716.967 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2022-05-09T23:58:51.108Z,1652140731.108 [Power24vConverter](INFO): Powering down. 2022-05-09T23:59:15.334Z,1652140755.334 [NAL9602](FAULT): GPS failed to acquire within timeout. 2022-05-09T23:59:15.335Z,1652140755.335 [NAL9602] Data Fault, FailCount= 1 2022-05-09T23:59:15.335Z,1652140755.335 [NAL9602](ERROR): Data Fault 2022-05-09T23:59:15.351Z,1652140755.351 [CBIT](ERROR): Data Fault in component: NAL9602 2022-05-09T23:59:15.735Z,1652140755.735 [NAL9602](INFO): Powering down 2022-05-09T23:59:16.558Z,1652140756.559 [CBIT](INFO): Clearing failed state for component NAL9602 2022-05-09T23:59:16.559Z,1652140756.559 [NAL9602] No Fault, FailCount= 1 2022-05-09T23:59:46.038Z,1652140786.038 [NAL9602](INFO): Powering up NAL9602 2022-05-09T23:59:56.946Z,1652140796.946 [NAL9602](INFO): NAL9602 initialized 2022-05-10T00:00:20.806Z,1652140820.806 [CBIT](INFO): Clearing failed state for component DVL_micro 2022-05-10T00:00:20.806Z,1652140820.806 [DVL_micro] No Fault, FailCount= 3 2022-05-10T00:00:21.200Z,1652140821.200 [Power24vConverter](INFO): Powering up. 2022-05-10T00:00:37.775Z,1652140837.775 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2022-05-10T00:00:37.775Z,1652140837.775 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2022-05-10T00:00:37.775Z,1652140837.775 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2022-05-10T00:00:37.786Z,1652140837.786 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2022-05-10T00:00:38.169Z,1652140838.169 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2022-05-10T00:00:38.169Z,1652140838.169 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2022-05-10T00:00:38.561Z,1652140838.561 [DVL_micro](FAULT): Failed to initialize within timeout. 2022-05-10T00:00:38.561Z,1652140838.561 [DVL_micro] Communications Fault, FailCount= 1 2022-05-10T00:00:38.561Z,1652140838.561 [DVL_micro](ERROR): Communications Fault 2022-05-10T00:00:38.586Z,1652140838.586 [CBIT](ERROR): Communications Fault in component: DVL_micro 2022-05-10T00:00:39.036Z,1652140839.036 [DVL_micro](INFO): Powering down 2022-05-10T00:00:39.799Z,1652140839.799 [CBIT](INFO): Clearing failed state for component DVL_micro 2022-05-10T00:00:39.799Z,1652140839.799 [DVL_micro] No Fault, FailCount= 1 2022-05-10T00:00:47.485Z,1652140847.485 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2022-05-10T00:00:47.485Z,1652140847.485 [WetLabsBB2FL] No Fault, FailCount= 5 2022-05-10T00:00:47.551Z,1652140847.551 [CommandExec](IMPORTANT): got command maintain control VerticalControl.massPositionAction -38 millimeter 2022-05-10T00:00:47.553Z,1652140847.553 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.massPositionAction" handled in the control thread. 2022-05-10T00:00:47.853Z,1652140847.853 [WetLabsBB2FL](INFO): Powering up 2022-05-10T00:00:47.887Z,1652140847.887 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,Depth_Keller,DVL_micro,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,ShortestDistanceToPolygonSidesCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.massPositionAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2022-05-10T00:00:53.144Z,1652140853.144 [WetLabsBB2FL] Communications Fault, FailCount= 1 2022-05-10T00:00:53.144Z,1652140853.144 [WetLabsBB2FL](ERROR): Communications Fault 2022-05-10T00:00:53.165Z,1652140853.165 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2022-05-10T00:00:53.640Z,1652140853.640 [WetLabsBB2FL](INFO): Powering down 2022-05-10T00:00:53.972Z,1652140853.972 [CBIT](INFO): Clearing failed state for component AHRS_M2 2022-05-10T00:00:53.972Z,1652140853.972 [AHRS_M2] No Fault, FailCount= 5 2022-05-10T00:00:54.321Z,1652140854.321 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2022-05-10T00:00:54.777Z,1652140854.777 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2022-05-10T00:00:54.777Z,1652140854.777 [WetLabsBB2FL] No Fault, FailCount= 1 2022-05-10T00:00:54.853Z,1652140854.853 [WetLabsBB2FL](INFO): Powering up 2022-05-10T00:00:57.868Z,1652140857.868 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:00:57.873Z,1652140857.873 [DVL_micro](FAULT): Failed to initialize within timeout. 2022-05-10T00:00:57.873Z,1652140857.873 [DVL_micro] Communications Fault, FailCount= 2 2022-05-10T00:00:57.873Z,1652140857.873 [DVL_micro](ERROR): Communications Fault 2022-05-10T00:00:57.953Z,1652140857.953 [CBIT](ERROR): Communications Fault in component: DVL_micro 2022-05-10T00:00:58.292Z,1652140858.292 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:00:58.376Z,1652140858.376 [DVL_micro](INFO): Powering down 2022-05-10T00:00:58.784Z,1652140858.784 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:00:59.208Z,1652140859.208 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:00:59.304Z,1652140859.304 [CBIT](INFO): Clearing failed state for component DVL_micro 2022-05-10T00:00:59.304Z,1652140859.304 [DVL_micro] No Fault, FailCount= 2 2022-05-10T00:00:59.636Z,1652140859.636 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:00.068Z,1652140860.068 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:00.148Z,1652140860.148 [WetLabsBB2FL] Communications Fault, FailCount= 2 2022-05-10T00:01:00.148Z,1652140860.148 [WetLabsBB2FL](ERROR): Communications Fault 2022-05-10T00:01:00.476Z,1652140860.476 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:00.549Z,1652140860.549 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2022-05-10T00:01:00.660Z,1652140860.660 [WetLabsBB2FL](INFO): Powering down 2022-05-10T00:01:00.912Z,1652140860.912 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:01.332Z,1652140861.332 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:01.744Z,1652140861.744 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:01.828Z,1652140861.828 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2022-05-10T00:01:01.828Z,1652140861.828 [WetLabsBB2FL] No Fault, FailCount= 2 2022-05-10T00:01:01.879Z,1652140861.879 [WetLabsBB2FL](INFO): Powering up 2022-05-10T00:01:02.208Z,1652140862.208 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:02.640Z,1652140862.640 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:03.108Z,1652140863.108 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:03.524Z,1652140863.524 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:03.932Z,1652140863.932 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:04.348Z,1652140864.348 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:04.752Z,1652140864.752 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:05.168Z,1652140865.168 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:05.612Z,1652140865.612 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:06.024Z,1652140866.024 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:06.436Z,1652140866.436 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:06.856Z,1652140866.856 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:07.164Z,1652140867.164 [WetLabsBB2FL] Communications Fault, FailCount= 3 2022-05-10T00:01:07.164Z,1652140867.164 [WetLabsBB2FL](ERROR): Communications Fault 2022-05-10T00:01:07.272Z,1652140867.272 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:07.272Z,1652140867.272 [AHRS_M2](FAULT): Failed to initialize within timeout. 2022-05-10T00:01:07.272Z,1652140867.272 [AHRS_M2] Communications Fault, FailCount= 1 2022-05-10T00:01:07.272Z,1652140867.272 [AHRS_M2](ERROR): Communications Fault 2022-05-10T00:01:07.320Z,1652140867.320 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2022-05-10T00:01:07.320Z,1652140867.320 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2022-05-10T00:01:07.365Z,1652140867.365 [AHRS_M2](INFO): Powering down 2022-05-10T00:01:07.666Z,1652140867.666 [WetLabsBB2FL](INFO): Powering down 2022-05-10T00:01:08.216Z,1652140868.216 [CBIT](INFO): Clearing failed state for component AHRS_M2 2022-05-10T00:01:08.216Z,1652140868.216 [AHRS_M2] No Fault, FailCount= 1 2022-05-10T00:01:08.549Z,1652140868.549 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2022-05-10T00:01:08.604Z,1652140868.604 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2022-05-10T00:01:08.604Z,1652140868.604 [WetLabsBB2FL] No Fault, FailCount= 3 2022-05-10T00:01:08.877Z,1652140868.877 [WetLabsBB2FL](INFO): Powering up 2022-05-10T00:01:12.108Z,1652140872.108 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:12.516Z,1652140872.516 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:12.924Z,1652140872.924 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:13.364Z,1652140873.364 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:13.800Z,1652140873.800 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:14.168Z,1652140874.168 [WetLabsBB2FL] Communications Fault, FailCount= 4 2022-05-10T00:01:14.168Z,1652140874.168 [WetLabsBB2FL](ERROR): Communications Fault 2022-05-10T00:01:14.217Z,1652140874.217 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:14.275Z,1652140874.275 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2022-05-10T00:01:14.628Z,1652140874.628 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:14.668Z,1652140874.668 [WetLabsBB2FL](INFO): Powering down 2022-05-10T00:01:15.124Z,1652140875.124 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:15.548Z,1652140875.548 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:15.608Z,1652140875.608 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2022-05-10T00:01:15.608Z,1652140875.608 [WetLabsBB2FL] No Fault, FailCount= 4 2022-05-10T00:01:15.881Z,1652140875.881 [WetLabsBB2FL](INFO): Powering up 2022-05-10T00:01:15.964Z,1652140875.964 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:16.392Z,1652140876.392 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:16.824Z,1652140876.824 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:17.257Z,1652140877.257 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:17.314Z,1652140877.314 [DVL_micro](FAULT): Failed to initialize within timeout. 2022-05-10T00:01:17.314Z,1652140877.314 [DVL_micro] Communications Fault, FailCount= 3 2022-05-10T00:01:17.314Z,1652140877.314 [DVL_micro](ERROR): Communications Fault 2022-05-10T00:01:17.408Z,1652140877.408 [CBIT](ERROR): Communications Fault in component: DVL_micro 2022-05-10T00:01:17.408Z,1652140877.408 [CBIT](CRITICAL): Communications Fault in component: DVL_micro 2022-05-10T00:01:17.776Z,1652140877.776 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:17.848Z,1652140877.848 [DVL_micro](INFO): Powering down 2022-05-10T00:01:17.911Z,1652140877.911 [CBIT](INFO): Critical error at 20220510T000117 2022-05-10T00:01:18.264Z,1652140878.264 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:18.668Z,1652140878.668 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:19.092Z,1652140879.092 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:19.500Z,1652140879.500 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:19.916Z,1652140879.916 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:20.328Z,1652140880.328 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:20.740Z,1652140880.740 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:21.168Z,1652140881.168 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:21.181Z,1652140881.181 [WetLabsBB2FL] Communications Fault, FailCount= 5 2022-05-10T00:01:21.181Z,1652140881.181 [WetLabsBB2FL](ERROR): Communications Fault 2022-05-10T00:01:21.256Z,1652140881.256 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2022-05-10T00:01:21.256Z,1652140881.256 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL 2022-05-10T00:01:21.620Z,1652140881.620 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:21.620Z,1652140881.620 [AHRS_M2](FAULT): Failed to initialize within timeout. 2022-05-10T00:01:21.620Z,1652140881.620 [AHRS_M2] Communications Fault, FailCount= 2 2022-05-10T00:01:21.620Z,1652140881.620 [AHRS_M2](ERROR): Communications Fault 2022-05-10T00:01:21.681Z,1652140881.681 [WetLabsBB2FL](INFO): Powering down 2022-05-10T00:01:21.708Z,1652140881.708 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2022-05-10T00:01:21.737Z,1652140881.737 [AHRS_M2](INFO): Powering down 2022-05-10T00:01:22.576Z,1652140882.576 [CBIT](INFO): Clearing failed state for component AHRS_M2 2022-05-10T00:01:22.576Z,1652140882.576 [AHRS_M2] No Fault, FailCount= 2 2022-05-10T00:01:22.933Z,1652140882.933 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2022-05-10T00:01:26.492Z,1652140886.492 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:26.920Z,1652140886.920 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:27.336Z,1652140887.336 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:27.752Z,1652140887.752 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:28.184Z,1652140888.184 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:28.380Z,1652140888.380 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-05-10T00:01:29.612Z,1652140889.612 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout 2022-05-10T00:01:30.768Z,1652140890.768 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2022-05-10T00:01:31.576Z,1652140891.576 [AHRS_M2](ERROR): Subscribe Yaw UART error: serial timeout 2022-05-10T00:01:34.004Z,1652140894.004 [AHRS_M2](ERROR): Subscribe Temperature UART error: serial timeout 2022-05-10T00:01:45.248Z,1652140905.248 [AHRS_M2](FAULT): Failed to acquire valid data within timeout. 2022-05-10T00:01:45.248Z,1652140905.248 [AHRS_M2] Data Fault, FailCount= 3 2022-05-10T00:01:45.248Z,1652140905.248 [AHRS_M2](ERROR): Data Fault 2022-05-10T00:01:45.315Z,1652140905.315 [CBIT](ERROR): Data Fault in component: AHRS_M2 2022-05-10T00:01:45.637Z,1652140905.637 [AHRS_M2](INFO): Powering down 2022-05-10T00:01:46.462Z,1652140906.462 [CBIT](INFO): Clearing failed state for component AHRS_M2 2022-05-10T00:01:46.462Z,1652140906.462 [AHRS_M2] No Fault, FailCount= 3 2022-05-10T00:01:46.846Z,1652140906.846 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2022-05-10T00:01:50.400Z,1652140910.400 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:01:50.820Z,1652140910.820 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:01:51.256Z,1652140911.256 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:01:51.676Z,1652140911.676 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:01:52.080Z,1652140912.080 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:01:52.496Z,1652140912.496 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:01:52.908Z,1652140912.908 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:01:53.324Z,1652140913.324 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:01:53.764Z,1652140913.764 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:01:54.184Z,1652140914.184 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:01:54.592Z,1652140914.592 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:01:55.016Z,1652140915.016 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:01:55.428Z,1652140915.428 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:01:55.836Z,1652140915.836 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:01:56.280Z,1652140916.280 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:01:56.708Z,1652140916.708 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:01:57.136Z,1652140917.136 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:01:57.564Z,1652140917.564 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:01:57.980Z,1652140917.980 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:01:58.400Z,1652140918.400 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:01:58.816Z,1652140918.816 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:01:59.236Z,1652140919.236 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:01:59.644Z,1652140919.644 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:02:00.072Z,1652140920.072 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:02:00.072Z,1652140920.072 [AHRS_M2](FAULT): Failed to initialize within timeout. 2022-05-10T00:02:00.072Z,1652140920.072 [AHRS_M2] Communications Fault, FailCount= 4 2022-05-10T00:02:00.072Z,1652140920.072 [AHRS_M2](ERROR): Communications Fault 2022-05-10T00:02:00.154Z,1652140920.154 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2022-05-10T00:02:00.185Z,1652140920.185 [AHRS_M2](INFO): Powering down 2022-05-10T00:02:01.026Z,1652140921.026 [CBIT](INFO): Clearing failed state for component AHRS_M2 2022-05-10T00:02:01.026Z,1652140921.026 [AHRS_M2] No Fault, FailCount= 4 2022-05-10T00:02:01.393Z,1652140921.393 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2022-05-10T00:02:04.960Z,1652140924.960 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:02:05.376Z,1652140925.376 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:02:05.812Z,1652140925.812 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:02:06.252Z,1652140926.252 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:02:06.676Z,1652140926.676 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:02:07.088Z,1652140927.088 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:02:07.500Z,1652140927.500 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:02:07.904Z,1652140927.904 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:02:08.328Z,1652140928.328 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:02:08.756Z,1652140928.756 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:02:09.184Z,1652140929.184 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:02:09.604Z,1652140929.604 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:02:10.016Z,1652140930.016 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:02:10.472Z,1652140930.472 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:02:10.896Z,1652140930.896 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:02:10.959Z,1652140930.959 [CommandExec](IMPORTANT): got command maintain control VerticalControl.massPositionAction -28 millimeter 2022-05-10T00:02:11.328Z,1652140931.328 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:02:11.756Z,1652140931.756 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:02:12.188Z,1652140932.188 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:02:12.604Z,1652140932.604 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:02:13.012Z,1652140933.012 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:02:13.436Z,1652140933.436 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:02:13.860Z,1652140933.860 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:02:14.280Z,1652140934.280 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2022-05-10T00:02:14.280Z,1652140934.280 [AHRS_M2](FAULT): Failed to initialize within timeout. 2022-05-10T00:02:14.280Z,1652140934.280 [AHRS_M2] Communications Fault, FailCount= 5 2022-05-10T00:02:14.280Z,1652140934.280 [AHRS_M2](ERROR): Communications Fault 2022-05-10T00:02:14.368Z,1652140934.368 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2022-05-10T00:02:14.369Z,1652140934.369 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2 2022-05-10T00:02:14.410Z,1652140934.410 [AHRS_M2](INFO): Powering down 2022-05-10T00:02:14.554Z,1652140934.554 [CBIT](INFO): Critical error at 20220510T000214 2022-05-10T00:02:26.118Z,1652140946.118 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2022-05-10T00:02:26.118Z,1652140946.118 [Default:CheckIn:C.Wait] Stopped 2022-05-10T00:02:26.118Z,1652140946.118 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2022-05-10T00:02:26.118Z,1652140946.118 [Default:CheckIn:D] Running Loop=1 2022-05-10T00:02:26.529Z,1652140946.529 [Default:CheckIn:D] Stopped 2022-05-10T00:02:26.529Z,1652140946.529 [Default:CheckIn:E] Running Loop=1 2022-05-10T00:02:26.919Z,1652140946.919 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.658138 min 2022-05-10T00:02:26.919Z,1652140946.919 [Default:CheckIn:E] Stopped 2022-05-10T00:02:26.919Z,1652140946.919 [Default:CheckIn](INFO): Completed Default:CheckIn 2022-05-10T00:02:26.919Z,1652140946.919 [Default:CheckIn] Stopped 2022-05-10T00:02:26.919Z,1652140946.919 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2022-05-10T00:02:26.919Z,1652140946.919 [Default:CheckIn](INFO): Running loop #2 2022-05-10T00:02:26.919Z,1652140946.919 [Default:CheckIn] Running Loop=2 2022-05-10T00:02:26.919Z,1652140946.919 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2022-05-10T00:02:26.919Z,1652140946.919 [Default:CheckIn:Read_GPS] Running Loop=1 2022-05-10T00:02:28.465Z,1652140948.465 [CommandExec](IMPORTANT): got command maintain control VerticalControl.massPositionAction -38 millimeter 2022-05-10T00:02:38.627Z,1652140958.627 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2022-05-10T00:02:38.628Z,1652140958.628 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2022-05-10T00:02:38.628Z,1652140958.628 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2022-05-10T00:02:38.697Z,1652140958.697 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2022-05-10T00:02:39.076Z,1652140959.076 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2022-05-10T00:02:39.076Z,1652140959.076 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2022-05-10T00:02:49.490Z,1652140969.490 [CommandExec](IMPORTANT): got command maintain clear 2022-05-10T00:02:49.554Z,1652140969.554 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,Depth_Keller,DVL_micro,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,ShortestDistanceToPolygonSidesCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2022-05-10T00:03:41.553Z,1652141021.553 [CommandExec](IMPORTANT): got command quit 2022-05-10T00:03:42.556Z,1652141022.556 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2022-05-10T00:03:42.556Z,1652141022.556 [CommandExec](INFO): Uninitializing the command executive. 2022-05-10T00:03:42.556Z,1652141022.556 [CommandExec](INFO): Uninitializing the command scheduler. 2022-05-10T00:03:42.557Z,1652141022.557 [CommandExec ThreadHandler](INFO): Thread cancelled. 2022-05-10T00:03:42.744Z,1652141022.744 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2022-05-10T00:03:42.744Z,1652141022.744 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2022-05-10T00:03:42.744Z,1652141022.744 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2022-05-10T00:03:42.745Z,1652141022.745 [NavChartDb](INFO): Join timeout helper Thread ID is 6780 2022-05-10T00:03:43.140Z,1652141023.140 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2022-05-10T00:03:43.140Z,1652141023.140 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2022-05-10T00:03:43.144Z,1652141023.144 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2022-05-10T00:03:43.144Z,1652141023.144 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2022-05-10T00:03:43.145Z,1652141023.145 [Radio_Surface](INFO): Join timeout helper Thread ID is 6781 2022-05-10T00:03:43.344Z,1652141023.344 [Radio_Surface](INFO): Powering down 2022-05-10T00:03:43.345Z,1652141023.345 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2022-05-10T00:03:43.345Z,1652141023.345 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2022-05-10T00:03:43.364Z,1652141023.364 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2022-05-10T00:03:43.364Z,1652141023.364 [Onboard ThreadHandler](INFO): Thread cancelled. 2022-05-10T00:03:43.365Z,1652141023.365 [Onboard](INFO): Join timeout helper Thread ID is 6782 2022-05-10T00:03:43.796Z,1652141023.796 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2022-05-10T00:03:47.784Z,1652141027.784 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2022-05-10T00:03:47.784Z,1652141027.784 [Onboard ThreadHandler](INFO): Thread cancelled. 2022-05-10T00:03:47.800Z,1652141027.800 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2022-05-10T00:03:47.800Z,1652141027.800 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2022-05-10T00:03:47.800Z,1652141027.800 [DataOverHttps](INFO): Join timeout helper Thread ID is 6783 2022-05-10T00:03:47.812Z,1652141027.812 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2022-05-10T00:03:47.812Z,1652141027.812 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2022-05-10T00:03:47.820Z,1652141027.820 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2022-05-10T00:03:47.820Z,1652141027.820 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2022-05-10T00:03:47.820Z,1652141027.820 [BackseatComponent](INFO): Join timeout helper Thread ID is 6784 2022-05-10T00:03:47.880Z,1652141027.880 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2022-05-10T00:03:47.881Z,1652141027.881 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2022-05-10T00:03:47.889Z,1652141027.889 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2022-05-10T00:03:47.889Z,1652141027.889 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2022-05-10T00:03:47.890Z,1652141027.890 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 6785 2022-05-10T00:03:47.928Z,1652141027.928 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2022-05-10T00:03:47.928Z,1652141027.928 [WetLabsBB2FL](INFO): Powering down 2022-05-10T00:03:47.929Z,1652141027.929 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2022-05-10T00:03:47.949Z,1652141027.949 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2022-05-10T00:03:47.949Z,1652141027.949 [logger ThreadHandler](INFO): Thread cancelled. 2022-05-10T00:03:47.949Z,1652141027.949 [logger](INFO): Join timeout helper Thread ID is 6786 2022-05-10T00:03:47.963Z,1652141027.963 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2022-05-10T00:03:47.963Z,1652141027.963 [logger ThreadHandler](INFO): Thread cancelled. 2022-05-10T00:03:47.981Z,1652141027.981 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2022-05-10T00:03:47.981Z,1652141027.981 [CommandLine ThreadHandler](INFO): Thread cancelled. 2022-05-10T00:03:47.988Z,1652141027.988 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2022-05-10T00:03:47.989Z,1652141027.989 [CommandLine ThreadHandler](INFO): Thread cancelled. 2022-05-10T00:03:47.989Z,1652141027.989 [CommandLine](INFO): Join timeout helper Thread ID is 6787 2022-05-10T00:03:48.001Z,1652141028.001 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2022-05-10T00:03:48.001Z,1652141028.001 [CommandExec ThreadHandler](INFO): Thread cancelled. 2022-05-10T00:03:48.001Z,1652141028.001 [CommandExec](INFO): Join timeout helper Thread ID is 6788 2022-05-10T00:03:48.009Z,1652141028.009 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2022-05-10T00:03:48.009Z,1652141028.009 [controlThread ThreadHandler](INFO): Thread cancelled. 2022-05-10T00:03:48.009Z,1652141028.009 [controlThread](INFO): Join timeout helper Thread ID is 6789 2022-05-10T00:03:48.096Z,1652141028.096 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2022-05-10T00:03:48.096Z,1652141028.096 [controlThread](DEBUG): Uninitializing ControlThread 2022-05-10T00:03:48.098Z,1652141028.098 [AHRS_M2](INFO): Powering down 2022-05-10T00:03:48.099Z,1652141028.099 [DVL_micro](INFO): Powering down 2022-05-10T00:03:48.100Z,1652141028.100 [NAL9602](INFO): Powering down 2022-05-10T00:03:48.102Z,1652141028.102 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2022-05-10T00:03:48.102Z,1652141028.102 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2022-05-10T00:03:48.103Z,1652141028.103 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2022-05-10T00:03:48.103Z,1652141028.103 [MissionManager](INFO): Uninitializing Mission Default 2022-05-10T00:03:48.103Z,1652141028.103 [Default] Stopped 2022-05-10T00:03:48.103Z,1652141028.103 [Default](DEBUG): Aggregate::uninitialize Default 2022-05-10T00:03:48.104Z,1652141028.104 [Default:B.GoToSurface] Stopped 2022-05-10T00:03:48.104Z,1652141028.104 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2022-05-10T00:03:48.104Z,1652141028.104 [Default:CheckIn] Stopped 2022-05-10T00:03:48.104Z,1652141028.104 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2022-05-10T00:03:48.104Z,1652141028.104 [Default:CheckIn:Read_GPS] Stopped 2022-05-10T00:03:48.107Z,1652141028.107 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2022-05-10T00:03:48.107Z,1652141028.107 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2022-05-10T00:03:48.107Z,1652141028.107 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2022-05-10T00:03:48.107Z,1652141028.107 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2022-05-10T00:03:48.108Z,1652141028.108 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2022-05-10T00:03:48.108Z,1652141028.108 [BuoyancyServo](INFO): Powering down 2022-05-10T00:03:48.120Z,1652141028.120 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2022-05-10T00:03:48.120Z,1652141028.120 [ElevatorServo](INFO): Powering down 2022-05-10T00:03:48.121Z,1652141028.121 [MassServo](DEBUG): Uninitialize Mass Servo. 2022-05-10T00:03:48.121Z,1652141028.121 [MassServo](INFO): Powering down 2022-05-10T00:03:48.122Z,1652141028.122 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2022-05-10T00:03:48.122Z,1652141028.122 [RudderServo](INFO): Powering down 2022-05-10T00:03:48.123Z,1652141028.123 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2022-05-10T00:03:48.123Z,1652141028.123 [ThrusterHE](INFO): Powering down 2022-05-10T00:03:48.124Z,1652141028.124 [SBIT](DEBUG): Uninitialize SBIT Component. 2022-05-10T00:03:48.125Z,1652141028.125 [IBIT](DEBUG): Uninitialize IBIT Component. 2022-05-10T00:03:48.125Z,1652141028.125 [CBIT](DEBUG): Uninitialize CBIT Component. 2022-05-10T00:03:48.125Z,1652141028.125 [CBIT](DEBUG): Powering off loads. 2022-05-10T00:03:48.136Z,1652141028.136 [CBIT](DEBUG): Disabling WDT. 2022-05-10T00:03:48.148Z,1652141028.148 [CBIT](DEBUG): Opening all GF detection circuits. 2022-05-10T00:03:48.149Z,1652141028.149 [controlThread ThreadHandler](INFO): Thread cancelled. 2022-05-10T00:03:48.314Z,1652141028.314 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2022-05-10T00:03:48.346Z,1652141028.346 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2022-05-10T00:03:48.348Z,1652141028.348 [Onboard ThreadHandler](INFO): Thread cancelled. 2022-05-10T00:03:48.355Z,1652141028.355 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2022-05-10T00:03:48.361Z,1652141028.361 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2022-05-10T00:03:48.415Z,1652141028.415 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2022-05-10T00:03:48.478Z,1652141028.478 [logger ThreadHandler](INFO): Thread cancelled.