2019-02-22T23:57:06.747Z,1550879826.747 [Supervisor](DEBUG): Initializing supervisor. 2019-02-22T23:57:06.750Z,1550879826.750 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2019-02-22T23:57:06.751Z,1550879826.751 [SyncHandler](INFO): Protected caller Thread ID is 2674 2019-02-22T23:57:06.752Z,1550879826.752 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2019-02-22T23:57:06.752Z,1550879826.752 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2019-02-22T23:57:06.753Z,1550879826.753 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 2675 2019-02-22T23:57:06.756Z,1550879826.756 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2019-02-22T23:57:06.768Z,1550879826.768 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2019-02-22T23:57:06.769Z,1550879826.769 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2019-02-22T23:57:06.769Z,1550879826.769 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 2676 2019-02-22T23:57:06.770Z,1550879826.770 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2019-02-22T23:57:06.771Z,1550879826.771 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2019-02-22T23:57:06.771Z,1550879826.771 [logger ThreadHandler](INFO): Protected caller Thread ID is 2677 2019-02-22T23:57:06.773Z,1550879826.773 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2019-02-22T23:57:06.773Z,1550879826.773 [Supervisor](INFO): Looking for Config files in directory: Config/ 2019-02-22T23:57:06.775Z,1550879826.775 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2019-02-22T23:57:07.196Z,1550879827.196 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2019-02-22T23:57:07.197Z,1550879827.197 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2019-02-22T23:57:07.337Z,1550879827.337 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2019-02-22T23:57:07.338Z,1550879827.338 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2019-02-22T23:57:07.416Z,1550879827.416 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2019-02-22T23:57:07.512Z,1550879827.512 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2019-02-22T23:57:07.513Z,1550879827.513 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2019-02-22T23:57:07.606Z,1550879827.606 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2019-02-22T23:57:07.606Z,1550879827.606 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2019-02-22T23:57:07.985Z,1550879827.985 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2019-02-22T23:57:07.986Z,1550879827.986 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2019-02-22T23:57:08.173Z,1550879828.173 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2019-02-22T23:57:08.174Z,1550879828.174 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2019-02-22T23:57:08.720Z,1550879828.720 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2019-02-22T23:57:08.720Z,1550879828.720 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2019-02-22T23:57:08.914Z,1550879828.914 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2019-02-22T23:57:08.915Z,1550879828.915 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2019-02-22T23:57:09.213Z,1550879829.213 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2019-02-22T23:57:09.214Z,1550879829.214 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2019-02-22T23:57:09.420Z,1550879829.420 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2019-02-22T23:57:09.420Z,1550879829.420 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2019-02-22T23:57:09.559Z,1550879829.559 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2019-02-22T23:57:09.559Z,1550879829.559 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2019-02-22T23:57:10.037Z,1550879830.037 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2019-02-22T23:57:10.037Z,1550879830.037 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2019-02-22T23:57:10.365Z,1550879830.365 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2019-02-22T23:57:10.365Z,1550879830.365 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2019-02-22T23:57:10.568Z,1550879830.568 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2019-02-22T23:57:10.570Z,1550879830.570 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/ 2019-02-22T23:57:10.571Z,1550879830.571 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/vehicle.cfg 2019-02-22T23:57:10.742Z,1550879830.742 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/secure.cfg 2019-02-22T23:57:10.868Z,1550879830.868 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Science.cfg 2019-02-22T23:57:10.979Z,1550879830.979 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Simulator.cfg 2019-02-22T23:57:11.065Z,1550879831.065 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Battery.cfg 2019-02-22T23:57:11.293Z,1550879831.293 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2019-02-22T23:57:11.294Z,1550879831.294 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/logger.cfg 2019-02-22T23:57:11.390Z,1550879831.390 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Servo.cfg 2019-02-22T23:57:11.496Z,1550879831.496 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Navigation.cfg 2019-02-22T23:57:11.591Z,1550879831.591 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Sensor.cfg 2019-02-22T23:57:11.738Z,1550879831.738 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Control.cfg 2019-02-22T23:57:11.836Z,1550879831.836 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/BIT.cfg 2019-02-22T23:57:11.933Z,1550879831.933 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2019-02-22T23:57:11.939Z,1550879831.939 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2019-02-22T23:57:11.952Z,1550879831.952 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2019-02-22T23:57:11.953Z,1550879831.953 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2019-02-22T23:57:12.018Z,1550879832.018 [VerticalControl](DEBUG): Construct VerticalControl. 2019-02-22T23:57:12.129Z,1550879832.129 [VerticalControl] Loaded 2019-02-22T23:57:12.129Z,1550879832.129 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2019-02-22T23:57:12.130Z,1550879832.130 [HorizontalControl](DEBUG): Construct HorizontalControl. 2019-02-22T23:57:12.197Z,1550879832.197 [HorizontalControl] Loaded 2019-02-22T23:57:12.197Z,1550879832.197 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2019-02-22T23:57:12.197Z,1550879832.197 [SpeedControl](DEBUG): Construct SpeedControl. 2019-02-22T23:57:12.203Z,1550879832.203 [SpeedControl] Loaded 2019-02-22T23:57:12.203Z,1550879832.203 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2019-02-22T23:57:12.204Z,1550879832.204 [LoopControl](DEBUG): Construct LoopControl. 2019-02-22T23:57:12.204Z,1550879832.204 [LoopControl] Loaded 2019-02-22T23:57:12.204Z,1550879832.204 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2019-02-22T23:57:12.205Z,1550879832.205 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2019-02-22T23:57:12.205Z,1550879832.205 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2019-02-22T23:57:12.319Z,1550879832.319 [ElevatorServo] Loaded 2019-02-22T23:57:12.320Z,1550879832.320 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2019-02-22T23:57:12.330Z,1550879832.330 [MassServo] Loaded 2019-02-22T23:57:12.330Z,1550879832.330 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2019-02-22T23:57:12.341Z,1550879832.341 [RudderServo] Loaded 2019-02-22T23:57:12.342Z,1550879832.342 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2019-02-22T23:57:12.342Z,1550879832.342 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2019-02-22T23:57:12.343Z,1550879832.343 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2019-02-22T23:57:12.382Z,1550879832.382 [DepthRateCalculator] Loaded 2019-02-22T23:57:12.382Z,1550879832.382 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2019-02-22T23:57:12.387Z,1550879832.387 [PitchRateCalculator] Loaded 2019-02-22T23:57:12.387Z,1550879832.387 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2019-02-22T23:57:12.402Z,1550879832.402 [SpeedCalculator] Loaded 2019-02-22T23:57:12.402Z,1550879832.402 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2019-02-22T23:57:12.423Z,1550879832.423 [TempGradientCalculator] Loaded 2019-02-22T23:57:12.423Z,1550879832.423 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2019-02-22T23:57:12.428Z,1550879832.428 [YawRateCalculator] Loaded 2019-02-22T23:57:12.428Z,1550879832.428 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2019-02-22T23:57:12.456Z,1550879832.456 [ElevatorOffsetCalculator] Loaded 2019-02-22T23:57:12.457Z,1550879832.457 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2019-02-22T23:57:12.457Z,1550879832.457 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2019-02-22T23:57:12.458Z,1550879832.458 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2019-02-22T23:57:12.558Z,1550879832.558 [DeadReckonUsingMultipleVelocitySources] Loaded 2019-02-22T23:57:12.558Z,1550879832.558 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2019-02-22T23:57:12.616Z,1550879832.616 [DeadReckonUsingSpeedCalculator] Loaded 2019-02-22T23:57:12.616Z,1550879832.616 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2019-02-22T23:57:12.632Z,1550879832.632 [NavChart] Loaded 2019-02-22T23:57:12.632Z,1550879832.632 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2019-02-22T23:57:12.636Z,1550879832.636 [UniversalFixResidualReporter] Loaded 2019-02-22T23:57:12.636Z,1550879832.636 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2019-02-22T23:57:12.637Z,1550879832.637 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2019-02-22T23:57:12.637Z,1550879832.637 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2019-02-22T23:57:12.937Z,1550879832.937 [DataOverHttps] Loaded 2019-02-22T23:57:12.937Z,1550879832.937 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2019-02-22T23:57:12.938Z,1550879832.938 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 407F54E0 2019-02-22T23:57:12.939Z,1550879832.939 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 2756 2019-02-22T23:57:12.952Z,1550879832.952 [Depth_Keller] Loaded 2019-02-22T23:57:12.952Z,1550879832.952 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2019-02-22T23:57:12.957Z,1550879832.957 [DropWeight] Loaded 2019-02-22T23:57:12.957Z,1550879832.957 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2019-02-22T23:57:13.051Z,1550879833.051 [NAL9602] Loaded 2019-02-22T23:57:13.052Z,1550879833.052 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2019-02-22T23:57:13.067Z,1550879833.067 [Onboard] Loaded 2019-02-22T23:57:13.068Z,1550879833.068 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2019-02-22T23:57:13.071Z,1550879833.071 [Radio_Surface] Loaded 2019-02-22T23:57:13.071Z,1550879833.071 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2019-02-22T23:57:13.072Z,1550879833.072 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408254E0 2019-02-22T23:57:13.072Z,1550879833.072 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 2757 2019-02-22T23:57:15.249Z,1550879835.249 [BPC1] Loaded 2019-02-22T23:57:15.249Z,1550879835.249 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2019-02-22T23:57:15.250Z,1550879835.250 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2019-02-22T23:57:15.250Z,1550879835.250 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2019-02-22T23:57:15.312Z,1550879835.312 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2019-02-22T23:57:15.312Z,1550879835.312 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2019-02-22T23:57:15.406Z,1550879835.406 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2019-02-22T23:57:15.407Z,1550879835.407 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2019-02-22T23:57:15.432Z,1550879835.432 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2019-02-22T23:57:15.433Z,1550879835.433 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2019-02-22T23:57:15.674Z,1550879835.674 [CTD_NeilBrown] Loaded 2019-02-22T23:57:15.675Z,1550879835.675 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread. 2019-02-22T23:57:15.676Z,1550879835.676 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 409B04E0 2019-02-22T23:57:15.676Z,1550879835.676 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 2758 2019-02-22T23:57:15.685Z,1550879835.685 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density 2019-02-22T23:57:15.690Z,1550879835.690 [CTD_Seabird](INFO): created writer for : sea_water_density 2019-02-22T23:57:15.692Z,1550879835.692 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth 2019-02-22T23:57:15.696Z,1550879835.696 [CTD_Seabird](INFO): created writer for : depth 2019-02-22T23:57:15.697Z,1550879835.697 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure 2019-02-22T23:57:15.702Z,1550879835.702 [CTD_Seabird](INFO): created writer for : sea_water_pressure 2019-02-22T23:57:15.702Z,1550879835.702 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity 2019-02-22T23:57:15.707Z,1550879835.707 [CTD_Seabird](INFO): created writer for : sea_water_salinity 2019-02-22T23:57:15.708Z,1550879835.708 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature 2019-02-22T23:57:15.713Z,1550879835.713 [CTD_Seabird](INFO): created writer for : sea_water_temperature 2019-02-22T23:57:15.713Z,1550879835.713 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity 2019-02-22T23:57:15.718Z,1550879835.718 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity 2019-02-22T23:57:15.719Z,1550879835.719 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water 2019-02-22T23:57:15.724Z,1550879835.724 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water 2019-02-22T23:57:15.749Z,1550879835.749 [CTD_Seabird] Loaded 2019-02-22T23:57:15.750Z,1550879835.750 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2019-02-22T23:57:15.751Z,1550879835.751 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 409E04E0 2019-02-22T23:57:15.751Z,1550879835.751 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 2759 2019-02-22T23:57:15.799Z,1550879835.799 [WetLabsBB2FL] Loaded 2019-02-22T23:57:15.799Z,1550879835.799 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2019-02-22T23:57:15.800Z,1550879835.800 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A104E0 2019-02-22T23:57:15.801Z,1550879835.801 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 2760 2019-02-22T23:57:15.801Z,1550879835.801 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2019-02-22T23:57:15.802Z,1550879835.802 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2019-02-22T23:57:16.025Z,1550879836.025 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2019-02-22T23:57:16.025Z,1550879836.025 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2019-02-22T23:57:16.155Z,1550879836.155 [SBIT](DEBUG): Construct Startup Built In Test. 2019-02-22T23:57:16.166Z,1550879836.166 [SBIT] Loaded 2019-02-22T23:57:16.166Z,1550879836.166 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2019-02-22T23:57:16.167Z,1550879836.167 [IBIT](DEBUG): Construct Initiated Built In Test. 2019-02-22T23:57:16.178Z,1550879836.178 [IBIT] Loaded 2019-02-22T23:57:16.179Z,1550879836.179 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2019-02-22T23:57:16.182Z,1550879836.182 [CBIT](DEBUG): Construct Continuous Built In Test. 2019-02-22T23:57:16.315Z,1550879836.315 [CBIT] Loaded 2019-02-22T23:57:16.315Z,1550879836.315 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2019-02-22T23:57:16.316Z,1550879836.316 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2019-02-22T23:57:16.319Z,1550879836.319 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2019-02-22T23:57:16.320Z,1550879836.320 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2019-02-22T23:57:16.327Z,1550879836.327 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2019-02-22T23:57:16.328Z,1550879836.328 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40ADD4E0 2019-02-22T23:57:16.328Z,1550879836.328 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 2761 2019-02-22T23:57:16.333Z,1550879836.333 [Supervisor](INFO): Main Thread ID is 2429 2019-02-22T23:57:16.333Z,1550879836.333 [Supervisor](DEBUG): Running supervisor. 2019-02-22T23:57:16.333Z,1550879836.333 [CommandLine ThreadHandler](INFO): Handler Thread ID is 2762 2019-02-22T23:57:16.336Z,1550879836.336 [controlThread ThreadHandler](INFO): Handler Thread ID is 2763 2019-02-22T23:57:16.336Z,1550879836.336 [controlThread](DEBUG): Initializing ControlThread 2019-02-22T23:57:16.337Z,1550879836.337 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2019-02-22T23:57:16.339Z,1550879836.339 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2019-02-22T23:57:16.339Z,1550879836.339 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2019-02-22T23:57:16.340Z,1550879836.340 [LoopControl](DEBUG): Initialize LoopControlComponent. 2019-02-22T23:57:16.341Z,1550879836.341 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2019-02-22T23:57:16.341Z,1550879836.341 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2019-02-22T23:57:16.341Z,1550879836.341 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2019-02-22T23:57:16.342Z,1550879836.342 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2019-02-22T23:57:16.342Z,1550879836.342 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2019-02-22T23:57:16.343Z,1550879836.343 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2019-02-22T23:57:16.344Z,1550879836.344 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2019-02-22T23:57:16.344Z,1550879836.344 [NavChart](DEBUG): Initialize NavChart Navigation. 2019-02-22T23:57:16.344Z,1550879836.344 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2019-02-22T23:57:16.348Z,1550879836.348 [SBIT](INFO): Initialize SBIT Component. 2019-02-22T23:57:16.349Z,1550879836.349 [SBIT](IMPORTANT): git: 2019-02-11-73-gd81f403 2019-02-22T23:57:16.349Z,1550879836.349 [SBIT](INFO): git hash: d81f403ba8dd4609f3c9691256c8521b6bd69743 2019-02-22T23:57:16.349Z,1550879836.349 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2019-02-22T23:57:16.350Z,1550879836.350 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018 Kernel Reported: #1 PREEMPT Tue Dec 18 21:19:28 PST 2018 2019-02-22T23:57:16.351Z,1550879836.351 [SBIT](INFO): Beginning SBIT in 28.000000 seconds. 2019-02-22T23:57:16.352Z,1550879836.352 [IBIT](INFO): Initialize IBIT Component. 2019-02-22T23:57:16.353Z,1550879836.353 [CBIT](DEBUG): Initialize CBIT Component. 2019-02-22T23:57:16.354Z,1550879836.354 [logger ThreadHandler](INFO): Handler Thread ID is 2764 2019-02-22T23:57:16.366Z,1550879836.366 [CBIT](DEBUG): Initialized mux pins. 2019-02-22T23:57:16.366Z,1550879836.366 [CBIT](DEBUG): Initializing the watchdog timer. 2019-02-22T23:57:16.371Z,1550879836.371 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 2765 2019-02-22T23:57:16.372Z,1550879836.372 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2019-02-22T23:57:16.379Z,1550879836.379 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 2766 2019-02-22T23:57:16.387Z,1550879836.387 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 2767 2019-02-22T23:57:16.390Z,1550879836.390 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2019-02-22T23:57:16.390Z,1550879836.390 [CBIT](DEBUG): Initializing heartbeat. 2019-02-22T23:57:16.399Z,1550879836.399 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 2768 2019-02-22T23:57:16.399Z,1550879836.399 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2019-02-22T23:57:16.403Z,1550879836.403 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20 2019-02-22T23:57:16.404Z,1550879836.404 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 2770 2019-02-22T23:57:16.405Z,1550879836.405 [WetLabsBB2FL](INFO): Powering down 2019-02-22T23:57:16.451Z,1550879836.451 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 2771 2019-02-22T23:57:16.453Z,1550879836.453 [NavChartDb](FAULT): Change detected in ENC collection. Wiping NavChart Directory 2019-02-22T23:57:16.460Z,1550879836.460 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2019-02-22T23:57:16.461Z,1550879836.461 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US1WC07M.000 2019-02-22T23:57:16.461Z,1550879836.461 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2019-02-22T23:57:16.462Z,1550879836.462 [CBIT](DEBUG): Deactivating GF circuits. 2019-02-22T23:57:16.462Z,1550879836.462 [CBIT](DEBUG): Deactivating emergency mode. 2019-02-22T23:57:16.463Z,1550879836.463 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US2WC11M.000 2019-02-22T23:57:16.463Z,1550879836.463 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2019-02-22T23:57:16.465Z,1550879836.465 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US3CA52M.000 2019-02-22T23:57:16.465Z,1550879836.465 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2019-02-22T23:57:16.466Z,1550879836.466 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US4CA60M.000 2019-02-22T23:57:16.467Z,1550879836.467 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2019-02-22T23:57:16.468Z,1550879836.468 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US5CA50M.000 2019-02-22T23:57:16.468Z,1550879836.468 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2019-02-22T23:57:16.470Z,1550879836.470 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US5CA61M.000 2019-02-22T23:57:16.470Z,1550879836.470 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2019-02-22T23:57:16.472Z,1550879836.472 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US5CA62M.000 2019-02-22T23:57:16.472Z,1550879836.472 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2019-02-22T23:57:16.473Z,1550879836.473 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US5CA83M.000 2019-02-22T23:57:16.499Z,1550879836.499 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2019-02-22T23:57:16.528Z,1550879836.528 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2019-02-22T23:57:16.538Z,1550879836.538 [MissionManager](DEBUG): 2019-02-22T23:57:16.539Z,1550879836.539 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2019-02-22T23:57:16.559Z,1550879836.559 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US5CA83M.000 2019-02-22T23:57:16.614Z,1550879836.614 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2019-02-22T23:57:16.615Z,1550879836.615 [Default:A.Wait](DEBUG): Construct Wait. 2019-02-22T23:57:16.617Z,1550879836.617 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2019-02-22T23:57:16.706Z,1550879836.706 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2019-02-22T23:57:16.709Z,1550879836.709 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2019-02-22T23:57:16.727Z,1550879836.727 [Default:E.Execute](DEBUG): Construct Execute. 2019-02-22T23:57:16.730Z,1550879836.730 [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 2019-02-22T23:57:16.741Z,1550879836.741 [controlThread](DEBUG): Component order: CycleStarter,Depth_Keller,DropWeight,NAL9602,Onboard,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,ElevatorServo,MassServo,RudderServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2019-02-22T23:57:16.760Z,1550879836.760 [Depth_Keller](ERROR): Pressure reading out of range: 1628.471313 decibar 2019-02-22T23:57:16.782Z,1550879836.782 [Radio_Surface](INFO): Powering up 2019-02-22T23:57:16.826Z,1550879836.826 [DepthRateCalculator](ERROR): Depth measurement is not active 2019-02-22T23:57:16.851Z,1550879836.851 [ElevatorServo](DEBUG): Initializing EZServoServo. 2019-02-22T23:57:16.859Z,1550879836.859 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2019-02-22T23:57:16.860Z,1550879836.860 [MassServo](DEBUG): Initializing EZServoServo. 2019-02-22T23:57:16.867Z,1550879836.867 [MassServo](DEBUG): Initializing MassServo. 2019-02-22T23:57:16.867Z,1550879836.867 [RudderServo](DEBUG): Initializing EZServoServo. 2019-02-22T23:57:16.894Z,1550879836.894 [RudderServo](DEBUG): Initializing RudderServo. 2019-02-22T23:57:17.164Z,1550879837.164 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2019-02-22T23:57:17.164Z,1550879837.164 [DropWeight] Hardware Fault, FailCount= 1 2019-02-22T23:57:17.164Z,1550879837.164 [DropWeight](ERROR): Hardware Fault 2019-02-22T23:57:17.223Z,1550879837.223 [CommandLine](FAULT): Scheduling is paused 2019-02-22T23:57:17.224Z,1550879837.224 [CBIT](INFO): Critical error at 20190222T235717 2019-02-22T23:57:17.224Z,1550879837.224 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2019-02-22T23:57:17.227Z,1550879837.227 [CBIT](ERROR): Hardware Fault in component: DropWeight 2019-02-22T23:57:17.227Z,1550879837.227 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2019-02-22T23:57:17.620Z,1550879837.620 [CBIT](INFO): Critical error at 20190222T235717 2019-02-22T23:57:21.259Z,1550879841.259 [RudderServo](FAULT): Overload Error 2019-02-22T23:57:21.259Z,1550879841.259 [RudderServo] Hardware Fault, FailCount= 1 2019-02-22T23:57:21.259Z,1550879841.259 [RudderServo](ERROR): Hardware Fault 2019-02-22T23:57:21.298Z,1550879841.298 [CBIT](ERROR): Hardware Fault in component: RudderServo 2019-02-22T23:57:21.639Z,1550879841.639 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2019-02-22T23:57:21.639Z,1550879841.639 [RudderServo](INFO): Powering down 2019-02-22T23:57:22.447Z,1550879842.447 [RudderServo](DEBUG): Initializing EZServoServo. 2019-02-22T23:57:22.567Z,1550879842.567 [RudderServo](DEBUG): Initializing RudderServo. 2019-02-22T23:57:22.571Z,1550879842.571 [CBIT](INFO): Clearing failed state for component RudderServo 2019-02-22T23:57:22.571Z,1550879842.571 [RudderServo] No Fault, FailCount= 1 2019-02-22T23:57:22.842Z,1550879842.842 [Radio_Surface](INFO): Powering down 2019-02-22T23:57:26.518Z,1550879846.518 [CBIT](CRITICAL): Environmental Failure. Press:14.965744 PSI. Humidity:24%. Temp:25 C. ABORTING MISSION 2019-02-22T23:57:26.958Z,1550879846.958 [RudderServo](FAULT): Overload Error 2019-02-22T23:57:26.958Z,1550879846.958 [RudderServo] Hardware Fault, FailCount= 2 2019-02-22T23:57:26.958Z,1550879846.958 [RudderServo](ERROR): Hardware Fault 2019-02-22T23:57:26.000Z,1550879847.000 [CBIT](INFO): Critical error at 20190222T235726 2019-02-22T23:57:27.002Z,1550879847.002 [CBIT](ERROR): Hardware Fault in component: RudderServo 2019-02-22T23:57:27.270Z,1550879847.270 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2019-02-22T23:57:27.270Z,1550879847.270 [RudderServo](INFO): Powering down 2019-02-22T23:57:28.082Z,1550879848.082 [RudderServo](DEBUG): Initializing EZServoServo. 2019-02-22T23:57:28.203Z,1550879848.203 [RudderServo](DEBUG): Initializing RudderServo. 2019-02-22T23:57:28.207Z,1550879848.207 [CBIT](INFO): Clearing failed state for component RudderServo 2019-02-22T23:57:28.207Z,1550879848.207 [RudderServo] No Fault, FailCount= 2 2019-02-22T23:57:30.450Z,1550879850.450 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2019-02-22T23:57:30.450Z,1550879850.450 [CTD_Seabird] Communications Fault, FailCount= 1 2019-02-22T23:57:30.450Z,1550879850.450 [CTD_Seabird](ERROR): Communications Fault 2019-02-22T23:57:30.530Z,1550879850.530 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2019-02-22T23:57:30.854Z,1550879850.854 [CTD_Seabird](INFO): Powering down 2019-02-22T23:57:31.445Z,1550879851.445 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US5CA83M.000 2019-02-22T23:57:32.974Z,1550879852.974 [RudderServo](FAULT): Overload Error 2019-02-22T23:57:32.975Z,1550879852.975 [RudderServo] Hardware Fault, FailCount= 3 2019-02-22T23:57:32.975Z,1550879852.975 [RudderServo](ERROR): Hardware Fault 2019-02-22T23:57:33.018Z,1550879853.018 [CBIT](ERROR): Hardware Fault in component: RudderServo 2019-02-22T23:57:33.018Z,1550879853.018 [CBIT](CRITICAL): Hardware Fault in component: RudderServo 2019-02-22T23:57:33.019Z,1550879853.019 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2019-02-22T23:57:33.019Z,1550879853.019 [CTD_Seabird] No Fault, FailCount= 1 2019-02-22T23:57:33.355Z,1550879853.355 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2019-02-22T23:57:33.355Z,1550879853.355 [RudderServo](INFO): Powering down 2019-02-22T23:57:33.357Z,1550879853.357 [CBIT](INFO): Critical error at 20190222T235733 2019-02-22T23:57:33.866Z,1550879853.866 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2019-02-22T23:57:33.875Z,1550879853.875 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20 2019-02-22T23:57:34.143Z,1550879854.143 [RudderServo](DEBUG): Initializing EZServoServo. 2019-02-22T23:57:34.259Z,1550879854.259 [RudderServo](DEBUG): Initializing RudderServo. 2019-02-22T23:57:43.416Z,1550879863.416 [NAL9602](INFO): Powering up NAL9602 2019-02-22T23:57:45.066Z,1550879865.066 [SBIT](IMPORTANT): Beginning Startup BIT 2019-02-22T23:57:45.071Z,1550879865.071 [CBIT](IMPORTANT): Beginning ground fault scan 2019-02-22T23:57:47.078Z,1550879867.078 [DataOverHttps](ERROR): Failed to read radio surface power status. Assuming ON. 2019-02-22T23:57:47.484Z,1550879867.484 [DataOverHttps](ERROR): Failed to read radio surface power status. Assuming ON. 2019-02-22T23:57:47.887Z,1550879867.887 [DataOverHttps](ERROR): Failed to read radio surface power status. Assuming ON. 2019-02-22T23:57:47.919Z,1550879867.919 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2019-02-22T23:57:47.920Z,1550879867.920 [CTD_Seabird] Communications Fault, FailCount= 2 2019-02-22T23:57:47.920Z,1550879867.920 [CTD_Seabird](ERROR): Communications Fault 2019-02-22T23:57:48.024Z,1550879868.024 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2019-02-22T23:57:48.290Z,1550879868.290 [DataOverHttps](ERROR): Failed to read radio surface power status. Assuming ON. 2019-02-22T23:57:48.326Z,1550879868.326 [CTD_Seabird](INFO): Powering down 2019-02-22T23:57:48.695Z,1550879868.695 [DataOverHttps](ERROR): Failed to read radio surface power status. Assuming ON. 2019-02-22T23:57:49.099Z,1550879869.099 [DataOverHttps](ERROR): Failed to read radio surface power status. Assuming ON. 2019-02-22T23:57:49.502Z,1550879869.502 [DataOverHttps](ERROR): Failed to read radio surface power status. Assuming ON. 2019-02-22T23:57:49.906Z,1550879869.906 [DataOverHttps](ERROR): Failed to read radio surface power status. Assuming ON. 2019-02-22T23:57:50.310Z,1550879870.310 [DataOverHttps](ERROR): Failed to read radio surface power status. Assuming ON. 2019-02-22T23:57:50.439Z,1550879870.439 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2019-02-22T23:57:50.439Z,1550879870.439 [CTD_Seabird] No Fault, FailCount= 2 2019-02-22T23:57:50.714Z,1550879870.714 [DataOverHttps](ERROR): Failed to read radio surface power status. Assuming ON. 2019-02-22T23:57:51.118Z,1550879871.118 [DataOverHttps](ERROR): Failed to read radio surface power status. Assuming ON. 2019-02-22T23:57:51.278Z,1550879871.278 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2019-02-22T23:57:51.280Z,1550879871.280 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20 2019-02-22T23:57:51.522Z,1550879871.522 [DataOverHttps](ERROR): Failed to read radio surface power status. Assuming ON. 2019-02-22T23:57:54.383Z,1550879874.383 [NAL9602](INFO): NAL9602 initialized 2019-02-22T23:57:55.202Z,1550879875.202 [NAL9602](DEBUG): Fix Requested 2019-02-22T23:57:56.091Z,1550879876.091 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.009333 CHAN A1 (24V): 0.002563 CHAN A2 (12V): -0.067986 CHAN A3 (5V): -0.002534 CHAN B0 (3.3V): 0.000026 CHAN B1 (3.15aV): -0.001214 CHAN B2 (3.15bV): -0.001391 CHAN B3 (GND): -0.000233 OPEN: -0.001275 Full Scale Calc: 4.765 mA, -1.589 mA 2019-02-22T23:57:58.179Z,1550879878.179 [SBIT](ERROR): Could not read rudderAngleReader_. 2019-02-22T23:57:59.453Z,1550879879.453 [NavChartDb](INFO): # of records loaded: 5000 2019-02-22T23:58:05.330Z,1550879885.330 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2019-02-22T23:58:05.330Z,1550879885.330 [CTD_Seabird] Communications Fault, FailCount= 3 2019-02-22T23:58:05.330Z,1550879885.330 [CTD_Seabird](ERROR): Communications Fault 2019-02-22T23:58:05.587Z,1550879885.587 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2019-02-22T23:58:05.587Z,1550879885.587 [CBIT](FAULT): Communications Fault in component: CTD_Seabird 2019-02-22T23:58:05.734Z,1550879885.734 [CTD_Seabird](INFO): Powering down 2019-02-22T23:58:20.736Z,1550879900.736 [CommandLine](IMPORTANT): got command get depth 2019-02-22T23:58:20.736Z,1550879900.736 [CommandLine](IMPORTANT): depth 2.514373 m 2019-02-22T23:58:22.226Z,1550879902.226 [DataOverHttps](ERROR): Failed to read radio surface power status. Assuming ON. 2019-02-22T23:58:22.630Z,1550879902.630 [DataOverHttps](ERROR): Failed to read radio surface power status. Assuming ON. 2019-02-22T23:58:23.035Z,1550879903.035 [DataOverHttps](ERROR): Failed to read radio surface power status. Assuming ON. 2019-02-22T23:58:23.438Z,1550879903.438 [DataOverHttps](ERROR): Failed to read radio surface power status. Assuming ON. 2019-02-22T23:58:23.842Z,1550879903.842 [DataOverHttps](ERROR): Failed to read radio surface power status. Assuming ON. 2019-02-22T23:58:24.246Z,1550879904.246 [DataOverHttps](ERROR): Failed to read radio surface power status. Assuming ON. 2019-02-22T23:58:24.650Z,1550879904.650 [DataOverHttps](ERROR): Failed to read radio surface power status. Assuming ON. 2019-02-22T23:58:24.795Z,1550879904.795 [SBIT](ERROR): Could not read rudderAngleReader_. 2019-02-22T23:58:24.795Z,1550879904.795 [SBIT](FAULT): Control surface position failure. 2019-02-22T23:58:25.054Z,1550879905.054 [DataOverHttps](ERROR): Failed to read radio surface power status. Assuming ON. 2019-02-22T23:58:25.459Z,1550879905.459 [DataOverHttps](ERROR): Failed to read radio surface power status. Assuming ON. 2019-02-22T23:58:25.862Z,1550879905.862 [DataOverHttps](ERROR): Failed to read radio surface power status. Assuming ON. 2019-02-22T23:58:26.266Z,1550879906.266 [DataOverHttps](ERROR): Failed to read radio surface power status. Assuming ON. 2019-02-22T23:58:26.670Z,1550879906.670 [DataOverHttps](ERROR): Failed to read radio surface power status. Assuming ON. 2019-02-22T23:58:30.511Z,1550879910.511 [BPC1](ERROR): BPC1A: No match for serial number 0295 in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2019-02-22T23:58:30.927Z,1550879910.927 [BPC1](ERROR): BPC1B: No match for serial number 0202 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2019-02-22T23:58:30.928Z,1550879910.928 [BPC1](FAULT): Failed to parse data from all battery packs. 2019-02-22T23:58:30.928Z,1550879910.928 [BPC1] Data Fault, FailCount= 1 2019-02-22T23:58:30.928Z,1550879910.928 [BPC1](ERROR): Data Fault 2019-02-22T23:58:31.014Z,1550879911.014 [CBIT](ERROR): Data Fault in component: BPC1 2019-02-22T23:58:36.236Z,1550879916.236 [NavChartDb](INFO): # of records loaded: 10000 2019-02-22T23:58:38.211Z,1550879918.211 [SBIT](ERROR): Could not read rudderAngleReader_. 2019-02-22T23:58:38.211Z,1550879918.211 [SBIT](FAULT): Control surface position failure. 2019-02-22T23:58:38.604Z,1550879918.604 [SBIT](CRITICAL): SBIT FAILED 2019-02-22T23:58:38.640Z,1550879918.640 [CommandLine](IMPORTANT): got command configSet list 2019-02-22T23:58:38.640Z,1550879918.640 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2019-02-22T23:58:38.641Z,1550879918.641 [CommandLine](IMPORTANT): AHRS_M2.loadAtStartup=0 bool; 2019-02-22T23:58:38.641Z,1550879918.641 [CommandLine](IMPORTANT): Aanderaa_O2.loadAtStartup=0 bool; 2019-02-22T23:58:38.641Z,1550879918.641 [CommandLine](IMPORTANT): BuoyancyServo.loadAtStartup=0 bool; 2019-02-22T23:58:38.641Z,1550879918.641 [CommandLine](IMPORTANT): PAR_Licor.loadAtStartup=0 bool; 2019-02-22T23:58:38.641Z,1550879918.641 [CommandLine](IMPORTANT): ThrusterServo.loadAtStartup=0 bool; 2019-02-22T23:58:38.647Z,1550879918.647 [CBIT](INFO): Critical error at 20190222T235838 2019-02-22T23:58:39.014Z,1550879919.014 [MissionManager](IMPORTANT): Started mission Startup 2019-02-22T23:58:39.015Z,1550879919.015 [Startup] Running Loop=1 2019-02-22T23:58:39.015Z,1550879919.015 [Startup](DEBUG): Aggregate::initialize Startup 2019-02-22T23:58:39.015Z,1550879919.015 [Startup:A.GoToSurface] Running Loop=1 2019-02-22T23:58:39.015Z,1550879919.015 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2019-02-22T23:58:39.016Z,1550879919.016 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2019-02-22T23:58:39.016Z,1550879919.016 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2019-02-22T23:58:39.016Z,1550879919.016 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2019-02-22T23:58:39.017Z,1550879919.017 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2019-02-22T23:58:39.017Z,1550879919.017 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2019-02-22T23:58:39.614Z,1550879919.614 [Radio_Surface](INFO): Powering up 2019-02-22T23:58:42.344Z,1550879922.344 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US5CA83M.000 2019-02-22T23:58:45.535Z,1550879925.535 [NavChartDb](INFO): # of records loaded: 15000 2019-02-22T23:58:48.012Z,1550879928.012 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US5CA83M.000 2019-02-22T23:59:16.593Z,1550879956.593 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-02-22T23:59:16.593Z,1550879956.593 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2019-02-22T23:59:16.593Z,1550879956.593 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-02-22T23:59:16.595Z,1550879956.595 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-02-22T23:59:16.595Z,1550879956.595 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1 2019-02-22T23:59:16.595Z,1550879956.595 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2019-02-22T23:59:16.607Z,1550879956.607 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-02-22T23:59:16.607Z,1550879956.607 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2019-02-22T23:59:17.008Z,1550879957.008 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-02-22T23:59:17.008Z,1550879957.008 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2019-02-22T23:59:17.009Z,1550879957.009 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2019-02-22T23:59:17.009Z,1550879957.009 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1 2019-02-22T23:59:17.401Z,1550879957.401 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2019-02-22T23:59:23.218Z,1550879963.218 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US5CA83M.000 2019-02-22T23:59:23.230Z,1550879963.230 [NavChartDb](INFO): # of records loaded: 19732 2019-02-22T23:59:23.238Z,1550879963.238 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US5CA83M.000 2019-02-22T23:59:23.291Z,1550879963.291 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US5CA62M.000 2019-02-22T23:59:29.912Z,1550879969.912 [CommandLine](IMPORTANT): got command failComponent 2019-02-22T23:59:29.912Z,1550879969.912 [CommandLine](IMPORTANT): Failed components: 2019-02-22T23:59:29.913Z,1550879969.913 [CommandLine](IMPORTANT): RudderServo: Hardware Fault 2019-02-22T23:59:29.913Z,1550879969.913 [CommandLine](IMPORTANT): DropWeight: Hardware Fault 2019-02-22T23:59:29.913Z,1550879969.913 [CommandLine](IMPORTANT): BPC1: Data Fault 2019-02-22T23:59:29.913Z,1550879969.913 [CommandLine](IMPORTANT): CTD_Seabird: Communications Fault 2019-02-22T23:59:30.517Z,1550879970.517 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US5CA62M.000 2019-02-22T23:59:44.371Z,1550879984.371 [NavChartDb](INFO): # of records loaded: 5000 2019-02-22T23:59:57.069Z,1550879997.069 [NavChartDb](INFO): # of records loaded: 10000 2019-02-23T00:00:08.879Z,1550880008.879 [NavChartDb](INFO): # of records loaded: 15000 2019-02-23T00:00:21.849Z,1550880021.849 [NavChartDb](INFO): # of records loaded: 20000 2019-02-23T00:00:35.440Z,1550880035.440 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2019-02-23T00:00:35.440Z,1550880035.440 [CTD_Seabird] No Fault, FailCount= 3 2019-02-23T00:00:35.778Z,1550880035.778 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2019-02-23T00:00:35.780Z,1550880035.780 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20 2019-02-23T00:00:36.676Z,1550880036.676 [CommandLine](IMPORTANT): got command maintain servo VerticalControl.elevatorAngleAction 10.000000 2019-02-23T00:00:36.676Z,1550880036.676 [CommandLine](FAULT): Incomplete syntax. Try: help maintain 2019-02-23T00:00:38.608Z,1550880038.608 [NavChartDb](INFO): # of records loaded: 25000 2019-02-23T00:00:46.280Z,1550880046.280 [CommandLine](IMPORTANT): got command maintain servo VerticalControl.elevatorAngleAction 10.000000 degree 2019-02-23T00:00:46.282Z,1550880046.282 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.elevatorAngleAction" handled in the control thread. 2019-02-23T00:00:46.359Z,1550880046.359 [controlThread](DEBUG): Component order: CycleStarter,Depth_Keller,DropWeight,NAL9602,Onboard,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,ElevatorServo,MassServo,RudderServo,Maintain_VerticalControl.elevatorAngleAction,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2019-02-23T00:00:48.421Z,1550880048.421 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US5CA62M.000 2019-02-23T00:00:49.822Z,1550880049.822 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2019-02-23T00:00:49.822Z,1550880049.822 [CTD_Seabird] Communications Fault, FailCount= 1 2019-02-23T00:00:49.822Z,1550880049.822 [CTD_Seabird](ERROR): Communications Fault 2019-02-23T00:00:49.976Z,1550880049.976 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2019-02-23T00:00:50.226Z,1550880050.226 [CTD_Seabird](INFO): Powering down 2019-02-23T00:00:52.405Z,1550880052.405 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2019-02-23T00:00:52.406Z,1550880052.406 [CTD_Seabird] No Fault, FailCount= 1 2019-02-23T00:00:53.175Z,1550880053.175 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2019-02-23T00:00:53.178Z,1550880053.178 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20 2019-02-23T00:00:54.544Z,1550880054.544 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US5CA62M.000 2019-02-23T00:00:55.003Z,1550880055.003 [NavChartDb](INFO): # of records loaded: 30000 2019-02-23T00:01:07.222Z,1550880067.222 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2019-02-23T00:01:07.222Z,1550880067.222 [CTD_Seabird] Communications Fault, FailCount= 2 2019-02-23T00:01:07.222Z,1550880067.222 [CTD_Seabird](ERROR): Communications Fault 2019-02-23T00:01:07.354Z,1550880067.354 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2019-02-23T00:01:07.626Z,1550880067.626 [CTD_Seabird](INFO): Powering down 2019-02-23T00:01:09.766Z,1550880069.766 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2019-02-23T00:01:09.766Z,1550880069.766 [CTD_Seabird] No Fault, FailCount= 2 2019-02-23T00:01:10.575Z,1550880070.575 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2019-02-23T00:01:10.599Z,1550880070.599 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20 2019-02-23T00:01:17.441Z,1550880077.441 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-02-23T00:01:17.441Z,1550880077.441 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2019-02-23T00:01:17.441Z,1550880077.441 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-02-23T00:01:17.442Z,1550880077.442 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-02-23T00:01:17.442Z,1550880077.442 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2 2019-02-23T00:01:17.442Z,1550880077.442 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2019-02-23T00:01:17.516Z,1550880077.516 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-02-23T00:01:17.516Z,1550880077.516 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2019-02-23T00:01:17.872Z,1550880077.872 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-02-23T00:01:17.872Z,1550880077.872 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2019-02-23T00:01:17.873Z,1550880077.873 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2019-02-23T00:01:17.873Z,1550880077.873 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2 2019-02-23T00:01:18.249Z,1550880078.249 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2019-02-23T00:01:18.795Z,1550880078.795 [NavChartDb](INFO): # of records loaded: 35000 2019-02-23T00:01:24.650Z,1550880084.650 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2019-02-23T00:01:24.650Z,1550880084.650 [CTD_Seabird] Communications Fault, FailCount= 3 2019-02-23T00:01:24.650Z,1550880084.650 [CTD_Seabird](ERROR): Communications Fault 2019-02-23T00:01:24.771Z,1550880084.771 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2019-02-23T00:01:24.771Z,1550880084.771 [CBIT](FAULT): Communications Fault in component: CTD_Seabird 2019-02-23T00:01:25.054Z,1550880085.054 [CTD_Seabird](INFO): Powering down 2019-02-23T00:01:29.458Z,1550880089.458 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005265 2019-02-23T00:01:34.293Z,1550880094.293 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US5CA62M.000 2019-02-23T00:01:34.328Z,1550880094.328 [NavChartDb](INFO): # of records loaded: 37376 2019-02-23T00:01:34.337Z,1550880094.337 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US5CA62M.000 2019-02-23T00:01:34.371Z,1550880094.371 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US5CA61M.000 2019-02-23T00:01:40.336Z,1550880100.336 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US5CA61M.000 2019-02-23T00:01:56.057Z,1550880116.057 [NavChartDb](INFO): # of records loaded: 5000 2019-02-23T00:02:07.310Z,1550880127.310 [NavChartDb](INFO): # of records loaded: 10000 2019-02-23T00:02:15.861Z,1550880135.861 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US5CA61M.000 2019-02-23T00:02:17.530Z,1550880137.530 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US5CA61M.000 2019-02-23T00:02:18.964Z,1550880138.964 [NavChartDb](INFO): # of records loaded: 15000 2019-02-23T00:02:31.019Z,1550880151.019 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US5CA61M.000 2019-02-23T00:02:31.274Z,1550880151.274 [NavChartDb](INFO): # of records loaded: 16998 2019-02-23T00:02:31.287Z,1550880151.287 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US5CA61M.000 2019-02-23T00:02:31.287Z,1550880151.287 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US5CA50M.000 2019-02-23T00:02:37.033Z,1550880157.033 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US5CA50M.000 2019-02-23T00:02:39.735Z,1550880159.735 [CommandLine](IMPORTANT): got command maintain servo VerticalControl.elevatorAngleAction -15.000000 degree 2019-02-23T00:02:50.693Z,1550880170.693 [NavChartDb](INFO): # of records loaded: 5000 2019-02-23T00:02:57.619Z,1550880177.619 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2019-02-23T00:02:57.827Z,1550880177.827 [NavChartDb](INFO): # of records loaded: 10000 2019-02-23T00:02:58.438Z,1550880178.438 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:03:03.690Z,1550880183.690 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:03:04.405Z,1550880184.405 [NavChartDb](INFO): # of records loaded: 15000 2019-02-23T00:03:05.714Z,1550880185.714 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:03:07.730Z,1550880187.730 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:03:09.750Z,1550880189.750 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:03:12.978Z,1550880192.978 [NavChartDb](INFO): # of records loaded: 20000 2019-02-23T00:03:12.982Z,1550880192.982 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:03:15.810Z,1550880195.810 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:03:18.648Z,1550880198.648 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-02-23T00:03:18.648Z,1550880198.648 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2019-02-23T00:03:18.648Z,1550880198.648 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-02-23T00:03:18.675Z,1550880198.675 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-02-23T00:03:18.676Z,1550880198.676 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3 2019-02-23T00:03:18.676Z,1550880198.676 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2019-02-23T00:03:18.691Z,1550880198.691 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-02-23T00:03:18.691Z,1550880198.691 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2019-02-23T00:03:19.042Z,1550880199.042 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:03:19.089Z,1550880199.089 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-02-23T00:03:19.089Z,1550880199.089 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2019-02-23T00:03:19.090Z,1550880199.090 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2019-02-23T00:03:19.094Z,1550880199.094 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3 2019-02-23T00:03:19.469Z,1550880199.469 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2019-02-23T00:03:20.842Z,1550880200.842 [NavChartDb](INFO): # of records loaded: 25000 2019-02-23T00:03:21.870Z,1550880201.870 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:03:24.027Z,1550880204.027 [CommandLine](IMPORTANT): got command maintain clear 2019-02-23T00:03:24.326Z,1550880204.326 [controlThread](DEBUG): Component order: CycleStarter,Depth_Keller,DropWeight,NAL9602,Onboard,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,ElevatorServo,MassServo,RudderServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2019-02-23T00:03:24.702Z,1550880204.702 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:03:26.718Z,1550880206.718 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:03:28.738Z,1550880208.738 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:03:28.936Z,1550880208.936 [NavChartDb](INFO): # of records loaded: 30000 2019-02-23T00:03:31.986Z,1550880211.986 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:03:34.798Z,1550880214.798 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:03:38.030Z,1550880218.030 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:03:40.675Z,1550880220.675 [NavChartDb](INFO): # of records loaded: 35000 2019-02-23T00:03:40.858Z,1550880220.858 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:03:43.686Z,1550880223.686 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:03:45.710Z,1550880225.710 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:03:47.726Z,1550880227.726 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:03:49.746Z,1550880229.746 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:03:52.753Z,1550880232.753 [NavChartDb](INFO): # of records loaded: 40000 2019-02-23T00:03:52.978Z,1550880232.978 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:03:55.099Z,1550880235.099 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2019-02-23T00:03:55.099Z,1550880235.099 [CTD_Seabird] No Fault, FailCount= 3 2019-02-23T00:03:55.158Z,1550880235.158 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2019-02-23T00:03:55.160Z,1550880235.160 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20 2019-02-23T00:03:55.818Z,1550880235.818 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:03:59.074Z,1550880239.074 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:04:01.878Z,1550880241.878 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:04:04.405Z,1550880244.405 [NavChartDb](INFO): # of records loaded: 45000 2019-02-23T00:04:04.707Z,1550880244.707 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:04:05.996Z,1550880245.996 [CommandLine](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction -15.000000 degree 2019-02-23T00:04:05.997Z,1550880245.997 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.elevatorAngleAction" handled in the control thread. 2019-02-23T00:04:06.365Z,1550880246.365 [controlThread](DEBUG): Component order: CycleStarter,Depth_Keller,DropWeight,NAL9602,Onboard,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.elevatorAngleAction,ElevatorServo,MassServo,RudderServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2019-02-23T00:04:06.726Z,1550880246.726 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:04:08.746Z,1550880248.746 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:04:09.206Z,1550880249.206 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2019-02-23T00:04:09.206Z,1550880249.206 [CTD_Seabird] Communications Fault, FailCount= 1 2019-02-23T00:04:09.206Z,1550880249.206 [CTD_Seabird](ERROR): Communications Fault 2019-02-23T00:04:09.212Z,1550880249.212 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2019-02-23T00:04:09.611Z,1550880249.611 [CTD_Seabird](INFO): Powering down 2019-02-23T00:04:11.408Z,1550880251.408 [NavChartDb](INFO): # of records loaded: 50000 2019-02-23T00:04:11.595Z,1550880251.595 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2019-02-23T00:04:11.595Z,1550880251.595 [CTD_Seabird] No Fault, FailCount= 1 2019-02-23T00:04:11.978Z,1550880251.978 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:04:12.555Z,1550880252.555 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2019-02-23T00:04:12.558Z,1550880252.558 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20 2019-02-23T00:04:14.806Z,1550880254.806 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:04:18.038Z,1550880258.038 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:04:20.866Z,1550880260.866 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:04:23.694Z,1550880263.694 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:04:25.714Z,1550880265.714 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:04:26.598Z,1550880266.598 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2019-02-23T00:04:26.598Z,1550880266.598 [CTD_Seabird] Communications Fault, FailCount= 2 2019-02-23T00:04:26.598Z,1550880266.598 [CTD_Seabird](ERROR): Communications Fault 2019-02-23T00:04:26.956Z,1550880266.956 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2019-02-23T00:04:27.002Z,1550880267.002 [CTD_Seabird](INFO): Powering down 2019-02-23T00:04:27.734Z,1550880267.734 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:04:28.508Z,1550880268.508 [NavChartDb](INFO): # of records loaded: 55000 2019-02-23T00:04:28.975Z,1550880268.975 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2019-02-23T00:04:28.975Z,1550880268.975 [CTD_Seabird] No Fault, FailCount= 2 2019-02-23T00:04:29.955Z,1550880269.955 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2019-02-23T00:04:29.963Z,1550880269.963 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20 2019-02-23T00:04:30.502Z,1550880270.502 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US5CA50M.000 2019-02-23T00:04:30.970Z,1550880270.970 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:04:32.365Z,1550880272.365 [CommandLine](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 15.000000 degree 2019-02-23T00:04:33.794Z,1550880273.794 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:04:37.026Z,1550880277.026 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:04:38.096Z,1550880278.096 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US5CA50M.000 2019-02-23T00:04:39.854Z,1550880279.854 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:04:42.203Z,1550880282.203 [NavChartDb](INFO): # of records loaded: 60000 2019-02-23T00:04:43.086Z,1550880283.086 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:04:44.002Z,1550880284.002 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2019-02-23T00:04:44.002Z,1550880284.002 [CTD_Seabird] Communications Fault, FailCount= 3 2019-02-23T00:04:44.002Z,1550880284.002 [CTD_Seabird](ERROR): Communications Fault 2019-02-23T00:04:44.320Z,1550880284.320 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2019-02-23T00:04:44.320Z,1550880284.320 [CBIT](FAULT): Communications Fault in component: CTD_Seabird 2019-02-23T00:04:44.406Z,1550880284.406 [CTD_Seabird](INFO): Powering down 2019-02-23T00:04:45.914Z,1550880285.914 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:04:48.742Z,1550880288.742 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:04:51.986Z,1550880291.986 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:04:54.348Z,1550880294.348 [CommandLine](IMPORTANT): got command maintain clear 2019-02-23T00:04:54.459Z,1550880294.459 [controlThread](DEBUG): Component order: CycleStarter,Depth_Keller,DropWeight,NAL9602,Onboard,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,ElevatorServo,MassServo,RudderServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2019-02-23T00:04:54.814Z,1550880294.814 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:04:55.038Z,1550880295.038 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US5CA50M.000 2019-02-23T00:04:55.280Z,1550880295.280 [NavChartDb](INFO): # of records loaded: 62026 2019-02-23T00:04:55.286Z,1550880295.286 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US5CA50M.000 2019-02-23T00:04:55.299Z,1550880295.299 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US4CA60M.000 2019-02-23T00:04:58.046Z,1550880298.046 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:05:00.874Z,1550880300.874 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:05:03.702Z,1550880303.702 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:05:03.765Z,1550880303.765 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US4CA60M.000 2019-02-23T00:05:05.722Z,1550880305.722 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:05:08.966Z,1550880308.966 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:05:11.786Z,1550880311.786 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:05:11.867Z,1550880311.867 [CommandLine](IMPORTANT): got command get platform_elevator_angle degree 2019-02-23T00:05:11.868Z,1550880311.868 [CommandLine](IMPORTANT): platform_elevator_angle -0.017595 arcdeg 2019-02-23T00:05:15.018Z,1550880315.018 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:05:15.140Z,1550880315.140 [NavChartDb](INFO): # of records loaded: 5000 2019-02-23T00:05:17.846Z,1550880317.846 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:05:19.469Z,1550880319.469 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-02-23T00:05:19.469Z,1550880319.469 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2019-02-23T00:05:19.469Z,1550880319.469 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-02-23T00:05:19.470Z,1550880319.470 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-02-23T00:05:19.470Z,1550880319.470 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4 2019-02-23T00:05:19.470Z,1550880319.470 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2019-02-23T00:05:19.486Z,1550880319.486 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-02-23T00:05:19.487Z,1550880319.487 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2019-02-23T00:05:19.897Z,1550880319.897 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-02-23T00:05:19.897Z,1550880319.897 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2019-02-23T00:05:19.897Z,1550880319.897 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2019-02-23T00:05:19.897Z,1550880319.897 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4 2019-02-23T00:05:20.281Z,1550880320.281 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2019-02-23T00:05:21.078Z,1550880321.078 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:05:23.906Z,1550880323.906 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:05:24.055Z,1550880324.055 [NavChartDb](INFO): # of records loaded: 10000 2019-02-23T00:05:26.734Z,1550880326.734 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:05:29.966Z,1550880329.966 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:05:32.790Z,1550880332.790 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:05:33.837Z,1550880333.837 [NavChartDb](INFO): # of records loaded: 15000 2019-02-23T00:05:36.022Z,1550880336.022 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:05:38.854Z,1550880338.854 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:05:42.082Z,1550880342.082 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:05:43.766Z,1550880343.766 [NavChartDb](INFO): # of records loaded: 20000 2019-02-23T00:05:44.910Z,1550880344.910 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:05:47.758Z,1550880347.758 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:05:50.970Z,1550880350.970 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:05:52.735Z,1550880352.735 [NavChartDb](INFO): # of records loaded: 25000 2019-02-23T00:05:53.802Z,1550880353.802 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:05:57.030Z,1550880357.030 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:05:59.894Z,1550880359.894 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:06:02.242Z,1550880362.242 [NavChartDb](INFO): # of records loaded: 30000 2019-02-23T00:06:02.690Z,1550880362.690 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:06:04.718Z,1550880364.718 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:06:06.733Z,1550880366.733 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:06:08.750Z,1550880368.750 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:06:11.708Z,1550880371.708 [NavChartDb](INFO): # of records loaded: 35000 2019-02-23T00:06:11.978Z,1550880371.978 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:06:14.806Z,1550880374.806 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:06:18.042Z,1550880378.042 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:06:20.866Z,1550880380.866 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:06:23.694Z,1550880383.694 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:06:24.740Z,1550880384.740 [NavChartDb](INFO): # of records loaded: 40000 2019-02-23T00:06:25.714Z,1550880385.714 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:06:28.962Z,1550880388.962 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:06:31.786Z,1550880391.786 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:06:35.018Z,1550880395.018 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:06:37.846Z,1550880397.846 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:06:40.674Z,1550880400.674 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:06:40.923Z,1550880400.923 [NavChartDb](INFO): # of records loaded: 45000 2019-02-23T00:06:42.694Z,1550880402.694 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:06:44.718Z,1550880404.718 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:06:45.448Z,1550880405.448 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US4CA60M.000 2019-02-23T00:06:46.742Z,1550880406.742 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:06:47.475Z,1550880407.475 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US4CA60M.000 2019-02-23T00:06:49.711Z,1550880409.711 [CommandLine](IMPORTANT): got command get Onboard.Pressure decibar 2019-02-23T00:06:49.712Z,1550880409.712 [CommandLine](IMPORTANT): Onboard.Pressure 10.340746 db 2019-02-23T00:06:49.966Z,1550880409.966 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:06:52.798Z,1550880412.798 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:06:54.440Z,1550880414.440 [CommandLine](IMPORTANT): got command get Onboard.Pressure decibar 2019-02-23T00:06:54.441Z,1550880414.441 [CommandLine](IMPORTANT): Onboard.Pressure 10.344979 db 2019-02-23T00:06:56.037Z,1550880416.037 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:06:58.862Z,1550880418.862 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:06:59.115Z,1550880419.115 [NavChartDb](INFO): # of records loaded: 50000 2019-02-23T00:07:01.690Z,1550880421.690 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:07:03.706Z,1550880423.706 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:07:05.726Z,1550880425.726 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:07:07.344Z,1550880427.344 [CommandLine](IMPORTANT): got command get Onboard.Temperature 2019-02-23T00:07:07.345Z,1550880427.345 [CommandLine](IMPORTANT): Onboard.Temperature 25.105616 degC 2019-02-23T00:07:08.970Z,1550880428.970 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:07:11.786Z,1550880431.786 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:07:14.231Z,1550880434.231 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2019-02-23T00:07:14.231Z,1550880434.231 [CTD_Seabird] No Fault, FailCount= 3 2019-02-23T00:07:14.410Z,1550880434.410 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2019-02-23T00:07:14.412Z,1550880434.412 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20 2019-02-23T00:07:15.038Z,1550880435.038 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:07:17.846Z,1550880437.846 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:07:20.120Z,1550880440.120 [CommandLine](IMPORTANT): got command get Onboard.Pressure decibar 2019-02-23T00:07:20.121Z,1550880440.121 [CommandLine](IMPORTANT): Onboard.Pressure 10.287209 db 2019-02-23T00:07:20.289Z,1550880440.289 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-02-23T00:07:20.289Z,1550880440.289 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2019-02-23T00:07:20.289Z,1550880440.289 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-02-23T00:07:20.290Z,1550880440.290 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-02-23T00:07:20.291Z,1550880440.291 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5 2019-02-23T00:07:20.291Z,1550880440.291 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2019-02-23T00:07:20.321Z,1550880440.321 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-02-23T00:07:20.321Z,1550880440.321 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2019-02-23T00:07:20.678Z,1550880440.678 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:07:20.718Z,1550880440.718 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-02-23T00:07:20.718Z,1550880440.718 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2019-02-23T00:07:20.719Z,1550880440.719 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2019-02-23T00:07:20.719Z,1550880440.719 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5 2019-02-23T00:07:21.113Z,1550880441.113 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2019-02-23T00:07:22.184Z,1550880442.184 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US4CA60M.000 2019-02-23T00:07:22.409Z,1550880442.409 [NavChartDb](INFO): # of records loaded: 53494 2019-02-23T00:07:22.431Z,1550880442.431 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US4CA60M.000 2019-02-23T00:07:22.432Z,1550880442.432 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US3CA52M.000 2019-02-23T00:07:22.698Z,1550880442.698 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:07:24.718Z,1550880444.718 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:07:25.973Z,1550880445.973 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US3CA52M.000 2019-02-23T00:07:26.738Z,1550880446.738 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:07:28.462Z,1550880448.462 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2019-02-23T00:07:28.462Z,1550880448.462 [CTD_Seabird] Communications Fault, FailCount= 1 2019-02-23T00:07:28.462Z,1550880448.462 [CTD_Seabird](ERROR): Communications Fault 2019-02-23T00:07:28.783Z,1550880448.783 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2019-02-23T00:07:28.867Z,1550880448.867 [CTD_Seabird](INFO): Powering down 2019-02-23T00:07:29.970Z,1550880449.970 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:07:30.823Z,1550880450.823 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2019-02-23T00:07:30.823Z,1550880450.823 [CTD_Seabird] No Fault, FailCount= 1 2019-02-23T00:07:31.814Z,1550880451.814 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2019-02-23T00:07:31.818Z,1550880451.818 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20 2019-02-23T00:07:32.810Z,1550880452.810 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:07:36.042Z,1550880456.042 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:07:38.874Z,1550880458.874 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:07:39.326Z,1550880459.326 [NavChartDb](INFO): # of records loaded: 5000 2019-02-23T00:07:41.698Z,1550880461.698 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:07:43.718Z,1550880463.718 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:07:45.738Z,1550880465.738 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:07:45.886Z,1550880465.886 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2019-02-23T00:07:45.886Z,1550880465.886 [CTD_Seabird] Communications Fault, FailCount= 2 2019-02-23T00:07:45.886Z,1550880465.886 [CTD_Seabird](ERROR): Communications Fault 2019-02-23T00:07:46.203Z,1550880466.203 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2019-02-23T00:07:46.290Z,1550880466.290 [CTD_Seabird](INFO): Powering down 2019-02-23T00:07:48.459Z,1550880468.459 [NavChartDb](INFO): # of records loaded: 10000 2019-02-23T00:07:48.595Z,1550880468.595 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2019-02-23T00:07:48.595Z,1550880468.595 [CTD_Seabird] No Fault, FailCount= 2 2019-02-23T00:07:48.970Z,1550880468.970 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:07:49.238Z,1550880469.238 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2019-02-23T00:07:49.247Z,1550880469.247 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20 2019-02-23T00:07:51.798Z,1550880471.798 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:07:55.030Z,1550880475.030 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:07:55.423Z,1550880475.423 [NAL9602](FAULT): GPS failed to acquire within timeout. 2019-02-23T00:07:55.424Z,1550880475.424 [NAL9602] Data Fault, FailCount= 1 2019-02-23T00:07:55.424Z,1550880475.424 [NAL9602](ERROR): Data Fault 2019-02-23T00:07:55.488Z,1550880475.488 [CBIT](ERROR): Data Fault in component: NAL9602 2019-02-23T00:07:55.827Z,1550880475.827 [NAL9602](INFO): Powering down 2019-02-23T00:07:56.693Z,1550880476.693 [CBIT](INFO): Clearing failed state for component NAL9602 2019-02-23T00:07:56.693Z,1550880476.693 [NAL9602] No Fault, FailCount= 1 2019-02-23T00:08:01.614Z,1550880481.614 [NavChartDb](INFO): # of records loaded: 15000 2019-02-23T00:08:03.310Z,1550880483.310 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2019-02-23T00:08:03.310Z,1550880483.310 [CTD_Seabird] Communications Fault, FailCount= 3 2019-02-23T00:08:03.310Z,1550880483.310 [CTD_Seabird](ERROR): Communications Fault 2019-02-23T00:08:03.535Z,1550880483.535 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2019-02-23T00:08:03.535Z,1550880483.535 [CBIT](FAULT): Communications Fault in component: CTD_Seabird 2019-02-23T00:08:03.714Z,1550880483.714 [CTD_Seabird](INFO): Powering down 2019-02-23T00:08:08.077Z,1550880488.077 [NavChartDb](INFO): # of records loaded: 20000 2019-02-23T00:08:14.532Z,1550880494.532 [NavChartDb](INFO): # of records loaded: 25000 2019-02-23T00:08:20.953Z,1550880500.953 [NavChartDb](INFO): # of records loaded: 30000 2019-02-23T00:08:26.127Z,1550880506.127 [NAL9602](INFO): Powering up NAL9602 2019-02-23T00:08:28.601Z,1550880508.601 [NavChartDb](INFO): # of records loaded: 35000 2019-02-23T00:08:31.831Z,1550880511.831 [CBIT](INFO): Clearing failed state for component BPC1 2019-02-23T00:08:31.831Z,1550880511.831 [BPC1] No Fault, FailCount= 1 2019-02-23T00:08:37.039Z,1550880517.039 [NAL9602](INFO): NAL9602 initialized 2019-02-23T00:08:37.125Z,1550880517.125 [NavChartDb](INFO): # of records loaded: 40000 2019-02-23T00:08:40.682Z,1550880520.682 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:08:43.510Z,1550880523.510 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:08:43.743Z,1550880523.743 [NavChartDb](INFO): # of records loaded: 45000 2019-02-23T00:08:46.742Z,1550880526.742 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:08:49.570Z,1550880529.570 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:08:50.252Z,1550880530.252 [NavChartDb](INFO): # of records loaded: 50000 2019-02-23T00:08:52.802Z,1550880532.802 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:08:55.630Z,1550880535.630 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:08:56.785Z,1550880536.785 [NavChartDb](INFO): # of records loaded: 55000 2019-02-23T00:08:58.462Z,1550880538.462 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:09:01.702Z,1550880541.702 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:09:04.518Z,1550880544.518 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:09:06.193Z,1550880546.193 [NavChartDb](INFO): # of records loaded: 60000 2019-02-23T00:09:07.754Z,1550880547.754 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:09:10.578Z,1550880550.578 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:09:12.344Z,1550880552.344 [CommandLine](IMPORTANT): got command show variable Drop 2019-02-23T00:09:12.391Z,1550880552.391 [CommandLine](IMPORTANT): Config/Simulator.dropWt1Mass (kilogram) 2019-02-23T00:09:12.392Z,1550880552.392 [CommandLine](IMPORTANT): Config/Simulator.dropWt1Volume (cubic_meter) 2019-02-23T00:09:12.392Z,1550880552.392 [CommandLine](IMPORTANT): Config/Simulator.dropWt1X (meter) 2019-02-23T00:09:12.392Z,1550880552.392 [CommandLine](IMPORTANT): Config/Simulator.dropWt1Y (meter) 2019-02-23T00:09:12.393Z,1550880552.393 [CommandLine](IMPORTANT): Config/Simulator.dropWt1Z (meter) 2019-02-23T00:09:12.478Z,1550880552.478 [CommandLine](IMPORTANT): DropWeight.loadAtStartup (bool) 2019-02-23T00:09:12.479Z,1550880552.479 [CommandLine](IMPORTANT): DropWeight.simulateHardware (bool) 2019-02-23T00:09:12.493Z,1550880552.493 [CommandLine](IMPORTANT): VerticalControl.dropWtDepthExcursion (meter) 2019-02-23T00:09:12.494Z,1550880552.494 [CommandLine](IMPORTANT): VerticalControl.dropWtOverrideDelay (minute) 2019-02-23T00:09:12.550Z,1550880552.550 [CommandLine](IMPORTANT): DropWeight.dropWeightState (bool) 2019-02-23T00:09:13.406Z,1550880553.406 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:09:13.749Z,1550880553.749 [NavChartDb](INFO): # of records loaded: 65000 2019-02-23T00:09:15.430Z,1550880555.430 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:09:17.446Z,1550880557.446 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:09:20.418Z,1550880560.418 [NavChartDb](INFO): # of records loaded: 70000 2019-02-23T00:09:20.682Z,1550880560.682 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:09:21.117Z,1550880561.117 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-02-23T00:09:21.117Z,1550880561.117 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2019-02-23T00:09:21.117Z,1550880561.117 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-02-23T00:09:21.118Z,1550880561.118 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-02-23T00:09:21.118Z,1550880561.118 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6 2019-02-23T00:09:21.118Z,1550880561.118 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2019-02-23T00:09:21.129Z,1550880561.129 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-02-23T00:09:21.129Z,1550880561.129 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2019-02-23T00:09:21.527Z,1550880561.527 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-02-23T00:09:21.527Z,1550880561.527 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2019-02-23T00:09:21.527Z,1550880561.527 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2019-02-23T00:09:21.527Z,1550880561.527 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6 2019-02-23T00:09:21.901Z,1550880561.901 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2019-02-23T00:09:23.506Z,1550880563.506 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:09:26.738Z,1550880566.738 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:09:27.073Z,1550880567.073 [NavChartDb](INFO): # of records loaded: 75000 2019-02-23T00:09:29.570Z,1550880569.570 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:09:32.802Z,1550880572.802 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:09:33.815Z,1550880573.815 [NavChartDb](INFO): # of records loaded: 80000 2019-02-23T00:09:35.630Z,1550880575.630 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:09:38.454Z,1550880578.454 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:09:38.471Z,1550880578.471 [BPC1](ERROR): BPC1B: No match for serial number 0163 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2019-02-23T00:09:39.675Z,1550880579.675 [BPC1](ERROR): BPC1A: No match for serial number 023F in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2019-02-23T00:09:40.711Z,1550880580.711 [CommandLine](IMPORTANT): got command get DropWeight.dropWeightState 2019-02-23T00:09:40.711Z,1550880580.711 [CommandLine](IMPORTANT): DropWeight.dropWeightState 0 bool 2019-02-23T00:09:41.686Z,1550880581.686 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:09:44.514Z,1550880584.514 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:09:44.884Z,1550880584.884 [NavChartDb](INFO): # of records loaded: 85000 2019-02-23T00:09:47.416Z,1550880587.416 [CommandLine](IMPORTANT): got command get DropWeight.dropWeightState 2019-02-23T00:09:47.417Z,1550880587.417 [CommandLine](IMPORTANT): DropWeight.dropWeightState 0 bool 2019-02-23T00:09:47.746Z,1550880587.746 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:09:50.574Z,1550880590.574 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:09:51.002Z,1550880591.002 [BPC1](ERROR): BPC1B: No match for serial number 0163 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2019-02-23T00:09:51.096Z,1550880591.096 [CommandLine](IMPORTANT): got command get DropWeight.dropWeightState 2019-02-23T00:09:51.097Z,1550880591.097 [CommandLine](IMPORTANT): DropWeight.dropWeightState 0 bool 2019-02-23T00:09:53.003Z,1550880593.003 [BPC1](ERROR): BPC1A: No match for serial number 023F in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2019-02-23T00:09:53.288Z,1550880593.288 [NavChartDb](INFO): # of records loaded: 90000 2019-02-23T00:09:53.410Z,1550880593.410 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:09:55.434Z,1550880595.434 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:09:57.139Z,1550880597.139 [CommandLine](IMPORTANT): got command failComponent 2019-02-23T00:09:57.139Z,1550880597.139 [CommandLine](IMPORTANT): Failed components: 2019-02-23T00:09:57.139Z,1550880597.139 [CommandLine](IMPORTANT): RudderServo: Hardware Fault 2019-02-23T00:09:57.140Z,1550880597.140 [CommandLine](IMPORTANT): DropWeight: Hardware Fault 2019-02-23T00:09:57.140Z,1550880597.140 [CommandLine](IMPORTANT): CTD_Seabird: Communications Fault 2019-02-23T00:09:57.458Z,1550880597.458 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:10:00.179Z,1550880600.179 [NavChartDb](INFO): # of records loaded: 95000 2019-02-23T00:10:00.682Z,1550880600.682 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:10:03.510Z,1550880603.510 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:10:03.527Z,1550880603.527 [BPC1](ERROR): BPC1B: No match for serial number 0163 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2019-02-23T00:10:06.742Z,1550880606.742 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:10:06.757Z,1550880606.757 [BPC1](ERROR): BPC1A: No match for serial number 023F in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2019-02-23T00:10:07.569Z,1550880607.569 [NavChartDb](INFO): # of records loaded: 100000 2019-02-23T00:10:08.440Z,1550880608.440 [CommandLine](IMPORTANT): got command failComponent none DropWeight 2019-02-23T00:10:08.440Z,1550880608.440 [DropWeight] No Fault, FailCount= 1 2019-02-23T00:10:08.440Z,1550880608.440 [CommandLine](IMPORTANT): DropWeight failureMode is No Fault 2019-02-23T00:10:09.570Z,1550880609.570 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:10:12.802Z,1550880612.802 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:10:15.654Z,1550880615.654 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:10:15.676Z,1550880615.676 [BPC1](ERROR): BPC1B: No match for serial number 0163 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2019-02-23T00:10:17.593Z,1550880617.593 [NavChartDb](INFO): # of records loaded: 105000 2019-02-23T00:10:18.462Z,1550880618.462 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:10:20.084Z,1550880620.084 [BPC1](ERROR): BPC1A: No match for serial number 023F in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2019-02-23T00:10:21.698Z,1550880621.698 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:10:24.522Z,1550880624.522 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:10:25.443Z,1550880625.443 [CommandLine](IMPORTANT): got command get DropWeight.dropWeightState 2019-02-23T00:10:25.443Z,1550880625.443 [CommandLine](IMPORTANT): DropWeight.dropWeightState 0 bool 2019-02-23T00:10:27.273Z,1550880627.273 [NavChartDb](INFO): # of records loaded: 110000 2019-02-23T00:10:27.774Z,1550880627.774 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:10:27.792Z,1550880627.792 [BPC1](ERROR): BPC1B: No match for serial number 0163 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2019-02-23T00:10:30.582Z,1550880630.582 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:10:33.410Z,1550880633.410 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:10:33.537Z,1550880633.537 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2019-02-23T00:10:33.537Z,1550880633.537 [CTD_Seabird] No Fault, FailCount= 3 2019-02-23T00:10:33.718Z,1550880633.718 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2019-02-23T00:10:33.720Z,1550880633.720 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20 2019-02-23T00:10:33.834Z,1550880633.834 [BPC1](ERROR): BPC1A: No match for serial number 023F in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2019-02-23T00:10:35.057Z,1550880635.057 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US3CA52M.000 2019-02-23T00:10:35.430Z,1550880635.430 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:10:36.509Z,1550880636.509 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US3CA52M.000 2019-02-23T00:10:37.450Z,1550880637.450 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:10:40.283Z,1550880640.283 [BPC1](ERROR): BPC1B: No match for serial number 0163 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2019-02-23T00:10:40.682Z,1550880640.682 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:10:41.421Z,1550880641.421 [NavChartDb](INFO): # of records loaded: 115000 2019-02-23T00:10:43.510Z,1550880643.510 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:10:46.746Z,1550880646.746 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:10:47.027Z,1550880647.027 [CommandLine](IMPORTANT): got command get DropWeight.dropWeightState 2019-02-23T00:10:47.027Z,1550880647.027 [CommandLine](IMPORTANT): DropWeight.dropWeightState 0 bool 2019-02-23T00:10:47.170Z,1550880647.170 [BPC1](ERROR): BPC1A: No match for serial number 023F in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2019-02-23T00:10:47.778Z,1550880647.778 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2019-02-23T00:10:47.778Z,1550880647.778 [CTD_Seabird] Communications Fault, FailCount= 1 2019-02-23T00:10:47.778Z,1550880647.778 [CTD_Seabird](ERROR): Communications Fault 2019-02-23T00:10:47.996Z,1550880647.996 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2019-02-23T00:10:48.182Z,1550880648.182 [CTD_Seabird](INFO): Powering down 2019-02-23T00:10:49.578Z,1550880649.578 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:10:50.440Z,1550880650.440 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2019-02-23T00:10:50.440Z,1550880650.440 [CTD_Seabird] No Fault, FailCount= 1 2019-02-23T00:10:51.130Z,1550880651.130 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2019-02-23T00:10:51.135Z,1550880651.135 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20 2019-02-23T00:10:51.547Z,1550880651.547 [CommandLine](IMPORTANT): got command get DropWeight.dropWeightState 2019-02-23T00:10:51.548Z,1550880651.548 [CommandLine](IMPORTANT): DropWeight.dropWeightState 0 bool 2019-02-23T00:10:52.410Z,1550880652.410 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:10:52.426Z,1550880652.426 [BPC1](ERROR): BPC1B: No match for serial number 0163 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2019-02-23T00:10:52.757Z,1550880652.757 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US3CA52M.000 2019-02-23T00:10:53.469Z,1550880653.469 [NavChartDb](INFO): # of records loaded: 117290 2019-02-23T00:10:53.490Z,1550880653.490 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US3CA52M.000 2019-02-23T00:10:53.491Z,1550880653.491 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US2WC11M.000 2019-02-23T00:10:54.426Z,1550880654.426 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:10:56.446Z,1550880656.446 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:10:57.553Z,1550880657.553 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US2WC11M.000 2019-02-23T00:10:58.019Z,1550880658.019 [CommandLine](IMPORTANT): got command get DropWeight.dropWeightState 2019-02-23T00:10:58.019Z,1550880658.019 [CommandLine](IMPORTANT): DropWeight.dropWeightState 0 bool 2019-02-23T00:10:59.690Z,1550880659.690 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:11:00.516Z,1550880660.516 [BPC1](ERROR): BPC1A: No match for serial number 023F in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2019-02-23T00:11:02.506Z,1550880662.506 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:11:05.133Z,1550880665.133 [NavChartDb](INFO): # of records loaded: 5000 2019-02-23T00:11:05.182Z,1550880665.182 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2019-02-23T00:11:05.182Z,1550880665.182 [CTD_Seabird] Communications Fault, FailCount= 2 2019-02-23T00:11:05.182Z,1550880665.182 [CTD_Seabird](ERROR): Communications Fault 2019-02-23T00:11:05.355Z,1550880665.355 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2019-02-23T00:11:05.586Z,1550880665.586 [CTD_Seabird](INFO): Powering down 2019-02-23T00:11:05.743Z,1550880665.743 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:11:06.162Z,1550880666.162 [BPC1](ERROR): BPC1B: No match for serial number 022A in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2019-02-23T00:11:07.779Z,1550880667.779 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2019-02-23T00:11:07.779Z,1550880667.779 [CTD_Seabird] No Fault, FailCount= 2 2019-02-23T00:11:08.534Z,1550880668.534 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2019-02-23T00:11:08.543Z,1550880668.543 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20 2019-02-23T00:11:08.590Z,1550880668.590 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:11:11.798Z,1550880671.798 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:11:13.827Z,1550880673.827 [BPC1](ERROR): BPC1A: No match for serial number 00BB in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2019-02-23T00:11:14.626Z,1550880674.626 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:11:16.172Z,1550880676.172 [NavChartDb](INFO): # of records loaded: 10000 2019-02-23T00:11:17.454Z,1550880677.454 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:11:19.480Z,1550880679.480 [BPC1](ERROR): BPC1B: No match for serial number 022A in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2019-02-23T00:11:20.686Z,1550880680.686 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:11:21.909Z,1550880681.909 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-02-23T00:11:21.909Z,1550880681.909 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2019-02-23T00:11:21.909Z,1550880681.909 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-02-23T00:11:21.911Z,1550880681.911 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-02-23T00:11:21.911Z,1550880681.911 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7 2019-02-23T00:11:21.911Z,1550880681.911 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2019-02-23T00:11:21.921Z,1550880681.921 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-02-23T00:11:21.922Z,1550880681.922 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2019-02-23T00:11:22.363Z,1550880682.363 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-02-23T00:11:22.363Z,1550880682.363 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2019-02-23T00:11:22.363Z,1550880682.363 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2019-02-23T00:11:22.363Z,1550880682.363 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7 2019-02-23T00:11:22.586Z,1550880682.586 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2019-02-23T00:11:22.586Z,1550880682.586 [CTD_Seabird] Communications Fault, FailCount= 3 2019-02-23T00:11:22.586Z,1550880682.586 [CTD_Seabird](ERROR): Communications Fault 2019-02-23T00:11:22.717Z,1550880682.717 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2019-02-23T00:11:22.730Z,1550880682.730 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2019-02-23T00:11:22.746Z,1550880682.746 [CBIT](FAULT): Communications Fault in component: CTD_Seabird 2019-02-23T00:11:22.990Z,1550880682.990 [CTD_Seabird](INFO): Powering down 2019-02-23T00:11:23.514Z,1550880683.514 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:11:24.601Z,1550880684.601 [NavChartDb](INFO): # of records loaded: 15000 2019-02-23T00:11:26.746Z,1550880686.746 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:11:27.174Z,1550880687.174 [BPC1](ERROR): BPC1A: No match for serial number 00BB in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2019-02-23T00:11:29.578Z,1550880689.578 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:11:31.972Z,1550880691.972 [CommandLine](IMPORTANT): got command get DropWeight.dropWeightState 2019-02-23T00:11:31.973Z,1550880691.973 [CommandLine](IMPORTANT): DropWeight.dropWeightState 0 bool 2019-02-23T00:11:32.807Z,1550880692.807 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:11:32.823Z,1550880692.823 [BPC1](ERROR): BPC1B: No match for serial number 022A in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2019-02-23T00:11:34.048Z,1550880694.048 [NavChartDb](INFO): # of records loaded: 20000 2019-02-23T00:11:35.634Z,1550880695.634 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:11:38.466Z,1550880698.466 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:11:40.896Z,1550880700.896 [BPC1](ERROR): BPC1A: No match for serial number 00BB in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2019-02-23T00:11:41.706Z,1550880701.706 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:11:41.759Z,1550880701.759 [CommandLine](IMPORTANT): got command failComponent 2019-02-23T00:11:41.759Z,1550880701.759 [CommandLine](IMPORTANT): Failed components: 2019-02-23T00:11:41.759Z,1550880701.759 [CommandLine](IMPORTANT): RudderServo: Hardware Fault 2019-02-23T00:11:41.760Z,1550880701.760 [CommandLine](IMPORTANT): CTD_Seabird: Communications Fault 2019-02-23T00:11:41.881Z,1550880701.881 [NavChartDb](INFO): # of records loaded: 25000 2019-02-23T00:11:44.526Z,1550880704.526 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:11:46.592Z,1550880706.592 [BPC1](ERROR): BPC1B: No match for serial number 022A in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2019-02-23T00:11:47.758Z,1550880707.758 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:11:50.433Z,1550880710.433 [NavChartDb](INFO): # of records loaded: 30000 2019-02-23T00:11:50.582Z,1550880710.582 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:11:53.410Z,1550880713.410 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:11:54.234Z,1550880714.234 [BPC1](ERROR): BPC1A: No match for serial number 00BB in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2019-02-23T00:11:55.430Z,1550880715.430 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:11:57.474Z,1550880717.474 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:11:59.476Z,1550880719.476 [BPC1](ERROR): BPC1B: No match for serial number 022A in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2019-02-23T00:12:00.682Z,1550880720.682 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:12:02.090Z,1550880722.090 [NavChartDb](INFO): # of records loaded: 35000 2019-02-23T00:12:03.514Z,1550880723.514 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:12:06.742Z,1550880726.742 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:12:06.839Z,1550880726.839 [CommandLine](IMPORTANT): got command failComponent 2019-02-23T00:12:06.839Z,1550880726.839 [CommandLine](IMPORTANT): Failed components: 2019-02-23T00:12:06.839Z,1550880726.839 [CommandLine](IMPORTANT): RudderServo: Hardware Fault 2019-02-23T00:12:06.840Z,1550880726.840 [CommandLine](IMPORTANT): CTD_Seabird: Communications Fault 2019-02-23T00:12:07.963Z,1550880727.963 [BPC1](ERROR): BPC1A: No match for serial number 00BB in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2019-02-23T00:12:09.570Z,1550880729.570 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:12:11.440Z,1550880731.440 [CommandLine](IMPORTANT): got command get DropWeight.dropWeightState 2019-02-23T00:12:11.440Z,1550880731.440 [CommandLine](IMPORTANT): DropWeight.dropWeightState 0 bool 2019-02-23T00:12:11.963Z,1550880731.963 [NavChartDb](INFO): # of records loaded: 40000 2019-02-23T00:12:12.398Z,1550880732.398 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:12:12.419Z,1550880732.419 [BPC1](ERROR): BPC1B: No match for serial number 022A in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2019-02-23T00:12:13.787Z,1550880733.787 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US2WC11M.000 2019-02-23T00:12:14.418Z,1550880734.418 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:12:14.520Z,1550880734.520 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US2WC11M.000 2019-02-23T00:12:16.438Z,1550880736.438 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:12:18.458Z,1550880738.458 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:12:21.291Z,1550880741.291 [BPC1](ERROR): BPC1A: No match for serial number 00BB in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2019-02-23T00:12:21.690Z,1550880741.690 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:12:23.220Z,1550880743.220 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US2WC11M.000 2019-02-23T00:12:23.388Z,1550880743.388 [NavChartDb](INFO): # of records loaded: 44880 2019-02-23T00:12:23.393Z,1550880743.393 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US2WC11M.000 2019-02-23T00:12:23.394Z,1550880743.394 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US1WC07M.000 2019-02-23T00:12:24.518Z,1550880744.518 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:12:26.140Z,1550880746.140 [BPC1](ERROR): BPC1B: No match for serial number 022A in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2019-02-23T00:12:26.850Z,1550880746.850 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US1WC07M.000 2019-02-23T00:12:27.750Z,1550880747.750 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:12:30.578Z,1550880750.578 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:12:33.066Z,1550880753.066 [CBIT](INFO): Clearing failed state for component RudderServo 2019-02-23T00:12:33.066Z,1550880753.066 [RudderServo] No Fault, FailCount= 3 2019-02-23T00:12:33.406Z,1550880753.406 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:12:35.031Z,1550880755.031 [BPC1](ERROR): BPC1A: No match for serial number 00BB in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2019-02-23T00:12:35.426Z,1550880755.426 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:12:37.462Z,1550880757.462 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:12:38.711Z,1550880758.711 [RudderServo](FAULT): Overload Error 2019-02-23T00:12:38.711Z,1550880758.711 [RudderServo] Hardware Fault, FailCount= 1 2019-02-23T00:12:38.711Z,1550880758.711 [RudderServo](ERROR): Hardware Fault 2019-02-23T00:12:38.774Z,1550880758.774 [CBIT](ERROR): Hardware Fault in component: RudderServo 2019-02-23T00:12:39.203Z,1550880759.203 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2019-02-23T00:12:39.203Z,1550880759.203 [RudderServo](INFO): Powering down 2019-02-23T00:12:39.243Z,1550880759.243 [NavChartDb](INFO): # of records loaded: 5000 2019-02-23T00:12:39.471Z,1550880759.471 [BPC1](ERROR): BPC1B: No match for serial number 022A in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2019-02-23T00:12:39.916Z,1550880759.916 [RudderServo](DEBUG): Initializing EZServoServo. 2019-02-23T00:12:40.039Z,1550880760.039 [RudderServo](DEBUG): Initializing RudderServo. 2019-02-23T00:12:40.043Z,1550880760.043 [CBIT](INFO): Clearing failed state for component RudderServo 2019-02-23T00:12:40.043Z,1550880760.043 [RudderServo] No Fault, FailCount= 1 2019-02-23T00:12:40.678Z,1550880760.678 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:12:43.510Z,1550880763.510 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:12:44.790Z,1550880764.790 [RudderServo](FAULT): Overload Error 2019-02-23T00:12:44.790Z,1550880764.790 [RudderServo] Hardware Fault, FailCount= 2 2019-02-23T00:12:44.791Z,1550880764.791 [RudderServo](ERROR): Hardware Fault 2019-02-23T00:12:44.830Z,1550880764.830 [CBIT](ERROR): Hardware Fault in component: RudderServo 2019-02-23T00:12:45.156Z,1550880765.156 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2019-02-23T00:12:45.156Z,1550880765.156 [RudderServo](INFO): Powering down 2019-02-23T00:12:45.972Z,1550880765.972 [RudderServo](DEBUG): Initializing EZServoServo. 2019-02-23T00:12:46.095Z,1550880766.095 [RudderServo](DEBUG): Initializing RudderServo. 2019-02-23T00:12:46.099Z,1550880766.099 [CBIT](INFO): Clearing failed state for component RudderServo 2019-02-23T00:12:46.099Z,1550880766.099 [RudderServo] No Fault, FailCount= 2 2019-02-23T00:12:46.738Z,1550880766.738 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:12:47.182Z,1550880767.182 [VerticalControl](CRITICAL): Failure to ascend, stopping mission after 840.088196 seconds, depthRate=-0.001474 m/s, pitch=nan deg. 2019-02-23T00:12:47.222Z,1550880767.222 [CBIT](INFO): Critical error at 20190223T001247 2019-02-23T00:12:48.035Z,1550880768.035 [NavChartDb](INFO): # of records loaded: 10000 2019-02-23T00:12:48.368Z,1550880768.368 [BPC1](ERROR): BPC1A: No match for serial number 00BB in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2019-02-23T00:12:49.574Z,1550880769.574 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:12:50.439Z,1550880770.439 [RudderServo](FAULT): Overload Error 2019-02-23T00:12:50.439Z,1550880770.439 [RudderServo] Hardware Fault, FailCount= 3 2019-02-23T00:12:50.439Z,1550880770.439 [RudderServo](ERROR): Hardware Fault 2019-02-23T00:12:50.478Z,1550880770.478 [CBIT](ERROR): Hardware Fault in component: RudderServo 2019-02-23T00:12:50.479Z,1550880770.479 [CBIT](CRITICAL): Hardware Fault in component: RudderServo 2019-02-23T00:12:50.812Z,1550880770.812 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2019-02-23T00:12:50.812Z,1550880770.812 [RudderServo](INFO): Powering down 2019-02-23T00:12:50.814Z,1550880770.814 [CBIT](INFO): Critical error at 20190223T001250 2019-02-23T00:12:51.615Z,1550880771.615 [RudderServo](DEBUG): Initializing EZServoServo. 2019-02-23T00:12:51.735Z,1550880771.735 [RudderServo](DEBUG): Initializing RudderServo. 2019-02-23T00:12:52.398Z,1550880772.398 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:12:52.824Z,1550880772.824 [BPC1](ERROR): BPC1B: No match for serial number 022A in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2019-02-23T00:12:54.430Z,1550880774.430 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:12:56.438Z,1550880776.438 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:12:57.796Z,1550880777.796 [NavChartDb](INFO): # of records loaded: 15000 2019-02-23T00:12:58.466Z,1550880778.466 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:13:01.698Z,1550880781.698 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:13:01.714Z,1550880781.714 [BPC1](ERROR): BPC1A: No match for serial number 00BB in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2019-02-23T00:13:04.522Z,1550880784.522 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:13:05.744Z,1550880785.744 [BPC1](ERROR): BPC1B: No match for serial number 022A in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2019-02-23T00:13:07.754Z,1550880787.754 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:13:08.078Z,1550880788.078 [NavChartDb](INFO): # of records loaded: 20000 2019-02-23T00:13:10.582Z,1550880790.582 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:13:11.264Z,1550880791.264 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US1WC07M.000 2019-02-23T00:13:13.159Z,1550880793.159 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US1WC07M.000 2019-02-23T00:13:13.414Z,1550880793.414 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:13:15.047Z,1550880795.047 [BPC1](ERROR): BPC1A: No match for serial number 00BB in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2019-02-23T00:13:15.454Z,1550880795.454 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:13:17.458Z,1550880797.458 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:13:19.483Z,1550880799.483 [BPC1](ERROR): BPC1B: No match for serial number 022A in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2019-02-23T00:13:20.686Z,1550880800.686 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:13:22.733Z,1550880802.733 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-02-23T00:13:22.733Z,1550880802.733 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2019-02-23T00:13:22.733Z,1550880802.733 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-02-23T00:13:22.734Z,1550880802.734 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-02-23T00:13:22.734Z,1550880802.734 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 8 2019-02-23T00:13:22.734Z,1550880802.734 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2019-02-23T00:13:22.755Z,1550880802.755 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-02-23T00:13:22.755Z,1550880802.755 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2019-02-23T00:13:23.163Z,1550880803.163 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-02-23T00:13:23.163Z,1550880803.163 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2019-02-23T00:13:23.164Z,1550880803.164 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2019-02-23T00:13:23.164Z,1550880803.164 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 8 2019-02-23T00:13:23.514Z,1550880803.514 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:13:23.537Z,1550880803.537 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2019-02-23T00:13:26.746Z,1550880806.746 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:13:29.179Z,1550880809.179 [BPC1](ERROR): BPC1A: No match for serial number 00BB in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2019-02-23T00:13:29.582Z,1550880809.582 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:13:32.402Z,1550880812.402 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:13:32.830Z,1550880812.830 [BPC1](ERROR): BPC1B: No match for serial number 0202 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2019-02-23T00:13:33.956Z,1550880813.956 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US1WC07M.000 2019-02-23T00:13:34.422Z,1550880814.422 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:13:34.506Z,1550880814.506 [NavChartDb](INFO): # of records loaded: 24424 2019-02-23T00:13:34.517Z,1550880814.517 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US1WC07M.000 2019-02-23T00:13:36.442Z,1550880816.442 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:13:37.388Z,1550880817.388 [NavChartDb](INFO): Creating index for soundings 2019-02-23T00:13:39.678Z,1550880819.678 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:13:42.502Z,1550880822.502 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:13:42.519Z,1550880822.519 [BPC1](ERROR): BPC1A: No match for serial number 0295 in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2019-02-23T00:13:45.738Z,1550880825.738 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:13:46.158Z,1550880826.158 [BPC1](ERROR): BPC1B: No match for serial number 0202 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2019-02-23T00:13:48.521Z,1550880828.521 [NavChartDb](INFO): Creating index for 0p0 2019-02-23T00:13:48.562Z,1550880828.562 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:13:51.794Z,1550880831.794 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:13:51.886Z,1550880831.886 [NavChartDb](INFO): Creating index for 1p8 2019-02-23T00:13:52.631Z,1550880832.631 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2019-02-23T00:13:52.631Z,1550880832.631 [CTD_Seabird] No Fault, FailCount= 3 2019-02-23T00:13:53.010Z,1550880833.010 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2019-02-23T00:13:53.012Z,1550880833.012 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20 2019-02-23T00:13:53.772Z,1550880833.772 [NavChartDb](INFO): Creating index for 3p6 2019-02-23T00:13:54.622Z,1550880834.622 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:13:56.243Z,1550880836.243 [BPC1](ERROR): BPC1A: No match for serial number 0295 in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2019-02-23T00:13:57.469Z,1550880837.469 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:13:59.476Z,1550880839.476 [BPC1](ERROR): BPC1B: No match for serial number 0202 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2019-02-23T00:14:00.221Z,1550880840.221 [NavChartDb](INFO): Creating index for 5p4 2019-02-23T00:14:00.682Z,1550880840.682 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:14:02.537Z,1550880842.537 [NavChartDb](INFO): Creating index for 9p1 2019-02-23T00:14:03.355Z,1550880843.355 [NavChartDb](INFO): Creating index for 10p9 2019-02-23T00:14:03.522Z,1550880843.522 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:14:05.311Z,1550880845.311 [NavChartDb](INFO): Creating index for 18p2 2019-02-23T00:14:06.746Z,1550880846.746 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:14:07.054Z,1550880847.054 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2019-02-23T00:14:07.054Z,1550880847.054 [CTD_Seabird] Communications Fault, FailCount= 1 2019-02-23T00:14:07.054Z,1550880847.054 [CTD_Seabird](ERROR): Communications Fault 2019-02-23T00:14:07.187Z,1550880847.187 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2019-02-23T00:14:07.458Z,1550880847.458 [CTD_Seabird](INFO): Powering down 2019-02-23T00:14:07.612Z,1550880847.612 [NavChartDb](INFO): Creating index for 36p5 2019-02-23T00:14:09.138Z,1550880849.138 [NavChartDb](INFO): Creating index for 54p8 2019-02-23T00:14:09.574Z,1550880849.574 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:14:09.590Z,1550880849.590 [BPC1](ERROR): BPC1A: No match for serial number 0295 in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2019-02-23T00:14:09.619Z,1550880849.619 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2019-02-23T00:14:09.619Z,1550880849.619 [CTD_Seabird] No Fault, FailCount= 1 2019-02-23T00:14:10.349Z,1550880850.349 [NavChartDb](INFO): Creating index for 73p1 2019-02-23T00:14:10.414Z,1550880850.414 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2019-02-23T00:14:10.477Z,1550880850.477 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20 2019-02-23T00:14:12.406Z,1550880852.406 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:14:13.230Z,1550880853.230 [BPC1](ERROR): BPC1B: No match for serial number 0202 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2019-02-23T00:14:14.370Z,1550880854.370 [NavChartDb](INFO): Creating index for 91p4 2019-02-23T00:14:14.426Z,1550880854.426 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:14:16.446Z,1550880856.446 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:14:19.678Z,1550880859.678 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:14:19.721Z,1550880859.721 [NavChartDb](INFO): Creating index for 182p8 2019-02-23T00:14:22.182Z,1550880862.182 [NavChartDb](INFO): Creating index for 274p3 2019-02-23T00:14:22.506Z,1550880862.506 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:14:22.930Z,1550880862.930 [BPC1](ERROR): BPC1A: No match for serial number 0295 in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2019-02-23T00:14:24.526Z,1550880864.526 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2019-02-23T00:14:24.526Z,1550880864.526 [CTD_Seabird] Communications Fault, FailCount= 2 2019-02-23T00:14:24.526Z,1550880864.526 [CTD_Seabird](ERROR): Communications Fault 2019-02-23T00:14:24.555Z,1550880864.555 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2019-02-23T00:14:24.688Z,1550880864.688 [NavChartDb](INFO): Creating index for 365p7 2019-02-23T00:14:24.931Z,1550880864.931 [CTD_Seabird](INFO): Powering down 2019-02-23T00:14:25.610Z,1550880865.610 [NavChartDb](INFO): Creating index for 457p2 2019-02-23T00:14:25.738Z,1550880865.738 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:14:26.562Z,1550880866.562 [BPC1](ERROR): BPC1B: No match for serial number 0202 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2019-02-23T00:14:26.995Z,1550880866.995 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2019-02-23T00:14:26.995Z,1550880866.995 [CTD_Seabird] No Fault, FailCount= 2 2019-02-23T00:14:27.406Z,1550880867.406 [NavChartDb](INFO): Creating index for 548p6 2019-02-23T00:14:27.878Z,1550880867.878 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2019-02-23T00:14:27.886Z,1550880867.886 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20 2019-02-23T00:14:28.566Z,1550880868.566 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:14:29.252Z,1550880869.252 [NavChartDb](INFO): Creating index for 640p0 2019-02-23T00:14:31.798Z,1550880871.798 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:14:32.646Z,1550880872.646 [BPC1](ERROR): Failed to receive data from all battery packs. 2019-02-23T00:14:32.646Z,1550880872.646 [BPC1] Communications Fault, FailCount= 2 2019-02-23T00:14:32.646Z,1550880872.646 [BPC1](ERROR): Communications Fault 2019-02-23T00:14:32.690Z,1550880872.690 [CBIT](ERROR): Communications Fault in component: BPC1 2019-02-23T00:14:33.029Z,1550880873.029 [NavChartDb](INFO): Creating index for 731p5 2019-02-23T00:14:34.626Z,1550880874.626 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:14:35.035Z,1550880875.035 [NavChartDb](INFO): Creating index for 822p9 2019-02-23T00:14:37.412Z,1550880877.412 [NavChartDb](INFO): Creating index for 914p4 2019-02-23T00:14:37.454Z,1550880877.454 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:14:38.435Z,1550880878.435 [NavChartDb](INFO): Creating index for 1005p8 2019-02-23T00:14:39.319Z,1550880879.319 [NavChartDb](INFO): Creating index for 1097p2 2019-02-23T00:14:39.757Z,1550880879.757 [NavChartDb](INFO): Creating index for 1188p7 2019-02-23T00:14:40.590Z,1550880880.590 [NavChartDb](INFO): Creating index for 1280p1 2019-02-23T00:14:40.686Z,1550880880.686 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:14:41.656Z,1550880881.656 [NavChartDb](INFO): Creating index for 1463p0 2019-02-23T00:14:41.926Z,1550880881.926 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2019-02-23T00:14:41.926Z,1550880881.926 [CTD_Seabird] Communications Fault, FailCount= 3 2019-02-23T00:14:41.926Z,1550880881.926 [CTD_Seabird](ERROR): Communications Fault 2019-02-23T00:14:41.936Z,1550880881.936 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2019-02-23T00:14:41.936Z,1550880881.936 [CBIT](FAULT): Communications Fault in component: CTD_Seabird 2019-02-23T00:14:42.330Z,1550880882.330 [CTD_Seabird](INFO): Powering down 2019-02-23T00:14:42.653Z,1550880882.653 [NavChartDb](INFO): Creating index for 1645p9 2019-02-23T00:14:43.526Z,1550880883.526 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:14:45.205Z,1550880885.205 [NavChartDb](INFO): Creating index for 1828p8 2019-02-23T00:14:46.671Z,1550880886.671 [NavChartDb](INFO): Creating index for 2011p6 2019-02-23T00:14:46.746Z,1550880886.746 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:14:47.409Z,1550880887.409 [NavChartDb](INFO): Creating index for 2194p5 2019-02-23T00:14:48.205Z,1550880888.205 [NavChartDb](INFO): Creating index for 2377p4 2019-02-23T00:14:48.882Z,1550880888.882 [NavChartDb](INFO): Creating index for 2560p3 2019-02-23T00:14:49.574Z,1550880889.574 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:14:49.888Z,1550880889.888 [NavChartDb](INFO): Creating index for 2743p2 2019-02-23T00:14:50.787Z,1550880890.787 [NavChartDb](INFO): Creating index for 2926p0 2019-02-23T00:14:51.478Z,1550880891.478 [NavChartDb](INFO): Creating index for 3108p9 2019-02-23T00:14:52.162Z,1550880892.162 [NavChartDb](INFO): Creating index for 3291p8 2019-02-23T00:14:52.402Z,1550880892.402 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:14:52.562Z,1550880892.562 [NavChartDb](INFO): Creating index for 3474p7 2019-02-23T00:14:54.434Z,1550880894.434 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:14:56.446Z,1550880896.446 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:14:59.674Z,1550880899.674 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:14:59.831Z,1550880899.831 [NavChartDb](INFO): Creating index for 3657p6 2019-02-23T00:15:02.502Z,1550880902.502 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:15:05.734Z,1550880905.734 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:15:08.562Z,1550880908.562 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:15:11.798Z,1550880911.798 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:15:14.622Z,1550880914.622 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:15:17.450Z,1550880917.450 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:15:19.074Z,1550880919.074 [Startup:A.GoToSurface](CRITICAL): Surfacing timeout. Returning calc satisfied. 2019-02-23T00:15:19.074Z,1550880919.074 [Startup:StartupSatComms] Running Loop=1 2019-02-23T00:15:19.075Z,1550880919.075 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2019-02-23T00:15:19.075Z,1550880919.075 [Startup:StartupSatComms:A] Running Loop=1 2019-02-23T00:15:19.081Z,1550880919.081 [CBIT](INFO): Critical error at 20190223T001519 2019-02-23T00:15:19.487Z,1550880919.487 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2019-02-23T00:15:20.689Z,1550880920.689 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:15:23.550Z,1550880923.550 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:15:23.567Z,1550880923.567 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-02-23T00:15:23.567Z,1550880923.567 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2019-02-23T00:15:23.568Z,1550880923.568 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-02-23T00:15:23.569Z,1550880923.569 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-02-23T00:15:23.569Z,1550880923.569 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 9 2019-02-23T00:15:23.569Z,1550880923.569 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2019-02-23T00:15:23.622Z,1550880923.622 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-02-23T00:15:23.623Z,1550880923.623 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2019-02-23T00:15:24.030Z,1550880924.030 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-02-23T00:15:24.031Z,1550880924.031 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2019-02-23T00:15:24.031Z,1550880924.031 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2019-02-23T00:15:24.031Z,1550880924.031 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 9 2019-02-23T00:15:24.377Z,1550880924.377 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2019-02-23T00:15:26.778Z,1550880926.778 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:15:29.606Z,1550880929.606 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:15:32.438Z,1550880932.438 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:15:34.454Z,1550880934.454 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:15:37.690Z,1550880937.690 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:15:40.514Z,1550880940.514 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:15:43.750Z,1550880943.750 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:15:46.578Z,1550880946.578 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:15:49.406Z,1550880949.406 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:15:51.422Z,1550880951.422 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:15:53.442Z,1550880953.442 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:15:56.674Z,1550880956.674 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:15:59.506Z,1550880959.506 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:16:02.738Z,1550880962.738 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:16:05.566Z,1550880965.566 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:16:08.394Z,1550880968.394 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:16:10.410Z,1550880970.410 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:16:12.430Z,1550880972.430 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:16:14.454Z,1550880974.454 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:16:17.686Z,1550880977.686 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:16:19.310Z,1550880979.310 [Startup:StartupSatComms:A](INFO): Timed out from 2019-02-23T00:15:19.1Z 2019-02-23T00:16:19.311Z,1550880979.311 [Startup:StartupSatComms:A] Stopped 2019-02-23T00:16:19.311Z,1550880979.311 [Startup:StartupSatComms:B] Running Loop=1 2019-02-23T00:16:19.713Z,1550880979.713 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2019-02-23T00:16:20.514Z,1550880980.514 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:16:23.746Z,1550880983.746 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:16:26.574Z,1550880986.574 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:16:29.402Z,1550880989.402 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:16:31.426Z,1550880991.426 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:16:33.442Z,1550880993.442 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:16:36.674Z,1550880996.674 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:16:39.506Z,1550880999.506 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:16:42.734Z,1550881002.734 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:16:45.562Z,1550881005.562 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:16:48.794Z,1550881008.794 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:16:51.625Z,1550881011.625 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:16:54.450Z,1550881014.450 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:16:57.686Z,1550881017.686 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:17:00.510Z,1550881020.510 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:17:03.750Z,1550881023.750 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:17:06.570Z,1550881026.570 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:17:09.402Z,1550881029.402 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:17:11.422Z,1550881031.422 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:17:12.264Z,1550881032.264 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2019-02-23T00:17:12.264Z,1550881032.264 [CTD_Seabird] No Fault, FailCount= 3 2019-02-23T00:17:12.366Z,1550881032.366 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2019-02-23T00:17:12.368Z,1550881032.368 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20 2019-02-23T00:17:13.438Z,1550881033.438 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:17:15.458Z,1550881035.458 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:17:18.690Z,1550881038.690 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:17:19.527Z,1550881039.527 [Startup:StartupSatComms:B](INFO): Timed out from 2019-02-23T00:16:19.3Z 2019-02-23T00:17:19.527Z,1550881039.527 [Startup:StartupSatComms:B] Stopped 2019-02-23T00:17:19.527Z,1550881039.527 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2019-02-23T00:17:19.527Z,1550881039.527 [Startup:StartupSatComms] Stopped 2019-02-23T00:17:19.527Z,1550881039.527 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2019-02-23T00:17:19.528Z,1550881039.528 [Startup](INFO): Completed Startup 2019-02-23T00:17:19.528Z,1550881039.528 [MissionManager](INFO): Startup is completed. 2019-02-23T00:17:19.528Z,1550881039.528 [MissionManager](INFO): Uninitializing Mission Startup 2019-02-23T00:17:19.528Z,1550881039.528 [Startup] Stopped 2019-02-23T00:17:19.528Z,1550881039.528 [Startup](DEBUG): Aggregate::uninitialize Startup 2019-02-23T00:17:19.528Z,1550881039.528 [Startup:A.GoToSurface] Stopped 2019-02-23T00:17:19.528Z,1550881039.528 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2019-02-23T00:17:19.914Z,1550881039.914 [MissionManager](IMPORTANT): Started mission Default 2019-02-23T00:17:19.914Z,1550881039.914 [Default] Running Loop=1 2019-02-23T00:17:19.914Z,1550881039.914 [Default](DEBUG): Aggregate::initialize Default 2019-02-23T00:17:19.915Z,1550881039.915 [Default:B.GoToSurface] Running Loop=1 2019-02-23T00:17:19.915Z,1550881039.915 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2019-02-23T00:17:19.915Z,1550881039.915 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2019-02-23T00:17:19.915Z,1550881039.915 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2019-02-23T00:17:19.915Z,1550881039.915 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2019-02-23T00:17:19.916Z,1550881039.916 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2019-02-23T00:17:19.916Z,1550881039.916 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2019-02-23T00:17:19.916Z,1550881039.916 [Default:A.Wait] Running Loop=1 2019-02-23T00:17:19.916Z,1550881039.916 [Default:A.Wait](DEBUG): Initialize Wait Component. 2019-02-23T00:17:21.522Z,1550881041.522 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:17:24.377Z,1550881044.377 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-02-23T00:17:24.377Z,1550881044.377 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2019-02-23T00:17:24.377Z,1550881044.377 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-02-23T00:17:24.379Z,1550881044.379 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-02-23T00:17:24.379Z,1550881044.379 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 10 2019-02-23T00:17:24.379Z,1550881044.379 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2019-02-23T00:17:24.466Z,1550881044.466 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-02-23T00:17:24.467Z,1550881044.467 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2019-02-23T00:17:24.770Z,1550881044.770 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:17:24.854Z,1550881044.854 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-02-23T00:17:24.854Z,1550881044.854 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10 2019-02-23T00:17:24.855Z,1550881044.855 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2019-02-23T00:17:24.855Z,1550881044.855 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 10 2019-02-23T00:17:25.196Z,1550881045.196 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2019-02-23T00:17:26.414Z,1550881046.414 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2019-02-23T00:17:26.414Z,1550881046.414 [CTD_Seabird] Communications Fault, FailCount= 1 2019-02-23T00:17:26.414Z,1550881046.414 [CTD_Seabird](ERROR): Communications Fault 2019-02-23T00:17:26.454Z,1550881046.454 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2019-02-23T00:17:26.818Z,1550881046.818 [CTD_Seabird](INFO): Powering down 2019-02-23T00:17:27.602Z,1550881047.602 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:17:28.870Z,1550881048.870 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2019-02-23T00:17:28.870Z,1550881048.870 [CTD_Seabird] No Fault, FailCount= 1 2019-02-23T00:17:29.766Z,1550881049.766 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2019-02-23T00:17:29.768Z,1550881049.768 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20 2019-02-23T00:17:30.426Z,1550881050.426 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:17:32.446Z,1550881052.446 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:17:33.279Z,1550881053.279 [Default:A.Wait](INFO): Done Waiting. 2019-02-23T00:17:33.279Z,1550881053.279 [Default:A.Wait] Stopped 2019-02-23T00:17:33.280Z,1550881053.280 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2019-02-23T00:17:35.678Z,1550881055.678 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:17:38.506Z,1550881058.506 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:17:41.738Z,1550881061.738 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:17:43.810Z,1550881063.810 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2019-02-23T00:17:43.810Z,1550881063.810 [CTD_Seabird] Communications Fault, FailCount= 2 2019-02-23T00:17:43.810Z,1550881063.810 [CTD_Seabird](ERROR): Communications Fault 2019-02-23T00:17:43.827Z,1550881063.827 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2019-02-23T00:17:44.215Z,1550881064.215 [CTD_Seabird](INFO): Powering down 2019-02-23T00:17:44.566Z,1550881064.566 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:17:46.238Z,1550881066.238 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2019-02-23T00:17:46.239Z,1550881066.239 [CTD_Seabird] No Fault, FailCount= 2 2019-02-23T00:17:47.166Z,1550881067.166 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2019-02-23T00:17:47.168Z,1550881067.168 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20 2019-02-23T00:17:47.394Z,1550881067.394 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:17:47.432Z,1550881067.432 [VerticalControl](CRITICAL): Failure to ascend, dropping drop weight after 300.234985 seconds, depthRate=0.000018 m/s, pitch=nan deg. 2019-02-23T00:17:47.489Z,1550881067.489 [CBIT](INFO): Critical error at 20190223T001747 2019-02-23T00:17:48.595Z,1550881068.595 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2019-02-23T00:17:48.595Z,1550881068.595 [DropWeight] Hardware Fault, FailCount= 2 2019-02-23T00:17:48.595Z,1550881068.595 [DropWeight](ERROR): Hardware Fault 2019-02-23T00:17:48.664Z,1550881068.664 [CBIT](INFO): Critical error at 20190223T001748 2019-02-23T00:17:48.699Z,1550881068.699 [CBIT](ERROR): Hardware Fault in component: DropWeight 2019-02-23T00:17:48.699Z,1550881068.699 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2019-02-23T00:17:49.072Z,1550881069.072 [CBIT](INFO): Critical error at 20190223T001748 2019-02-23T00:17:49.414Z,1550881069.414 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:17:51.434Z,1550881071.434 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:17:53.454Z,1550881073.454 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:17:56.694Z,1550881076.694 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:17:59.514Z,1550881079.514 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:18:01.210Z,1550881081.210 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2019-02-23T00:18:01.210Z,1550881081.210 [CTD_Seabird] Communications Fault, FailCount= 3 2019-02-23T00:18:01.210Z,1550881081.210 [CTD_Seabird](ERROR): Communications Fault 2019-02-23T00:18:01.555Z,1550881081.555 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2019-02-23T00:18:01.556Z,1550881081.556 [CBIT](FAULT): Communications Fault in component: CTD_Seabird 2019-02-23T00:18:01.614Z,1550881081.614 [CTD_Seabird](INFO): Powering down 2019-02-23T00:18:02.754Z,1550881082.754 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:18:05.574Z,1550881085.574 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:18:08.406Z,1550881088.406 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:18:10.422Z,1550881090.422 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:18:12.442Z,1550881092.442 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:18:15.674Z,1550881095.674 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:18:18.502Z,1550881098.502 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:18:21.734Z,1550881101.734 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:18:24.562Z,1550881104.562 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:18:27.390Z,1550881107.390 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:18:29.414Z,1550881109.414 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:18:31.434Z,1550881111.434 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:18:33.458Z,1550881113.458 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:18:36.682Z,1550881116.682 [NAL9602](DEBUG): Fix Requested 2019-02-23T00:18:39.500Z,1550881119.500 [NAL9602](FAULT): GPS failed to acquire within timeout. 2019-02-23T00:18:39.500Z,1550881119.500 [NAL9602] Data Fault, FailCount= 2 2019-02-23T00:18:39.500Z,1550881119.500 [NAL9602](ERROR): Data Fault 2019-02-23T00:18:39.536Z,1550881119.536 [CBIT](ERROR): Data Fault in component: NAL9602 2019-02-23T00:18:39.903Z,1550881119.903 [NAL9602](INFO): Powering down 2019-02-23T00:18:40.745Z,1550881120.745 [CBIT](INFO): Clearing failed state for component NAL9602 2019-02-23T00:18:40.745Z,1550881120.745 [NAL9602] No Fault, FailCount= 2 2019-02-23T00:19:10.203Z,1550881150.203 [NAL9602](INFO): Powering up NAL9602 2019-02-23T00:19:12.084Z,1550881152.084 [CommandLine](IMPORTANT): got command quit 2019-02-23T00:19:13.090Z,1550881153.090 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2019-02-23T00:19:13.091Z,1550881153.091 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-02-23T00:19:13.174Z,1550881153.174 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2019-02-23T00:19:13.174Z,1550881153.174 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-02-23T00:19:13.175Z,1550881153.175 [CommandLine](INFO): Join timeout helper Thread ID is 2818 2019-02-23T00:19:13.175Z,1550881153.175 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2019-02-23T00:19:13.175Z,1550881153.175 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-02-23T00:19:13.176Z,1550881153.176 [NavChartDb](INFO): Join timeout helper Thread ID is 2819 2019-02-23T00:19:13.466Z,1550881153.466 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2019-02-23T00:19:13.467Z,1550881153.467 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-02-23T00:19:13.478Z,1550881153.478 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2019-02-23T00:19:13.478Z,1550881153.478 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2019-02-23T00:19:13.479Z,1550881153.479 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 2820 2019-02-23T00:19:13.978Z,1550881153.978 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2019-02-23T00:19:13.978Z,1550881153.978 [WetLabsBB2FL](INFO): Powering down 2019-02-23T00:19:13.979Z,1550881153.979 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2019-02-23T00:19:13.990Z,1550881153.990 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2019-02-23T00:19:13.990Z,1550881153.990 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2019-02-23T00:19:13.991Z,1550881153.991 [CTD_Seabird](INFO): Join timeout helper Thread ID is 2821 2019-02-23T00:19:14.050Z,1550881154.050 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2019-02-23T00:19:14.050Z,1550881154.050 [CTD_Seabird](INFO): Powering down 2019-02-23T00:19:14.062Z,1550881154.062 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2019-02-23T00:19:14.070Z,1550881154.070 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler 2019-02-23T00:19:14.070Z,1550881154.070 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2019-02-23T00:19:14.071Z,1550881154.071 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 2822 2019-02-23T00:19:14.134Z,1550881154.134 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread. 2019-02-23T00:19:14.135Z,1550881154.135 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2019-02-23T00:19:14.155Z,1550881154.155 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2019-02-23T00:19:14.155Z,1550881154.155 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-02-23T00:19:14.156Z,1550881154.156 [Radio_Surface](INFO): Join timeout helper Thread ID is 2823 2019-02-23T00:19:14.394Z,1550881154.394 [Radio_Surface](INFO): Powering down 2019-02-23T00:19:14.395Z,1550881154.395 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2019-02-23T00:19:14.395Z,1550881154.395 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-02-23T00:19:14.415Z,1550881154.415 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2019-02-23T00:19:14.415Z,1550881154.415 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-02-23T00:19:14.416Z,1550881154.416 [DataOverHttps](INFO): Join timeout helper Thread ID is 2824 2019-02-23T00:19:14.416Z,1550881154.416 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2019-02-23T00:19:14.416Z,1550881154.416 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-02-23T00:19:14.417Z,1550881154.417 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2019-02-23T00:19:14.417Z,1550881154.417 [logger ThreadHandler](INFO): Thread cancelled. 2019-02-23T00:19:14.418Z,1550881154.418 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2019-02-23T00:19:14.419Z,1550881154.419 [logger ThreadHandler](INFO): Thread cancelled. 2019-02-23T00:19:14.419Z,1550881154.419 [logger](INFO): Join timeout helper Thread ID is 2825 2019-02-23T00:19:14.420Z,1550881154.420 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2019-02-23T00:19:14.420Z,1550881154.420 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-02-23T00:19:14.420Z,1550881154.420 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2019-02-23T00:19:14.420Z,1550881154.420 [controlThread ThreadHandler](INFO): Thread cancelled. 2019-02-23T00:19:14.421Z,1550881154.421 [controlThread](INFO): Join timeout helper Thread ID is 2826 2019-02-23T00:19:14.642Z,1550881154.642 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2019-02-23T00:19:14.643Z,1550881154.643 [controlThread](DEBUG): Uninitializing ControlThread 2019-02-23T00:19:14.643Z,1550881154.643 [NAL9602](INFO): Powering down 2019-02-23T00:19:14.645Z,1550881154.645 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2019-02-23T00:19:14.646Z,1550881154.646 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2019-02-23T00:19:14.647Z,1550881154.647 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2019-02-23T00:19:14.647Z,1550881154.647 [MissionManager](INFO): Uninitializing Mission Default 2019-02-23T00:19:14.647Z,1550881154.647 [Default] Stopped 2019-02-23T00:19:14.647Z,1550881154.647 [Default](DEBUG): Aggregate::uninitialize Default 2019-02-23T00:19:14.647Z,1550881154.647 [Default:B.GoToSurface] Stopped 2019-02-23T00:19:14.647Z,1550881154.647 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2019-02-23T00:19:14.650Z,1550881154.650 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2019-02-23T00:19:14.650Z,1550881154.650 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2019-02-23T00:19:14.650Z,1550881154.650 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2019-02-23T00:19:14.651Z,1550881154.651 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2019-02-23T00:19:14.651Z,1550881154.651 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2019-02-23T00:19:14.651Z,1550881154.651 [ElevatorServo](INFO): Powering down 2019-02-23T00:19:14.652Z,1550881154.652 [MassServo](DEBUG): Uninitialize Mass Servo. 2019-02-23T00:19:14.652Z,1550881154.652 [MassServo](INFO): Powering down 2019-02-23T00:19:14.653Z,1550881154.653 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2019-02-23T00:19:14.653Z,1550881154.653 [RudderServo](INFO): Powering down 2019-02-23T00:19:14.654Z,1550881154.654 [SBIT](DEBUG): Uninitialize SBIT Component. 2019-02-23T00:19:14.654Z,1550881154.654 [IBIT](DEBUG): Uninitialize IBIT Component. 2019-02-23T00:19:14.654Z,1550881154.654 [CBIT](DEBUG): Uninitialize CBIT Component. 2019-02-23T00:19:14.654Z,1550881154.654 [CBIT](DEBUG): Powering off loads. 2019-02-23T00:19:14.666Z,1550881154.666 [CBIT](DEBUG): Disabling WDT. 2019-02-23T00:19:14.678Z,1550881154.678 [CBIT](DEBUG): Opening all GF detection circuits. 2019-02-23T00:19:14.679Z,1550881154.679 [controlThread ThreadHandler](INFO): Thread cancelled. 2019-02-23T00:19:14.890Z,1550881154.890 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-02-23T00:19:14.895Z,1550881154.895 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-02-23T00:19:14.926Z,1550881154.926 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2019-02-23T00:19:14.928Z,1550881154.928 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2019-02-23T00:19:14.932Z,1550881154.932 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2019-02-23T00:19:14.961Z,1550881154.961 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-02-23T00:19:15.014Z,1550881155.014 [logger ThreadHandler](INFO): Thread cancelled.