2019-04-09T15:53:29.306Z,1554825209.306 [Supervisor](DEBUG): Initializing supervisor.
2019-04-09T15:53:29.309Z,1554825209.309 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-04-09T15:53:29.309Z,1554825209.309 [SyncHandler](INFO): Protected caller Thread ID is 3431
2019-04-09T15:53:29.310Z,1554825209.310 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2019-04-09T15:53:29.311Z,1554825209.311 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2019-04-09T15:53:29.311Z,1554825209.311 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 3432
2019-04-09T15:53:29.314Z,1554825209.314 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2019-04-09T15:53:29.326Z,1554825209.326 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2019-04-09T15:53:29.327Z,1554825209.327 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2019-04-09T15:53:29.328Z,1554825209.328 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 3433
2019-04-09T15:53:29.328Z,1554825209.328 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2019-04-09T15:53:29.329Z,1554825209.329 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2019-04-09T15:53:29.330Z,1554825209.330 [logger ThreadHandler](INFO): Protected caller Thread ID is 3434
2019-04-09T15:53:29.332Z,1554825209.332 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2019-04-09T15:53:29.332Z,1554825209.332 [Supervisor](INFO): Looking for Config files in directory: Config/
2019-04-09T15:53:29.334Z,1554825209.334 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2019-04-09T15:53:29.436Z,1554825209.436 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2019-04-09T15:53:29.437Z,1554825209.437 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2019-04-09T15:53:29.728Z,1554825209.728 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2019-04-09T15:53:29.729Z,1554825209.729 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2019-04-09T15:53:29.868Z,1554825209.868 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2019-04-09T15:53:29.869Z,1554825209.869 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2019-04-09T15:53:30.342Z,1554825210.342 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2019-04-09T15:53:30.343Z,1554825210.343 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2019-04-09T15:53:30.795Z,1554825210.795 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2019-04-09T15:53:30.796Z,1554825210.796 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2019-04-09T15:53:31.275Z,1554825211.275 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2019-04-09T15:53:31.275Z,1554825211.275 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2019-04-09T15:53:31.591Z,1554825211.591 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2019-04-09T15:53:31.592Z,1554825211.592 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2019-04-09T15:53:31.933Z,1554825211.933 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2019-04-09T15:53:31.934Z,1554825211.934 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2019-04-09T15:53:32.338Z,1554825212.338 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2019-04-09T15:53:32.339Z,1554825212.339 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2019-04-09T15:53:32.491Z,1554825212.491 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2019-04-09T15:53:32.492Z,1554825212.492 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2019-04-09T15:53:32.598Z,1554825212.598 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2019-04-09T15:53:32.599Z,1554825212.599 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2019-04-09T15:53:32.681Z,1554825212.681 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2019-04-09T15:53:32.783Z,1554825212.783 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2019-04-09T15:53:32.784Z,1554825212.784 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2019-04-09T15:53:32.985Z,1554825212.985 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2019-04-09T15:53:32.986Z,1554825212.986 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2019-04-09T15:53:33.198Z,1554825213.198 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2019-04-09T15:53:33.200Z,1554825213.200 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2019-04-09T15:53:33.201Z,1554825213.201 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2019-04-09T15:53:33.285Z,1554825213.285 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2019-04-09T15:53:33.520Z,1554825213.520 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2019-04-09T15:53:33.521Z,1554825213.521 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2019-04-09T15:53:33.617Z,1554825213.617 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2019-04-09T15:53:33.796Z,1554825213.796 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2019-04-09T15:53:34.016Z,1554825214.016 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2019-04-09T15:53:34.101Z,1554825214.101 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2019-04-09T15:53:34.201Z,1554825214.201 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2019-04-09T15:53:34.296Z,1554825214.296 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2019-04-09T15:53:34.481Z,1554825214.481 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2019-04-09T15:53:34.749Z,1554825214.749 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2019-04-09T15:53:34.917Z,1554825214.917 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2019-04-09T15:53:34.921Z,1554825214.921 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2019-04-09T15:53:35.024Z,1554825215.024 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2019-04-09T15:53:35.024Z,1554825215.024 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2019-04-09T15:53:35.298Z,1554825215.298 [BuoyancyServo] Loaded
2019-04-09T15:53:35.298Z,1554825215.298 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2019-04-09T15:53:35.313Z,1554825215.313 [ElevatorServo] Loaded
2019-04-09T15:53:35.314Z,1554825215.314 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2019-04-09T15:53:35.329Z,1554825215.329 [MassServo] Loaded
2019-04-09T15:53:35.329Z,1554825215.329 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2019-04-09T15:53:35.345Z,1554825215.345 [RudderServo] Loaded
2019-04-09T15:53:35.345Z,1554825215.345 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2019-04-09T15:53:35.371Z,1554825215.371 [ThrusterServo] Loaded
2019-04-09T15:53:35.371Z,1554825215.371 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2019-04-09T15:53:35.371Z,1554825215.371 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2019-04-09T15:53:35.372Z,1554825215.372 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2019-04-09T15:53:35.700Z,1554825215.700 [SBIT](DEBUG): Construct Startup Built In Test.
2019-04-09T15:53:35.729Z,1554825215.729 [SBIT] Loaded
2019-04-09T15:53:35.729Z,1554825215.729 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2019-04-09T15:53:35.730Z,1554825215.730 [IBIT](DEBUG): Construct Initiated Built In Test.
2019-04-09T15:53:35.758Z,1554825215.758 [IBIT] Loaded
2019-04-09T15:53:35.759Z,1554825215.759 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2019-04-09T15:53:35.762Z,1554825215.762 [CBIT](DEBUG): Construct Continuous Built In Test.
2019-04-09T15:53:36.157Z,1554825216.157 [CBIT] Loaded
2019-04-09T15:53:36.157Z,1554825216.157 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2019-04-09T15:53:36.157Z,1554825216.157 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2019-04-09T15:53:36.158Z,1554825216.158 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2019-04-09T15:53:36.341Z,1554825216.341 [Aanderaa_O2] Loaded
2019-04-09T15:53:36.342Z,1554825216.342 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2019-04-09T15:53:36.352Z,1554825216.352 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density
2019-04-09T15:53:36.357Z,1554825216.357 [CTD_Seabird](INFO): created writer for : sea_water_density
2019-04-09T15:53:36.359Z,1554825216.359 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth
2019-04-09T15:53:36.364Z,1554825216.364 [CTD_Seabird](INFO): created writer for : depth
2019-04-09T15:53:36.364Z,1554825216.364 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure
2019-04-09T15:53:36.369Z,1554825216.369 [CTD_Seabird](INFO): created writer for : sea_water_pressure
2019-04-09T15:53:36.370Z,1554825216.370 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity
2019-04-09T15:53:36.375Z,1554825216.375 [CTD_Seabird](INFO): created writer for : sea_water_salinity
2019-04-09T15:53:36.376Z,1554825216.376 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature
2019-04-09T15:53:36.381Z,1554825216.381 [CTD_Seabird](INFO): created writer for : sea_water_temperature
2019-04-09T15:53:36.382Z,1554825216.382 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity
2019-04-09T15:53:36.388Z,1554825216.388 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity
2019-04-09T15:53:36.388Z,1554825216.388 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water
2019-04-09T15:53:36.393Z,1554825216.393 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water
2019-04-09T15:53:36.421Z,1554825216.421 [CTD_Seabird] Loaded
2019-04-09T15:53:36.421Z,1554825216.421 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2019-04-09T15:53:36.422Z,1554825216.422 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406654E0
2019-04-09T15:53:36.422Z,1554825216.422 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 3513
2019-04-09T15:53:36.448Z,1554825216.448 [ESPComponent] Loaded
2019-04-09T15:53:36.449Z,1554825216.449 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2019-04-09T15:53:36.463Z,1554825216.463 [PAR_Licor] Loaded
2019-04-09T15:53:36.464Z,1554825216.464 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2019-04-09T15:53:36.513Z,1554825216.513 [WetLabsBB2FL] Loaded
2019-04-09T15:53:36.513Z,1554825216.513 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2019-04-09T15:53:36.514Z,1554825216.514 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406954E0
2019-04-09T15:53:36.514Z,1554825216.514 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 3514
2019-04-09T15:53:36.515Z,1554825216.515 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2019-04-09T15:53:36.516Z,1554825216.516 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2019-04-09T15:53:36.556Z,1554825216.556 [DepthRateCalculator] Loaded
2019-04-09T15:53:36.556Z,1554825216.556 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2019-04-09T15:53:36.562Z,1554825216.562 [PitchRateCalculator] Loaded
2019-04-09T15:53:36.562Z,1554825216.562 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2019-04-09T15:53:36.579Z,1554825216.579 [SpeedCalculator] Loaded
2019-04-09T15:53:36.579Z,1554825216.579 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2019-04-09T15:53:36.601Z,1554825216.601 [TempGradientCalculator] Loaded
2019-04-09T15:53:36.601Z,1554825216.601 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2019-04-09T15:53:36.607Z,1554825216.607 [YawRateCalculator] Loaded
2019-04-09T15:53:36.607Z,1554825216.607 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2019-04-09T15:53:36.641Z,1554825216.641 [ElevatorOffsetCalculator] Loaded
2019-04-09T15:53:36.641Z,1554825216.641 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2019-04-09T15:53:36.642Z,1554825216.642 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2019-04-09T15:53:36.642Z,1554825216.642 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2019-04-09T15:53:36.670Z,1554825216.670 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2019-04-09T15:53:36.670Z,1554825216.670 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2019-04-09T15:53:36.774Z,1554825216.774 [DeadReckonUsingMultipleVelocitySources] Loaded
2019-04-09T15:53:36.774Z,1554825216.774 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2019-04-09T15:53:36.835Z,1554825216.835 [DeadReckonUsingSpeedCalculator] Loaded
2019-04-09T15:53:36.835Z,1554825216.835 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2019-04-09T15:53:36.896Z,1554825216.896 [DeadReckonWithRespectToSeafloor] Loaded
2019-04-09T15:53:36.897Z,1554825216.897 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2019-04-09T15:53:36.918Z,1554825216.918 [NavChart] Loaded
2019-04-09T15:53:36.918Z,1554825216.918 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2019-04-09T15:53:36.922Z,1554825216.922 [UniversalFixResidualReporter] Loaded
2019-04-09T15:53:36.923Z,1554825216.923 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2019-04-09T15:53:36.923Z,1554825216.923 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2019-04-09T15:53:36.924Z,1554825216.924 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2019-04-09T15:53:37.235Z,1554825217.235 [AcousticModem_Benthos_ATM900] Loaded
2019-04-09T15:53:37.236Z,1554825217.236 [ComponentRegistry](DEBUG): SyncComponent "AcousticModem_Benthos_ATM900" handled in the control thread.
2019-04-09T15:53:37.310Z,1554825217.310 [DataOverHttps] Loaded
2019-04-09T15:53:37.310Z,1554825217.310 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2019-04-09T15:53:37.311Z,1554825217.311 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409714E0
2019-04-09T15:53:37.312Z,1554825217.312 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 3515
2019-04-09T15:53:37.325Z,1554825217.325 [Depth_Keller] Loaded
2019-04-09T15:53:37.325Z,1554825217.325 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2019-04-09T15:53:37.419Z,1554825217.419 [NAL9602] Loaded
2019-04-09T15:53:37.419Z,1554825217.419 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2019-04-09T15:53:37.424Z,1554825217.424 [Onboard] Loaded
2019-04-09T15:53:37.424Z,1554825217.424 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2019-04-09T15:53:37.428Z,1554825217.428 [Radio_Surface] Loaded
2019-04-09T15:53:37.428Z,1554825217.428 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2019-04-09T15:53:37.429Z,1554825217.429 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409A14E0
2019-04-09T15:53:37.430Z,1554825217.430 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 3516
2019-04-09T15:53:38.733Z,1554825218.733 [BPC1] Loaded
2019-04-09T15:53:38.734Z,1554825218.734 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2019-04-09T15:53:38.765Z,1554825218.765 [BR_Ping1D](CRITICAL): No configuration setting for: BR_Ping1D.minrange
2019-04-09T15:53:38.767Z,1554825218.767 [BR_Ping1D](CRITICAL): No configuration setting for: BR_Ping1D.maxrange
2019-04-09T15:53:38.769Z,1554825218.769 [BR_Ping1D](CRITICAL): No configuration setting for: BR_Ping1D.soundspeed
2019-04-09T15:53:38.771Z,1554825218.771 [BR_Ping1D](CRITICAL): No configuration setting for: BR_Ping1D.automode
2019-04-09T15:53:38.773Z,1554825218.773 [BR_Ping1D](CRITICAL): No configuration setting for: BR_Ping1D.gainindex
2019-04-09T15:53:38.775Z,1554825218.775 [BR_Ping1D](CRITICAL): No configuration setting for: BR_Ping1D.minconfidence
2019-04-09T15:53:38.777Z,1554825218.777 [BR_Ping1D](CRITICAL): No configuration setting for: BR_Ping1D.pingenable
2019-04-09T15:53:38.780Z,1554825218.780 [BR_Ping1D] Loaded
2019-04-09T15:53:38.780Z,1554825218.780 [ComponentRegistry](DEBUG): SyncComponent "BR_Ping1D" handled in the control thread.
2019-04-09T15:53:38.780Z,1554825218.780 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2019-04-09T15:53:38.781Z,1554825218.781 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2019-04-09T15:53:38.845Z,1554825218.845 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2019-04-09T15:53:38.846Z,1554825218.846 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2019-04-09T15:53:38.912Z,1554825218.912 [VerticalControl](DEBUG): Construct VerticalControl.
2019-04-09T15:53:38.998Z,1554825218.998 [VerticalControl] Loaded
2019-04-09T15:53:38.999Z,1554825218.999 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2019-04-09T15:53:38.999Z,1554825218.999 [HorizontalControl](DEBUG): Construct HorizontalControl.
2019-04-09T15:53:39.058Z,1554825219.058 [HorizontalControl] Loaded
2019-04-09T15:53:39.059Z,1554825219.059 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2019-04-09T15:53:39.059Z,1554825219.059 [SpeedControl](DEBUG): Construct SpeedControl.
2019-04-09T15:53:39.061Z,1554825219.061 [SpeedControl] Loaded
2019-04-09T15:53:39.061Z,1554825219.061 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2019-04-09T15:53:39.062Z,1554825219.062 [LoopControl](DEBUG): Construct LoopControl.
2019-04-09T15:53:39.063Z,1554825219.063 [LoopControl] Loaded
2019-04-09T15:53:39.063Z,1554825219.063 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2019-04-09T15:53:39.063Z,1554825219.063 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2019-04-09T15:53:39.064Z,1554825219.064 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2019-04-09T15:53:39.077Z,1554825219.077 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2019-04-09T15:53:39.078Z,1554825219.078 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2019-04-09T15:53:39.355Z,1554825219.355 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2019-04-09T15:53:39.359Z,1554825219.359 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2019-04-09T15:53:39.360Z,1554825219.360 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2019-04-09T15:53:39.367Z,1554825219.367 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2019-04-09T15:53:39.368Z,1554825219.368 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40ACE4E0
2019-04-09T15:53:39.368Z,1554825219.368 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 3517
2019-04-09T15:53:39.373Z,1554825219.373 [Supervisor](INFO): Main Thread ID is 4347
2019-04-09T15:53:39.373Z,1554825219.373 [Supervisor](DEBUG): Running supervisor.
2019-04-09T15:53:39.374Z,1554825219.374 [CommandLine ThreadHandler](INFO): Handler Thread ID is 3518
2019-04-09T15:53:39.376Z,1554825219.376 [controlThread ThreadHandler](INFO): Handler Thread ID is 3519
2019-04-09T15:53:39.376Z,1554825219.376 [controlThread](DEBUG): Initializing ControlThread
2019-04-09T15:53:39.378Z,1554825219.378 [SBIT](INFO): Initialize SBIT Component.
2019-04-09T15:53:39.379Z,1554825219.379 [SBIT](IMPORTANT): git: 2019-03-18-31-ge98d5dc
2019-04-09T15:53:39.379Z,1554825219.379 [SBIT](INFO): git hash: e98d5dc50cbc39e402f19b9946ff4dc0776c8725
2019-04-09T15:53:39.379Z,1554825219.379 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2019-04-09T15:53:39.381Z,1554825219.381 [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-09T15:53:39.382Z,1554825219.382 [SBIT](INFO): Beginning SBIT in 24.000000 seconds.
2019-04-09T15:53:39.382Z,1554825219.382 [IBIT](INFO): Initialize IBIT Component.
2019-04-09T15:53:39.383Z,1554825219.383 [CBIT](DEBUG): Initialize CBIT Component.
2019-04-09T15:53:39.384Z,1554825219.384 [logger ThreadHandler](INFO): Handler Thread ID is 3520
2019-04-09T15:53:39.394Z,1554825219.394 [CBIT](DEBUG): Initialized mux pins.
2019-04-09T15:53:39.394Z,1554825219.394 [CBIT](DEBUG): Initializing the watchdog timer.
2019-04-09T15:53:39.402Z,1554825219.402 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 3521
2019-04-09T15:53:39.403Z,1554825219.403 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-04-09T15:53:39.407Z,1554825219.407 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-04-09T15:53:39.408Z,1554825219.408 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 3523
2019-04-09T15:53:39.409Z,1554825219.409 [WetLabsBB2FL](INFO): Powering down
2019-04-09T15:53:39.418Z,1554825219.418 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2019-04-09T15:53:39.418Z,1554825219.418 [CBIT](DEBUG): Initializing heartbeat.
2019-04-09T15:53:39.438Z,1554825219.438 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 3524
2019-04-09T15:53:39.439Z,1554825219.439 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2019-04-09T15:53:39.447Z,1554825219.447 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 3525
2019-04-09T15:53:39.466Z,1554825219.466 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 3526
2019-04-09T15:53:39.469Z,1554825219.469 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2019-04-09T15:53:39.470Z,1554825219.470 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2019-04-09T15:53:39.470Z,1554825219.470 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2019-04-09T15:53:39.470Z,1554825219.470 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2019-04-09T15:53:39.470Z,1554825219.470 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2019-04-09T15:53:39.470Z,1554825219.470 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2019-04-09T15:53:39.471Z,1554825219.471 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2019-04-09T15:53:39.471Z,1554825219.471 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2019-04-09T15:53:39.471Z,1554825219.471 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2019-04-09T15:53:39.471Z,1554825219.471 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2019-04-09T15:53:39.471Z,1554825219.471 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2019-04-09T15:53:39.471Z,1554825219.471 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2019-04-09T15:53:39.472Z,1554825219.472 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2019-04-09T15:53:39.472Z,1554825219.472 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2019-04-09T15:53:39.472Z,1554825219.472 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2019-04-09T15:53:39.472Z,1554825219.472 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2019-04-09T15:53:39.490Z,1554825219.490 [CBIT](DEBUG): Deactivating GF circuits.
2019-04-09T15:53:39.490Z,1554825219.490 [CBIT](DEBUG): Deactivating emergency mode.
2019-04-09T15:53:39.526Z,1554825219.526 [CBIT](DEBUG): Backplane powered.
2019-04-09T15:53:39.530Z,1554825219.530 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2019-04-09T15:53:39.531Z,1554825219.531 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2019-04-09T15:53:39.531Z,1554825219.531 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2019-04-09T15:53:39.531Z,1554825219.531 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2019-04-09T15:53:39.532Z,1554825219.532 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2019-04-09T15:53:39.532Z,1554825219.532 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2019-04-09T15:53:39.533Z,1554825219.533 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-04-09T15:53:39.534Z,1554825219.534 [NavChart](DEBUG): Initialize NavChart Navigation.
2019-04-09T15:53:39.535Z,1554825219.535 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2019-04-09T15:53:39.539Z,1554825219.539 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2019-04-09T15:53:39.541Z,1554825219.541 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2019-04-09T15:53:39.542Z,1554825219.542 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2019-04-09T15:53:39.542Z,1554825219.542 [LoopControl](DEBUG): Initialize LoopControlComponent.
2019-04-09T15:53:39.543Z,1554825219.543 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2019-04-09T15:53:39.578Z,1554825219.578 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2019-04-09T15:53:39.601Z,1554825219.601 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="StartupSatComms">

        <Sequence/>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:latitude_fix/>
        </ReadDatum>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:platform_communications/>
        </ReadDatum>

    </Aggregate>

</Mission>


2019-04-09T15:53:39.606Z,1554825219.606 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2019-04-09T15:53:39.649Z,1554825219.649 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2019-04-09T15:53:39.650Z,1554825219.650 [Default:A.Wait](DEBUG): Construct Wait.
2019-04-09T15:53:39.652Z,1554825219.652 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2019-04-09T15:53:39.683Z,1554825219.683 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2019-04-09T15:53:39.706Z,1554825219.706 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2019-04-09T15:53:39.724Z,1554825219.724 [Default:E.Execute](DEBUG): Construct Execute.
2019-04-09T15:53:39.756Z,1554825219.756 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="Default">

    <DefineArg Name="ElapsedSinceDefaultStarted"><Units:minute/><Value>0</Value></DefineArg>

    <Guidance:Wait>
        <Description>
            Wait a moment to see if the scheduler starts a new mission before
            starting to actually run Default.
        </Description>
        <Sequence/>
        <Setting><Guidance:Wait.duration/><Units:second/><Value>13</Value></Setting>
    </Guidance:Wait>

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

        <ReadDatum Id="Read_GPS">
            <Timeout Duration="P5M"/>
            <Universal:time_fix/>
        </ReadDatum>

        <ReadDatum Id="Read_Iridium">
            <Timeout Duration="P2H">
                <Guidance:Execute>
                    <Sequence/>
                    <Setting><Guidance:Execute.command/><String>Burn on</String></Setting>
                </Guidance:Execute>
                <Syslog Severity="Critical">Dropped weight due to communications timeout.</Syslog>
            </Timeout>
            <Universal:platform_communications/>
        </ReadDatum>

        <Guidance:Wait>
            <Sequence/>
            <Setting><Guidance:Wait.duration/><Units:minute/><Value>5</Value></Setting>
        </Guidance:Wait>

        <Assign><Sequence/><Arg Name="ElapsedSinceDefaultStarted"/><Elapsed><Universal:mission_started/></Elapsed></Assign>

        <Syslog Severity="Important">Default mission has been running for <Arg Name="ElapsedSinceDefaultStarted"/><Units:minute/></Syslog>

    </Aggregate>

    <Syslog Severity="Important">Restarting logs and Default mission.</Syslog>

    <Guidance:Execute>
        <Sequence/>
        <Setting><Guidance:Execute.command/><String>restart logs</String></Setting>
    </Guidance:Execute>

</Mission>


2019-04-09T15:53:39.766Z,1554825219.766 [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-09T15:53:39.783Z,1554825219.783 [ESPComponent](INFO): powering down ESP
2019-04-09T15:53:39.890Z,1554825219.890 [Radio_Surface](INFO): Powering up
2019-04-09T15:53:40.194Z,1554825220.194 [PAR_Licor](INFO): A/D timeout, 7 tries over 128 ms

2019-04-09T15:53:40.195Z,1554825220.195 [PAR_Licor] Data Fault, FailCount= 1
2019-04-09T15:53:40.195Z,1554825220.195 [PAR_Licor](ERROR): Data Fault
2019-04-09T15:53:40.195Z,1554825220.195 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-04-09T15:53:40.196Z,1554825220.196 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-04-09T15:53:40.436Z,1554825220.436 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-04-09T15:53:40.442Z,1554825220.442 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-04-09T15:53:40.444Z,1554825220.444 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-04-09T15:53:40.450Z,1554825220.450 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-04-09T15:53:40.451Z,1554825220.451 [MassServo](DEBUG): Initializing EZServoServo.
2019-04-09T15:53:40.458Z,1554825220.458 [MassServo](DEBUG): Initializing MassServo.
2019-04-09T15:53:40.459Z,1554825220.459 [RudderServo](DEBUG): Initializing EZServoServo.
2019-04-09T15:53:40.466Z,1554825220.466 [RudderServo](DEBUG): Initializing RudderServo.
2019-04-09T15:53:40.467Z,1554825220.467 [ThrusterServo](DEBUG): Initializing EZServoServo.
2019-04-09T15:53:40.474Z,1554825220.474 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2019-04-09T15:53:40.477Z,1554825220.477 [CommandLine](FAULT): Scheduling is paused
2019-04-09T15:53:40.477Z,1554825220.477 [CBIT](INFO): Critical error at 20190409T155338
2019-04-09T15:53:40.478Z,1554825220.478 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2019-04-09T15:53:40.479Z,1554825220.479 [CBIT](FAULT): Main Battery Failure. Count: 1
2019-04-09T15:53:40.482Z,1554825220.482 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-04-09T15:53:40.482Z,1554825220.482 [CBIT](INFO): Clearing failed state for component PAR_Licor
2019-04-09T15:53:40.482Z,1554825220.482 [PAR_Licor] No Fault, FailCount= 1
2019-04-09T15:53:41.034Z,1554825221.034 [PAR_Licor](INFO): A/D timeout, 9 tries over 142 ms

2019-04-09T15:53:41.034Z,1554825221.034 [PAR_Licor] Data Fault, FailCount= 2
2019-04-09T15:53:41.034Z,1554825221.034 [PAR_Licor](ERROR): Data Fault
2019-04-09T15:53:41.070Z,1554825221.070 [BR_Ping1D](INFO): startup: 0
2019-04-09T15:53:41.070Z,1554825221.070 [BR_Ping1D](INFO): UART setting parameters ...
2019-04-09T15:53:41.082Z,1554825221.082 [BR_Ping1D](INFO): sending request for Ping Interval: 500
2019-04-09T15:53:41.095Z,1554825221.095 [BR_Ping1D](CRITICAL): SIGSEGV: address not mapped to object
2019-04-09T15:53:41.095Z,1554825221.095 [BR_Ping1D](CRITICAL): Bad address: 0x1F4
2019-04-09T15:53:41.095Z,1554825221.095 [BR_Ping1D](CRITICAL): Backtrace: 
./bin/LRAUV(_ZN7PCaller20DefaultSignalHandlerEiP7siginfoPv+0x20) [0x179208]
Modules/Sensor.so(_ZN9BR_Ping1D8startingEv+0x278) [0x40795578]
./bin/LRAUV(_ZN9Component7executeEv+0x31c) [0xd6b4c]
./bin/LRAUV(_ZN7PCaller10PThreadRunEPv+0xbc) [0x178da4]

2019-04-09T15:53:41.095Z,1554825221.095 [BR_Ping1D] Software Fault, FailCount= 1
2019-04-09T15:53:41.095Z,1554825221.095 [BR_Ping1D](ERROR): Software Fault
2019-04-09T15:53:41.106Z,1554825221.106 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-04-09T15:53:41.106Z,1554825221.106 [SyncHandler](INFO): Protected caller Thread ID is 3536
2019-04-09T15:53:41.435Z,1554825221.435 [CBIT](INFO): Critical error at 20190409T155341
2019-04-09T15:53:41.438Z,1554825221.438 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-04-09T15:53:41.438Z,1554825221.438 [CBIT](INFO): Clearing failed state for component PAR_Licor
2019-04-09T15:53:41.438Z,1554825221.438 [PAR_Licor] No Fault, FailCount= 2
2019-04-09T15:53:41.439Z,1554825221.439 [CBIT](ERROR): Software Fault in component: BR_Ping1D
2019-04-09T15:53:41.478Z,1554825221.478 [BR_Ping1D](INFO): Stop
2019-04-09T15:53:41.478Z,1554825221.478 [BR_Ping1D](INFO): uninitialize
2019-04-09T15:53:41.478Z,1554825221.478 [BR_Ping1D](INFO): Powering down
2019-04-09T15:53:41.870Z,1554825221.870 [BR_Ping1D](INFO): Stopping
2019-04-09T15:53:42.382Z,1554825222.382 [PAR_Licor](INFO): A/D timeout, 9 tries over 130 ms

2019-04-09T15:53:42.382Z,1554825222.382 [PAR_Licor] Data Fault, FailCount= 1
2019-04-09T15:53:42.382Z,1554825222.382 [PAR_Licor](ERROR): Data Fault
2019-04-09T15:53:42.416Z,1554825222.416 [BR_Ping1D](INFO): Stopping
2019-04-09T15:53:42.454Z,1554825222.454 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-04-09T15:53:42.454Z,1554825222.454 [CBIT](INFO): Clearing failed state for component PAR_Licor
2019-04-09T15:53:42.455Z,1554825222.455 [PAR_Licor] No Fault, FailCount= 1
2019-04-09T15:53:42.678Z,1554825222.678 [BR_Ping1D](INFO): Stopped
2019-04-09T15:53:42.778Z,1554825222.778 [CBIT](INFO): Clearing failed state for component BR_Ping1D
2019-04-09T15:53:42.778Z,1554825222.778 [BR_Ping1D] No Fault, FailCount= 1
2019-04-09T15:53:43.194Z,1554825223.194 [PAR_Licor](INFO): A/D timeout, 8 tries over 134 ms

2019-04-09T15:53:43.194Z,1554825223.194 [PAR_Licor] Data Fault, FailCount= 2
2019-04-09T15:53:43.194Z,1554825223.194 [PAR_Licor](ERROR): Data Fault
2019-04-09T15:53:43.215Z,1554825223.215 [BR_Ping1D](INFO): Start
2019-04-09T15:53:43.562Z,1554825223.562 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout
2019-04-09T15:53:43.562Z,1554825223.562 [MassServo] Communications Fault, FailCount= 1
2019-04-09T15:53:43.562Z,1554825223.562 [MassServo](ERROR): Communications Fault
2019-04-09T15:53:43.566Z,1554825223.566 [CBIT](ERROR): Communications Fault in component: MassServo
2019-04-09T15:53:43.567Z,1554825223.567 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-04-09T15:53:43.567Z,1554825223.567 [CBIT](INFO): Clearing failed state for component PAR_Licor
2019-04-09T15:53:43.567Z,1554825223.567 [PAR_Licor] No Fault, FailCount= 2
2019-04-09T15:53:43.610Z,1554825223.610 [BR_Ping1D](INFO): Starting
2019-04-09T15:53:43.706Z,1554825223.706 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-04-09T15:53:43.706Z,1554825223.706 [MassServo](INFO): Powering down
2019-04-09T15:53:43.998Z,1554825223.998 [BR_Ping1D](INFO): Starting
2019-04-09T15:53:43.998Z,1554825223.998 [BR_Ping1D](INFO): readConfig
2019-04-09T15:53:43.999Z,1554825223.999 [BR_Ping1D](INFO): startup: 0
2019-04-09T15:53:43.999Z,1554825223.999 [BR_Ping1D](INFO): UART setting parameters ...
2019-04-09T15:53:44.010Z,1554825224.010 [BR_Ping1D](INFO): sending request for Ping Interval: 500
2019-04-09T15:53:44.022Z,1554825224.022 [BR_Ping1D](CRITICAL): SIGSEGV: address not mapped to object
2019-04-09T15:53:44.022Z,1554825224.022 [BR_Ping1D](CRITICAL): Bad address: 0x1F4
2019-04-09T15:53:44.023Z,1554825224.023 [BR_Ping1D](CRITICAL): Backtrace: 
./bin/LRAUV(_ZN7PCaller20DefaultSignalHandlerEiP7siginfoPv+0x20) [0x179208]
Modules/Sensor.so(_ZN9BR_Ping1D8startingEv+0x278) [0x40795578]
./bin/LRAUV(_ZN9Component7executeEv+0x31c) [0xd6b4c]
./bin/LRAUV(_ZN7PCaller10PThreadRunEPv+0xbc) [0x178da4]

2019-04-09T15:53:44.023Z,1554825224.023 [BR_Ping1D] Software Fault, FailCount= 2
2019-04-09T15:53:44.023Z,1554825224.023 [BR_Ping1D](ERROR): Software Fault
2019-04-09T15:53:44.024Z,1554825224.024 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-04-09T15:53:44.024Z,1554825224.024 [SyncHandler](INFO): Protected caller Thread ID is 3538
2019-04-09T15:53:44.360Z,1554825224.360 [CBIT](INFO): Critical error at 20190409T155344
2019-04-09T15:53:44.363Z,1554825224.363 [CBIT](ERROR): Software Fault in component: BR_Ping1D
2019-04-09T15:53:44.526Z,1554825224.526 [PAR_Licor](INFO): A/D timeout, 8 tries over 146 ms

2019-04-09T15:53:44.526Z,1554825224.526 [PAR_Licor] Data Fault, FailCount= 1
2019-04-09T15:53:44.526Z,1554825224.526 [PAR_Licor](ERROR): Data Fault
2019-04-09T15:53:44.561Z,1554825224.561 [BR_Ping1D](INFO): Stop
2019-04-09T15:53:44.561Z,1554825224.561 [BR_Ping1D](INFO): uninitialize
2019-04-09T15:53:44.561Z,1554825224.561 [BR_Ping1D](INFO): Powering down
2019-04-09T15:53:44.732Z,1554825224.732 [MassServo](DEBUG): Initializing EZServoServo.
2019-04-09T15:53:44.851Z,1554825224.851 [MassServo](DEBUG): Initializing MassServo.
2019-04-09T15:53:44.853Z,1554825224.853 [CBIT](FAULT): Main Battery Failure. Count: 11
2019-04-09T15:53:44.856Z,1554825224.856 [CBIT](INFO): Clearing failed state for component MassServo
2019-04-09T15:53:44.856Z,1554825224.856 [MassServo] No Fault, FailCount= 1
2019-04-09T15:53:44.856Z,1554825224.856 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-04-09T15:53:44.856Z,1554825224.856 [CBIT](INFO): Clearing failed state for component PAR_Licor
2019-04-09T15:53:44.856Z,1554825224.856 [PAR_Licor] No Fault, FailCount= 1
2019-04-09T15:53:44.890Z,1554825224.890 [BR_Ping1D](INFO): Stopping
2019-04-09T15:53:45.406Z,1554825225.406 [PAR_Licor](INFO): A/D timeout, 9 tries over 142 ms

2019-04-09T15:53:45.406Z,1554825225.406 [PAR_Licor] Data Fault, FailCount= 2
2019-04-09T15:53:45.406Z,1554825225.406 [PAR_Licor](ERROR): Data Fault
2019-04-09T15:53:45.441Z,1554825225.441 [BR_Ping1D](INFO): Stopping
2019-04-09T15:53:45.476Z,1554825225.476 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-04-09T15:53:45.477Z,1554825225.477 [CBIT](INFO): Clearing failed state for component PAR_Licor
2019-04-09T15:53:45.477Z,1554825225.477 [PAR_Licor] No Fault, FailCount= 2
2019-04-09T15:53:45.690Z,1554825225.690 [BR_Ping1D](INFO): Stopped
2019-04-09T15:53:45.774Z,1554825225.774 [CBIT](INFO): Clearing failed state for component BR_Ping1D
2019-04-09T15:53:45.774Z,1554825225.774 [BR_Ping1D] No Fault, FailCount= 2
2019-04-09T15:53:46.214Z,1554825226.214 [PAR_Licor](INFO): A/D timeout, 9 tries over 142 ms

2019-04-09T15:53:46.214Z,1554825226.214 [PAR_Licor] Data Fault, FailCount= 3
2019-04-09T15:53:46.214Z,1554825226.214 [PAR_Licor](ERROR): Data Fault
2019-04-09T15:53:46.249Z,1554825226.249 [BR_Ping1D](INFO): Start
2019-04-09T15:53:46.303Z,1554825226.303 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-04-09T15:53:46.303Z,1554825226.303 [CBIT](CRITICAL): Data Fault in component: PAR_Licor
2019-04-09T15:53:46.494Z,1554825226.494 [BR_Ping1D](INFO): Starting
2019-04-09T15:53:46.708Z,1554825226.708 [CBIT](INFO): Critical error at 20190409T155346
2019-04-09T15:53:46.898Z,1554825226.898 [BR_Ping1D](INFO): Starting
2019-04-09T15:53:46.898Z,1554825226.898 [BR_Ping1D](INFO): readConfig
2019-04-09T15:53:46.898Z,1554825226.898 [BR_Ping1D](INFO): startup: 0
2019-04-09T15:53:46.898Z,1554825226.898 [BR_Ping1D](INFO): UART setting parameters ...
2019-04-09T15:53:46.910Z,1554825226.910 [BR_Ping1D](INFO): sending request for Ping Interval: 500
2019-04-09T15:53:46.922Z,1554825226.922 [BR_Ping1D](CRITICAL): SIGSEGV: address not mapped to object
2019-04-09T15:53:46.923Z,1554825226.923 [BR_Ping1D](CRITICAL): Bad address: 0x1F4
2019-04-09T15:53:46.923Z,1554825226.923 [BR_Ping1D](CRITICAL): Backtrace: 
./bin/LRAUV(_ZN7PCaller20DefaultSignalHandlerEiP7siginfoPv+0x20) [0x179208]
Modules/Sensor.so(_ZN9BR_Ping1D8startingEv+0x278) [0x40795578]
./bin/LRAUV(_ZN9Component7executeEv+0x31c) [0xd6b4c]
./bin/LRAUV(_ZN7PCaller10PThreadRunEPv+0xbc) [0x178da4]

2019-04-09T15:53:46.923Z,1554825226.923 [BR_Ping1D] Software Fault, FailCount= 3
2019-04-09T15:53:46.923Z,1554825226.923 [BR_Ping1D](ERROR): Software Fault
2019-04-09T15:53:46.924Z,1554825226.924 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-04-09T15:53:46.925Z,1554825226.925 [SyncHandler](INFO): Protected caller Thread ID is 3541
2019-04-09T15:53:47.250Z,1554825227.250 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout
2019-04-09T15:53:47.250Z,1554825227.250 [MassServo] Communications Fault, FailCount= 2
2019-04-09T15:53:47.250Z,1554825227.250 [MassServo](ERROR): Communications Fault
2019-04-09T15:53:47.252Z,1554825227.252 [CBIT](INFO): Critical error at 20190409T155346
2019-04-09T15:53:47.255Z,1554825227.255 [CBIT](ERROR): Communications Fault in component: MassServo
2019-04-09T15:53:47.255Z,1554825227.255 [CBIT](ERROR): Software Fault in component: BR_Ping1D
2019-04-09T15:53:47.299Z,1554825227.299 [BR_Ping1D](INFO): Stop
2019-04-09T15:53:47.299Z,1554825227.299 [BR_Ping1D](INFO): uninitialize
2019-04-09T15:53:47.299Z,1554825227.299 [BR_Ping1D](INFO): Powering down
2019-04-09T15:53:47.383Z,1554825227.383 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-04-09T15:53:47.383Z,1554825227.383 [MassServo](INFO): Powering down
2019-04-09T15:53:47.705Z,1554825227.705 [BR_Ping1D](INFO): Stopping
2019-04-09T15:53:48.110Z,1554825228.110 [BR_Ping1D](INFO): Stopping
2019-04-09T15:53:48.139Z,1554825228.139 [MassServo](DEBUG): Initializing EZServoServo.
2019-04-09T15:53:48.259Z,1554825228.259 [MassServo](DEBUG): Initializing MassServo.
2019-04-09T15:53:48.263Z,1554825228.263 [CBIT](INFO): Clearing failed state for component MassServo
2019-04-09T15:53:48.263Z,1554825228.263 [MassServo] No Fault, FailCount= 2
2019-04-09T15:53:48.513Z,1554825228.513 [BR_Ping1D](INFO): Stopped
2019-04-09T15:53:48.524Z,1554825228.524 [CBIT](FAULT): Main Battery Failure. Count: 21
2019-04-09T15:53:48.527Z,1554825228.527 [CBIT](INFO): Clearing failed state for component BR_Ping1D
2019-04-09T15:53:48.527Z,1554825228.527 [BR_Ping1D] No Fault, FailCount= 3
2019-04-09T15:53:48.918Z,1554825228.918 [BR_Ping1D](INFO): Start
2019-04-09T15:53:49.322Z,1554825229.322 [BR_Ping1D](INFO): Starting
2019-04-09T15:53:49.726Z,1554825229.726 [BR_Ping1D](INFO): Starting
2019-04-09T15:53:49.726Z,1554825229.726 [BR_Ping1D](INFO): readConfig
2019-04-09T15:53:49.727Z,1554825229.727 [BR_Ping1D](INFO): startup: 0
2019-04-09T15:53:49.727Z,1554825229.727 [BR_Ping1D](INFO): UART setting parameters ...
2019-04-09T15:53:49.738Z,1554825229.738 [BR_Ping1D](INFO): sending request for Ping Interval: 500
2019-04-09T15:53:49.746Z,1554825229.746 [BR_Ping1D](CRITICAL): SIGSEGV: address not mapped to object
2019-04-09T15:53:49.747Z,1554825229.747 [BR_Ping1D](CRITICAL): Bad address: 0x1F4
2019-04-09T15:53:49.747Z,1554825229.747 [BR_Ping1D](CRITICAL): Backtrace: 
./bin/LRAUV(_ZN7PCaller20DefaultSignalHandlerEiP7siginfoPv+0x20) [0x179208]
Modules/Sensor.so(_ZN9BR_Ping1D8startingEv+0x278) [0x40795578]
./bin/LRAUV(_ZN9Component7executeEv+0x31c) [0xd6b4c]
./bin/LRAUV(_ZN7PCaller10PThreadRunEPv+0xbc) [0x178da4]

2019-04-09T15:53:49.747Z,1554825229.747 [BR_Ping1D] Software Fault, FailCount= 4
2019-04-09T15:53:49.747Z,1554825229.747 [BR_Ping1D](ERROR): Software Fault
2019-04-09T15:53:49.749Z,1554825229.749 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-04-09T15:53:49.749Z,1554825229.749 [SyncHandler](INFO): Protected caller Thread ID is 3544
2019-04-09T15:53:49.775Z,1554825229.775 [CBIT](INFO): Critical error at 20190409T155349
2019-04-09T15:53:49.778Z,1554825229.778 [CBIT](CRITICAL): Environmental Failure. Press:14.879421 PSI. Humidity:35%. Temp:26 C. ABORTING MISSION
2019-04-09T15:53:49.779Z,1554825229.779 [CBIT](ERROR): Software Fault in component: BR_Ping1D
2019-04-09T15:53:50.110Z,1554825230.110 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-04-09T15:53:50.110Z,1554825230.110 [Aanderaa_O2] Communications Fault, FailCount= 1
2019-04-09T15:53:50.111Z,1554825230.111 [Aanderaa_O2](ERROR): Communications Fault
2019-04-09T15:53:50.129Z,1554825230.129 [BR_Ping1D](INFO): Stop
2019-04-09T15:53:50.129Z,1554825230.129 [BR_Ping1D](INFO): uninitialize
2019-04-09T15:53:50.129Z,1554825230.129 [BR_Ping1D](INFO): Powering down
2019-04-09T15:53:50.225Z,1554825230.225 [CBIT](INFO): Critical error at 20190409T155349
2019-04-09T15:53:50.227Z,1554825230.227 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-04-09T15:53:50.634Z,1554825230.634 [Aanderaa_O2](INFO): Powering down
2019-04-09T15:53:50.723Z,1554825230.723 [BR_Ping1D](INFO): Stopping
2019-04-09T15:53:51.062Z,1554825231.062 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout
2019-04-09T15:53:51.062Z,1554825231.062 [MassServo] Communications Fault, FailCount= 3
2019-04-09T15:53:51.062Z,1554825231.062 [MassServo](ERROR): Communications Fault
2019-04-09T15:53:51.066Z,1554825231.066 [CBIT](ERROR): Communications Fault in component: MassServo
2019-04-09T15:53:51.094Z,1554825231.094 [BR_Ping1D](INFO): Stopped
2019-04-09T15:53:51.139Z,1554825231.139 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-04-09T15:53:51.139Z,1554825231.139 [MassServo](INFO): Powering down
2019-04-09T15:53:51.144Z,1554825231.144 [CBIT](INFO): Clearing failed state for component BR_Ping1D
2019-04-09T15:53:51.144Z,1554825231.144 [BR_Ping1D] No Fault, FailCount= 4
2019-04-09T15:53:51.494Z,1554825231.494 [BR_Ping1D](INFO): Start
2019-04-09T15:53:51.547Z,1554825231.547 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-04-09T15:53:51.547Z,1554825231.547 [Aanderaa_O2] No Fault, FailCount= 1
2019-04-09T15:53:51.898Z,1554825231.898 [BR_Ping1D](INFO): Starting
2019-04-09T15:53:51.911Z,1554825231.911 [MassServo](DEBUG): Initializing EZServoServo.
2019-04-09T15:53:52.031Z,1554825232.031 [MassServo](DEBUG): Initializing MassServo.
2019-04-09T15:53:52.035Z,1554825232.035 [CBIT](INFO): Clearing failed state for component MassServo
2019-04-09T15:53:52.035Z,1554825232.035 [MassServo] No Fault, FailCount= 3
2019-04-09T15:53:52.314Z,1554825232.314 [BR_Ping1D](INFO): Starting
2019-04-09T15:53:52.314Z,1554825232.314 [BR_Ping1D](INFO): readConfig
2019-04-09T15:53:52.314Z,1554825232.314 [BR_Ping1D](INFO): startup: 0
2019-04-09T15:53:52.314Z,1554825232.314 [BR_Ping1D](INFO): UART setting parameters ...
2019-04-09T15:53:52.326Z,1554825232.326 [BR_Ping1D](INFO): sending request for Ping Interval: 500
2019-04-09T15:53:52.338Z,1554825232.338 [BR_Ping1D](CRITICAL): SIGSEGV: address not mapped to object
2019-04-09T15:53:52.338Z,1554825232.338 [BR_Ping1D](CRITICAL): Bad address: 0x1F4
2019-04-09T15:53:52.339Z,1554825232.339 [BR_Ping1D](CRITICAL): Backtrace: 
./bin/LRAUV(_ZN7PCaller20DefaultSignalHandlerEiP7siginfoPv+0x20) [0x179208]
Modules/Sensor.so(_ZN9BR_Ping1D8startingEv+0x278) [0x40795578]
./bin/LRAUV(_ZN9Component7executeEv+0x31c) [0xd6b4c]
./bin/LRAUV(_ZN7PCaller10PThreadRunEPv+0xbc) [0x178da4]

2019-04-09T15:53:52.339Z,1554825232.339 [BR_Ping1D] Software Fault, FailCount= 5
2019-04-09T15:53:52.339Z,1554825232.339 [BR_Ping1D](ERROR): Software Fault
2019-04-09T15:53:52.346Z,1554825232.346 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-04-09T15:53:52.346Z,1554825232.346 [SyncHandler](INFO): Protected caller Thread ID is 3548
2019-04-09T15:53:52.360Z,1554825232.360 [CBIT](INFO): Critical error at 20190409T155352
2019-04-09T15:53:52.363Z,1554825232.363 [CBIT](ERROR): Software Fault in component: BR_Ping1D
2019-04-09T15:53:52.363Z,1554825232.363 [CBIT](CRITICAL): Software Fault in component: BR_Ping1D
2019-04-09T15:53:52.466Z,1554825232.466 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-04-09T15:53:52.466Z,1554825232.466 [CTD_Seabird] Communications Fault, FailCount= 1
2019-04-09T15:53:52.466Z,1554825232.466 [CTD_Seabird](ERROR): Communications Fault
2019-04-09T15:53:52.705Z,1554825232.705 [BR_Ping1D](INFO): Stop
2019-04-09T15:53:52.705Z,1554825232.705 [BR_Ping1D](INFO): uninitialize
2019-04-09T15:53:52.706Z,1554825232.706 [BR_Ping1D](INFO): Powering down
2019-04-09T15:53:52.793Z,1554825232.793 [CBIT](INFO): Critical error at 20190409T155352
2019-04-09T15:53:52.793Z,1554825232.793 [CBIT](FAULT): Main Battery Failure. Count: 31
2019-04-09T15:53:52.795Z,1554825232.795 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-04-09T15:53:52.870Z,1554825232.870 [CTD_Seabird](INFO): Powering down
2019-04-09T15:53:53.110Z,1554825233.110 [BR_Ping1D](INFO): Stopping
2019-04-09T15:53:53.518Z,1554825233.519 [BR_Ping1D](INFO): Stopping
2019-04-09T15:53:53.918Z,1554825233.918 [BR_Ping1D](INFO): Stopped
2019-04-09T15:53:53.935Z,1554825233.935 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-04-09T15:53:53.935Z,1554825233.935 [CTD_Seabird] No Fault, FailCount= 1
2019-04-09T15:53:54.254Z,1554825234.254 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-04-09T15:53:54.256Z,1554825234.256 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-04-09T15:53:54.642Z,1554825234.642 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout
2019-04-09T15:53:54.642Z,1554825234.642 [MassServo] Communications Fault, FailCount= 4
2019-04-09T15:53:54.642Z,1554825234.642 [MassServo](ERROR): Communications Fault
2019-04-09T15:53:54.646Z,1554825234.646 [CBIT](ERROR): Communications Fault in component: MassServo
2019-04-09T15:53:54.739Z,1554825234.739 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-04-09T15:53:54.739Z,1554825234.739 [MassServo](INFO): Powering down
2019-04-09T15:53:55.544Z,1554825235.544 [MassServo](DEBUG): Initializing EZServoServo.
2019-04-09T15:53:55.663Z,1554825235.663 [MassServo](DEBUG): Initializing MassServo.
2019-04-09T15:53:55.667Z,1554825235.667 [CBIT](INFO): Clearing failed state for component MassServo
2019-04-09T15:53:55.667Z,1554825235.667 [MassServo] No Fault, FailCount= 4
2019-04-09T15:53:56.786Z,1554825236.786 [CBIT](FAULT): Main Battery Failure. Count: 41
2019-04-09T15:53:58.298Z,1554825238.298 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout
2019-04-09T15:53:58.298Z,1554825238.298 [MassServo] Communications Fault, FailCount= 5
2019-04-09T15:53:58.298Z,1554825238.298 [MassServo](ERROR): Communications Fault
2019-04-09T15:53:58.302Z,1554825238.302 [CBIT](ERROR): Communications Fault in component: MassServo
2019-04-09T15:53:58.303Z,1554825238.303 [CBIT](CRITICAL): Communications Fault in component: MassServo
2019-04-09T15:53:58.409Z,1554825238.409 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-04-09T15:53:58.409Z,1554825238.409 [MassServo](INFO): Powering down
2019-04-09T15:53:58.433Z,1554825238.433 [CBIT](INFO): Critical error at 20190409T155358
2019-04-09T15:53:59.199Z,1554825239.199 [MassServo](DEBUG): Initializing EZServoServo.
2019-04-09T15:53:59.319Z,1554825239.319 [MassServo](DEBUG): Initializing MassServo.
2019-04-09T15:54:00.362Z,1554825240.362 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-04-09T15:54:00.363Z,1554825240.363 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 1
2019-04-09T15:54:00.363Z,1554825240.363 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-04-09T15:54:00.407Z,1554825240.407 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-04-09T15:54:00.767Z,1554825240.767 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-04-09T15:54:00.944Z,1554825240.944 [CBIT](FAULT): Main Battery Failure. Count: 51
2019-04-09T15:54:01.619Z,1554825241.619 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-04-09T15:54:01.619Z,1554825241.619 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 1
2019-04-09T15:54:01.978Z,1554825241.978 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-04-09T15:54:01.978Z,1554825241.978 [Aanderaa_O2] Communications Fault, FailCount= 2
2019-04-09T15:54:01.978Z,1554825241.978 [Aanderaa_O2](ERROR): Communications Fault
2019-04-09T15:54:02.027Z,1554825242.027 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-04-09T15:54:02.502Z,1554825242.502 [Aanderaa_O2](INFO): Powering down
2019-04-09T15:54:03.223Z,1554825243.223 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-04-09T15:54:03.223Z,1554825243.223 [Aanderaa_O2] No Fault, FailCount= 2
2019-04-09T15:54:04.010Z,1554825244.010 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-04-09T15:54:04.010Z,1554825244.010 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-04-09T15:54:04.060Z,1554825244.060 [SBIT](IMPORTANT): Beginning Startup BIT
2019-04-09T15:54:04.064Z,1554825244.064 [CBIT](IMPORTANT): Beginning ground fault scan
2019-04-09T15:54:04.876Z,1554825244.876 [CBIT](FAULT): Main Battery Failure. Count: 61
2019-04-09T15:54:07.307Z,1554825247.307 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-04-09T15:54:07.307Z,1554825247.307 [CTD_Seabird] Communications Fault, FailCount= 2
2019-04-09T15:54:07.307Z,1554825247.307 [CTD_Seabird](ERROR): Communications Fault
2019-04-09T15:54:07.355Z,1554825247.355 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-04-09T15:54:07.639Z,1554825247.639 [NAL9602](INFO): Powering up NAL9602
2019-04-09T15:54:07.710Z,1554825247.710 [CTD_Seabird](INFO): Powering down
2019-04-09T15:54:09.004Z,1554825249.004 [CBIT](FAULT): Main Battery Failure. Count: 71
2019-04-09T15:54:09.007Z,1554825249.007 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-04-09T15:54:09.007Z,1554825249.007 [CTD_Seabird] No Fault, FailCount= 2
2019-04-09T15:54:09.054Z,1554825249.054 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-04-09T15:54:09.062Z,1554825249.062 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-04-09T15:54:12.917Z,1554825252.917 [CBIT](FAULT): Main Battery Failure. Count: 81
2019-04-09T15:54:13.694Z,1554825253.694 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-04-09T15:54:13.694Z,1554825253.694 [Aanderaa_O2] Communications Fault, FailCount= 3
2019-04-09T15:54:13.694Z,1554825253.694 [Aanderaa_O2](ERROR): Communications Fault
2019-04-09T15:54:13.728Z,1554825253.728 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-04-09T15:54:13.728Z,1554825253.728 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2019-04-09T15:54:14.218Z,1554825254.218 [Aanderaa_O2](INFO): Powering down
2019-04-09T15:54:14.943Z,1554825254.943 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): -0.006325
CHAN A1 (24V): -0.127256
CHAN A2 (12V): -0.005278
CHAN A3 (5V): -0.003137
CHAN B0 (3.3V): -0.001049
CHAN B1 (3.15aV): -0.001272
CHAN B2 (3.15bV): -0.001462
CHAN B3 (GND): 0.000358
OPEN: -0.000621
Full Scale Calc: 4.765 mA, -1.589 mA
2019-04-09T15:54:16.957Z,1554825256.957 [CBIT](FAULT): Main Battery Failure. Count: 91
2019-04-09T15:54:17.360Z,1554825257.360 [SBIT](ERROR): Could not read massPosReader_.
2019-04-09T15:54:18.548Z,1554825258.548 [NAL9602](INFO): NAL9602 initialized
2019-04-09T15:54:19.366Z,1554825259.366 [NAL9602](DEBUG): Fix Requested
2019-04-09T15:54:21.053Z,1554825261.053 [CBIT](FAULT): Main Battery Failure. Count: 101
2019-04-09T15:54:22.106Z,1554825262.106 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-04-09T15:54:22.106Z,1554825262.106 [CTD_Seabird] Communications Fault, FailCount= 3
2019-04-09T15:54:22.106Z,1554825262.106 [CTD_Seabird](ERROR): Communications Fault
2019-04-09T15:54:22.287Z,1554825262.287 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-04-09T15:54:22.288Z,1554825262.288 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2019-04-09T15:54:22.510Z,1554825262.510 [CTD_Seabird](INFO): Powering down
2019-04-09T15:54:24.198Z,1554825264.198 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-04-09T15:54:24.198Z,1554825264.198 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 2
2019-04-09T15:54:24.198Z,1554825264.198 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-04-09T15:54:24.300Z,1554825264.300 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-04-09T15:54:24.602Z,1554825264.602 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-04-09T15:54:25.280Z,1554825265.280 [CBIT](FAULT): Main Battery Failure. Count: 111
2019-04-09T15:54:25.448Z,1554825265.448 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-04-09T15:54:25.448Z,1554825265.448 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 2
2019-04-09T15:54:27.834Z,1554825267.834 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-04-09T15:54:27.835Z,1554825267.835 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-04-09T15:54:29.083Z,1554825269.083 [CBIT](FAULT): Main Battery Failure. Count: 121
2019-04-09T15:54:33.135Z,1554825273.135 [CBIT](FAULT): Main Battery Failure. Count: 131
2019-04-09T15:54:37.155Z,1554825277.155 [CBIT](FAULT): Main Battery Failure. Count: 141
2019-04-09T15:54:41.201Z,1554825281.201 [CBIT](FAULT): Main Battery Failure. Count: 151
2019-04-09T15:54:44.039Z,1554825284.039 [SBIT](ERROR): Could not read massPosReader_.
2019-04-09T15:54:44.039Z,1554825284.039 [SBIT](FAULT): Control surface position failure.
2019-04-09T15:54:45.243Z,1554825285.243 [CBIT](FAULT): Main Battery Failure. Count: 161
2019-04-09T15:54:48.035Z,1554825288.035 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-04-09T15:54:48.035Z,1554825288.035 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 3
2019-04-09T15:54:48.035Z,1554825288.035 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-04-09T15:54:48.148Z,1554825288.148 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-04-09T15:54:48.438Z,1554825288.438 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-04-09T15:54:49.532Z,1554825289.532 [CBIT](FAULT): Main Battery Failure. Count: 171
2019-04-09T15:54:49.535Z,1554825289.535 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-04-09T15:54:49.535Z,1554825289.535 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 3
2019-04-09T15:54:51.670Z,1554825291.670 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-04-09T15:54:51.671Z,1554825291.671 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-04-09T15:54:53.334Z,1554825293.334 [CBIT](FAULT): Main Battery Failure. Count: 181
2019-04-09T15:54:57.362Z,1554825297.362 [CBIT](FAULT): Main Battery Failure. Count: 191
2019-04-09T15:54:57.764Z,1554825297.764 [SBIT](ERROR): Could not read massPosReader_.
2019-04-09T15:54:57.764Z,1554825297.764 [SBIT](FAULT): Control surface position failure.
2019-04-09T15:54:58.161Z,1554825298.161 [SBIT](CRITICAL): SBIT FAILED
2019-04-09T15:54:58.176Z,1554825298.176 [CBIT](INFO): Critical error at 20190409T155458
2019-04-09T15:54:58.242Z,1554825298.242 [CommandLine](IMPORTANT): got command configSet list
2019-04-09T15:54:58.243Z,1554825298.243 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2019-04-09T15:54:58.244Z,1554825298.244 [CommandLine](IMPORTANT): DropWeight.loadAtStartup=0 bool;

2019-04-09T15:54:58.244Z,1554825298.244 [CommandLine](IMPORTANT): Rowe_600LCM.loadAtStartup=0 bool;

2019-04-09T15:54:58.583Z,1554825298.583 [MissionManager](IMPORTANT): Started mission Startup
2019-04-09T15:54:58.583Z,1554825298.583 [Startup] Running Loop=1
2019-04-09T15:54:58.584Z,1554825298.584 [Startup](DEBUG): Aggregate::initialize Startup
2019-04-09T15:54:58.584Z,1554825298.584 [Startup:A.GoToSurface] Running Loop=1
2019-04-09T15:54:58.584Z,1554825298.584 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-04-09T15:54:58.584Z,1554825298.584 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-04-09T15:54:58.585Z,1554825298.585 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-04-09T15:54:58.585Z,1554825298.585 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-04-09T15:54:58.585Z,1554825298.585 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-04-09T15:54:58.586Z,1554825298.586 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-04-09T15:54:58.587Z,1554825298.587 [Startup:StartupSatComms] Running Loop=1
2019-04-09T15:54:58.588Z,1554825298.588 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2019-04-09T15:54:58.588Z,1554825298.588 [Startup:StartupSatComms:A] Running Loop=1
2019-04-09T15:54:58.983Z,1554825298.983 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2019-04-09T15:55:01.401Z,1554825301.401 [CBIT](FAULT): Main Battery Failure. Count: 201
2019-04-09T15:55:05.441Z,1554825305.441 [CBIT](FAULT): Main Battery Failure. Count: 211
2019-04-09T15:55:09.498Z,1554825309.498 [CBIT](FAULT): Main Battery Failure. Count: 221
2019-04-09T15:55:11.870Z,1554825311.870 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-04-09T15:55:11.871Z,1554825311.871 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 4
2019-04-09T15:55:11.871Z,1554825311.871 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-04-09T15:55:11.908Z,1554825311.908 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-04-09T15:55:12.274Z,1554825312.274 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-04-09T15:55:13.120Z,1554825313.120 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-04-09T15:55:13.120Z,1554825313.120 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 4
2019-04-09T15:55:13.521Z,1554825313.521 [CBIT](FAULT): Main Battery Failure. Count: 231
2019-04-09T15:55:15.506Z,1554825315.506 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-04-09T15:55:15.507Z,1554825315.507 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-04-09T15:55:17.565Z,1554825317.565 [CBIT](FAULT): Main Battery Failure. Count: 241
2019-04-09T15:55:21.601Z,1554825321.601 [CBIT](FAULT): Main Battery Failure. Count: 251
2019-04-09T15:55:25.651Z,1554825325.651 [CBIT](FAULT): Main Battery Failure. Count: 261
2019-04-09T15:55:29.682Z,1554825329.682 [CBIT](FAULT): Main Battery Failure. Count: 271
2019-04-09T15:55:33.721Z,1554825333.721 [CBIT](FAULT): Main Battery Failure. Count: 281
2019-04-09T15:55:35.706Z,1554825335.706 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-04-09T15:55:35.707Z,1554825335.707 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 5
2019-04-09T15:55:35.707Z,1554825335.707 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-04-09T15:55:35.784Z,1554825335.784 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-04-09T15:55:36.111Z,1554825336.111 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-04-09T15:55:36.952Z,1554825336.952 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-04-09T15:55:36.952Z,1554825336.952 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 5
2019-04-09T15:55:37.763Z,1554825337.763 [CBIT](FAULT): Main Battery Failure. Count: 291
2019-04-09T15:55:39.342Z,1554825339.342 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-04-09T15:55:39.343Z,1554825339.343 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-04-09T15:55:39.773Z,1554825339.773 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-04-09T15:55:39.773Z,1554825339.773 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2019-04-09T15:55:39.774Z,1554825339.774 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-04-09T15:55:39.775Z,1554825339.775 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-04-09T15:55:39.775Z,1554825339.775 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2019-04-09T15:55:39.776Z,1554825339.776 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-04-09T15:55:39.777Z,1554825339.777 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-04-09T15:55:39.777Z,1554825339.777 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2019-04-09T15:55:39.777Z,1554825339.777 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-04-09T15:55:39.788Z,1554825339.788 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-04-09T15:55:39.788Z,1554825339.788 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-04-09T15:55:39.788Z,1554825339.788 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-04-09T15:55:40.183Z,1554825340.183 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-04-09T15:55:40.183Z,1554825340.183 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2019-04-09T15:55:40.184Z,1554825340.184 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-04-09T15:55:40.184Z,1554825340.184 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2019-04-09T15:55:40.184Z,1554825340.184 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-04-09T15:55:40.184Z,1554825340.184 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2019-04-09T15:55:40.593Z,1554825340.593 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-04-09T15:55:41.814Z,1554825341.814 [CBIT](FAULT): Main Battery Failure. Count: 301
2019-04-09T15:55:45.863Z,1554825345.863 [CBIT](FAULT): Main Battery Failure. Count: 311
2019-04-09T15:55:49.875Z,1554825349.875 [CBIT](FAULT): Main Battery Failure. Count: 321
2019-04-09T15:55:53.921Z,1554825353.921 [CBIT](FAULT): Main Battery Failure. Count: 331
2019-04-09T15:55:57.961Z,1554825357.961 [CBIT](FAULT): Main Battery Failure. Count: 341
2019-04-09T15:55:58.766Z,1554825358.766 [Startup:StartupSatComms:A](INFO): Timed out from 2019-04-09T15:54:58.6Z
2019-04-09T15:55:58.766Z,1554825358.766 [Startup:StartupSatComms:A] Stopped
2019-04-09T15:55:58.766Z,1554825358.766 [Startup:StartupSatComms:B] Running Loop=1
2019-04-09T15:55:59.168Z,1554825359.168 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-04-09T15:55:59.542Z,1554825359.542 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-04-09T15:55:59.543Z,1554825359.543 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 6
2019-04-09T15:55:59.543Z,1554825359.543 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-04-09T15:55:59.580Z,1554825359.580 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-04-09T15:55:59.946Z,1554825359.946 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-04-09T15:56:00.792Z,1554825360.792 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-04-09T15:56:00.792Z,1554825360.792 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 6
2019-04-09T15:56:02.015Z,1554825362.015 [CBIT](FAULT): Main Battery Failure. Count: 351
2019-04-09T15:56:03.178Z,1554825363.178 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-04-09T15:56:03.179Z,1554825363.179 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-04-09T15:56:06.034Z,1554825366.034 [CBIT](FAULT): Main Battery Failure. Count: 361
2019-04-09T15:56:10.082Z,1554825370.082 [CBIT](FAULT): Main Battery Failure. Count: 371
2019-04-09T15:56:14.121Z,1554825374.121 [CBIT](FAULT): Main Battery Failure. Count: 381
2019-04-09T15:56:18.168Z,1554825378.168 [CBIT](FAULT): Main Battery Failure. Count: 391
2019-04-09T15:56:21.300Z,1554825381.300 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004949
2019-04-09T15:56:22.205Z,1554825382.205 [CBIT](FAULT): Main Battery Failure. Count: 401
2019-04-09T15:56:23.378Z,1554825383.378 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-04-09T15:56:23.379Z,1554825383.379 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 7
2019-04-09T15:56:23.379Z,1554825383.379 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-04-09T15:56:23.452Z,1554825383.452 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-04-09T15:56:23.782Z,1554825383.782 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-04-09T15:56:24.632Z,1554825384.632 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-04-09T15:56:24.632Z,1554825384.632 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 7
2019-04-09T15:56:26.261Z,1554825386.261 [CBIT](FAULT): Main Battery Failure. Count: 411
2019-04-09T15:56:27.014Z,1554825387.014 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-04-09T15:56:27.014Z,1554825387.014 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-04-09T15:56:27.606Z,1554825387.606 [DataOverHttps](INFO): Sending 101 bytes from file Logs/20190409T154730/Courier0004.lzma
2019-04-09T15:56:28.412Z,1554825388.412 [DataOverHttps](INFO): Moved sent file to Logs/20190409T154730/Courier0004.lzma.bak
2019-04-09T15:56:28.412Z,1554825388.412 [DataOverHttps](INFO): SBD MOMSN=10513877
2019-04-09T15:56:30.276Z,1554825390.276 [CBIT](FAULT): Main Battery Failure. Count: 421
2019-04-09T15:56:34.328Z,1554825394.328 [CBIT](FAULT): Main Battery Failure. Count: 431
2019-04-09T15:56:38.381Z,1554825398.381 [CBIT](FAULT): Main Battery Failure. Count: 441
2019-04-09T15:56:42.422Z,1554825402.422 [CBIT](FAULT): Main Battery Failure. Count: 451
2019-04-09T15:56:43.055Z,1554825403.055 [DataOverHttps](INFO): Sending 636 bytes from file Logs/20190409T155329/Courier0000.lzma
2019-04-09T15:56:43.716Z,1554825403.716 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-04-09T15:56:43.716Z,1554825403.716 [Aanderaa_O2] No Fault, FailCount= 3
2019-04-09T15:56:43.860Z,1554825403.860 [DataOverHttps](INFO): Moved sent file to Logs/20190409T155329/Courier0000.lzma.bak
2019-04-09T15:56:43.860Z,1554825403.860 [DataOverHttps](INFO): SBD MOMSN=10513881
2019-04-09T15:56:46.457Z,1554825406.457 [CBIT](FAULT): Main Battery Failure. Count: 461
2019-04-09T15:56:47.231Z,1554825407.231 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-04-09T15:56:47.231Z,1554825407.231 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 8
2019-04-09T15:56:47.231Z,1554825407.231 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-04-09T15:56:47.262Z,1554825407.262 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-04-09T15:56:47.263Z,1554825407.263 [CBIT](FAULT): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-04-09T15:56:47.635Z,1554825407.635 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-04-09T15:56:49.519Z,1554825409.519 [CommandLine](IMPORTANT): got command restart application
2019-04-09T15:56:50.505Z,1554825410.505 [CBIT](FAULT): Main Battery Failure. Count: 471
2019-04-09T15:56:50.522Z,1554825410.522 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-09T15:56:50.523Z,1554825410.523 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-04-09T15:56:50.634Z,1554825410.634 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2019-04-09T15:56:50.634Z,1554825410.634 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-04-09T15:56:50.635Z,1554825410.635 [CommandLine](INFO): Join timeout helper Thread ID is 3575
2019-04-09T15:56:50.650Z,1554825410.650 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2019-04-09T15:56:50.650Z,1554825410.650 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-04-09T15:56:50.650Z,1554825410.650 [NavChartDb](INFO): Join timeout helper Thread ID is 3576
2019-04-09T15:56:50.818Z,1554825410.818 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-09T15:56:50.818Z,1554825410.818 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-04-09T15:56:50.822Z,1554825410.822 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2019-04-09T15:56:50.822Z,1554825410.822 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-04-09T15:56:50.822Z,1554825410.822 [Radio_Surface](INFO): Join timeout helper Thread ID is 3577
2019-04-09T15:56:51.022Z,1554825411.022 [Radio_Surface](INFO): Powering down
2019-04-09T15:56:51.023Z,1554825411.023 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-09T15:56:51.023Z,1554825411.023 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-04-09T15:56:51.038Z,1554825411.038 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2019-04-09T15:56:51.038Z,1554825411.038 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-04-09T15:56:51.038Z,1554825411.038 [DataOverHttps](INFO): Join timeout helper Thread ID is 3578
2019-04-09T15:56:51.864Z,1554825411.864 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-09T15:56:51.867Z,1554825411.867 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-04-09T15:56:51.874Z,1554825411.874 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2019-04-09T15:56:51.874Z,1554825411.874 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-04-09T15:56:51.875Z,1554825411.875 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 3579
2019-04-09T15:56:51.950Z,1554825411.950 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-09T15:56:51.951Z,1554825411.951 [WetLabsBB2FL](INFO): Powering down
2019-04-09T15:56:51.951Z,1554825411.951 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-04-09T15:56:51.955Z,1554825411.955 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2019-04-09T15:56:51.955Z,1554825411.955 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-04-09T15:56:51.955Z,1554825411.955 [CTD_Seabird](INFO): Join timeout helper Thread ID is 3580
2019-04-09T15:56:52.119Z,1554825412.119 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-04-09T15:56:52.119Z,1554825412.119 [CTD_Seabird] No Fault, FailCount= 3
2019-04-09T15:56:52.138Z,1554825412.138 [CTD_Seabird](INFO): Powering down
2019-04-09T15:56:52.150Z,1554825412.150 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-09T15:56:52.150Z,1554825412.150 [CTD_Seabird](INFO): Powering down
2019-04-09T15:56:52.162Z,1554825412.162 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-04-09T15:56:52.179Z,1554825412.179 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2019-04-09T15:56:52.179Z,1554825412.179 [logger ThreadHandler](INFO): Thread cancelled.
2019-04-09T15:56:52.179Z,1554825412.179 [logger](INFO): Join timeout helper Thread ID is 3581
2019-04-09T15:56:52.198Z,1554825412.198 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-09T15:56:52.198Z,1554825412.198 [logger ThreadHandler](INFO): Thread cancelled.
2019-04-09T15:56:52.219Z,1554825412.219 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2019-04-09T15:56:52.219Z,1554825412.219 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-04-09T15:56:52.219Z,1554825412.219 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2019-04-09T15:56:52.219Z,1554825412.219 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-04-09T15:56:52.219Z,1554825412.219 [controlThread](INFO): Join timeout helper Thread ID is 3582
2019-04-09T15:56:52.478Z,1554825412.478 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-09T15:56:52.478Z,1554825412.478 [controlThread](DEBUG): Uninitializing ControlThread
2019-04-09T15:56:52.598Z,1554825412.598 [Aanderaa_O2](INFO): Powering down
2019-04-09T15:56:52.600Z,1554825412.600 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-04-09T15:56:52.601Z,1554825412.601 [NAL9602](INFO): Powering down
2019-04-09T15:56:52.603Z,1554825412.603 [BR_Ping1D](INFO): uninitialize
2019-04-09T15:56:52.603Z,1554825412.603 [BR_Ping1D](INFO): Powering down
2019-04-09T15:56:52.605Z,1554825412.605 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2019-04-09T15:56:52.605Z,1554825412.605 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2019-04-09T15:56:52.606Z,1554825412.606 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2019-04-09T15:56:52.607Z,1554825412.607 [MissionManager](INFO): Uninitializing Mission Default
2019-04-09T15:56:52.609Z,1554825412.609 [MissionManager](INFO): Uninitializing Mission Startup
2019-04-09T15:56:52.609Z,1554825412.609 [Startup] Stopped
2019-04-09T15:56:52.609Z,1554825412.609 [Startup](DEBUG): Aggregate::uninitialize Startup
2019-04-09T15:56:52.609Z,1554825412.609 [Startup:A.GoToSurface] Stopped
2019-04-09T15:56:52.609Z,1554825412.609 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-04-09T15:56:52.610Z,1554825412.610 [Startup:StartupSatComms] Stopped
2019-04-09T15:56:52.610Z,1554825412.610 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2019-04-09T15:56:52.610Z,1554825412.610 [Startup:StartupSatComms:B] Stopped
2019-04-09T15:56:52.611Z,1554825412.611 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2019-04-09T15:56:52.612Z,1554825412.612 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2019-04-09T15:56:52.612Z,1554825412.612 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2019-04-09T15:56:52.612Z,1554825412.612 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2019-04-09T15:56:52.612Z,1554825412.612 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-04-09T15:56:52.612Z,1554825412.612 [BuoyancyServo](INFO): Powering down
2019-04-09T15:56:52.626Z,1554825412.626 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-04-09T15:56:52.626Z,1554825412.626 [ElevatorServo](INFO): Powering down
2019-04-09T15:56:52.627Z,1554825412.627 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-04-09T15:56:52.627Z,1554825412.627 [MassServo](INFO): Powering down
2019-04-09T15:56:52.628Z,1554825412.628 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-04-09T15:56:52.628Z,1554825412.628 [RudderServo](INFO): Powering down
2019-04-09T15:56:52.629Z,1554825412.629 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2019-04-09T15:56:52.629Z,1554825412.629 [ThrusterServo](INFO): Powering down
2019-04-09T15:56:52.630Z,1554825412.630 [SBIT](DEBUG): Uninitialize SBIT Component.
2019-04-09T15:56:52.630Z,1554825412.630 [IBIT](DEBUG): Uninitialize IBIT Component.
2019-04-09T15:56:52.630Z,1554825412.630 [CBIT](DEBUG): Uninitialize CBIT Component.
2019-04-09T15:56:52.630Z,1554825412.630 [CBIT](DEBUG): Powering off loads.
2019-04-09T15:56:52.642Z,1554825412.642 [CBIT](DEBUG): Disabling WDT.
2019-04-09T15:56:52.654Z,1554825412.654 [CBIT](DEBUG): Opening all GF detection circuits.
2019-04-09T15:56:52.655Z,1554825412.655 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-04-09T15:56:52.801Z,1554825412.801 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-04-09T15:56:52.806Z,1554825412.806 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-04-09T15:56:52.874Z,1554825412.874 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-04-09T15:56:52.878Z,1554825412.878 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-04-09T15:56:52.945Z,1554825412.945 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-04-09T15:56:53.022Z,1554825413.022 [logger ThreadHandler](INFO): Thread cancelled.