2019-04-09T22:48:03.216Z,1554850083.216 [Supervisor](DEBUG): Initializing supervisor.
2019-04-09T22:48:03.219Z,1554850083.219 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-04-09T22:48:03.220Z,1554850083.220 [SyncHandler](INFO): Protected caller Thread ID is 7255
2019-04-09T22:48:03.221Z,1554850083.221 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2019-04-09T22:48:03.222Z,1554850083.222 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2019-04-09T22:48:03.222Z,1554850083.222 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 7256
2019-04-09T22:48:03.225Z,1554850083.225 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2019-04-09T22:48:03.238Z,1554850083.238 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2019-04-09T22:48:03.239Z,1554850083.239 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2019-04-09T22:48:03.240Z,1554850083.240 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 7257
2019-04-09T22:48:03.240Z,1554850083.240 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2019-04-09T22:48:03.241Z,1554850083.241 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2019-04-09T22:48:03.242Z,1554850083.242 [logger ThreadHandler](INFO): Protected caller Thread ID is 7258
2019-04-09T22:48:03.244Z,1554850083.244 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2019-04-09T22:48:03.244Z,1554850083.244 [Supervisor](INFO): Looking for Config files in directory: Config/
2019-04-09T22:48:03.246Z,1554850083.246 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2019-04-09T22:48:03.344Z,1554850083.344 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2019-04-09T22:48:03.344Z,1554850083.344 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2019-04-09T22:48:03.552Z,1554850083.552 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2019-04-09T22:48:03.553Z,1554850083.553 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2019-04-09T22:48:03.694Z,1554850083.694 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2019-04-09T22:48:03.695Z,1554850083.695 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2019-04-09T22:48:04.204Z,1554850084.204 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2019-04-09T22:48:04.204Z,1554850084.204 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2019-04-09T22:48:04.660Z,1554850084.660 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2019-04-09T22:48:04.661Z,1554850084.661 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2019-04-09T22:48:05.142Z,1554850085.142 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2019-04-09T22:48:05.143Z,1554850085.143 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2019-04-09T22:48:05.460Z,1554850085.460 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2019-04-09T22:48:05.460Z,1554850085.460 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2019-04-09T22:48:05.805Z,1554850085.805 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2019-04-09T22:48:05.805Z,1554850085.805 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2019-04-09T22:48:06.217Z,1554850086.217 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2019-04-09T22:48:06.218Z,1554850086.218 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2019-04-09T22:48:06.371Z,1554850086.371 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2019-04-09T22:48:06.372Z,1554850086.372 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2019-04-09T22:48:06.480Z,1554850086.480 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2019-04-09T22:48:06.480Z,1554850086.480 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2019-04-09T22:48:06.563Z,1554850086.563 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2019-04-09T22:48:06.667Z,1554850086.667 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2019-04-09T22:48:06.668Z,1554850086.668 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2019-04-09T22:48:06.871Z,1554850086.871 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2019-04-09T22:48:06.871Z,1554850086.871 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2019-04-09T22:48:07.086Z,1554850087.086 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2019-04-09T22:48:07.088Z,1554850087.088 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2019-04-09T22:48:07.088Z,1554850087.088 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2019-04-09T22:48:07.174Z,1554850087.174 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2019-04-09T22:48:07.415Z,1554850087.415 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2019-04-09T22:48:07.415Z,1554850087.415 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2019-04-09T22:48:07.514Z,1554850087.514 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2019-04-09T22:48:07.694Z,1554850087.694 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2019-04-09T22:48:07.916Z,1554850087.916 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2019-04-09T22:48:08.004Z,1554850088.004 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2019-04-09T22:48:08.105Z,1554850088.105 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2019-04-09T22:48:08.200Z,1554850088.200 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2019-04-09T22:48:08.358Z,1554850088.358 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2019-04-09T22:48:08.465Z,1554850088.465 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2019-04-09T22:48:08.566Z,1554850088.566 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2019-04-09T22:48:08.570Z,1554850088.570 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2019-04-09T22:48:08.669Z,1554850088.669 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2019-04-09T22:48:08.671Z,1554850088.671 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2019-04-09T22:48:08.797Z,1554850088.797 [BuoyancyServo] Loaded
2019-04-09T22:48:08.797Z,1554850088.797 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2019-04-09T22:48:08.813Z,1554850088.813 [ElevatorServo] Loaded
2019-04-09T22:48:08.813Z,1554850088.813 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2019-04-09T22:48:08.829Z,1554850088.829 [MassServo] Loaded
2019-04-09T22:48:08.829Z,1554850088.829 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2019-04-09T22:48:08.845Z,1554850088.845 [RudderServo] Loaded
2019-04-09T22:48:08.845Z,1554850088.845 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2019-04-09T22:48:08.860Z,1554850088.860 [ThrusterServo] Loaded
2019-04-09T22:48:08.860Z,1554850088.860 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2019-04-09T22:48:08.860Z,1554850088.860 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2019-04-09T22:48:08.861Z,1554850088.861 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2019-04-09T22:48:08.997Z,1554850088.997 [SBIT](DEBUG): Construct Startup Built In Test.
2019-04-09T22:48:09.026Z,1554850089.026 [SBIT] Loaded
2019-04-09T22:48:09.027Z,1554850089.027 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2019-04-09T22:48:09.027Z,1554850089.027 [IBIT](DEBUG): Construct Initiated Built In Test.
2019-04-09T22:48:09.056Z,1554850089.056 [IBIT] Loaded
2019-04-09T22:48:09.056Z,1554850089.056 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2019-04-09T22:48:09.060Z,1554850089.060 [CBIT](DEBUG): Construct Continuous Built In Test.
2019-04-09T22:48:09.458Z,1554850089.458 [CBIT] Loaded
2019-04-09T22:48:09.458Z,1554850089.458 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2019-04-09T22:48:09.459Z,1554850089.459 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2019-04-09T22:48:09.459Z,1554850089.459 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2019-04-09T22:48:10.311Z,1554850090.311 [Aanderaa_O2] Loaded
2019-04-09T22:48:10.312Z,1554850090.312 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2019-04-09T22:48:10.321Z,1554850090.321 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density
2019-04-09T22:48:10.327Z,1554850090.327 [CTD_Seabird](INFO): created writer for : sea_water_density
2019-04-09T22:48:10.328Z,1554850090.328 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth
2019-04-09T22:48:10.333Z,1554850090.333 [CTD_Seabird](INFO): created writer for : depth
2019-04-09T22:48:10.334Z,1554850090.334 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure
2019-04-09T22:48:10.339Z,1554850090.339 [CTD_Seabird](INFO): created writer for : sea_water_pressure
2019-04-09T22:48:10.340Z,1554850090.340 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity
2019-04-09T22:48:10.345Z,1554850090.345 [CTD_Seabird](INFO): created writer for : sea_water_salinity
2019-04-09T22:48:10.346Z,1554850090.346 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature
2019-04-09T22:48:10.351Z,1554850090.351 [CTD_Seabird](INFO): created writer for : sea_water_temperature
2019-04-09T22:48:10.352Z,1554850090.352 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity
2019-04-09T22:48:10.358Z,1554850090.358 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity
2019-04-09T22:48:10.358Z,1554850090.358 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water
2019-04-09T22:48:10.363Z,1554850090.363 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water
2019-04-09T22:48:10.395Z,1554850090.395 [CTD_Seabird] Loaded
2019-04-09T22:48:10.395Z,1554850090.395 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2019-04-09T22:48:10.396Z,1554850090.396 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406654E0
2019-04-09T22:48:10.397Z,1554850090.397 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 7337
2019-04-09T22:48:10.423Z,1554850090.423 [ESPComponent] Loaded
2019-04-09T22:48:10.423Z,1554850090.423 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2019-04-09T22:48:10.438Z,1554850090.438 [PAR_Licor] Loaded
2019-04-09T22:48:10.438Z,1554850090.438 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2019-04-09T22:48:10.488Z,1554850090.488 [WetLabsBB2FL] Loaded
2019-04-09T22:48:10.488Z,1554850090.488 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2019-04-09T22:48:10.489Z,1554850090.489 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406954E0
2019-04-09T22:48:10.489Z,1554850090.489 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 7338
2019-04-09T22:48:10.490Z,1554850090.490 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2019-04-09T22:48:10.491Z,1554850090.491 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2019-04-09T22:48:10.532Z,1554850090.532 [DepthRateCalculator] Loaded
2019-04-09T22:48:10.532Z,1554850090.532 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2019-04-09T22:48:10.538Z,1554850090.538 [PitchRateCalculator] Loaded
2019-04-09T22:48:10.538Z,1554850090.538 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2019-04-09T22:48:10.555Z,1554850090.555 [SpeedCalculator] Loaded
2019-04-09T22:48:10.555Z,1554850090.555 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2019-04-09T22:48:10.577Z,1554850090.577 [TempGradientCalculator] Loaded
2019-04-09T22:48:10.577Z,1554850090.577 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2019-04-09T22:48:10.583Z,1554850090.583 [YawRateCalculator] Loaded
2019-04-09T22:48:10.583Z,1554850090.583 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2019-04-09T22:48:10.617Z,1554850090.617 [ElevatorOffsetCalculator] Loaded
2019-04-09T22:48:10.618Z,1554850090.618 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2019-04-09T22:48:10.618Z,1554850090.618 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2019-04-09T22:48:10.619Z,1554850090.619 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2019-04-09T22:48:10.646Z,1554850090.646 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2019-04-09T22:48:10.647Z,1554850090.647 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2019-04-09T22:48:10.752Z,1554850090.752 [DeadReckonUsingMultipleVelocitySources] Loaded
2019-04-09T22:48:10.752Z,1554850090.752 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2019-04-09T22:48:10.813Z,1554850090.813 [DeadReckonUsingSpeedCalculator] Loaded
2019-04-09T22:48:10.813Z,1554850090.813 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2019-04-09T22:48:10.875Z,1554850090.875 [DeadReckonWithRespectToSeafloor] Loaded
2019-04-09T22:48:10.875Z,1554850090.875 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2019-04-09T22:48:10.896Z,1554850090.896 [NavChart] Loaded
2019-04-09T22:48:10.897Z,1554850090.897 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2019-04-09T22:48:10.901Z,1554850090.901 [UniversalFixResidualReporter] Loaded
2019-04-09T22:48:10.901Z,1554850090.901 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2019-04-09T22:48:10.902Z,1554850090.902 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2019-04-09T22:48:10.902Z,1554850090.902 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2019-04-09T22:48:11.216Z,1554850091.216 [AcousticModem_Benthos_ATM900] Loaded
2019-04-09T22:48:11.216Z,1554850091.216 [ComponentRegistry](DEBUG): SyncComponent "AcousticModem_Benthos_ATM900" handled in the control thread.
2019-04-09T22:48:11.291Z,1554850091.291 [DataOverHttps] Loaded
2019-04-09T22:48:11.291Z,1554850091.291 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2019-04-09T22:48:11.292Z,1554850091.292 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409714E0
2019-04-09T22:48:11.292Z,1554850091.292 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 7339
2019-04-09T22:48:11.306Z,1554850091.306 [Depth_Keller] Loaded
2019-04-09T22:48:11.306Z,1554850091.306 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2019-04-09T22:48:11.400Z,1554850091.400 [NAL9602] Loaded
2019-04-09T22:48:11.400Z,1554850091.400 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2019-04-09T22:48:11.406Z,1554850091.406 [Onboard] Loaded
2019-04-09T22:48:11.406Z,1554850091.406 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2019-04-09T22:48:11.409Z,1554850091.409 [Radio_Surface] Loaded
2019-04-09T22:48:11.410Z,1554850091.410 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2019-04-09T22:48:11.411Z,1554850091.411 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409A14E0
2019-04-09T22:48:11.411Z,1554850091.411 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 7340
2019-04-09T22:48:12.726Z,1554850092.726 [BPC1] Loaded
2019-04-09T22:48:12.727Z,1554850092.727 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2019-04-09T22:48:12.758Z,1554850092.758 [BR_Ping1D](CRITICAL): No configuration setting for: BR_Ping1D.minrange
2019-04-09T22:48:12.760Z,1554850092.760 [BR_Ping1D](CRITICAL): No configuration setting for: BR_Ping1D.maxrange
2019-04-09T22:48:12.762Z,1554850092.762 [BR_Ping1D](CRITICAL): No configuration setting for: BR_Ping1D.soundspeed
2019-04-09T22:48:12.764Z,1554850092.764 [BR_Ping1D](CRITICAL): No configuration setting for: BR_Ping1D.automode
2019-04-09T22:48:12.767Z,1554850092.767 [BR_Ping1D](CRITICAL): No configuration setting for: BR_Ping1D.gainindex
2019-04-09T22:48:12.769Z,1554850092.769 [BR_Ping1D](CRITICAL): No configuration setting for: BR_Ping1D.minconfidence
2019-04-09T22:48:12.771Z,1554850092.771 [BR_Ping1D](CRITICAL): No configuration setting for: BR_Ping1D.pingenable
2019-04-09T22:48:12.773Z,1554850092.773 [BR_Ping1D] Loaded
2019-04-09T22:48:12.773Z,1554850092.773 [ComponentRegistry](DEBUG): SyncComponent "BR_Ping1D" handled in the control thread.
2019-04-09T22:48:12.774Z,1554850092.774 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2019-04-09T22:48:12.774Z,1554850092.774 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2019-04-09T22:48:12.839Z,1554850092.839 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2019-04-09T22:48:12.839Z,1554850092.839 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2019-04-09T22:48:12.906Z,1554850092.906 [VerticalControl](DEBUG): Construct VerticalControl.
2019-04-09T22:48:12.993Z,1554850092.993 [VerticalControl] Loaded
2019-04-09T22:48:12.993Z,1554850092.993 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2019-04-09T22:48:12.994Z,1554850092.994 [HorizontalControl](DEBUG): Construct HorizontalControl.
2019-04-09T22:48:13.054Z,1554850093.054 [HorizontalControl] Loaded
2019-04-09T22:48:13.055Z,1554850093.055 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2019-04-09T22:48:13.056Z,1554850093.056 [SpeedControl](DEBUG): Construct SpeedControl.
2019-04-09T22:48:13.057Z,1554850093.057 [SpeedControl] Loaded
2019-04-09T22:48:13.058Z,1554850093.058 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2019-04-09T22:48:13.058Z,1554850093.058 [LoopControl](DEBUG): Construct LoopControl.
2019-04-09T22:48:13.059Z,1554850093.059 [LoopControl] Loaded
2019-04-09T22:48:13.059Z,1554850093.059 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2019-04-09T22:48:13.060Z,1554850093.060 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2019-04-09T22:48:13.060Z,1554850093.060 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2019-04-09T22:48:13.074Z,1554850093.074 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2019-04-09T22:48:13.074Z,1554850093.074 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2019-04-09T22:48:13.353Z,1554850093.353 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2019-04-09T22:48:13.357Z,1554850093.357 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2019-04-09T22:48:13.358Z,1554850093.358 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2019-04-09T22:48:13.365Z,1554850093.365 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2019-04-09T22:48:13.366Z,1554850093.366 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40ACE4E0
2019-04-09T22:48:13.366Z,1554850093.366 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 7341
2019-04-09T22:48:13.371Z,1554850093.371 [Supervisor](INFO): Main Thread ID is 4347
2019-04-09T22:48:13.371Z,1554850093.371 [Supervisor](DEBUG): Running supervisor.
2019-04-09T22:48:13.372Z,1554850093.372 [CommandLine ThreadHandler](INFO): Handler Thread ID is 7342
2019-04-09T22:48:13.374Z,1554850093.374 [controlThread ThreadHandler](INFO): Handler Thread ID is 7343
2019-04-09T22:48:13.375Z,1554850093.375 [controlThread](DEBUG): Initializing ControlThread
2019-04-09T22:48:13.376Z,1554850093.376 [SBIT](INFO): Initialize SBIT Component.
2019-04-09T22:48:13.377Z,1554850093.377 [SBIT](IMPORTANT): git: 2019-03-18-31-ge98d5dc
2019-04-09T22:48:13.377Z,1554850093.377 [SBIT](INFO): git hash: e98d5dc50cbc39e402f19b9946ff4dc0776c8725
2019-04-09T22:48:13.377Z,1554850093.377 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2019-04-09T22:48:13.379Z,1554850093.379 [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-09T22:48:13.380Z,1554850093.380 [SBIT](INFO): Beginning SBIT in 24.000000 seconds.
2019-04-09T22:48:13.380Z,1554850093.380 [IBIT](INFO): Initialize IBIT Component.
2019-04-09T22:48:13.381Z,1554850093.381 [CBIT](DEBUG): Initialize CBIT Component.
2019-04-09T22:48:13.382Z,1554850093.382 [logger ThreadHandler](INFO): Handler Thread ID is 7344
2019-04-09T22:48:13.394Z,1554850093.394 [CBIT](DEBUG): Initialized mux pins.
2019-04-09T22:48:13.394Z,1554850093.394 [CBIT](DEBUG): Initializing the watchdog timer.
2019-04-09T22:48:13.402Z,1554850093.402 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 7345
2019-04-09T22:48:13.403Z,1554850093.403 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-04-09T22:48:13.407Z,1554850093.407 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-04-09T22:48:13.408Z,1554850093.408 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 7347
2019-04-09T22:48:13.409Z,1554850093.409 [WetLabsBB2FL](INFO): Powering down
2019-04-09T22:48:13.418Z,1554850093.418 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2019-04-09T22:48:13.419Z,1554850093.418 [CBIT](DEBUG): Initializing heartbeat.
2019-04-09T22:48:13.438Z,1554850093.438 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 7348
2019-04-09T22:48:13.439Z,1554850093.439 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2019-04-09T22:48:13.447Z,1554850093.447 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 7349
2019-04-09T22:48:13.466Z,1554850093.466 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 7350
2019-04-09T22:48:13.469Z,1554850093.469 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2019-04-09T22:48:13.470Z,1554850093.470 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2019-04-09T22:48:13.470Z,1554850093.470 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2019-04-09T22:48:13.470Z,1554850093.470 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2019-04-09T22:48:13.470Z,1554850093.470 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2019-04-09T22:48:13.471Z,1554850093.471 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2019-04-09T22:48:13.471Z,1554850093.471 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2019-04-09T22:48:13.471Z,1554850093.471 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2019-04-09T22:48:13.471Z,1554850093.471 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2019-04-09T22:48:13.471Z,1554850093.471 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2019-04-09T22:48:13.472Z,1554850093.472 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2019-04-09T22:48:13.472Z,1554850093.472 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2019-04-09T22:48:13.472Z,1554850093.472 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2019-04-09T22:48:13.472Z,1554850093.472 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2019-04-09T22:48:13.472Z,1554850093.472 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2019-04-09T22:48:13.472Z,1554850093.472 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2019-04-09T22:48:13.490Z,1554850093.490 [CBIT](DEBUG): Deactivating GF circuits.
2019-04-09T22:48:13.491Z,1554850093.491 [CBIT](DEBUG): Deactivating emergency mode.
2019-04-09T22:48:13.526Z,1554850093.526 [CBIT](DEBUG): Backplane powered.
2019-04-09T22:48:13.530Z,1554850093.530 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2019-04-09T22:48:13.531Z,1554850093.531 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2019-04-09T22:48:13.531Z,1554850093.531 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2019-04-09T22:48:13.531Z,1554850093.531 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2019-04-09T22:48:13.532Z,1554850093.532 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2019-04-09T22:48:13.532Z,1554850093.532 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2019-04-09T22:48:13.533Z,1554850093.533 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-04-09T22:48:13.534Z,1554850093.534 [NavChart](DEBUG): Initialize NavChart Navigation.
2019-04-09T22:48:13.535Z,1554850093.535 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2019-04-09T22:48:13.539Z,1554850093.539 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2019-04-09T22:48:13.541Z,1554850093.541 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2019-04-09T22:48:13.542Z,1554850093.542 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2019-04-09T22:48:13.542Z,1554850093.542 [LoopControl](DEBUG): Initialize LoopControlComponent.
2019-04-09T22:48:13.543Z,1554850093.543 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2019-04-09T22:48:13.571Z,1554850093.571 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2019-04-09T22:48:13.603Z,1554850093.603 [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-09T22:48:13.603Z,1554850093.603 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2019-04-09T22:48:13.686Z,1554850093.686 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2019-04-09T22:48:13.687Z,1554850093.687 [Default:A.Wait](DEBUG): Construct Wait.
2019-04-09T22:48:13.689Z,1554850093.689 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2019-04-09T22:48:13.732Z,1554850093.732 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2019-04-09T22:48:13.743Z,1554850093.743 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2019-04-09T22:48:13.749Z,1554850093.749 [Default:E.Execute](DEBUG): Construct Execute.
2019-04-09T22:48:13.785Z,1554850093.785 [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-09T22:48:13.798Z,1554850093.798 [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-09T22:48:13.819Z,1554850093.819 [ESPComponent](INFO): powering down ESP
2019-04-09T22:48:13.850Z,1554850093.850 [Radio_Surface](INFO): Powering up
2019-04-09T22:48:14.103Z,1554850094.103 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-04-09T22:48:14.104Z,1554850094.104 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-04-09T22:48:14.127Z,1554850094.127 [Depth_Keller](ERROR): Pressure reading out of range: 1895.684326 decibar
2019-04-09T22:48:14.179Z,1554850094.179 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-04-09T22:48:14.224Z,1554850094.224 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-04-09T22:48:14.230Z,1554850094.230 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-04-09T22:48:14.232Z,1554850094.232 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-04-09T22:48:14.238Z,1554850094.238 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-04-09T22:48:14.239Z,1554850094.239 [MassServo](DEBUG): Initializing EZServoServo.
2019-04-09T22:48:14.247Z,1554850094.247 [MassServo](DEBUG): Initializing MassServo.
2019-04-09T22:48:14.248Z,1554850094.248 [RudderServo](DEBUG): Initializing EZServoServo.
2019-04-09T22:48:14.255Z,1554850094.255 [RudderServo](DEBUG): Initializing RudderServo.
2019-04-09T22:48:14.256Z,1554850094.256 [ThrusterServo](DEBUG): Initializing EZServoServo.
2019-04-09T22:48:14.262Z,1554850094.262 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2019-04-09T22:48:14.265Z,1554850094.265 [CommandLine](FAULT): Scheduling is paused
2019-04-09T22:48:14.265Z,1554850094.265 [CBIT](INFO): Critical error at 20190409T224812
2019-04-09T22:48:14.265Z,1554850094.265 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2019-04-09T22:48:14.814Z,1554850094.814 [PAR_Licor](INFO): A/D timeout, 8 tries over 134 ms

2019-04-09T22:48:14.814Z,1554850094.814 [PAR_Licor] Data Fault, FailCount= 1
2019-04-09T22:48:14.814Z,1554850094.814 [PAR_Licor](ERROR): Data Fault
2019-04-09T22:48:14.849Z,1554850094.849 [BR_Ping1D](INFO): startup: 0
2019-04-09T22:48:14.850Z,1554850094.850 [BR_Ping1D](INFO): UART setting parameters ...
2019-04-09T22:48:14.862Z,1554850094.862 [BR_Ping1D](INFO): sending request for Ping Interval: 500
2019-04-09T22:48:14.862Z,1554850094.862 [BR_Ping1D](INFO): data 0145
2019-04-09T22:48:14.876Z,1554850094.876 [BR_Ping1D](CRITICAL): SIGSEGV: address not mapped to object
2019-04-09T22:48:14.876Z,1554850094.876 [BR_Ping1D](CRITICAL): Bad address: 0x1F4
2019-04-09T22:48:14.876Z,1554850094.876 [BR_Ping1D](CRITICAL): Backtrace: 
./bin/LRAUV(_ZN7PCaller20DefaultSignalHandlerEiP7siginfoPv+0x20) [0x179208]
Modules/Sensor.so(_ZN9BR_Ping1D8startingEv+0x278) [0x40795608]
./bin/LRAUV(_ZN9Component7executeEv+0x31c) [0xd6b4c]
./bin/LRAUV(_ZN7PCaller10PThreadRunEPv+0xbc) [0x178da4]

2019-04-09T22:48:14.876Z,1554850094.876 [BR_Ping1D] Software Fault, FailCount= 1
2019-04-09T22:48:14.876Z,1554850094.876 [BR_Ping1D](ERROR): Software Fault
2019-04-09T22:48:14.894Z,1554850094.894 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-04-09T22:48:14.894Z,1554850094.894 [SyncHandler](INFO): Protected caller Thread ID is 7360
2019-04-09T22:48:15.227Z,1554850095.227 [CBIT](INFO): Critical error at 20190409T224814
2019-04-09T22:48:15.230Z,1554850095.230 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-04-09T22:48:15.230Z,1554850095.230 [CBIT](INFO): Clearing failed state for component PAR_Licor
2019-04-09T22:48:15.230Z,1554850095.230 [PAR_Licor] No Fault, FailCount= 1
2019-04-09T22:48:15.231Z,1554850095.231 [CBIT](ERROR): Software Fault in component: BR_Ping1D
2019-04-09T22:48:15.256Z,1554850095.256 [BR_Ping1D](INFO): Stop
2019-04-09T22:48:15.256Z,1554850095.256 [BR_Ping1D](INFO): uninitialize
2019-04-09T22:48:15.256Z,1554850095.256 [BR_Ping1D](INFO): Powering down
2019-04-09T22:48:15.661Z,1554850095.661 [BR_Ping1D](INFO): Stopping
2019-04-09T22:48:16.178Z,1554850096.178 [PAR_Licor](INFO): A/D timeout, 8 tries over 134 ms

2019-04-09T22:48:16.178Z,1554850096.178 [PAR_Licor] Data Fault, FailCount= 1
2019-04-09T22:48:16.178Z,1554850096.178 [PAR_Licor](ERROR): Data Fault
2019-04-09T22:48:16.234Z,1554850096.234 [BR_Ping1D](INFO): Stopping
2019-04-09T22:48:16.274Z,1554850096.274 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-04-09T22:48:16.274Z,1554850096.274 [CBIT](INFO): Clearing failed state for component PAR_Licor
2019-04-09T22:48:16.275Z,1554850096.275 [PAR_Licor] No Fault, FailCount= 1
2019-04-09T22:48:16.469Z,1554850096.469 [BR_Ping1D](INFO): Stopped
2019-04-09T22:48:16.554Z,1554850096.554 [CBIT](INFO): Clearing failed state for component BR_Ping1D
2019-04-09T22:48:16.554Z,1554850096.554 [BR_Ping1D] No Fault, FailCount= 1
2019-04-09T22:48:16.990Z,1554850096.990 [PAR_Licor](INFO): A/D timeout, 8 tries over 138 ms

2019-04-09T22:48:16.990Z,1554850096.990 [PAR_Licor] Data Fault, FailCount= 2
2019-04-09T22:48:16.990Z,1554850096.990 [PAR_Licor](ERROR): Data Fault
2019-04-09T22:48:17.011Z,1554850097.011 [BR_Ping1D](INFO): Start
2019-04-09T22:48:17.075Z,1554850097.075 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-04-09T22:48:17.075Z,1554850097.075 [CBIT](INFO): Clearing failed state for component PAR_Licor
2019-04-09T22:48:17.076Z,1554850097.076 [PAR_Licor] No Fault, FailCount= 2
2019-04-09T22:48:17.278Z,1554850097.278 [BR_Ping1D](INFO): Starting
2019-04-09T22:48:17.682Z,1554850097.682 [BR_Ping1D](INFO): Starting
2019-04-09T22:48:17.682Z,1554850097.682 [BR_Ping1D](INFO): readConfig
2019-04-09T22:48:17.683Z,1554850097.683 [BR_Ping1D](INFO): startup: 0
2019-04-09T22:48:17.683Z,1554850097.683 [BR_Ping1D](INFO): UART setting parameters ...
2019-04-09T22:48:17.694Z,1554850097.694 [BR_Ping1D](INFO): sending request for Ping Interval: 500
2019-04-09T22:48:17.694Z,1554850097.694 [BR_Ping1D](INFO): data 0122
2019-04-09T22:48:17.706Z,1554850097.706 [BR_Ping1D](CRITICAL): SIGSEGV: address not mapped to object
2019-04-09T22:48:17.707Z,1554850097.707 [BR_Ping1D](CRITICAL): Bad address: 0x1F4
2019-04-09T22:48:17.707Z,1554850097.707 [BR_Ping1D](CRITICAL): Backtrace: 
./bin/LRAUV(_ZN7PCaller20DefaultSignalHandlerEiP7siginfoPv+0x20) [0x179208]
Modules/Sensor.so(_ZN9BR_Ping1D8startingEv+0x278) [0x40795608]
./bin/LRAUV(_ZN9Component7executeEv+0x31c) [0xd6b4c]
./bin/LRAUV(_ZN7PCaller10PThreadRunEPv+0xbc) [0x178da4]

2019-04-09T22:48:17.707Z,1554850097.707 [BR_Ping1D] Software Fault, FailCount= 2
2019-04-09T22:48:17.707Z,1554850097.707 [BR_Ping1D](ERROR): Software Fault
2019-04-09T22:48:17.708Z,1554850097.708 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-04-09T22:48:17.709Z,1554850097.709 [SyncHandler](INFO): Protected caller Thread ID is 7362
2019-04-09T22:48:18.096Z,1554850098.096 [CBIT](INFO): Critical error at 20190409T224817
2019-04-09T22:48:18.099Z,1554850098.099 [CBIT](ERROR): Software Fault in component: BR_Ping1D
2019-04-09T22:48:18.254Z,1554850098.254 [PAR_Licor](INFO): A/D timeout, 7 tries over 149 ms

2019-04-09T22:48:18.254Z,1554850098.254 [PAR_Licor] Data Fault, FailCount= 1
2019-04-09T22:48:18.254Z,1554850098.254 [PAR_Licor](ERROR): Data Fault
2019-04-09T22:48:18.290Z,1554850098.290 [BR_Ping1D](INFO): Stop
2019-04-09T22:48:18.290Z,1554850098.290 [BR_Ping1D](INFO): uninitialize
2019-04-09T22:48:18.290Z,1554850098.290 [BR_Ping1D](INFO): Powering down
2019-04-09T22:48:18.423Z,1554850098.423 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-04-09T22:48:18.423Z,1554850098.423 [CBIT](INFO): Clearing failed state for component PAR_Licor
2019-04-09T22:48:18.423Z,1554850098.423 [PAR_Licor] No Fault, FailCount= 1
2019-04-09T22:48:18.530Z,1554850098.530 [BR_Ping1D](INFO): Stopping
2019-04-09T22:48:19.050Z,1554850099.050 [PAR_Licor](INFO): A/D timeout, 8 tries over 138 ms

2019-04-09T22:48:19.050Z,1554850099.050 [PAR_Licor] Data Fault, FailCount= 2
2019-04-09T22:48:19.050Z,1554850099.050 [PAR_Licor](ERROR): Data Fault
2019-04-09T22:48:19.085Z,1554850099.085 [BR_Ping1D](INFO): Stopping
2019-04-09T22:48:19.154Z,1554850099.154 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-04-09T22:48:19.154Z,1554850099.154 [CBIT](INFO): Clearing failed state for component PAR_Licor
2019-04-09T22:48:19.154Z,1554850099.154 [PAR_Licor] No Fault, FailCount= 2
2019-04-09T22:48:19.338Z,1554850099.338 [BR_Ping1D](INFO): Stopped
2019-04-09T22:48:19.411Z,1554850099.411 [CBIT](INFO): Clearing failed state for component BR_Ping1D
2019-04-09T22:48:19.411Z,1554850099.411 [BR_Ping1D] No Fault, FailCount= 2
2019-04-09T22:48:19.850Z,1554850099.850 [PAR_Licor](INFO): A/D timeout, 8 tries over 130 ms

2019-04-09T22:48:19.850Z,1554850099.850 [PAR_Licor] Data Fault, FailCount= 3
2019-04-09T22:48:19.850Z,1554850099.850 [PAR_Licor](ERROR): Data Fault
2019-04-09T22:48:19.880Z,1554850099.880 [BR_Ping1D](INFO): Start
2019-04-09T22:48:20.143Z,1554850100.143 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-04-09T22:48:20.143Z,1554850100.143 [CBIT](CRITICAL): Data Fault in component: PAR_Licor
2019-04-09T22:48:20.171Z,1554850100.171 [BR_Ping1D](INFO): Starting
2019-04-09T22:48:20.241Z,1554850100.241 [CBIT](INFO): Critical error at 20190409T224820
2019-04-09T22:48:20.569Z,1554850100.569 [BR_Ping1D](INFO): Starting
2019-04-09T22:48:20.569Z,1554850100.569 [BR_Ping1D](INFO): readConfig
2019-04-09T22:48:20.570Z,1554850100.570 [BR_Ping1D](INFO): startup: 0
2019-04-09T22:48:20.570Z,1554850100.570 [BR_Ping1D](INFO): UART setting parameters ...
2019-04-09T22:48:20.582Z,1554850100.582 [BR_Ping1D](INFO): sending request for Ping Interval: 500
2019-04-09T22:48:20.582Z,1554850100.582 [BR_Ping1D](INFO): data 0122
2019-04-09T22:48:20.594Z,1554850100.594 [BR_Ping1D](CRITICAL): SIGSEGV: address not mapped to object
2019-04-09T22:48:20.595Z,1554850100.595 [BR_Ping1D](CRITICAL): Bad address: 0x1F4
2019-04-09T22:48:20.595Z,1554850100.595 [BR_Ping1D](CRITICAL): Backtrace: 
./bin/LRAUV(_ZN7PCaller20DefaultSignalHandlerEiP7siginfoPv+0x20) [0x179208]
Modules/Sensor.so(_ZN9BR_Ping1D8startingEv+0x278) [0x40795608]
./bin/LRAUV(_ZN9Component7executeEv+0x31c) [0xd6b4c]
./bin/LRAUV(_ZN7PCaller10PThreadRunEPv+0xbc) [0x178da4]

2019-04-09T22:48:20.595Z,1554850100.595 [BR_Ping1D] Software Fault, FailCount= 3
2019-04-09T22:48:20.595Z,1554850100.595 [BR_Ping1D](ERROR): Software Fault
2019-04-09T22:48:20.596Z,1554850100.596 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-04-09T22:48:20.597Z,1554850100.597 [SyncHandler](INFO): Protected caller Thread ID is 7364
2019-04-09T22:48:20.644Z,1554850100.644 [CBIT](INFO): Critical error at 20190409T224820
2019-04-09T22:48:20.646Z,1554850100.647 [CBIT](ERROR): Software Fault in component: BR_Ping1D
2019-04-09T22:48:20.974Z,1554850100.974 [BR_Ping1D](INFO): Stop
2019-04-09T22:48:20.974Z,1554850100.974 [BR_Ping1D](INFO): uninitialize
2019-04-09T22:48:20.974Z,1554850100.974 [BR_Ping1D](INFO): Powering down
2019-04-09T22:48:21.377Z,1554850101.377 [BR_Ping1D](INFO): Stopping
2019-04-09T22:48:21.782Z,1554850101.782 [BR_Ping1D](INFO): Stopping
2019-04-09T22:48:22.185Z,1554850102.185 [BR_Ping1D](INFO): Stopped
2019-04-09T22:48:22.263Z,1554850102.263 [CBIT](INFO): Clearing failed state for component BR_Ping1D
2019-04-09T22:48:22.263Z,1554850102.263 [BR_Ping1D] No Fault, FailCount= 3
2019-04-09T22:48:22.589Z,1554850102.589 [BR_Ping1D](INFO): Start
2019-04-09T22:48:22.994Z,1554850102.994 [BR_Ping1D](INFO): Starting
2019-04-09T22:48:23.398Z,1554850103.398 [BR_Ping1D](INFO): Starting
2019-04-09T22:48:23.398Z,1554850103.398 [BR_Ping1D](INFO): readConfig
2019-04-09T22:48:23.398Z,1554850103.398 [BR_Ping1D](INFO): startup: 0
2019-04-09T22:48:23.398Z,1554850103.398 [BR_Ping1D](INFO): UART setting parameters ...
2019-04-09T22:48:23.410Z,1554850103.410 [BR_Ping1D](INFO): sending request for Ping Interval: 500
2019-04-09T22:48:23.410Z,1554850103.410 [BR_Ping1D](INFO): data 0122
2019-04-09T22:48:23.423Z,1554850103.423 [BR_Ping1D](CRITICAL): SIGSEGV: address not mapped to object
2019-04-09T22:48:23.423Z,1554850103.423 [BR_Ping1D](CRITICAL): Bad address: 0x1F4
2019-04-09T22:48:23.424Z,1554850103.424 [BR_Ping1D](CRITICAL): Backtrace: 
./bin/LRAUV(_ZN7PCaller20DefaultSignalHandlerEiP7siginfoPv+0x20) [0x179208]
Modules/Sensor.so(_ZN9BR_Ping1D8startingEv+0x278) [0x40795608]
./bin/LRAUV(_ZN9Component7executeEv+0x31c) [0xd6b4c]
./bin/LRAUV(_ZN7PCaller10PThreadRunEPv+0xbc) [0x178da4]

2019-04-09T22:48:23.424Z,1554850103.424 [BR_Ping1D] Software Fault, FailCount= 4
2019-04-09T22:48:23.424Z,1554850103.424 [BR_Ping1D](ERROR): Software Fault
2019-04-09T22:48:23.425Z,1554850103.425 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-04-09T22:48:23.425Z,1554850103.425 [SyncHandler](INFO): Protected caller Thread ID is 7366
2019-04-09T22:48:23.572Z,1554850103.572 [CBIT](INFO): Critical error at 20190409T224823
2019-04-09T22:48:23.575Z,1554850103.575 [CBIT](CRITICAL): Environmental Failure. Press:14.814690 PSI. Humidity:37%. Temp:25 C. ABORTING MISSION
2019-04-09T22:48:23.576Z,1554850103.576 [CBIT](ERROR): Software Fault in component: BR_Ping1D
2019-04-09T22:48:23.801Z,1554850103.801 [BR_Ping1D](INFO): Stop
2019-04-09T22:48:23.801Z,1554850103.801 [BR_Ping1D](INFO): uninitialize
2019-04-09T22:48:23.801Z,1554850103.801 [BR_Ping1D](INFO): Powering down
2019-04-09T22:48:23.897Z,1554850103.897 [CBIT](INFO): Critical error at 20190409T224823
2019-04-09T22:48:24.186Z,1554850104.186 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-04-09T22:48:24.186Z,1554850104.186 [Aanderaa_O2] Communications Fault, FailCount= 1
2019-04-09T22:48:24.186Z,1554850104.186 [Aanderaa_O2](ERROR): Communications Fault
2019-04-09T22:48:24.206Z,1554850104.206 [BR_Ping1D](INFO): Stopping
2019-04-09T22:48:24.223Z,1554850104.223 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-04-09T22:48:24.710Z,1554850104.710 [Aanderaa_O2](INFO): Powering down
2019-04-09T22:48:24.809Z,1554850104.809 [BR_Ping1D](INFO): Stopping
2019-04-09T22:48:25.014Z,1554850105.014 [BR_Ping1D](INFO): Stopped
2019-04-09T22:48:25.031Z,1554850105.031 [CBIT](INFO): Clearing failed state for component BR_Ping1D
2019-04-09T22:48:25.031Z,1554850105.031 [BR_Ping1D] No Fault, FailCount= 4
2019-04-09T22:48:25.418Z,1554850105.418 [BR_Ping1D](INFO): Start
2019-04-09T22:48:25.467Z,1554850105.467 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-04-09T22:48:25.467Z,1554850105.467 [Aanderaa_O2] No Fault, FailCount= 1
2019-04-09T22:48:25.822Z,1554850105.822 [BR_Ping1D](INFO): Starting
2019-04-09T22:48:26.237Z,1554850106.237 [BR_Ping1D](INFO): Starting
2019-04-09T22:48:26.237Z,1554850106.237 [BR_Ping1D](INFO): readConfig
2019-04-09T22:48:26.237Z,1554850106.237 [BR_Ping1D](INFO): startup: 0
2019-04-09T22:48:26.238Z,1554850106.238 [BR_Ping1D](INFO): UART setting parameters ...
2019-04-09T22:48:26.250Z,1554850106.250 [BR_Ping1D](INFO): sending request for Ping Interval: 500
2019-04-09T22:48:26.250Z,1554850106.250 [BR_Ping1D](INFO): data 0122
2019-04-09T22:48:26.262Z,1554850106.262 [BR_Ping1D](CRITICAL): SIGSEGV: address not mapped to object
2019-04-09T22:48:26.263Z,1554850106.263 [BR_Ping1D](CRITICAL): Bad address: 0x1F4
2019-04-09T22:48:26.263Z,1554850106.263 [BR_Ping1D](CRITICAL): Backtrace: 
./bin/LRAUV(_ZN7PCaller20DefaultSignalHandlerEiP7siginfoPv+0x20) [0x179208]
Modules/Sensor.so(_ZN9BR_Ping1D8startingEv+0x278) [0x40795608]
./bin/LRAUV(_ZN9Component7executeEv+0x31c) [0xd6b4c]
./bin/LRAUV(_ZN7PCaller10PThreadRunEPv+0xbc) [0x178da4]

2019-04-09T22:48:26.263Z,1554850106.263 [BR_Ping1D] Software Fault, FailCount= 5
2019-04-09T22:48:26.263Z,1554850106.263 [BR_Ping1D](ERROR): Software Fault
2019-04-09T22:48:26.264Z,1554850106.264 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-04-09T22:48:26.265Z,1554850106.265 [SyncHandler](INFO): Protected caller Thread ID is 7369
2019-04-09T22:48:26.276Z,1554850106.276 [CBIT](INFO): Critical error at 20190409T224826
2019-04-09T22:48:26.279Z,1554850106.279 [CBIT](ERROR): Software Fault in component: BR_Ping1D
2019-04-09T22:48:26.279Z,1554850106.279 [CBIT](CRITICAL): Software Fault in component: BR_Ping1D
2019-04-09T22:48:26.454Z,1554850106.454 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-04-09T22:48:26.454Z,1554850106.454 [CTD_Seabird] Communications Fault, FailCount= 1
2019-04-09T22:48:26.454Z,1554850106.454 [CTD_Seabird](ERROR): Communications Fault
2019-04-09T22:48:26.630Z,1554850106.630 [BR_Ping1D](INFO): Stop
2019-04-09T22:48:26.630Z,1554850106.630 [BR_Ping1D](INFO): uninitialize
2019-04-09T22:48:26.630Z,1554850106.630 [BR_Ping1D](INFO): Powering down
2019-04-09T22:48:26.717Z,1554850106.717 [CBIT](INFO): Critical error at 20190409T224826
2019-04-09T22:48:26.720Z,1554850106.720 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-04-09T22:48:26.858Z,1554850106.858 [CTD_Seabird](INFO): Powering down
2019-04-09T22:48:27.035Z,1554850107.035 [BR_Ping1D](INFO): Stopping
2019-04-09T22:48:27.438Z,1554850107.438 [BR_Ping1D](INFO): Stopping
2019-04-09T22:48:27.841Z,1554850107.841 [BR_Ping1D](INFO): Stopped
2019-04-09T22:48:27.855Z,1554850107.855 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-04-09T22:48:27.855Z,1554850107.855 [CTD_Seabird] No Fault, FailCount= 1
2019-04-09T22:48:28.250Z,1554850108.250 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-04-09T22:48:28.252Z,1554850108.252 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-04-09T22:48:34.286Z,1554850114.286 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-04-09T22:48:34.287Z,1554850114.287 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 1
2019-04-09T22:48:34.287Z,1554850114.287 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-04-09T22:48:34.337Z,1554850114.337 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-04-09T22:48:34.690Z,1554850114.690 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-04-09T22:48:35.531Z,1554850115.531 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-04-09T22:48:35.531Z,1554850115.531 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 1
2019-04-09T22:48:35.902Z,1554850115.902 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-04-09T22:48:35.902Z,1554850115.902 [Aanderaa_O2] Communications Fault, FailCount= 2
2019-04-09T22:48:35.902Z,1554850115.902 [Aanderaa_O2](ERROR): Communications Fault
2019-04-09T22:48:35.935Z,1554850115.935 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-04-09T22:48:36.426Z,1554850116.426 [Aanderaa_O2](INFO): Powering down
2019-04-09T22:48:37.163Z,1554850117.163 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-04-09T22:48:37.163Z,1554850117.163 [Aanderaa_O2] No Fault, FailCount= 2
2019-04-09T22:48:37.934Z,1554850117.934 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-04-09T22:48:37.934Z,1554850117.934 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-04-09T22:48:37.988Z,1554850117.988 [SBIT](IMPORTANT): Beginning Startup BIT
2019-04-09T22:48:37.992Z,1554850117.992 [CBIT](IMPORTANT): Beginning ground fault scan
2019-04-09T22:48:41.302Z,1554850121.302 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-04-09T22:48:41.302Z,1554850121.302 [CTD_Seabird] Communications Fault, FailCount= 2
2019-04-09T22:48:41.302Z,1554850121.302 [CTD_Seabird](ERROR): Communications Fault
2019-04-09T22:48:41.379Z,1554850121.379 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-04-09T22:48:41.623Z,1554850121.623 [NAL9602](INFO): Powering up NAL9602
2019-04-09T22:48:41.706Z,1554850121.706 [CTD_Seabird](INFO): Powering down
2019-04-09T22:48:43.023Z,1554850123.023 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-04-09T22:48:43.023Z,1554850123.023 [CTD_Seabird] No Fault, FailCount= 2
2019-04-09T22:48:43.050Z,1554850123.050 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-04-09T22:48:43.058Z,1554850123.058 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-04-09T22:48:47.678Z,1554850127.678 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-04-09T22:48:47.678Z,1554850127.678 [Aanderaa_O2] Communications Fault, FailCount= 3
2019-04-09T22:48:47.678Z,1554850127.678 [Aanderaa_O2](ERROR): Communications Fault
2019-04-09T22:48:47.771Z,1554850127.771 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-04-09T22:48:47.771Z,1554850127.771 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2019-04-09T22:48:48.202Z,1554850128.202 [Aanderaa_O2](INFO): Powering down
2019-04-09T22:48:49.367Z,1554850129.367 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): -0.006666
CHAN A1 (24V): -0.127944
CHAN A2 (12V): -0.005014
CHAN A3 (5V): -0.002437
CHAN B0 (3.3V): -0.001375
CHAN B1 (3.15aV): -0.000911
CHAN B2 (3.15bV): -0.001782
CHAN B3 (GND): -0.000072
OPEN: -0.000880
Full Scale Calc: 4.765 mA, -1.589 mA
2019-04-09T22:48:52.531Z,1554850132.531 [NAL9602](INFO): NAL9602 initialized
2019-04-09T22:48:53.514Z,1554850133.514 [NAL9602](DEBUG): Fix Requested
2019-04-09T22:48:56.102Z,1554850136.102 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-04-09T22:48:56.102Z,1554850136.102 [CTD_Seabird] Communications Fault, FailCount= 3
2019-04-09T22:48:56.102Z,1554850136.102 [CTD_Seabird](ERROR): Communications Fault
2019-04-09T22:48:56.467Z,1554850136.467 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-04-09T22:48:56.468Z,1554850136.468 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2019-04-09T22:48:56.506Z,1554850136.506 [CTD_Seabird](INFO): Powering down
2019-04-09T22:48:58.343Z,1554850138.343 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-04-09T22:48:58.343Z,1554850138.343 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 2
2019-04-09T22:48:58.343Z,1554850138.343 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-04-09T22:48:58.551Z,1554850138.551 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-04-09T22:48:58.747Z,1554850138.747 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-04-09T22:48:59.671Z,1554850139.671 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-04-09T22:48:59.672Z,1554850139.672 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 2
2019-04-09T22:49:02.023Z,1554850142.023 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-04-09T22:49:02.023Z,1554850142.023 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-04-09T22:49:21.521Z,1554850161.521 [BPC1](ERROR): BPC1A: No match for serial number 04CC in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file).
2019-04-09T22:49:21.935Z,1554850161.935 [BPC1](ERROR): BPC1B: No match for serial number 018D in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2019-04-09T22:49:21.935Z,1554850161.935 [BPC1](FAULT): Failed to parse data from all battery packs.
2019-04-09T22:49:21.935Z,1554850161.935 [BPC1] Data Fault, FailCount= 1
2019-04-09T22:49:21.935Z,1554850161.935 [BPC1](ERROR): Data Fault
2019-04-09T22:49:22.051Z,1554850162.051 [CBIT](ERROR): Data Fault in component: BPC1
2019-04-09T22:49:22.290Z,1554850162.290 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-04-09T22:49:22.290Z,1554850162.290 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 3
2019-04-09T22:49:22.291Z,1554850162.291 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-04-09T22:49:22.507Z,1554850162.507 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-04-09T22:49:22.694Z,1554850162.694 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-04-09T22:49:23.637Z,1554850163.637 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-04-09T22:49:23.637Z,1554850163.637 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 3
2019-04-09T22:49:25.974Z,1554850165.974 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-04-09T22:49:25.975Z,1554850165.975 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-04-09T22:49:31.259Z,1554850171.259 [SBIT](IMPORTANT): SBIT PASSED
2019-04-09T22:49:31.279Z,1554850171.279 [CommandLine](IMPORTANT): got command configSet list
2019-04-09T22:49:31.279Z,1554850171.279 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2019-04-09T22:49:31.280Z,1554850171.280 [CommandLine](IMPORTANT): DropWeight.loadAtStartup=0 bool;

2019-04-09T22:49:31.280Z,1554850171.280 [CommandLine](IMPORTANT): Rowe_600LCM.loadAtStartup=0 bool;

2019-04-09T22:49:31.663Z,1554850171.663 [MissionManager](IMPORTANT): Started mission Startup
2019-04-09T22:49:31.663Z,1554850171.663 [Startup] Running Loop=1
2019-04-09T22:49:31.664Z,1554850171.664 [Startup](DEBUG): Aggregate::initialize Startup
2019-04-09T22:49:31.664Z,1554850171.664 [Startup:A.GoToSurface] Running Loop=1
2019-04-09T22:49:31.664Z,1554850171.664 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-04-09T22:49:31.664Z,1554850171.664 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-04-09T22:49:31.665Z,1554850171.665 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-04-09T22:49:31.665Z,1554850171.665 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-04-09T22:49:31.665Z,1554850171.665 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-04-09T22:49:31.666Z,1554850171.666 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-04-09T22:49:31.668Z,1554850171.668 [Startup:StartupSatComms] Running Loop=1
2019-04-09T22:49:31.668Z,1554850171.668 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2019-04-09T22:49:31.668Z,1554850171.668 [Startup:StartupSatComms:A] Running Loop=1
2019-04-09T22:49:32.079Z,1554850172.079 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2019-04-09T22:49:46.175Z,1554850186.175 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-04-09T22:49:46.175Z,1554850186.175 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 4
2019-04-09T22:49:46.175Z,1554850186.175 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-04-09T22:49:46.227Z,1554850186.227 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-04-09T22:49:46.578Z,1554850186.578 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-04-09T22:49:47.424Z,1554850187.424 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-04-09T22:49:47.424Z,1554850187.424 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 4
2019-04-09T22:49:49.811Z,1554850189.811 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-04-09T22:49:49.811Z,1554850189.811 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-04-09T22:50:10.011Z,1554850210.011 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-04-09T22:50:10.011Z,1554850210.011 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 5
2019-04-09T22:50:10.011Z,1554850210.011 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-04-09T22:50:10.068Z,1554850210.068 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-04-09T22:50:10.414Z,1554850210.414 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-04-09T22:50:11.259Z,1554850211.259 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-04-09T22:50:11.259Z,1554850211.259 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 5
2019-04-09T22:50:13.646Z,1554850213.646 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-04-09T22:50:13.647Z,1554850213.647 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-04-09T22:50:13.693Z,1554850213.693 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-04-09T22:50:13.693Z,1554850213.693 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2019-04-09T22:50:13.693Z,1554850213.693 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-04-09T22:50:13.695Z,1554850213.695 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-04-09T22:50:13.695Z,1554850213.695 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2019-04-09T22:50:13.695Z,1554850213.695 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-04-09T22:50:13.696Z,1554850213.696 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-04-09T22:50:13.696Z,1554850213.696 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2019-04-09T22:50:13.696Z,1554850213.696 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-04-09T22:50:13.707Z,1554850213.707 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-04-09T22:50:13.707Z,1554850213.707 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-04-09T22:50:13.707Z,1554850213.707 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-04-09T22:50:14.096Z,1554850214.096 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-04-09T22:50:14.096Z,1554850214.096 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2019-04-09T22:50:14.097Z,1554850214.097 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-04-09T22:50:14.097Z,1554850214.097 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2019-04-09T22:50:14.097Z,1554850214.097 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-04-09T22:50:14.097Z,1554850214.097 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2019-04-09T22:50:14.493Z,1554850214.493 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-04-09T22:50:31.855Z,1554850231.855 [Startup:StartupSatComms:A](INFO): Timed out from 2019-04-09T22:49:31.7Z
2019-04-09T22:50:31.855Z,1554850231.855 [Startup:StartupSatComms:A] Stopped
2019-04-09T22:50:31.855Z,1554850231.855 [Startup:StartupSatComms:B] Running Loop=1
2019-04-09T22:50:32.253Z,1554850232.253 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-04-09T22:50:33.846Z,1554850233.846 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-04-09T22:50:33.847Z,1554850233.847 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 6
2019-04-09T22:50:33.847Z,1554850233.847 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-04-09T22:50:33.900Z,1554850233.900 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-04-09T22:50:34.250Z,1554850234.250 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-04-09T22:50:35.118Z,1554850235.118 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-04-09T22:50:35.118Z,1554850235.118 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 6
2019-04-09T22:50:37.482Z,1554850237.482 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-04-09T22:50:37.483Z,1554850237.483 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-04-09T22:50:55.248Z,1554850255.248 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004934
2019-04-09T22:50:57.692Z,1554850257.692 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-04-09T22:50:57.692Z,1554850257.692 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 7
2019-04-09T22:50:57.692Z,1554850257.692 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-04-09T22:50:57.749Z,1554850257.749 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-04-09T22:50:58.086Z,1554850258.086 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-04-09T22:50:58.932Z,1554850258.932 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-04-09T22:50:58.932Z,1554850258.932 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 7
2019-04-09T22:51:01.318Z,1554850261.318 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-04-09T22:51:01.319Z,1554850261.319 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-04-09T22:51:07.458Z,1554850267.458 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20190409T200100/Courier0049.lzma
2019-04-09T22:51:08.264Z,1554850268.264 [DataOverHttps](INFO): Moved sent file to Logs/20190409T200100/Courier0049.lzma.bak
2019-04-09T22:51:08.264Z,1554850268.264 [DataOverHttps](INFO): SBD MOMSN=10520387
2019-04-09T22:51:17.940Z,1554850277.940 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-04-09T22:51:17.940Z,1554850277.940 [Aanderaa_O2] No Fault, FailCount= 3
2019-04-09T22:51:21.520Z,1554850281.520 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-04-09T22:51:21.520Z,1554850281.520 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 8
2019-04-09T22:51:21.520Z,1554850281.520 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-04-09T22:51:21.557Z,1554850281.557 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-04-09T22:51:21.557Z,1554850281.557 [CBIT](FAULT): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-04-09T22:51:21.922Z,1554850281.922 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-04-09T22:51:26.404Z,1554850286.404 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-04-09T22:51:26.404Z,1554850286.404 [CTD_Seabird] No Fault, FailCount= 3
2019-04-09T22:51:26.522Z,1554850286.522 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-04-09T22:51:26.524Z,1554850286.524 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-04-09T22:51:28.386Z,1554850288.386 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-04-09T22:51:28.386Z,1554850288.386 [Aanderaa_O2] Communications Fault, FailCount= 1
2019-04-09T22:51:28.386Z,1554850288.386 [Aanderaa_O2](ERROR): Communications Fault
2019-04-09T22:51:28.444Z,1554850288.444 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-04-09T22:51:28.910Z,1554850288.910 [Aanderaa_O2](INFO): Powering down
2019-04-09T22:51:29.655Z,1554850289.655 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-04-09T22:51:29.655Z,1554850289.655 [Aanderaa_O2] No Fault, FailCount= 1
2019-04-09T22:51:30.919Z,1554850290.919 [DataOverHttps](INFO): Sending 552 bytes from file Logs/20190409T224221/Courier0000.lzma
2019-04-09T22:51:31.723Z,1554850291.723 [DataOverHttps](INFO): Moved sent file to Logs/20190409T224221/Courier0000.lzma.bak
2019-04-09T22:51:31.724Z,1554850291.724 [DataOverHttps](INFO): SBD MOMSN=10520416
2019-04-09T22:51:32.055Z,1554850292.055 [Startup:StartupSatComms:B](INFO): Timed out from 2019-04-09T22:50:31.9Z
2019-04-09T22:51:32.055Z,1554850292.055 [Startup:StartupSatComms:B] Stopped
2019-04-09T22:51:32.055Z,1554850292.055 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2019-04-09T22:51:32.055Z,1554850292.055 [Startup:StartupSatComms] Stopped
2019-04-09T22:51:32.055Z,1554850292.055 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2019-04-09T22:51:32.056Z,1554850292.056 [Startup](INFO): Completed Startup
2019-04-09T22:51:32.056Z,1554850292.056 [MissionManager](INFO): Startup is completed.
2019-04-09T22:51:32.057Z,1554850292.057 [MissionManager](INFO): Uninitializing Mission Startup
2019-04-09T22:51:32.057Z,1554850292.057 [Startup] Stopped
2019-04-09T22:51:32.057Z,1554850292.057 [Startup](DEBUG): Aggregate::uninitialize Startup
2019-04-09T22:51:32.057Z,1554850292.057 [Startup:A.GoToSurface] Stopped
2019-04-09T22:51:32.057Z,1554850292.057 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-04-09T22:51:32.471Z,1554850292.471 [MissionManager](IMPORTANT): Started mission Default
2019-04-09T22:51:32.471Z,1554850292.471 [Default] Running Loop=1
2019-04-09T22:51:32.471Z,1554850292.471 [Default](DEBUG): Aggregate::initialize Default
2019-04-09T22:51:32.471Z,1554850292.471 [Default:B.GoToSurface] Running Loop=1
2019-04-09T22:51:32.471Z,1554850292.471 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-04-09T22:51:32.471Z,1554850292.471 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-04-09T22:51:32.472Z,1554850292.472 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-04-09T22:51:32.472Z,1554850292.472 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-04-09T22:51:32.472Z,1554850292.472 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-04-09T22:51:32.473Z,1554850292.473 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-04-09T22:51:32.473Z,1554850292.473 [Default:A.Wait] Running Loop=1
2019-04-09T22:51:32.473Z,1554850292.473 [Default:A.Wait](DEBUG): Initialize Wait Component.
2019-04-09T22:51:39.594Z,1554850299.594 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-04-09T22:51:39.594Z,1554850299.594 [CTD_Seabird] Communications Fault, FailCount= 1
2019-04-09T22:51:39.594Z,1554850299.594 [CTD_Seabird](ERROR): Communications Fault
2019-04-09T22:51:39.742Z,1554850299.742 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-04-09T22:51:39.998Z,1554850299.998 [CTD_Seabird](INFO): Powering down
2019-04-09T22:51:40.102Z,1554850300.102 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-04-09T22:51:40.102Z,1554850300.102 [Aanderaa_O2] Communications Fault, FailCount= 2
2019-04-09T22:51:40.102Z,1554850300.102 [Aanderaa_O2](ERROR): Communications Fault
2019-04-09T22:51:40.167Z,1554850300.167 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-04-09T22:51:40.626Z,1554850300.626 [Aanderaa_O2](INFO): Powering down
2019-04-09T22:51:40.949Z,1554850300.949 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-04-09T22:51:40.949Z,1554850300.949 [CTD_Seabird] No Fault, FailCount= 1
2019-04-09T22:51:41.346Z,1554850301.346 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-04-09T22:51:41.348Z,1554850301.348 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-04-09T22:51:41.354Z,1554850301.354 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-04-09T22:51:41.354Z,1554850301.354 [Aanderaa_O2] No Fault, FailCount= 2
2019-04-09T22:51:45.788Z,1554850305.788 [Default:A.Wait](INFO): Done Waiting.
2019-04-09T22:51:45.788Z,1554850305.788 [Default:A.Wait] Stopped
2019-04-09T22:51:45.788Z,1554850305.788 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2019-04-09T22:51:46.195Z,1554850306.195 [Default:CheckIn] Running Loop=1
2019-04-09T22:51:46.196Z,1554850306.196 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-04-09T22:51:46.196Z,1554850306.196 [Default:CheckIn:Read_GPS] Running Loop=1
2019-04-09T22:51:46.600Z,1554850306.600 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2019-04-09T22:51:51.818Z,1554850311.818 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-04-09T22:51:51.818Z,1554850311.818 [Aanderaa_O2] Communications Fault, FailCount= 3
2019-04-09T22:51:51.819Z,1554850311.819 [Aanderaa_O2](ERROR): Communications Fault
2019-04-09T22:51:51.860Z,1554850311.860 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-04-09T22:51:51.860Z,1554850311.860 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2019-04-09T22:51:52.342Z,1554850312.342 [Aanderaa_O2](INFO): Powering down
2019-04-09T22:51:54.398Z,1554850314.398 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-04-09T22:51:54.398Z,1554850314.398 [CTD_Seabird] Communications Fault, FailCount= 2
2019-04-09T22:51:54.398Z,1554850314.398 [CTD_Seabird](ERROR): Communications Fault
2019-04-09T22:51:54.692Z,1554850314.692 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-04-09T22:51:54.802Z,1554850314.802 [CTD_Seabird](INFO): Powering down
2019-04-09T22:51:55.895Z,1554850315.895 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-04-09T22:51:55.895Z,1554850315.895 [CTD_Seabird] No Fault, FailCount= 2
2019-04-09T22:51:56.146Z,1554850316.146 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-04-09T22:51:56.148Z,1554850316.148 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-04-09T22:52:09.198Z,1554850329.198 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-04-09T22:52:09.198Z,1554850329.198 [CTD_Seabird] Communications Fault, FailCount= 3
2019-04-09T22:52:09.198Z,1554850329.198 [CTD_Seabird](ERROR): Communications Fault
2019-04-09T22:52:09.242Z,1554850329.242 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-04-09T22:52:09.243Z,1554850329.243 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2019-04-09T22:52:09.602Z,1554850329.602 [CTD_Seabird](INFO): Powering down
2019-04-09T22:52:14.884Z,1554850334.884 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-04-09T22:52:14.884Z,1554850334.884 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2019-04-09T22:52:14.884Z,1554850334.884 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-04-09T22:52:14.885Z,1554850334.885 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-04-09T22:52:14.885Z,1554850334.885 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2019-04-09T22:52:14.885Z,1554850334.885 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-04-09T22:52:14.887Z,1554850334.887 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-04-09T22:52:14.887Z,1554850334.887 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2019-04-09T22:52:14.887Z,1554850334.887 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-04-09T22:52:14.897Z,1554850334.897 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-04-09T22:52:14.898Z,1554850334.898 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-04-09T22:52:14.898Z,1554850334.898 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-04-09T22:52:15.297Z,1554850335.297 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-04-09T22:52:15.297Z,1554850335.297 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2019-04-09T22:52:15.297Z,1554850335.297 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-04-09T22:52:15.297Z,1554850335.297 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2019-04-09T22:52:15.298Z,1554850335.298 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-04-09T22:52:15.298Z,1554850335.298 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2019-04-09T22:52:15.693Z,1554850335.693 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-04-09T22:53:26.392Z,1554850406.392 [CBIT](INFO): Clearing failed state for component BR_Ping1D
2019-04-09T22:53:26.392Z,1554850406.392 [BR_Ping1D] No Fault, FailCount= 5
2019-04-09T22:53:26.782Z,1554850406.782 [BR_Ping1D](INFO): Start
2019-04-09T22:53:27.178Z,1554850407.178 [BR_Ping1D](INFO): Starting
2019-04-09T22:53:27.586Z,1554850407.586 [BR_Ping1D](INFO): Starting
2019-04-09T22:53:27.586Z,1554850407.586 [BR_Ping1D](INFO): readConfig
2019-04-09T22:53:27.586Z,1554850407.586 [BR_Ping1D](INFO): startup: 0
2019-04-09T22:53:27.586Z,1554850407.586 [BR_Ping1D](INFO): UART setting parameters ...
2019-04-09T22:53:27.598Z,1554850407.598 [BR_Ping1D](INFO): sending request for Ping Interval: 500
2019-04-09T22:53:27.598Z,1554850407.598 [BR_Ping1D](INFO): data 0122
2019-04-09T22:53:27.609Z,1554850407.609 [BR_Ping1D](CRITICAL): SIGSEGV: address not mapped to object
2019-04-09T22:53:27.610Z,1554850407.610 [BR_Ping1D](CRITICAL): Bad address: 0x1F4
2019-04-09T22:53:27.610Z,1554850407.610 [BR_Ping1D](CRITICAL): Backtrace: 
./bin/LRAUV(_ZN7PCaller20DefaultSignalHandlerEiP7siginfoPv+0x20) [0x179208]
Modules/Sensor.so(_ZN9BR_Ping1D8startingEv+0x278) [0x40795608]
./bin/LRAUV(_ZN9Component7executeEv+0x31c) [0xd6b4c]
./bin/LRAUV(_ZN7PCaller10PThreadRunEPv+0xbc) [0x178da4]

2019-04-09T22:53:27.610Z,1554850407.610 [BR_Ping1D] Software Fault, FailCount= 1
2019-04-09T22:53:27.610Z,1554850407.610 [BR_Ping1D](ERROR): Software Fault
2019-04-09T22:53:27.611Z,1554850407.611 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-04-09T22:53:27.612Z,1554850407.612 [SyncHandler](INFO): Protected caller Thread ID is 7404
2019-04-09T22:53:27.626Z,1554850407.626 [CBIT](INFO): Critical error at 20190409T225327
2019-04-09T22:53:27.629Z,1554850407.629 [CBIT](ERROR): Software Fault in component: BR_Ping1D
2019-04-09T22:53:27.000Z,1554850408.000 [BR_Ping1D](INFO): Stop
2019-04-09T22:53:28.000Z,1554850408.000 [BR_Ping1D](INFO): uninitialize
2019-04-09T22:53:28.000Z,1554850408.000 [BR_Ping1D](INFO): Powering down
2019-04-09T22:53:28.405Z,1554850408.405 [BR_Ping1D](INFO): Stopping
2019-04-09T22:53:28.812Z,1554850408.812 [BR_Ping1D](INFO): Stopping
2019-04-09T22:53:29.221Z,1554850409.221 [BR_Ping1D](INFO): Stopped
2019-04-09T22:53:29.235Z,1554850409.235 [CBIT](INFO): Clearing failed state for component BR_Ping1D
2019-04-09T22:53:29.235Z,1554850409.235 [BR_Ping1D] No Fault, FailCount= 1
2019-04-09T22:53:29.606Z,1554850409.606 [BR_Ping1D](INFO): Start
2019-04-09T22:53:30.014Z,1554850410.014 [BR_Ping1D](INFO): Starting
2019-04-09T22:53:30.418Z,1554850410.418 [BR_Ping1D](INFO): Starting
2019-04-09T22:53:30.418Z,1554850410.418 [BR_Ping1D](INFO): readConfig
2019-04-09T22:53:30.418Z,1554850410.418 [BR_Ping1D](INFO): startup: 0
2019-04-09T22:53:30.418Z,1554850410.418 [BR_Ping1D](INFO): UART setting parameters ...
2019-04-09T22:53:30.430Z,1554850410.430 [BR_Ping1D](INFO): sending request for Ping Interval: 500
2019-04-09T22:53:30.430Z,1554850410.430 [BR_Ping1D](INFO): data 0122
2019-04-09T22:53:30.442Z,1554850410.442 [BR_Ping1D](CRITICAL): SIGSEGV: address not mapped to object
2019-04-09T22:53:30.442Z,1554850410.442 [BR_Ping1D](CRITICAL): Bad address: 0x1F4
2019-04-09T22:53:30.443Z,1554850410.443 [BR_Ping1D](CRITICAL): Backtrace: 
./bin/LRAUV(_ZN7PCaller20DefaultSignalHandlerEiP7siginfoPv+0x20) [0x179208]
Modules/Sensor.so(_ZN9BR_Ping1D8startingEv+0x278) [0x40795608]
./bin/LRAUV(_ZN9Component7executeEv+0x31c) [0xd6b4c]
./bin/LRAUV(_ZN7PCaller10PThreadRunEPv+0xbc) [0x178da4]

2019-04-09T22:53:30.443Z,1554850410.443 [BR_Ping1D] Software Fault, FailCount= 2
2019-04-09T22:53:30.443Z,1554850410.443 [BR_Ping1D](ERROR): Software Fault
2019-04-09T22:53:30.444Z,1554850410.444 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-04-09T22:53:30.444Z,1554850410.444 [SyncHandler](INFO): Protected caller Thread ID is 7406
2019-04-09T22:53:30.457Z,1554850410.457 [CBIT](INFO): Critical error at 20190409T225330
2019-04-09T22:53:30.484Z,1554850410.484 [CBIT](ERROR): Software Fault in component: BR_Ping1D
2019-04-09T22:53:30.819Z,1554850410.819 [BR_Ping1D](INFO): Stop
2019-04-09T22:53:30.819Z,1554850410.819 [BR_Ping1D](INFO): uninitialize
2019-04-09T22:53:30.819Z,1554850410.819 [BR_Ping1D](INFO): Powering down
2019-04-09T22:53:31.223Z,1554850411.223 [BR_Ping1D](INFO): Stopping
2019-04-09T22:53:31.630Z,1554850411.630 [BR_Ping1D](INFO): Stopping
2019-04-09T22:53:32.026Z,1554850412.026 [BR_Ping1D](INFO): Stopped
2019-04-09T22:53:32.055Z,1554850412.055 [CBIT](INFO): Clearing failed state for component BR_Ping1D
2019-04-09T22:53:32.055Z,1554850412.055 [BR_Ping1D] No Fault, FailCount= 2
2019-04-09T22:53:32.434Z,1554850412.434 [BR_Ping1D](INFO): Start
2019-04-09T22:53:32.841Z,1554850412.841 [BR_Ping1D](INFO): Starting
2019-04-09T22:53:33.252Z,1554850413.252 [BR_Ping1D](INFO): Starting
2019-04-09T22:53:33.253Z,1554850413.253 [BR_Ping1D](INFO): readConfig
2019-04-09T22:53:33.253Z,1554850413.253 [BR_Ping1D](INFO): startup: 0
2019-04-09T22:53:33.253Z,1554850413.253 [BR_Ping1D](INFO): UART setting parameters ...
2019-04-09T22:53:33.266Z,1554850413.266 [BR_Ping1D](INFO): sending request for Ping Interval: 500
2019-04-09T22:53:33.266Z,1554850413.266 [BR_Ping1D](INFO): data 0122
2019-04-09T22:53:33.273Z,1554850413.273 [BR_Ping1D](CRITICAL): SIGSEGV: address not mapped to object
2019-04-09T22:53:33.273Z,1554850413.273 [BR_Ping1D](CRITICAL): Bad address: 0x1F4
2019-04-09T22:53:33.276Z,1554850413.276 [BR_Ping1D](CRITICAL): Backtrace: 
./bin/LRAUV(_ZN7PCaller20DefaultSignalHandlerEiP7siginfoPv+0x20) [0x179208]
Modules/Sensor.so(_ZN9BR_Ping1D8startingEv+0x278) [0x40795608]
./bin/LRAUV(_ZN9Component7executeEv+0x31c) [0xd6b4c]
./bin/LRAUV(_ZN7PCaller10PThreadRunEPv+0xbc) [0x178da4]

2019-04-09T22:53:33.276Z,1554850413.276 [BR_Ping1D] Software Fault, FailCount= 3
2019-04-09T22:53:33.276Z,1554850413.276 [BR_Ping1D](ERROR): Software Fault
2019-04-09T22:53:33.277Z,1554850413.277 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-04-09T22:53:33.278Z,1554850413.278 [SyncHandler](INFO): Protected caller Thread ID is 7409
2019-04-09T22:53:33.317Z,1554850413.317 [CBIT](INFO): Critical error at 20190409T225333
2019-04-09T22:53:33.324Z,1554850413.324 [CBIT](ERROR): Software Fault in component: BR_Ping1D
2019-04-09T22:53:33.657Z,1554850413.657 [BR_Ping1D](INFO): Stop
2019-04-09T22:53:33.657Z,1554850413.657 [BR_Ping1D](INFO): uninitialize
2019-04-09T22:53:33.658Z,1554850413.658 [BR_Ping1D](INFO): Powering down
2019-04-09T22:53:34.061Z,1554850414.061 [BR_Ping1D](INFO): Stopping
2019-04-09T22:53:34.465Z,1554850414.465 [BR_Ping1D](INFO): Stopping
2019-04-09T22:53:34.861Z,1554850414.861 [BR_Ping1D](INFO): Stopped
2019-04-09T22:53:34.876Z,1554850414.876 [CBIT](INFO): Clearing failed state for component BR_Ping1D
2019-04-09T22:53:34.876Z,1554850414.876 [BR_Ping1D] No Fault, FailCount= 3
2019-04-09T22:53:35.262Z,1554850415.262 [BR_Ping1D](INFO): Start
2019-04-09T22:53:35.665Z,1554850415.665 [BR_Ping1D](INFO): Starting
2019-04-09T22:53:36.069Z,1554850416.069 [BR_Ping1D](INFO): Starting
2019-04-09T22:53:36.070Z,1554850416.070 [BR_Ping1D](INFO): readConfig
2019-04-09T22:53:36.070Z,1554850416.070 [BR_Ping1D](INFO): startup: 0
2019-04-09T22:53:36.070Z,1554850416.070 [BR_Ping1D](INFO): UART setting parameters ...
2019-04-09T22:53:36.082Z,1554850416.082 [BR_Ping1D](INFO): sending request for Ping Interval: 500
2019-04-09T22:53:36.082Z,1554850416.082 [BR_Ping1D](INFO): data 0122
2019-04-09T22:53:36.095Z,1554850416.095 [BR_Ping1D](CRITICAL): SIGSEGV: address not mapped to object
2019-04-09T22:53:36.095Z,1554850416.095 [BR_Ping1D](CRITICAL): Bad address: 0x1F4
2019-04-09T22:53:36.096Z,1554850416.096 [BR_Ping1D](CRITICAL): Backtrace: 
./bin/LRAUV(_ZN7PCaller20DefaultSignalHandlerEiP7siginfoPv+0x20) [0x179208]
Modules/Sensor.so(_ZN9BR_Ping1D8startingEv+0x278) [0x40795608]
./bin/LRAUV(_ZN9Component7executeEv+0x31c) [0xd6b4c]
./bin/LRAUV(_ZN7PCaller10PThreadRunEPv+0xbc) [0x178da4]

2019-04-09T22:53:36.096Z,1554850416.096 [BR_Ping1D] Software Fault, FailCount= 4
2019-04-09T22:53:36.096Z,1554850416.096 [BR_Ping1D](ERROR): Software Fault
2019-04-09T22:53:36.130Z,1554850416.130 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-04-09T22:53:36.130Z,1554850416.130 [SyncHandler](INFO): Protected caller Thread ID is 7411
2019-04-09T22:53:36.144Z,1554850416.144 [CBIT](INFO): Critical error at 20190409T225336
2019-04-09T22:53:36.147Z,1554850416.147 [CBIT](ERROR): Software Fault in component: BR_Ping1D
2019-04-09T22:53:36.475Z,1554850416.475 [BR_Ping1D](INFO): Stop
2019-04-09T22:53:36.475Z,1554850416.475 [BR_Ping1D](INFO): uninitialize
2019-04-09T22:53:36.475Z,1554850416.475 [BR_Ping1D](INFO): Powering down
2019-04-09T22:53:36.878Z,1554850416.878 [BR_Ping1D](INFO): Stopping
2019-04-09T22:53:36.940Z,1554850416.940 [CommandLine](IMPORTANT): got command restart application
2019-04-09T22:53:37.282Z,1554850417.282 [BR_Ping1D](INFO): Stopping
2019-04-09T22:53:37.689Z,1554850417.689 [BR_Ping1D](INFO): Stopped
2019-04-09T22:53:37.704Z,1554850417.704 [CBIT](INFO): Clearing failed state for component BR_Ping1D
2019-04-09T22:53:37.704Z,1554850417.704 [BR_Ping1D] No Fault, FailCount= 4
2019-04-09T22:53:37.962Z,1554850417.962 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-09T22:53:37.962Z,1554850417.962 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-04-09T22:53:38.030Z,1554850418.030 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2019-04-09T22:53:38.030Z,1554850418.030 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-04-09T22:53:38.031Z,1554850418.031 [CommandLine](INFO): Join timeout helper Thread ID is 7412
2019-04-09T22:53:38.031Z,1554850418.031 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2019-04-09T22:53:38.031Z,1554850418.031 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-04-09T22:53:38.031Z,1554850418.031 [NavChartDb](INFO): Join timeout helper Thread ID is 7413
2019-04-09T22:53:38.102Z,1554850418.102 [BR_Ping1D](INFO): Start
2019-04-09T22:53:38.310Z,1554850418.310 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-09T22:53:38.310Z,1554850418.310 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-04-09T22:53:38.318Z,1554850418.318 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2019-04-09T22:53:38.318Z,1554850418.318 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-04-09T22:53:38.318Z,1554850418.318 [Radio_Surface](INFO): Join timeout helper Thread ID is 7415
2019-04-09T22:53:38.513Z,1554850418.513 [BR_Ping1D](INFO): Starting
2019-04-09T22:53:38.682Z,1554850418.682 [Radio_Surface](INFO): Powering down
2019-04-09T22:53:38.683Z,1554850418.683 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-09T22:53:38.683Z,1554850418.683 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-04-09T22:53:38.702Z,1554850418.702 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2019-04-09T22:53:38.702Z,1554850418.702 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-04-09T22:53:38.702Z,1554850418.702 [DataOverHttps](INFO): Join timeout helper Thread ID is 7416
2019-04-09T22:53:38.908Z,1554850418.908 [BR_Ping1D](INFO): Starting
2019-04-09T22:53:38.909Z,1554850418.909 [BR_Ping1D](INFO): readConfig
2019-04-09T22:53:38.909Z,1554850418.909 [BR_Ping1D](INFO): startup: 0
2019-04-09T22:53:38.909Z,1554850418.909 [BR_Ping1D](INFO): UART setting parameters ...
2019-04-09T22:53:38.918Z,1554850418.918 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-09T22:53:38.918Z,1554850418.918 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-04-09T22:53:38.926Z,1554850418.926 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2019-04-09T22:53:38.926Z,1554850418.926 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-04-09T22:53:38.927Z,1554850418.927 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 7417
2019-04-09T22:53:38.932Z,1554850418.932 [BR_Ping1D](INFO): sending request for Ping Interval: 500
2019-04-09T22:53:38.932Z,1554850418.932 [BR_Ping1D](INFO): data 0122
2019-04-09T22:53:38.946Z,1554850418.946 [BR_Ping1D](CRITICAL): SIGSEGV: address not mapped to object
2019-04-09T22:53:38.946Z,1554850418.946 [BR_Ping1D](CRITICAL): Bad address: 0x1F4
2019-04-09T22:53:38.947Z,1554850418.947 [BR_Ping1D](CRITICAL): Backtrace: 
./bin/LRAUV(_ZN7PCaller20DefaultSignalHandlerEiP7siginfoPv+0x20) [0x179208]
Modules/Sensor.so(_ZN9BR_Ping1D8startingEv+0x278) [0x40795608]
./bin/LRAUV(_ZN9Component7executeEv+0x31c) [0xd6b4c]
./bin/LRAUV(_ZN7PCaller10PThreadRunEPv+0xbc) [0x178da4]

2019-04-09T22:53:38.947Z,1554850418.947 [BR_Ping1D] Software Fault, FailCount= 5
2019-04-09T22:53:38.947Z,1554850418.947 [BR_Ping1D](ERROR): Software Fault
2019-04-09T22:53:38.948Z,1554850418.948 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-04-09T22:53:38.948Z,1554850418.948 [SyncHandler](INFO): Protected caller Thread ID is 7418
2019-04-09T22:53:38.962Z,1554850418.962 [CBIT](INFO): Critical error at 20190409T225338
2019-04-09T22:53:38.965Z,1554850418.965 [CBIT](ERROR): Software Fault in component: BR_Ping1D
2019-04-09T22:53:38.965Z,1554850418.965 [CBIT](CRITICAL): Software Fault in component: BR_Ping1D
2019-04-09T22:53:39.118Z,1554850419.118 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-09T22:53:39.119Z,1554850419.119 [WetLabsBB2FL](INFO): Powering down
2019-04-09T22:53:39.120Z,1554850419.120 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-04-09T22:53:39.127Z,1554850419.127 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2019-04-09T22:53:39.127Z,1554850419.127 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-04-09T22:53:39.128Z,1554850419.128 [CTD_Seabird](INFO): Join timeout helper Thread ID is 7419
2019-04-09T22:53:39.312Z,1554850419.312 [BR_Ping1D](INFO): Stop
2019-04-09T22:53:39.312Z,1554850419.312 [BR_Ping1D](INFO): uninitialize
2019-04-09T22:53:39.312Z,1554850419.312 [BR_Ping1D](INFO): Powering down
2019-04-09T22:53:39.398Z,1554850419.398 [CBIT](INFO): Critical error at 20190409T225338
2019-04-09T22:53:39.434Z,1554850419.434 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-09T22:53:39.434Z,1554850419.434 [CTD_Seabird](INFO): Powering down
2019-04-09T22:53:39.446Z,1554850419.446 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-04-09T22:53:39.447Z,1554850419.447 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2019-04-09T22:53:39.447Z,1554850419.447 [logger ThreadHandler](INFO): Thread cancelled.
2019-04-09T22:53:39.448Z,1554850419.448 [logger](INFO): Join timeout helper Thread ID is 7420
2019-04-09T22:53:39.459Z,1554850419.459 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-09T22:53:39.460Z,1554850419.460 [logger ThreadHandler](INFO): Thread cancelled.
2019-04-09T22:53:39.475Z,1554850419.475 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2019-04-09T22:53:39.475Z,1554850419.475 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-04-09T22:53:39.475Z,1554850419.475 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2019-04-09T22:53:39.475Z,1554850419.475 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-04-09T22:53:39.475Z,1554850419.475 [controlThread](INFO): Join timeout helper Thread ID is 7421
2019-04-09T22:53:39.682Z,1554850419.682 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-09T22:53:39.682Z,1554850419.682 [controlThread](DEBUG): Uninitializing ControlThread
2019-04-09T22:53:39.683Z,1554850419.683 [Aanderaa_O2](INFO): Powering down
2019-04-09T22:53:39.685Z,1554850419.685 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-04-09T22:53:39.686Z,1554850419.686 [NAL9602](INFO): Powering down
2019-04-09T22:53:39.687Z,1554850419.687 [BR_Ping1D](INFO): uninitialize
2019-04-09T22:53:39.688Z,1554850419.688 [BR_Ping1D](INFO): Powering down
2019-04-09T22:53:39.689Z,1554850419.689 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2019-04-09T22:53:39.690Z,1554850419.690 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2019-04-09T22:53:39.691Z,1554850419.691 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2019-04-09T22:53:39.691Z,1554850419.691 [MissionManager](INFO): Uninitializing Mission Default
2019-04-09T22:53:39.691Z,1554850419.691 [Default] Stopped
2019-04-09T22:53:39.691Z,1554850419.691 [Default](DEBUG): Aggregate::uninitialize Default
2019-04-09T22:53:39.691Z,1554850419.691 [Default:B.GoToSurface] Stopped
2019-04-09T22:53:39.691Z,1554850419.691 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-04-09T22:53:39.692Z,1554850419.692 [Default:CheckIn] Stopped
2019-04-09T22:53:39.692Z,1554850419.692 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-04-09T22:53:39.692Z,1554850419.692 [Default:CheckIn:Read_GPS] Stopped
2019-04-09T22:53:39.694Z,1554850419.694 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2019-04-09T22:53:39.695Z,1554850419.695 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2019-04-09T22:53:39.695Z,1554850419.695 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2019-04-09T22:53:39.695Z,1554850419.695 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2019-04-09T22:53:39.695Z,1554850419.695 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-04-09T22:53:39.695Z,1554850419.695 [BuoyancyServo](INFO): Powering down
2019-04-09T22:53:39.710Z,1554850419.710 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-04-09T22:53:39.710Z,1554850419.710 [ElevatorServo](INFO): Powering down
2019-04-09T22:53:39.711Z,1554850419.711 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-04-09T22:53:39.711Z,1554850419.711 [MassServo](INFO): Powering down
2019-04-09T22:53:39.712Z,1554850419.712 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-04-09T22:53:39.712Z,1554850419.712 [RudderServo](INFO): Powering down
2019-04-09T22:53:39.713Z,1554850419.713 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2019-04-09T22:53:39.713Z,1554850419.713 [ThrusterServo](INFO): Powering down
2019-04-09T22:53:39.714Z,1554850419.714 [SBIT](DEBUG): Uninitialize SBIT Component.
2019-04-09T22:53:39.714Z,1554850419.714 [IBIT](DEBUG): Uninitialize IBIT Component.
2019-04-09T22:53:39.715Z,1554850419.715 [CBIT](DEBUG): Uninitialize CBIT Component.
2019-04-09T22:53:39.715Z,1554850419.715 [CBIT](DEBUG): Powering off loads.
2019-04-09T22:53:39.726Z,1554850419.726 [CBIT](DEBUG): Disabling WDT.
2019-04-09T22:53:39.738Z,1554850419.738 [CBIT](DEBUG): Opening all GF detection circuits.
2019-04-09T22:53:39.739Z,1554850419.739 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-04-09T22:53:39.781Z,1554850419.781 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-04-09T22:53:39.786Z,1554850419.786 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-04-09T22:53:39.854Z,1554850419.854 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-04-09T22:53:39.858Z,1554850419.858 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-04-09T22:53:39.910Z,1554850419.910 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-04-09T22:53:39.968Z,1554850419.968 [logger ThreadHandler](INFO): Thread cancelled.