2019-04-09T01:07:36.410Z,1554772056.410 [Supervisor](DEBUG): Initializing supervisor. 2019-04-09T01:07:36.413Z,1554772056.413 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2019-04-09T01:07:36.414Z,1554772056.414 [SyncHandler](INFO): Protected caller Thread ID is 5178 2019-04-09T01:07:36.415Z,1554772056.415 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2019-04-09T01:07:36.416Z,1554772056.416 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2019-04-09T01:07:36.416Z,1554772056.416 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 5179 2019-04-09T01:07:36.419Z,1554772056.419 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2019-04-09T01:07:36.431Z,1554772056.431 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2019-04-09T01:07:36.432Z,1554772056.432 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2019-04-09T01:07:36.433Z,1554772056.433 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 5180 2019-04-09T01:07:36.434Z,1554772056.434 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2019-04-09T01:07:36.435Z,1554772056.435 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2019-04-09T01:07:36.435Z,1554772056.435 [logger ThreadHandler](INFO): Protected caller Thread ID is 5181 2019-04-09T01:07:36.437Z,1554772056.437 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2019-04-09T01:07:36.437Z,1554772056.437 [Supervisor](INFO): Looking for Config files in directory: Config/ 2019-04-09T01:07:36.439Z,1554772056.439 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2019-04-09T01:07:36.533Z,1554772056.533 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2019-04-09T01:07:36.534Z,1554772056.534 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2019-04-09T01:07:36.736Z,1554772056.736 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2019-04-09T01:07:36.737Z,1554772056.737 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2019-04-09T01:07:36.873Z,1554772056.873 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2019-04-09T01:07:36.873Z,1554772056.873 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2019-04-09T01:07:37.334Z,1554772057.334 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2019-04-09T01:07:37.335Z,1554772057.335 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2019-04-09T01:07:37.782Z,1554772057.782 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2019-04-09T01:07:37.783Z,1554772057.783 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2019-04-09T01:07:38.257Z,1554772058.257 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2019-04-09T01:07:38.258Z,1554772058.258 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2019-04-09T01:07:38.566Z,1554772058.566 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2019-04-09T01:07:38.566Z,1554772058.566 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2019-04-09T01:07:38.914Z,1554772058.914 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2019-04-09T01:07:38.915Z,1554772058.915 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2019-04-09T01:07:39.311Z,1554772059.311 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2019-04-09T01:07:39.312Z,1554772059.312 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2019-04-09T01:07:39.461Z,1554772059.461 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2019-04-09T01:07:39.462Z,1554772059.462 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2019-04-09T01:07:39.569Z,1554772059.569 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2019-04-09T01:07:39.569Z,1554772059.569 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2019-04-09T01:07:39.649Z,1554772059.649 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2019-04-09T01:07:39.750Z,1554772059.750 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2019-04-09T01:07:39.750Z,1554772059.750 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2019-04-09T01:07:39.945Z,1554772059.945 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2019-04-09T01:07:39.946Z,1554772059.946 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2019-04-09T01:07:40.153Z,1554772060.153 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2019-04-09T01:07:40.155Z,1554772060.155 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/ 2019-04-09T01:07:40.156Z,1554772060.156 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg 2019-04-09T01:07:40.238Z,1554772060.238 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg 2019-04-09T01:07:40.473Z,1554772060.473 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2019-04-09T01:07:40.474Z,1554772060.474 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg 2019-04-09T01:07:40.577Z,1554772060.577 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg 2019-04-09T01:07:40.789Z,1554772060.789 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg 2019-04-09T01:07:41.246Z,1554772061.246 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg 2019-04-09T01:07:41.369Z,1554772061.369 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg 2019-04-09T01:07:41.472Z,1554772061.472 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg 2019-04-09T01:07:41.715Z,1554772061.715 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg 2019-04-09T01:07:41.866Z,1554772061.866 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg 2019-04-09T01:07:41.970Z,1554772061.970 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg 2019-04-09T01:07:42.068Z,1554772062.068 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/ 2019-04-09T01:07:42.068Z,1554772062.068 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2019-04-09T01:07:42.072Z,1554772062.072 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2019-04-09T01:07:42.178Z,1554772062.178 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2019-04-09T01:07:42.179Z,1554772062.179 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2019-04-09T01:07:42.309Z,1554772062.309 [BuoyancyServo] Loaded 2019-04-09T01:07:42.309Z,1554772062.309 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2019-04-09T01:07:42.325Z,1554772062.325 [ElevatorServo] Loaded 2019-04-09T01:07:42.325Z,1554772062.325 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2019-04-09T01:07:42.340Z,1554772062.340 [MassServo] Loaded 2019-04-09T01:07:42.341Z,1554772062.341 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2019-04-09T01:07:42.356Z,1554772062.356 [RudderServo] Loaded 2019-04-09T01:07:42.356Z,1554772062.356 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2019-04-09T01:07:42.371Z,1554772062.371 [ThrusterServo] Loaded 2019-04-09T01:07:42.371Z,1554772062.371 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2019-04-09T01:07:42.372Z,1554772062.372 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2019-04-09T01:07:42.372Z,1554772062.372 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2019-04-09T01:07:42.518Z,1554772062.518 [SBIT](DEBUG): Construct Startup Built In Test. 2019-04-09T01:07:42.547Z,1554772062.547 [SBIT] Loaded 2019-04-09T01:07:42.547Z,1554772062.547 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2019-04-09T01:07:42.548Z,1554772062.548 [IBIT](DEBUG): Construct Initiated Built In Test. 2019-04-09T01:07:42.577Z,1554772062.577 [IBIT] Loaded 2019-04-09T01:07:42.577Z,1554772062.577 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2019-04-09T01:07:42.580Z,1554772062.580 [CBIT](DEBUG): Construct Continuous Built In Test. 2019-04-09T01:07:42.983Z,1554772062.983 [CBIT] Loaded 2019-04-09T01:07:42.983Z,1554772062.983 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2019-04-09T01:07:42.983Z,1554772062.983 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2019-04-09T01:07:42.984Z,1554772062.984 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2019-04-09T01:07:43.179Z,1554772063.179 [Aanderaa_O2] Loaded 2019-04-09T01:07:43.179Z,1554772063.179 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread. 2019-04-09T01:07:43.189Z,1554772063.189 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density 2019-04-09T01:07:43.194Z,1554772063.194 [CTD_Seabird](INFO): created writer for : sea_water_density 2019-04-09T01:07:43.196Z,1554772063.196 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth 2019-04-09T01:07:43.201Z,1554772063.201 [CTD_Seabird](INFO): created writer for : depth 2019-04-09T01:07:43.202Z,1554772063.202 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure 2019-04-09T01:07:43.207Z,1554772063.207 [CTD_Seabird](INFO): created writer for : sea_water_pressure 2019-04-09T01:07:43.208Z,1554772063.208 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity 2019-04-09T01:07:43.213Z,1554772063.213 [CTD_Seabird](INFO): created writer for : sea_water_salinity 2019-04-09T01:07:43.214Z,1554772063.214 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature 2019-04-09T01:07:43.219Z,1554772063.219 [CTD_Seabird](INFO): created writer for : sea_water_temperature 2019-04-09T01:07:43.220Z,1554772063.220 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity 2019-04-09T01:07:43.226Z,1554772063.226 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity 2019-04-09T01:07:43.226Z,1554772063.226 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water 2019-04-09T01:07:43.232Z,1554772063.232 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water 2019-04-09T01:07:43.259Z,1554772063.259 [CTD_Seabird] Loaded 2019-04-09T01:07:43.259Z,1554772063.259 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2019-04-09T01:07:43.260Z,1554772063.260 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406654E0 2019-04-09T01:07:43.261Z,1554772063.261 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 5260 2019-04-09T01:07:43.287Z,1554772063.287 [ESPComponent] Loaded 2019-04-09T01:07:43.287Z,1554772063.287 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2019-04-09T01:07:43.301Z,1554772063.301 [PAR_Licor] Loaded 2019-04-09T01:07:43.302Z,1554772063.302 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2019-04-09T01:07:43.351Z,1554772063.351 [WetLabsBB2FL] Loaded 2019-04-09T01:07:43.352Z,1554772063.352 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2019-04-09T01:07:43.353Z,1554772063.353 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406954E0 2019-04-09T01:07:43.353Z,1554772063.353 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 5261 2019-04-09T01:07:43.354Z,1554772063.354 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2019-04-09T01:07:43.354Z,1554772063.354 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2019-04-09T01:07:43.397Z,1554772063.397 [DepthRateCalculator] Loaded 2019-04-09T01:07:43.397Z,1554772063.397 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2019-04-09T01:07:43.403Z,1554772063.403 [PitchRateCalculator] Loaded 2019-04-09T01:07:43.403Z,1554772063.403 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2019-04-09T01:07:43.420Z,1554772063.420 [SpeedCalculator] Loaded 2019-04-09T01:07:43.420Z,1554772063.420 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2019-04-09T01:07:43.442Z,1554772063.442 [TempGradientCalculator] Loaded 2019-04-09T01:07:43.442Z,1554772063.442 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2019-04-09T01:07:43.448Z,1554772063.448 [YawRateCalculator] Loaded 2019-04-09T01:07:43.449Z,1554772063.449 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2019-04-09T01:07:43.482Z,1554772063.482 [ElevatorOffsetCalculator] Loaded 2019-04-09T01:07:43.483Z,1554772063.483 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2019-04-09T01:07:43.483Z,1554772063.483 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2019-04-09T01:07:43.484Z,1554772063.484 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2019-04-09T01:07:43.512Z,1554772063.512 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2019-04-09T01:07:43.513Z,1554772063.513 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2019-04-09T01:07:43.619Z,1554772063.619 [DeadReckonUsingMultipleVelocitySources] Loaded 2019-04-09T01:07:43.620Z,1554772063.620 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2019-04-09T01:07:43.681Z,1554772063.681 [DeadReckonUsingSpeedCalculator] Loaded 2019-04-09T01:07:43.682Z,1554772063.682 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2019-04-09T01:07:43.744Z,1554772063.744 [DeadReckonWithRespectToSeafloor] Loaded 2019-04-09T01:07:43.744Z,1554772063.744 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread. 2019-04-09T01:07:43.765Z,1554772063.765 [NavChart] Loaded 2019-04-09T01:07:43.766Z,1554772063.766 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2019-04-09T01:07:43.770Z,1554772063.770 [UniversalFixResidualReporter] Loaded 2019-04-09T01:07:43.770Z,1554772063.770 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2019-04-09T01:07:43.770Z,1554772063.770 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2019-04-09T01:07:43.771Z,1554772063.771 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2019-04-09T01:07:44.101Z,1554772064.101 [AcousticModem_Benthos_ATM900] Loaded 2019-04-09T01:07:44.101Z,1554772064.101 [ComponentRegistry](DEBUG): SyncComponent "AcousticModem_Benthos_ATM900" handled in the control thread. 2019-04-09T01:07:44.177Z,1554772064.177 [DataOverHttps] Loaded 2019-04-09T01:07:44.178Z,1554772064.178 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2019-04-09T01:07:44.179Z,1554772064.179 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409704E0 2019-04-09T01:07:44.179Z,1554772064.179 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 5262 2019-04-09T01:07:44.193Z,1554772064.193 [Depth_Keller] Loaded 2019-04-09T01:07:44.193Z,1554772064.193 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2019-04-09T01:07:44.289Z,1554772064.289 [NAL9602] Loaded 2019-04-09T01:07:44.289Z,1554772064.289 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2019-04-09T01:07:44.294Z,1554772064.294 [Onboard] Loaded 2019-04-09T01:07:44.295Z,1554772064.295 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2019-04-09T01:07:44.298Z,1554772064.298 [Radio_Surface] Loaded 2019-04-09T01:07:44.298Z,1554772064.298 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2019-04-09T01:07:44.299Z,1554772064.299 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409A04E0 2019-04-09T01:07:44.300Z,1554772064.300 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 5263 2019-04-09T01:07:45.656Z,1554772065.656 [BPC1] Loaded 2019-04-09T01:07:45.657Z,1554772065.657 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2019-04-09T01:07:45.659Z,1554772065.659 [BR_Ping1D](INFO): constructor 2019-04-09T01:07:45.688Z,1554772065.688 [BR_Ping1D](CRITICAL): No configuration setting for: BR_Ping1D.minrange 2019-04-09T01:07:45.690Z,1554772065.690 [BR_Ping1D](CRITICAL): No configuration setting for: BR_Ping1D.maxrange 2019-04-09T01:07:45.692Z,1554772065.692 [BR_Ping1D](CRITICAL): No configuration setting for: BR_Ping1D.soundspeed 2019-04-09T01:07:45.694Z,1554772065.694 [BR_Ping1D](CRITICAL): No configuration setting for: BR_Ping1D.automode 2019-04-09T01:07:45.697Z,1554772065.697 [BR_Ping1D](CRITICAL): No configuration setting for: BR_Ping1D.gainindex 2019-04-09T01:07:45.699Z,1554772065.699 [BR_Ping1D](CRITICAL): No configuration setting for: BR_Ping1D.minconfidence 2019-04-09T01:07:45.701Z,1554772065.701 [BR_Ping1D](CRITICAL): No configuration setting for: BR_Ping1D.pingenable 2019-04-09T01:07:45.703Z,1554772065.703 [BR_Ping1D] Loaded 2019-04-09T01:07:45.703Z,1554772065.703 [ComponentRegistry](DEBUG): SyncComponent "BR_Ping1D" handled in the control thread. 2019-04-09T01:07:45.704Z,1554772065.704 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2019-04-09T01:07:45.704Z,1554772065.704 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2019-04-09T01:07:45.839Z,1554772065.839 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2019-04-09T01:07:45.840Z,1554772065.840 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2019-04-09T01:07:46.011Z,1554772066.011 [VerticalControl](DEBUG): Construct VerticalControl. 2019-04-09T01:07:46.121Z,1554772066.121 [VerticalControl] Loaded 2019-04-09T01:07:46.121Z,1554772066.121 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2019-04-09T01:07:46.122Z,1554772066.122 [HorizontalControl](DEBUG): Construct HorizontalControl. 2019-04-09T01:07:46.181Z,1554772066.181 [HorizontalControl] Loaded 2019-04-09T01:07:46.181Z,1554772066.181 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2019-04-09T01:07:46.182Z,1554772066.182 [SpeedControl](DEBUG): Construct SpeedControl. 2019-04-09T01:07:46.183Z,1554772066.183 [SpeedControl] Loaded 2019-04-09T01:07:46.184Z,1554772066.184 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2019-04-09T01:07:46.184Z,1554772066.184 [LoopControl](DEBUG): Construct LoopControl. 2019-04-09T01:07:46.185Z,1554772066.185 [LoopControl] Loaded 2019-04-09T01:07:46.185Z,1554772066.185 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2019-04-09T01:07:46.186Z,1554772066.186 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2019-04-09T01:07:46.186Z,1554772066.186 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2019-04-09T01:07:46.200Z,1554772066.200 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2019-04-09T01:07:46.200Z,1554772066.200 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2019-04-09T01:07:46.499Z,1554772066.499 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2019-04-09T01:07:46.503Z,1554772066.503 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2019-04-09T01:07:46.504Z,1554772066.504 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2019-04-09T01:07:46.511Z,1554772066.511 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2019-04-09T01:07:46.512Z,1554772066.512 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40ACD4E0 2019-04-09T01:07:46.512Z,1554772066.512 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 5264 2019-04-09T01:07:46.517Z,1554772066.517 [Supervisor](INFO): Main Thread ID is 4347 2019-04-09T01:07:46.517Z,1554772066.517 [Supervisor](DEBUG): Running supervisor. 2019-04-09T01:07:46.518Z,1554772066.518 [CommandLine ThreadHandler](INFO): Handler Thread ID is 5265 2019-04-09T01:07:46.520Z,1554772066.520 [controlThread ThreadHandler](INFO): Handler Thread ID is 5266 2019-04-09T01:07:46.520Z,1554772066.520 [controlThread](DEBUG): Initializing ControlThread 2019-04-09T01:07:46.522Z,1554772066.522 [SBIT](INFO): Initialize SBIT Component. 2019-04-09T01:07:46.523Z,1554772066.523 [SBIT](IMPORTANT): git: 2019-03-18-31-ge98d5dc 2019-04-09T01:07:46.523Z,1554772066.523 [SBIT](INFO): git hash: e98d5dc50cbc39e402f19b9946ff4dc0776c8725 2019-04-09T01:07:46.523Z,1554772066.523 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2019-04-09T01:07:46.525Z,1554772066.525 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018 Kernel Reported: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019 2019-04-09T01:07:46.526Z,1554772066.526 [SBIT](INFO): Beginning SBIT in 24.000000 seconds. 2019-04-09T01:07:46.526Z,1554772066.526 [IBIT](INFO): Initialize IBIT Component. 2019-04-09T01:07:46.527Z,1554772066.527 [CBIT](DEBUG): Initialize CBIT Component. 2019-04-09T01:07:46.528Z,1554772066.528 [logger ThreadHandler](INFO): Handler Thread ID is 5267 2019-04-09T01:07:46.538Z,1554772066.538 [CBIT](DEBUG): Initialized mux pins. 2019-04-09T01:07:46.538Z,1554772066.538 [CBIT](DEBUG): Initializing the watchdog timer. 2019-04-09T01:07:46.546Z,1554772066.546 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 5268 2019-04-09T01:07:46.547Z,1554772066.547 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2019-04-09T01:07:46.551Z,1554772066.551 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20 2019-04-09T01:07:46.552Z,1554772066.552 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 5270 2019-04-09T01:07:46.553Z,1554772066.553 [WetLabsBB2FL](INFO): Powering down 2019-04-09T01:07:46.562Z,1554772066.562 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2019-04-09T01:07:46.563Z,1554772066.563 [CBIT](DEBUG): Initializing heartbeat. 2019-04-09T01:07:46.583Z,1554772066.583 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 5271 2019-04-09T01:07:46.584Z,1554772066.584 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2019-04-09T01:07:46.595Z,1554772066.595 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 5272 2019-04-09T01:07:46.610Z,1554772066.610 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 5273 2019-04-09T01:07:46.613Z,1554772066.613 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2019-04-09T01:07:46.613Z,1554772066.613 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2019-04-09T01:07:46.614Z,1554772066.614 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2019-04-09T01:07:46.614Z,1554772066.614 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2019-04-09T01:07:46.614Z,1554772066.614 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2019-04-09T01:07:46.614Z,1554772066.614 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2019-04-09T01:07:46.614Z,1554772066.614 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2019-04-09T01:07:46.615Z,1554772066.615 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2019-04-09T01:07:46.615Z,1554772066.615 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2019-04-09T01:07:46.615Z,1554772066.615 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2019-04-09T01:07:46.615Z,1554772066.615 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2019-04-09T01:07:46.615Z,1554772066.615 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2019-04-09T01:07:46.616Z,1554772066.616 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2019-04-09T01:07:46.616Z,1554772066.616 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2019-04-09T01:07:46.616Z,1554772066.616 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2019-04-09T01:07:46.616Z,1554772066.616 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2019-04-09T01:07:46.634Z,1554772066.634 [CBIT](DEBUG): Deactivating GF circuits. 2019-04-09T01:07:46.634Z,1554772066.634 [CBIT](DEBUG): Deactivating emergency mode. 2019-04-09T01:07:46.670Z,1554772066.670 [CBIT](DEBUG): Backplane powered. 2019-04-09T01:07:46.674Z,1554772066.674 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2019-04-09T01:07:46.675Z,1554772066.675 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2019-04-09T01:07:46.675Z,1554772066.675 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2019-04-09T01:07:46.675Z,1554772066.675 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2019-04-09T01:07:46.676Z,1554772066.676 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2019-04-09T01:07:46.676Z,1554772066.676 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2019-04-09T01:07:46.677Z,1554772066.677 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2019-04-09T01:07:46.678Z,1554772066.678 [NavChart](DEBUG): Initialize NavChart Navigation. 2019-04-09T01:07:46.679Z,1554772066.679 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2019-04-09T01:07:46.683Z,1554772066.683 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2019-04-09T01:07:46.685Z,1554772066.685 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2019-04-09T01:07:46.690Z,1554772066.690 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2019-04-09T01:07:46.691Z,1554772066.691 [LoopControl](DEBUG): Initialize LoopControlComponent. 2019-04-09T01:07:46.692Z,1554772066.692 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2019-04-09T01:07:46.717Z,1554772066.717 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2019-04-09T01:07:46.753Z,1554772066.753 [MissionManager](DEBUG): 2019-04-09T01:07:46.754Z,1554772066.754 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2019-04-09T01:07:46.822Z,1554772066.822 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2019-04-09T01:07:46.823Z,1554772066.823 [Default:A.Wait](DEBUG): Construct Wait. 2019-04-09T01:07:46.825Z,1554772066.825 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2019-04-09T01:07:46.877Z,1554772066.877 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2019-04-09T01:07:46.879Z,1554772066.879 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2019-04-09T01:07:46.904Z,1554772066.904 [Default:E.Execute](DEBUG): Construct Execute. 2019-04-09T01:07:46.927Z,1554772066.927 [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-04-09T01:07:46.946Z,1554772066.946 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,ESPComponent,PAR_Licor,AcousticModem_Benthos_ATM900,Depth_Keller,NAL9602,Onboard,BPC1,BR_Ping1D,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2019-04-09T01:07:46.959Z,1554772066.959 [ESPComponent](INFO): powering down ESP 2019-04-09T01:07:46.998Z,1554772066.998 [Radio_Surface](INFO): Powering up 2019-04-09T01:07:47.403Z,1554772067.403 [PAR_Licor](INFO): A/D timeout, 8 tries over 134 ms 2019-04-09T01:07:47.403Z,1554772067.403 [PAR_Licor] Data Fault, FailCount= 1 2019-04-09T01:07:47.403Z,1554772067.403 [PAR_Licor](ERROR): Data Fault 2019-04-09T01:07:47.404Z,1554772067.404 [AcousticModem_Benthos_ATM900](INFO): Powering up 2019-04-09T01:07:47.404Z,1554772067.404 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900. 2019-04-09T01:07:47.427Z,1554772067.427 [Depth_Keller](ERROR): Pressure reading out of range: 1895.684326 decibar 2019-04-09T01:07:47.474Z,1554772067.474 [BR_Ping1D](INFO): Start 2019-04-09T01:07:47.478Z,1554772067.478 [DepthRateCalculator](ERROR): Depth measurement is not active 2019-04-09T01:07:47.522Z,1554772067.522 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2019-04-09T01:07:47.530Z,1554772067.530 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2019-04-09T01:07:47.532Z,1554772067.532 [ElevatorServo](DEBUG): Initializing EZServoServo. 2019-04-09T01:07:47.538Z,1554772067.538 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2019-04-09T01:07:47.539Z,1554772067.539 [MassServo](DEBUG): Initializing EZServoServo. 2019-04-09T01:07:47.546Z,1554772067.546 [MassServo](DEBUG): Initializing MassServo. 2019-04-09T01:07:47.547Z,1554772067.547 [RudderServo](DEBUG): Initializing EZServoServo. 2019-04-09T01:07:47.554Z,1554772067.554 [RudderServo](DEBUG): Initializing RudderServo. 2019-04-09T01:07:47.555Z,1554772067.555 [ThrusterServo](DEBUG): Initializing EZServoServo. 2019-04-09T01:07:47.562Z,1554772067.562 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2019-04-09T01:07:47.565Z,1554772067.565 [CommandLine](FAULT): Scheduling is paused 2019-04-09T01:07:47.565Z,1554772067.565 [CBIT](INFO): Critical error at 20190409T010745 2019-04-09T01:07:47.565Z,1554772067.565 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2019-04-09T01:07:47.566Z,1554772067.566 [CBIT](FAULT): Main Battery Failure. Count: 1 2019-04-09T01:07:47.570Z,1554772067.570 [CBIT](ERROR): Data Fault in component: PAR_Licor 2019-04-09T01:07:47.570Z,1554772067.570 [CBIT](INFO): Clearing failed state for component PAR_Licor 2019-04-09T01:07:47.570Z,1554772067.570 [PAR_Licor] No Fault, FailCount= 1 2019-04-09T01:07:47.688Z,1554772067.688 [BR_Ping1D](INFO): Starting 2019-04-09T01:07:48.110Z,1554772068.110 [PAR_Licor](INFO): A/D timeout, 8 tries over 130 ms 2019-04-09T01:07:48.110Z,1554772068.110 [PAR_Licor] Data Fault, FailCount= 2 2019-04-09T01:07:48.110Z,1554772068.110 [PAR_Licor](ERROR): Data Fault 2019-04-09T01:07:48.140Z,1554772068.140 [BR_Ping1D](INFO): Starting 2019-04-09T01:07:48.140Z,1554772068.140 [BR_Ping1D](INFO): readConfig 2019-04-09T01:07:48.141Z,1554772068.141 [BR_Ping1D](INFO): XXXX automode1: 1 2019-04-09T01:07:48.141Z,1554772068.141 [BR_Ping1D](INFO): XXXX automode2: 1 2019-04-09T01:07:48.141Z,1554772068.141 [BR_Ping1D](INFO): UART setting parameters ... 2019-04-09T01:07:48.154Z,1554772068.154 [BR_Ping1D](INFO): sending request for Ping Interval: 500 2019-04-09T01:07:48.154Z,1554772068.154 [BR_Ping1D](INFO): sending request for Auto Mode: 1 2019-04-09T01:07:48.155Z,1554772068.155 [BR_Ping1D](INFO): sending request for Soundspeed: 1075049184 2019-04-09T01:07:48.155Z,1554772068.155 [BR_Ping1D](INFO): sending request for Ping Enable: 224 2019-04-09T01:07:48.518Z,1554772068.518 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2019-04-09T01:07:48.518Z,1554772068.518 [RudderServo](FAULT): Rudder failed to initialize 2019-04-09T01:07:48.518Z,1554772068.518 [RudderServo] Communications Fault, FailCount= 1 2019-04-09T01:07:48.518Z,1554772068.518 [RudderServo](ERROR): Communications Fault 2019-04-09T01:07:48.629Z,1554772068.629 [CBIT](ERROR): Communications Fault in component: RudderServo 2019-04-09T01:07:48.630Z,1554772068.630 [CBIT](ERROR): Data Fault in component: PAR_Licor 2019-04-09T01:07:48.630Z,1554772068.630 [CBIT](INFO): Clearing failed state for component PAR_Licor 2019-04-09T01:07:48.630Z,1554772068.630 [PAR_Licor] No Fault, FailCount= 2 2019-04-09T01:07:48.673Z,1554772068.673 [BR_Ping1D](INFO): Starting 2019-04-09T01:07:48.673Z,1554772068.673 [BR_Ping1D](INFO): readConfig 2019-04-09T01:07:48.674Z,1554772068.674 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:07:48.674Z,1554772068.674 [BR_Ping1D](INFO): XXXX automode2: 1 2019-04-09T01:07:48.674Z,1554772068.674 [BR_Ping1D](INFO): UART requesting status 2019-04-09T01:07:48.827Z,1554772068.827 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2019-04-09T01:07:48.827Z,1554772068.827 [RudderServo](INFO): Powering down 2019-04-09T01:07:49.061Z,1554772069.061 [BR_Ping1D](INFO): Starting 2019-04-09T01:07:49.582Z,1554772069.582 [PAR_Licor](INFO): A/D timeout, 8 tries over 138 ms 2019-04-09T01:07:49.582Z,1554772069.582 [PAR_Licor] Data Fault, FailCount= 1 2019-04-09T01:07:49.582Z,1554772069.582 [PAR_Licor](ERROR): Data Fault 2019-04-09T01:07:49.617Z,1554772069.617 [BR_Ping1D](INFO): Starting 2019-04-09T01:07:49.618Z,1554772069.618 [BR_Ping1D](INFO): readConfig 2019-04-09T01:07:49.618Z,1554772069.618 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:07:49.618Z,1554772069.618 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:07:49.618Z,1554772069.618 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:07:49.618Z,1554772069.618 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:07:49.619Z,1554772069.619 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:07:49.619Z,1554772069.619 [BR_Ping1D](INFO): No UART data 2019-04-09T01:07:49.651Z,1554772069.651 [RudderServo](DEBUG): Initializing EZServoServo. 2019-04-09T01:07:49.771Z,1554772069.771 [RudderServo](DEBUG): Initializing RudderServo. 2019-04-09T01:07:49.775Z,1554772069.775 [CBIT](INFO): Clearing failed state for component RudderServo 2019-04-09T01:07:49.775Z,1554772069.775 [RudderServo] No Fault, FailCount= 1 2019-04-09T01:07:49.775Z,1554772069.775 [CBIT](ERROR): Data Fault in component: PAR_Licor 2019-04-09T01:07:49.776Z,1554772069.776 [CBIT](INFO): Clearing failed state for component PAR_Licor 2019-04-09T01:07:49.776Z,1554772069.776 [PAR_Licor] No Fault, FailCount= 1 2019-04-09T01:07:49.869Z,1554772069.869 [BR_Ping1D](INFO): Starting 2019-04-09T01:07:50.218Z,1554772070.218 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout 2019-04-09T01:07:50.218Z,1554772070.218 [MassServo] Communications Fault, FailCount= 1 2019-04-09T01:07:50.218Z,1554772070.218 [MassServo](ERROR): Communications Fault 2019-04-09T01:07:50.250Z,1554772070.250 [CBIT](ERROR): Communications Fault in component: MassServo 2019-04-09T01:07:50.292Z,1554772070.292 [BR_Ping1D](INFO): Starting 2019-04-09T01:07:50.292Z,1554772070.292 [BR_Ping1D](INFO): readConfig 2019-04-09T01:07:50.292Z,1554772070.292 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:07:50.292Z,1554772070.292 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:07:50.292Z,1554772070.292 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:07:50.293Z,1554772070.293 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:07:50.293Z,1554772070.293 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:07:50.293Z,1554772070.293 [BR_Ping1D](INFO): No UART data 2019-04-09T01:07:50.394Z,1554772070.394 [MassServo](DEBUG): Uninitialize Mass Servo. 2019-04-09T01:07:50.394Z,1554772070.394 [MassServo](INFO): Powering down 2019-04-09T01:07:50.681Z,1554772070.681 [BR_Ping1D](INFO): Starting 2019-04-09T01:07:51.210Z,1554772071.210 [PAR_Licor](INFO): A/D timeout, 9 tries over 146 ms 2019-04-09T01:07:51.210Z,1554772071.210 [PAR_Licor] Data Fault, FailCount= 1 2019-04-09T01:07:51.210Z,1554772071.210 [PAR_Licor](ERROR): Data Fault 2019-04-09T01:07:51.246Z,1554772071.246 [BR_Ping1D](INFO): Starting 2019-04-09T01:07:51.246Z,1554772071.246 [BR_Ping1D](INFO): readConfig 2019-04-09T01:07:51.246Z,1554772071.246 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:07:51.246Z,1554772071.246 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:07:51.246Z,1554772071.246 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:07:51.247Z,1554772071.247 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:07:51.247Z,1554772071.247 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:07:51.247Z,1554772071.247 [BR_Ping1D](INFO): No UART data 2019-04-09T01:07:51.348Z,1554772071.348 [MassServo](DEBUG): Initializing EZServoServo. 2019-04-09T01:07:51.467Z,1554772071.467 [MassServo](DEBUG): Initializing MassServo. 2019-04-09T01:07:51.614Z,1554772071.614 [CBIT](INFO): Clearing failed state for component MassServo 2019-04-09T01:07:51.614Z,1554772071.614 [MassServo] No Fault, FailCount= 1 2019-04-09T01:07:51.614Z,1554772071.614 [CBIT](ERROR): Data Fault in component: PAR_Licor 2019-04-09T01:07:51.615Z,1554772071.615 [CBIT](INFO): Clearing failed state for component PAR_Licor 2019-04-09T01:07:51.615Z,1554772071.615 [PAR_Licor] No Fault, FailCount= 1 2019-04-09T01:07:51.665Z,1554772071.665 [BR_Ping1D](INFO): Starting 2019-04-09T01:07:51.700Z,1554772071.700 [CBIT](FAULT): Main Battery Failure. Count: 11 2019-04-09T01:07:52.162Z,1554772072.162 [PAR_Licor](INFO): A/D timeout, 8 tries over 138 ms 2019-04-09T01:07:52.162Z,1554772072.162 [PAR_Licor] Data Fault, FailCount= 2 2019-04-09T01:07:52.162Z,1554772072.162 [PAR_Licor](ERROR): Data Fault 2019-04-09T01:07:52.203Z,1554772072.203 [BR_Ping1D](INFO): Starting 2019-04-09T01:07:52.203Z,1554772072.203 [BR_Ping1D](INFO): readConfig 2019-04-09T01:07:52.203Z,1554772072.203 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:07:52.203Z,1554772072.203 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:07:52.203Z,1554772072.203 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:07:52.203Z,1554772072.203 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:07:52.204Z,1554772072.204 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:07:52.204Z,1554772072.204 [BR_Ping1D](INFO): No UART data 2019-04-09T01:07:52.262Z,1554772072.262 [CBIT](ERROR): Data Fault in component: PAR_Licor 2019-04-09T01:07:52.262Z,1554772072.262 [CBIT](INFO): Clearing failed state for component PAR_Licor 2019-04-09T01:07:52.262Z,1554772072.262 [PAR_Licor] No Fault, FailCount= 2 2019-04-09T01:07:52.450Z,1554772072.450 [BR_Ping1D](INFO): Starting 2019-04-09T01:07:52.962Z,1554772072.962 [PAR_Licor](INFO): A/D timeout, 7 tries over 130 ms 2019-04-09T01:07:52.962Z,1554772072.962 [PAR_Licor] Data Fault, FailCount= 3 2019-04-09T01:07:52.962Z,1554772072.962 [PAR_Licor](ERROR): Data Fault 2019-04-09T01:07:52.999Z,1554772072.999 [BR_Ping1D](INFO): Starting 2019-04-09T01:07:52.999Z,1554772072.999 [BR_Ping1D](INFO): readConfig 2019-04-09T01:07:52.999Z,1554772072.999 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:07:52.999Z,1554772072.999 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:07:52.999Z,1554772072.999 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:07:52.999Z,1554772072.999 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:07:52.000Z,1554772073.000 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:07:52.000Z,1554772073.000 [BR_Ping1D](INFO): No UART data 2019-04-09T01:07:53.078Z,1554772073.078 [CBIT](ERROR): Data Fault in component: PAR_Licor 2019-04-09T01:07:53.079Z,1554772073.079 [CBIT](CRITICAL): Data Fault in component: PAR_Licor 2019-04-09T01:07:53.253Z,1554772073.253 [BR_Ping1D](INFO): Starting 2019-04-09T01:07:53.560Z,1554772073.560 [CBIT](INFO): Critical error at 20190409T010753 2019-04-09T01:07:53.658Z,1554772073.658 [BR_Ping1D](INFO): Starting 2019-04-09T01:07:53.658Z,1554772073.658 [BR_Ping1D](INFO): readConfig 2019-04-09T01:07:53.658Z,1554772073.658 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:07:53.658Z,1554772073.658 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:07:53.658Z,1554772073.658 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:07:53.659Z,1554772073.659 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:07:53.659Z,1554772073.659 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:07:53.659Z,1554772073.659 [BR_Ping1D](INFO): No UART data 2019-04-09T01:07:53.982Z,1554772073.982 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout 2019-04-09T01:07:53.982Z,1554772073.982 [MassServo] Communications Fault, FailCount= 2 2019-04-09T01:07:53.982Z,1554772073.982 [MassServo](ERROR): Communications Fault 2019-04-09T01:07:53.986Z,1554772073.986 [CBIT](ERROR): Communications Fault in component: MassServo 2019-04-09T01:07:54.066Z,1554772074.066 [BR_Ping1D](INFO): Starting 2019-04-09T01:07:54.095Z,1554772074.095 [MassServo](DEBUG): Uninitialize Mass Servo. 2019-04-09T01:07:54.095Z,1554772074.095 [MassServo](INFO): Powering down 2019-04-09T01:07:54.467Z,1554772074.467 [BR_Ping1D](INFO): Starting 2019-04-09T01:07:54.467Z,1554772074.467 [BR_Ping1D](INFO): readConfig 2019-04-09T01:07:54.467Z,1554772074.467 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:07:54.467Z,1554772074.467 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:07:54.468Z,1554772074.468 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:07:54.468Z,1554772074.468 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:07:54.468Z,1554772074.468 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:07:54.468Z,1554772074.468 [BR_Ping1D](INFO): No UART data 2019-04-09T01:07:54.869Z,1554772074.869 [BR_Ping1D](INFO): Starting 2019-04-09T01:07:54.883Z,1554772074.883 [MassServo](DEBUG): Initializing EZServoServo. 2019-04-09T01:07:55.003Z,1554772075.003 [MassServo](DEBUG): Initializing MassServo. 2019-04-09T01:07:55.007Z,1554772075.007 [CBIT](INFO): Clearing failed state for component MassServo 2019-04-09T01:07:55.007Z,1554772075.007 [MassServo] No Fault, FailCount= 2 2019-04-09T01:07:55.274Z,1554772075.274 [BR_Ping1D](INFO): Starting 2019-04-09T01:07:55.274Z,1554772075.274 [BR_Ping1D](INFO): readConfig 2019-04-09T01:07:55.275Z,1554772075.275 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:07:55.275Z,1554772075.275 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:07:55.275Z,1554772075.275 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:07:55.275Z,1554772075.275 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:07:55.275Z,1554772075.275 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:07:55.275Z,1554772075.275 [BR_Ping1D](INFO): No UART data 2019-04-09T01:07:55.677Z,1554772075.677 [BR_Ping1D](INFO): Starting 2019-04-09T01:07:55.708Z,1554772075.708 [CBIT](FAULT): Main Battery Failure. Count: 21 2019-04-09T01:07:56.083Z,1554772076.083 [BR_Ping1D](INFO): Starting 2019-04-09T01:07:56.083Z,1554772076.083 [BR_Ping1D](INFO): readConfig 2019-04-09T01:07:56.083Z,1554772076.083 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:07:56.083Z,1554772076.083 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:07:56.083Z,1554772076.083 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:07:56.084Z,1554772076.084 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:07:56.084Z,1554772076.084 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:07:56.084Z,1554772076.084 [BR_Ping1D](INFO): No UART data 2019-04-09T01:07:56.494Z,1554772076.494 [BR_Ping1D](INFO): Starting 2019-04-09T01:07:56.890Z,1554772076.890 [BR_Ping1D](INFO): Starting 2019-04-09T01:07:56.890Z,1554772076.890 [BR_Ping1D](INFO): readConfig 2019-04-09T01:07:56.891Z,1554772076.891 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:07:56.891Z,1554772076.891 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:07:56.891Z,1554772076.891 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:07:56.891Z,1554772076.891 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:07:56.891Z,1554772076.891 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:07:56.891Z,1554772076.891 [BR_Ping1D](INFO): No UART data 2019-04-09T01:07:56.907Z,1554772076.907 [CBIT](CRITICAL): Environmental Failure. Press:14.847911 PSI. Humidity:45%. Temp:26 C. ABORTING MISSION 2019-04-09T01:07:57.274Z,1554772077.274 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2019-04-09T01:07:57.274Z,1554772077.274 [Aanderaa_O2] Communications Fault, FailCount= 1 2019-04-09T01:07:57.274Z,1554772077.274 [Aanderaa_O2](ERROR): Communications Fault 2019-04-09T01:07:57.293Z,1554772077.293 [BR_Ping1D](INFO): Starting 2019-04-09T01:07:57.634Z,1554772077.634 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout 2019-04-09T01:07:57.634Z,1554772077.634 [MassServo] Communications Fault, FailCount= 3 2019-04-09T01:07:57.634Z,1554772077.634 [MassServo](ERROR): Communications Fault 2019-04-09T01:07:57.636Z,1554772077.636 [CBIT](INFO): Critical error at 20190409T010756 2019-04-09T01:07:57.639Z,1554772077.639 [CBIT](ERROR): Communications Fault in component: MassServo 2019-04-09T01:07:57.640Z,1554772077.640 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2019-04-09T01:07:57.798Z,1554772077.798 [Aanderaa_O2](INFO): Powering down 2019-04-09T01:07:57.875Z,1554772077.875 [BR_Ping1D](INFO): Starting 2019-04-09T01:07:57.875Z,1554772077.875 [BR_Ping1D](INFO): readConfig 2019-04-09T01:07:57.875Z,1554772077.875 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:07:57.875Z,1554772077.875 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:07:57.875Z,1554772077.875 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:07:57.876Z,1554772077.876 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:07:57.876Z,1554772077.876 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:07:57.876Z,1554772077.876 [BR_Ping1D](INFO): No UART data 2019-04-09T01:07:57.887Z,1554772077.887 [MassServo](DEBUG): Uninitialize Mass Servo. 2019-04-09T01:07:57.887Z,1554772077.887 [MassServo](INFO): Powering down 2019-04-09T01:07:58.101Z,1554772078.101 [BR_Ping1D](INFO): Starting 2019-04-09T01:07:58.506Z,1554772078.506 [BR_Ping1D](INFO): Starting 2019-04-09T01:07:58.506Z,1554772078.506 [BR_Ping1D](INFO): readConfig 2019-04-09T01:07:58.506Z,1554772078.506 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:07:58.506Z,1554772078.506 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:07:58.506Z,1554772078.506 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:07:58.507Z,1554772078.507 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:07:58.507Z,1554772078.507 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:07:58.507Z,1554772078.507 [BR_Ping1D](INFO): No UART data 2019-04-09T01:07:58.535Z,1554772078.535 [MassServo](DEBUG): Initializing EZServoServo. 2019-04-09T01:07:58.655Z,1554772078.655 [MassServo](DEBUG): Initializing MassServo. 2019-04-09T01:07:58.659Z,1554772078.659 [CBIT](INFO): Clearing failed state for component MassServo 2019-04-09T01:07:58.659Z,1554772078.659 [MassServo] No Fault, FailCount= 3 2019-04-09T01:07:58.660Z,1554772078.660 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2019-04-09T01:07:58.660Z,1554772078.660 [Aanderaa_O2] No Fault, FailCount= 1 2019-04-09T01:07:58.914Z,1554772078.914 [BR_Ping1D](INFO): Starting 2019-04-09T01:07:59.326Z,1554772079.326 [BR_Ping1D](INFO): Starting 2019-04-09T01:07:59.326Z,1554772079.326 [BR_Ping1D](INFO): readConfig 2019-04-09T01:07:59.326Z,1554772079.326 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:07:59.326Z,1554772079.326 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:07:59.326Z,1554772079.326 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:07:59.327Z,1554772079.327 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:07:59.327Z,1554772079.327 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:07:59.327Z,1554772079.327 [BR_Ping1D](INFO): No UART data 2019-04-09T01:07:59.598Z,1554772079.598 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2019-04-09T01:07:59.598Z,1554772079.598 [CTD_Seabird] Communications Fault, FailCount= 1 2019-04-09T01:07:59.598Z,1554772079.598 [CTD_Seabird](ERROR): Communications Fault 2019-04-09T01:07:59.717Z,1554772079.717 [BR_Ping1D](INFO): Starting 2019-04-09T01:07:59.760Z,1554772079.760 [CBIT](FAULT): Main Battery Failure. Count: 31 2019-04-09T01:07:59.779Z,1554772079.779 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2019-04-09T01:08:00.002Z,1554772080.002 [CTD_Seabird](INFO): Powering down 2019-04-09T01:08:00.122Z,1554772080.122 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:00.122Z,1554772080.122 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:00.123Z,1554772080.123 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:00.123Z,1554772080.123 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:00.123Z,1554772080.123 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:00.123Z,1554772080.123 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:00.123Z,1554772080.123 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:00.123Z,1554772080.123 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:00.525Z,1554772080.525 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:00.930Z,1554772080.930 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:00.930Z,1554772080.930 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:00.930Z,1554772080.930 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:00.930Z,1554772080.930 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:00.930Z,1554772080.930 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:00.931Z,1554772080.931 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:00.931Z,1554772080.931 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:00.931Z,1554772080.931 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:01.254Z,1554772081.254 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout 2019-04-09T01:08:01.254Z,1554772081.254 [MassServo] Communications Fault, FailCount= 4 2019-04-09T01:08:01.254Z,1554772081.254 [MassServo](ERROR): Communications Fault 2019-04-09T01:08:01.258Z,1554772081.258 [CBIT](ERROR): Communications Fault in component: MassServo 2019-04-09T01:08:01.259Z,1554772081.259 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2019-04-09T01:08:01.259Z,1554772081.259 [CTD_Seabird] No Fault, FailCount= 1 2019-04-09T01:08:01.332Z,1554772081.332 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:01.370Z,1554772081.370 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2019-04-09T01:08:01.394Z,1554772081.394 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20 2019-04-09T01:08:01.416Z,1554772081.416 [MassServo](DEBUG): Uninitialize Mass Servo. 2019-04-09T01:08:01.416Z,1554772081.416 [MassServo](INFO): Powering down 2019-04-09T01:08:01.737Z,1554772081.737 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:01.738Z,1554772081.738 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:01.738Z,1554772081.738 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:01.738Z,1554772081.738 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:01.738Z,1554772081.738 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:01.738Z,1554772081.738 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:01.739Z,1554772081.739 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:01.739Z,1554772081.739 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:02.142Z,1554772082.142 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:02.156Z,1554772082.156 [MassServo](DEBUG): Initializing EZServoServo. 2019-04-09T01:08:02.275Z,1554772082.275 [MassServo](DEBUG): Initializing MassServo. 2019-04-09T01:08:02.279Z,1554772082.279 [CBIT](INFO): Clearing failed state for component MassServo 2019-04-09T01:08:02.279Z,1554772082.279 [MassServo] No Fault, FailCount= 4 2019-04-09T01:08:02.546Z,1554772082.546 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:02.546Z,1554772082.546 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:02.546Z,1554772082.546 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:02.546Z,1554772082.546 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:02.547Z,1554772082.547 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:02.547Z,1554772082.547 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:02.547Z,1554772082.547 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:02.547Z,1554772082.547 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:02.949Z,1554772082.949 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:03.354Z,1554772083.354 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:03.354Z,1554772083.354 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:03.354Z,1554772083.354 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:03.355Z,1554772083.355 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:03.355Z,1554772083.355 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:03.355Z,1554772083.355 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:03.355Z,1554772083.355 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:03.355Z,1554772083.355 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:03.758Z,1554772083.758 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:03.785Z,1554772083.785 [CBIT](FAULT): Main Battery Failure. Count: 41 2019-04-09T01:08:04.162Z,1554772084.162 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:04.162Z,1554772084.162 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:04.163Z,1554772084.163 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:04.163Z,1554772084.163 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:04.163Z,1554772084.163 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:04.163Z,1554772084.163 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:04.163Z,1554772084.163 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:04.163Z,1554772084.163 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:04.566Z,1554772084.566 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:04.890Z,1554772084.890 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout 2019-04-09T01:08:04.890Z,1554772084.890 [MassServo] Communications Fault, FailCount= 5 2019-04-09T01:08:04.890Z,1554772084.890 [MassServo](ERROR): Communications Fault 2019-04-09T01:08:04.894Z,1554772084.894 [CBIT](ERROR): Communications Fault in component: MassServo 2019-04-09T01:08:04.895Z,1554772084.895 [CBIT](CRITICAL): Communications Fault in component: MassServo 2019-04-09T01:08:04.975Z,1554772084.975 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:04.975Z,1554772084.975 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:04.975Z,1554772084.975 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:04.975Z,1554772084.975 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:04.975Z,1554772084.975 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:04.976Z,1554772084.976 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:04.976Z,1554772084.976 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:04.976Z,1554772084.976 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:05.003Z,1554772085.003 [MassServo](DEBUG): Uninitialize Mass Servo. 2019-04-09T01:08:05.003Z,1554772085.003 [MassServo](INFO): Powering down 2019-04-09T01:08:05.006Z,1554772085.006 [CBIT](INFO): Critical error at 20190409T010804 2019-04-09T01:08:05.374Z,1554772085.374 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:05.778Z,1554772085.778 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:05.778Z,1554772085.778 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:05.778Z,1554772085.778 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:05.779Z,1554772085.779 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:05.779Z,1554772085.779 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:05.779Z,1554772085.779 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:05.779Z,1554772085.779 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:05.779Z,1554772085.779 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:05.792Z,1554772085.792 [MassServo](DEBUG): Initializing EZServoServo. 2019-04-09T01:08:05.915Z,1554772085.915 [MassServo](DEBUG): Initializing MassServo. 2019-04-09T01:08:06.181Z,1554772086.181 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:06.590Z,1554772086.590 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:06.590Z,1554772086.590 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:06.590Z,1554772086.590 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:06.590Z,1554772086.590 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:06.590Z,1554772086.590 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:06.591Z,1554772086.591 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:06.591Z,1554772086.591 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:06.591Z,1554772086.591 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:06.989Z,1554772086.989 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:07.399Z,1554772087.399 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:07.399Z,1554772087.399 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:07.399Z,1554772087.399 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:07.399Z,1554772087.399 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:07.399Z,1554772087.399 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:07.399Z,1554772087.399 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:07.400Z,1554772087.400 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:07.400Z,1554772087.400 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:07.779Z,1554772087.779 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface 2019-04-09T01:08:07.779Z,1554772087.779 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 1 2019-04-09T01:08:07.779Z,1554772087.779 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault 2019-04-09T01:08:07.798Z,1554772087.798 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:07.813Z,1554772087.813 [CBIT](FAULT): Main Battery Failure. Count: 51 2019-04-09T01:08:07.816Z,1554772087.816 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900 2019-04-09T01:08:08.183Z,1554772088.183 [AcousticModem_Benthos_ATM900](INFO): Powering down 2019-04-09T01:08:08.342Z,1554772088.342 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:08.342Z,1554772088.342 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:08.342Z,1554772088.342 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:08.343Z,1554772088.343 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:08.343Z,1554772088.343 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:08.343Z,1554772088.343 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:08.343Z,1554772088.343 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:08.343Z,1554772088.343 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:08.606Z,1554772088.606 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:08.990Z,1554772088.990 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2019-04-09T01:08:08.990Z,1554772088.990 [Aanderaa_O2] Communications Fault, FailCount= 2 2019-04-09T01:08:08.990Z,1554772088.990 [Aanderaa_O2](ERROR): Communications Fault 2019-04-09T01:08:09.010Z,1554772089.010 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:09.011Z,1554772089.011 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:09.011Z,1554772089.011 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:09.011Z,1554772089.011 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:09.011Z,1554772089.011 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:09.011Z,1554772089.011 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:09.012Z,1554772089.012 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:09.012Z,1554772089.012 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:09.027Z,1554772089.027 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2019-04-09T01:08:09.027Z,1554772089.027 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900 2019-04-09T01:08:09.027Z,1554772089.027 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 1 2019-04-09T01:08:09.514Z,1554772089.514 [Aanderaa_O2](INFO): Powering down 2019-04-09T01:08:09.611Z,1554772089.611 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:09.611Z,1554772089.611 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:09.612Z,1554772089.612 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:09.612Z,1554772089.612 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:09.612Z,1554772089.612 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:09.612Z,1554772089.612 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:09.612Z,1554772089.612 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:09.612Z,1554772089.612 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:09.818Z,1554772089.818 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:10.221Z,1554772090.221 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:10.222Z,1554772090.222 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:10.222Z,1554772090.222 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:10.222Z,1554772090.222 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:10.222Z,1554772090.222 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:10.222Z,1554772090.222 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:10.223Z,1554772090.223 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:10.223Z,1554772090.223 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:10.251Z,1554772090.251 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2019-04-09T01:08:10.251Z,1554772090.251 [Aanderaa_O2] No Fault, FailCount= 2 2019-04-09T01:08:10.634Z,1554772090.634 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:11.041Z,1554772091.041 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:11.041Z,1554772091.041 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:11.042Z,1554772091.042 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:11.042Z,1554772091.042 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:11.042Z,1554772091.042 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:11.042Z,1554772091.042 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:11.042Z,1554772091.042 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:11.043Z,1554772091.043 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:11.057Z,1554772091.057 [SBIT](IMPORTANT): Beginning Startup BIT 2019-04-09T01:08:11.098Z,1554772091.098 [CBIT](IMPORTANT): Beginning ground fault scan 2019-04-09T01:08:11.415Z,1554772091.415 [AcousticModem_Benthos_ATM900](INFO): Powering up 2019-04-09T01:08:11.416Z,1554772091.416 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900. 2019-04-09T01:08:11.450Z,1554772091.450 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:11.840Z,1554772091.840 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:11.841Z,1554772091.841 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:11.841Z,1554772091.841 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:11.841Z,1554772091.841 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:11.841Z,1554772091.841 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:11.841Z,1554772091.841 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:11.842Z,1554772091.842 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:11.842Z,1554772091.842 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:11.932Z,1554772091.932 [CBIT](FAULT): Main Battery Failure. Count: 61 2019-04-09T01:08:12.241Z,1554772092.241 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:12.643Z,1554772092.643 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:12.643Z,1554772092.643 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:12.644Z,1554772092.644 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:12.644Z,1554772092.644 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:12.644Z,1554772092.644 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:12.644Z,1554772092.644 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:12.644Z,1554772092.644 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:12.645Z,1554772092.645 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:13.053Z,1554772093.053 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:13.453Z,1554772093.453 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:13.454Z,1554772093.454 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:13.454Z,1554772093.454 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:13.454Z,1554772093.454 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:13.454Z,1554772093.454 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:13.455Z,1554772093.455 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:13.455Z,1554772093.455 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:13.455Z,1554772093.455 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:13.858Z,1554772093.858 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:14.269Z,1554772094.269 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:14.270Z,1554772094.270 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:14.271Z,1554772094.271 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:14.271Z,1554772094.271 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:14.271Z,1554772094.271 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:14.271Z,1554772094.271 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:14.271Z,1554772094.271 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:14.271Z,1554772094.271 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:14.651Z,1554772094.651 [NAL9602](INFO): Powering up NAL9602 2019-04-09T01:08:14.667Z,1554772094.667 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:15.069Z,1554772095.069 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:15.069Z,1554772095.069 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:15.070Z,1554772095.070 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:15.070Z,1554772095.070 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:15.070Z,1554772095.070 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:15.070Z,1554772095.070 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:15.070Z,1554772095.070 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:15.071Z,1554772095.071 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:15.426Z,1554772095.426 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2019-04-09T01:08:15.426Z,1554772095.426 [CTD_Seabird] Communications Fault, FailCount= 2 2019-04-09T01:08:15.426Z,1554772095.426 [CTD_Seabird](ERROR): Communications Fault 2019-04-09T01:08:15.474Z,1554772095.474 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:15.560Z,1554772095.560 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2019-04-09T01:08:15.830Z,1554772095.830 [CTD_Seabird](INFO): Powering down 2019-04-09T01:08:15.879Z,1554772095.879 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:15.879Z,1554772095.879 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:15.880Z,1554772095.880 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:15.880Z,1554772095.880 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:15.880Z,1554772095.880 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:15.880Z,1554772095.880 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:15.880Z,1554772095.880 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:15.880Z,1554772095.880 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:16.012Z,1554772096.012 [CBIT](FAULT): Main Battery Failure. Count: 71 2019-04-09T01:08:16.285Z,1554772096.285 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:16.685Z,1554772096.685 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:16.685Z,1554772096.685 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:16.685Z,1554772096.685 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:16.686Z,1554772096.686 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:16.686Z,1554772096.686 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:16.686Z,1554772096.686 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:16.686Z,1554772096.686 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:16.686Z,1554772096.686 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:17.089Z,1554772097.089 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:17.135Z,1554772097.135 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2019-04-09T01:08:17.135Z,1554772097.135 [CTD_Seabird] No Fault, FailCount= 2 2019-04-09T01:08:17.178Z,1554772097.178 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2019-04-09T01:08:17.180Z,1554772097.180 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20 2019-04-09T01:08:17.494Z,1554772097.494 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:17.494Z,1554772097.494 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:17.494Z,1554772097.494 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:17.494Z,1554772097.494 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:17.494Z,1554772097.494 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:17.495Z,1554772097.495 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:17.495Z,1554772097.495 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:17.495Z,1554772097.495 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:17.897Z,1554772097.897 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:18.301Z,1554772098.301 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:18.302Z,1554772098.302 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:18.303Z,1554772098.303 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:18.303Z,1554772098.303 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:18.303Z,1554772098.303 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:18.303Z,1554772098.303 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:18.303Z,1554772098.303 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:18.304Z,1554772098.304 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:18.705Z,1554772098.705 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:19.109Z,1554772099.109 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:19.109Z,1554772099.109 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:19.109Z,1554772099.109 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:19.109Z,1554772099.109 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:19.110Z,1554772099.110 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:19.110Z,1554772099.110 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:19.110Z,1554772099.110 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:19.110Z,1554772099.110 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:19.522Z,1554772099.522 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:19.920Z,1554772099.920 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:19.920Z,1554772099.920 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:19.920Z,1554772099.920 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:19.920Z,1554772099.920 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:19.921Z,1554772099.921 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:19.921Z,1554772099.921 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:19.921Z,1554772099.921 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:19.921Z,1554772099.921 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:19.949Z,1554772099.949 [CBIT](FAULT): Main Battery Failure. Count: 81 2019-04-09T01:08:20.323Z,1554772100.323 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:20.706Z,1554772100.706 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2019-04-09T01:08:20.707Z,1554772100.707 [Aanderaa_O2] Communications Fault, FailCount= 3 2019-04-09T01:08:20.707Z,1554772100.707 [Aanderaa_O2](ERROR): Communications Fault 2019-04-09T01:08:20.726Z,1554772100.726 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:20.726Z,1554772100.726 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:20.726Z,1554772100.726 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:20.726Z,1554772100.726 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:20.726Z,1554772100.726 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:20.727Z,1554772100.727 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:20.727Z,1554772100.727 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:20.727Z,1554772100.727 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:20.743Z,1554772100.743 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2019-04-09T01:08:20.744Z,1554772100.744 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2019-04-09T01:08:21.230Z,1554772101.230 [Aanderaa_O2](INFO): Powering down 2019-04-09T01:08:21.250Z,1554772101.250 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:21.250Z,1554772101.250 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:21.250Z,1554772101.250 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:21.250Z,1554772101.250 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:21.251Z,1554772101.251 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:21.251Z,1554772101.251 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:21.251Z,1554772101.251 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:21.251Z,1554772101.251 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:21.533Z,1554772101.533 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:21.945Z,1554772101.945 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:21.946Z,1554772101.946 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:21.946Z,1554772101.946 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:21.946Z,1554772101.946 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:21.946Z,1554772101.946 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:21.947Z,1554772101.947 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:21.947Z,1554772101.947 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:21.947Z,1554772101.947 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:21.967Z,1554772101.967 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): -0.006848 CHAN A1 (24V): -0.127547 CHAN A2 (12V): -0.005079 CHAN A3 (5V): -0.002513 CHAN B0 (3.3V): -0.001382 CHAN B1 (3.15aV): -0.001094 CHAN B2 (3.15bV): -0.001231 CHAN B3 (GND): 0.000299 OPEN: -0.000918 Full Scale Calc: 4.765 mA, -1.589 mA 2019-04-09T01:08:22.339Z,1554772102.339 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:22.745Z,1554772102.745 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:22.746Z,1554772102.746 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:22.746Z,1554772102.746 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:22.746Z,1554772102.746 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:22.746Z,1554772102.746 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:22.746Z,1554772102.746 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:22.747Z,1554772102.747 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:22.747Z,1554772102.747 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:23.152Z,1554772103.152 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:23.553Z,1554772103.553 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:23.554Z,1554772103.554 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:23.565Z,1554772103.565 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:23.565Z,1554772103.565 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:23.565Z,1554772103.565 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:23.566Z,1554772103.566 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:23.566Z,1554772103.566 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:23.566Z,1554772103.566 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:23.957Z,1554772103.957 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:23.969Z,1554772103.969 [CBIT](FAULT): Main Battery Failure. Count: 91 2019-04-09T01:08:24.362Z,1554772104.362 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:24.362Z,1554772104.362 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:24.362Z,1554772104.362 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:24.363Z,1554772104.363 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:24.363Z,1554772104.363 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:24.363Z,1554772104.363 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:24.363Z,1554772104.363 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:24.363Z,1554772104.363 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:24.376Z,1554772104.376 [SBIT](ERROR): Could not read massPosReader_. 2019-04-09T01:08:24.765Z,1554772104.765 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:25.181Z,1554772105.181 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:25.181Z,1554772105.181 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:25.181Z,1554772105.181 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:25.181Z,1554772105.181 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:25.181Z,1554772105.181 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:25.182Z,1554772105.182 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:25.182Z,1554772105.182 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:25.182Z,1554772105.182 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:25.559Z,1554772105.559 [NAL9602](INFO): NAL9602 initialized 2019-04-09T01:08:25.574Z,1554772105.574 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:25.987Z,1554772105.987 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:25.987Z,1554772105.987 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:25.987Z,1554772105.987 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:25.987Z,1554772105.987 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:25.987Z,1554772105.987 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:25.988Z,1554772105.988 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:25.988Z,1554772105.988 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:25.988Z,1554772105.988 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:26.382Z,1554772106.382 [NAL9602](DEBUG): Fix Requested 2019-04-09T01:08:26.397Z,1554772106.397 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:26.805Z,1554772106.805 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:26.805Z,1554772106.805 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:26.805Z,1554772106.805 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:26.805Z,1554772106.805 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:26.805Z,1554772106.805 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:26.805Z,1554772106.805 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:26.806Z,1554772106.806 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:26.806Z,1554772106.806 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:27.217Z,1554772107.217 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:27.598Z,1554772107.598 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:27.598Z,1554772107.598 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:27.599Z,1554772107.599 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:27.599Z,1554772107.599 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:27.599Z,1554772107.599 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:27.599Z,1554772107.599 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:27.599Z,1554772107.599 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:27.600Z,1554772107.600 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:28.002Z,1554772108.001 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:28.073Z,1554772108.073 [CBIT](FAULT): Main Battery Failure. Count: 101 2019-04-09T01:08:28.406Z,1554772108.406 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:28.406Z,1554772108.406 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:28.407Z,1554772108.407 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:28.407Z,1554772108.407 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:28.407Z,1554772108.407 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:28.407Z,1554772108.407 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:28.407Z,1554772108.407 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:28.408Z,1554772108.408 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:28.811Z,1554772108.811 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:29.225Z,1554772109.225 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:29.225Z,1554772109.225 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:29.225Z,1554772109.225 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:29.225Z,1554772109.225 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:29.225Z,1554772109.225 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:29.226Z,1554772109.226 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:29.226Z,1554772109.226 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:29.227Z,1554772109.227 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:29.632Z,1554772109.632 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:30.037Z,1554772110.037 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:30.037Z,1554772110.037 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:30.038Z,1554772110.038 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:30.038Z,1554772110.038 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:30.038Z,1554772110.038 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:30.039Z,1554772110.039 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:30.039Z,1554772110.039 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:30.039Z,1554772110.039 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:30.230Z,1554772110.230 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2019-04-09T01:08:30.230Z,1554772110.230 [CTD_Seabird] Communications Fault, FailCount= 3 2019-04-09T01:08:30.230Z,1554772110.230 [CTD_Seabird](ERROR): Communications Fault 2019-04-09T01:08:30.428Z,1554772110.428 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:30.491Z,1554772110.491 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2019-04-09T01:08:30.492Z,1554772110.492 [CBIT](FAULT): Communications Fault in component: CTD_Seabird 2019-04-09T01:08:30.634Z,1554772110.634 [CTD_Seabird](INFO): Powering down 2019-04-09T01:08:30.830Z,1554772110.830 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:30.830Z,1554772110.830 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:30.831Z,1554772110.831 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:30.831Z,1554772110.831 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:30.831Z,1554772110.831 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:30.831Z,1554772110.831 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:30.831Z,1554772110.831 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:30.832Z,1554772110.832 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:31.234Z,1554772111.234 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:31.619Z,1554772111.619 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface 2019-04-09T01:08:31.619Z,1554772111.619 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 2 2019-04-09T01:08:31.619Z,1554772111.619 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault 2019-04-09T01:08:31.638Z,1554772111.638 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:31.638Z,1554772111.638 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:31.638Z,1554772111.638 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:31.638Z,1554772111.638 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:31.639Z,1554772111.639 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:31.639Z,1554772111.639 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:31.639Z,1554772111.639 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:31.639Z,1554772111.639 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:31.783Z,1554772111.783 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900 2019-04-09T01:08:32.023Z,1554772112.023 [AcousticModem_Benthos_ATM900](INFO): Powering down 2019-04-09T01:08:32.162Z,1554772112.162 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:32.162Z,1554772112.162 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:32.162Z,1554772112.162 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:32.163Z,1554772112.163 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:32.163Z,1554772112.163 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:32.163Z,1554772112.163 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:32.163Z,1554772112.163 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:32.163Z,1554772112.163 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:32.372Z,1554772112.372 [CBIT](FAULT): Main Battery Failure. Count: 111 2019-04-09T01:08:32.446Z,1554772112.446 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:32.858Z,1554772112.858 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:32.858Z,1554772112.858 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:32.858Z,1554772112.858 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:32.858Z,1554772112.858 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:32.858Z,1554772112.858 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:32.859Z,1554772112.859 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:32.859Z,1554772112.859 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:32.859Z,1554772112.859 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:32.876Z,1554772112.876 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900 2019-04-09T01:08:32.876Z,1554772112.876 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 2 2019-04-09T01:08:33.256Z,1554772113.256 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:33.660Z,1554772113.660 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:33.661Z,1554772113.661 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:33.661Z,1554772113.661 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:33.661Z,1554772113.661 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:33.661Z,1554772113.661 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:33.661Z,1554772113.661 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:33.661Z,1554772113.661 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:33.662Z,1554772113.662 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:34.076Z,1554772114.076 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:34.476Z,1554772114.476 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:34.476Z,1554772114.476 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:34.476Z,1554772114.476 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:34.477Z,1554772114.477 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:34.477Z,1554772114.477 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:34.477Z,1554772114.477 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:34.477Z,1554772114.477 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:34.477Z,1554772114.477 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:34.880Z,1554772114.880 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:35.255Z,1554772115.255 [AcousticModem_Benthos_ATM900](INFO): Powering up 2019-04-09T01:08:35.255Z,1554772115.255 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900. 2019-04-09T01:08:35.300Z,1554772115.300 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:35.300Z,1554772115.300 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:35.301Z,1554772115.301 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:35.301Z,1554772115.301 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:35.301Z,1554772115.301 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:35.301Z,1554772115.301 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:35.301Z,1554772115.301 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:35.301Z,1554772115.301 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:35.678Z,1554772115.678 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:36.082Z,1554772116.082 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:36.082Z,1554772116.082 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:36.082Z,1554772116.082 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:36.082Z,1554772116.082 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:36.082Z,1554772116.082 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:36.083Z,1554772116.083 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:36.083Z,1554772116.083 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:36.083Z,1554772116.083 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:36.097Z,1554772116.097 [CBIT](FAULT): Main Battery Failure. Count: 121 2019-04-09T01:08:36.486Z,1554772116.486 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:36.893Z,1554772116.893 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:36.893Z,1554772116.893 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:36.893Z,1554772116.893 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:36.893Z,1554772116.893 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:36.894Z,1554772116.894 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:36.894Z,1554772116.894 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:36.894Z,1554772116.894 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:36.894Z,1554772116.894 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:37.298Z,1554772117.298 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:37.697Z,1554772117.697 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:37.698Z,1554772117.698 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:37.698Z,1554772117.698 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:37.698Z,1554772117.698 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:37.698Z,1554772117.698 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:37.698Z,1554772117.698 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:37.699Z,1554772117.699 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:37.699Z,1554772117.699 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:38.102Z,1554772118.102 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:38.506Z,1554772118.506 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:38.506Z,1554772118.506 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:38.506Z,1554772118.506 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:38.506Z,1554772118.506 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:38.507Z,1554772118.507 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:38.507Z,1554772118.507 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:38.507Z,1554772118.507 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:38.507Z,1554772118.507 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:38.910Z,1554772118.910 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:39.324Z,1554772119.324 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:39.324Z,1554772119.324 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:39.324Z,1554772119.324 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:39.325Z,1554772119.325 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:39.325Z,1554772119.325 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:39.325Z,1554772119.325 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:39.325Z,1554772119.325 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:39.325Z,1554772119.325 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:39.729Z,1554772119.729 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:40.136Z,1554772120.136 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:40.136Z,1554772120.136 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:40.136Z,1554772120.136 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:40.136Z,1554772120.136 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:40.137Z,1554772120.137 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:40.137Z,1554772120.137 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:40.137Z,1554772120.137 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:40.137Z,1554772120.137 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:40.153Z,1554772120.153 [CBIT](FAULT): Main Battery Failure. Count: 131 2019-04-09T01:08:40.539Z,1554772120.539 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:40.927Z,1554772120.927 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:40.927Z,1554772120.927 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:40.927Z,1554772120.927 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:40.927Z,1554772120.927 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:40.927Z,1554772120.927 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:40.928Z,1554772120.928 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:40.928Z,1554772120.928 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:40.928Z,1554772120.928 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:41.334Z,1554772121.334 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:41.742Z,1554772121.742 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:41.742Z,1554772121.742 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:41.742Z,1554772121.742 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:41.742Z,1554772121.742 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:41.742Z,1554772121.742 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:41.742Z,1554772121.742 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:41.743Z,1554772121.743 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:41.743Z,1554772121.743 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:42.142Z,1554772122.142 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:42.546Z,1554772122.546 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:42.546Z,1554772122.546 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:42.546Z,1554772122.546 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:42.546Z,1554772122.546 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:42.546Z,1554772122.546 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:42.547Z,1554772122.547 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:42.547Z,1554772122.547 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:42.547Z,1554772122.547 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:42.950Z,1554772122.950 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:43.351Z,1554772123.351 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:43.351Z,1554772123.351 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:43.352Z,1554772123.352 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:43.352Z,1554772123.352 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:43.352Z,1554772123.352 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:43.352Z,1554772123.352 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:43.352Z,1554772123.352 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:43.353Z,1554772123.353 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:43.761Z,1554772123.761 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:44.159Z,1554772124.159 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:44.159Z,1554772124.159 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:44.159Z,1554772124.159 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:44.159Z,1554772124.159 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:44.159Z,1554772124.159 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:44.159Z,1554772124.159 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:44.160Z,1554772124.160 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:44.160Z,1554772124.160 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:44.207Z,1554772124.207 [CBIT](FAULT): Main Battery Failure. Count: 141 2019-04-09T01:08:44.576Z,1554772124.576 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:44.984Z,1554772124.984 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:44.984Z,1554772124.984 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:44.984Z,1554772124.984 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:44.985Z,1554772124.985 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:44.985Z,1554772124.985 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:44.985Z,1554772124.985 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:44.985Z,1554772124.985 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:44.985Z,1554772124.985 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:45.388Z,1554772125.388 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:45.792Z,1554772125.792 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:45.792Z,1554772125.792 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:45.792Z,1554772125.792 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:45.793Z,1554772125.793 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:45.793Z,1554772125.793 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:45.793Z,1554772125.793 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:45.793Z,1554772125.793 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:45.793Z,1554772125.793 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:46.186Z,1554772126.186 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:46.590Z,1554772126.590 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:46.590Z,1554772126.590 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:46.590Z,1554772126.590 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:46.590Z,1554772126.590 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:46.590Z,1554772126.590 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:46.591Z,1554772126.591 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:46.591Z,1554772126.591 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:46.591Z,1554772126.591 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:46.991Z,1554772126.991 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:47.396Z,1554772127.396 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:47.396Z,1554772127.396 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:47.397Z,1554772127.397 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:47.397Z,1554772127.397 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:47.397Z,1554772127.397 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:47.397Z,1554772127.397 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:47.397Z,1554772127.397 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:47.398Z,1554772127.398 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:47.798Z,1554772127.798 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:48.199Z,1554772128.199 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:48.199Z,1554772128.199 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:48.199Z,1554772128.199 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:48.200Z,1554772128.200 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:48.200Z,1554772128.200 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:48.200Z,1554772128.200 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:48.200Z,1554772128.200 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:48.200Z,1554772128.200 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:48.212Z,1554772128.212 [CBIT](FAULT): Main Battery Failure. Count: 151 2019-04-09T01:08:48.606Z,1554772128.606 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:49.007Z,1554772129.007 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:49.007Z,1554772129.007 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:49.007Z,1554772129.007 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:49.008Z,1554772129.008 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:49.008Z,1554772129.008 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:49.008Z,1554772129.008 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:49.008Z,1554772129.008 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:49.008Z,1554772129.008 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:49.414Z,1554772129.414 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:49.828Z,1554772129.828 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:49.828Z,1554772129.828 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:49.829Z,1554772129.829 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:49.829Z,1554772129.829 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:49.829Z,1554772129.829 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:49.829Z,1554772129.829 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:49.829Z,1554772129.829 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:49.830Z,1554772129.830 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:50.237Z,1554772130.237 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:50.639Z,1554772130.639 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:50.639Z,1554772130.639 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:50.640Z,1554772130.640 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:50.640Z,1554772130.640 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:50.640Z,1554772130.640 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:50.640Z,1554772130.640 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:50.640Z,1554772130.640 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:50.641Z,1554772130.641 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:51.044Z,1554772131.044 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:51.060Z,1554772131.060 [SBIT](ERROR): Could not read massPosReader_. 2019-04-09T01:08:51.060Z,1554772131.060 [SBIT](FAULT): Control surface position failure. 2019-04-09T01:08:51.431Z,1554772131.431 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:51.431Z,1554772131.431 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:51.431Z,1554772131.431 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:51.431Z,1554772131.431 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:51.431Z,1554772131.431 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:51.432Z,1554772131.432 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:51.432Z,1554772131.432 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:51.432Z,1554772131.432 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:51.842Z,1554772131.842 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:52.242Z,1554772132.242 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:52.242Z,1554772132.242 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:52.242Z,1554772132.242 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:52.243Z,1554772132.243 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:52.243Z,1554772132.243 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:52.243Z,1554772132.243 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:52.243Z,1554772132.243 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:52.243Z,1554772132.243 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:52.262Z,1554772132.262 [CBIT](FAULT): Main Battery Failure. Count: 161 2019-04-09T01:08:52.646Z,1554772132.646 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:53.047Z,1554772133.047 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:53.047Z,1554772133.047 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:53.047Z,1554772133.047 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:53.047Z,1554772133.047 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:53.048Z,1554772133.048 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:53.048Z,1554772133.048 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:53.048Z,1554772133.048 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:53.048Z,1554772133.048 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:53.458Z,1554772133.458 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:53.861Z,1554772133.861 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:53.861Z,1554772133.861 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:53.861Z,1554772133.861 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:53.862Z,1554772133.862 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:53.862Z,1554772133.862 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:53.862Z,1554772133.862 [BR_Ping1D](INFO): elapsed0.0002 2019-04-09T01:08:53.862Z,1554772133.862 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:53.862Z,1554772133.862 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:54.266Z,1554772134.266 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:54.666Z,1554772134.666 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:54.666Z,1554772134.666 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:54.666Z,1554772134.666 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:54.667Z,1554772134.667 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:54.667Z,1554772134.667 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:54.667Z,1554772134.667 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:54.667Z,1554772134.667 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:54.667Z,1554772134.667 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:55.085Z,1554772135.085 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:55.454Z,1554772135.454 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface 2019-04-09T01:08:55.455Z,1554772135.455 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 3 2019-04-09T01:08:55.455Z,1554772135.455 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault 2019-04-09T01:08:55.484Z,1554772135.484 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:55.485Z,1554772135.485 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:55.485Z,1554772135.485 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:55.485Z,1554772135.485 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:55.485Z,1554772135.485 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:55.485Z,1554772135.485 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:55.485Z,1554772135.485 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:55.486Z,1554772135.486 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:55.564Z,1554772135.564 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900 2019-04-09T01:08:55.858Z,1554772135.858 [AcousticModem_Benthos_ATM900](INFO): Powering down 2019-04-09T01:08:56.017Z,1554772136.017 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:56.017Z,1554772136.017 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:56.017Z,1554772136.017 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:56.017Z,1554772136.017 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:56.017Z,1554772136.017 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:56.018Z,1554772136.018 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:56.018Z,1554772136.018 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:56.018Z,1554772136.018 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:56.297Z,1554772136.297 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:56.548Z,1554772136.548 [CBIT](FAULT): Main Battery Failure. Count: 171 2019-04-09T01:08:56.686Z,1554772136.686 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:56.686Z,1554772136.686 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:56.686Z,1554772136.686 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:56.687Z,1554772136.687 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:56.687Z,1554772136.687 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:56.687Z,1554772136.687 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:56.687Z,1554772136.687 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:56.687Z,1554772136.687 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:56.702Z,1554772136.702 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900 2019-04-09T01:08:56.702Z,1554772136.702 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 3 2019-04-09T01:08:57.096Z,1554772137.096 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:57.492Z,1554772137.492 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:57.492Z,1554772137.492 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:57.492Z,1554772137.492 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:57.492Z,1554772137.492 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:57.493Z,1554772137.493 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:57.493Z,1554772137.493 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:57.493Z,1554772137.493 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:57.493Z,1554772137.493 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:57.898Z,1554772137.898 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:58.306Z,1554772138.306 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:58.306Z,1554772138.306 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:58.307Z,1554772138.307 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:58.307Z,1554772138.307 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:58.307Z,1554772138.307 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:58.307Z,1554772138.307 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:58.307Z,1554772138.307 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:58.308Z,1554772138.308 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:58.710Z,1554772138.710 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:59.090Z,1554772139.090 [AcousticModem_Benthos_ATM900](INFO): Powering up 2019-04-09T01:08:59.091Z,1554772139.091 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900. 2019-04-09T01:08:59.126Z,1554772139.126 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:59.126Z,1554772139.126 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:59.126Z,1554772139.126 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:59.126Z,1554772139.126 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:59.127Z,1554772139.127 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:59.127Z,1554772139.127 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:59.127Z,1554772139.127 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:59.127Z,1554772139.127 [BR_Ping1D](INFO): No UART data 2019-04-09T01:08:59.518Z,1554772139.518 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:59.916Z,1554772139.916 [BR_Ping1D](INFO): Starting 2019-04-09T01:08:59.916Z,1554772139.916 [BR_Ping1D](INFO): readConfig 2019-04-09T01:08:59.916Z,1554772139.916 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:08:59.916Z,1554772139.916 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:08:59.916Z,1554772139.916 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:08:59.917Z,1554772139.917 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:08:59.917Z,1554772139.917 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:08:59.917Z,1554772139.917 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:00.340Z,1554772140.340 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:00.357Z,1554772140.357 [CBIT](FAULT): Main Battery Failure. Count: 181 2019-04-09T01:09:00.741Z,1554772140.741 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:00.741Z,1554772140.741 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:00.741Z,1554772140.741 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:00.741Z,1554772140.741 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:00.741Z,1554772140.741 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:00.742Z,1554772140.742 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:00.742Z,1554772140.742 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:00.742Z,1554772140.742 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:01.140Z,1554772141.140 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:01.549Z,1554772141.549 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:01.549Z,1554772141.549 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:01.549Z,1554772141.549 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:01.549Z,1554772141.549 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:01.549Z,1554772141.549 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:01.550Z,1554772141.550 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:01.550Z,1554772141.550 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:01.550Z,1554772141.550 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:01.938Z,1554772141.938 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:02.339Z,1554772142.339 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:02.340Z,1554772142.340 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:02.340Z,1554772142.340 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:02.340Z,1554772142.340 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:02.340Z,1554772142.340 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:02.340Z,1554772142.340 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:02.341Z,1554772142.341 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:02.341Z,1554772142.341 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:02.745Z,1554772142.745 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:03.154Z,1554772143.154 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:03.154Z,1554772143.154 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:03.155Z,1554772143.155 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:03.155Z,1554772143.155 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:03.155Z,1554772143.155 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:03.155Z,1554772143.155 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:03.155Z,1554772143.155 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:03.155Z,1554772143.155 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:03.559Z,1554772143.559 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:03.961Z,1554772143.961 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:03.962Z,1554772143.962 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:03.962Z,1554772143.962 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:03.962Z,1554772143.962 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:03.962Z,1554772143.962 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:03.962Z,1554772143.962 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:03.963Z,1554772143.963 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:03.963Z,1554772143.963 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:04.362Z,1554772144.362 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:04.392Z,1554772144.392 [CBIT](FAULT): Main Battery Failure. Count: 191 2019-04-09T01:09:04.770Z,1554772144.770 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:04.771Z,1554772144.771 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:04.771Z,1554772144.771 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:04.771Z,1554772144.771 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:04.771Z,1554772144.771 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:04.771Z,1554772144.771 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:04.771Z,1554772144.771 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:04.772Z,1554772144.772 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:04.783Z,1554772144.783 [SBIT](ERROR): Could not read massPosReader_. 2019-04-09T01:09:04.783Z,1554772144.783 [SBIT](FAULT): Control surface position failure. 2019-04-09T01:09:05.169Z,1554772145.169 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:05.187Z,1554772145.187 [SBIT](CRITICAL): SBIT FAILED 2019-04-09T01:09:05.202Z,1554772145.202 [CommandLine](IMPORTANT): got command configSet list 2019-04-09T01:09:05.202Z,1554772145.202 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2019-04-09T01:09:05.203Z,1554772145.203 [CommandLine](IMPORTANT): DropWeight.loadAtStartup=0 bool; 2019-04-09T01:09:05.203Z,1554772145.203 [CommandLine](IMPORTANT): Rowe_600LCM.loadAtStartup=0 bool; 2019-04-09T01:09:05.231Z,1554772145.231 [CBIT](INFO): Critical error at 20190409T010905 2019-04-09T01:09:05.589Z,1554772145.589 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:05.589Z,1554772145.589 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:05.589Z,1554772145.589 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:05.589Z,1554772145.589 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:05.589Z,1554772145.589 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:05.589Z,1554772145.589 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:05.590Z,1554772145.590 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:05.590Z,1554772145.590 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:05.596Z,1554772145.596 [MissionManager](IMPORTANT): Started mission Startup 2019-04-09T01:09:05.596Z,1554772145.596 [Startup] Running Loop=1 2019-04-09T01:09:05.596Z,1554772145.596 [Startup](DEBUG): Aggregate::initialize Startup 2019-04-09T01:09:05.596Z,1554772145.596 [Startup:A.GoToSurface] Running Loop=1 2019-04-09T01:09:05.596Z,1554772145.596 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2019-04-09T01:09:05.597Z,1554772145.597 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2019-04-09T01:09:05.597Z,1554772145.597 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2019-04-09T01:09:05.598Z,1554772145.598 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2019-04-09T01:09:05.598Z,1554772145.598 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2019-04-09T01:09:05.598Z,1554772145.598 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2019-04-09T01:09:05.600Z,1554772145.600 [Startup:StartupSatComms] Running Loop=1 2019-04-09T01:09:05.600Z,1554772145.600 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2019-04-09T01:09:05.600Z,1554772145.600 [Startup:StartupSatComms:A] Running Loop=1 2019-04-09T01:09:05.988Z,1554772145.988 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:05.000Z,1554772146.000 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2019-04-09T01:09:06.392Z,1554772146.392 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:06.393Z,1554772146.393 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:06.393Z,1554772146.393 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:06.393Z,1554772146.393 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:06.393Z,1554772146.393 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:06.393Z,1554772146.393 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:06.394Z,1554772146.394 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:06.394Z,1554772146.394 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:06.800Z,1554772146.800 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:07.191Z,1554772147.191 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:07.191Z,1554772147.191 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:07.191Z,1554772147.191 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:07.191Z,1554772147.191 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:07.191Z,1554772147.191 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:07.192Z,1554772147.192 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:07.192Z,1554772147.192 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:07.192Z,1554772147.192 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:07.593Z,1554772147.593 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:08.002Z,1554772148.002 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:08.002Z,1554772148.002 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:08.003Z,1554772148.003 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:08.003Z,1554772148.003 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:08.003Z,1554772148.003 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:08.003Z,1554772148.003 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:08.003Z,1554772148.003 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:08.003Z,1554772148.003 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:08.402Z,1554772148.402 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:08.414Z,1554772148.414 [CBIT](FAULT): Main Battery Failure. Count: 201 2019-04-09T01:09:08.806Z,1554772148.806 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:08.806Z,1554772148.806 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:08.806Z,1554772148.806 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:08.807Z,1554772148.807 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:08.807Z,1554772148.807 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:08.807Z,1554772148.807 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:08.807Z,1554772148.807 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:08.807Z,1554772148.807 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:09.210Z,1554772149.210 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:09.617Z,1554772149.617 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:09.617Z,1554772149.617 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:09.618Z,1554772149.618 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:09.618Z,1554772149.618 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:09.618Z,1554772149.618 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:09.618Z,1554772149.618 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:09.618Z,1554772149.618 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:09.619Z,1554772149.619 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:10.018Z,1554772150.018 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:10.428Z,1554772150.428 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:10.428Z,1554772150.428 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:10.428Z,1554772150.428 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:10.428Z,1554772150.428 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:10.428Z,1554772150.428 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:10.428Z,1554772150.428 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:10.429Z,1554772150.429 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:10.429Z,1554772150.429 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:10.843Z,1554772150.843 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:11.241Z,1554772151.241 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:11.241Z,1554772151.241 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:11.241Z,1554772151.241 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:11.241Z,1554772151.241 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:11.241Z,1554772151.241 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:11.242Z,1554772151.242 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:11.256Z,1554772151.256 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:11.256Z,1554772151.256 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:11.652Z,1554772151.652 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:12.049Z,1554772152.049 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:12.049Z,1554772152.049 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:12.049Z,1554772152.049 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:12.049Z,1554772152.049 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:12.049Z,1554772152.049 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:12.050Z,1554772152.050 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:12.050Z,1554772152.050 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:12.050Z,1554772152.050 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:12.441Z,1554772152.441 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:12.461Z,1554772152.461 [CBIT](FAULT): Main Battery Failure. Count: 211 2019-04-09T01:09:12.850Z,1554772152.850 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:12.850Z,1554772152.850 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:12.851Z,1554772152.851 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:12.851Z,1554772152.851 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:12.851Z,1554772152.851 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:12.851Z,1554772152.851 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:12.851Z,1554772152.851 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:12.851Z,1554772152.851 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:13.250Z,1554772153.250 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:13.655Z,1554772153.655 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:13.655Z,1554772153.655 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:13.656Z,1554772153.656 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:13.656Z,1554772153.656 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:13.656Z,1554772153.656 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:13.656Z,1554772153.656 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:13.656Z,1554772153.656 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:13.656Z,1554772153.656 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:14.065Z,1554772154.065 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:14.459Z,1554772154.459 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:14.460Z,1554772154.460 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:14.460Z,1554772154.460 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:14.460Z,1554772154.460 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:14.460Z,1554772154.460 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:14.460Z,1554772154.460 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:14.461Z,1554772154.461 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:14.461Z,1554772154.461 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:14.865Z,1554772154.865 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:15.275Z,1554772155.275 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:15.275Z,1554772155.275 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:15.275Z,1554772155.275 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:15.275Z,1554772155.275 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:15.275Z,1554772155.275 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:15.276Z,1554772155.276 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:15.276Z,1554772155.276 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:15.276Z,1554772155.276 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:15.674Z,1554772155.674 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:16.089Z,1554772156.089 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:16.089Z,1554772156.089 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:16.089Z,1554772156.089 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:16.089Z,1554772156.089 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:16.089Z,1554772156.089 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:16.089Z,1554772156.089 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:16.090Z,1554772156.090 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:16.090Z,1554772156.090 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:16.496Z,1554772156.496 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:16.513Z,1554772156.513 [CBIT](FAULT): Main Battery Failure. Count: 221 2019-04-09T01:09:16.897Z,1554772156.897 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:16.897Z,1554772156.897 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:16.897Z,1554772156.897 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:16.897Z,1554772156.897 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:16.897Z,1554772156.897 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:16.898Z,1554772156.898 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:16.898Z,1554772156.898 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:16.898Z,1554772156.898 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:17.301Z,1554772157.301 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:17.705Z,1554772157.705 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:17.705Z,1554772157.705 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:17.705Z,1554772157.705 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:17.705Z,1554772157.705 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:17.705Z,1554772157.705 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:17.706Z,1554772157.706 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:17.706Z,1554772157.706 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:17.706Z,1554772157.706 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:18.098Z,1554772158.098 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:18.502Z,1554772158.502 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:18.502Z,1554772158.502 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:18.502Z,1554772158.502 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:18.503Z,1554772158.503 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:18.503Z,1554772158.503 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:18.503Z,1554772158.503 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:18.503Z,1554772158.503 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:18.503Z,1554772158.503 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:18.906Z,1554772158.906 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:19.290Z,1554772159.290 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface 2019-04-09T01:09:19.291Z,1554772159.291 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 4 2019-04-09T01:09:19.291Z,1554772159.291 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault 2019-04-09T01:09:19.308Z,1554772159.308 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:19.309Z,1554772159.309 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:19.309Z,1554772159.309 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:19.309Z,1554772159.309 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:19.309Z,1554772159.309 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:19.309Z,1554772159.309 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:19.309Z,1554772159.309 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:19.310Z,1554772159.310 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:19.332Z,1554772159.332 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900 2019-04-09T01:09:19.694Z,1554772159.694 [AcousticModem_Benthos_ATM900](INFO): Powering down 2019-04-09T01:09:19.842Z,1554772159.842 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:19.842Z,1554772159.842 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:19.842Z,1554772159.842 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:19.842Z,1554772159.842 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:19.842Z,1554772159.842 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:19.843Z,1554772159.843 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:19.843Z,1554772159.843 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:19.843Z,1554772159.843 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:20.118Z,1554772160.118 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:20.523Z,1554772160.523 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:20.523Z,1554772160.523 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:20.524Z,1554772160.524 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:20.524Z,1554772160.524 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:20.524Z,1554772160.524 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:20.524Z,1554772160.524 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:20.524Z,1554772160.524 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:20.524Z,1554772160.524 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:20.541Z,1554772160.541 [CBIT](FAULT): Main Battery Failure. Count: 231 2019-04-09T01:09:20.544Z,1554772160.544 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900 2019-04-09T01:09:20.544Z,1554772160.544 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 4 2019-04-09T01:09:20.930Z,1554772160.930 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:21.347Z,1554772161.347 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:21.348Z,1554772161.348 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:21.348Z,1554772161.348 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:21.348Z,1554772161.348 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:21.348Z,1554772161.348 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:21.348Z,1554772161.348 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:21.348Z,1554772161.348 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:21.349Z,1554772161.349 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:21.745Z,1554772161.745 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:22.148Z,1554772162.148 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:22.148Z,1554772162.148 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:22.149Z,1554772162.149 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:22.149Z,1554772162.149 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:22.149Z,1554772162.149 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:22.149Z,1554772162.149 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:22.149Z,1554772162.149 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:22.150Z,1554772162.150 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:22.556Z,1554772162.556 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:22.926Z,1554772162.926 [AcousticModem_Benthos_ATM900](INFO): Powering up 2019-04-09T01:09:22.927Z,1554772162.927 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900. 2019-04-09T01:09:22.962Z,1554772162.962 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:22.962Z,1554772162.962 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:22.962Z,1554772162.962 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:22.962Z,1554772162.962 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:22.962Z,1554772162.962 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:22.963Z,1554772162.963 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:22.963Z,1554772162.963 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:22.963Z,1554772162.963 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:23.358Z,1554772163.358 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:23.758Z,1554772163.758 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:23.758Z,1554772163.758 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:23.758Z,1554772163.758 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:23.759Z,1554772163.759 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:23.759Z,1554772163.759 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:23.759Z,1554772163.759 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:23.759Z,1554772163.759 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:23.759Z,1554772163.759 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:24.161Z,1554772164.161 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:24.562Z,1554772164.562 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:24.562Z,1554772164.562 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:24.562Z,1554772164.562 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:24.562Z,1554772164.562 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:24.562Z,1554772164.562 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:24.563Z,1554772164.563 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:24.563Z,1554772164.563 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:24.563Z,1554772164.563 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:24.625Z,1554772164.625 [CBIT](FAULT): Main Battery Failure. Count: 241 2019-04-09T01:09:24.966Z,1554772164.966 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:25.370Z,1554772165.370 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:25.370Z,1554772165.370 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:25.371Z,1554772165.371 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:25.371Z,1554772165.371 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:25.371Z,1554772165.371 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:25.371Z,1554772165.371 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:25.371Z,1554772165.371 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:25.371Z,1554772165.371 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:25.774Z,1554772165.774 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:26.182Z,1554772166.182 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:26.182Z,1554772166.182 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:26.182Z,1554772166.182 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:26.183Z,1554772166.183 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:26.183Z,1554772166.183 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:26.183Z,1554772166.183 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:26.183Z,1554772166.183 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:26.183Z,1554772166.183 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:26.593Z,1554772166.593 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:26.996Z,1554772166.996 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:26.996Z,1554772166.996 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:26.997Z,1554772166.997 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:26.997Z,1554772166.997 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:26.997Z,1554772166.997 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:26.997Z,1554772166.997 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:26.997Z,1554772166.997 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:26.997Z,1554772166.997 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:27.409Z,1554772167.409 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:27.807Z,1554772167.807 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:27.807Z,1554772167.807 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:27.807Z,1554772167.807 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:27.807Z,1554772167.807 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:27.807Z,1554772167.807 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:27.808Z,1554772167.808 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:27.808Z,1554772167.808 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:27.808Z,1554772167.808 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:28.198Z,1554772168.198 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:28.602Z,1554772168.602 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:28.602Z,1554772168.602 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:28.603Z,1554772168.603 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:28.603Z,1554772168.603 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:28.603Z,1554772168.603 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:28.603Z,1554772168.603 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:28.603Z,1554772168.603 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:28.603Z,1554772168.603 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:28.621Z,1554772168.621 [CBIT](FAULT): Main Battery Failure. Count: 251 2019-04-09T01:09:29.006Z,1554772169.006 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:29.407Z,1554772169.407 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:29.408Z,1554772169.408 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:29.408Z,1554772169.408 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:29.408Z,1554772169.408 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:29.408Z,1554772169.408 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:29.408Z,1554772169.408 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:29.408Z,1554772169.408 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:29.409Z,1554772169.409 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:29.814Z,1554772169.814 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:30.219Z,1554772170.219 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:30.219Z,1554772170.219 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:30.219Z,1554772170.219 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:30.219Z,1554772170.219 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:30.219Z,1554772170.219 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:30.220Z,1554772170.220 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:30.220Z,1554772170.220 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:30.220Z,1554772170.220 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:30.626Z,1554772170.626 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:31.026Z,1554772171.026 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:31.026Z,1554772171.026 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:31.026Z,1554772171.026 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:31.027Z,1554772171.027 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:31.027Z,1554772171.027 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:31.027Z,1554772171.027 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:31.027Z,1554772171.027 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:31.027Z,1554772171.027 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:31.430Z,1554772171.430 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:31.848Z,1554772171.848 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:31.848Z,1554772171.848 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:31.849Z,1554772171.849 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:31.849Z,1554772171.849 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:31.849Z,1554772171.849 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:31.849Z,1554772171.849 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:31.849Z,1554772171.849 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:31.850Z,1554772171.850 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:32.249Z,1554772172.249 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:32.652Z,1554772172.652 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:32.652Z,1554772172.652 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:32.653Z,1554772172.653 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:32.653Z,1554772172.653 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:32.653Z,1554772172.653 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:32.653Z,1554772172.653 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:32.653Z,1554772172.653 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:32.654Z,1554772172.654 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:32.673Z,1554772172.673 [CBIT](FAULT): Main Battery Failure. Count: 261 2019-04-09T01:09:33.057Z,1554772173.057 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:33.454Z,1554772173.454 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:33.454Z,1554772173.454 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:33.455Z,1554772173.455 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:33.455Z,1554772173.455 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:33.455Z,1554772173.455 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:33.455Z,1554772173.455 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:33.455Z,1554772173.455 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:33.455Z,1554772173.455 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:33.857Z,1554772173.857 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:34.255Z,1554772174.255 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:34.255Z,1554772174.255 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:34.255Z,1554772174.255 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:34.256Z,1554772174.256 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:34.256Z,1554772174.256 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:34.256Z,1554772174.256 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:34.256Z,1554772174.256 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:34.256Z,1554772174.256 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:34.662Z,1554772174.662 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:35.066Z,1554772175.066 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:35.066Z,1554772175.066 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:35.066Z,1554772175.066 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:35.066Z,1554772175.066 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:35.066Z,1554772175.066 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:35.067Z,1554772175.067 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:35.067Z,1554772175.067 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:35.067Z,1554772175.067 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:35.470Z,1554772175.470 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:35.874Z,1554772175.874 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:35.874Z,1554772175.874 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:35.875Z,1554772175.875 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:35.875Z,1554772175.875 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:35.875Z,1554772175.875 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:35.875Z,1554772175.875 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:35.875Z,1554772175.875 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:35.875Z,1554772175.875 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:36.282Z,1554772176.282 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:36.686Z,1554772176.686 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:36.686Z,1554772176.686 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:36.686Z,1554772176.686 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:36.686Z,1554772176.686 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:36.687Z,1554772176.687 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:36.687Z,1554772176.687 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:36.687Z,1554772176.687 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:36.687Z,1554772176.687 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:36.699Z,1554772176.699 [CBIT](FAULT): Main Battery Failure. Count: 271 2019-04-09T01:09:37.105Z,1554772177.105 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:37.503Z,1554772177.503 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:37.503Z,1554772177.503 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:37.503Z,1554772177.503 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:37.504Z,1554772177.504 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:37.504Z,1554772177.504 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:37.504Z,1554772177.504 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:37.504Z,1554772177.504 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:37.504Z,1554772177.504 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:37.905Z,1554772177.905 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:38.312Z,1554772178.312 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:38.312Z,1554772178.312 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:38.313Z,1554772178.313 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:38.313Z,1554772178.313 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:38.313Z,1554772178.313 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:38.313Z,1554772178.313 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:38.313Z,1554772178.313 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:38.314Z,1554772178.314 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:38.702Z,1554772178.702 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:39.103Z,1554772179.103 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:39.103Z,1554772179.103 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:39.103Z,1554772179.103 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:39.103Z,1554772179.103 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:39.103Z,1554772179.103 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:39.104Z,1554772179.104 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:39.104Z,1554772179.104 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:39.104Z,1554772179.104 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:39.514Z,1554772179.514 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:39.913Z,1554772179.913 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:39.914Z,1554772179.914 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:39.914Z,1554772179.914 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:39.914Z,1554772179.914 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:39.914Z,1554772179.914 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:39.914Z,1554772179.914 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:39.915Z,1554772179.915 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:39.915Z,1554772179.915 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:40.317Z,1554772180.317 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:40.725Z,1554772180.725 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:40.725Z,1554772180.725 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:40.725Z,1554772180.725 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:40.725Z,1554772180.725 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:40.725Z,1554772180.725 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:40.725Z,1554772180.725 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:40.726Z,1554772180.726 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:40.726Z,1554772180.726 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:40.738Z,1554772180.738 [CBIT](FAULT): Main Battery Failure. Count: 281 2019-04-09T01:09:41.125Z,1554772181.125 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:41.534Z,1554772181.534 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:41.534Z,1554772181.534 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:41.534Z,1554772181.534 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:41.534Z,1554772181.534 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:41.535Z,1554772181.535 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:41.535Z,1554772181.535 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:41.535Z,1554772181.535 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:41.535Z,1554772181.535 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:41.934Z,1554772181.934 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:42.348Z,1554772182.348 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:42.348Z,1554772182.348 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:42.349Z,1554772182.349 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:42.349Z,1554772182.349 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:42.349Z,1554772182.349 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:42.349Z,1554772182.349 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:42.349Z,1554772182.349 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:42.350Z,1554772182.350 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:42.753Z,1554772182.753 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:43.127Z,1554772183.127 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface 2019-04-09T01:09:43.127Z,1554772183.127 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 5 2019-04-09T01:09:43.127Z,1554772183.127 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault 2019-04-09T01:09:43.156Z,1554772183.156 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:43.157Z,1554772183.157 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:43.157Z,1554772183.157 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:43.157Z,1554772183.157 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:43.157Z,1554772183.157 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:43.157Z,1554772183.157 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:43.157Z,1554772183.157 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:43.158Z,1554772183.158 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:43.180Z,1554772183.180 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900 2019-04-09T01:09:43.531Z,1554772183.531 [AcousticModem_Benthos_ATM900](INFO): Powering down 2019-04-09T01:09:43.690Z,1554772183.690 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:43.690Z,1554772183.690 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:43.690Z,1554772183.690 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:43.690Z,1554772183.690 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:43.690Z,1554772183.690 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:43.691Z,1554772183.691 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:43.691Z,1554772183.691 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:43.691Z,1554772183.691 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:43.957Z,1554772183.957 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:44.361Z,1554772184.361 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:44.362Z,1554772184.362 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:44.362Z,1554772184.362 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:44.362Z,1554772184.362 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:44.362Z,1554772184.362 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:44.362Z,1554772184.362 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:44.363Z,1554772184.363 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:44.363Z,1554772184.363 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:44.384Z,1554772184.384 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900 2019-04-09T01:09:44.384Z,1554772184.384 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 5 2019-04-09T01:09:44.762Z,1554772184.762 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:44.774Z,1554772184.774 [CBIT](FAULT): Main Battery Failure. Count: 291 2019-04-09T01:09:45.163Z,1554772185.163 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:45.163Z,1554772185.163 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:45.164Z,1554772185.164 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:45.164Z,1554772185.164 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:45.164Z,1554772185.164 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:45.164Z,1554772185.164 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:45.164Z,1554772185.164 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:45.165Z,1554772185.165 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:45.570Z,1554772185.570 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:45.971Z,1554772185.971 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:45.971Z,1554772185.971 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:45.971Z,1554772185.971 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:45.972Z,1554772185.972 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:45.972Z,1554772185.972 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:45.972Z,1554772185.972 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:45.972Z,1554772185.972 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:45.972Z,1554772185.972 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:46.378Z,1554772186.378 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:46.762Z,1554772186.762 [AcousticModem_Benthos_ATM900](INFO): Powering up 2019-04-09T01:09:46.763Z,1554772186.763 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900. 2019-04-09T01:09:46.798Z,1554772186.798 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:46.798Z,1554772186.798 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:46.798Z,1554772186.798 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:46.799Z,1554772186.799 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:46.799Z,1554772186.799 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:46.799Z,1554772186.799 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:46.799Z,1554772186.799 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:46.799Z,1554772186.799 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:46.809Z,1554772186.809 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-04-09T01:09:46.809Z,1554772186.809 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2019-04-09T01:09:46.809Z,1554772186.809 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-04-09T01:09:46.811Z,1554772186.811 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-04-09T01:09:46.811Z,1554772186.811 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1 2019-04-09T01:09:46.811Z,1554772186.811 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2019-04-09T01:09:46.812Z,1554772186.812 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-04-09T01:09:46.812Z,1554772186.812 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2019-04-09T01:09:46.812Z,1554772186.812 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2019-04-09T01:09:46.823Z,1554772186.823 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-04-09T01:09:46.823Z,1554772186.823 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2019-04-09T01:09:46.823Z,1554772186.823 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2019-04-09T01:09:47.187Z,1554772187.187 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:47.200Z,1554772187.200 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-04-09T01:09:47.200Z,1554772187.200 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2019-04-09T01:09:47.201Z,1554772187.201 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2019-04-09T01:09:47.201Z,1554772187.201 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1 2019-04-09T01:09:47.201Z,1554772187.201 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2019-04-09T01:09:47.201Z,1554772187.201 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2019-04-09T01:09:47.601Z,1554772187.601 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:47.601Z,1554772187.601 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:47.601Z,1554772187.601 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:47.601Z,1554772187.601 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:47.602Z,1554772187.602 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:47.602Z,1554772187.602 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:47.602Z,1554772187.602 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:47.602Z,1554772187.602 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:47.613Z,1554772187.613 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2019-04-09T01:09:48.011Z,1554772188.011 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:48.409Z,1554772188.409 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:48.409Z,1554772188.409 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:48.409Z,1554772188.409 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:48.409Z,1554772188.409 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:48.409Z,1554772188.409 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:48.409Z,1554772188.409 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:48.410Z,1554772188.410 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:48.410Z,1554772188.410 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:48.812Z,1554772188.812 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:48.829Z,1554772188.829 [CBIT](FAULT): Main Battery Failure. Count: 301 2019-04-09T01:09:49.206Z,1554772189.206 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:49.206Z,1554772189.206 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:49.206Z,1554772189.206 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:49.207Z,1554772189.207 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:49.207Z,1554772189.207 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:49.207Z,1554772189.207 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:49.207Z,1554772189.207 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:49.207Z,1554772189.207 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:49.610Z,1554772189.610 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:50.012Z,1554772190.012 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:50.012Z,1554772190.012 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:50.012Z,1554772190.012 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:50.012Z,1554772190.012 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:50.012Z,1554772190.012 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:50.012Z,1554772190.012 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:50.013Z,1554772190.013 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:50.013Z,1554772190.013 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:50.418Z,1554772190.418 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:50.823Z,1554772190.823 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:50.824Z,1554772190.824 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:50.824Z,1554772190.824 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:50.824Z,1554772190.824 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:50.824Z,1554772190.824 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:50.824Z,1554772190.824 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:50.825Z,1554772190.825 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:50.825Z,1554772190.825 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:51.228Z,1554772191.228 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:51.630Z,1554772191.630 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:51.630Z,1554772191.630 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:51.630Z,1554772191.630 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:51.630Z,1554772191.630 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:51.631Z,1554772191.631 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:51.631Z,1554772191.631 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:51.631Z,1554772191.631 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:51.631Z,1554772191.631 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:52.034Z,1554772192.034 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:52.435Z,1554772192.435 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:52.436Z,1554772192.436 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:52.436Z,1554772192.436 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:52.436Z,1554772192.436 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:52.436Z,1554772192.436 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:52.436Z,1554772192.436 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:52.437Z,1554772192.437 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:52.437Z,1554772192.437 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:52.852Z,1554772192.852 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:52.869Z,1554772192.869 [CBIT](FAULT): Main Battery Failure. Count: 311 2019-04-09T01:09:53.257Z,1554772193.257 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:53.257Z,1554772193.257 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:53.257Z,1554772193.257 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:53.257Z,1554772193.257 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:53.257Z,1554772193.257 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:53.257Z,1554772193.257 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:53.258Z,1554772193.258 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:53.258Z,1554772193.258 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:53.660Z,1554772193.660 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:54.065Z,1554772194.065 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:54.065Z,1554772194.065 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:54.065Z,1554772194.065 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:54.065Z,1554772194.065 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:54.065Z,1554772194.065 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:54.065Z,1554772194.065 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:54.066Z,1554772194.066 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:54.066Z,1554772194.066 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:54.461Z,1554772194.461 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:54.866Z,1554772194.866 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:54.866Z,1554772194.866 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:54.866Z,1554772194.866 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:54.867Z,1554772194.867 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:54.867Z,1554772194.867 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:54.867Z,1554772194.867 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:54.867Z,1554772194.867 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:54.867Z,1554772194.867 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:55.266Z,1554772195.266 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:55.674Z,1554772195.674 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:55.674Z,1554772195.674 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:55.674Z,1554772195.674 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:55.675Z,1554772195.675 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:55.675Z,1554772195.675 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:55.675Z,1554772195.675 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:55.675Z,1554772195.675 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:55.675Z,1554772195.675 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:56.074Z,1554772196.074 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:56.482Z,1554772196.482 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:56.482Z,1554772196.482 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:56.482Z,1554772196.482 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:56.483Z,1554772196.483 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:56.483Z,1554772196.483 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:56.483Z,1554772196.483 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:56.483Z,1554772196.483 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:56.483Z,1554772196.483 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:56.882Z,1554772196.882 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:56.894Z,1554772196.894 [CBIT](FAULT): Main Battery Failure. Count: 321 2019-04-09T01:09:57.283Z,1554772197.283 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:57.284Z,1554772197.284 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:57.284Z,1554772197.284 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:57.284Z,1554772197.284 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:57.284Z,1554772197.284 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:57.284Z,1554772197.284 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:57.285Z,1554772197.285 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:57.285Z,1554772197.285 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:57.696Z,1554772197.696 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:58.109Z,1554772198.109 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:58.109Z,1554772198.109 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:58.109Z,1554772198.109 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:58.110Z,1554772198.110 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:58.110Z,1554772198.110 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:58.110Z,1554772198.110 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:58.110Z,1554772198.110 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:58.110Z,1554772198.110 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:58.508Z,1554772198.508 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:58.917Z,1554772198.917 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:58.917Z,1554772198.917 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:58.917Z,1554772198.917 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:58.917Z,1554772198.917 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:58.917Z,1554772198.917 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:58.918Z,1554772198.918 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:58.918Z,1554772198.918 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:58.918Z,1554772198.918 [BR_Ping1D](INFO): No UART data 2019-04-09T01:09:59.316Z,1554772199.316 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:59.710Z,1554772199.710 [BR_Ping1D](INFO): Starting 2019-04-09T01:09:59.710Z,1554772199.710 [BR_Ping1D](INFO): readConfig 2019-04-09T01:09:59.711Z,1554772199.711 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:09:59.711Z,1554772199.711 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:09:59.711Z,1554772199.711 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:09:59.711Z,1554772199.711 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:09:59.711Z,1554772199.711 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:09:59.712Z,1554772199.712 [BR_Ping1D](INFO): No UART data 2019-04-09T01:10:00.118Z,1554772200.118 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:00.514Z,1554772200.514 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:00.515Z,1554772200.515 [BR_Ping1D](INFO): readConfig 2019-04-09T01:10:00.515Z,1554772200.515 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:10:00.515Z,1554772200.515 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:10:00.515Z,1554772200.515 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:10:00.515Z,1554772200.515 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:10:00.515Z,1554772200.515 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:10:00.516Z,1554772200.516 [BR_Ping1D](INFO): No UART data 2019-04-09T01:10:00.924Z,1554772200.924 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:00.942Z,1554772200.942 [CBIT](FAULT): Main Battery Failure. Count: 331 2019-04-09T01:10:01.333Z,1554772201.333 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:01.333Z,1554772201.333 [BR_Ping1D](INFO): readConfig 2019-04-09T01:10:01.334Z,1554772201.334 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:10:01.334Z,1554772201.334 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:10:01.334Z,1554772201.334 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:10:01.334Z,1554772201.334 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:10:01.334Z,1554772201.334 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:10:01.335Z,1554772201.335 [BR_Ping1D](INFO): No UART data 2019-04-09T01:10:01.730Z,1554772201.730 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:02.138Z,1554772202.138 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:02.138Z,1554772202.138 [BR_Ping1D](INFO): readConfig 2019-04-09T01:10:02.139Z,1554772202.139 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:10:02.139Z,1554772202.139 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:10:02.139Z,1554772202.139 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:10:02.139Z,1554772202.139 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:10:02.139Z,1554772202.139 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:10:02.140Z,1554772202.140 [BR_Ping1D](INFO): No UART data 2019-04-09T01:10:02.542Z,1554772202.542 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:02.946Z,1554772202.946 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:02.946Z,1554772202.946 [BR_Ping1D](INFO): readConfig 2019-04-09T01:10:02.947Z,1554772202.947 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:10:02.947Z,1554772202.947 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:10:02.947Z,1554772202.947 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:10:02.947Z,1554772202.947 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:10:02.947Z,1554772202.947 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:10:02.948Z,1554772202.948 [BR_Ping1D](INFO): No UART data 2019-04-09T01:10:03.360Z,1554772203.360 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:03.761Z,1554772203.761 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:03.761Z,1554772203.761 [BR_Ping1D](INFO): readConfig 2019-04-09T01:10:03.761Z,1554772203.761 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:10:03.761Z,1554772203.761 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:10:03.761Z,1554772203.761 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:10:03.761Z,1554772203.761 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:10:03.762Z,1554772203.762 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:10:03.762Z,1554772203.762 [BR_Ping1D](INFO): No UART data 2019-04-09T01:10:04.168Z,1554772204.168 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:04.571Z,1554772204.571 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:04.571Z,1554772204.571 [BR_Ping1D](INFO): readConfig 2019-04-09T01:10:04.572Z,1554772204.572 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:10:04.572Z,1554772204.572 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:10:04.572Z,1554772204.572 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:10:04.572Z,1554772204.572 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:10:04.572Z,1554772204.572 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:10:04.573Z,1554772204.573 [BR_Ping1D](INFO): No UART data 2019-04-09T01:10:04.966Z,1554772204.966 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:04.992Z,1554772204.992 [CBIT](FAULT): Main Battery Failure. Count: 341 2019-04-09T01:10:05.363Z,1554772205.363 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:05.363Z,1554772205.363 [BR_Ping1D](INFO): readConfig 2019-04-09T01:10:05.364Z,1554772205.364 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:10:05.364Z,1554772205.364 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:10:05.364Z,1554772205.364 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:10:05.364Z,1554772205.364 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:10:05.364Z,1554772205.364 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:10:05.364Z,1554772205.364 [BR_Ping1D](INFO): No UART data 2019-04-09T01:10:05.770Z,1554772205.770 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:05.783Z,1554772205.783 [Startup:StartupSatComms:A](INFO): Timed out from 2019-04-09T01:09:05.6Z 2019-04-09T01:10:05.783Z,1554772205.783 [Startup:StartupSatComms:A] Stopped 2019-04-09T01:10:05.783Z,1554772205.783 [Startup:StartupSatComms:B] Running Loop=1 2019-04-09T01:10:06.174Z,1554772206.174 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:06.174Z,1554772206.174 [BR_Ping1D](INFO): readConfig 2019-04-09T01:10:06.174Z,1554772206.174 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:10:06.175Z,1554772206.175 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:10:06.175Z,1554772206.175 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:10:06.175Z,1554772206.175 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:10:06.175Z,1554772206.175 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:10:06.175Z,1554772206.175 [BR_Ping1D](INFO): No UART data 2019-04-09T01:10:06.187Z,1554772206.187 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2019-04-09T01:10:06.582Z,1554772206.582 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:06.962Z,1554772206.962 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface 2019-04-09T01:10:06.963Z,1554772206.963 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 6 2019-04-09T01:10:06.963Z,1554772206.963 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault 2019-04-09T01:10:06.980Z,1554772206.980 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:06.980Z,1554772206.980 [BR_Ping1D](INFO): readConfig 2019-04-09T01:10:06.980Z,1554772206.980 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:10:06.980Z,1554772206.980 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:10:06.980Z,1554772206.980 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:10:06.981Z,1554772206.981 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:10:06.981Z,1554772206.981 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:10:06.981Z,1554772206.981 [BR_Ping1D](INFO): No UART data 2019-04-09T01:10:07.000Z,1554772207.000 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900 2019-04-09T01:10:07.366Z,1554772207.366 [AcousticModem_Benthos_ATM900](INFO): Powering down 2019-04-09T01:10:07.510Z,1554772207.510 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:07.510Z,1554772207.510 [BR_Ping1D](INFO): readConfig 2019-04-09T01:10:07.510Z,1554772207.510 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:10:07.511Z,1554772207.511 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:10:07.511Z,1554772207.511 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:10:07.511Z,1554772207.511 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:10:07.511Z,1554772207.511 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:10:07.511Z,1554772207.511 [BR_Ping1D](INFO): No UART data 2019-04-09T01:10:07.793Z,1554772207.793 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:08.193Z,1554772208.193 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:08.194Z,1554772208.194 [BR_Ping1D](INFO): readConfig 2019-04-09T01:10:08.194Z,1554772208.194 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:10:08.194Z,1554772208.194 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:10:08.194Z,1554772208.194 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:10:08.194Z,1554772208.194 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:10:08.195Z,1554772208.195 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:10:08.195Z,1554772208.195 [BR_Ping1D](INFO): No UART data 2019-04-09T01:10:08.243Z,1554772208.243 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900 2019-04-09T01:10:08.243Z,1554772208.243 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 6 2019-04-09T01:10:08.613Z,1554772208.613 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:09.014Z,1554772209.014 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:09.015Z,1554772209.015 [BR_Ping1D](INFO): readConfig 2019-04-09T01:10:09.015Z,1554772209.015 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:10:09.015Z,1554772209.015 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:10:09.015Z,1554772209.015 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:10:09.015Z,1554772209.015 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:10:09.015Z,1554772209.015 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:10:09.016Z,1554772209.016 [BR_Ping1D](INFO): No UART data 2019-04-09T01:10:09.030Z,1554772209.030 [CBIT](FAULT): Main Battery Failure. Count: 351 2019-04-09T01:10:09.418Z,1554772209.418 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:09.822Z,1554772209.822 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:09.822Z,1554772209.822 [BR_Ping1D](INFO): readConfig 2019-04-09T01:10:09.822Z,1554772209.822 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:10:09.822Z,1554772209.822 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:10:09.823Z,1554772209.823 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:10:09.823Z,1554772209.823 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:10:09.823Z,1554772209.823 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:10:09.823Z,1554772209.823 [BR_Ping1D](INFO): No UART data 2019-04-09T01:10:10.214Z,1554772210.214 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:10.598Z,1554772210.598 [AcousticModem_Benthos_ATM900](INFO): Powering up 2019-04-09T01:10:10.599Z,1554772210.599 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900. 2019-04-09T01:10:10.639Z,1554772210.639 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:10.639Z,1554772210.639 [BR_Ping1D](INFO): readConfig 2019-04-09T01:10:10.640Z,1554772210.640 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:10:10.640Z,1554772210.640 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:10:10.640Z,1554772210.640 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:10:10.640Z,1554772210.640 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:10:10.640Z,1554772210.640 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:10:10.641Z,1554772210.641 [BR_Ping1D](INFO): No UART data 2019-04-09T01:10:11.026Z,1554772211.026 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:11.448Z,1554772211.448 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:11.448Z,1554772211.448 [BR_Ping1D](INFO): readConfig 2019-04-09T01:10:11.448Z,1554772211.448 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:10:11.448Z,1554772211.448 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:10:11.449Z,1554772211.449 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:10:11.449Z,1554772211.449 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:10:11.449Z,1554772211.449 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:10:11.449Z,1554772211.449 [BR_Ping1D](INFO): No UART data 2019-04-09T01:10:11.830Z,1554772211.830 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:12.233Z,1554772212.233 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:12.233Z,1554772212.233 [BR_Ping1D](INFO): readConfig 2019-04-09T01:10:12.234Z,1554772212.234 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:10:12.234Z,1554772212.234 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:10:12.234Z,1554772212.234 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:10:12.234Z,1554772212.234 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:10:12.234Z,1554772212.234 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:10:12.235Z,1554772212.235 [BR_Ping1D](INFO): No UART data 2019-04-09T01:10:12.640Z,1554772212.640 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:13.044Z,1554772213.044 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:13.044Z,1554772213.044 [BR_Ping1D](INFO): readConfig 2019-04-09T01:10:13.044Z,1554772213.044 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:10:13.044Z,1554772213.044 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:10:13.044Z,1554772213.044 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:10:13.045Z,1554772213.045 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:10:13.045Z,1554772213.045 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:10:13.045Z,1554772213.045 [BR_Ping1D](INFO): No UART data 2019-04-09T01:10:13.056Z,1554772213.056 [CBIT](FAULT): Main Battery Failure. Count: 361 2019-04-09T01:10:13.446Z,1554772213.446 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:13.864Z,1554772213.864 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:13.864Z,1554772213.864 [BR_Ping1D](INFO): readConfig 2019-04-09T01:10:13.865Z,1554772213.865 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:10:13.865Z,1554772213.865 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:10:13.865Z,1554772213.865 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:10:13.865Z,1554772213.865 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:10:13.865Z,1554772213.865 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:10:13.866Z,1554772213.866 [BR_Ping1D](INFO): No UART data 2019-04-09T01:10:14.269Z,1554772214.269 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:14.680Z,1554772214.680 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:14.680Z,1554772214.680 [BR_Ping1D](INFO): readConfig 2019-04-09T01:10:14.680Z,1554772214.680 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:10:14.680Z,1554772214.680 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:10:14.680Z,1554772214.680 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:10:14.681Z,1554772214.681 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:10:14.681Z,1554772214.681 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:10:14.681Z,1554772214.681 [BR_Ping1D](INFO): No UART data 2019-04-09T01:10:15.072Z,1554772215.072 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:15.466Z,1554772215.466 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:15.466Z,1554772215.466 [BR_Ping1D](INFO): readConfig 2019-04-09T01:10:15.467Z,1554772215.467 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:10:15.467Z,1554772215.467 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:10:15.467Z,1554772215.467 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:10:15.467Z,1554772215.467 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:10:15.467Z,1554772215.467 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:10:15.468Z,1554772215.468 [BR_Ping1D](INFO): No UART data 2019-04-09T01:10:15.874Z,1554772215.874 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:16.274Z,1554772216.274 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:16.274Z,1554772216.274 [BR_Ping1D](INFO): readConfig 2019-04-09T01:10:16.274Z,1554772216.274 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:10:16.274Z,1554772216.274 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:10:16.275Z,1554772216.275 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:10:16.275Z,1554772216.275 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:10:16.275Z,1554772216.275 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:10:16.275Z,1554772216.275 [BR_Ping1D](INFO): No UART data 2019-04-09T01:10:16.678Z,1554772216.678 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:17.086Z,1554772217.086 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:17.086Z,1554772217.086 [BR_Ping1D](INFO): readConfig 2019-04-09T01:10:17.087Z,1554772217.087 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:10:17.087Z,1554772217.087 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:10:17.087Z,1554772217.087 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:10:17.087Z,1554772217.087 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:10:17.087Z,1554772217.087 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:10:17.087Z,1554772217.087 [BR_Ping1D](INFO): No UART data 2019-04-09T01:10:17.100Z,1554772217.100 [CBIT](FAULT): Main Battery Failure. Count: 371 2019-04-09T01:10:17.488Z,1554772217.488 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:17.892Z,1554772217.892 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:17.892Z,1554772217.892 [BR_Ping1D](INFO): readConfig 2019-04-09T01:10:17.892Z,1554772217.892 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:10:17.893Z,1554772217.893 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:10:17.893Z,1554772217.893 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:10:17.893Z,1554772217.893 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:10:17.893Z,1554772217.893 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:10:17.893Z,1554772217.893 [BR_Ping1D](INFO): No UART data 2019-04-09T01:10:18.295Z,1554772218.295 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:18.703Z,1554772218.703 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:18.704Z,1554772218.704 [BR_Ping1D](INFO): readConfig 2019-04-09T01:10:18.704Z,1554772218.704 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:10:18.704Z,1554772218.704 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:10:18.704Z,1554772218.704 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:10:18.704Z,1554772218.704 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:10:18.705Z,1554772218.705 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:10:18.705Z,1554772218.705 [BR_Ping1D](INFO): No UART data 2019-04-09T01:10:19.117Z,1554772219.117 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:19.524Z,1554772219.524 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:19.524Z,1554772219.524 [BR_Ping1D](INFO): readConfig 2019-04-09T01:10:19.525Z,1554772219.525 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:10:19.525Z,1554772219.525 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:10:19.525Z,1554772219.525 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:10:19.525Z,1554772219.525 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:10:19.525Z,1554772219.525 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:10:19.525Z,1554772219.525 [BR_Ping1D](INFO): No UART data 2019-04-09T01:10:19.680Z,1554772219.680 [CommandLine](IMPORTANT): got command restart application 2019-04-09T01:10:19.921Z,1554772219.921 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:20.324Z,1554772220.324 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:20.325Z,1554772220.325 [BR_Ping1D](INFO): readConfig 2019-04-09T01:10:20.325Z,1554772220.325 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:10:20.325Z,1554772220.325 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:10:20.325Z,1554772220.325 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:10:20.325Z,1554772220.325 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:10:20.326Z,1554772220.326 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:10:20.326Z,1554772220.326 [BR_Ping1D](INFO): No UART data 2019-04-09T01:10:20.682Z,1554772220.682 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2019-04-09T01:10:20.682Z,1554772220.682 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-04-09T01:10:20.726Z,1554772220.726 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:20.774Z,1554772220.774 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2019-04-09T01:10:20.774Z,1554772220.774 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-04-09T01:10:20.775Z,1554772220.775 [CommandLine](INFO): Join timeout helper Thread ID is 5315 2019-04-09T01:10:20.775Z,1554772220.775 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2019-04-09T01:10:20.775Z,1554772220.775 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-04-09T01:10:20.776Z,1554772220.776 [NavChartDb](INFO): Join timeout helper Thread ID is 5316 2019-04-09T01:10:21.010Z,1554772221.010 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2019-04-09T01:10:21.010Z,1554772221.010 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-04-09T01:10:21.026Z,1554772221.026 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2019-04-09T01:10:21.026Z,1554772221.026 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-04-09T01:10:21.026Z,1554772221.026 [Radio_Surface](INFO): Join timeout helper Thread ID is 5317 2019-04-09T01:10:21.132Z,1554772221.132 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:21.132Z,1554772221.132 [BR_Ping1D](INFO): readConfig 2019-04-09T01:10:21.132Z,1554772221.132 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:10:21.132Z,1554772221.132 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:10:21.132Z,1554772221.132 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:10:21.133Z,1554772221.133 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:10:21.133Z,1554772221.133 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:10:21.133Z,1554772221.133 [BR_Ping1D](INFO): No UART data 2019-04-09T01:10:21.150Z,1554772221.150 [CBIT](FAULT): Main Battery Failure. Count: 381 2019-04-09T01:10:21.330Z,1554772221.330 [Radio_Surface](INFO): Powering down 2019-04-09T01:10:21.331Z,1554772221.331 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2019-04-09T01:10:21.331Z,1554772221.331 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-04-09T01:10:21.342Z,1554772221.342 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2019-04-09T01:10:21.342Z,1554772221.342 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-04-09T01:10:21.342Z,1554772221.342 [DataOverHttps](INFO): Join timeout helper Thread ID is 5318 2019-04-09T01:10:21.530Z,1554772221.530 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:21.930Z,1554772221.930 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:21.930Z,1554772221.930 [BR_Ping1D](INFO): readConfig 2019-04-09T01:10:21.930Z,1554772221.930 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:10:21.931Z,1554772221.931 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:10:21.931Z,1554772221.931 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:10:21.931Z,1554772221.931 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:10:21.931Z,1554772221.931 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:10:21.931Z,1554772221.931 [BR_Ping1D](INFO): No UART data 2019-04-09T01:10:22.335Z,1554772222.335 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:22.735Z,1554772222.735 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:22.735Z,1554772222.735 [BR_Ping1D](INFO): readConfig 2019-04-09T01:10:22.735Z,1554772222.735 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:10:22.735Z,1554772222.735 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:10:22.735Z,1554772222.735 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:10:22.735Z,1554772222.735 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:10:22.736Z,1554772222.736 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:10:22.736Z,1554772222.736 [BR_Ping1D](INFO): No UART data 2019-04-09T01:10:23.139Z,1554772223.139 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:23.546Z,1554772223.546 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:23.546Z,1554772223.546 [BR_Ping1D](INFO): readConfig 2019-04-09T01:10:23.547Z,1554772223.547 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:10:23.547Z,1554772223.547 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:10:23.547Z,1554772223.547 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:10:23.547Z,1554772223.547 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:10:23.547Z,1554772223.547 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:10:23.548Z,1554772223.548 [BR_Ping1D](INFO): No UART data 2019-04-09T01:10:23.950Z,1554772223.950 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:24.042Z,1554772224.042 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2019-04-09T01:10:24.047Z,1554772224.047 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-04-09T01:10:24.062Z,1554772224.062 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2019-04-09T01:10:24.062Z,1554772224.062 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2019-04-09T01:10:24.063Z,1554772224.063 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 5319 2019-04-09T01:10:24.342Z,1554772224.342 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2019-04-09T01:10:24.343Z,1554772224.343 [WetLabsBB2FL](INFO): Powering down 2019-04-09T01:10:24.344Z,1554772224.344 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2019-04-09T01:10:24.364Z,1554772224.364 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2019-04-09T01:10:24.364Z,1554772224.364 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2019-04-09T01:10:24.364Z,1554772224.364 [CTD_Seabird](INFO): Join timeout helper Thread ID is 5320 2019-04-09T01:10:24.367Z,1554772224.367 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:24.367Z,1554772224.367 [BR_Ping1D](INFO): readConfig 2019-04-09T01:10:24.367Z,1554772224.367 [BR_Ping1D](INFO): XXXX automode1: 4962020 2019-04-09T01:10:24.367Z,1554772224.367 [BR_Ping1D](INFO): XXXX automode2: 228 2019-04-09T01:10:24.367Z,1554772224.367 [BR_Ping1D](INFO): UART waiting for response 2019-04-09T01:10:24.368Z,1554772224.368 [BR_Ping1D](INFO): elapsed0.0001 2019-04-09T01:10:24.368Z,1554772224.368 [BR_Ping1D](INFO): timeout5.0000 2019-04-09T01:10:24.368Z,1554772224.368 [BR_Ping1D](INFO): No UART data 2019-04-09T01:10:24.694Z,1554772224.694 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2019-04-09T01:10:24.694Z,1554772224.694 [CTD_Seabird](INFO): Powering down 2019-04-09T01:10:24.706Z,1554772224.706 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2019-04-09T01:10:24.723Z,1554772224.723 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2019-04-09T01:10:24.723Z,1554772224.723 [logger ThreadHandler](INFO): Thread cancelled. 2019-04-09T01:10:24.723Z,1554772224.723 [logger](INFO): Join timeout helper Thread ID is 5321 2019-04-09T01:10:24.750Z,1554772224.750 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2019-04-09T01:10:24.750Z,1554772224.750 [logger ThreadHandler](INFO): Thread cancelled. 2019-04-09T01:10:24.768Z,1554772224.768 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2019-04-09T01:10:24.768Z,1554772224.768 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-04-09T01:10:24.768Z,1554772224.768 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2019-04-09T01:10:24.768Z,1554772224.768 [controlThread ThreadHandler](INFO): Thread cancelled. 2019-04-09T01:10:24.769Z,1554772224.769 [controlThread](INFO): Join timeout helper Thread ID is 5322 2019-04-09T01:10:24.774Z,1554772224.774 [BR_Ping1D](INFO): Starting 2019-04-09T01:10:24.790Z,1554772224.790 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2019-04-09T01:10:24.790Z,1554772224.790 [controlThread](DEBUG): Uninitializing ControlThread 2019-04-09T01:10:24.791Z,1554772224.791 [Aanderaa_O2](INFO): Powering down 2019-04-09T01:10:24.793Z,1554772224.793 [AcousticModem_Benthos_ATM900](INFO): Powering down 2019-04-09T01:10:24.911Z,1554772224.911 [NAL9602](INFO): Powering down 2019-04-09T01:10:24.912Z,1554772224.912 [BR_Ping1D](INFO): uninitialize 2019-04-09T01:10:25.003Z,1554772225.003 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2019-04-09T01:10:25.003Z,1554772225.003 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2019-04-09T01:10:25.004Z,1554772225.004 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2019-04-09T01:10:25.005Z,1554772225.005 [MissionManager](INFO): Uninitializing Mission Default 2019-04-09T01:10:25.007Z,1554772225.007 [MissionManager](INFO): Uninitializing Mission Startup 2019-04-09T01:10:25.007Z,1554772225.007 [Startup] Stopped 2019-04-09T01:10:25.007Z,1554772225.007 [Startup](DEBUG): Aggregate::uninitialize Startup 2019-04-09T01:10:25.007Z,1554772225.007 [Startup:A.GoToSurface] Stopped 2019-04-09T01:10:25.007Z,1554772225.007 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2019-04-09T01:10:25.007Z,1554772225.007 [Startup:StartupSatComms] Stopped 2019-04-09T01:10:25.008Z,1554772225.008 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2019-04-09T01:10:25.008Z,1554772225.008 [Startup:StartupSatComms:B] Stopped 2019-04-09T01:10:25.009Z,1554772225.009 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2019-04-09T01:10:25.009Z,1554772225.009 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2019-04-09T01:10:25.009Z,1554772225.009 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2019-04-09T01:10:25.010Z,1554772225.010 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2019-04-09T01:10:25.010Z,1554772225.010 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2019-04-09T01:10:25.010Z,1554772225.010 [BuoyancyServo](INFO): Powering down 2019-04-09T01:10:25.022Z,1554772225.022 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2019-04-09T01:10:25.022Z,1554772225.022 [ElevatorServo](INFO): Powering down 2019-04-09T01:10:25.023Z,1554772225.023 [MassServo](DEBUG): Uninitialize Mass Servo. 2019-04-09T01:10:25.023Z,1554772225.023 [MassServo](INFO): Powering down 2019-04-09T01:10:25.024Z,1554772225.024 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2019-04-09T01:10:25.024Z,1554772225.024 [RudderServo](INFO): Powering down 2019-04-09T01:10:25.025Z,1554772225.025 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2019-04-09T01:10:25.025Z,1554772225.025 [ThrusterServo](INFO): Powering down 2019-04-09T01:10:25.026Z,1554772225.026 [SBIT](DEBUG): Uninitialize SBIT Component. 2019-04-09T01:10:25.026Z,1554772225.026 [IBIT](DEBUG): Uninitialize IBIT Component. 2019-04-09T01:10:25.026Z,1554772225.026 [CBIT](DEBUG): Uninitialize CBIT Component. 2019-04-09T01:10:25.026Z,1554772225.026 [CBIT](DEBUG): Powering off loads. 2019-04-09T01:10:25.038Z,1554772225.038 [CBIT](DEBUG): Disabling WDT. 2019-04-09T01:10:25.050Z,1554772225.050 [CBIT](DEBUG): Opening all GF detection circuits. 2019-04-09T01:10:25.051Z,1554772225.051 [controlThread ThreadHandler](INFO): Thread cancelled. 2019-04-09T01:10:25.209Z,1554772225.209 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2019-04-09T01:10:25.214Z,1554772225.214 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2019-04-09T01:10:25.281Z,1554772225.281 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-04-09T01:10:25.286Z,1554772225.286 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-04-09T01:10:25.337Z,1554772225.337 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-04-09T01:10:25.394Z,1554772225.394 [logger ThreadHandler](INFO): Thread cancelled.