2023-05-30T19:09:10.278Z,1685473750.278 [Supervisor](DEBUG): Initializing supervisor. 2023-05-30T19:09:10.282Z,1685473750.282 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2023-05-30T19:09:10.283Z,1685473750.283 [SyncHandler](INFO): Protected caller Thread ID is 7772 2023-05-30T19:09:10.283Z,1685473750.283 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2023-05-30T19:09:10.284Z,1685473750.284 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2023-05-30T19:09:10.284Z,1685473750.284 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 7773 2023-05-30T19:09:10.288Z,1685473750.288 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2023-05-30T19:09:10.306Z,1685473750.306 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2023-05-30T19:09:10.307Z,1685473750.307 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2023-05-30T19:09:10.308Z,1685473750.308 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 7774 2023-05-30T19:09:10.312Z,1685473750.312 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2023-05-30T19:09:10.313Z,1685473750.313 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2023-05-30T19:09:10.313Z,1685473750.313 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 7775 2023-05-30T19:09:10.315Z,1685473750.315 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2023-05-30T19:09:10.316Z,1685473750.316 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2023-05-30T19:09:10.317Z,1685473750.317 [logger ThreadHandler](INFO): Protected caller Thread ID is 7776 2023-05-30T19:09:10.320Z,1685473750.320 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2023-05-30T19:09:10.321Z,1685473750.321 [Supervisor](INFO): Looking for Config files in directory: Config/ 2023-05-30T19:09:10.322Z,1685473750.322 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2023-05-30T19:09:10.640Z,1685473750.640 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2023-05-30T19:09:10.641Z,1685473750.641 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2023-05-30T19:09:10.722Z,1685473750.722 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2023-05-30T19:09:10.827Z,1685473750.827 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2023-05-30T19:09:10.827Z,1685473750.827 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2023-05-30T19:09:10.953Z,1685473750.953 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2023-05-30T19:09:10.954Z,1685473750.954 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2023-05-30T19:09:11.273Z,1685473751.273 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2023-05-30T19:09:11.274Z,1685473751.274 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2023-05-30T19:09:11.369Z,1685473751.369 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2023-05-30T19:09:11.370Z,1685473751.370 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2023-05-30T19:09:11.738Z,1685473751.738 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2023-05-30T19:09:11.738Z,1685473751.738 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2023-05-30T19:09:12.005Z,1685473752.005 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2023-05-30T19:09:12.006Z,1685473752.006 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2023-05-30T19:09:12.084Z,1685473752.084 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2023-05-30T19:09:12.299Z,1685473752.299 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2023-05-30T19:09:12.299Z,1685473752.299 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2023-05-30T19:09:12.511Z,1685473752.511 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2023-05-30T19:09:12.511Z,1685473752.511 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2023-05-30T19:09:13.003Z,1685473753.003 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2023-05-30T19:09:13.004Z,1685473753.004 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2023-05-30T19:09:13.184Z,1685473753.184 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2023-05-30T19:09:13.184Z,1685473753.184 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2023-05-30T19:09:13.452Z,1685473753.452 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2023-05-30T19:09:13.453Z,1685473753.453 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2023-05-30T19:09:14.183Z,1685473754.183 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2023-05-30T19:09:14.184Z,1685473754.184 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2023-05-30T19:09:14.672Z,1685473754.672 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2023-05-30T19:09:14.675Z,1685473754.675 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/ 2023-05-30T19:09:14.675Z,1685473754.675 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Control.cfg 2023-05-30T19:09:14.769Z,1685473754.769 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Science.cfg 2023-05-30T19:09:14.893Z,1685473754.893 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/secure.cfg 2023-05-30T19:09:14.984Z,1685473754.984 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Servo.cfg 2023-05-30T19:09:15.100Z,1685473755.100 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/BIT.cfg 2023-05-30T19:09:15.196Z,1685473755.196 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Battery.cfg 2023-05-30T19:09:15.448Z,1685473755.448 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2023-05-30T19:09:15.448Z,1685473755.448 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/vehicle.cfg 2023-05-30T19:09:15.550Z,1685473755.550 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/logger.cfg 2023-05-30T19:09:15.642Z,1685473755.642 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Navigation.cfg 2023-05-30T19:09:15.744Z,1685473755.744 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Sensor.cfg 2023-05-30T19:09:15.861Z,1685473755.861 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Simulator.cfg 2023-05-30T19:09:15.947Z,1685473755.947 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/root/ 2023-05-30T19:09:15.948Z,1685473755.948 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2023-05-30T19:09:15.951Z,1685473755.951 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2023-05-30T19:09:16.047Z,1685473756.047 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2023-05-30T19:09:16.048Z,1685473756.048 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2023-05-30T19:09:16.098Z,1685473756.098 [VerticalControl](DEBUG): Construct VerticalControl. 2023-05-30T19:09:16.157Z,1685473756.157 [VerticalControl] Loaded 2023-05-30T19:09:16.157Z,1685473756.157 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2023-05-30T19:09:16.160Z,1685473756.160 [HorizontalControl](DEBUG): Construct HorizontalControl. 2023-05-30T19:09:16.201Z,1685473756.201 [HorizontalControl] Loaded 2023-05-30T19:09:16.201Z,1685473756.201 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2023-05-30T19:09:16.204Z,1685473756.204 [SpeedControl](DEBUG): Construct SpeedControl. 2023-05-30T19:09:16.207Z,1685473756.207 [SpeedControl] Loaded 2023-05-30T19:09:16.207Z,1685473756.207 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2023-05-30T19:09:16.210Z,1685473756.210 [LoopControl](DEBUG): Construct LoopControl. 2023-05-30T19:09:16.210Z,1685473756.210 [LoopControl] Loaded 2023-05-30T19:09:16.211Z,1685473756.211 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2023-05-30T19:09:16.211Z,1685473756.211 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2023-05-30T19:09:16.212Z,1685473756.212 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2023-05-30T19:09:16.267Z,1685473756.267 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2023-05-30T19:09:16.267Z,1685473756.267 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2023-05-30T19:09:16.683Z,1685473756.683 [AHRS_M2] Loaded 2023-05-30T19:09:16.683Z,1685473756.683 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2023-05-30T19:09:17.481Z,1685473757.481 [BPC1] Loaded 2023-05-30T19:09:17.482Z,1685473757.482 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2023-05-30T19:09:17.552Z,1685473757.552 [DataOverHttps] Loaded 2023-05-30T19:09:17.553Z,1685473757.553 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2023-05-30T19:09:17.554Z,1685473757.554 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4087B4E0 2023-05-30T19:09:17.554Z,1685473757.554 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 7859 2023-05-30T19:09:17.575Z,1685473757.575 [Depth_Keller] Loaded 2023-05-30T19:09:17.575Z,1685473757.575 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2023-05-30T19:09:17.580Z,1685473757.580 [DropWeight] Loaded 2023-05-30T19:09:17.580Z,1685473757.580 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2023-05-30T19:09:17.642Z,1685473757.642 [NAL9602] Loaded 2023-05-30T19:09:17.643Z,1685473757.643 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2023-05-30T19:09:17.673Z,1685473757.672 [Onboard] Loaded 2023-05-30T19:09:17.673Z,1685473757.673 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2023-05-30T19:09:17.674Z,1685473757.674 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408AB4E0 2023-05-30T19:09:17.674Z,1685473757.674 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 7860 2023-05-30T19:09:17.687Z,1685473757.687 [Power24vConverter] Loaded 2023-05-30T19:09:17.688Z,1685473757.688 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2023-05-30T19:09:17.701Z,1685473757.701 [Radio_Surface] Loaded 2023-05-30T19:09:17.701Z,1685473757.701 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2023-05-30T19:09:17.702Z,1685473757.702 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408DB4E0 2023-05-30T19:09:17.702Z,1685473757.702 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 7861 2023-05-30T19:09:17.734Z,1685473757.734 [Rowe_600] Loaded 2023-05-30T19:09:17.734Z,1685473757.734 [ComponentRegistry](DEBUG): SyncComponent "Rowe_600" handled in the control thread. 2023-05-30T19:09:17.825Z,1685473757.825 [DAT] Loaded 2023-05-30T19:09:17.826Z,1685473757.826 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2023-05-30T19:09:17.827Z,1685473757.827 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 4090B4E0 2023-05-30T19:09:17.827Z,1685473757.827 [DAT ThreadHandler](INFO): Protected caller Thread ID is 7862 2023-05-30T19:09:17.828Z,1685473757.828 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2023-05-30T19:09:17.828Z,1685473757.828 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2023-05-30T19:09:17.838Z,1685473757.838 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2023-05-30T19:09:17.839Z,1685473757.839 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2023-05-30T19:09:17.869Z,1685473757.869 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2023-05-30T19:09:17.869Z,1685473757.869 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2023-05-30T19:09:18.003Z,1685473758.003 [SBIT](DEBUG): Construct Startup Built In Test. 2023-05-30T19:09:18.012Z,1685473758.012 [SBIT] Loaded 2023-05-30T19:09:18.012Z,1685473758.012 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2023-05-30T19:09:18.015Z,1685473758.015 [IBIT](DEBUG): Construct Initiated Built In Test. 2023-05-30T19:09:18.028Z,1685473758.028 [IBIT] Loaded 2023-05-30T19:09:18.028Z,1685473758.028 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2023-05-30T19:09:18.034Z,1685473758.034 [CBIT](DEBUG): Construct Continuous Built In Test. 2023-05-30T19:09:18.138Z,1685473758.138 [CBIT] Loaded 2023-05-30T19:09:18.138Z,1685473758.138 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2023-05-30T19:09:18.139Z,1685473758.139 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2023-05-30T19:09:18.139Z,1685473758.139 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2023-05-30T19:09:18.443Z,1685473758.443 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2023-05-30T19:09:18.444Z,1685473758.444 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2023-05-30T19:09:18.493Z,1685473758.493 [DepthRateCalculator] Loaded 2023-05-30T19:09:18.493Z,1685473758.493 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2023-05-30T19:09:18.498Z,1685473758.498 [PitchRateCalculator] Loaded 2023-05-30T19:09:18.498Z,1685473758.498 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2023-05-30T19:09:18.508Z,1685473758.508 [SpeedCalculator] Loaded 2023-05-30T19:09:18.509Z,1685473758.509 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2023-05-30T19:09:18.513Z,1685473758.513 [YawRateCalculator] Loaded 2023-05-30T19:09:18.513Z,1685473758.513 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2023-05-30T19:09:18.532Z,1685473758.532 [ElevatorOffsetCalculator] Loaded 2023-05-30T19:09:18.532Z,1685473758.532 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2023-05-30T19:09:18.533Z,1685473758.533 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2023-05-30T19:09:18.533Z,1685473758.533 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2023-05-30T19:09:18.676Z,1685473758.676 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2023-05-30T19:09:18.677Z,1685473758.677 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2023-05-30T19:09:18.790Z,1685473758.790 [DeadReckonUsingMultipleVelocitySources] Loaded 2023-05-30T19:09:18.790Z,1685473758.790 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2023-05-30T19:09:18.832Z,1685473758.832 [DeadReckonUsingSpeedCalculator] Loaded 2023-05-30T19:09:18.832Z,1685473758.832 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2023-05-30T19:09:18.875Z,1685473758.875 [DeadReckonWithRespectToSeafloor] Loaded 2023-05-30T19:09:18.875Z,1685473758.875 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread. 2023-05-30T19:09:18.889Z,1685473758.889 [NavChart] Loaded 2023-05-30T19:09:18.889Z,1685473758.889 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2023-05-30T19:09:18.895Z,1685473758.895 [UniversalFixResidualReporter] Loaded 2023-05-30T19:09:18.895Z,1685473758.895 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2023-05-30T19:09:18.896Z,1685473758.896 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2023-05-30T19:09:18.896Z,1685473758.896 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2023-05-30T19:09:19.026Z,1685473759.026 [BuoyancyServo] Loaded 2023-05-30T19:09:19.027Z,1685473759.027 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2023-05-30T19:09:19.047Z,1685473759.047 [ElevatorServo] Loaded 2023-05-30T19:09:19.047Z,1685473759.047 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2023-05-30T19:09:19.067Z,1685473759.067 [MassServo] Loaded 2023-05-30T19:09:19.067Z,1685473759.067 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2023-05-30T19:09:19.086Z,1685473759.086 [RudderServo] Loaded 2023-05-30T19:09:19.086Z,1685473759.086 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2023-05-30T19:09:19.101Z,1685473759.101 [ThrusterHE] Loaded 2023-05-30T19:09:19.101Z,1685473759.101 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2023-05-30T19:09:19.102Z,1685473759.102 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2023-05-30T19:09:19.102Z,1685473759.102 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2023-05-30T19:09:19.240Z,1685473759.240 [Aanderaa_O2] Loaded 2023-05-30T19:09:19.240Z,1685473759.240 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread. 2023-05-30T19:09:19.301Z,1685473759.301 [CTD_Seabird] Loaded 2023-05-30T19:09:19.301Z,1685473759.301 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2023-05-30T19:09:19.303Z,1685473759.303 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B5A4E0 2023-05-30T19:09:19.303Z,1685473759.303 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 7863 2023-05-30T19:09:19.336Z,1685473759.336 [ESPComponent] Loaded 2023-05-30T19:09:19.336Z,1685473759.336 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2023-05-30T19:09:19.356Z,1685473759.356 [PAR_Licor] Loaded 2023-05-30T19:09:19.357Z,1685473759.357 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2023-05-30T19:09:19.388Z,1685473759.388 [WetLabsBB2FL] Loaded 2023-05-30T19:09:19.388Z,1685473759.388 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2023-05-30T19:09:19.389Z,1685473759.389 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B8A4E0 2023-05-30T19:09:19.390Z,1685473759.390 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 7864 2023-05-30T19:09:19.390Z,1685473759.390 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2023-05-30T19:09:19.397Z,1685473759.397 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2023-05-30T19:09:19.400Z,1685473759.400 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2023-05-30T19:09:19.411Z,1685473759.411 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2023-05-30T19:09:19.412Z,1685473759.412 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BBA4E0 2023-05-30T19:09:19.412Z,1685473759.412 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 7865 2023-05-30T19:09:19.418Z,1685473759.418 [Supervisor](INFO): Main Thread ID is 7771 2023-05-30T19:09:19.418Z,1685473759.418 [Supervisor](DEBUG): Running supervisor. 2023-05-30T19:09:19.419Z,1685473759.419 [CommandExec ThreadHandler](INFO): Handler Thread ID is 7866 2023-05-30T19:09:19.420Z,1685473759.420 [CommandExec](INFO): Initializing the command executive. 2023-05-30T19:09:19.421Z,1685473759.421 [CommandLine ThreadHandler](INFO): Handler Thread ID is 7867 2023-05-30T19:09:19.423Z,1685473759.423 [controlThread ThreadHandler](INFO): Handler Thread ID is 7868 2023-05-30T19:09:19.424Z,1685473759.424 [controlThread](DEBUG): Initializing ControlThread 2023-05-30T19:09:19.425Z,1685473759.425 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2023-05-30T19:09:19.426Z,1685473759.426 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2023-05-30T19:09:19.427Z,1685473759.427 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2023-05-30T19:09:19.428Z,1685473759.428 [LoopControl](DEBUG): Initialize LoopControlComponent. 2023-05-30T19:09:19.433Z,1685473759.433 [SBIT](INFO): Initialize SBIT Component. 2023-05-30T19:09:19.433Z,1685473759.433 [SBIT](IMPORTANT): git: 2023-05-23 2023-05-30T19:09:19.433Z,1685473759.433 [SBIT](INFO): git hash: b3953f130bbf661f8bdb6215fe799a82fab83260 2023-05-30T19:09:19.434Z,1685473759.434 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2023-05-30T19:09:19.435Z,1685473759.435 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #639 PREEMPT Wed Mar 12 12:53:33 PDT 2014 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2023-05-30T19:09:19.436Z,1685473759.436 [SBIT](INFO): Beginning SBIT in 71.000000 seconds. 2023-05-30T19:09:19.436Z,1685473759.436 [IBIT](INFO): Initialize IBIT Component. 2023-05-30T19:09:19.437Z,1685473759.437 [CBIT](DEBUG): Initialize CBIT Component. 2023-05-30T19:09:19.438Z,1685473759.438 [logger ThreadHandler](INFO): Handler Thread ID is 7869 2023-05-30T19:09:19.451Z,1685473759.451 [CBIT](DEBUG): Initialized mux pins. 2023-05-30T19:09:19.451Z,1685473759.451 [CBIT](DEBUG): Initializing the watchdog timer. 2023-05-30T19:09:19.459Z,1685473759.459 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 7870 2023-05-30T19:09:19.460Z,1685473759.460 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2023-05-30T19:09:19.471Z,1685473759.471 [Onboard ThreadHandler](INFO): Handler Thread ID is 7871 2023-05-30T19:09:19.475Z,1685473759.475 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2023-05-30T19:09:19.476Z,1685473759.476 [CBIT](DEBUG): Initializing heartbeat. 2023-05-30T19:09:19.491Z,1685473759.491 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 7872 2023-05-30T19:09:19.507Z,1685473759.507 [DAT ThreadHandler](INFO): Handler Thread ID is 7873 2023-05-30T19:09:19.508Z,1685473759.508 [DAT](INFO): Powering up 2023-05-30T19:09:19.508Z,1685473759.508 [DAT](DEBUG): Initializing DAT. 2023-05-30T19:09:19.512Z,1685473759.512 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 7875 2023-05-30T19:09:19.513Z,1685473759.513 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2023-05-30T19:09:19.516Z,1685473759.516 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 7877 2023-05-30T19:09:19.519Z,1685473759.519 [WetLabsBB2FL](INFO): Powering up 2023-05-30T19:09:19.520Z,1685473759.520 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 7879 2023-05-30T19:09:19.524Z,1685473759.524 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2HA05M.000 2023-05-30T19:09:19.524Z,1685473759.524 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2HA05M.000 2023-05-30T19:09:19.524Z,1685473759.524 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3HA20M.000 2023-05-30T19:09:19.525Z,1685473759.525 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3HA20M.000 2023-05-30T19:09:19.525Z,1685473759.525 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000 2023-05-30T19:09:19.525Z,1685473759.525 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000 2023-05-30T19:09:19.525Z,1685473759.525 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000 2023-05-30T19:09:19.525Z,1685473759.525 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000 2023-05-30T19:09:19.525Z,1685473759.525 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA53M.000 2023-05-30T19:09:19.526Z,1685473759.526 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA53M.000 2023-05-30T19:09:19.526Z,1685473759.526 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA55M.000 2023-05-30T19:09:19.526Z,1685473759.526 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA55M.000 2023-05-30T19:09:19.547Z,1685473759.547 [CBIT](DEBUG): Deactivating GF circuits. 2023-05-30T19:09:19.547Z,1685473759.547 [CBIT](DEBUG): Deactivating emergency mode. 2023-05-30T19:09:19.587Z,1685473759.587 [CBIT](DEBUG): Backplane powered. 2023-05-30T19:09:19.587Z,1685473759.587 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2023-05-30T19:09:19.587Z,1685473759.587 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2023-05-30T19:09:19.588Z,1685473759.588 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2023-05-30T19:09:19.588Z,1685473759.588 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2023-05-30T19:09:19.588Z,1685473759.588 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2023-05-30T19:09:19.590Z,1685473759.590 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-05-30T19:09:19.591Z,1685473759.591 [NavChart](DEBUG): Initialize NavChart Navigation. 2023-05-30T19:09:19.591Z,1685473759.591 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2023-05-30T19:09:19.597Z,1685473759.597 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml 2023-05-30T19:09:19.615Z,1685473759.615 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2023-05-30T19:09:19.644Z,1685473759.644 [MissionManager](DEBUG): 2023-05-30T19:09:19.647Z,1685473759.647 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml 2023-05-30T19:09:19.700Z,1685473759.700 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2023-05-30T19:09:19.702Z,1685473759.702 [Default:A.Wait](DEBUG): Construct Wait. 2023-05-30T19:09:19.704Z,1685473759.704 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2023-05-30T19:09:19.717Z,1685473759.717 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2023-05-30T19:09:19.756Z,1685473759.756 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2023-05-30T19:09:19.780Z,1685473759.780 [Default:E.Execute](DEBUG): Construct Execute. 2023-05-30T19:09:19.784Z,1685473759.784 [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 2023-05-30T19:09:19.792Z,1685473759.792 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Rowe_600,Aanderaa_O2,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2023-05-30T19:09:19.815Z,1685473759.815 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2023-05-30T19:09:19.864Z,1685473759.864 [Depth_Keller](ERROR): Pressure or depth reading out of range: -1.140412 decibar, -1.132002 m 2023-05-30T19:09:19.865Z,1685473759.865 [Power24vConverter](INFO): Powering up. 2023-05-30T19:09:19.879Z,1685473759.879 [DepthRateCalculator](ERROR): Depth measurement is not active 2023-05-30T19:09:19.899Z,1685473759.899 [Radio_Surface](INFO): Powering up 2023-05-30T19:09:19.901Z,1685473759.901 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2023-05-30T19:09:19.907Z,1685473759.907 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2023-05-30T19:09:19.908Z,1685473759.908 [ElevatorServo](DEBUG): Initializing EZServoServo. 2023-05-30T19:09:19.915Z,1685473759.915 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2023-05-30T19:09:19.916Z,1685473759.916 [MassServo](DEBUG): Initializing EZServoServo. 2023-05-30T19:09:19.923Z,1685473759.923 [MassServo](DEBUG): Initializing MassServo. 2023-05-30T19:09:19.924Z,1685473759.924 [RudderServo](DEBUG): Initializing EZServoServo. 2023-05-30T19:09:19.931Z,1685473759.931 [RudderServo](DEBUG): Initializing RudderServo. 2023-05-30T19:09:19.932Z,1685473759.932 [ThrusterHE](DEBUG): Initializing EZServoServo. 2023-05-30T19:09:19.939Z,1685473759.939 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2023-05-30T19:09:20.244Z,1685473760.244 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2023-05-30T19:09:20.244Z,1685473760.244 [DropWeight] Hardware Fault, FailCount= 1 2023-05-30T19:09:20.244Z,1685473760.244 [DropWeight](ERROR): Hardware Fault 2023-05-30T19:09:20.281Z,1685473760.281 [CommandExec](FAULT): Scheduling is paused 2023-05-30T19:09:20.282Z,1685473760.282 [CBIT](INFO): Critical error at 20230530T190920 2023-05-30T19:09:20.282Z,1685473760.282 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2023-05-30T19:09:20.288Z,1685473760.288 [CBIT](ERROR): Hardware Fault in component: DropWeight 2023-05-30T19:09:20.289Z,1685473760.289 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2023-05-30T19:09:20.630Z,1685473760.630 [CBIT](INFO): Critical error at 20230530T190920 2023-05-30T19:09:21.391Z,1685473761.391 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2023-05-30T19:09:21.391Z,1685473761.391 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2023-05-30T19:09:21.391Z,1685473761.391 [BuoyancyServo] Communications Fault, FailCount= 1 2023-05-30T19:09:21.391Z,1685473761.391 [BuoyancyServo](ERROR): Communications Fault 2023-05-30T19:09:21.703Z,1685473761.703 [ElevatorServo](ERROR): Elevator initialization uart error I:serial timeout 2023-05-30T19:09:21.703Z,1685473761.703 [ElevatorServo](FAULT): Elevator failed to initialize 2023-05-30T19:09:21.703Z,1685473761.703 [ElevatorServo] Communications Fault, FailCount= 1 2023-05-30T19:09:21.703Z,1685473761.703 [ElevatorServo](ERROR): Communications Fault 2023-05-30T19:09:22.011Z,1685473762.011 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2023-05-30T19:09:22.011Z,1685473762.011 [RudderServo](FAULT): Rudder failed to initialize 2023-05-30T19:09:22.011Z,1685473762.011 [RudderServo] Communications Fault, FailCount= 1 2023-05-30T19:09:22.011Z,1685473762.011 [RudderServo](ERROR): Communications Fault 2023-05-30T19:09:22.018Z,1685473762.018 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2023-05-30T19:09:22.021Z,1685473762.021 [CBIT](ERROR): Communications Fault in component: ElevatorServo 2023-05-30T19:09:22.022Z,1685473762.022 [CBIT](ERROR): Communications Fault in component: RudderServo 2023-05-30T19:09:22.067Z,1685473762.067 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2023-05-30T19:09:22.068Z,1685473762.068 [ElevatorServo](INFO): Powering down 2023-05-30T19:09:22.075Z,1685473762.075 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2023-05-30T19:09:22.075Z,1685473762.075 [RudderServo](INFO): Powering down 2023-05-30T19:09:23.163Z,1685473763.163 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:09:23.211Z,1685473763.211 [ElevatorServo](DEBUG): Initializing EZServoServo. 2023-05-30T19:09:23.332Z,1685473763.332 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2023-05-30T19:09:23.333Z,1685473763.333 [RudderServo](DEBUG): Initializing EZServoServo. 2023-05-30T19:09:23.452Z,1685473763.452 [RudderServo](DEBUG): Initializing RudderServo. 2023-05-30T19:09:23.456Z,1685473763.456 [CBIT](INFO): Clearing failed state for component ElevatorServo 2023-05-30T19:09:23.456Z,1685473763.456 [ElevatorServo] No Fault, FailCount= 1 2023-05-30T19:09:23.456Z,1685473763.456 [CBIT](INFO): Clearing failed state for component RudderServo 2023-05-30T19:09:23.456Z,1685473763.456 [RudderServo] No Fault, FailCount= 1 2023-05-30T19:09:23.831Z,1685473763.831 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:09:24.239Z,1685473764.239 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:09:24.386Z,1685473764.386 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2023-05-30T19:09:24.386Z,1685473764.386 [BuoyancyServo] No Fault, FailCount= 1 2023-05-30T19:09:24.651Z,1685473764.651 [WetLabsBB2FL](INFO): Powering down 2023-05-30T19:09:24.711Z,1685473764.711 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:09:24.763Z,1685473764.763 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2023-05-30T19:09:24.884Z,1685473764.884 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2023-05-30T19:09:25.239Z,1685473765.239 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:09:25.643Z,1685473765.643 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:09:26.087Z,1685473766.087 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:09:26.541Z,1685473766.541 [CTD_Seabird](ERROR): Failed to parse device response: -0.10,21.9915,-0.00001 2023-05-30T19:09:26.735Z,1685473766.735 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:09:27.163Z,1685473767.163 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:09:27.544Z,1685473767.544 [CTD_Seabird](ERROR): Failed to parse device response: -0.11,21.9920,-0.00001 2023-05-30T19:09:27.615Z,1685473767.615 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:09:28.075Z,1685473768.075 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:09:28.531Z,1685473768.531 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:09:28.548Z,1685473768.548 [CTD_Seabird](ERROR): Failed to parse device response: -0.11,21.9912,-0.00001 2023-05-30T19:09:28.951Z,1685473768.951 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:09:29.435Z,1685473769.435 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:09:29.535Z,1685473769.535 [CBIT](CRITICAL): Environmental Failure. Press:14.734951 PSI. Humidity:40%. Temp:25 C. ABORTING MISSION 2023-05-30T19:09:29.552Z,1685473769.552 [CTD_Seabird](ERROR): Failed to parse device response: -0.11,21.9922,-0.00001 2023-05-30T19:09:29.855Z,1685473769.855 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:09:30.028Z,1685473770.028 [CBIT](INFO): Critical error at 20230530T190929 2023-05-30T19:09:30.363Z,1685473770.363 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:09:30.372Z,1685473770.372 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2023-05-30T19:09:30.372Z,1685473770.372 [Aanderaa_O2] Communications Fault, FailCount= 1 2023-05-30T19:09:30.372Z,1685473770.372 [Aanderaa_O2](ERROR): Communications Fault 2023-05-30T19:09:30.424Z,1685473770.424 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2023-05-30T19:09:30.556Z,1685473770.556 [CTD_Seabird](ERROR): Failed to parse device response: -0.11,21.9927,-0.00002 2023-05-30T19:09:30.767Z,1685473770.767 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:09:30.899Z,1685473770.899 [Aanderaa_O2](INFO): Powering down 2023-05-30T19:09:31.282Z,1685473771.283 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:09:31.560Z,1685473771.560 [CTD_Seabird](ERROR): Failed to parse device response: -0.10,21.9925,-0.00001 2023-05-30T19:09:31.799Z,1685473771.799 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:09:31.860Z,1685473771.860 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2023-05-30T19:09:31.860Z,1685473771.860 [Aanderaa_O2] No Fault, FailCount= 1 2023-05-30T19:09:32.211Z,1685473772.211 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:09:32.564Z,1685473772.564 [CTD_Seabird](ERROR): Failed to parse device response: -0.11,21.9922,-0.00001 2023-05-30T19:09:32.564Z,1685473772.564 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2023-05-30T19:09:32.564Z,1685473772.564 [CTD_Seabird] Communications Fault, FailCount= 1 2023-05-30T19:09:32.564Z,1685473772.564 [CTD_Seabird](ERROR): Communications Fault 2023-05-30T19:09:32.601Z,1685473772.601 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:09:32.601Z,1685473772.601 [AHRS_M2](FAULT): Failed to initialize within timeout. 2023-05-30T19:09:32.601Z,1685473772.601 [AHRS_M2] Communications Fault, FailCount= 1 2023-05-30T19:09:32.601Z,1685473772.601 [AHRS_M2](ERROR): Communications Fault 2023-05-30T19:09:32.943Z,1685473772.943 [MassServo](ERROR): getPosition uart error serial timeout 2023-05-30T19:09:32.943Z,1685473772.943 [MassServo](FAULT): Invalid EZ Servo response:"" 2023-05-30T19:09:32.943Z,1685473772.943 [MassServo] Communications Fault, FailCount= 1 2023-05-30T19:09:32.943Z,1685473772.943 [MassServo](ERROR): Communications Fault 2023-05-30T19:09:32.947Z,1685473772.947 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2023-05-30T19:09:32.948Z,1685473772.948 [CBIT](ERROR): Communications Fault in component: MassServo 2023-05-30T19:09:32.948Z,1685473772.948 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2023-05-30T19:09:32.954Z,1685473772.954 [AHRS_M2](INFO): Powering down 2023-05-30T19:09:32.967Z,1685473772.967 [CTD_Seabird](INFO): Powering down 2023-05-30T19:09:33.055Z,1685473773.055 [MassServo](DEBUG): Uninitialize Mass Servo. 2023-05-30T19:09:33.055Z,1685473773.055 [MassServo](INFO): Powering down 2023-05-30T19:09:33.781Z,1685473773.781 [MassServo](DEBUG): Initializing EZServoServo. 2023-05-30T19:09:33.900Z,1685473773.900 [MassServo](DEBUG): Initializing MassServo. 2023-05-30T19:09:33.904Z,1685473773.904 [CBIT](INFO): Clearing failed state for component AHRS_M2 2023-05-30T19:09:33.904Z,1685473773.904 [AHRS_M2] No Fault, FailCount= 1 2023-05-30T19:09:33.904Z,1685473773.904 [CBIT](INFO): Clearing failed state for component MassServo 2023-05-30T19:09:33.904Z,1685473773.904 [MassServo] No Fault, FailCount= 1 2023-05-30T19:09:34.163Z,1685473774.163 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2023-05-30T19:09:34.190Z,1685473774.190 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2023-05-30T19:09:34.190Z,1685473774.190 [CTD_Seabird] No Fault, FailCount= 1 2023-05-30T19:09:34.315Z,1685473774.315 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2023-05-30T19:09:36.507Z,1685473776.507 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout 2023-05-30T19:09:36.507Z,1685473776.507 [MassServo] Communications Fault, FailCount= 2 2023-05-30T19:09:36.507Z,1685473776.507 [MassServo](ERROR): Communications Fault 2023-05-30T19:09:36.511Z,1685473776.511 [CBIT](ERROR): Communications Fault in component: MassServo 2023-05-30T19:09:36.612Z,1685473776.612 [MassServo](DEBUG): Uninitialize Mass Servo. 2023-05-30T19:09:36.612Z,1685473776.612 [MassServo](INFO): Powering down 2023-05-30T19:09:37.719Z,1685473777.719 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:09:37.740Z,1685473777.740 [MassServo](DEBUG): Initializing EZServoServo. 2023-05-30T19:09:37.860Z,1685473777.860 [MassServo](DEBUG): Initializing MassServo. 2023-05-30T19:09:37.864Z,1685473777.864 [CBIT](INFO): Clearing failed state for component MassServo 2023-05-30T19:09:37.864Z,1685473777.864 [MassServo] No Fault, FailCount= 2 2023-05-30T19:09:38.195Z,1685473778.195 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:09:38.591Z,1685473778.591 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:09:38.999Z,1685473778.999 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:09:39.403Z,1685473779.403 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:09:39.811Z,1685473779.811 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:09:40.211Z,1685473780.211 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:09:40.615Z,1685473780.615 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:09:40.903Z,1685473780.903 [MassServo](FAULT): Mass initialization uart error:serial timeout 2023-05-30T19:09:40.903Z,1685473780.903 [MassServo] Communications Fault, FailCount= 3 2023-05-30T19:09:40.903Z,1685473780.903 [MassServo](ERROR): Communications Fault 2023-05-30T19:09:40.907Z,1685473780.907 [CBIT](ERROR): Communications Fault in component: MassServo 2023-05-30T19:09:41.231Z,1685473781.231 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:09:41.245Z,1685473781.245 [MassServo](DEBUG): Uninitialize Mass Servo. 2023-05-30T19:09:41.245Z,1685473781.245 [MassServo](INFO): Powering down 2023-05-30T19:09:41.361Z,1685473781.361 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit. 2023-05-30T19:09:41.639Z,1685473781.639 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:09:42.043Z,1685473782.043 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:09:42.064Z,1685473782.064 [MassServo](DEBUG): Initializing EZServoServo. 2023-05-30T19:09:42.180Z,1685473782.180 [MassServo](DEBUG): Initializing MassServo. 2023-05-30T19:09:42.184Z,1685473782.184 [CBIT](INFO): Clearing failed state for component MassServo 2023-05-30T19:09:42.184Z,1685473782.184 [MassServo] No Fault, FailCount= 3 2023-05-30T19:09:42.347Z,1685473782.347 [CTD_Seabird](ERROR): Failed to parse device response: 05 2023-05-30T19:09:42.519Z,1685473782.519 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:09:42.529Z,1685473782.529 [Rowe_600](ERROR): No DVL communication! Re-initializing 2023-05-30T19:09:42.529Z,1685473782.529 [Rowe_600] Communications Fault, FailCount= 1 2023-05-30T19:09:42.529Z,1685473782.529 [Rowe_600](ERROR): Communications Fault 2023-05-30T19:09:42.530Z,1685473782.530 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2023-05-30T19:09:42.530Z,1685473782.530 [Aanderaa_O2] Communications Fault, FailCount= 2 2023-05-30T19:09:42.530Z,1685473782.530 [Aanderaa_O2](ERROR): Communications Fault 2023-05-30T19:09:42.546Z,1685473782.546 [CBIT](ERROR): Communications Fault in component: Rowe_600 2023-05-30T19:09:42.546Z,1685473782.546 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2023-05-30T19:09:42.939Z,1685473782.939 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:09:43.015Z,1685473783.015 [Rowe_600](INFO): Powering down 2023-05-30T19:09:46.863Z,1685473786.863 [CommandExec](IMPORTANT): got command failComponent 2023-05-30T19:09:46.863Z,1685473786.863 [CommandExec](IMPORTANT): Failed components: 2023-05-30T19:09:46.863Z,1685473786.863 [CommandExec](IMPORTANT): DropWeight: Hardware Fault 2023-05-30T19:09:46.864Z,1685473786.864 [CommandExec](IMPORTANT): Rowe_600: Communications Fault 2023-05-30T19:09:46.864Z,1685473786.864 [CommandExec](IMPORTANT): Aanderaa_O2: Communications Fault 2023-05-30T19:09:47.367Z,1685473787.367 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2023-05-30T19:09:47.367Z,1685473787.367 [CTD_Seabird] Communications Fault, FailCount= 2 2023-05-30T19:09:47.367Z,1685473787.367 [CTD_Seabird](ERROR): Communications Fault 2023-05-30T19:09:47.771Z,1685473787.771 [CTD_Seabird](INFO): Powering down 2023-05-30T19:10:13.135Z,1685473813.135 [Aanderaa_O2](INFO): Powering down 2023-05-30T19:10:13.200Z,1685473813.200 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2023-05-30T19:10:13.200Z,1685473813.200 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2023-05-30T19:10:13.200Z,1685473813.200 [CTD_Seabird] No Fault, FailCount= 2 2023-05-30T19:10:13.355Z,1685473813.355 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2023-05-30T19:10:13.527Z,1685473813.527 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:13.527Z,1685473813.527 [AHRS_M2](FAULT): Failed to initialize within timeout. 2023-05-30T19:10:13.527Z,1685473813.527 [AHRS_M2] Communications Fault, FailCount= 2 2023-05-30T19:10:13.527Z,1685473813.527 [AHRS_M2](ERROR): Communications Fault 2023-05-30T19:10:13.549Z,1685473813.549 [NAL9602](INFO): Powering up NAL9602 2023-05-30T19:10:13.567Z,1685473813.567 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2023-05-30T19:10:13.608Z,1685473813.608 [AHRS_M2](INFO): Powering down 2023-05-30T19:10:13.702Z,1685473813.702 [CBIT](INFO): Clearing failed state for component Rowe_600 2023-05-30T19:10:13.702Z,1685473813.702 [Rowe_600] No Fault, FailCount= 1 2023-05-30T19:10:13.702Z,1685473813.702 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2023-05-30T19:10:13.702Z,1685473813.702 [Aanderaa_O2] No Fault, FailCount= 2 2023-05-30T19:10:14.454Z,1685473814.454 [CBIT](INFO): Clearing failed state for component AHRS_M2 2023-05-30T19:10:14.454Z,1685473814.454 [AHRS_M2] No Fault, FailCount= 2 2023-05-30T19:10:14.819Z,1685473814.819 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2023-05-30T19:10:15.103Z,1685473815.103 [MassServo](FAULT): Mass initialization uart error:serial timeout 2023-05-30T19:10:15.103Z,1685473815.103 [MassServo] Communications Fault, FailCount= 4 2023-05-30T19:10:15.103Z,1685473815.103 [MassServo](ERROR): Communications Fault 2023-05-30T19:10:15.107Z,1685473815.107 [CBIT](ERROR): Communications Fault in component: MassServo 2023-05-30T19:10:15.242Z,1685473815.242 [MassServo](DEBUG): Uninitialize Mass Servo. 2023-05-30T19:10:15.242Z,1685473815.242 [MassServo](INFO): Powering down 2023-05-30T19:10:16.052Z,1685473816.052 [MassServo](DEBUG): Initializing EZServoServo. 2023-05-30T19:10:16.172Z,1685473816.172 [MassServo](DEBUG): Initializing MassServo. 2023-05-30T19:10:16.176Z,1685473816.176 [CBIT](INFO): Clearing failed state for component MassServo 2023-05-30T19:10:16.176Z,1685473816.176 [MassServo] No Fault, FailCount= 4 2023-05-30T19:10:18.375Z,1685473818.375 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:18.779Z,1685473818.779 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:19.175Z,1685473819.175 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:19.583Z,1685473819.583 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:19.759Z,1685473819.759 [DAT](FAULT): failed to initialize, no bytes available on serial interface 2023-05-30T19:10:19.759Z,1685473819.759 [DAT] Communications Fault, FailCount= 1 2023-05-30T19:10:19.759Z,1685473819.759 [DAT](ERROR): Communications Fault 2023-05-30T19:10:19.987Z,1685473819.987 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:20.050Z,1685473820.050 [CBIT](ERROR): Communications Fault in component: DAT 2023-05-30T19:10:20.163Z,1685473820.163 [DAT](INFO): Powering down 2023-05-30T19:10:20.385Z,1685473820.385 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit. 2023-05-30T19:10:20.394Z,1685473820.394 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:20.803Z,1685473820.803 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:21.215Z,1685473821.215 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:21.259Z,1685473821.259 [CBIT](INFO): Clearing failed state for component DAT 2023-05-30T19:10:21.259Z,1685473821.259 [DAT] No Fault, FailCount= 1 2023-05-30T19:10:21.388Z,1685473821.388 [CTD_Seabird](ERROR): Failed to parse device response: -0.11,22.0040,-0.00001 2023-05-30T19:10:21.599Z,1685473821.599 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:22.007Z,1685473822.007 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:22.392Z,1685473822.392 [CTD_Seabird](ERROR): Failed to parse device response: -0.10,22.0048,-0.00000 2023-05-30T19:10:22.419Z,1685473822.419 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:22.823Z,1685473822.823 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:23.211Z,1685473823.211 [DAT](INFO): Powering up 2023-05-30T19:10:23.211Z,1685473823.211 [DAT](DEBUG): Initializing DAT. 2023-05-30T19:10:23.225Z,1685473823.225 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:23.396Z,1685473823.396 [CTD_Seabird](ERROR): Failed to parse device response: -0.11,22.0049,-0.00002 2023-05-30T19:10:23.623Z,1685473823.623 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:24.035Z,1685473824.035 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:24.060Z,1685473824.060 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2023-05-30T19:10:24.060Z,1685473824.060 [Aanderaa_O2] Communications Fault, FailCount= 3 2023-05-30T19:10:24.060Z,1685473824.060 [Aanderaa_O2](ERROR): Communications Fault 2023-05-30T19:10:24.130Z,1685473824.130 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2023-05-30T19:10:24.131Z,1685473824.131 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2023-05-30T19:10:24.400Z,1685473824.400 [CTD_Seabird](ERROR): Failed to parse device response: -0.11,22.0054,-0.00000 2023-05-30T19:10:24.459Z,1685473824.459 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:24.464Z,1685473824.464 [NAL9602](INFO): NAL9602 initialized 2023-05-30T19:10:24.583Z,1685473824.583 [Aanderaa_O2](INFO): Powering down 2023-05-30T19:10:24.971Z,1685473824.971 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:25.375Z,1685473825.375 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:25.404Z,1685473825.404 [CTD_Seabird](ERROR): Failed to parse device response: -0.10,22.0056,-0.00002 2023-05-30T19:10:25.799Z,1685473825.799 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:26.207Z,1685473826.207 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:26.408Z,1685473826.408 [CTD_Seabird](ERROR): Failed to parse device response: -0.10,22.0066,-0.00002 2023-05-30T19:10:26.408Z,1685473826.408 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2023-05-30T19:10:26.408Z,1685473826.408 [CTD_Seabird] Communications Fault, FailCount= 3 2023-05-30T19:10:26.408Z,1685473826.408 [CTD_Seabird](ERROR): Communications Fault 2023-05-30T19:10:26.631Z,1685473826.631 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:26.707Z,1685473826.707 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2023-05-30T19:10:26.707Z,1685473826.707 [CBIT](FAULT): Communications Fault in component: CTD_Seabird 2023-05-30T19:10:26.811Z,1685473826.811 [CTD_Seabird](INFO): Powering down 2023-05-30T19:10:27.035Z,1685473827.035 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:27.491Z,1685473827.491 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:27.899Z,1685473827.899 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:27.899Z,1685473827.899 [AHRS_M2](FAULT): Failed to initialize within timeout. 2023-05-30T19:10:27.899Z,1685473827.899 [AHRS_M2] Communications Fault, FailCount= 3 2023-05-30T19:10:27.899Z,1685473827.899 [AHRS_M2](ERROR): Communications Fault 2023-05-30T19:10:27.911Z,1685473827.911 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-05-30T19:10:28.015Z,1685473828.015 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2023-05-30T19:10:28.022Z,1685473828.022 [AHRS_M2](INFO): Powering down 2023-05-30T19:10:28.901Z,1685473828.901 [CBIT](INFO): Clearing failed state for component AHRS_M2 2023-05-30T19:10:28.901Z,1685473828.901 [AHRS_M2] No Fault, FailCount= 3 2023-05-30T19:10:29.231Z,1685473829.231 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2023-05-30T19:10:30.904Z,1685473830.904 [SBIT](IMPORTANT): Beginning Startup BIT 2023-05-30T19:10:30.909Z,1685473830.909 [CBIT](IMPORTANT): Beginning ground fault scan 2023-05-30T19:10:32.779Z,1685473832.779 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:33.327Z,1685473833.327 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:33.751Z,1685473833.751 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:34.191Z,1685473834.191 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:34.711Z,1685473834.711 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:35.147Z,1685473835.147 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:35.571Z,1685473835.571 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:35.876Z,1685473835.876 [CommandExec](IMPORTANT): got command ! echo 1 > /dev/loadB2 2023-05-30T19:10:36.072Z,1685473836.072 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:36.591Z,1685473836.591 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:36.601Z,1685473836.601 [Rowe_600](ERROR): No DVL communication! Re-initializing 2023-05-30T19:10:36.601Z,1685473836.601 [Rowe_600] Communications Fault, FailCount= 2 2023-05-30T19:10:36.601Z,1685473836.601 [Rowe_600](ERROR): Communications Fault 2023-05-30T19:10:36.669Z,1685473836.669 [CBIT](ERROR): Communications Fault in component: Rowe_600 2023-05-30T19:10:36.991Z,1685473836.991 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:37.071Z,1685473837.071 [Rowe_600](INFO): Powering down 2023-05-30T19:10:37.627Z,1685473837.626 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:38.031Z,1685473838.030 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:38.084Z,1685473838.084 [CBIT](INFO): Clearing failed state for component Rowe_600 2023-05-30T19:10:38.084Z,1685473838.084 [Rowe_600] No Fault, FailCount= 2 2023-05-30T19:10:38.451Z,1685473838.451 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:38.859Z,1685473838.859 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:39.319Z,1685473839.319 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:39.727Z,1685473839.727 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:40.115Z,1685473840.115 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:40.563Z,1685473840.563 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:40.999Z,1685473840.999 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:41.403Z,1685473841.403 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:41.863Z,1685473841.863 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:42.259Z,1685473842.259 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:42.259Z,1685473842.259 [AHRS_M2](FAULT): Failed to initialize within timeout. 2023-05-30T19:10:42.259Z,1685473842.259 [AHRS_M2] Communications Fault, FailCount= 4 2023-05-30T19:10:42.259Z,1685473842.259 [AHRS_M2](ERROR): Communications Fault 2023-05-30T19:10:42.304Z,1685473842.304 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2023-05-30T19:10:42.344Z,1685473842.344 [AHRS_M2](INFO): Powering down 2023-05-30T19:10:43.195Z,1685473843.195 [CBIT](INFO): Clearing failed state for component AHRS_M2 2023-05-30T19:10:43.195Z,1685473843.195 [AHRS_M2] No Fault, FailCount= 4 2023-05-30T19:10:43.199Z,1685473843.199 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.068641 CHAN A1 (24V): -0.128873 CHAN A2 (12V): -0.000031 CHAN A3 (5V): 0.000618 CHAN B0 (3.3V): -0.000083 CHAN B1 (3.15aV): 0.000360 CHAN B2 (3.15bV): 0.000078 CHAN B3 (GND): -0.000001 OPEN: 0.006622 Full Scale: +/- 1 mA 2023-05-30T19:10:43.555Z,1685473843.555 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2023-05-30T19:10:45.172Z,1685473845.172 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-05-30T19:10:47.115Z,1685473847.115 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:47.559Z,1685473847.559 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:48.003Z,1685473848.003 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:48.447Z,1685473848.447 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:48.919Z,1685473848.919 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:49.375Z,1685473849.375 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:49.839Z,1685473849.839 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:50.291Z,1685473850.291 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:50.751Z,1685473850.751 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:51.207Z,1685473851.207 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:51.707Z,1685473851.707 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:52.220Z,1685473852.220 [CommandExec](IMPORTANT): got command ! echo 1 > /dev/loadB2 2023-05-30T19:10:52.255Z,1685473852.255 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:52.719Z,1685473852.719 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:53.147Z,1685473853.147 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:53.599Z,1685473853.599 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:54.071Z,1685473854.071 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:54.599Z,1685473854.599 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:55.075Z,1685473855.075 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:55.543Z,1685473855.543 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:56.007Z,1685473856.007 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:56.451Z,1685473856.451 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2023-05-30T19:10:56.451Z,1685473856.451 [AHRS_M2](FAULT): Failed to initialize within timeout. 2023-05-30T19:10:56.451Z,1685473856.451 [AHRS_M2] Communications Fault, FailCount= 5 2023-05-30T19:10:56.451Z,1685473856.451 [AHRS_M2](ERROR): Communications Fault 2023-05-30T19:10:56.571Z,1685473856.571 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2023-05-30T19:10:56.572Z,1685473856.572 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2 2023-05-30T19:10:56.578Z,1685473856.578 [AHRS_M2](INFO): Powering down 2023-05-30T19:10:56.757Z,1685473856.757 [CBIT](INFO): Critical error at 20230530T191056 2023-05-30T19:11:01.029Z,1685473861.029 [Rowe_600](ERROR): No DVL communication! Re-initializing 2023-05-30T19:11:01.030Z,1685473861.030 [Rowe_600] Communications Fault, FailCount= 3 2023-05-30T19:11:01.030Z,1685473861.030 [Rowe_600](ERROR): Communications Fault 2023-05-30T19:11:01.124Z,1685473861.124 [CBIT](ERROR): Communications Fault in component: Rowe_600 2023-05-30T19:11:01.124Z,1685473861.124 [CBIT](CRITICAL): Communications Fault in component: Rowe_600 2023-05-30T19:11:01.499Z,1685473861.499 [Rowe_600](INFO): Powering down 2023-05-30T19:11:01.585Z,1685473861.585 [CBIT](INFO): Critical error at 20230530T191101 2023-05-30T19:11:02.232Z,1685473862.232 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-05-30T19:11:07.541Z,1685473867.541 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2023-05-30T19:11:18.796Z,1685473878.796 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-05-30T19:11:19.636Z,1685473879.636 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2023-05-30T19:11:19.636Z,1685473879.636 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2023-05-30T19:11:19.636Z,1685473879.636 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-05-30T19:11:19.637Z,1685473879.637 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2023-05-30T19:11:19.638Z,1685473879.638 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1 2023-05-30T19:11:19.638Z,1685473879.638 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-05-30T19:11:19.639Z,1685473879.639 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2023-05-30T19:11:19.639Z,1685473879.639 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2023-05-30T19:11:19.639Z,1685473879.639 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2023-05-30T19:11:19.651Z,1685473879.651 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-05-30T19:11:19.651Z,1685473879.651 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-05-30T19:11:19.652Z,1685473879.652 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2023-05-30T19:11:20.053Z,1685473880.053 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-05-30T19:11:20.053Z,1685473880.053 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2023-05-30T19:11:20.053Z,1685473880.053 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-05-30T19:11:20.053Z,1685473880.053 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1 2023-05-30T19:11:20.054Z,1685473880.054 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2023-05-30T19:11:20.054Z,1685473880.054 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2023-05-30T19:11:20.438Z,1685473880.438 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-05-30T19:11:23.247Z,1685473883.247 [DAT](FAULT): failed to initialize, no bytes available on serial interface 2023-05-30T19:11:23.247Z,1685473883.247 [DAT] Communications Fault, FailCount= 2 2023-05-30T19:11:23.247Z,1685473883.247 [DAT](ERROR): Communications Fault 2023-05-30T19:11:23.288Z,1685473883.288 [CBIT](ERROR): Communications Fault in component: DAT 2023-05-30T19:11:23.651Z,1685473883.651 [DAT](INFO): Powering down 2023-05-30T19:11:24.885Z,1685473884.885 [SBIT](IMPORTANT): SBIT PASSED 2023-05-30T19:11:24.885Z,1685473884.885 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2023-05-30T19:11:24.886Z,1685473884.886 [SBIT](IMPORTANT): AHRS_M2.simulateHardware=0 bool; 2023-05-30T19:11:24.890Z,1685473884.890 [CBIT](INFO): Clearing failed state for component DAT 2023-05-30T19:11:24.891Z,1685473884.891 [DAT] No Fault, FailCount= 2 2023-05-30T19:11:25.286Z,1685473885.286 [MissionManager](IMPORTANT): Started mission Startup 2023-05-30T19:11:25.287Z,1685473885.287 [Startup] Running Loop=1 2023-05-30T19:11:25.287Z,1685473885.287 [Startup](DEBUG): Aggregate::initialize Startup 2023-05-30T19:11:25.287Z,1685473885.287 [Startup:A.GoToSurface] Running Loop=1 2023-05-30T19:11:25.287Z,1685473885.287 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2023-05-30T19:11:25.288Z,1685473885.288 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2023-05-30T19:11:25.288Z,1685473885.288 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2023-05-30T19:11:25.288Z,1685473885.288 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2023-05-30T19:11:25.289Z,1685473885.289 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2023-05-30T19:11:25.289Z,1685473885.289 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2023-05-30T19:11:25.309Z,1685473885.309 [Startup:StartupSatComms] Running Loop=1 2023-05-30T19:11:25.309Z,1685473885.309 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2023-05-30T19:11:25.310Z,1685473885.310 [Startup:StartupSatComms:A] Running Loop=1 2023-05-30T19:11:25.698Z,1685473885.698 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2023-05-30T19:11:26.699Z,1685473886.699 [DAT](INFO): Powering up 2023-05-30T19:11:26.699Z,1685473886.699 [DAT](DEBUG): Initializing DAT. 2023-05-30T19:11:35.140Z,1685473895.140 [CommandExec](IMPORTANT): got command strobe off 2023-05-30T19:11:35.140Z,1685473895.140 [CommandExec](IMPORTANT): Deactivating strobe 2023-05-30T19:11:35.775Z,1685473895.775 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-05-30T19:11:42.131Z,1685473902.131 [Radio_Surface](FAULT): LCB fault: Current Limiter Activated. 2023-05-30T19:11:42.131Z,1685473902.131 [Radio_Surface] Hardware Fault, FailCount= 1 2023-05-30T19:11:42.131Z,1685473902.131 [Radio_Surface](ERROR): Hardware Fault 2023-05-30T19:11:42.237Z,1685473902.237 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated. 2023-05-30T19:11:42.237Z,1685473902.237 [Power24vConverter] Hardware Fault, FailCount= 1 2023-05-30T19:11:42.237Z,1685473902.237 [Power24vConverter](ERROR): Hardware Fault 2023-05-30T19:11:42.237Z,1685473902.237 [Power24vConverter](INFO): Powering down. 2023-05-30T19:11:42.238Z,1685473902.238 [Power24vConverter](FAULT): 24V Power is reporting not powering/powered. 2023-05-30T19:11:42.255Z,1685473902.255 [CBIT](ERROR): Hardware Fault in component: Power24vConverter 2023-05-30T19:11:42.255Z,1685473902.255 [CBIT](ERROR): Hardware Fault in component: Radio_Surface 2023-05-30T19:11:42.535Z,1685473902.535 [Radio_Surface](INFO): Powering down 2023-05-30T19:11:42.637Z,1685473902.637 [NAL9602](FAULT): LCB fault: Current Limiter Activated. 2023-05-30T19:11:42.637Z,1685473902.637 [NAL9602] Hardware Fault, FailCount= 1 2023-05-30T19:11:42.637Z,1685473902.637 [NAL9602](ERROR): Hardware Fault 2023-05-30T19:11:42.638Z,1685473902.638 [Power24vConverter](INFO): Powering down. 2023-05-30T19:11:42.655Z,1685473902.655 [CBIT](ERROR): Hardware Fault in component: NAL9602 2023-05-30T19:11:42.939Z,1685473902.939 [Radio_Surface](FAULT): LCB fault: Current Limiter Activated. 2023-05-30T19:11:43.041Z,1685473903.041 [NAL9602](INFO): Powering down 2023-05-30T19:11:43.042Z,1685473903.042 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated. 2023-05-30T19:11:43.444Z,1685473903.444 [NAL9602](FAULT): LCB fault: Current Limiter Activated. 2023-05-30T19:11:43.444Z,1685473903.444 [Power24vConverter](INFO): Powering down. 2023-05-30T19:11:43.483Z,1685473903.483 [CBIT](INFO): Clearing failed state for component Radio_Surface 2023-05-30T19:11:43.483Z,1685473903.483 [Radio_Surface] No Fault, FailCount= 1 2023-05-30T19:11:43.747Z,1685473903.747 [Radio_Surface](INFO): Powering up 2023-05-30T19:11:43.852Z,1685473903.852 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated. 2023-05-30T19:11:43.869Z,1685473903.869 [CBIT](INFO): Clearing failed state for component NAL9602 2023-05-30T19:11:43.869Z,1685473903.869 [NAL9602] No Fault, FailCount= 1 2023-05-30T19:11:44.256Z,1685473904.256 [Power24vConverter](INFO): Powering down. 2023-05-30T19:11:44.659Z,1685473904.659 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated. 2023-05-30T19:11:45.060Z,1685473905.060 [Power24vConverter](INFO): Powering down. 2023-05-30T19:11:45.468Z,1685473905.468 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:11:45.872Z,1685473905.872 [Power24vConverter](INFO): Powering down. 2023-05-30T19:11:46.273Z,1685473906.273 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:11:46.676Z,1685473906.676 [Power24vConverter](INFO): Powering down. 2023-05-30T19:11:47.084Z,1685473907.084 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:11:47.488Z,1685473907.488 [Power24vConverter](INFO): Powering down. 2023-05-30T19:11:47.892Z,1685473907.892 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:11:48.296Z,1685473908.296 [Power24vConverter](INFO): Powering down. 2023-05-30T19:11:48.755Z,1685473908.755 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:11:49.112Z,1685473909.112 [Power24vConverter](INFO): Powering down. 2023-05-30T19:11:49.520Z,1685473909.520 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:11:49.924Z,1685473909.924 [Power24vConverter](INFO): Powering down. 2023-05-30T19:11:50.211Z,1685473910.211 [Radio_Surface](FAULT): LCB fault: Current Limiter Activated. 2023-05-30T19:11:50.211Z,1685473910.211 [Radio_Surface] Hardware Fault, FailCount= 2 2023-05-30T19:11:50.211Z,1685473910.211 [Radio_Surface](ERROR): Hardware Fault 2023-05-30T19:11:50.312Z,1685473910.312 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:11:50.349Z,1685473910.349 [CBIT](ERROR): Hardware Fault in component: Radio_Surface 2023-05-30T19:11:50.615Z,1685473910.615 [Radio_Surface](INFO): Powering down 2023-05-30T19:11:50.716Z,1685473910.716 [Power24vConverter](INFO): Powering down. 2023-05-30T19:11:51.019Z,1685473911.019 [Radio_Surface](FAULT): LCB fault: Current Limiter Activated. 2023-05-30T19:11:51.120Z,1685473911.120 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:11:51.525Z,1685473911.525 [Power24vConverter](INFO): Powering down. 2023-05-30T19:11:51.546Z,1685473911.546 [CBIT](INFO): Clearing failed state for component Radio_Surface 2023-05-30T19:11:51.546Z,1685473911.546 [Radio_Surface] No Fault, FailCount= 2 2023-05-30T19:11:51.827Z,1685473911.827 [Radio_Surface](INFO): Powering up 2023-05-30T19:11:51.928Z,1685473911.928 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:11:52.336Z,1685473912.336 [Power24vConverter](INFO): Powering down. 2023-05-30T19:11:52.777Z,1685473912.777 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:11:53.137Z,1685473913.137 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-05-30T19:11:53.145Z,1685473913.145 [Power24vConverter](INFO): Powering down. 2023-05-30T19:11:53.557Z,1685473913.557 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:11:53.964Z,1685473913.964 [Power24vConverter](INFO): Powering down. 2023-05-30T19:11:54.350Z,1685473914.350 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:11:54.754Z,1685473914.754 [Power24vConverter](INFO): Powering down. 2023-05-30T19:11:55.103Z,1685473915.103 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2023-05-30T19:11:55.158Z,1685473915.158 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:11:55.568Z,1685473915.568 [Power24vConverter](INFO): Powering down. 2023-05-30T19:11:55.968Z,1685473915.968 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:11:56.376Z,1685473916.376 [Power24vConverter](INFO): Powering down. 2023-05-30T19:11:56.780Z,1685473916.780 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:11:57.111Z,1685473917.111 [DataOverHttps](INFO): Radio surface powered ON. 2023-05-30T19:11:57.184Z,1685473917.184 [Power24vConverter](INFO): Powering down. 2023-05-30T19:11:57.588Z,1685473917.588 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:11:57.988Z,1685473917.988 [Power24vConverter](INFO): Powering down. 2023-05-30T19:11:58.397Z,1685473918.397 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:11:58.800Z,1685473918.800 [Power24vConverter](INFO): Powering down. 2023-05-30T19:11:59.204Z,1685473919.204 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:11:59.621Z,1685473919.621 [Power24vConverter](INFO): Powering down. 2023-05-30T19:12:00.010Z,1685473920.010 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:12:00.412Z,1685473920.412 [Power24vConverter](INFO): Powering down. 2023-05-30T19:12:00.820Z,1685473920.820 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:12:01.220Z,1685473921.220 [Power24vConverter](INFO): Powering down. 2023-05-30T19:12:01.625Z,1685473921.625 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:12:02.032Z,1685473922.032 [Power24vConverter](INFO): Powering down. 2023-05-30T19:12:02.490Z,1685473922.490 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:12:02.841Z,1685473922.841 [Power24vConverter](INFO): Powering down. 2023-05-30T19:12:03.249Z,1685473923.249 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:12:03.658Z,1685473923.658 [Power24vConverter](INFO): Powering down. 2023-05-30T19:12:04.048Z,1685473924.048 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:12:04.450Z,1685473924.450 [Power24vConverter](INFO): Powering down. 2023-05-30T19:12:04.858Z,1685473924.858 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:12:05.260Z,1685473925.260 [Power24vConverter](INFO): Powering down. 2023-05-30T19:12:05.668Z,1685473925.668 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:12:06.072Z,1685473926.072 [Power24vConverter](INFO): Powering down. 2023-05-30T19:12:06.474Z,1685473926.474 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:12:06.880Z,1685473926.880 [Power24vConverter](INFO): Powering down. 2023-05-30T19:12:07.285Z,1685473927.285 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:12:07.688Z,1685473927.688 [Power24vConverter](INFO): Powering down. 2023-05-30T19:12:08.092Z,1685473928.092 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:12:08.496Z,1685473928.496 [Power24vConverter](INFO): Powering down. 2023-05-30T19:12:08.900Z,1685473928.900 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:12:09.304Z,1685473929.304 [Power24vConverter](INFO): Powering down. 2023-05-30T19:12:09.750Z,1685473929.750 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:12:10.104Z,1685473930.104 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-05-30T19:12:10.128Z,1685473930.128 [Power24vConverter](INFO): Powering down. 2023-05-30T19:12:10.525Z,1685473930.525 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:12:10.928Z,1685473930.928 [Power24vConverter](INFO): Powering down. 2023-05-30T19:12:11.325Z,1685473931.325 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:12:11.729Z,1685473931.729 [Power24vConverter](INFO): Powering down. 2023-05-30T19:12:12.128Z,1685473932.128 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:12:12.536Z,1685473932.536 [Power24vConverter](INFO): Powering down. 2023-05-30T19:12:12.940Z,1685473932.940 [Power24vConverter](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-05-30T19:12:13.342Z,1685473933.342 [NAL9602](INFO): Powering up NAL9602 2023-05-30T19:12:13.344Z,1685473933.344 [Power24vConverter](INFO): Powering down. 2023-05-30T19:12:14.152Z,1685473934.152 [Power24vConverter](INFO): Powering up. 2023-05-30T19:12:14.169Z,1685473934.169 [CBIT](INFO): Clearing failed state for component Power24vConverter 2023-05-30T19:12:14.169Z,1685473934.169 [Power24vConverter] No Fault, FailCount= 1 2023-05-30T19:12:19.175Z,1685473939.175 [CommandExec](IMPORTANT): got command failComponent 2023-05-30T19:12:19.175Z,1685473939.175 [CommandExec](IMPORTANT): Failed components: 2023-05-30T19:12:19.176Z,1685473939.176 [CommandExec](IMPORTANT): AHRS_M2: Communications Fault 2023-05-30T19:12:19.176Z,1685473939.176 [CommandExec](IMPORTANT): DropWeight: Hardware Fault 2023-05-30T19:12:19.176Z,1685473939.176 [CommandExec](IMPORTANT): Rowe_600: Communications Fault 2023-05-30T19:12:19.176Z,1685473939.176 [CommandExec](IMPORTANT): Aanderaa_O2: Communications Fault 2023-05-30T19:12:19.176Z,1685473939.176 [CommandExec](IMPORTANT): CTD_Seabird: Communications Fault 2023-05-30T19:12:25.469Z,1685473945.469 [Startup:StartupSatComms:A](INFO): Timed out from 2023-05-30T19:11:25.3Z 2023-05-30T19:12:25.469Z,1685473945.469 [Startup:StartupSatComms:A] Stopped 2023-05-30T19:12:25.470Z,1685473945.470 [Startup:StartupSatComms:B] Running Loop=1 2023-05-30T19:12:25.883Z,1685473945.883 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2023-05-30T19:12:26.711Z,1685473946.711 [DAT](FAULT): failed to initialize, no bytes available on serial interface 2023-05-30T19:12:26.711Z,1685473946.711 [DAT] Communications Fault, FailCount= 3 2023-05-30T19:12:26.711Z,1685473946.711 [DAT](ERROR): Communications Fault 2023-05-30T19:12:26.732Z,1685473946.732 [CBIT](ERROR): Communications Fault in component: DAT 2023-05-30T19:12:27.073Z,1685473947.073 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-05-30T19:12:27.115Z,1685473947.115 [DAT](INFO): Powering down 2023-05-30T19:12:28.309Z,1685473948.309 [CBIT](INFO): Clearing failed state for component DAT 2023-05-30T19:12:28.309Z,1685473948.309 [DAT] No Fault, FailCount= 3 2023-05-30T19:12:30.175Z,1685473950.175 [DAT](INFO): Powering up 2023-05-30T19:12:30.175Z,1685473950.175 [DAT](DEBUG): Initializing DAT. 2023-05-30T19:12:33.945Z,1685473953.945 [NAL9602](ERROR): NAL9602 initialization error. 2023-05-30T19:12:33.945Z,1685473953.945 [NAL9602] Communications Fault, FailCount= 2 2023-05-30T19:12:33.945Z,1685473953.945 [NAL9602](ERROR): Communications Fault 2023-05-30T19:12:33.964Z,1685473953.964 [CBIT](ERROR): Communications Fault in component: NAL9602 2023-05-30T19:12:34.368Z,1685473954.368 [NAL9602](INFO): Powering down 2023-05-30T19:12:35.188Z,1685473955.188 [CBIT](INFO): Clearing failed state for component NAL9602 2023-05-30T19:12:35.189Z,1685473955.189 [NAL9602] No Fault, FailCount= 2 2023-05-30T19:12:52.379Z,1685473972.379 [CommandExec](IMPORTANT): got command quit 2023-05-30T19:12:53.383Z,1685473973.383 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2023-05-30T19:12:53.383Z,1685473973.383 [CommandExec](INFO): Uninitializing the command executive. 2023-05-30T19:12:53.383Z,1685473973.383 [CommandExec](INFO): Uninitializing the command scheduler. 2023-05-30T19:12:53.383Z,1685473973.383 [CommandExec ThreadHandler](INFO): Thread cancelled. 2023-05-30T19:12:53.547Z,1685473973.547 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2023-05-30T19:12:53.547Z,1685473973.547 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2023-05-30T19:12:53.547Z,1685473973.547 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-05-30T19:12:53.548Z,1685473973.548 [NavChartDb](INFO): Join timeout helper Thread ID is 7916 2023-05-30T19:12:53.819Z,1685473973.819 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2023-05-30T19:12:53.819Z,1685473973.819 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-05-30T19:12:53.831Z,1685473973.831 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2023-05-30T19:12:53.831Z,1685473973.831 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-05-30T19:12:53.831Z,1685473973.831 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 7917 2023-05-30T19:12:54.165Z,1685473974.165 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2023-05-30T19:12:54.165Z,1685473974.165 [Aanderaa_O2] No Fault, FailCount= 3 2023-05-30T19:12:54.299Z,1685473974.299 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2023-05-30T19:12:54.299Z,1685473974.299 [WetLabsBB2FL](INFO): Powering down 2023-05-30T19:12:54.300Z,1685473974.300 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-05-30T19:12:54.317Z,1685473974.317 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2023-05-30T19:12:54.317Z,1685473974.317 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-05-30T19:12:54.317Z,1685473974.317 [CTD_Seabird](INFO): Join timeout helper Thread ID is 7918 2023-05-30T19:12:54.411Z,1685473974.411 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2023-05-30T19:12:54.411Z,1685473974.411 [CTD_Seabird](INFO): Powering down 2023-05-30T19:12:54.423Z,1685473974.423 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-05-30T19:12:54.435Z,1685473974.435 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2023-05-30T19:12:54.435Z,1685473974.435 [DAT ThreadHandler](INFO): Thread cancelled. 2023-05-30T19:12:54.435Z,1685473974.435 [DAT](INFO): Join timeout helper Thread ID is 7919 2023-05-30T19:12:54.631Z,1685473974.631 [DAT](INFO): Powering down 2023-05-30T19:12:54.703Z,1685473974.703 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2023-05-30T19:12:54.703Z,1685473974.703 [DAT](INFO): Powering down 2023-05-30T19:12:54.704Z,1685473974.704 [DAT ThreadHandler](INFO): Thread cancelled. 2023-05-30T19:12:54.723Z,1685473974.723 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2023-05-30T19:12:54.723Z,1685473974.723 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-05-30T19:12:54.724Z,1685473974.724 [Radio_Surface](INFO): Join timeout helper Thread ID is 7921 2023-05-30T19:12:54.851Z,1685473974.851 [Radio_Surface](INFO): Powering down 2023-05-30T19:12:54.851Z,1685473974.851 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2023-05-30T19:12:54.852Z,1685473974.852 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-05-30T19:12:54.863Z,1685473974.863 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2023-05-30T19:12:54.864Z,1685473974.864 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-05-30T19:12:54.864Z,1685473974.864 [Onboard](INFO): Join timeout helper Thread ID is 7922 2023-05-30T19:12:56.607Z,1685473976.607 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2023-05-30T19:12:56.607Z,1685473976.607 [CTD_Seabird] No Fault, FailCount= 3 2023-05-30T19:12:59.399Z,1685473979.399 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2023-05-30T19:12:59.647Z,1685473979.647 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2023-05-30T19:12:59.647Z,1685473979.647 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-05-30T19:12:59.668Z,1685473979.668 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2023-05-30T19:12:59.668Z,1685473979.668 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-05-30T19:12:59.669Z,1685473979.669 [DataOverHttps](INFO): Join timeout helper Thread ID is 7923 2023-05-30T19:13:00.403Z,1685473980.403 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2023-05-30T19:13:00.403Z,1685473980.403 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-05-30T19:13:00.415Z,1685473980.415 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2023-05-30T19:13:00.415Z,1685473980.415 [logger ThreadHandler](INFO): Thread cancelled. 2023-05-30T19:13:00.416Z,1685473980.416 [logger](INFO): Join timeout helper Thread ID is 7924 2023-05-30T19:13:00.443Z,1685473980.443 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2023-05-30T19:13:00.443Z,1685473980.443 [logger ThreadHandler](INFO): Thread cancelled. 2023-05-30T19:13:00.455Z,1685473980.455 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2023-05-30T19:13:00.455Z,1685473980.455 [CommandLine ThreadHandler](INFO): Thread cancelled. 2023-05-30T19:13:00.456Z,1685473980.456 [CommandLine](INFO): Join timeout helper Thread ID is 7925 2023-05-30T19:13:00.539Z,1685473980.539 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2023-05-30T19:13:00.539Z,1685473980.539 [CommandLine ThreadHandler](INFO): Thread cancelled. 2023-05-30T19:13:00.555Z,1685473980.555 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2023-05-30T19:13:00.555Z,1685473980.555 [CommandExec ThreadHandler](INFO): Thread cancelled. 2023-05-30T19:13:00.556Z,1685473980.556 [CommandExec](INFO): Join timeout helper Thread ID is 7926 2023-05-30T19:13:00.557Z,1685473980.557 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2023-05-30T19:13:00.557Z,1685473980.557 [controlThread ThreadHandler](INFO): Thread cancelled. 2023-05-30T19:13:00.557Z,1685473980.557 [controlThread](INFO): Join timeout helper Thread ID is 7927 2023-05-30T19:13:00.607Z,1685473980.607 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2023-05-30T19:13:00.607Z,1685473980.607 [controlThread](DEBUG): Uninitializing ControlThread 2023-05-30T19:13:00.607Z,1685473980.607 [AHRS_M2](INFO): Powering down 2023-05-30T19:13:00.609Z,1685473980.609 [NAL9602](INFO): Powering down 2023-05-30T19:13:00.611Z,1685473980.611 [Rowe_600](INFO): Powering down 2023-05-30T19:13:00.731Z,1685473980.731 [Aanderaa_O2](INFO): Powering down 2023-05-30T19:13:00.733Z,1685473980.733 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2023-05-30T19:13:00.734Z,1685473980.734 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2023-05-30T19:13:00.735Z,1685473980.735 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2023-05-30T19:13:00.736Z,1685473980.736 [MissionManager](INFO): Uninitializing Mission Default 2023-05-30T19:13:00.738Z,1685473980.738 [MissionManager](INFO): Uninitializing Mission Startup 2023-05-30T19:13:00.738Z,1685473980.738 [Startup] Stopped 2023-05-30T19:13:00.738Z,1685473980.738 [Startup](DEBUG): Aggregate::uninitialize Startup 2023-05-30T19:13:00.738Z,1685473980.738 [Startup:A.GoToSurface] Stopped 2023-05-30T19:13:00.738Z,1685473980.738 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2023-05-30T19:13:00.739Z,1685473980.739 [Startup:StartupSatComms] Stopped 2023-05-30T19:13:00.739Z,1685473980.739 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2023-05-30T19:13:00.739Z,1685473980.739 [Startup:StartupSatComms:B] Stopped 2023-05-30T19:13:00.740Z,1685473980.740 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2023-05-30T19:13:00.741Z,1685473980.741 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2023-05-30T19:13:00.741Z,1685473980.741 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2023-05-30T19:13:00.741Z,1685473980.741 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2023-05-30T19:13:00.741Z,1685473980.741 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2023-05-30T19:13:00.742Z,1685473980.742 [BuoyancyServo](INFO): Powering down 2023-05-30T19:13:00.755Z,1685473980.755 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2023-05-30T19:13:00.755Z,1685473980.755 [ElevatorServo](INFO): Powering down 2023-05-30T19:13:00.756Z,1685473980.756 [MassServo](DEBUG): Uninitialize Mass Servo. 2023-05-30T19:13:00.756Z,1685473980.756 [MassServo](INFO): Powering down 2023-05-30T19:13:00.757Z,1685473980.757 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2023-05-30T19:13:00.757Z,1685473980.757 [RudderServo](INFO): Powering down 2023-05-30T19:13:00.758Z,1685473980.758 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2023-05-30T19:13:00.758Z,1685473980.758 [ThrusterHE](INFO): Powering down 2023-05-30T19:13:00.759Z,1685473980.759 [SBIT](DEBUG): Uninitialize SBIT Component. 2023-05-30T19:13:00.759Z,1685473980.759 [IBIT](DEBUG): Uninitialize IBIT Component. 2023-05-30T19:13:00.759Z,1685473980.759 [CBIT](DEBUG): Uninitialize CBIT Component. 2023-05-30T19:13:00.759Z,1685473980.759 [CBIT](DEBUG): Powering off loads. 2023-05-30T19:13:00.770Z,1685473980.770 [CBIT](DEBUG): Disabling WDT. 2023-05-30T19:13:00.782Z,1685473980.782 [CBIT](DEBUG): Opening all GF detection circuits. 2023-05-30T19:13:00.783Z,1685473980.783 [controlThread ThreadHandler](INFO): Thread cancelled. 2023-05-30T19:13:00.814Z,1685473980.814 [DAT ThreadHandler](INFO): Thread cancelled. 2023-05-30T19:13:00.820Z,1685473980.820 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-05-30T19:13:00.822Z,1685473980.822 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-05-30T19:13:00.828Z,1685473980.828 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-05-30T19:13:00.957Z,1685473980.957 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-05-30T19:13:00.962Z,1685473980.962 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-05-30T19:13:00.971Z,1685473980.971 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-05-30T19:13:01.017Z,1685473981.017 [logger ThreadHandler](INFO): Thread cancelled.