2019-02-16T01:02:47.838Z,1550278967.838 [Supervisor](DEBUG): Initializing supervisor.
2019-02-16T01:02:47.841Z,1550278967.841 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-02-16T01:02:47.842Z,1550278967.842 [SyncHandler](INFO): Protected caller Thread ID is 3563
2019-02-16T01:02:47.842Z,1550278967.842 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2019-02-16T01:02:47.843Z,1550278967.843 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2019-02-16T01:02:47.843Z,1550278967.843 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 3564
2019-02-16T01:02:47.846Z,1550278967.846 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2019-02-16T01:02:47.858Z,1550278967.858 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2019-02-16T01:02:47.859Z,1550278967.859 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2019-02-16T01:02:47.859Z,1550278967.859 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 3565
2019-02-16T01:02:47.860Z,1550278967.860 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2019-02-16T01:02:47.861Z,1550278967.861 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2019-02-16T01:02:47.862Z,1550278967.862 [logger ThreadHandler](INFO): Protected caller Thread ID is 3566
2019-02-16T01:02:47.864Z,1550278967.864 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2019-02-16T01:02:47.864Z,1550278967.864 [Supervisor](INFO): Looking for Config files in directory: Config/
2019-02-16T01:02:47.866Z,1550278967.866 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2019-02-16T01:02:47.960Z,1550278967.960 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2019-02-16T01:02:47.961Z,1550278967.961 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2019-02-16T01:02:48.161Z,1550278968.161 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2019-02-16T01:02:48.161Z,1550278968.161 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2019-02-16T01:02:48.298Z,1550278968.298 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2019-02-16T01:02:48.299Z,1550278968.299 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2019-02-16T01:02:48.779Z,1550278968.779 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2019-02-16T01:02:48.779Z,1550278968.779 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2019-02-16T01:02:49.229Z,1550278969.229 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2019-02-16T01:02:49.230Z,1550278969.230 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2019-02-16T01:02:49.715Z,1550278969.715 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2019-02-16T01:02:49.716Z,1550278969.716 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2019-02-16T01:02:50.027Z,1550278970.027 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2019-02-16T01:02:50.028Z,1550278970.028 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2019-02-16T01:02:50.380Z,1550278970.380 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2019-02-16T01:02:50.381Z,1550278970.381 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2019-02-16T01:02:50.780Z,1550278970.780 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2019-02-16T01:02:50.780Z,1550278970.780 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2019-02-16T01:02:50.931Z,1550278970.931 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2019-02-16T01:02:50.932Z,1550278970.932 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2019-02-16T01:02:51.038Z,1550278971.038 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2019-02-16T01:02:51.039Z,1550278971.039 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2019-02-16T01:02:51.118Z,1550278971.118 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2019-02-16T01:02:51.220Z,1550278971.220 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2019-02-16T01:02:51.220Z,1550278971.220 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2019-02-16T01:02:51.416Z,1550278971.416 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2019-02-16T01:02:51.417Z,1550278971.417 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2019-02-16T01:02:51.626Z,1550278971.626 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2019-02-16T01:02:51.628Z,1550278971.628 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2019-02-16T01:02:51.629Z,1550278971.629 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2019-02-16T01:02:51.712Z,1550278971.712 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2019-02-16T01:02:51.950Z,1550278971.950 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2019-02-16T01:02:51.951Z,1550278971.951 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2019-02-16T01:02:52.046Z,1550278972.046 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2019-02-16T01:02:52.206Z,1550278972.206 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2019-02-16T01:02:52.413Z,1550278972.413 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2019-02-16T01:02:52.498Z,1550278972.498 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2019-02-16T01:02:52.671Z,1550278972.671 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2019-02-16T01:02:53.036Z,1550278973.036 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2019-02-16T01:02:53.401Z,1550278973.401 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2019-02-16T01:02:53.581Z,1550278973.581 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2019-02-16T01:02:53.679Z,1550278973.679 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2019-02-16T01:02:53.681Z,1550278973.681 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2019-02-16T01:02:53.790Z,1550278973.790 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2019-02-16T01:02:53.790Z,1550278973.790 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2019-02-16T01:02:53.901Z,1550278973.901 [BuoyancyServo] Loaded
2019-02-16T01:02:53.901Z,1550278973.901 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2019-02-16T01:02:53.917Z,1550278973.917 [ElevatorServo] Loaded
2019-02-16T01:02:53.917Z,1550278973.917 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2019-02-16T01:02:53.932Z,1550278973.932 [MassServo] Loaded
2019-02-16T01:02:53.933Z,1550278973.933 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2019-02-16T01:02:53.948Z,1550278973.948 [RudderServo] Loaded
2019-02-16T01:02:53.949Z,1550278973.949 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2019-02-16T01:02:53.963Z,1550278973.963 [ThrusterServo] Loaded
2019-02-16T01:02:53.964Z,1550278973.964 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2019-02-16T01:02:53.964Z,1550278973.964 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2019-02-16T01:02:53.965Z,1550278973.965 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2019-02-16T01:02:54.109Z,1550278974.109 [SBIT](DEBUG): Construct Startup Built In Test.
2019-02-16T01:02:54.140Z,1550278974.140 [SBIT] Loaded
2019-02-16T01:02:54.140Z,1550278974.140 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2019-02-16T01:02:54.141Z,1550278974.141 [IBIT](DEBUG): Construct Initiated Built In Test.
2019-02-16T01:02:54.170Z,1550278974.170 [IBIT] Loaded
2019-02-16T01:02:54.170Z,1550278974.170 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2019-02-16T01:02:54.173Z,1550278974.173 [CBIT](DEBUG): Construct Continuous Built In Test.
2019-02-16T01:02:54.588Z,1550278974.588 [CBIT] Loaded
2019-02-16T01:02:54.588Z,1550278974.588 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2019-02-16T01:02:54.588Z,1550278974.588 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2019-02-16T01:02:54.589Z,1550278974.589 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2019-02-16T01:02:54.784Z,1550278974.784 [Aanderaa_O2] Loaded
2019-02-16T01:02:54.784Z,1550278974.784 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2019-02-16T01:02:54.794Z,1550278974.794 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density
2019-02-16T01:02:54.799Z,1550278974.799 [CTD_Seabird](INFO): created writer for : sea_water_density
2019-02-16T01:02:54.801Z,1550278974.801 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth
2019-02-16T01:02:54.806Z,1550278974.806 [CTD_Seabird](INFO): created writer for : depth
2019-02-16T01:02:54.807Z,1550278974.807 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure
2019-02-16T01:02:54.812Z,1550278974.812 [CTD_Seabird](INFO): created writer for : sea_water_pressure
2019-02-16T01:02:54.813Z,1550278974.813 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity
2019-02-16T01:02:54.819Z,1550278974.819 [CTD_Seabird](INFO): created writer for : sea_water_salinity
2019-02-16T01:02:54.819Z,1550278974.819 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature
2019-02-16T01:02:54.825Z,1550278974.825 [CTD_Seabird](INFO): created writer for : sea_water_temperature
2019-02-16T01:02:54.826Z,1550278974.826 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity
2019-02-16T01:02:54.832Z,1550278974.832 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity
2019-02-16T01:02:54.832Z,1550278974.832 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water
2019-02-16T01:02:54.838Z,1550278974.838 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water
2019-02-16T01:02:54.866Z,1550278974.866 [CTD_Seabird] Loaded
2019-02-16T01:02:54.867Z,1550278974.867 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2019-02-16T01:02:54.868Z,1550278974.868 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 4062F4E0
2019-02-16T01:02:54.868Z,1550278974.868 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 3646
2019-02-16T01:02:54.890Z,1550278974.890 [ESPComponent] Loaded
2019-02-16T01:02:54.891Z,1550278974.891 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2019-02-16T01:02:54.905Z,1550278974.905 [PAR_Licor] Loaded
2019-02-16T01:02:54.905Z,1550278974.905 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2019-02-16T01:02:54.957Z,1550278974.957 [WetLabsBB2FL] Loaded
2019-02-16T01:02:54.957Z,1550278974.957 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2019-02-16T01:02:54.958Z,1550278974.958 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 4065F4E0
2019-02-16T01:02:54.958Z,1550278974.958 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 3647
2019-02-16T01:02:54.959Z,1550278974.959 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2019-02-16T01:02:54.960Z,1550278974.960 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2019-02-16T01:02:55.004Z,1550278975.004 [DepthRateCalculator] Loaded
2019-02-16T01:02:55.004Z,1550278975.004 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2019-02-16T01:02:55.010Z,1550278975.010 [PitchRateCalculator] Loaded
2019-02-16T01:02:55.011Z,1550278975.011 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2019-02-16T01:02:55.027Z,1550278975.027 [SpeedCalculator] Loaded
2019-02-16T01:02:55.027Z,1550278975.027 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2019-02-16T01:02:55.049Z,1550278975.049 [TempGradientCalculator] Loaded
2019-02-16T01:02:55.049Z,1550278975.049 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2019-02-16T01:02:55.055Z,1550278975.055 [YawRateCalculator] Loaded
2019-02-16T01:02:55.056Z,1550278975.056 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2019-02-16T01:02:55.091Z,1550278975.091 [ElevatorOffsetCalculator] Loaded
2019-02-16T01:02:55.091Z,1550278975.091 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2019-02-16T01:02:55.091Z,1550278975.091 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2019-02-16T01:02:55.092Z,1550278975.092 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2019-02-16T01:02:55.122Z,1550278975.122 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2019-02-16T01:02:55.122Z,1550278975.122 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2019-02-16T01:02:55.231Z,1550278975.231 [DeadReckonUsingMultipleVelocitySources] Loaded
2019-02-16T01:02:55.231Z,1550278975.231 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2019-02-16T01:02:55.294Z,1550278975.294 [DeadReckonUsingSpeedCalculator] Loaded
2019-02-16T01:02:55.294Z,1550278975.294 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2019-02-16T01:02:55.356Z,1550278975.356 [DeadReckonWithRespectToSeafloor] Loaded
2019-02-16T01:02:55.357Z,1550278975.357 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2019-02-16T01:02:55.374Z,1550278975.374 [NavChart] Loaded
2019-02-16T01:02:55.374Z,1550278975.374 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2019-02-16T01:02:55.378Z,1550278975.378 [UniversalFixResidualReporter] Loaded
2019-02-16T01:02:55.378Z,1550278975.378 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2019-02-16T01:02:55.379Z,1550278975.379 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2019-02-16T01:02:55.379Z,1550278975.379 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2019-02-16T01:02:55.683Z,1550278975.683 [AcousticModem_Benthos_ATM900] Loaded
2019-02-16T01:02:55.683Z,1550278975.683 [ComponentRegistry](DEBUG): SyncComponent "AcousticModem_Benthos_ATM900" handled in the control thread.
2019-02-16T01:02:55.760Z,1550278975.760 [DataOverHttps] Loaded
2019-02-16T01:02:55.761Z,1550278975.761 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2019-02-16T01:02:55.762Z,1550278975.762 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409264E0
2019-02-16T01:02:55.762Z,1550278975.762 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 3648
2019-02-16T01:02:55.776Z,1550278975.776 [Depth_Keller] Loaded
2019-02-16T01:02:55.776Z,1550278975.776 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2019-02-16T01:02:55.781Z,1550278975.781 [DropWeight] Loaded
2019-02-16T01:02:55.782Z,1550278975.782 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2019-02-16T01:02:55.878Z,1550278975.878 [NAL9602] Loaded
2019-02-16T01:02:55.879Z,1550278975.879 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2019-02-16T01:02:55.884Z,1550278975.884 [Onboard] Loaded
2019-02-16T01:02:55.884Z,1550278975.884 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2019-02-16T01:02:55.892Z,1550278975.892 [Radio_Surface] Loaded
2019-02-16T01:02:55.892Z,1550278975.892 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2019-02-16T01:02:55.893Z,1550278975.893 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409564E0
2019-02-16T01:02:55.894Z,1550278975.894 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 3649
2019-02-16T01:02:55.943Z,1550278975.943 [PNI_TCM] Loaded
2019-02-16T01:02:55.944Z,1550278975.944 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread.
2019-02-16T01:02:56.007Z,1550278976.007 [Rowe_600LCM] Loaded
2019-02-16T01:02:56.008Z,1550278976.008 [ComponentRegistry](DEBUG): Component "Rowe_600LCM" handled in its own thread.
2019-02-16T01:02:56.009Z,1550278976.009 [Rowe_600LCM ThreadHandler](DEBUG): Created PCaller Thread at 409864E0
2019-02-16T01:02:56.009Z,1550278976.009 [Rowe_600LCM ThreadHandler](INFO): Protected caller Thread ID is 3650
2019-02-16T01:02:57.697Z,1550278977.697 [BPC1] Loaded
2019-02-16T01:02:57.697Z,1550278977.697 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2019-02-16T01:02:57.697Z,1550278977.697 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2019-02-16T01:02:57.698Z,1550278977.698 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2019-02-16T01:02:57.884Z,1550278977.884 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2019-02-16T01:02:57.885Z,1550278977.885 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2019-02-16T01:02:57.977Z,1550278977.977 [VerticalControl](DEBUG): Construct VerticalControl.
2019-02-16T01:02:58.064Z,1550278978.064 [VerticalControl] Loaded
2019-02-16T01:02:58.065Z,1550278978.065 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2019-02-16T01:02:58.065Z,1550278978.065 [HorizontalControl](DEBUG): Construct HorizontalControl.
2019-02-16T01:02:58.126Z,1550278978.126 [HorizontalControl] Loaded
2019-02-16T01:02:58.126Z,1550278978.126 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2019-02-16T01:02:58.127Z,1550278978.127 [SpeedControl](DEBUG): Construct SpeedControl.
2019-02-16T01:02:58.129Z,1550278978.129 [SpeedControl] Loaded
2019-02-16T01:02:58.129Z,1550278978.129 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2019-02-16T01:02:58.130Z,1550278978.130 [LoopControl](DEBUG): Construct LoopControl.
2019-02-16T01:02:58.130Z,1550278978.130 [LoopControl] Loaded
2019-02-16T01:02:58.130Z,1550278978.130 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2019-02-16T01:02:58.131Z,1550278978.131 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2019-02-16T01:02:58.131Z,1550278978.131 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2019-02-16T01:02:58.146Z,1550278978.146 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2019-02-16T01:02:58.146Z,1550278978.146 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2019-02-16T01:02:58.403Z,1550278978.403 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2019-02-16T01:02:58.407Z,1550278978.407 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2019-02-16T01:02:58.408Z,1550278978.408 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2019-02-16T01:02:58.415Z,1550278978.415 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2019-02-16T01:02:58.416Z,1550278978.416 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AA84E0
2019-02-16T01:02:58.416Z,1550278978.416 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 3651
2019-02-16T01:02:58.421Z,1550278978.421 [Supervisor](INFO): Main Thread ID is 3562
2019-02-16T01:02:58.421Z,1550278978.421 [Supervisor](DEBUG): Running supervisor.
2019-02-16T01:02:58.422Z,1550278978.422 [CommandLine ThreadHandler](INFO): Handler Thread ID is 3652
2019-02-16T01:02:58.425Z,1550278978.425 [controlThread ThreadHandler](INFO): Handler Thread ID is 3653
2019-02-16T01:02:58.425Z,1550278978.425 [controlThread](DEBUG): Initializing ControlThread
2019-02-16T01:02:58.427Z,1550278978.427 [SBIT](INFO): Initialize SBIT Component.
2019-02-16T01:02:58.427Z,1550278978.427 [SBIT](IMPORTANT): git: 2019-02-11-18-g088f29c
2019-02-16T01:02:58.428Z,1550278978.428 [SBIT](INFO): git hash: 088f29c08f1651a006237423a6ffed1cbba6c6ba
2019-02-16T01:02:58.428Z,1550278978.428 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2019-02-16T01:02:58.429Z,1550278978.429 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Tue Dec 18 21:19:28 PST 2018
2019-02-16T01:02:58.430Z,1550278978.430 [SBIT](INFO): Beginning SBIT in 24.000000 seconds.
2019-02-16T01:02:58.431Z,1550278978.431 [IBIT](INFO): Initialize IBIT Component.
2019-02-16T01:02:58.432Z,1550278978.432 [CBIT](DEBUG): Initialize CBIT Component.
2019-02-16T01:02:58.433Z,1550278978.433 [logger ThreadHandler](INFO): Handler Thread ID is 3654
2019-02-16T01:02:58.445Z,1550278978.445 [CBIT](DEBUG): Initialized mux pins.
2019-02-16T01:02:58.445Z,1550278978.445 [CBIT](DEBUG): Initializing the watchdog timer.
2019-02-16T01:02:58.458Z,1550278978.458 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 3655
2019-02-16T01:02:58.459Z,1550278978.459 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-02-16T01:02:58.462Z,1550278978.462 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-02-16T01:02:58.463Z,1550278978.463 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 3657
2019-02-16T01:02:58.464Z,1550278978.464 [WetLabsBB2FL](INFO): Powering down
2019-02-16T01:02:58.469Z,1550278978.469 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2019-02-16T01:02:58.469Z,1550278978.469 [CBIT](DEBUG): Initializing heartbeat.
2019-02-16T01:02:58.494Z,1550278978.494 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 3658
2019-02-16T01:02:58.495Z,1550278978.495 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2019-02-16T01:02:58.506Z,1550278978.506 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 3659
2019-02-16T01:02:58.507Z,1550278978.507 [Radio_Surface](INFO): Powering up
2019-02-16T01:02:58.514Z,1550278978.514 [Rowe_600LCM ThreadHandler](INFO): Handler Thread ID is 3660
2019-02-16T01:02:58.514Z,1550278978.514 [Rowe_600LCM](INFO): Initializing
2019-02-16T01:02:58.524Z,1550278978.524 [Rowe_600LCM](INFO): Powering up
2019-02-16T01:02:58.530Z,1550278978.530 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 3661
2019-02-16T01:02:58.534Z,1550278978.534 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2019-02-16T01:02:58.534Z,1550278978.534 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2019-02-16T01:02:58.534Z,1550278978.534 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2019-02-16T01:02:58.534Z,1550278978.534 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2019-02-16T01:02:58.534Z,1550278978.534 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2019-02-16T01:02:58.535Z,1550278978.535 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2019-02-16T01:02:58.535Z,1550278978.535 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2019-02-16T01:02:58.535Z,1550278978.535 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2019-02-16T01:02:58.535Z,1550278978.535 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2019-02-16T01:02:58.535Z,1550278978.535 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2019-02-16T01:02:58.536Z,1550278978.536 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2019-02-16T01:02:58.536Z,1550278978.536 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2019-02-16T01:02:58.536Z,1550278978.536 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2019-02-16T01:02:58.536Z,1550278978.536 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2019-02-16T01:02:58.536Z,1550278978.536 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2019-02-16T01:02:58.536Z,1550278978.536 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2019-02-16T01:02:58.542Z,1550278978.542 [CBIT](DEBUG): Deactivating GF circuits.
2019-02-16T01:02:58.542Z,1550278978.542 [CBIT](DEBUG): Deactivating emergency mode.
2019-02-16T01:02:58.582Z,1550278978.582 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2019-02-16T01:02:58.582Z,1550278978.582 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2019-02-16T01:02:58.582Z,1550278978.582 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2019-02-16T01:02:58.583Z,1550278978.583 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2019-02-16T01:02:58.583Z,1550278978.583 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2019-02-16T01:02:58.584Z,1550278978.584 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2019-02-16T01:02:58.585Z,1550278978.585 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-02-16T01:02:58.586Z,1550278978.586 [NavChart](DEBUG): Initialize NavChart Navigation.
2019-02-16T01:02:58.586Z,1550278978.586 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2019-02-16T01:02:58.592Z,1550278978.592 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2019-02-16T01:02:58.598Z,1550278978.598 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2019-02-16T01:02:58.599Z,1550278978.599 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2019-02-16T01:02:58.599Z,1550278978.599 [LoopControl](DEBUG): Initialize LoopControlComponent.
2019-02-16T01:02:58.600Z,1550278978.600 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2019-02-16T01:02:58.632Z,1550278978.632 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2019-02-16T01:02:58.667Z,1550278978.667 [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-02-16T01:02:58.668Z,1550278978.668 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2019-02-16T01:02:58.745Z,1550278978.745 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2019-02-16T01:02:58.766Z,1550278978.766 [Default:A.Wait](DEBUG): Construct Wait.
2019-02-16T01:02:58.768Z,1550278978.768 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2019-02-16T01:02:58.810Z,1550278978.810 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2019-02-16T01:02:58.813Z,1550278978.813 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2019-02-16T01:02:58.843Z,1550278978.843 [Default:E.Execute](DEBUG): Construct Execute.
2019-02-16T01:02:58.862Z,1550278978.862 [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-02-16T01:02:58.867Z,1550278978.867 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,ESPComponent,PAR_Licor,AcousticModem_Benthos_ATM900,Depth_Keller,DropWeight,NAL9602,Onboard,PNI_TCM,BPC1,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-02-16T01:02:58.886Z,1550278978.886 [ESPComponent](INFO): powering down ESP
2019-02-16T01:02:59.207Z,1550278979.207 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-02-16T01:02:59.207Z,1550278979.207 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-02-16T01:02:59.231Z,1550278979.231 [Depth_Keller](ERROR): Pressure reading out of range: 1895.684326 decibar
2019-02-16T01:02:59.298Z,1550278979.298 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-16T01:02:59.332Z,1550278979.332 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-02-16T01:02:59.334Z,1550278979.334 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-02-16T01:02:59.335Z,1550278979.335 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-02-16T01:02:59.342Z,1550278979.342 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-02-16T01:02:59.343Z,1550278979.343 [MassServo](DEBUG): Initializing EZServoServo.
2019-02-16T01:02:59.350Z,1550278979.350 [MassServo](DEBUG): Initializing MassServo.
2019-02-16T01:02:59.351Z,1550278979.351 [RudderServo](DEBUG): Initializing EZServoServo.
2019-02-16T01:02:59.358Z,1550278979.358 [RudderServo](DEBUG): Initializing RudderServo.
2019-02-16T01:02:59.359Z,1550278979.359 [ThrusterServo](DEBUG): Initializing EZServoServo.
2019-02-16T01:02:59.374Z,1550278979.374 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2019-02-16T01:02:59.461Z,1550278979.461 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2019-02-16T01:02:59.477Z,1550278979.477 [DropWeight] Hardware Fault, FailCount= 1
2019-02-16T01:02:59.477Z,1550278979.477 [DropWeight](ERROR): Hardware Fault
2019-02-16T01:02:59.531Z,1550278979.531 [CommandLine](FAULT): Scheduling is paused
2019-02-16T01:02:59.532Z,1550278979.532 [CBIT](INFO): Critical error at 20190216T010259
2019-02-16T01:02:59.532Z,1550278979.532 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2019-02-16T01:02:59.535Z,1550278979.535 [CBIT](ERROR): Hardware Fault in component: DropWeight
2019-02-16T01:02:59.535Z,1550278979.535 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2019-02-16T01:03:00.185Z,1550278980.185 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2019-02-16T01:03:00.186Z,1550278980.186 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2019-02-16T01:03:00.186Z,1550278980.186 [BuoyancyServo] Communications Fault, FailCount= 1
2019-02-16T01:03:00.186Z,1550278980.186 [BuoyancyServo](ERROR): Communications Fault
2019-02-16T01:03:00.391Z,1550278980.391 [CBIT](INFO): Critical error at 20190216T010259
2019-02-16T01:03:00.393Z,1550278980.393 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2019-02-16T01:03:02.133Z,1550278982.133 [Aanderaa_O2](INFO): Powering down
2019-02-16T01:03:02.522Z,1550278982.522 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2019-02-16T01:03:02.522Z,1550278982.522 [BuoyancyServo] No Fault, FailCount= 1
2019-02-16T01:03:02.878Z,1550278982.878 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2019-02-16T01:03:02.994Z,1550278982.994 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-02-16T01:03:02.994Z,1550278982.994 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-02-16T01:03:03.090Z,1550278983.090 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null &
2019-02-16T01:03:06.923Z,1550278986.923 [AcousticModem_Benthos_ATM900](DEBUG): 
2019-02-16T01:03:08.136Z,1550278988.136 [AcousticModem_Benthos_ATM900](DEBUG): Teledyne Benthos ATM-900 Series OEM w/burn wire
2019-02-16T01:03:08.136Z,1550278988.136 [AcousticModem_Benthos_ATM900](DEBUG): MF Frequency Band
2019-02-16T01:03:08.137Z,1550278988.137 [AcousticModem_Benthos_ATM900](DEBUG): Standard version 8.6.3
2019-02-16T01:03:08.535Z,1550278988.535 [AcousticModem_Benthos_ATM900](DEBUG): Feb 11 2019 19:47:46 
2019-02-16T01:03:08.659Z,1550278988.659 [CBIT](CRITICAL): Environmental Failure. Press:14.787616 PSI. Humidity:32%. Temp:24 C. ABORTING MISSION
2019-02-16T01:03:08.935Z,1550278988.935 [AcousticModem_Benthos_ATM900](DEBUG): WARNING: battery low
2019-02-16T01:03:09.019Z,1550278989.019 [CBIT](INFO): Critical error at 20190216T010308
2019-02-16T01:03:09.742Z,1550278989.742 [AcousticModem_Benthos_ATM900](INFO): entering command mode
2019-02-16T01:03:10.146Z,1550278990.146 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2019-02-16T01:03:10.147Z,1550278990.147 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt 1: user:1>
2019-02-16T01:03:10.147Z,1550278990.147 [AcousticModem_Benthos_ATM900](INFO): command mode acknowledged
2019-02-16T01:03:10.550Z,1550278990.550 [AcousticModem_Benthos_ATM900](INFO): setting local address to 3
2019-02-16T01:03:10.958Z,1550278990.958 [AcousticModem_Benthos_ATM900](DEBUG): checking for local address setting acknowledgment
2019-02-16T01:03:10.959Z,1550278990.959 [AcousticModem_Benthos_ATM900](INFO): set local address to 3
2019-02-16T01:03:11.363Z,1550278991.363 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt 2: user:2>
2019-02-16T01:03:12.092Z,1550278992.092 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005782
2019-02-16T01:03:23.152Z,1550279003.152 [SBIT](IMPORTANT): Beginning Startup BIT
2019-02-16T01:03:23.157Z,1550279003.157 [CBIT](IMPORTANT): Beginning ground fault scan
2019-02-16T01:03:26.039Z,1550279006.039 [NAL9602](INFO): Powering up NAL9602
2019-02-16T01:03:34.218Z,1550279014.218 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.008856
CHAN A1 (24V): -0.012563
CHAN A2 (12V): -0.005125
CHAN A3 (5V): -0.002510
CHAN B0 (3.3V): -0.001784
CHAN B1 (3.15aV): -0.001262
CHAN B2 (3.15bV): -0.001255
CHAN B3 (GND): 0.000324
OPEN: 0.004373
Full Scale Calc: 4.765 mA, -1.589 mA
2019-02-16T01:03:36.947Z,1550279016.947 [NAL9602](INFO): NAL9602 initialized
2019-02-16T01:03:37.750Z,1550279017.750 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:04:04.628Z,1550279044.628 [BPC1](FAULT): Failed to parse data from all battery packs.
2019-02-16T01:04:04.628Z,1550279044.628 [BPC1] Data Fault, FailCount= 1
2019-02-16T01:04:04.628Z,1550279044.628 [BPC1](ERROR): Data Fault
2019-02-16T01:04:04.826Z,1550279044.826 [CBIT](ERROR): Data Fault in component: BPC1
2019-02-16T01:04:16.458Z,1550279056.458 [SBIT](IMPORTANT): SBIT PASSED
2019-02-16T01:04:16.547Z,1550279056.547 [CommandLine](IMPORTANT): got command configSet list
2019-02-16T01:04:16.547Z,1550279056.547 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2019-02-16T01:04:16.548Z,1550279056.548 [CommandLine](IMPORTANT): No configSet variables persisted
2019-02-16T01:04:16.845Z,1550279056.845 [MissionManager](IMPORTANT): Started mission Startup
2019-02-16T01:04:16.845Z,1550279056.845 [Startup] Running Loop=1
2019-02-16T01:04:16.845Z,1550279056.845 [Startup](DEBUG): Aggregate::initialize Startup
2019-02-16T01:04:16.845Z,1550279056.845 [Startup:A.GoToSurface] Running Loop=1
2019-02-16T01:04:16.846Z,1550279056.846 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-02-16T01:04:16.846Z,1550279056.846 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-02-16T01:04:16.847Z,1550279056.847 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-02-16T01:04:16.847Z,1550279056.847 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-02-16T01:04:16.847Z,1550279056.847 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-02-16T01:04:16.848Z,1550279056.848 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-02-16T01:04:16.870Z,1550279056.870 [Startup:StartupSatComms] Running Loop=1
2019-02-16T01:04:16.870Z,1550279056.870 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2019-02-16T01:04:16.870Z,1550279056.870 [Startup:StartupSatComms:A] Running Loop=1
2019-02-16T01:04:17.257Z,1550279057.257 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2019-02-16T01:04:58.621Z,1550279098.621 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2019-02-16T01:04:58.621Z,1550279098.621 [Rowe_600LCM] Communications Fault, FailCount= 1
2019-02-16T01:04:58.621Z,1550279098.621 [Rowe_600LCM](ERROR): Communications Fault
2019-02-16T01:04:58.878Z,1550279098.878 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2019-02-16T01:04:59.025Z,1550279099.025 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2019-02-16T01:04:59.116Z,1550279099.116 [Rowe_600LCM](INFO): Powering down
2019-02-16T01:05:00.521Z,1550279100.521 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2019-02-16T01:05:00.521Z,1550279100.521 [Rowe_600LCM] No Fault, FailCount= 1
2019-02-16T01:05:00.730Z,1550279100.730 [Rowe_600LCM](INFO): Initializing
2019-02-16T01:05:00.730Z,1550279100.730 [Rowe_600LCM](INFO): Powering up
2019-02-16T01:05:04.851Z,1550279104.851 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2019-02-16T01:05:04.971Z,1550279104.971 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null &
2019-02-16T01:05:17.037Z,1550279117.037 [Startup:StartupSatComms:A](INFO): Timed out from 2019-02-16T01:04:16.9Z
2019-02-16T01:05:17.037Z,1550279117.037 [Startup:StartupSatComms:A] Stopped
2019-02-16T01:05:17.037Z,1550279117.037 [Startup:StartupSatComms:B] Running Loop=1
2019-02-16T01:05:17.446Z,1550279117.446 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-02-16T01:05:22.473Z,1550279122.473 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20190215T225756/Courier0000.lzma
2019-02-16T01:05:22.923Z,1550279122.923 [CommandLine](IMPORTANT): got command run ./Missions/Insert/Science.xml
2019-02-16T01:05:22.923Z,1550279122.923 [MissionManager](INFO): Loading Mission: ./Missions/Insert/Science.xml
2019-02-16T01:05:23.181Z,1550279123.181 [MissionManager](INFO): DefineArg Science.SampleISUS = 0 bool
2019-02-16T01:05:23.184Z,1550279123.184 [MissionManager](INFO): DefineArg Science.SampleISUSmaxPitch = 60.000000 arcdeg
2019-02-16T01:05:23.187Z,1550279123.187 [MissionManager](INFO): DefineArg Science.SampleISUSminPitch = -60.000000 arcdeg
2019-02-16T01:05:23.190Z,1550279123.190 [MissionManager](INFO): DefineArg Science.PeakDetectChlActive = 0 bool
2019-02-16T01:05:23.193Z,1550279123.193 [MissionManager](INFO): DefineArg Science.TimeWindowPeakReport = nan min
2019-02-16T01:05:23.196Z,1550279123.196 [MissionManager](INFO): DefineArg Science.HighestChlPeakReportActive = 0 bool
2019-02-16T01:05:23.199Z,1550279123.199 [MissionManager](INFO): DefineArg Science.PatchTracking = 0 bool
2019-02-16T01:05:23.202Z,1550279123.202 [MissionManager](INFO): DefineArg Science.FilterWidthHorizontal = 3.000000 count
2019-02-16T01:05:23.205Z,1550279123.205 [MissionManager](INFO): DefineArg Science.NumProfilesSlidingwindow = 100.000000 count
2019-02-16T01:05:23.208Z,1550279123.208 [MissionManager](INFO): DefineArg Science.OffPeakFractionHorizontal = 80.000000 %
2019-02-16T01:05:23.211Z,1550279123.211 [MissionManager](INFO): DefineArg Science.PeakDetectNO3Active = 0 bool
2019-02-16T01:05:23.214Z,1550279123.214 [MissionManager](INFO): DefineArg Science.PeakDetectOilActive = 0 bool
2019-02-16T01:05:23.216Z,1550279123.216 [MissionManager](INFO): DefineArg Science.PeakDetectFDOMActive = 0 bool
2019-02-16T01:05:23.219Z,1550279123.219 [MissionManager](INFO): DefineArg Science.UpwardDerivativeOfTemperatureActive = 0 bool
2019-02-16T01:05:23.223Z,1550279123.223 [MissionManager](INFO): DefineArg Science.EnabledAanderaaO2 = 1.000000 bool
2019-02-16T01:05:23.226Z,1550279123.226 [MissionManager](INFO): DefineArg Science.EnabledNeilBrown = 0.000000 bool
2019-02-16T01:05:23.230Z,1550279123.230 [MissionManager](INFO): DefineArg Science.EnabledSeabird = 1.000000 bool
2019-02-16T01:05:23.233Z,1550279123.233 [MissionManager](INFO): DefineArg Science.EnabledTurbulence_NPS = 0.000000 bool
2019-02-16T01:05:23.237Z,1550279123.237 [MissionManager](INFO): DefineArg Science.EnabledWetLabsBB2FL = 1.000000 bool
2019-02-16T01:05:23.240Z,1550279123.240 [MissionManager](INFO): DefineArg Science.EnabledWetLabsSeaOWL_UV_A = 0.000000 bool
2019-02-16T01:05:23.244Z,1550279123.244 [MissionManager](INFO): DefineArg Science.EnabledWetLabsUBAT = 0.000000 bool
2019-02-16T01:05:23.267Z,1550279123.267 [DataOverHttps](INFO): Moved sent file to Logs/20190215T225756/Courier0000.lzma.bak
2019-02-16T01:05:23.267Z,1550279123.267 [DataOverHttps](INFO): SBD MOMSN=9925026
2019-02-16T01:05:23.298Z,1550279123.298 [MissionManager](INFO): DefineArg Science.EnabledISUS = 0.000000 bool
2019-02-16T01:05:23.301Z,1550279123.301 [MissionManager](INFO): DefineArg Science.LowPassWindowLength = 20.000000 count
2019-02-16T01:05:23.304Z,1550279123.304 [MissionManager](INFO): DefineArg Science.PeakChlShallowBound = nan m
2019-02-16T01:05:23.324Z,1550279123.324 [MissionManager](INFO): DefineArg Science.PeakChlDeepBound = nan m
2019-02-16T01:05:23.327Z,1550279123.327 [MissionManager](INFO): DefineArg Science.PeakShallowBound = nan m
2019-02-16T01:05:23.330Z,1550279123.330 [MissionManager](INFO): DefineArg Science.PeakDeepBound = nan m
2019-02-16T01:05:23.333Z,1550279123.333 [MissionManager](INFO): DefineOutput Science.PeakChl = 0.000000 ug/l
2019-02-16T01:05:23.347Z,1550279123.347 [MissionManager](INFO): DefineOutput Science.PeakChlDepth = 0.000000 m
2019-02-16T01:05:23.351Z,1550279123.351 [MissionManager](INFO): DefineOutput Science.PeakChlTemperature = 0.000000 degC
2019-02-16T01:05:23.366Z,1550279123.366 [MissionManager](INFO): DefineOutput Science.PeakChlLatitude = nan arcdeg
2019-02-16T01:05:23.369Z,1550279123.369 [MissionManager](INFO): DefineOutput Science.PeakChlLongitude = nan arcdeg
2019-02-16T01:05:23.372Z,1550279123.372 [MissionManager](INFO): DefineOutput Science.PeakNO3 = 0.000000 umol/l
2019-02-16T01:05:23.376Z,1550279123.376 [MissionManager](INFO): DefineOutput Science.PeakNO3Depth = 0.000000 m
2019-02-16T01:05:23.409Z,1550279123.409 [MissionManager](INFO): DefineOutput Science.PeakNO3Latitude = nan arcdeg
2019-02-16T01:05:23.413Z,1550279123.413 [MissionManager](INFO): DefineOutput Science.PeakNO3Longitude = nan arcdeg
2019-02-16T01:05:23.428Z,1550279123.428 [MissionManager](INFO): DefineOutput Science.PatchChl = 0.000000 m
2019-02-16T01:05:23.434Z,1550279123.434 [MissionManager](INFO): DefineOutput Science.PatchChlDepth = 0.000000 m
2019-02-16T01:05:23.438Z,1550279123.438 [MissionManager](INFO): DefineOutput Science.PatchChlLatitude = nan arcdeg
2019-02-16T01:05:23.441Z,1550279123.441 [MissionManager](INFO): DefineOutput Science.PatchChlLongitude = nan arcdeg
2019-02-16T01:05:23.444Z,1550279123.444 [MissionManager](INFO): DefineOutput Science.PatchChlDistance = nan m
2019-02-16T01:05:23.519Z,1550279123.519 [MissionManager](INFO): DefineOutput Science.PeakOil = 0.000000 kg/m3
2019-02-16T01:05:23.528Z,1550279123.528 [MissionManager](INFO): DefineOutput Science.PeakOilDepth = 0.000000 m
2019-02-16T01:05:23.547Z,1550279123.547 [MissionManager](INFO): DefineOutput Science.PeakOilLatitude = nan arcdeg
2019-02-16T01:05:23.559Z,1550279123.559 [MissionManager](INFO): DefineOutput Science.PeakOilLongitude = nan arcdeg
2019-02-16T01:05:23.574Z,1550279123.574 [MissionManager](INFO): DefineOutput Science.PeakFDOM = 0.000000 ppb
2019-02-16T01:05:23.578Z,1550279123.578 [MissionManager](INFO): DefineOutput Science.PeakFDOMDepth = 0.000000 m
2019-02-16T01:05:23.581Z,1550279123.581 [MissionManager](INFO): DefineOutput Science.PeakFDOMLatitude = nan arcdeg
2019-02-16T01:05:23.589Z,1550279123.589 [MissionManager](INFO): DefineOutput Science.PeakFDOMLongitude = nan arcdeg
2019-02-16T01:05:23.599Z,1550279123.599 [MissionManager](INFO): DefineOutput Science.PatchFDOMDistance = nan m
2019-02-16T01:05:23.642Z,1550279123.642 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2019-02-16T01:05:23.668Z,1550279123.668 [Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2019-02-16T01:05:23.739Z,1550279123.739 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2019-02-16T01:05:23.772Z,1550279123.772 [Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2019-02-16T01:05:23.812Z,1550279123.812 [Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2019-02-16T01:05:23.936Z,1550279123.936 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<!-- ====================
     Generated by TethysL
     ==================== -->
<Aggregate xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
           xmlns="Tethys"
           xmlns:Units="Tethys/Units"
           xmlns:Science="Tethys/Science"
           xmlns:Universal="Tethys/Universal"
           xmlns:Trigger="Tethys/Trigger"
           xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                               Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                               Tethys/Science http://okeanids.mbari.org/tethys/Xml/Science.xsd
                               Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd
                               Tethys/Trigger http://okeanids.mbari.org/tethys/Xml/Trigger.xsd"
       Id="Science">

    <DefineArg Name="SampleISUS"><Description>
        Set either this or PeakDetectNO3Active to True in order to sample
        Nitrate. EnabledISUS must also be true.
    </Description><False/></DefineArg>

    <DefineArg Name="SampleISUSmaxPitch"><Description>
        Maximum pitch to sample ISUS. (EnabledISUS must also be true.)
    </Description><Units:degree/><Value>60.0</Value></DefineArg>

    <DefineArg Name="SampleISUSminPitch"><Description>
        Minimum pitch to sample ISUS. (EnabledISUS must also be true.)
    </Description><Units:degree/><Value>-60.0</Value></DefineArg>

    <DefineArg Name="PeakDetectChlActive"><Description>
        Turns on peak detection of Cholorphyll.
    </Description><False/></DefineArg>

    <DefineArg Name="TimeWindowPeakReport"><Description>
        If greater than zero, report a peak every window. If NaN or zero, this
        variable is ignored.
    </Description><Units:minute/><Value>NaN</Value></DefineArg>

    <DefineArg Name="HighestChlPeakReportActive"><Description>
        Turns on reporting of the highest peak value on yo-yo profiles in a
        horizontal sliding window (of length numProfilesSlidingwindow)
    </Description><False/></DefineArg>

    <DefineArg Name="PatchTracking"><Description>
        If tracking a patch
    </Description><False/></DefineArg>

<!--debug
    </Description><True/></DefineArg>
-->

    <DefineArg Name="FilterWidthHorizontal"><Description>
        Width of boxcar filter applied to yoyo-wise chl peaks to pick out the
        highest peak.
    </Description><Units:count/><Value>3</Value></DefineArg>

    <DefineArg Name="NumProfilesSlidingwindow"><Description>
        Length of horizontal sliding window. The highest yoyo-wise chl peak
        (after low-pass filtering by a filter of length FilterWidthHorizontal)
        within this window.
    </Description><Units:count/><Value>100</Value></DefineArg>

    <DefineArg Name="OffPeakFractionHorizontal"><Description>
        When filtered horizontal value is this fraction of the peak, consider it
        outside the patch.
    </Description><Units:percent/><Value>80</Value></DefineArg>

    <DefineArg Name="PeakDetectNO3Active"><Description>
        Turns on peak detection of Nitrate (and turns on ISUS).
    </Description><False/></DefineArg>

    <DefineArg Name="PeakDetectOilActive"><Description>
        Turns on peak detection of Dissolved Oil.
    </Description><False/></DefineArg>

    <DefineArg Name="PeakDetectFDOMActive"><Description>
        Turns on peak detection of concentration_of_colored_dissolved_organic_matter_in_sea_water_expressed_as_equivalent_mass_fraction_of_quinine_sulfate_dihydrate from FDOM sensor.
    </Description><False/></DefineArg>
    
    <DefineArg Name="UpwardDerivativeOfTemperatureActive"><Description>
        Turns on seawater temperature derivative.
    </Description><False/></DefineArg>

    <DefineArg Name="EnabledAanderaaO2"><Description>
        Automatically set to True if the Aanderaa O2 sensor is installed. Set to
        false to disable reading Aandera O2.
    </Description><Science:Aanderaa_O2.loadAtStartup/></DefineArg>

    <DefineArg Name="EnabledNeilBrown"><Description>
        Automatically set to true if the Neil Brown CTD is enabled. Set to false
        to disable reading from the Neil Brown.
    </Description><Science:CTD_NeilBrown.loadAtStartup/></DefineArg>

    <DefineArg Name="EnabledSeabird"><Description>
        Automatically set to true if the CTD is enabled. Set to false to disable
        reading from the CTD.
    </Description><Science:CTD_Seabird.loadAtStartup/></DefineArg>

    <DefineArg Name="EnabledTurbulence_NPS"><Description>
        Automatically set to true if the NPS Turbulence sensor is enabled. Set
        to false to disable reading from the NPS Turbulence sensor.
    </Description><Science:Turbulence_NPS.loadAtStartup/></DefineArg>

    <DefineArg Name="EnabledWetLabsBB2FL"><Description>
        Automatically set to true if the the WetLabs BB2FL is enabled. Set to
        false to disable the WetLabs BB2FL.
    </Description><Science:WetLabsBB2FL.loadAtStartup/></DefineArg>

    <DefineArg Name="EnabledWetLabsSeaOWL_UV_A"><Description>
        Automatically set to true if the the WetLabs SeaOWL UV-A is enabled. Set
        to false to disable the WetLabs SeaOWL UV-A.
    </Description><Science:WetLabsSeaOWL_UV_A.loadAtStartup/></DefineArg>

    <DefineArg Name="EnabledWetLabsUBAT"><Description>
        Automatically set to true if the the WetLabs UBAT is enabled. Set
        to false to disable the WetLabs UBAT.
    </Description><Science:WetLabsUBAT.loadAtStartup/></DefineArg>    

    <DefineArg Name="EnabledISUS"><Description>
        Automatically set to True if ISUS is enabled. Set to false to disable
        ISUS.
    </Description><Science:ISUS.loadAtStartup/></DefineArg>

    <DefineArg Name="LowPassWindowLength"><Description>
        Low-pass window length (based on depth sensor sampling interval 0.4
        second) for low-pass filtering.
    </Description><Units:count/><Value>20</Value></DefineArg>

    <DefineArg Name="PeakChlShallowBound"><Description>
        Shallow depth bound for detecting chl peak on each descent or ascent
        profile.
    </Description><Units:meter/><Value>NaN</Value></DefineArg>

<!--debug
    </Description><Units:meter/><Value>10</Value></DefineArg>
-->

    <DefineArg Name="PeakChlDeepBound"><Description>
        Deep depth bound for detecting chl peak on each descent or ascent
        profile.
    </Description><Units:meter/><Value>NaN</Value></DefineArg>

<!--debug
    </Description><Units:meter/><Value>20</Value></DefineArg>
-->

    <DefineArg Name="PeakShallowBound"><Description>
        Shallow depth bound for detecting any peak on each descent or ascent
        profile.
    </Description><Units:meter/><Value>NaN</Value></DefineArg>

    <DefineArg Name="PeakDeepBound"><Description>
        Deep depth bound for detecting any peak on each descent or ascent
        profile.
    </Description><Units:meter/><Value>NaN</Value></DefineArg>

    <DefineOutput Name="PeakChl"><Units:microgram_per_liter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakChlDepth"><Units:meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakChlTemperature"><Units:celsius/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakChlLatitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PeakChlLongitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PeakNO3"><Units:micromole_per_liter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakNO3Depth"><Units:meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakNO3Latitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PeakNO3Longitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PatchChl"><Units:meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PatchChlDepth"><Units:meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PatchChlLatitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PatchChlLongitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PatchChlDistance"><Units:meter/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PeakOil"><Units:kilogram_per_cubic_meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakOilDepth"><Units:meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakOilLatitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PeakOilLongitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PeakFDOM"><Units:part_per_billion/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakFDOMDepth"><Units:meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakFDOMLatitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PeakFDOMLongitude"><Units:degree/><Value>NaN</Value></DefineOutput>
    
    <DefineOutput Name="PatchFDOMDistance"><Units:meter/><Value>NaN</Value></DefineOutput>    
    
    <Parallel/>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledAanderaaO2"/>
        </While>
        <Universal:mass_concentration_of_oxygen_in_sea_water/>
    </ReadData>

    <ReadData>
        <While>
            <Arg Name="EnabledISUS"/>
            <And><Universal:platform_pitch_angle/><Lt><Arg Name="SampleISUSmaxPitch"/></Lt><And><Universal:platform_pitch_angle/><Gt><Arg Name="SampleISUSminPitch"/></Gt><And><Arg Name="SampleISUS"/><Or><Arg Name="PeakDetectNO3Active"/></Or></And></And></And>
        </While>
        <Universal:mole_concentration_of_nitrate_in_sea_water/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledNeilBrown"/>
            <Or><Arg Name="EnabledSeabird"/></Or>
        </While>
        <Universal:sea_water_temperature/>
        <Universal:sea_water_salinity/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledSeabird"/>
        </While>
        <Science:CTD_Seabird.sea_water_temperature/>
        <Science:CTD_Seabird.sea_water_salinity/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledNeilBrown"/>
            <Or><Arg Name="EnabledSeabird"/></Or>
            <And><Arg Name="UpwardDerivativeOfTemperatureActive"/></And>
        </While>
        <Universal:upward_derivative_of_sea_water_temperature/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledTurbulence_NPS"/>
        </While>
        <Science:Turbulence_NPS.MicroCond/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledWetLabsBB2FL"/>
            <Or><Arg Name="PeakDetectChlActive"/></Or>
        </While>
        <Universal:mass_concentration_of_chlorophyll_in_sea_water/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledWetLabsUBAT"/>
        </While>
        <Science:WetLabsUBAT.biolum_potential/>
    </ReadData>

<!--debug-->

    <ReadData Id="Read_Oil" Strategy="MinError">
        <While>
            <Arg Name="EnabledWetLabsSeaOWL_UV_A"/>
            <Or><Arg Name="PeakDetectOilActive"/></Or>
        </While>
        <Universal:mass_concentration_of_chlorophyll_in_sea_water/>
    </ReadData>

    <Aggregate Id="PeakDetectChl">

        <While>
            <Arg Name="PeakDetectChlActive"/>
        </While>

        <Trigger:PeakDetectVsDepth>
            <Sequence/>
            <Setting><Trigger:PeakDetectVsDepth.detect/><Universal:mass_concentration_of_chlorophyll_in_sea_water/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.timeWindowPeakReport/><Arg Name="TimeWindowPeakReport"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.windowLength/><Arg Name="LowPassWindowLength"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.shallowBound/><Arg Name="PeakChlShallowBound"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.deepBound/><Arg Name="PeakChlDeepBound"/></Setting>
            <OutputArg Name="PeakChl"><Trigger:PeakDetectVsDepth.peakDetect/></OutputArg>
            <OutputArg Name="PeakChlDepth"><Trigger:PeakDetectVsDepth.peakDepth/></OutputArg>
            <OutputArg Name="PeakChlTemperature"><Trigger:PeakDetectVsDepth.peakTemperature/></OutputArg>
            <OutputArg Name="PeakChlLatitude"><Trigger:PeakDetectVsDepth.peakLatitude/></OutputArg>
            <OutputArg Name="PeakChlLongitude"><Trigger:PeakDetectVsDepth.peakLongitude/></OutputArg>
        </Trigger:PeakDetectVsDepth>

<!--debug
        <Syslog Severity="Important">PeakChl, PeakChlLatitude, PeakChlLongitude = <Arg Name="PeakChl"/><Units:microgram_per_liter/>, <Arg Name="PeakChlLatitude"/><Units:degree/>, <Arg Name="PeakChlLongitude"/><Units:degree/></Syslog>
-->

        <SendData Service="Express"><Arg Name="PeakChl"/><Arg Name="PeakChlDepth"/>
        </SendData>

    </Aggregate>

    <Aggregate Id="HighestChlPeakReport">

        <While>
            <Arg Name="HighestChlPeakReportActive"/>
        </While>

        <Trigger:PeakDetectHorizontal>
            <Sequence/>
            <Setting><Trigger:PeakDetectHorizontal.detectFrom/><Arg Name="PeakChl"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.depthFrom/><Arg Name="PeakChlDepth"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.latitudeFrom/><Arg Name="PeakChlLatitude"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.longitudeFrom/><Arg Name="PeakChlLongitude"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.patchTracking/><Arg Name="PatchTracking"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.filterWidth/><Arg Name="FilterWidthHorizontal"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.numProfilesSlidingwindow/><Arg Name="NumProfilesSlidingwindow"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.offPeakFraction/><Arg Name="OffPeakFractionHorizontal"/></Setting>
            <OutputArg Name="PatchChl"><Trigger:PeakDetectHorizontal.peakDetect/></OutputArg>
            <OutputArg Name="PatchChlDepth"><Trigger:PeakDetectHorizontal.peakDepth/></OutputArg>
            <OutputArg Name="PatchChlLatitude"><Trigger:PeakDetectHorizontal.peakLatitude/></OutputArg>
            <OutputArg Name="PatchChlLongitude"><Trigger:PeakDetectHorizontal.peakLongitude/></OutputArg>
            <OutputArg Name="PatchChlDistance"><Trigger:PeakDetectHorizontal.peakDistance/></OutputArg>
        </Trigger:PeakDetectHorizontal>

    </Aggregate>

    <Aggregate Id="PeakDetectNO3">

        <While>
            <Arg Name="PeakDetectNO3Active"/>
        </While>

        <Trigger:PeakDetectVsDepth>
            <Sequence/>
            <Setting><Trigger:PeakDetectVsDepth.detect/><Universal:mole_concentration_of_nitrate_in_sea_water/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.timeWindowPeakReport/><Arg Name="TimeWindowPeakReport"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.windowLength/><Arg Name="LowPassWindowLength"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.shallowBound/><Arg Name="PeakShallowBound"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.deepBound/><Arg Name="PeakDeepBound"/></Setting>
            <OutputArg Name="PeakNO3"><Trigger:PeakDetectVsDepth.peakDetect/></OutputArg>
            <OutputArg Name="PeakNO3Depth"><Trigger:PeakDetectVsDepth.peakDepth/></OutputArg>
            <OutputArg Name="PeakNO3Latitude"><Trigger:PeakDetectVsDepth.peakLatitude/></OutputArg>
            <OutputArg Name="PeakNO3Longitude"><Trigger:PeakDetectVsDepth.peakLongitude/></OutputArg>
        </Trigger:PeakDetectVsDepth>

        <SendData Service="Express"><Arg Name="PeakNO3"/><Arg Name="PeakNO3Depth"/>
        </SendData>

    </Aggregate>

    <Aggregate Id="PeakDetectOil">

        <While>
            <Arg Name="PeakDetectOilActive"/>
        </While>

        <Trigger:PeakDetectVsDepth>
            <Sequence/>
            <Setting><Trigger:PeakDetectVsDepth.detect/><Universal:mass_concentration_of_petroleum_hydrocarbons_in_sea_water/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.timeWindowPeakReport/><Arg Name="TimeWindowPeakReport"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.windowLength/><Arg Name="LowPassWindowLength"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.shallowBound/><Arg Name="PeakShallowBound"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.deepBound/><Arg Name="PeakDeepBound"/></Setting>
            <OutputArg Name="PeakOil"><Trigger:PeakDetectVsDepth.peakDetect/></OutputArg>
            <OutputArg Name="PeakOilDepth"><Trigger:PeakDetectVsDepth.peakDepth/></OutputArg>
            <OutputArg Name="PeakOilLatitude"><Trigger:PeakDetectVsDepth.peakLatitude/></OutputArg>
            <OutputArg Name="PeakOilLongitude"><Trigger:PeakDetectVsDepth.peakLongitude/></OutputArg>
        </Trigger:PeakDetectVsDepth>

        <SendData Service="Express"><Arg Name="PeakOil"/><Arg Name="PeakOilDepth"/>
        </SendData>

    </Aggregate>

    <Aggregate Id="PeakDetectFDOM">

        <While>
            <Arg Name="PeakDetectFDOMActive"/>
        </While>

        <Trigger:PeakDetectVsDepth>
            <Sequence/>
            <Setting><Trigger:PeakDetectVsDepth.detect/><Universal:concentration_of_colored_dissolved_organic_matter_in_sea_water_expressed_as_equivalent_mass_fraction_of_quinine_sulfate_dihydrate/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.timeWindowPeakReport/><Arg Name="TimeWindowPeakReport"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.windowLength/><Arg Name="LowPassWindowLength"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.shallowBound/><Arg Name="PeakShallowBound"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.deepBound/><Arg Name="PeakDeepBound"/></Setting>
            <OutputArg Name="PeakFDOM"><Trigger:PeakDetectVsDepth.peakDetect/></OutputArg>
            <OutputArg Name="PeakFDOMDepth"><Trigger:PeakDetectVsDepth.peakDepth/></OutputArg>
            <OutputArg Name="PeakFDOMTemperature"><Trigger:PeakDetectVsDepth.peakTemperature/></OutputArg>
            <OutputArg Name="PeakFDOMLatitude"><Trigger:PeakDetectVsDepth.peakLatitude/></OutputArg>
            <OutputArg Name="PeakFDOMLongitude"><Trigger:PeakDetectVsDepth.peakLongitude/></OutputArg>
        </Trigger:PeakDetectVsDepth>

        <SendData Service="Express"><Arg Name="PeakFDOM"/><Arg Name="PeakFDOMDepth"/>
        </SendData>

    </Aggregate>

</Aggregate>


2019-02-16T01:05:23.947Z,1550279123.947 [CommandLine](IMPORTANT): Running ./Missions/Insert/Science.xml
2019-02-16T01:05:35.509Z,1550279135.509 [DataOverHttps](INFO): Sending 213 bytes from file Logs/20190216T010247/Courier0000.lzma
2019-02-16T01:05:36.315Z,1550279136.315 [DataOverHttps](INFO): Moved sent file to Logs/20190216T010247/Courier0000.lzma.bak
2019-02-16T01:05:36.315Z,1550279136.315 [DataOverHttps](INFO): SBD MOMSN=9925029
2019-02-16T01:05:50.233Z,1550279150.233 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20190215T225756/Express0001.lzma
2019-02-16T01:05:51.039Z,1550279151.039 [DataOverHttps](INFO): Moved sent file to Logs/20190215T225756/Express0001.lzma.bak
2019-02-16T01:05:51.039Z,1550279151.039 [DataOverHttps](INFO): SBD MOMSN=9925035
2019-02-16T01:05:58.652Z,1550279158.652 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2019-02-16T01:05:58.652Z,1550279158.652 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-02-16T01:05:58.654Z,1550279158.654 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2019-02-16T01:05:58.654Z,1550279158.654 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-02-16T01:05:58.655Z,1550279158.655 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2019-02-16T01:05:58.655Z,1550279158.655 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-02-16T01:05:58.665Z,1550279158.665 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-02-16T01:05:58.666Z,1550279158.666 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-02-16T01:05:58.666Z,1550279158.666 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-02-16T01:05:59.083Z,1550279159.083 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-02-16T01:05:59.083Z,1550279159.083 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2019-02-16T01:05:59.083Z,1550279159.083 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-02-16T01:05:59.083Z,1550279159.083 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2019-02-16T01:05:59.084Z,1550279159.084 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-02-16T01:05:59.084Z,1550279159.084 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2019-02-16T01:05:59.479Z,1550279159.479 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-02-16T01:06:03.722Z,1550279163.722 [DataOverHttps](INFO): Sending 783 bytes from file Logs/20190216T010247/Express0001.lzma
2019-02-16T01:06:04.527Z,1550279164.527 [DataOverHttps](INFO): Moved sent file to Logs/20190216T010247/Express0001.lzma.bak
2019-02-16T01:06:04.527Z,1550279164.527 [DataOverHttps](INFO): SBD MOMSN=9925037
2019-02-16T01:06:05.128Z,1550279165.128 [Startup:StartupSatComms:B] Stopped
2019-02-16T01:06:05.129Z,1550279165.129 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2019-02-16T01:06:05.129Z,1550279165.129 [Startup:StartupSatComms] Stopped
2019-02-16T01:06:05.129Z,1550279165.129 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2019-02-16T01:06:05.130Z,1550279165.130 [Startup](INFO): Completed Startup
2019-02-16T01:06:05.130Z,1550279165.130 [MissionManager](INFO): Startup is completed.
2019-02-16T01:06:05.130Z,1550279165.130 [MissionManager](INFO): Uninitializing Mission Startup
2019-02-16T01:06:05.130Z,1550279165.130 [Startup] Stopped
2019-02-16T01:06:05.131Z,1550279165.131 [Startup](DEBUG): Aggregate::uninitialize Startup
2019-02-16T01:06:05.131Z,1550279165.131 [Startup:A.GoToSurface] Stopped
2019-02-16T01:06:05.131Z,1550279165.131 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-02-16T01:06:05.532Z,1550279165.532 [MissionManager](IMPORTANT): Started mission Science
2019-02-16T01:06:05.532Z,1550279165.532 [Science] Running Loop=1
2019-02-16T01:06:05.532Z,1550279165.532 [Science](DEBUG): Aggregate::initialize Science
2019-02-16T01:06:05.532Z,1550279165.532 [Science:A] Running Loop=1
2019-02-16T01:06:05.532Z,1550279165.532 [Science:B] Running Loop=1
2019-02-16T01:06:05.532Z,1550279165.532 [Science:C] Running Loop=1
2019-02-16T01:06:05.532Z,1550279165.532 [Science:D] Running Loop=1
2019-02-16T01:06:05.532Z,1550279165.532 [Science:E] Running Loop=1
2019-02-16T01:06:05.533Z,1550279165.533 [Science:F] Running Loop=1
2019-02-16T01:06:05.533Z,1550279165.533 [Science:G] Running Loop=1
2019-02-16T01:06:05.533Z,1550279165.533 [Science:H] Running Loop=1
2019-02-16T01:06:05.533Z,1550279165.533 [Science:Read_Oil] Running Loop=1
2019-02-16T01:06:05.533Z,1550279165.533 [Science:PeakDetectChl] Running Loop=1
2019-02-16T01:06:05.533Z,1550279165.533 [Science:PeakDetectChl](DEBUG): Aggregate::initialize Science:PeakDetectChl
2019-02-16T01:06:05.533Z,1550279165.533 [Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1
2019-02-16T01:06:05.533Z,1550279165.533 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize.
2019-02-16T01:06:05.535Z,1550279165.535 [Science:HighestChlPeakReport] Running Loop=1
2019-02-16T01:06:05.535Z,1550279165.535 [Science:HighestChlPeakReport](DEBUG): Aggregate::initialize Science:HighestChlPeakReport
2019-02-16T01:06:05.535Z,1550279165.535 [Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1
2019-02-16T01:06:05.536Z,1550279165.536 [Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2019-02-16T01:06:05.536Z,1550279165.536 [Science:PeakDetectNO3] Running Loop=1
2019-02-16T01:06:05.536Z,1550279165.536 [Science:PeakDetectNO3](DEBUG): Aggregate::initialize Science:PeakDetectNO3
2019-02-16T01:06:05.536Z,1550279165.536 [Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1
2019-02-16T01:06:05.536Z,1550279165.536 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize.
2019-02-16T01:06:05.538Z,1550279165.538 [Science:PeakDetectOil] Running Loop=1
2019-02-16T01:06:05.539Z,1550279165.539 [Science:PeakDetectOil](DEBUG): Aggregate::initialize Science:PeakDetectOil
2019-02-16T01:06:05.539Z,1550279165.539 [Science:PeakDetectOil:A.PeakDetectVsDepth] Running Loop=1
2019-02-16T01:06:05.539Z,1550279165.539 [Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Initialize.
2019-02-16T01:06:05.541Z,1550279165.541 [Science:PeakDetectFDOM] Running Loop=1
2019-02-16T01:06:05.541Z,1550279165.541 [Science:PeakDetectFDOM](DEBUG): Aggregate::initialize Science:PeakDetectFDOM
2019-02-16T01:06:05.541Z,1550279165.541 [Science:PeakDetectFDOM:A.PeakDetectVsDepth] Running Loop=1
2019-02-16T01:06:05.542Z,1550279165.542 [Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Initialize.
2019-02-16T01:06:05.544Z,1550279165.544 [Science:PeakDetectFDOM] Stopped
2019-02-16T01:06:05.544Z,1550279165.544 [Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize Science:PeakDetectFDOM
2019-02-16T01:06:05.544Z,1550279165.544 [Science:PeakDetectFDOM:A.PeakDetectVsDepth] Stopped
2019-02-16T01:06:05.545Z,1550279165.545 [Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2019-02-16T01:06:05.545Z,1550279165.545 [Science:PeakDetectOil] Stopped
2019-02-16T01:06:05.545Z,1550279165.545 [Science:PeakDetectOil](DEBUG): Aggregate::uninitialize Science:PeakDetectOil
2019-02-16T01:06:05.545Z,1550279165.545 [Science:PeakDetectOil:A.PeakDetectVsDepth] Stopped
2019-02-16T01:06:05.545Z,1550279165.545 [Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2019-02-16T01:06:05.545Z,1550279165.545 [Science:PeakDetectNO3] Stopped
2019-02-16T01:06:05.545Z,1550279165.545 [Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize Science:PeakDetectNO3
2019-02-16T01:06:05.545Z,1550279165.545 [Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped
2019-02-16T01:06:05.545Z,1550279165.545 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2019-02-16T01:06:05.545Z,1550279165.545 [Science:HighestChlPeakReport] Stopped
2019-02-16T01:06:05.546Z,1550279165.546 [Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize Science:HighestChlPeakReport
2019-02-16T01:06:05.546Z,1550279165.546 [Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped
2019-02-16T01:06:05.546Z,1550279165.546 [Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2019-02-16T01:06:05.546Z,1550279165.546 [Science:PeakDetectChl] Stopped
2019-02-16T01:06:05.546Z,1550279165.546 [Science:PeakDetectChl](DEBUG): Aggregate::uninitialize Science:PeakDetectChl
2019-02-16T01:06:05.546Z,1550279165.546 [Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped
2019-02-16T01:06:05.546Z,1550279165.546 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2019-02-16T01:06:05.546Z,1550279165.546 [Science:Read_Oil] Stopped
2019-02-16T01:06:05.546Z,1550279165.546 [Science:H] Stopped
2019-02-16T01:06:05.546Z,1550279165.546 [Science:G] Running Loop=1
2019-02-16T01:06:05.547Z,1550279165.547 [Science:G](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2019-02-16T01:06:05.547Z,1550279165.547 [Science:F] Stopped
2019-02-16T01:06:05.547Z,1550279165.547 [Science:E] Stopped
2019-02-16T01:06:05.547Z,1550279165.547 [Science:D] Running Loop=1
2019-02-16T01:06:05.548Z,1550279165.548 [Science:D](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_temperature
2019-02-16T01:06:05.548Z,1550279165.548 [Science:D](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_salinity
2019-02-16T01:06:05.549Z,1550279165.549 [Science:C] Running Loop=1
2019-02-16T01:06:05.549Z,1550279165.549 [Science:C](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature
2019-02-16T01:06:05.550Z,1550279165.550 [Science:C](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity
2019-02-16T01:06:05.550Z,1550279165.550 [Science:B] Stopped
2019-02-16T01:06:05.550Z,1550279165.550 [Science:A] Running Loop=1
2019-02-16T01:06:05.551Z,1550279165.551 [Science:A](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_oxygen_in_sea_water
2019-02-16T01:06:05.975Z,1550279165.975 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=2
2019-02-16T01:06:05.975Z,1550279165.975 [WetLabsBB2FL](INFO): Powering up
2019-02-16T01:06:06.207Z,1550279166.207 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-02-16T01:06:09.219Z,1550279169.219 [CTD_Seabird](ERROR): Failed to parse device response: <!--startlogging-->
2019-02-16T01:06:19.563Z,1550279179.563 [CommandLine](IMPORTANT): got command maintain sensor Depth_Keller.depth 3.000000 meter
2019-02-16T01:06:19.565Z,1550279179.565 [ComponentRegistry](DEBUG): SyncComponent "Maintain_Depth_Keller.depth" handled in the control thread.
2019-02-16T01:06:19.724Z,1550279179.724 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,ESPComponent,PAR_Licor,AcousticModem_Benthos_ATM900,Depth_Keller,DropWeight,NAL9602,Onboard,PNI_TCM,BPC1,PAR_Licor,Depth_Keller,Maintain_Depth_Keller.depth,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-02-16T01:06:24.279Z,1550279184.279 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:06:28.295Z,1550279188.295 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:06:30.303Z,1550279190.303 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:06:33.316Z,1550279193.316 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:06:40.378Z,1550279200.378 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:06:44.382Z,1550279204.382 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:06:45.390Z,1550279205.390 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:06:47.384Z,1550279207.384 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:06:50.395Z,1550279210.395 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:06:54.012Z,1550279214.012 [CommandLine](IMPORTANT): got command report
2019-02-16T01:06:54.412Z,1550279214.412 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:07:00.436Z,1550279220.436 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:07:01.225Z,1550279221.225 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2019-02-16T01:07:01.225Z,1550279221.225 [Rowe_600LCM] Communications Fault, FailCount= 2
2019-02-16T01:07:01.225Z,1550279221.225 [Rowe_600LCM](ERROR): Communications Fault
2019-02-16T01:07:01.324Z,1550279221.324 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2019-02-16T01:07:01.443Z,1550279221.443 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:07:01.630Z,1550279221.630 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2019-02-16T01:07:01.813Z,1550279221.813 [Rowe_600LCM](INFO): Powering down
2019-02-16T01:07:03.327Z,1550279223.327 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2019-02-16T01:07:03.327Z,1550279223.327 [Rowe_600LCM] No Fault, FailCount= 2
2019-02-16T01:07:03.430Z,1550279223.430 [Rowe_600LCM](INFO): Initializing
2019-02-16T01:07:03.431Z,1550279223.431 [Rowe_600LCM](INFO): Powering up
2019-02-16T01:07:06.463Z,1550279226.463 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:07:07.633Z,1550279227.633 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2019-02-16T01:07:07.781Z,1550279227.781 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null &
2019-02-16T01:07:08.468Z,1550279228.468 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:07:11.487Z,1550279231.487 [CommandLine](IMPORTANT): got command report touch depth
2019-02-16T01:07:11.803Z,1550279231.803 [Reporter](INFO): depth 3.000000 m
2019-02-16T01:07:12.206Z,1550279232.206 [Reporter](INFO): depth 3.000000 m
2019-02-16T01:07:12.599Z,1550279232.599 [Reporter](INFO): depth 3.000000 m
2019-02-16T01:07:13.004Z,1550279233.004 [Reporter](INFO): depth 3.000000 m
2019-02-16T01:07:13.426Z,1550279233.426 [Reporter](INFO): depth 3.000000 m
2019-02-16T01:07:13.812Z,1550279233.812 [Reporter](INFO): depth 3.000000 m
2019-02-16T01:07:14.219Z,1550279234.219 [Reporter](INFO): depth 3.000000 m
2019-02-16T01:07:14.491Z,1550279234.491 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:07:14.652Z,1550279234.652 [Reporter](INFO): depth 3.000000 m
2019-02-16T01:07:15.049Z,1550279235.049 [Reporter](INFO): depth 3.000000 m
2019-02-16T01:07:15.459Z,1550279235.459 [Reporter](INFO): depth 3.000000 m
2019-02-16T01:07:15.867Z,1550279235.867 [Reporter](INFO): depth 3.000000 m
2019-02-16T01:07:16.270Z,1550279236.270 [Reporter](INFO): depth 3.000000 m
2019-02-16T01:07:16.643Z,1550279236.643 [Reporter](INFO): depth 3.000000 m
2019-02-16T01:07:17.047Z,1550279237.047 [Reporter](INFO): depth 3.000000 m
2019-02-16T01:07:17.318Z,1550279237.318 [CommandLine](IMPORTANT): got command report clear
2019-02-16T01:07:17.504Z,1550279237.504 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:07:19.512Z,1550279239.512 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:07:20.516Z,1550279240.516 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:07:21.520Z,1550279241.520 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:07:22.523Z,1550279242.523 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:07:23.528Z,1550279243.528 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:07:24.532Z,1550279244.532 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:07:25.535Z,1550279245.535 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:07:27.544Z,1550279247.544 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:07:34.572Z,1550279254.572 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:07:40.596Z,1550279260.596 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:07:41.600Z,1550279261.600 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:07:42.604Z,1550279262.604 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:07:43.608Z,1550279263.608 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:07:44.612Z,1550279264.612 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:07:45.616Z,1550279265.616 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:07:46.620Z,1550279266.620 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:07:48.639Z,1550279268.639 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:07:52.652Z,1550279272.652 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:07:53.656Z,1550279273.656 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:07:54.672Z,1550279274.672 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:07:59.692Z,1550279279.692 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:08:00.695Z,1550279280.695 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:08:01.700Z,1550279281.700 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:08:02.704Z,1550279282.704 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:08:04.711Z,1550279284.711 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:08:05.716Z,1550279285.716 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:08:06.719Z,1550279286.719 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:08:08.727Z,1550279288.727 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:08:09.732Z,1550279289.732 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:08:10.735Z,1550279290.735 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:08:19.772Z,1550279299.772 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:08:21.780Z,1550279301.780 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:08:25.798Z,1550279305.798 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:08:32.840Z,1550279312.840 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:08:34.847Z,1550279314.847 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:08:35.852Z,1550279315.852 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000000 psu
2019-02-16T01:08:35.962Z,1550279315.962 [CommandLine](IMPORTANT): got command stop
2019-02-16T01:08:35.962Z,1550279315.962 [CommandLine](IMPORTANT): Scheduling is paused
2019-02-16T01:08:35.962Z,1550279315.962 [Supervisor](INFO): Stop Mission called by CommandLine::commandStop
2019-02-16T01:08:36.242Z,1550279316.242 [MissionManager](INFO): MissionManager is completed.
2019-02-16T01:08:36.242Z,1550279316.242 [MissionManager](INFO): Uninitializing Mission Science
2019-02-16T01:08:36.242Z,1550279316.242 [Science] Stopped
2019-02-16T01:08:36.242Z,1550279316.242 [Science](DEBUG): Aggregate::uninitialize Science
2019-02-16T01:08:36.242Z,1550279316.242 [Science:A] Stopped
2019-02-16T01:08:36.243Z,1550279316.243 [Science:C] Stopped
2019-02-16T01:08:36.243Z,1550279316.243 [Science:D] Stopped
2019-02-16T01:08:36.243Z,1550279316.243 [Science:G] Stopped
2019-02-16T01:08:36.648Z,1550279316.648 [MissionManager](IMPORTANT): Started mission Default
2019-02-16T01:08:36.648Z,1550279316.648 [Default] Running Loop=1
2019-02-16T01:08:36.648Z,1550279316.648 [Default](DEBUG): Aggregate::initialize Default
2019-02-16T01:08:36.648Z,1550279316.648 [Default:B.GoToSurface] Running Loop=1
2019-02-16T01:08:36.649Z,1550279316.649 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-02-16T01:08:36.649Z,1550279316.649 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-02-16T01:08:36.649Z,1550279316.649 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-02-16T01:08:36.650Z,1550279316.650 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-02-16T01:08:36.650Z,1550279316.650 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-02-16T01:08:36.650Z,1550279316.650 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-02-16T01:08:36.651Z,1550279316.651 [Default:A.Wait] Running Loop=1
2019-02-16T01:08:36.652Z,1550279316.652 [Default:A.Wait](DEBUG): Initialize Wait Component.
2019-02-16T01:08:36.722Z,1550279316.722 [Radio_Surface](INFO): Powering down
2019-02-16T01:08:36.814Z,1550279316.814 [WetLabsBB2FL](INFO): Powering down
2019-02-16T01:08:37.110Z,1550279317.110 [Aanderaa_O2](INFO): Powering down
2019-02-16T01:08:37.163Z,1550279317.163 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 1.00 m/s, pitch 30.00 deg, mass-position -13.00 mm (1 active estimators).
2019-02-16T01:08:40.089Z,1550279320.089 [ThrusterServo](FAULT): Overload Error
2019-02-16T01:08:40.090Z,1550279320.090 [ThrusterServo] Hardware Fault, FailCount= 1
2019-02-16T01:08:40.090Z,1550279320.090 [ThrusterServo](ERROR): Hardware Fault
2019-02-16T01:08:40.093Z,1550279320.093 [CBIT](ERROR): Hardware Fault in component: ThrusterServo
2019-02-16T01:08:40.447Z,1550279320.447 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2019-02-16T01:08:40.447Z,1550279320.447 [ThrusterServo](INFO): Powering down
2019-02-16T01:08:40.747Z,1550279320.747 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-02-16T01:08:41.363Z,1550279321.363 [ThrusterServo](DEBUG): Initializing EZServoServo.
2019-02-16T01:08:41.482Z,1550279321.482 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2019-02-16T01:08:41.486Z,1550279321.486 [CBIT](INFO): Clearing failed state for component ThrusterServo
2019-02-16T01:08:41.486Z,1550279321.486 [ThrusterServo] No Fault, FailCount= 1
2019-02-16T01:08:41.570Z,1550279321.570 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:08:42.783Z,1550279322.783 [Radio_Surface](INFO): Powering up
2019-02-16T01:08:46.014Z,1550279326.014 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:08:49.245Z,1550279329.245 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:08:49.686Z,1550279329.686 [Default:A.Wait](INFO): Done Waiting.
2019-02-16T01:08:49.686Z,1550279329.686 [Default:A.Wait] Stopped
2019-02-16T01:08:49.686Z,1550279329.686 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2019-02-16T01:08:52.074Z,1550279332.074 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:08:55.306Z,1550279335.306 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:08:55.379Z,1550279335.379 [CommandLine](IMPORTANT): got command maintain clear
2019-02-16T01:08:55.396Z,1550279335.396 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,ESPComponent,PAR_Licor,AcousticModem_Benthos_ATM900,Depth_Keller,DropWeight,NAL9602,Onboard,PNI_TCM,BPC1,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-02-16T01:08:55.749Z,1550279335.749 [Default:CheckIn] Running Loop=1
2019-02-16T01:08:55.749Z,1550279335.749 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-02-16T01:08:55.750Z,1550279335.750 [Default:CheckIn:Read_GPS] Running Loop=1
2019-02-16T01:08:56.149Z,1550279336.149 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2019-02-16T01:08:58.205Z,1550279338.205 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:08:59.850Z,1550279339.850 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2019-02-16T01:08:59.851Z,1550279339.851 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-02-16T01:08:59.852Z,1550279339.852 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2019-02-16T01:08:59.852Z,1550279339.852 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-02-16T01:08:59.853Z,1550279339.853 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2019-02-16T01:08:59.853Z,1550279339.853 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-02-16T01:08:59.970Z,1550279339.970 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-02-16T01:08:59.971Z,1550279339.971 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-02-16T01:08:59.971Z,1550279339.971 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-02-16T01:09:00.430Z,1550279340.430 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-02-16T01:09:00.430Z,1550279340.430 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2019-02-16T01:09:00.431Z,1550279340.431 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-02-16T01:09:00.431Z,1550279340.431 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2019-02-16T01:09:00.431Z,1550279340.431 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-02-16T01:09:00.431Z,1550279340.431 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2019-02-16T01:09:00.670Z,1550279340.670 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-02-16T01:09:01.033Z,1550279341.033 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:09:04.081Z,1550279344.081 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2019-02-16T01:09:04.081Z,1550279344.081 [Rowe_600LCM] Communications Fault, FailCount= 3
2019-02-16T01:09:04.081Z,1550279344.081 [Rowe_600LCM](ERROR): Communications Fault
2019-02-16T01:09:04.269Z,1550279344.269 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:09:04.370Z,1550279344.370 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2019-02-16T01:09:04.486Z,1550279344.486 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2019-02-16T01:09:04.584Z,1550279344.584 [Rowe_600LCM](INFO): Powering down
2019-02-16T01:09:05.942Z,1550279345.942 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2019-02-16T01:09:05.942Z,1550279345.942 [Rowe_600LCM] No Fault, FailCount= 3
2019-02-16T01:09:06.198Z,1550279346.198 [Rowe_600LCM](INFO): Initializing
2019-02-16T01:09:06.198Z,1550279346.198 [Rowe_600LCM](INFO): Powering up
2019-02-16T01:09:07.101Z,1550279347.101 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:09:10.326Z,1550279350.326 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:09:10.372Z,1550279350.372 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2019-02-16T01:09:10.485Z,1550279350.485 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null &
2019-02-16T01:09:13.153Z,1550279353.153 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:09:16.385Z,1550279356.385 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:09:19.213Z,1550279359.213 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:09:22.037Z,1550279362.037 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:09:24.061Z,1550279364.061 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:09:27.289Z,1550279367.289 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:09:30.117Z,1550279370.117 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:09:33.353Z,1550279373.353 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:09:35.914Z,1550279375.914 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-02-16T01:09:36.181Z,1550279376.181 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:09:39.409Z,1550279379.409 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:09:40.475Z,1550279380.475 [CommandLine](IMPORTANT): got command get platform_surface_radio_power
2019-02-16T01:09:40.476Z,1550279380.476 [CommandLine](FAULT): Element has no value
2019-02-16T01:09:42.241Z,1550279382.241 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:09:45.061Z,1550279385.061 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:09:47.089Z,1550279387.089 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:09:50.318Z,1550279390.318 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:09:53.149Z,1550279393.149 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:09:56.377Z,1550279396.377 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:09:59.225Z,1550279399.225 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:10:02.437Z,1550279402.437 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:10:05.269Z,1550279405.269 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:10:08.093Z,1550279408.093 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:10:10.117Z,1550279410.117 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:10:11.755Z,1550279411.755 [CommandLine](IMPORTANT): got command get Radio_Surface.platform_surface_radio_power
2019-02-16T01:10:11.756Z,1550279411.756 [CommandLine](IMPORTANT): Radio_Surface.platform_surface_radio_power 1 bool
2019-02-16T01:10:12.133Z,1550279412.133 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:10:15.365Z,1550279415.365 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:10:18.197Z,1550279418.197 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:10:21.421Z,1550279421.421 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:10:24.257Z,1550279424.257 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:10:27.485Z,1550279427.485 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:10:30.317Z,1550279430.317 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:10:33.149Z,1550279433.149 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:10:35.165Z,1550279435.165 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:10:36.110Z,1550279436.110 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-02-16T01:10:38.397Z,1550279438.397 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:10:41.221Z,1550279441.221 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:10:44.458Z,1550279444.458 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:10:45.523Z,1550279445.523 [CommandLine](IMPORTANT): got command maintain sensor Depth_Keller.depth 3.000000 meter
2019-02-16T01:10:45.525Z,1550279445.525 [ComponentRegistry](DEBUG): SyncComponent "Maintain_Depth_Keller.depth" handled in the control thread.
2019-02-16T01:10:45.698Z,1550279445.698 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,ESPComponent,PAR_Licor,AcousticModem_Benthos_ATM900,Depth_Keller,DropWeight,NAL9602,Onboard,PNI_TCM,BPC1,PAR_Licor,Depth_Keller,Maintain_Depth_Keller.depth,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-02-16T01:10:46.442Z,1550279446.442 [Radio_Surface](INFO): Powering down
2019-02-16T01:10:47.277Z,1550279447.277 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:10:50.217Z,1550279450.217 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:10:53.445Z,1550279453.445 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:10:56.277Z,1550279456.277 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:10:59.509Z,1550279459.509 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:11:02.337Z,1550279462.337 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:11:05.165Z,1550279465.165 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:11:06.757Z,1550279466.757 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2019-02-16T01:11:06.757Z,1550279466.757 [Rowe_600LCM] Communications Fault, FailCount= 4
2019-02-16T01:11:06.758Z,1550279466.758 [Rowe_600LCM](ERROR): Communications Fault
2019-02-16T01:11:06.838Z,1550279466.838 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2019-02-16T01:11:07.162Z,1550279467.162 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2019-02-16T01:11:07.226Z,1550279467.226 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:11:07.404Z,1550279467.404 [Rowe_600LCM](INFO): Powering down
2019-02-16T01:11:08.893Z,1550279468.893 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2019-02-16T01:11:08.893Z,1550279468.893 [Rowe_600LCM] No Fault, FailCount= 4
2019-02-16T01:11:09.018Z,1550279469.018 [Rowe_600LCM](INFO): Initializing
2019-02-16T01:11:09.018Z,1550279469.018 [Rowe_600LCM](INFO): Powering up
2019-02-16T01:11:09.201Z,1550279469.201 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:11:11.225Z,1550279471.225 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:11:13.140Z,1550279473.140 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2019-02-16T01:11:13.204Z,1550279473.204 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null &
2019-02-16T01:11:14.458Z,1550279474.458 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:11:17.285Z,1550279477.285 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:11:20.513Z,1550279480.513 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:11:23.345Z,1550279483.345 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:11:26.573Z,1550279486.573 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:11:29.405Z,1550279489.405 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:11:32.233Z,1550279492.233 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:11:34.249Z,1550279494.249 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:11:36.273Z,1550279496.273 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:11:39.501Z,1550279499.501 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:11:41.271Z,1550279501.271 [CommandLine](IMPORTANT): got command get Radio_Surface.platform_surface_radio_power
2019-02-16T01:11:41.272Z,1550279501.272 [CommandLine](IMPORTANT): Radio_Surface.platform_surface_radio_power 0 bool
2019-02-16T01:11:42.333Z,1550279502.333 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:11:45.565Z,1550279505.565 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:11:48.389Z,1550279508.389 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:11:51.621Z,1550279511.621 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:11:54.453Z,1550279514.453 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:11:57.282Z,1550279517.282 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:11:59.301Z,1550279519.301 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:12:00.944Z,1550279520.944 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2019-02-16T01:12:00.944Z,1550279520.944 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-02-16T01:12:00.946Z,1550279520.946 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2019-02-16T01:12:00.946Z,1550279520.946 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-02-16T01:12:00.947Z,1550279520.947 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 3
2019-02-16T01:12:00.947Z,1550279520.947 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-02-16T01:12:00.985Z,1550279520.985 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-02-16T01:12:00.986Z,1550279520.986 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-02-16T01:12:00.986Z,1550279520.986 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-02-16T01:12:01.385Z,1550279521.385 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-02-16T01:12:01.385Z,1550279521.385 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2019-02-16T01:12:01.386Z,1550279521.386 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-02-16T01:12:01.386Z,1550279521.386 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2019-02-16T01:12:01.386Z,1550279521.386 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-02-16T01:12:01.386Z,1550279521.386 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 3
2019-02-16T01:12:01.762Z,1550279521.762 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-02-16T01:12:02.533Z,1550279522.533 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:12:05.361Z,1550279525.361 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:12:08.589Z,1550279528.589 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:12:11.421Z,1550279531.421 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:12:11.502Z,1550279531.502 [CommandLine](IMPORTANT): got command maintain clear
2019-02-16T01:12:11.907Z,1550279531.907 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,ESPComponent,PAR_Licor,AcousticModem_Benthos_ATM900,Depth_Keller,DropWeight,NAL9602,Onboard,PNI_TCM,BPC1,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-02-16T01:12:12.494Z,1550279532.494 [Radio_Surface](INFO): Powering up
2019-02-16T01:12:14.713Z,1550279534.713 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:12:17.557Z,1550279537.557 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:12:17.764Z,1550279537.764 [CommandLine](IMPORTANT): got command maintain sensor Depth_Keller.depth 3.000000 meter
2019-02-16T01:12:17.768Z,1550279537.768 [ComponentRegistry](DEBUG): SyncComponent "Maintain_Depth_Keller.depth" handled in the control thread.
2019-02-16T01:12:18.047Z,1550279538.047 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,ESPComponent,PAR_Licor,AcousticModem_Benthos_ATM900,Depth_Keller,DropWeight,NAL9602,Onboard,PNI_TCM,BPC1,PAR_Licor,Depth_Keller,Maintain_Depth_Keller.depth,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-02-16T01:12:18.555Z,1550279538.555 [Radio_Surface](INFO): Powering down
2019-02-16T01:12:18.958Z,1550279538.958 [Radio_Surface](FAULT): LCB fault:  Invalid Command.
2019-02-16T01:12:18.958Z,1550279538.958 [Radio_Surface] Hardware Fault, FailCount= 1
2019-02-16T01:12:18.958Z,1550279538.958 [Radio_Surface](ERROR): Hardware Fault
2019-02-16T01:12:19.386Z,1550279539.386 [CBIT](ERROR): Hardware Fault in component: Radio_Surface
2019-02-16T01:12:20.095Z,1550279540.095 [CBIT](INFO): Clearing failed state for component Radio_Surface
2019-02-16T01:12:20.095Z,1550279540.095 [Radio_Surface] No Fault, FailCount= 1
2019-02-16T01:12:20.170Z,1550279540.170 [Radio_Surface](INFO): Powering up
2019-02-16T01:12:20.373Z,1550279540.373 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:12:21.750Z,1550279541.750 [ThrusterServo](FAULT): Overload Error
2019-02-16T01:12:21.751Z,1550279541.751 [ThrusterServo] Hardware Fault, FailCount= 1
2019-02-16T01:12:21.751Z,1550279541.751 [ThrusterServo](ERROR): Hardware Fault
2019-02-16T01:12:21.759Z,1550279541.759 [CBIT](ERROR): Hardware Fault in component: ThrusterServo
2019-02-16T01:12:22.150Z,1550279542.150 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2019-02-16T01:12:22.151Z,1550279542.151 [ThrusterServo](INFO): Powering down
2019-02-16T01:12:22.995Z,1550279542.995 [ThrusterServo](DEBUG): Initializing EZServoServo.
2019-02-16T01:12:23.115Z,1550279543.115 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2019-02-16T01:12:23.119Z,1550279543.119 [CBIT](INFO): Clearing failed state for component ThrusterServo
2019-02-16T01:12:23.119Z,1550279543.119 [ThrusterServo] No Fault, FailCount= 1
2019-02-16T01:12:23.605Z,1550279543.605 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:12:23.959Z,1550279543.959 [CommandLine](IMPORTANT): got command maintain clear
2019-02-16T01:12:23.969Z,1550279543.969 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,ESPComponent,PAR_Licor,AcousticModem_Benthos_ATM900,Depth_Keller,DropWeight,NAL9602,Onboard,PNI_TCM,BPC1,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-02-16T01:12:26.525Z,1550279546.525 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:12:29.353Z,1550279549.353 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:12:32.586Z,1550279552.586 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:12:35.075Z,1550279555.075 [CommandLine](IMPORTANT): got command get Radio_Surface.platform_surface_radio_power
2019-02-16T01:12:35.076Z,1550279555.076 [CommandLine](IMPORTANT): Radio_Surface.platform_surface_radio_power 1 bool
2019-02-16T01:12:35.417Z,1550279555.417 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:12:38.645Z,1550279558.645 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:12:41.470Z,1550279561.470 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:12:44.705Z,1550279564.705 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:12:47.533Z,1550279567.533 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:12:50.357Z,1550279570.357 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:12:52.381Z,1550279572.381 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:12:55.621Z,1550279575.621 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:12:58.433Z,1550279578.433 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:12:59.895Z,1550279579.895 [CommandLine](IMPORTANT): got command report mod platform_surface_radio_power
2019-02-16T01:13:00.090Z,1550279580.090 [Reporter](INFO): platform_surface_radio_power no_value
2019-02-16T01:13:01.673Z,1550279581.673 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:13:04.498Z,1550279584.497 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:13:07.733Z,1550279587.733 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:13:09.525Z,1550279589.525 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2019-02-16T01:13:09.526Z,1550279589.526 [Rowe_600LCM] Communications Fault, FailCount= 5
2019-02-16T01:13:09.526Z,1550279589.526 [Rowe_600LCM](ERROR): Communications Fault
2019-02-16T01:13:09.818Z,1550279589.818 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2019-02-16T01:13:09.818Z,1550279589.818 [CBIT](FAULT): Communications Fault in component: Rowe_600LCM
2019-02-16T01:13:09.930Z,1550279589.930 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2019-02-16T01:13:10.093Z,1550279590.093 [Rowe_600LCM](INFO): Powering down
2019-02-16T01:13:10.557Z,1550279590.557 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:13:13.389Z,1550279593.389 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:13:15.401Z,1550279595.401 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:13:17.425Z,1550279597.425 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:13:20.661Z,1550279600.661 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:13:23.489Z,1550279603.489 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:13:26.720Z,1550279606.720 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:13:29.549Z,1550279609.549 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:13:32.778Z,1550279612.778 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:13:35.605Z,1550279615.605 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:13:38.427Z,1550279618.427 [NAL9602](FAULT): GPS failed to acquire within timeout.
2019-02-16T01:13:38.427Z,1550279618.427 [NAL9602] Data Fault, FailCount= 1
2019-02-16T01:13:38.427Z,1550279618.427 [NAL9602](ERROR): Data Fault
2019-02-16T01:13:38.466Z,1550279618.466 [CBIT](ERROR): Data Fault in component: NAL9602
2019-02-16T01:13:38.827Z,1550279618.827 [NAL9602](INFO): Powering down
2019-02-16T01:13:39.674Z,1550279619.674 [CBIT](INFO): Clearing failed state for component NAL9602
2019-02-16T01:13:39.674Z,1550279619.674 [NAL9602] No Fault, FailCount= 1
2019-02-16T01:13:55.824Z,1550279635.824 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-02-16T01:08:55.7Z
2019-02-16T01:13:55.824Z,1550279635.824 [Default:CheckIn:Read_GPS] Stopped
2019-02-16T01:13:55.824Z,1550279635.824 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-02-16T01:13:56.228Z,1550279636.228 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-02-16T01:13:59.554Z,1550279639.554 [CommandLine](IMPORTANT): got command report mod Radio_Surface.platform_surface_radio_power
2019-02-16T01:13:59.941Z,1550279639.941 [Reporter](INFO): Radio_Surface.platform_surface_radio_power 1 bool
2019-02-16T01:14:01.973Z,1550279641.973 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190216T010247/Courier0004.lzma
2019-02-16T01:14:02.779Z,1550279642.779 [DataOverHttps](INFO): Moved sent file to Logs/20190216T010247/Courier0004.lzma.bak
2019-02-16T01:14:02.779Z,1550279642.779 [DataOverHttps](INFO): SBD MOMSN=9925054
2019-02-16T01:14:05.588Z,1550279645.588 [CBIT](INFO): Clearing failed state for component BPC1
2019-02-16T01:14:05.588Z,1550279645.588 [BPC1] No Fault, FailCount= 1
2019-02-16T01:14:09.128Z,1550279649.128 [NAL9602](INFO): Powering up NAL9602
2019-02-16T01:14:15.335Z,1550279655.335 [DataOverHttps](INFO): Sending 1009 bytes from file Logs/20190216T010247/Express0005.lzma
2019-02-16T01:14:16.139Z,1550279656.139 [DataOverHttps](INFO): Moved sent file to Logs/20190216T010247/Express0005.lzma.bak
2019-02-16T01:14:16.139Z,1550279656.139 [DataOverHttps](INFO): SBD MOMSN=9925056
2019-02-16T01:14:16.840Z,1550279656.840 [Default:CheckIn:Read_Iridium] Stopped
2019-02-16T01:14:16.840Z,1550279656.840 [Default:CheckIn:C.Wait] Running Loop=1
2019-02-16T01:14:16.840Z,1550279656.840 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-02-16T01:14:20.043Z,1550279660.043 [NAL9602](INFO): NAL9602 initialized
2019-02-16T01:14:20.850Z,1550279660.850 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:14:23.689Z,1550279663.689 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:14:26.917Z,1550279666.917 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:14:29.745Z,1550279669.745 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:14:29.803Z,1550279669.803 [CommandLine](IMPORTANT): got command maintain sensor Depth_Keller.depth 3.000000 meter
2019-02-16T01:14:29.804Z,1550279669.804 [ComponentRegistry](DEBUG): SyncComponent "Maintain_Depth_Keller.depth" handled in the control thread.
2019-02-16T01:14:30.197Z,1550279670.197 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,ESPComponent,PAR_Licor,AcousticModem_Benthos_ATM900,Depth_Keller,DropWeight,NAL9602,Onboard,PNI_TCM,BPC1,PAR_Licor,Depth_Keller,Maintain_Depth_Keller.depth,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-02-16T01:14:30.678Z,1550279670.678 [Radio_Surface](INFO): Powering down
2019-02-16T01:14:30.992Z,1550279670.992 [Reporter](INFO): Radio_Surface.platform_surface_radio_power no_value
2019-02-16T01:14:33.073Z,1550279673.073 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:14:34.022Z,1550279674.022 [ThrusterServo](FAULT): Overload Error
2019-02-16T01:14:34.022Z,1550279674.022 [ThrusterServo] Hardware Fault, FailCount= 2
2019-02-16T01:14:34.022Z,1550279674.022 [ThrusterServo](ERROR): Hardware Fault
2019-02-16T01:14:34.026Z,1550279674.026 [CBIT](ERROR): Hardware Fault in component: ThrusterServo
2019-02-16T01:14:34.379Z,1550279674.379 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2019-02-16T01:14:34.379Z,1550279674.379 [ThrusterServo](INFO): Powering down
2019-02-16T01:14:35.242Z,1550279675.242 [ThrusterServo](DEBUG): Initializing EZServoServo.
2019-02-16T01:14:35.363Z,1550279675.363 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2019-02-16T01:14:35.367Z,1550279675.367 [CBIT](INFO): Clearing failed state for component ThrusterServo
2019-02-16T01:14:35.367Z,1550279675.367 [ThrusterServo] No Fault, FailCount= 2
2019-02-16T01:14:35.902Z,1550279675.902 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:14:38.725Z,1550279678.725 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:14:39.567Z,1550279679.567 [Radio_Surface](INFO): Powering up
2019-02-16T01:14:40.850Z,1550279680.850 [ThrusterServo](FAULT): Overload Error
2019-02-16T01:14:40.850Z,1550279680.850 [ThrusterServo] Hardware Fault, FailCount= 3
2019-02-16T01:14:40.850Z,1550279680.850 [ThrusterServo](ERROR): Hardware Fault
2019-02-16T01:14:40.869Z,1550279680.869 [CBIT](ERROR): Hardware Fault in component: ThrusterServo
2019-02-16T01:14:41.231Z,1550279681.231 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2019-02-16T01:14:41.231Z,1550279681.231 [ThrusterServo](INFO): Powering down
2019-02-16T01:14:41.961Z,1550279681.961 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:14:42.055Z,1550279682.055 [ThrusterServo](DEBUG): Initializing EZServoServo.
2019-02-16T01:14:42.170Z,1550279682.170 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2019-02-16T01:14:42.174Z,1550279682.174 [CBIT](INFO): Clearing failed state for component ThrusterServo
2019-02-16T01:14:42.174Z,1550279682.174 [ThrusterServo] No Fault, FailCount= 3
2019-02-16T01:14:44.793Z,1550279684.793 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:14:45.318Z,1550279685.318 [Reporter](INFO): Radio_Surface.platform_surface_radio_power 1 bool
2019-02-16T01:14:46.030Z,1550279686.030 [Radio_Surface](INFO): Powering down
2019-02-16T01:14:46.107Z,1550279686.107 [Reporter](INFO): Radio_Surface.platform_surface_radio_power no_value
2019-02-16T01:14:46.442Z,1550279686.442 [CommandLine](IMPORTANT): got command maintain clear
2019-02-16T01:14:46.523Z,1550279686.523 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,ESPComponent,PAR_Licor,AcousticModem_Benthos_ATM900,Depth_Keller,DropWeight,NAL9602,Onboard,PNI_TCM,BPC1,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-02-16T01:14:47.616Z,1550279687.616 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:14:49.637Z,1550279689.637 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:14:51.657Z,1550279691.657 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:14:52.090Z,1550279692.090 [Radio_Surface](INFO): Powering up
2019-02-16T01:14:53.673Z,1550279693.673 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:14:56.909Z,1550279696.909 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:14:57.800Z,1550279697.800 [Reporter](INFO): Radio_Surface.platform_surface_radio_power 1 bool
2019-02-16T01:14:59.729Z,1550279699.729 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:15:01.788Z,1550279701.788 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2019-02-16T01:15:01.788Z,1550279701.788 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-02-16T01:15:01.789Z,1550279701.789 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4
2019-02-16T01:15:01.789Z,1550279701.789 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-02-16T01:15:01.790Z,1550279701.790 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 4
2019-02-16T01:15:01.790Z,1550279701.790 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-02-16T01:15:01.839Z,1550279701.839 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-02-16T01:15:01.839Z,1550279701.839 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-02-16T01:15:01.839Z,1550279701.839 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-02-16T01:15:02.298Z,1550279702.298 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-02-16T01:15:02.298Z,1550279702.298 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2019-02-16T01:15:02.299Z,1550279702.299 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-02-16T01:15:02.299Z,1550279702.299 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4
2019-02-16T01:15:02.299Z,1550279702.299 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-02-16T01:15:02.299Z,1550279702.299 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 4
2019-02-16T01:15:02.585Z,1550279702.585 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-02-16T01:15:02.969Z,1550279702.969 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:15:05.789Z,1550279705.789 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:15:09.025Z,1550279709.025 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:15:11.857Z,1550279711.857 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:15:14.685Z,1550279714.685 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:15:16.705Z,1550279716.705 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:15:19.937Z,1550279719.937 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:15:22.765Z,1550279722.765 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:15:25.997Z,1550279725.997 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:15:28.825Z,1550279728.825 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:15:32.060Z,1550279732.060 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:15:34.885Z,1550279734.885 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:15:37.709Z,1550279737.709 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:15:39.733Z,1550279739.733 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:15:42.965Z,1550279742.965 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:15:45.785Z,1550279745.785 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:15:47.110Z,1550279747.110 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-02-16T01:15:49.026Z,1550279749.026 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:15:51.853Z,1550279751.853 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:15:55.085Z,1550279755.085 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:15:57.913Z,1550279757.913 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:16:00.741Z,1550279760.741 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:16:02.753Z,1550279762.753 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:16:04.781Z,1550279764.781 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:16:08.013Z,1550279768.013 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:16:10.837Z,1550279770.837 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:16:14.073Z,1550279774.073 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:16:16.901Z,1550279776.901 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:16:20.134Z,1550279780.134 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:16:22.961Z,1550279782.961 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:16:25.781Z,1550279785.781 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:16:27.805Z,1550279787.805 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:16:31.041Z,1550279791.041 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:16:33.865Z,1550279793.865 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:16:37.101Z,1550279797.101 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:16:39.929Z,1550279799.929 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:16:43.161Z,1550279803.161 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:16:45.989Z,1550279805.989 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:16:47.342Z,1550279807.342 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-02-16T01:16:48.809Z,1550279808.809 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:16:50.833Z,1550279810.833 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:16:52.857Z,1550279812.857 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:16:56.089Z,1550279816.089 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:16:58.917Z,1550279818.917 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:17:02.142Z,1550279822.142 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:17:04.977Z,1550279824.977 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:17:08.210Z,1550279828.210 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:17:11.037Z,1550279831.037 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:17:13.861Z,1550279833.861 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:17:15.885Z,1550279835.885 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:17:19.109Z,1550279839.109 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:17:21.941Z,1550279841.941 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:17:22.987Z,1550279842.987 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.352158
2019-02-16T01:17:25.177Z,1550279845.177 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:17:28.005Z,1550279848.005 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:17:31.237Z,1550279851.237 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:17:34.065Z,1550279854.065 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:17:36.889Z,1550279856.889 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:17:38.913Z,1550279858.913 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:17:40.933Z,1550279860.933 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:17:44.165Z,1550279864.165 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:17:46.993Z,1550279866.993 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:17:50.221Z,1550279870.221 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:17:53.053Z,1550279873.053 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:17:56.285Z,1550279876.285 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:17:59.114Z,1550279879.114 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:17:59.578Z,1550279879.578 [CBIT](INFO): Clearing failed state for component DropWeight
2019-02-16T01:17:59.578Z,1550279879.578 [DropWeight] No Fault, FailCount= 1
2019-02-16T01:18:01.941Z,1550279881.941 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:18:02.783Z,1550279882.783 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2019-02-16T01:18:02.783Z,1550279882.783 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-02-16T01:18:02.784Z,1550279882.784 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5
2019-02-16T01:18:02.784Z,1550279882.784 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-02-16T01:18:02.785Z,1550279882.785 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 5
2019-02-16T01:18:02.785Z,1550279882.785 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-02-16T01:18:02.796Z,1550279882.796 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-02-16T01:18:02.796Z,1550279882.796 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-02-16T01:18:02.796Z,1550279882.796 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-02-16T01:18:03.191Z,1550279883.191 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-02-16T01:18:03.191Z,1550279883.191 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2019-02-16T01:18:03.191Z,1550279883.191 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-02-16T01:18:03.192Z,1550279883.192 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5
2019-02-16T01:18:03.192Z,1550279883.192 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-02-16T01:18:03.192Z,1550279883.192 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 5
2019-02-16T01:18:03.639Z,1550279883.639 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-02-16T01:18:03.953Z,1550279883.953 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:18:07.193Z,1550279887.193 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:18:10.021Z,1550279890.021 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:18:13.253Z,1550279893.253 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:18:16.081Z,1550279896.081 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:18:19.305Z,1550279899.305 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:18:22.133Z,1550279902.133 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:18:23.599Z,1550279903.599 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004185
2019-02-16T01:18:24.969Z,1550279904.969 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:18:26.989Z,1550279906.989 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:18:30.221Z,1550279910.221 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:18:33.045Z,1550279913.045 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:18:36.285Z,1550279916.285 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:18:39.109Z,1550279919.109 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:18:42.333Z,1550279922.333 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:18:45.169Z,1550279925.169 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:18:47.997Z,1550279927.997 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:18:50.017Z,1550279930.017 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:18:52.037Z,1550279932.037 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:18:55.269Z,1550279935.269 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:18:58.097Z,1550279938.097 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:19:01.329Z,1550279941.329 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:19:04.157Z,1550279944.157 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:19:07.390Z,1550279947.390 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:19:10.213Z,1550279950.213 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:19:13.045Z,1550279953.045 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:19:15.057Z,1550279955.057 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:19:17.514Z,1550279957.514 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-02-16T01:19:17.514Z,1550279957.514 [Default:CheckIn:C.Wait] Stopped
2019-02-16T01:19:17.514Z,1550279957.514 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-02-16T01:19:17.515Z,1550279957.515 [Default:CheckIn:D] Running Loop=1
2019-02-16T01:19:17.912Z,1550279957.912 [Default:CheckIn:D] Stopped
2019-02-16T01:19:17.912Z,1550279957.912 [Default:CheckIn:E] Running Loop=1
2019-02-16T01:19:18.297Z,1550279958.297 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:19:18.334Z,1550279958.334 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.687728 min 
2019-02-16T01:19:18.335Z,1550279958.335 [Default:CheckIn:E] Stopped
2019-02-16T01:19:18.335Z,1550279958.335 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-02-16T01:19:18.335Z,1550279958.335 [Default:CheckIn] Stopped
2019-02-16T01:19:18.335Z,1550279958.335 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-02-16T01:19:18.335Z,1550279958.335 [Default:CheckIn](INFO): Running loop #2
2019-02-16T01:19:18.335Z,1550279958.335 [Default:CheckIn] Running Loop=2
2019-02-16T01:19:18.335Z,1550279958.335 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-02-16T01:19:18.335Z,1550279958.335 [Default:CheckIn:Read_GPS] Running Loop=1
2019-02-16T01:19:21.133Z,1550279961.133 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:19:24.357Z,1550279964.357 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:19:26.920Z,1550279966.920 [CommandLine](IMPORTANT): got command maintain clear
2019-02-16T01:19:27.185Z,1550279967.185 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:19:30.417Z,1550279970.417 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:19:33.246Z,1550279973.246 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:19:36.073Z,1550279976.073 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:19:38.093Z,1550279978.093 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:19:40.113Z,1550279980.113 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:19:43.345Z,1550279983.345 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:19:46.173Z,1550279986.173 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:19:49.401Z,1550279989.401 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:19:52.232Z,1550279992.232 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:19:55.461Z,1550279995.461 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:19:58.293Z,1550279998.293 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:20:01.121Z,1550280001.121 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:20:03.141Z,1550280003.141 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:20:06.369Z,1550280006.369 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:20:09.201Z,1550280009.201 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:20:12.425Z,1550280012.425 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:20:15.261Z,1550280015.261 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:20:18.493Z,1550280018.493 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:20:21.317Z,1550280021.317 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:20:24.149Z,1550280024.149 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:20:26.169Z,1550280026.169 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:20:28.189Z,1550280028.189 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:20:31.421Z,1550280031.421 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:20:34.245Z,1550280034.245 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:20:37.481Z,1550280037.481 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:20:40.309Z,1550280040.309 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:20:43.541Z,1550280043.541 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:20:46.365Z,1550280046.365 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:20:49.197Z,1550280049.197 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:20:51.209Z,1550280051.209 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:20:54.449Z,1550280054.449 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:20:57.277Z,1550280057.277 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:21:00.509Z,1550280060.509 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:21:03.337Z,1550280063.337 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:21:03.778Z,1550280063.778 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2019-02-16T01:21:03.778Z,1550280063.778 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-02-16T01:21:03.779Z,1550280063.779 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6
2019-02-16T01:21:03.779Z,1550280063.779 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-02-16T01:21:03.780Z,1550280063.780 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 6
2019-02-16T01:21:03.780Z,1550280063.780 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-02-16T01:21:03.791Z,1550280063.791 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-02-16T01:21:03.791Z,1550280063.791 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-02-16T01:21:03.792Z,1550280063.792 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-02-16T01:21:04.196Z,1550280064.196 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-02-16T01:21:04.196Z,1550280064.196 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2019-02-16T01:21:04.196Z,1550280064.196 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-02-16T01:21:04.196Z,1550280064.196 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6
2019-02-16T01:21:04.197Z,1550280064.197 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-02-16T01:21:04.197Z,1550280064.197 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 6
2019-02-16T01:21:04.563Z,1550280064.563 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-02-16T01:21:06.569Z,1550280066.569 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:21:09.393Z,1550280069.393 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:21:12.225Z,1550280072.225 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:21:14.241Z,1550280074.241 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:21:17.473Z,1550280077.473 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:21:20.309Z,1550280080.309 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:21:23.549Z,1550280083.549 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:21:26.378Z,1550280086.378 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:21:29.613Z,1550280089.613 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:21:32.436Z,1550280092.436 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:21:35.269Z,1550280095.269 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:21:37.289Z,1550280097.289 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:21:40.521Z,1550280100.521 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:21:43.349Z,1550280103.349 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:21:46.581Z,1550280106.581 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:21:49.410Z,1550280109.410 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:21:52.638Z,1550280112.638 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:21:55.470Z,1550280115.470 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:21:58.297Z,1550280118.297 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:22:00.317Z,1550280120.317 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:22:03.549Z,1550280123.549 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:22:06.377Z,1550280126.377 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:22:09.609Z,1550280129.609 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:22:12.433Z,1550280132.433 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:22:15.665Z,1550280135.665 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:22:18.497Z,1550280138.497 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:22:21.337Z,1550280141.337 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:22:23.341Z,1550280143.341 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:22:25.369Z,1550280145.369 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:22:28.597Z,1550280148.597 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:22:31.425Z,1550280151.425 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:22:34.657Z,1550280154.657 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:22:37.482Z,1550280157.482 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:22:40.721Z,1550280160.721 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:22:43.545Z,1550280163.545 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:22:46.365Z,1550280166.365 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:22:48.393Z,1550280168.393 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:22:51.625Z,1550280171.625 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:22:54.453Z,1550280174.453 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:22:57.686Z,1550280177.686 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:23:00.513Z,1550280180.513 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:23:03.745Z,1550280183.745 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:23:06.573Z,1550280186.573 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:23:09.401Z,1550280189.401 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:23:09.856Z,1550280189.856 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2019-02-16T01:23:09.857Z,1550280189.857 [Rowe_600LCM] No Fault, FailCount= 5
2019-02-16T01:23:10.066Z,1550280190.066 [Rowe_600LCM](INFO): Initializing
2019-02-16T01:23:10.066Z,1550280190.066 [Rowe_600LCM](INFO): Powering up
2019-02-16T01:23:11.421Z,1550280191.421 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:23:13.441Z,1550280193.441 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:23:14.183Z,1550280194.183 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2019-02-16T01:23:14.287Z,1550280194.287 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null &
2019-02-16T01:23:16.673Z,1550280196.673 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:23:19.501Z,1550280199.501 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:23:22.729Z,1550280202.729 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:23:25.561Z,1550280205.561 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:23:28.793Z,1550280208.793 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:23:31.617Z,1550280211.617 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:23:34.450Z,1550280214.450 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:23:36.476Z,1550280216.476 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:23:39.701Z,1550280219.701 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:23:42.525Z,1550280222.525 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:23:45.761Z,1550280225.761 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:23:48.589Z,1550280228.589 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:23:51.821Z,1550280231.821 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:23:54.649Z,1550280234.649 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:23:57.477Z,1550280237.477 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:23:59.497Z,1550280239.497 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:24:01.517Z,1550280241.517 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:24:04.749Z,1550280244.749 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:24:04.792Z,1550280244.792 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2019-02-16T01:24:04.792Z,1550280244.792 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-02-16T01:24:04.793Z,1550280244.793 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7
2019-02-16T01:24:04.794Z,1550280244.794 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-02-16T01:24:04.795Z,1550280244.795 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 7
2019-02-16T01:24:04.795Z,1550280244.795 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-02-16T01:24:04.805Z,1550280244.805 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-02-16T01:24:04.805Z,1550280244.805 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-02-16T01:24:04.806Z,1550280244.806 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-02-16T01:24:05.253Z,1550280245.253 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-02-16T01:24:05.253Z,1550280245.253 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2019-02-16T01:24:05.254Z,1550280245.254 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-02-16T01:24:05.254Z,1550280245.254 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7
2019-02-16T01:24:05.254Z,1550280245.254 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-02-16T01:24:05.254Z,1550280245.254 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 7
2019-02-16T01:24:05.587Z,1550280245.587 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-02-16T01:24:07.577Z,1550280247.577 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:24:10.066Z,1550280250.066 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2019-02-16T01:24:10.809Z,1550280250.809 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:24:13.638Z,1550280253.638 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:24:16.873Z,1550280256.873 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:24:18.506Z,1550280258.506 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-02-16T01:19:18.3Z
2019-02-16T01:24:18.506Z,1550280258.506 [Default:CheckIn:Read_GPS] Stopped
2019-02-16T01:24:18.506Z,1550280258.506 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-02-16T01:24:19.698Z,1550280259.698 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:24:22.527Z,1550280262.527 [NAL9602](FAULT): GPS failed to acquire within timeout.
2019-02-16T01:24:22.527Z,1550280262.527 [NAL9602] Data Fault, FailCount= 2
2019-02-16T01:24:22.527Z,1550280262.527 [NAL9602](ERROR): Data Fault
2019-02-16T01:24:22.579Z,1550280262.579 [CBIT](ERROR): Data Fault in component: NAL9602
2019-02-16T01:24:22.915Z,1550280262.915 [NAL9602](INFO): Powering down
2019-02-16T01:24:23.778Z,1550280263.778 [CBIT](INFO): Clearing failed state for component NAL9602
2019-02-16T01:24:23.778Z,1550280263.778 [NAL9602] No Fault, FailCount= 2
2019-02-16T01:24:25.117Z,1550280265.117 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190216T010247/Courier0007.lzma
2019-02-16T01:24:25.923Z,1550280265.923 [DataOverHttps](INFO): Moved sent file to Logs/20190216T010247/Courier0007.lzma.bak
2019-02-16T01:24:25.923Z,1550280265.923 [DataOverHttps](INFO): SBD MOMSN=9925092
2019-02-16T01:24:38.622Z,1550280278.622 [DataOverHttps](INFO): Sending 277 bytes from file Logs/20190216T010247/Express0008.lzma
2019-02-16T01:24:39.427Z,1550280279.427 [DataOverHttps](INFO): Moved sent file to Logs/20190216T010247/Express0008.lzma.bak
2019-02-16T01:24:39.427Z,1550280279.427 [DataOverHttps](INFO): SBD MOMSN=9925094
2019-02-16T01:24:40.437Z,1550280280.437 [Default:CheckIn:Read_Iridium] Stopped
2019-02-16T01:24:40.441Z,1550280280.441 [Default:CheckIn:C.Wait] Running Loop=1
2019-02-16T01:24:40.441Z,1550280280.441 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-02-16T01:24:53.219Z,1550280293.219 [NAL9602](INFO): Powering up NAL9602
2019-02-16T01:25:04.124Z,1550280304.124 [NAL9602](INFO): NAL9602 initialized
2019-02-16T01:25:04.945Z,1550280304.945 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:25:07.773Z,1550280307.773 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:25:10.517Z,1550280310.517 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2019-02-16T01:25:10.517Z,1550280310.517 [Rowe_600LCM] Communications Fault, FailCount= 1
2019-02-16T01:25:10.518Z,1550280310.518 [Rowe_600LCM](ERROR): Communications Fault
2019-02-16T01:25:10.655Z,1550280310.655 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2019-02-16T01:25:10.922Z,1550280310.922 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2019-02-16T01:25:11.006Z,1550280311.006 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:25:11.090Z,1550280311.090 [Rowe_600LCM](INFO): Powering down
2019-02-16T01:25:12.654Z,1550280312.654 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2019-02-16T01:25:12.654Z,1550280312.654 [Rowe_600LCM] No Fault, FailCount= 1
2019-02-16T01:25:12.706Z,1550280312.706 [Rowe_600LCM](INFO): Initializing
2019-02-16T01:25:12.706Z,1550280312.706 [Rowe_600LCM](INFO): Powering up
2019-02-16T01:25:13.829Z,1550280313.829 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:25:16.844Z,1550280316.844 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2019-02-16T01:25:16.909Z,1550280316.909 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null &
2019-02-16T01:25:17.065Z,1550280317.065 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:25:19.893Z,1550280319.893 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:25:22.721Z,1550280322.721 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:25:24.741Z,1550280324.741 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:25:27.977Z,1550280327.977 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:25:30.801Z,1550280330.801 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:25:31.255Z,1550280331.255 [BPC1](FAULT): Failed to parse data from all battery packs.
2019-02-16T01:25:31.255Z,1550280331.255 [BPC1] Data Fault, FailCount= 2
2019-02-16T01:25:31.255Z,1550280331.255 [BPC1](ERROR): Data Fault
2019-02-16T01:25:31.281Z,1550280331.281 [CBIT](ERROR): Data Fault in component: BPC1
2019-02-16T01:25:34.033Z,1550280334.033 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:25:36.861Z,1550280336.861 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:25:40.093Z,1550280340.093 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:25:42.921Z,1550280342.921 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:25:45.749Z,1550280345.749 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:25:47.769Z,1550280347.769 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:25:50.998Z,1550280350.998 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:25:53.826Z,1550280353.826 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:25:57.061Z,1550280357.061 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:25:59.889Z,1550280359.889 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:26:03.121Z,1550280363.121 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:26:05.949Z,1550280365.949 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:26:08.778Z,1550280368.778 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:26:10.797Z,1550280370.797 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:26:12.817Z,1550280372.817 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:26:16.045Z,1550280376.045 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:26:18.873Z,1550280378.873 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:26:22.105Z,1550280382.105 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:26:24.937Z,1550280384.937 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:26:28.170Z,1550280388.170 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:26:30.993Z,1550280390.993 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:26:33.825Z,1550280393.825 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:26:35.841Z,1550280395.841 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:26:39.077Z,1550280399.077 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:26:41.905Z,1550280401.905 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:26:45.137Z,1550280405.137 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:26:47.965Z,1550280407.965 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:26:51.189Z,1550280411.189 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:26:54.025Z,1550280414.025 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:26:56.853Z,1550280416.853 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:26:58.873Z,1550280418.873 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:27:00.893Z,1550280420.893 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:27:04.121Z,1550280424.121 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:27:05.762Z,1550280425.762 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2019-02-16T01:27:05.762Z,1550280425.762 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-02-16T01:27:05.763Z,1550280425.763 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 8
2019-02-16T01:27:05.763Z,1550280425.763 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-02-16T01:27:05.764Z,1550280425.764 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 8
2019-02-16T01:27:05.764Z,1550280425.764 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-02-16T01:27:05.775Z,1550280425.775 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-02-16T01:27:05.775Z,1550280425.775 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-02-16T01:27:05.776Z,1550280425.776 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-02-16T01:27:06.179Z,1550280426.179 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-02-16T01:27:06.179Z,1550280426.179 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2019-02-16T01:27:06.180Z,1550280426.180 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-02-16T01:27:06.180Z,1550280426.180 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 8
2019-02-16T01:27:06.180Z,1550280426.180 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-02-16T01:27:06.180Z,1550280426.180 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 8
2019-02-16T01:27:06.571Z,1550280426.571 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-02-16T01:27:06.953Z,1550280426.953 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:27:10.185Z,1550280430.185 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:27:13.012Z,1550280433.012 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:27:13.141Z,1550280433.141 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2019-02-16T01:27:13.141Z,1550280433.141 [Rowe_600LCM] Communications Fault, FailCount= 2
2019-02-16T01:27:13.142Z,1550280433.142 [Rowe_600LCM](ERROR): Communications Fault
2019-02-16T01:27:13.465Z,1550280433.465 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2019-02-16T01:27:13.546Z,1550280433.546 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2019-02-16T01:27:13.644Z,1550280433.644 [Rowe_600LCM](INFO): Powering down
2019-02-16T01:27:15.062Z,1550280435.062 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2019-02-16T01:27:15.062Z,1550280435.062 [Rowe_600LCM] No Fault, FailCount= 2
2019-02-16T01:27:15.261Z,1550280435.261 [Rowe_600LCM](INFO): Initializing
2019-02-16T01:27:15.262Z,1550280435.262 [Rowe_600LCM](INFO): Powering up
2019-02-16T01:27:16.245Z,1550280436.245 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:27:19.073Z,1550280439.073 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:27:19.386Z,1550280439.386 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2019-02-16T01:27:19.440Z,1550280439.440 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null &
2019-02-16T01:27:21.905Z,1550280441.905 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:27:23.921Z,1550280443.921 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:27:27.153Z,1550280447.153 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:27:29.977Z,1550280449.977 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:27:33.213Z,1550280453.213 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:27:36.041Z,1550280456.041 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:27:39.269Z,1550280459.269 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:27:42.097Z,1550280462.097 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:27:44.925Z,1550280464.925 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:27:46.945Z,1550280466.945 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:27:48.970Z,1550280468.970 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:27:52.209Z,1550280472.209 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:27:55.033Z,1550280475.033 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:27:58.261Z,1550280478.261 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:28:01.089Z,1550280481.089 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:28:04.321Z,1550280484.321 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:28:07.149Z,1550280487.149 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:28:09.977Z,1550280489.977 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:28:12.001Z,1550280492.001 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:28:15.230Z,1550280495.230 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:28:18.057Z,1550280498.057 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:28:21.289Z,1550280501.289 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:28:24.113Z,1550280504.113 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:28:27.346Z,1550280507.346 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:28:30.173Z,1550280510.173 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:28:33.005Z,1550280513.005 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:28:35.025Z,1550280515.025 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:28:38.257Z,1550280518.257 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:28:41.081Z,1550280521.081 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:28:44.317Z,1550280524.317 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:28:47.145Z,1550280527.145 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:28:50.373Z,1550280530.373 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:28:53.201Z,1550280533.201 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:28:56.033Z,1550280536.033 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:28:58.053Z,1550280538.053 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:29:00.069Z,1550280540.069 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:29:03.301Z,1550280543.301 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:29:06.133Z,1550280546.133 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:29:09.365Z,1550280549.365 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:29:12.193Z,1550280552.193 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:29:15.425Z,1550280555.425 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:29:15.673Z,1550280555.673 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2019-02-16T01:29:15.673Z,1550280555.673 [Rowe_600LCM] Communications Fault, FailCount= 3
2019-02-16T01:29:15.674Z,1550280555.674 [Rowe_600LCM](ERROR): Communications Fault
2019-02-16T01:29:15.882Z,1550280555.882 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2019-02-16T01:29:16.078Z,1550280556.078 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2019-02-16T01:29:16.162Z,1550280556.162 [Rowe_600LCM](INFO): Powering down
2019-02-16T01:29:17.476Z,1550280557.476 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2019-02-16T01:29:17.476Z,1550280557.476 [Rowe_600LCM] No Fault, FailCount= 3
2019-02-16T01:29:17.777Z,1550280557.777 [Rowe_600LCM](INFO): Initializing
2019-02-16T01:29:17.778Z,1550280557.778 [Rowe_600LCM](INFO): Powering up
2019-02-16T01:29:18.253Z,1550280558.253 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:29:21.077Z,1550280561.077 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:29:21.964Z,1550280561.964 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2019-02-16T01:29:22.052Z,1550280562.052 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null &
2019-02-16T01:29:23.097Z,1550280563.097 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:29:26.334Z,1550280566.334 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:29:29.169Z,1550280569.169 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:29:32.393Z,1550280572.393 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:29:35.221Z,1550280575.221 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:29:38.466Z,1550280578.466 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:29:40.894Z,1550280580.894 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-02-16T01:29:40.894Z,1550280580.894 [Default:CheckIn:C.Wait] Stopped
2019-02-16T01:29:40.894Z,1550280580.894 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-02-16T01:29:40.894Z,1550280580.894 [Default:CheckIn:D] Running Loop=1
2019-02-16T01:29:41.281Z,1550280581.281 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:29:41.316Z,1550280581.316 [Default:CheckIn:D] Stopped
2019-02-16T01:29:41.316Z,1550280581.316 [Default:CheckIn:E] Running Loop=1
2019-02-16T01:29:41.725Z,1550280581.725 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.077797 min 
2019-02-16T01:29:41.725Z,1550280581.725 [Default:CheckIn:E] Stopped
2019-02-16T01:29:41.725Z,1550280581.725 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-02-16T01:29:41.725Z,1550280581.725 [Default:CheckIn] Stopped
2019-02-16T01:29:41.726Z,1550280581.726 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-02-16T01:29:41.726Z,1550280581.726 [Default:CheckIn](INFO): Running loop #3
2019-02-16T01:29:41.726Z,1550280581.726 [Default:CheckIn] Running Loop=3
2019-02-16T01:29:41.726Z,1550280581.726 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-02-16T01:29:41.726Z,1550280581.726 [Default:CheckIn:Read_GPS] Running Loop=1
2019-02-16T01:29:44.109Z,1550280584.109 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:29:46.129Z,1550280586.129 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:29:48.084Z,1550280588.084 [CommandLine](IMPORTANT): got command configSet DropWeight.loadAtStartup 0.000000 bool persist
2019-02-16T01:29:48.084Z,1550280588.084 [CommandLine](IMPORTANT): configSet DropWeight.loadAtStartup requires a restart to take effect.
2019-02-16T01:29:48.154Z,1550280588.154 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:29:51.374Z,1550280591.374 [NAL9602](DEBUG): Fix Requested
2019-02-16T01:29:51.886Z,1550280591.886 [CommandLine](IMPORTANT): got command restart application
2019-02-16T01:29:52.890Z,1550280592.890 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-16T01:29:52.890Z,1550280592.890 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-02-16T01:29:52.921Z,1550280592.921 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2019-02-16T01:29:52.922Z,1550280592.922 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-02-16T01:29:52.922Z,1550280592.922 [CommandLine](INFO): Join timeout helper Thread ID is 3765
2019-02-16T01:29:52.933Z,1550280592.933 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2019-02-16T01:29:52.934Z,1550280592.934 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-02-16T01:29:52.934Z,1550280592.934 [NavChartDb](INFO): Join timeout helper Thread ID is 3766
2019-02-16T01:29:53.254Z,1550280593.254 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-16T01:29:53.254Z,1550280593.254 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-02-16T01:29:53.266Z,1550280593.266 [ComponentRegistry](INFO): Shutting down Rowe_600LCM ThreadHandler
2019-02-16T01:29:53.266Z,1550280593.266 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled.
2019-02-16T01:29:53.266Z,1550280593.266 [Rowe_600LCM](INFO): Join timeout helper Thread ID is 3767
2019-02-16T01:29:53.506Z,1550280593.506 [Rowe_600LCM ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-16T01:29:53.506Z,1550280593.506 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2019-02-16T01:29:53.591Z,1550280593.591 [Rowe_600LCM](INFO): Powering down
2019-02-16T01:29:53.593Z,1550280593.593 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled.
2019-02-16T01:29:53.598Z,1550280593.598 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2019-02-16T01:29:53.598Z,1550280593.598 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-02-16T01:29:53.598Z,1550280593.598 [Radio_Surface](INFO): Join timeout helper Thread ID is 3769
2019-02-16T01:29:53.842Z,1550280593.842 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-16T01:29:53.842Z,1550280593.842 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-02-16T01:29:53.857Z,1550280593.857 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2019-02-16T01:29:53.858Z,1550280593.858 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-02-16T01:29:53.858Z,1550280593.858 [DataOverHttps](INFO): Join timeout helper Thread ID is 3770
2019-02-16T01:29:53.862Z,1550280593.862 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-16T01:29:53.871Z,1550280593.871 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-02-16T01:29:53.879Z,1550280593.879 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2019-02-16T01:29:53.879Z,1550280593.879 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-02-16T01:29:53.880Z,1550280593.880 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 3771
2019-02-16T01:29:53.970Z,1550280593.970 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-16T01:29:53.970Z,1550280593.970 [WetLabsBB2FL](INFO): Powering down
2019-02-16T01:29:53.971Z,1550280593.971 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-02-16T01:29:53.972Z,1550280593.972 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2019-02-16T01:29:53.972Z,1550280593.972 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-02-16T01:29:53.973Z,1550280593.973 [CTD_Seabird](INFO): Join timeout helper Thread ID is 3772
2019-02-16T01:29:53.973Z,1550280593.973 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-16T01:29:53.974Z,1550280593.974 [CTD_Seabird](INFO): Powering down
2019-02-16T01:29:53.986Z,1550280593.986 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-02-16T01:29:53.994Z,1550280593.994 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2019-02-16T01:29:53.994Z,1550280593.994 [logger ThreadHandler](INFO): Thread cancelled.
2019-02-16T01:29:53.995Z,1550280593.995 [logger](INFO): Join timeout helper Thread ID is 3773
2019-02-16T01:29:53.998Z,1550280593.998 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-16T01:29:53.998Z,1550280593.998 [logger ThreadHandler](INFO): Thread cancelled.
2019-02-16T01:29:54.014Z,1550280594.014 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2019-02-16T01:29:54.014Z,1550280594.014 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-02-16T01:29:54.014Z,1550280594.014 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2019-02-16T01:29:54.014Z,1550280594.014 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-02-16T01:29:54.015Z,1550280594.015 [controlThread](INFO): Join timeout helper Thread ID is 3774
2019-02-16T01:29:54.181Z,1550280594.181 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-16T01:29:54.182Z,1550280594.182 [controlThread](DEBUG): Uninitializing ControlThread
2019-02-16T01:29:54.182Z,1550280594.182 [Aanderaa_O2](INFO): Powering down
2019-02-16T01:29:54.186Z,1550280594.186 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-02-16T01:29:54.306Z,1550280594.306 [NAL9602](INFO): Powering down
2019-02-16T01:29:54.307Z,1550280594.307 [PNI_TCM](INFO): Powering down
2019-02-16T01:29:54.394Z,1550280594.394 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2019-02-16T01:29:54.395Z,1550280594.395 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2019-02-16T01:29:54.396Z,1550280594.396 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2019-02-16T01:29:54.396Z,1550280594.396 [MissionManager](INFO): Uninitializing Mission Default
2019-02-16T01:29:54.397Z,1550280594.397 [Default] Stopped
2019-02-16T01:29:54.397Z,1550280594.397 [Default](DEBUG): Aggregate::uninitialize Default
2019-02-16T01:29:54.397Z,1550280594.397 [Default:B.GoToSurface] Stopped
2019-02-16T01:29:54.397Z,1550280594.397 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-02-16T01:29:54.397Z,1550280594.397 [Default:CheckIn] Stopped
2019-02-16T01:29:54.397Z,1550280594.397 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-02-16T01:29:54.397Z,1550280594.397 [Default:CheckIn:Read_GPS] Stopped
2019-02-16T01:29:54.400Z,1550280594.400 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2019-02-16T01:29:54.400Z,1550280594.400 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2019-02-16T01:29:54.400Z,1550280594.400 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2019-02-16T01:29:54.400Z,1550280594.400 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2019-02-16T01:29:54.401Z,1550280594.401 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-02-16T01:29:54.401Z,1550280594.401 [BuoyancyServo](INFO): Powering down
2019-02-16T01:29:54.414Z,1550280594.414 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-02-16T01:29:54.414Z,1550280594.414 [ElevatorServo](INFO): Powering down
2019-02-16T01:29:54.415Z,1550280594.415 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-02-16T01:29:54.415Z,1550280594.415 [MassServo](INFO): Powering down
2019-02-16T01:29:54.415Z,1550280594.415 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-02-16T01:29:54.416Z,1550280594.416 [RudderServo](INFO): Powering down
2019-02-16T01:29:54.416Z,1550280594.416 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2019-02-16T01:29:54.416Z,1550280594.416 [ThrusterServo](INFO): Powering down
2019-02-16T01:29:54.417Z,1550280594.417 [SBIT](DEBUG): Uninitialize SBIT Component.
2019-02-16T01:29:54.418Z,1550280594.418 [IBIT](DEBUG): Uninitialize IBIT Component.
2019-02-16T01:29:54.418Z,1550280594.418 [CBIT](DEBUG): Uninitialize CBIT Component.
2019-02-16T01:29:54.418Z,1550280594.418 [CBIT](DEBUG): Powering off loads.
2019-02-16T01:29:54.429Z,1550280594.429 [CBIT](DEBUG): Disabling WDT.
2019-02-16T01:29:54.441Z,1550280594.441 [CBIT](DEBUG): Opening all GF detection circuits.
2019-02-16T01:29:54.442Z,1550280594.442 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-02-16T01:29:54.494Z,1550280594.494 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-02-16T01:29:54.499Z,1550280594.499 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-02-16T01:29:54.576Z,1550280594.576 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled.
2019-02-16T01:29:54.581Z,1550280594.581 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-02-16T01:29:54.587Z,1550280594.587 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-02-16T01:29:54.636Z,1550280594.636 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-02-16T01:29:54.695Z,1550280594.695 [logger ThreadHandler](INFO): Thread cancelled.