2019-02-21T22:09:35.034Z,1550786975.034 [Supervisor](DEBUG): Initializing supervisor.
2019-02-21T22:09:35.058Z,1550786975.058 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-02-21T22:09:35.059Z,1550786975.059 [SyncHandler](INFO): Protected caller Thread ID is 1701
2019-02-21T22:09:35.059Z,1550786975.059 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2019-02-21T22:09:35.081Z,1550786975.081 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2019-02-21T22:09:35.081Z,1550786975.081 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1702
2019-02-21T22:09:35.084Z,1550786975.084 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2019-02-21T22:09:35.095Z,1550786975.095 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2019-02-21T22:09:35.101Z,1550786975.101 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2019-02-21T22:09:35.101Z,1550786975.101 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1703
2019-02-21T22:09:35.102Z,1550786975.102 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2019-02-21T22:09:35.121Z,1550786975.121 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2019-02-21T22:09:35.122Z,1550786975.122 [logger ThreadHandler](INFO): Protected caller Thread ID is 1704
2019-02-21T22:09:35.124Z,1550786975.124 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2019-02-21T22:09:35.124Z,1550786975.124 [Supervisor](INFO): Looking for Config files in directory: Config/
2019-02-21T22:09:35.126Z,1550786975.126 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2019-02-21T22:09:35.315Z,1550786975.315 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2019-02-21T22:09:35.316Z,1550786975.316 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2019-02-21T22:09:35.809Z,1550786975.809 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2019-02-21T22:09:35.810Z,1550786975.810 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2019-02-21T22:09:36.040Z,1550786976.040 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2019-02-21T22:09:36.041Z,1550786976.041 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2019-02-21T22:09:37.240Z,1550786977.240 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2019-02-21T22:09:37.241Z,1550786977.241 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2019-02-21T22:09:38.428Z,1550786978.428 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2019-02-21T22:09:38.429Z,1550786978.429 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2019-02-21T22:09:39.812Z,1550786979.812 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2019-02-21T22:09:39.812Z,1550786979.812 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2019-02-21T22:09:40.792Z,1550786980.792 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2019-02-21T22:09:40.792Z,1550786980.792 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2019-02-21T22:09:41.649Z,1550786981.649 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2019-02-21T22:09:41.650Z,1550786981.650 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2019-02-21T22:09:42.585Z,1550786982.585 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2019-02-21T22:09:42.586Z,1550786982.586 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2019-02-21T22:09:42.999Z,1550786982.999 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2019-02-21T22:09:42.999Z,1550786982.999 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2019-02-21T22:09:43.296Z,1550786983.296 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2019-02-21T22:09:43.297Z,1550786983.297 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2019-02-21T22:09:43.508Z,1550786983.508 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2019-02-21T22:09:43.724Z,1550786983.724 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2019-02-21T22:09:43.724Z,1550786983.724 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2019-02-21T22:09:44.230Z,1550786984.230 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2019-02-21T22:09:44.230Z,1550786984.230 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2019-02-21T22:09:44.898Z,1550786984.898 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2019-02-21T22:09:44.900Z,1550786984.900 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2019-02-21T22:09:44.901Z,1550786984.901 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2019-02-21T22:09:45.100Z,1550786985.100 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2019-02-21T22:09:45.596Z,1550786985.596 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2019-02-21T22:09:45.596Z,1550786985.596 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2019-02-21T22:09:45.798Z,1550786985.798 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2019-02-21T22:09:46.171Z,1550786986.171 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2019-02-21T22:09:46.718Z,1550786986.718 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2019-02-21T22:09:46.876Z,1550786986.876 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2019-02-21T22:09:47.043Z,1550786987.043 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2019-02-21T22:09:47.230Z,1550786987.230 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2019-02-21T22:09:47.668Z,1550786987.668 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2019-02-21T22:09:47.960Z,1550786987.960 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2019-02-21T22:09:48.193Z,1550786988.193 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2019-02-21T22:09:48.198Z,1550786988.198 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2019-02-21T22:09:48.488Z,1550786988.488 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2019-02-21T22:09:48.493Z,1550786988.493 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2019-02-21T22:09:48.825Z,1550786988.825 [BuoyancyServo] Loaded
2019-02-21T22:09:48.825Z,1550786988.825 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2019-02-21T22:09:48.849Z,1550786988.849 [ElevatorServo] Loaded
2019-02-21T22:09:48.849Z,1550786988.849 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2019-02-21T22:09:48.879Z,1550786988.879 [MassServo] Loaded
2019-02-21T22:09:48.879Z,1550786988.879 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2019-02-21T22:09:48.935Z,1550786988.935 [RudderServo] Loaded
2019-02-21T22:09:48.935Z,1550786988.935 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2019-02-21T22:09:48.983Z,1550786988.983 [ThrusterServo] Loaded
2019-02-21T22:09:48.984Z,1550786988.984 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2019-02-21T22:09:48.984Z,1550786988.984 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2019-02-21T22:09:48.985Z,1550786988.985 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2019-02-21T22:09:49.370Z,1550786989.370 [SBIT](DEBUG): Construct Startup Built In Test.
2019-02-21T22:09:49.483Z,1550786989.483 [SBIT] Loaded
2019-02-21T22:09:49.483Z,1550786989.483 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2019-02-21T22:09:49.484Z,1550786989.484 [IBIT](DEBUG): Construct Initiated Built In Test.
2019-02-21T22:09:49.589Z,1550786989.589 [IBIT] Loaded
2019-02-21T22:09:49.590Z,1550786989.590 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2019-02-21T22:09:49.597Z,1550786989.597 [CBIT](DEBUG): Construct Continuous Built In Test.
2019-02-21T22:09:50.652Z,1550786990.652 [CBIT] Loaded
2019-02-21T22:09:50.652Z,1550786990.652 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2019-02-21T22:09:50.653Z,1550786990.653 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2019-02-21T22:09:50.653Z,1550786990.653 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2019-02-21T22:09:51.158Z,1550786991.158 [Aanderaa_O2] Loaded
2019-02-21T22:09:51.158Z,1550786991.158 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2019-02-21T22:09:51.192Z,1550786991.192 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density
2019-02-21T22:09:51.197Z,1550786991.197 [CTD_Seabird](INFO): created writer for : sea_water_density
2019-02-21T22:09:51.199Z,1550786991.199 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth
2019-02-21T22:09:51.224Z,1550786991.224 [CTD_Seabird](INFO): created writer for : depth
2019-02-21T22:09:51.224Z,1550786991.224 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure
2019-02-21T22:09:51.230Z,1550786991.230 [CTD_Seabird](INFO): created writer for : sea_water_pressure
2019-02-21T22:09:51.231Z,1550786991.231 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity
2019-02-21T22:09:51.236Z,1550786991.236 [CTD_Seabird](INFO): created writer for : sea_water_salinity
2019-02-21T22:09:51.236Z,1550786991.236 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature
2019-02-21T22:09:51.256Z,1550786991.256 [CTD_Seabird](INFO): created writer for : sea_water_temperature
2019-02-21T22:09:51.257Z,1550786991.257 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity
2019-02-21T22:09:51.263Z,1550786991.263 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity
2019-02-21T22:09:51.263Z,1550786991.263 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water
2019-02-21T22:09:51.276Z,1550786991.276 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water
2019-02-21T22:09:51.356Z,1550786991.356 [CTD_Seabird] Loaded
2019-02-21T22:09:51.357Z,1550786991.357 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2019-02-21T22:09:51.389Z,1550786991.389 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406644E0
2019-02-21T22:09:51.389Z,1550786991.389 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1871
2019-02-21T22:09:51.447Z,1550786991.447 [ESPComponent] Loaded
2019-02-21T22:09:51.447Z,1550786991.447 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2019-02-21T22:09:51.496Z,1550786991.496 [PAR_Licor] Loaded
2019-02-21T22:09:51.496Z,1550786991.496 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2019-02-21T22:09:51.622Z,1550786991.622 [WetLabsBB2FL] Loaded
2019-02-21T22:09:51.623Z,1550786991.623 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2019-02-21T22:09:51.651Z,1550786991.651 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406944E0
2019-02-21T22:09:51.652Z,1550786991.652 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1872
2019-02-21T22:09:51.652Z,1550786991.652 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2019-02-21T22:09:51.653Z,1550786991.653 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2019-02-21T22:09:51.721Z,1550786991.721 [DepthRateCalculator] Loaded
2019-02-21T22:09:51.721Z,1550786991.721 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2019-02-21T22:09:51.726Z,1550786991.726 [PitchRateCalculator] Loaded
2019-02-21T22:09:51.727Z,1550786991.727 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2019-02-21T22:09:51.767Z,1550786991.767 [SpeedCalculator] Loaded
2019-02-21T22:09:51.767Z,1550786991.767 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2019-02-21T22:09:51.808Z,1550786991.808 [TempGradientCalculator] Loaded
2019-02-21T22:09:51.809Z,1550786991.809 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2019-02-21T22:09:51.815Z,1550786991.815 [YawRateCalculator] Loaded
2019-02-21T22:09:51.815Z,1550786991.815 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2019-02-21T22:09:51.904Z,1550786991.904 [ElevatorOffsetCalculator] Loaded
2019-02-21T22:09:51.904Z,1550786991.904 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2019-02-21T22:09:51.905Z,1550786991.905 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2019-02-21T22:09:51.905Z,1550786991.905 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2019-02-21T22:09:51.984Z,1550786991.984 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2019-02-21T22:09:51.984Z,1550786991.984 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2019-02-21T22:09:52.270Z,1550786992.270 [DeadReckonUsingMultipleVelocitySources] Loaded
2019-02-21T22:09:52.270Z,1550786992.270 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2019-02-21T22:09:52.355Z,1550786992.355 [DeadReckonUsingSpeedCalculator] Loaded
2019-02-21T22:09:52.355Z,1550786992.355 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2019-02-21T22:09:52.516Z,1550786992.516 [DeadReckonWithRespectToSeafloor] Loaded
2019-02-21T22:09:52.516Z,1550786992.516 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2019-02-21T22:09:52.552Z,1550786992.552 [NavChart] Loaded
2019-02-21T22:09:52.552Z,1550786992.552 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2019-02-21T22:09:52.556Z,1550786992.556 [UniversalFixResidualReporter] Loaded
2019-02-21T22:09:52.577Z,1550786992.577 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2019-02-21T22:09:52.577Z,1550786992.577 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2019-02-21T22:09:52.578Z,1550786992.578 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2019-02-21T22:09:53.455Z,1550786993.455 [AcousticModem_Benthos_ATM900] Loaded
2019-02-21T22:09:53.456Z,1550786993.456 [ComponentRegistry](DEBUG): SyncComponent "AcousticModem_Benthos_ATM900" handled in the control thread.
2019-02-21T22:09:53.650Z,1550786993.650 [DataOverHttps] Loaded
2019-02-21T22:09:53.651Z,1550786993.651 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2019-02-21T22:09:53.664Z,1550786993.664 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4095B4E0
2019-02-21T22:09:53.664Z,1550786993.664 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1885
2019-02-21T22:09:53.677Z,1550786993.677 [Depth_Keller] Loaded
2019-02-21T22:09:53.677Z,1550786993.677 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2019-02-21T22:09:53.918Z,1550786993.918 [NAL9602] Loaded
2019-02-21T22:09:53.918Z,1550786993.918 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2019-02-21T22:09:53.923Z,1550786993.923 [Onboard] Loaded
2019-02-21T22:09:53.923Z,1550786993.923 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2019-02-21T22:09:53.943Z,1550786993.943 [Radio_Surface] Loaded
2019-02-21T22:09:53.944Z,1550786993.944 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2019-02-21T22:09:53.965Z,1550786993.965 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4098B4E0
2019-02-21T22:09:53.965Z,1550786993.965 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1890
2019-02-21T22:09:54.168Z,1550786994.168 [PNI_TCM] Loaded
2019-02-21T22:09:54.168Z,1550786994.168 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread.
2019-02-21T22:09:58.808Z,1550786998.808 [BPC1] Loaded
2019-02-21T22:09:58.808Z,1550786998.808 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2019-02-21T22:09:58.809Z,1550786998.809 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2019-02-21T22:09:58.809Z,1550786998.809 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2019-02-21T22:09:59.915Z,1550786999.915 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2019-02-21T22:09:59.916Z,1550786999.916 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2019-02-21T22:10:00.130Z,1550787000.130 [VerticalControl](DEBUG): Construct VerticalControl.
2019-02-21T22:10:00.316Z,1550787000.316 [VerticalControl] Loaded
2019-02-21T22:10:00.317Z,1550787000.317 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2019-02-21T22:10:00.317Z,1550787000.317 [HorizontalControl](DEBUG): Construct HorizontalControl.
2019-02-21T22:10:00.495Z,1550787000.495 [HorizontalControl] Loaded
2019-02-21T22:10:00.495Z,1550787000.495 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2019-02-21T22:10:00.496Z,1550787000.496 [SpeedControl](DEBUG): Construct SpeedControl.
2019-02-21T22:10:00.515Z,1550787000.515 [SpeedControl] Loaded
2019-02-21T22:10:00.515Z,1550787000.515 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2019-02-21T22:10:00.516Z,1550787000.516 [LoopControl](DEBUG): Construct LoopControl.
2019-02-21T22:10:00.517Z,1550787000.517 [LoopControl] Loaded
2019-02-21T22:10:00.517Z,1550787000.517 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2019-02-21T22:10:00.517Z,1550787000.517 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2019-02-21T22:10:00.518Z,1550787000.518 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2019-02-21T22:10:00.608Z,1550787000.608 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2019-02-21T22:10:00.608Z,1550787000.608 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2019-02-21T22:10:01.273Z,1550787001.273 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2019-02-21T22:10:01.277Z,1550787001.277 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2019-02-21T22:10:01.278Z,1550787001.278 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2019-02-21T22:10:01.303Z,1550787001.303 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2019-02-21T22:10:01.319Z,1550787001.319 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AAD4E0
2019-02-21T22:10:01.320Z,1550787001.320 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1927
2019-02-21T22:10:01.324Z,1550787001.324 [Supervisor](INFO): Main Thread ID is 1696
2019-02-21T22:10:01.325Z,1550787001.325 [Supervisor](DEBUG): Running supervisor.
2019-02-21T22:10:01.345Z,1550787001.345 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1928
2019-02-21T22:10:01.357Z,1550787001.357 [controlThread ThreadHandler](INFO): Handler Thread ID is 1929
2019-02-21T22:10:01.358Z,1550787001.358 [controlThread](DEBUG): Initializing ControlThread
2019-02-21T22:10:01.359Z,1550787001.359 [SBIT](INFO): Initialize SBIT Component.
2019-02-21T22:10:01.359Z,1550787001.359 [SBIT](IMPORTANT): git: 2019-02-11-71-g9c7399e
2019-02-21T22:10:01.360Z,1550787001.360 [SBIT](INFO): git hash: 9c7399e77d563bdda1c6e0d72b5b07cc90ba4f4b
2019-02-21T22:10:01.360Z,1550787001.360 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2019-02-21T22:10:01.361Z,1550787001.361 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019
2019-02-21T22:10:01.363Z,1550787001.363 [SBIT](INFO): Beginning SBIT in 24.000000 seconds.
2019-02-21T22:10:01.363Z,1550787001.363 [IBIT](INFO): Initialize IBIT Component.
2019-02-21T22:10:01.364Z,1550787001.364 [CBIT](DEBUG): Initialize CBIT Component.
2019-02-21T22:10:01.377Z,1550787001.377 [CBIT](DEBUG): Initialized mux pins.
2019-02-21T22:10:01.377Z,1550787001.377 [CBIT](DEBUG): Initializing the watchdog timer.
2019-02-21T22:10:01.378Z,1550787001.378 [logger ThreadHandler](INFO): Handler Thread ID is 1930
2019-02-21T22:10:01.401Z,1550787001.401 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2019-02-21T22:10:01.401Z,1550787001.401 [CBIT](DEBUG): Initializing heartbeat.
2019-02-21T22:10:01.414Z,1550787001.414 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1931
2019-02-21T22:10:01.414Z,1550787001.414 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-02-21T22:10:01.421Z,1550787001.421 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1933
2019-02-21T22:10:01.423Z,1550787001.423 [WetLabsBB2FL](INFO): Powering down
2019-02-21T22:10:01.441Z,1550787001.441 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-02-21T22:10:01.473Z,1550787001.473 [CBIT](DEBUG): Deactivating GF circuits.
2019-02-21T22:10:01.473Z,1550787001.473 [CBIT](DEBUG): Deactivating emergency mode.
2019-02-21T22:10:01.489Z,1550787001.489 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1934
2019-02-21T22:10:01.490Z,1550787001.490 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2019-02-21T22:10:01.513Z,1550787001.513 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2019-02-21T22:10:01.514Z,1550787001.514 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2019-02-21T22:10:01.514Z,1550787001.514 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2019-02-21T22:10:01.514Z,1550787001.514 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2019-02-21T22:10:01.515Z,1550787001.515 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2019-02-21T22:10:01.515Z,1550787001.515 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2019-02-21T22:10:01.516Z,1550787001.516 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-02-21T22:10:01.517Z,1550787001.517 [NavChart](DEBUG): Initialize NavChart Navigation.
2019-02-21T22:10:01.518Z,1550787001.518 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2019-02-21T22:10:01.522Z,1550787001.522 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2019-02-21T22:10:01.524Z,1550787001.524 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2019-02-21T22:10:01.525Z,1550787001.525 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2019-02-21T22:10:01.525Z,1550787001.525 [LoopControl](DEBUG): Initialize LoopControlComponent.
2019-02-21T22:10:01.526Z,1550787001.526 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2019-02-21T22:10:01.537Z,1550787001.537 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1935
2019-02-21T22:10:01.558Z,1550787001.558 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2019-02-21T22:10:01.565Z,1550787001.565 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1936
2019-02-21T22:10:01.568Z,1550787001.568 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2019-02-21T22:10:01.568Z,1550787001.568 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2019-02-21T22:10:01.569Z,1550787001.569 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2019-02-21T22:10:01.569Z,1550787001.569 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2019-02-21T22:10:01.569Z,1550787001.569 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2019-02-21T22:10:01.569Z,1550787001.569 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2019-02-21T22:10:01.570Z,1550787001.570 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2019-02-21T22:10:01.570Z,1550787001.570 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2019-02-21T22:10:01.570Z,1550787001.570 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2019-02-21T22:10:01.570Z,1550787001.570 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2019-02-21T22:10:01.570Z,1550787001.570 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2019-02-21T22:10:01.571Z,1550787001.571 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2019-02-21T22:10:01.571Z,1550787001.571 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2019-02-21T22:10:01.571Z,1550787001.571 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2019-02-21T22:10:01.571Z,1550787001.571 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2019-02-21T22:10:01.571Z,1550787001.571 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2019-02-21T22:10:01.668Z,1550787001.668 [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-21T22:10:01.685Z,1550787001.685 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2019-02-21T22:10:01.816Z,1550787001.816 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2019-02-21T22:10:01.834Z,1550787001.834 [Default:A.Wait](DEBUG): Construct Wait.
2019-02-21T22:10:01.835Z,1550787001.835 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2019-02-21T22:10:01.906Z,1550787001.906 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2019-02-21T22:10:01.925Z,1550787001.925 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2019-02-21T22:10:01.941Z,1550787001.941 [Radio_Surface](INFO): Powering up
2019-02-21T22:10:01.948Z,1550787001.948 [Default:E.Execute](DEBUG): Construct Execute.
2019-02-21T22:10:01.975Z,1550787001.975 [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-21T22:10:01.980Z,1550787001.980 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,ESPComponent,PAR_Licor,AcousticModem_Benthos_ATM900,Depth_Keller,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-21T22:10:02.037Z,1550787002.037 [ESPComponent](INFO): powering down ESP
2019-02-21T22:10:02.805Z,1550787002.805 [PAR_Licor](INFO): A/D timeout, 10 tries over 127 ms

2019-02-21T22:10:02.806Z,1550787002.806 [PAR_Licor] Data Fault, FailCount= 1
2019-02-21T22:10:02.806Z,1550787002.806 [PAR_Licor](ERROR): Data Fault
2019-02-21T22:10:02.806Z,1550787002.806 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-02-21T22:10:02.807Z,1550787002.807 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-02-21T22:10:03.073Z,1550787003.073 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-02-21T22:10:03.093Z,1550787003.093 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-02-21T22:10:03.094Z,1550787003.094 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-02-21T22:10:03.117Z,1550787003.117 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-02-21T22:10:03.118Z,1550787003.118 [MassServo](DEBUG): Initializing EZServoServo.
2019-02-21T22:10:03.149Z,1550787003.149 [MassServo](DEBUG): Initializing MassServo.
2019-02-21T22:10:03.150Z,1550787003.150 [RudderServo](DEBUG): Initializing EZServoServo.
2019-02-21T22:10:03.189Z,1550787003.189 [RudderServo](DEBUG): Initializing RudderServo.
2019-02-21T22:10:03.190Z,1550787003.190 [ThrusterServo](DEBUG): Initializing EZServoServo.
2019-02-21T22:10:03.213Z,1550787003.213 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2019-02-21T22:10:03.220Z,1550787003.220 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-02-21T22:10:03.220Z,1550787003.220 [CBIT](INFO): Clearing failed state for component PAR_Licor
2019-02-21T22:10:03.220Z,1550787003.220 [PAR_Licor] No Fault, FailCount= 1
2019-02-21T22:10:04.005Z,1550787004.005 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2019-02-21T22:10:04.005Z,1550787004.005 [RudderServo](FAULT): Rudder failed to initialize
2019-02-21T22:10:04.005Z,1550787004.005 [RudderServo] Communications Fault, FailCount= 1
2019-02-21T22:10:04.005Z,1550787004.005 [RudderServo](ERROR): Communications Fault
2019-02-21T22:10:04.164Z,1550787004.164 [CBIT](ERROR): Communications Fault in component: RudderServo
2019-02-21T22:10:04.394Z,1550787004.394 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-02-21T22:10:04.394Z,1550787004.394 [RudderServo](INFO): Powering down
2019-02-21T22:10:05.113Z,1550787005.113 [PAR_Licor](INFO): A/D timeout, 6 tries over 133 ms

2019-02-21T22:10:05.113Z,1550787005.113 [PAR_Licor] Data Fault, FailCount= 1
2019-02-21T22:10:05.113Z,1550787005.113 [PAR_Licor](ERROR): Data Fault
2019-02-21T22:10:05.252Z,1550787005.252 [RudderServo](DEBUG): Initializing EZServoServo.
2019-02-21T22:10:05.370Z,1550787005.370 [RudderServo](DEBUG): Initializing RudderServo.
2019-02-21T22:10:05.376Z,1550787005.376 [CBIT](INFO): Clearing failed state for component RudderServo
2019-02-21T22:10:05.376Z,1550787005.376 [RudderServo] No Fault, FailCount= 1
2019-02-21T22:10:05.376Z,1550787005.376 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-02-21T22:10:05.376Z,1550787005.376 [CBIT](INFO): Clearing failed state for component PAR_Licor
2019-02-21T22:10:05.376Z,1550787005.376 [PAR_Licor] No Fault, FailCount= 1
2019-02-21T22:10:06.745Z,1550787006.745 [PAR_Licor](INFO): A/D timeout, 10 tries over 148 ms

2019-02-21T22:10:06.745Z,1550787006.745 [PAR_Licor] Data Fault, FailCount= 1
2019-02-21T22:10:06.745Z,1550787006.745 [PAR_Licor](ERROR): Data Fault
2019-02-21T22:10:07.049Z,1550787007.049 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-02-21T22:10:07.049Z,1550787007.049 [CBIT](INFO): Clearing failed state for component PAR_Licor
2019-02-21T22:10:07.049Z,1550787007.049 [PAR_Licor] No Fault, FailCount= 1
2019-02-21T22:10:07.173Z,1550787007.173 [Aanderaa_O2](INFO): Powering down
2019-02-21T22:10:07.989Z,1550787007.989 [PAR_Licor](INFO): A/D timeout, 8 tries over 125 ms

2019-02-21T22:10:07.989Z,1550787007.989 [PAR_Licor] Data Fault, FailCount= 1
2019-02-21T22:10:07.989Z,1550787007.989 [PAR_Licor](ERROR): Data Fault
2019-02-21T22:10:08.121Z,1550787008.121 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-02-21T22:10:08.121Z,1550787008.121 [CBIT](INFO): Clearing failed state for component PAR_Licor
2019-02-21T22:10:08.121Z,1550787008.121 [PAR_Licor] No Fault, FailCount= 1
2019-02-21T22:10:08.502Z,1550787008.502 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit.
2019-02-21T22:10:10.298Z,1550787010.298 [AcousticModem_Benthos_ATM900](DEBUG): 
2019-02-21T22:10:10.317Z,1550787010.317 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2019-02-21T22:10:10.317Z,1550787010.317 [PNI_TCM] Data Fault, FailCount= 1
2019-02-21T22:10:10.317Z,1550787010.317 [PNI_TCM](ERROR): Data Fault
2019-02-21T22:10:10.462Z,1550787010.462 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-02-21T22:10:10.759Z,1550787010.759 [PNI_TCM](INFO): Powering down
2019-02-21T22:10:11.511Z,1550787011.511 [AcousticModem_Benthos_ATM900](DEBUG): Teledyne Benthos ATM-900 Series OEM w/burn wire
2019-02-21T22:10:11.511Z,1550787011.511 [AcousticModem_Benthos_ATM900](DEBUG): MF Frequency Band
2019-02-21T22:10:11.512Z,1550787011.512 [AcousticModem_Benthos_ATM900](DEBUG): Standard version 8.6.3
2019-02-21T22:10:11.638Z,1550787011.638 [CBIT](CRITICAL): Environmental Failure. Press:14.572789 PSI. Humidity:22%. Temp:25 C. ABORTING MISSION
2019-02-21T22:10:11.638Z,1550787011.638 [Supervisor](INFO): Stop Mission called by CBIT::monitorEnvironmentals
2019-02-21T22:10:12.027Z,1550787012.027 [AcousticModem_Benthos_ATM900](DEBUG): Feb 12 2019 19:37:03 
2019-02-21T22:10:12.027Z,1550787012.027 [AcousticModem_Benthos_ATM900](DEBUG): WARNING: battery low
2019-02-21T22:10:12.207Z,1550787012.207 [CommandLine](FAULT): Scheduling is paused
2019-02-21T22:10:12.208Z,1550787012.208 [CBIT](INFO): Critical error at 20190221T221011
2019-02-21T22:10:12.210Z,1550787012.210 [CBIT](INFO): Clearing failed state for component PNI_TCM
2019-02-21T22:10:12.210Z,1550787012.210 [PNI_TCM] No Fault, FailCount= 1
2019-02-21T22:10:12.441Z,1550787012.441 [PAR_Licor](INFO): A/D timeout, 6 tries over 125 ms

2019-02-21T22:10:12.441Z,1550787012.441 [PAR_Licor] Data Fault, FailCount= 1
2019-02-21T22:10:12.441Z,1550787012.441 [PAR_Licor](ERROR): Data Fault
2019-02-21T22:10:12.645Z,1550787012.645 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-02-21T22:10:12.645Z,1550787012.645 [CBIT](INFO): Clearing failed state for component PAR_Licor
2019-02-21T22:10:12.645Z,1550787012.645 [PAR_Licor] No Fault, FailCount= 1
2019-02-21T22:10:12.725Z,1550787012.725 [AcousticModem_Benthos_ATM900](INFO): entering command mode
2019-02-21T22:10:13.273Z,1550787013.273 [PAR_Licor](INFO): A/D timeout, 8 tries over 148 ms

2019-02-21T22:10:13.273Z,1550787013.273 [PAR_Licor] Data Fault, FailCount= 2
2019-02-21T22:10:13.273Z,1550787013.273 [PAR_Licor](ERROR): Data Fault
2019-02-21T22:10:13.278Z,1550787013.278 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2019-02-21T22:10:13.278Z,1550787013.278 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt 1: user:1>
2019-02-21T22:10:13.279Z,1550787013.279 [AcousticModem_Benthos_ATM900](INFO): command mode acknowledged
2019-02-21T22:10:13.403Z,1550787013.403 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-02-21T22:10:13.403Z,1550787013.403 [CBIT](INFO): Clearing failed state for component PAR_Licor
2019-02-21T22:10:13.403Z,1550787013.403 [PAR_Licor] No Fault, FailCount= 2
2019-02-21T22:10:13.529Z,1550787013.529 [AcousticModem_Benthos_ATM900](INFO): setting local address to 3
2019-02-21T22:10:14.066Z,1550787014.066 [PAR_Licor](INFO): A/D timeout, 13 tries over 133 ms

2019-02-21T22:10:14.066Z,1550787014.066 [PAR_Licor] Data Fault, FailCount= 3
2019-02-21T22:10:14.066Z,1550787014.066 [PAR_Licor](ERROR): Data Fault
2019-02-21T22:10:14.066Z,1550787014.066 [AcousticModem_Benthos_ATM900](DEBUG): checking for local address setting acknowledgment
2019-02-21T22:10:14.067Z,1550787014.067 [AcousticModem_Benthos_ATM900](INFO): set local address to 3
2019-02-21T22:10:14.172Z,1550787014.172 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-02-21T22:10:14.173Z,1550787014.173 [CBIT](CRITICAL): Data Fault in component: PAR_Licor
2019-02-21T22:10:14.334Z,1550787014.334 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt 2: user:2>
2019-02-21T22:10:14.384Z,1550787014.384 [CBIT](INFO): Critical error at 20190221T221014
2019-02-21T22:10:19.605Z,1550787019.605 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2019-02-21T22:10:19.605Z,1550787019.605 [PNI_TCM] Data Fault, FailCount= 2
2019-02-21T22:10:19.606Z,1550787019.606 [PNI_TCM](ERROR): Data Fault
2019-02-21T22:10:19.646Z,1550787019.646 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-02-21T22:10:20.008Z,1550787020.008 [PNI_TCM](INFO): Powering down
2019-02-21T22:10:21.268Z,1550787021.268 [CBIT](INFO): Clearing failed state for component PNI_TCM
2019-02-21T22:10:21.268Z,1550787021.268 [PNI_TCM] No Fault, FailCount= 2
2019-02-21T22:10:24.034Z,1550787024.034 [NAL9602](INFO): Powering up NAL9602
2019-02-21T22:10:26.083Z,1550787026.083 [SBIT](IMPORTANT): Beginning Startup BIT
2019-02-21T22:10:26.088Z,1550787026.088 [CBIT](IMPORTANT): Beginning ground fault scan
2019-02-21T22:10:29.208Z,1550787029.208 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2019-02-21T22:10:29.209Z,1550787029.209 [PNI_TCM] Data Fault, FailCount= 3
2019-02-21T22:10:29.209Z,1550787029.209 [PNI_TCM](ERROR): Data Fault
2019-02-21T22:10:29.350Z,1550787029.350 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-02-21T22:10:29.601Z,1550787029.601 [PNI_TCM](INFO): Powering down
2019-02-21T22:10:30.986Z,1550787030.986 [CBIT](INFO): Clearing failed state for component PNI_TCM
2019-02-21T22:10:30.986Z,1550787030.986 [PNI_TCM] No Fault, FailCount= 3
2019-02-21T22:10:35.246Z,1550787035.246 [NAL9602](INFO): NAL9602 initialized
2019-02-21T22:10:36.057Z,1550787036.057 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:10:37.342Z,1550787037.342 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.007931
CHAN A1 (24V): -0.012073
CHAN A2 (12V): -0.005463
CHAN A3 (5V): -0.002478
CHAN B0 (3.3V): -0.001338
CHAN B1 (3.15aV): -0.001037
CHAN B2 (3.15bV): -0.001003
CHAN B3 (GND): 0.000183
OPEN: 0.004582
Full Scale Calc: 4.765 mA, -1.589 mA
2019-02-21T22:10:38.496Z,1550787038.496 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2019-02-21T22:10:38.496Z,1550787038.496 [PNI_TCM] Data Fault, FailCount= 4
2019-02-21T22:10:38.497Z,1550787038.497 [PNI_TCM](ERROR): Data Fault
2019-02-21T22:10:38.554Z,1550787038.554 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-02-21T22:10:38.900Z,1550787038.900 [PNI_TCM](INFO): Powering down
2019-02-21T22:10:40.136Z,1550787040.136 [CBIT](INFO): Clearing failed state for component PNI_TCM
2019-02-21T22:10:40.136Z,1550787040.136 [PNI_TCM] No Fault, FailCount= 4
2019-02-21T22:10:47.866Z,1550787047.866 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2019-02-21T22:10:47.866Z,1550787047.866 [PNI_TCM] Data Fault, FailCount= 5
2019-02-21T22:10:47.866Z,1550787047.866 [PNI_TCM](ERROR): Data Fault
2019-02-21T22:10:47.926Z,1550787047.926 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-02-21T22:10:47.926Z,1550787047.926 [CBIT](CRITICAL): Data Fault in component: PNI_TCM
2019-02-21T22:10:48.277Z,1550787048.277 [PNI_TCM](INFO): Powering down
2019-02-21T22:10:48.432Z,1550787048.432 [CBIT](INFO): Critical error at 20190221T221047
2019-02-21T22:11:19.978Z,1550787079.978 [SBIT](IMPORTANT): SBIT PASSED
2019-02-21T22:11:20.082Z,1550787080.082 [CommandLine](IMPORTANT): got command configSet list
2019-02-21T22:11:20.083Z,1550787080.083 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2019-02-21T22:11:20.083Z,1550787080.083 [CommandLine](IMPORTANT): DropWeight.loadAtStartup=0 bool;

2019-02-21T22:11:20.084Z,1550787080.084 [CommandLine](IMPORTANT): Rowe_600LCM.loadAtStartup=0 bool;

2019-02-21T22:11:20.374Z,1550787080.374 [MissionManager](IMPORTANT): Started mission Startup
2019-02-21T22:11:20.374Z,1550787080.374 [Startup] Running Loop=1
2019-02-21T22:11:20.375Z,1550787080.375 [Startup](DEBUG): Aggregate::initialize Startup
2019-02-21T22:11:20.375Z,1550787080.375 [Startup:A.GoToSurface] Running Loop=1
2019-02-21T22:11:20.375Z,1550787080.375 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-02-21T22:11:20.375Z,1550787080.375 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-02-21T22:11:20.376Z,1550787080.376 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-02-21T22:11:20.376Z,1550787080.376 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-02-21T22:11:20.376Z,1550787080.376 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-02-21T22:11:20.377Z,1550787080.377 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-02-21T22:11:20.378Z,1550787080.378 [Startup:StartupSatComms] Running Loop=1
2019-02-21T22:11:20.378Z,1550787080.378 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2019-02-21T22:11:20.379Z,1550787080.379 [Startup:StartupSatComms:A] Running Loop=1
2019-02-21T22:11:20.826Z,1550787080.826 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2019-02-21T22:12:01.660Z,1550787121.660 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-02-21T22:12:01.660Z,1550787121.660 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2019-02-21T22:12:01.660Z,1550787121.660 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-02-21T22:12:01.662Z,1550787121.662 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-02-21T22:12:01.662Z,1550787121.662 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2019-02-21T22:12:01.662Z,1550787121.662 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-02-21T22:12:01.663Z,1550787121.663 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-02-21T22:12:01.663Z,1550787121.663 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2019-02-21T22:12:01.663Z,1550787121.663 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-02-21T22:12:01.674Z,1550787121.674 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-02-21T22:12:01.675Z,1550787121.675 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-02-21T22:12:01.675Z,1550787121.675 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-02-21T22:12:02.070Z,1550787122.070 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-02-21T22:12:02.070Z,1550787122.070 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2019-02-21T22:12:02.070Z,1550787122.070 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-02-21T22:12:02.070Z,1550787122.070 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2019-02-21T22:12:02.071Z,1550787122.071 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-02-21T22:12:02.071Z,1550787122.071 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2019-02-21T22:12:02.466Z,1550787122.466 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-02-21T22:12:20.671Z,1550787140.671 [Startup:StartupSatComms:A](INFO): Timed out from 2019-02-21T22:11:20.4Z
2019-02-21T22:12:20.672Z,1550787140.672 [Startup:StartupSatComms:A] Stopped
2019-02-21T22:12:20.672Z,1550787140.672 [Startup:StartupSatComms:B] Running Loop=1
2019-02-21T22:12:21.050Z,1550787141.050 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-02-21T22:12:41.583Z,1550787161.583 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004784
2019-02-21T22:12:46.954Z,1550787166.954 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190221T220610/Courier0004.lzma
2019-02-21T22:12:47.759Z,1550787167.759 [DataOverHttps](INFO): Moved sent file to Logs/20190221T220610/Courier0004.lzma.bak
2019-02-21T22:12:47.759Z,1550787167.759 [DataOverHttps](INFO): SBD MOMSN=10066561
2019-02-21T22:12:58.432Z,1550787178.432 [DataOverHttps](INFO): Sending 192 bytes from file Logs/20190221T220934/Courier0000.lzma
2019-02-21T22:12:59.238Z,1550787179.238 [DataOverHttps](INFO): Moved sent file to Logs/20190221T220934/Courier0000.lzma.bak
2019-02-21T22:12:59.238Z,1550787179.238 [DataOverHttps](INFO): SBD MOMSN=10066563
2019-02-21T22:13:11.594Z,1550787191.594 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20190218T211640/Express0026.lzma
2019-02-21T22:13:12.398Z,1550787192.398 [DataOverHttps](INFO): Moved sent file to Logs/20190218T211640/Express0026.lzma.bak
2019-02-21T22:13:12.398Z,1550787192.398 [DataOverHttps](INFO): SBD MOMSN=10066569
2019-02-21T22:13:14.778Z,1550787194.778 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2019-02-21T22:13:20.854Z,1550787200.854 [Startup:StartupSatComms:B](INFO): Timed out from 2019-02-21T22:12:20.7Z
2019-02-21T22:13:20.854Z,1550787200.854 [Startup:StartupSatComms:B] Stopped
2019-02-21T22:13:20.854Z,1550787200.854 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2019-02-21T22:13:20.854Z,1550787200.854 [Startup:StartupSatComms] Stopped
2019-02-21T22:13:20.854Z,1550787200.854 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2019-02-21T22:13:20.855Z,1550787200.855 [Startup](INFO): Completed Startup
2019-02-21T22:13:20.855Z,1550787200.855 [MissionManager](INFO): Startup is completed.
2019-02-21T22:13:20.856Z,1550787200.856 [MissionManager](INFO): Uninitializing Mission Startup
2019-02-21T22:13:20.856Z,1550787200.856 [Startup] Stopped
2019-02-21T22:13:20.856Z,1550787200.856 [Startup](DEBUG): Aggregate::uninitialize Startup
2019-02-21T22:13:20.856Z,1550787200.856 [Startup:A.GoToSurface] Stopped
2019-02-21T22:13:20.856Z,1550787200.856 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-02-21T22:13:21.258Z,1550787201.258 [MissionManager](IMPORTANT): Started mission Default
2019-02-21T22:13:21.258Z,1550787201.258 [Default] Running Loop=1
2019-02-21T22:13:21.258Z,1550787201.258 [Default](DEBUG): Aggregate::initialize Default
2019-02-21T22:13:21.258Z,1550787201.258 [Default:B.GoToSurface] Running Loop=1
2019-02-21T22:13:21.259Z,1550787201.259 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-02-21T22:13:21.259Z,1550787201.259 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-02-21T22:13:21.259Z,1550787201.259 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-02-21T22:13:21.259Z,1550787201.259 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-02-21T22:13:21.260Z,1550787201.260 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-02-21T22:13:21.260Z,1550787201.260 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-02-21T22:13:21.260Z,1550787201.260 [Default:A.Wait] Running Loop=1
2019-02-21T22:13:21.260Z,1550787201.260 [Default:A.Wait](DEBUG): Initialize Wait Component.
2019-02-21T22:13:25.847Z,1550787205.847 [DataOverHttps](INFO): Sending 744 bytes from file Logs/20190218T223746/Express0001.lzma
2019-02-21T22:13:26.650Z,1550787206.650 [DataOverHttps](INFO): Moved sent file to Logs/20190218T223746/Express0001.lzma.bak
2019-02-21T22:13:26.650Z,1550787206.650 [DataOverHttps](INFO): SBD MOMSN=10066572
2019-02-21T22:13:34.572Z,1550787214.572 [Default:A.Wait](INFO): Done Waiting.
2019-02-21T22:13:34.572Z,1550787214.572 [Default:A.Wait] Stopped
2019-02-21T22:13:34.572Z,1550787214.572 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2019-02-21T22:13:34.987Z,1550787214.987 [Default:CheckIn] Running Loop=1
2019-02-21T22:13:34.987Z,1550787214.987 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-02-21T22:13:34.987Z,1550787214.987 [Default:CheckIn:Read_GPS] Running Loop=1
2019-02-21T22:13:35.431Z,1550787215.431 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2019-02-21T22:14:02.468Z,1550787242.468 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-02-21T22:14:02.468Z,1550787242.468 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2019-02-21T22:14:02.468Z,1550787242.468 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-02-21T22:14:02.470Z,1550787242.470 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-02-21T22:14:02.470Z,1550787242.470 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2019-02-21T22:14:02.470Z,1550787242.470 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-02-21T22:14:02.471Z,1550787242.471 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-02-21T22:14:02.471Z,1550787242.471 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2019-02-21T22:14:02.471Z,1550787242.471 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-02-21T22:14:02.483Z,1550787242.483 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-02-21T22:14:02.483Z,1550787242.483 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-02-21T22:14:02.483Z,1550787242.483 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-02-21T22:14:02.882Z,1550787242.882 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-02-21T22:14:02.882Z,1550787242.882 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2019-02-21T22:14:02.882Z,1550787242.882 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-02-21T22:14:02.882Z,1550787242.882 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2019-02-21T22:14:02.883Z,1550787242.883 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-02-21T22:14:02.883Z,1550787242.883 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2019-02-21T22:14:03.276Z,1550787243.276 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-02-21T22:15:38.626Z,1550787338.626 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-02-21T22:15:39.445Z,1550787339.445 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:15:44.293Z,1550787344.293 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:15:47.121Z,1550787347.121 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:15:48.009Z,1550787348.009 [CBIT](INFO): Clearing failed state for component PNI_TCM
2019-02-21T22:15:48.010Z,1550787348.010 [PNI_TCM] No Fault, FailCount= 5
2019-02-21T22:15:50.353Z,1550787350.353 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:15:53.181Z,1550787353.181 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:15:55.613Z,1550787355.613 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2019-02-21T22:15:55.613Z,1550787355.613 [PNI_TCM] Data Fault, FailCount= 1
2019-02-21T22:15:55.613Z,1550787355.613 [PNI_TCM](ERROR): Data Fault
2019-02-21T22:15:55.629Z,1550787355.629 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-02-21T22:15:56.009Z,1550787356.009 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:15:56.023Z,1550787356.023 [PNI_TCM](INFO): Powering down
2019-02-21T22:15:57.255Z,1550787357.255 [CBIT](INFO): Clearing failed state for component PNI_TCM
2019-02-21T22:15:57.256Z,1550787357.256 [PNI_TCM] No Fault, FailCount= 1
2019-02-21T22:15:59.273Z,1550787359.273 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:16:02.093Z,1550787362.093 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:16:03.317Z,1550787363.317 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-02-21T22:16:03.317Z,1550787363.317 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2019-02-21T22:16:03.317Z,1550787363.317 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-02-21T22:16:03.318Z,1550787363.318 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-02-21T22:16:03.318Z,1550787363.318 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2019-02-21T22:16:03.318Z,1550787363.318 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-02-21T22:16:03.320Z,1550787363.320 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-02-21T22:16:03.320Z,1550787363.320 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 3
2019-02-21T22:16:03.320Z,1550787363.320 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-02-21T22:16:03.331Z,1550787363.331 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-02-21T22:16:03.331Z,1550787363.331 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-02-21T22:16:03.331Z,1550787363.331 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-02-21T22:16:03.739Z,1550787363.739 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-02-21T22:16:03.739Z,1550787363.739 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2019-02-21T22:16:03.739Z,1550787363.739 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-02-21T22:16:03.739Z,1550787363.739 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2019-02-21T22:16:03.740Z,1550787363.740 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-02-21T22:16:03.740Z,1550787363.740 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 3
2019-02-21T22:16:04.128Z,1550787364.128 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-02-21T22:16:04.929Z,1550787364.929 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2019-02-21T22:16:04.929Z,1550787364.929 [PNI_TCM] Data Fault, FailCount= 2
2019-02-21T22:16:04.929Z,1550787364.929 [PNI_TCM](ERROR): Data Fault
2019-02-21T22:16:04.962Z,1550787364.962 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-02-21T22:16:05.329Z,1550787365.329 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:16:05.343Z,1550787365.343 [PNI_TCM](INFO): Powering down
2019-02-21T22:16:06.567Z,1550787366.567 [CBIT](INFO): Clearing failed state for component PNI_TCM
2019-02-21T22:16:06.567Z,1550787366.567 [PNI_TCM] No Fault, FailCount= 2
2019-02-21T22:16:08.157Z,1550787368.157 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:16:11.389Z,1550787371.389 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:16:14.217Z,1550787374.217 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:16:14.231Z,1550787374.231 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2019-02-21T22:16:14.232Z,1550787374.232 [PNI_TCM] Data Fault, FailCount= 3
2019-02-21T22:16:14.232Z,1550787374.232 [PNI_TCM](ERROR): Data Fault
2019-02-21T22:16:14.255Z,1550787374.255 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-02-21T22:16:14.635Z,1550787374.635 [PNI_TCM](INFO): Powering down
2019-02-21T22:16:15.891Z,1550787375.891 [CBIT](INFO): Clearing failed state for component PNI_TCM
2019-02-21T22:16:15.891Z,1550787375.891 [PNI_TCM] No Fault, FailCount= 3
2019-02-21T22:16:17.077Z,1550787377.077 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:16:20.309Z,1550787380.309 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:16:23.137Z,1550787383.137 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:16:23.559Z,1550787383.559 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2019-02-21T22:16:23.559Z,1550787383.559 [PNI_TCM] Data Fault, FailCount= 4
2019-02-21T22:16:23.559Z,1550787383.559 [PNI_TCM](ERROR): Data Fault
2019-02-21T22:16:23.589Z,1550787383.589 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-02-21T22:16:23.955Z,1550787383.955 [PNI_TCM](INFO): Powering down
2019-02-21T22:16:25.256Z,1550787385.256 [CBIT](INFO): Clearing failed state for component PNI_TCM
2019-02-21T22:16:25.256Z,1550787385.256 [PNI_TCM] No Fault, FailCount= 4
2019-02-21T22:16:26.369Z,1550787386.369 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:16:29.197Z,1550787389.197 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:16:32.425Z,1550787392.425 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:16:32.848Z,1550787392.848 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2019-02-21T22:16:32.848Z,1550787392.848 [PNI_TCM] Data Fault, FailCount= 5
2019-02-21T22:16:32.848Z,1550787392.848 [PNI_TCM](ERROR): Data Fault
2019-02-21T22:16:32.872Z,1550787392.872 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-02-21T22:16:32.872Z,1550787392.872 [CBIT](CRITICAL): Data Fault in component: PNI_TCM
2019-02-21T22:16:33.250Z,1550787393.250 [PNI_TCM](INFO): Powering down
2019-02-21T22:16:33.360Z,1550787393.360 [CBIT](INFO): Critical error at 20190221T221632
2019-02-21T22:16:35.253Z,1550787395.253 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:16:38.121Z,1550787398.121 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:16:41.373Z,1550787401.373 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:16:44.145Z,1550787404.145 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:16:47.377Z,1550787407.377 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:16:50.205Z,1550787410.205 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:16:53.433Z,1550787413.433 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:16:56.265Z,1550787416.265 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:16:59.093Z,1550787419.093 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:17:01.117Z,1550787421.117 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:17:03.129Z,1550787423.129 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:17:06.365Z,1550787426.365 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:17:09.193Z,1550787429.193 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:17:12.425Z,1550787432.425 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:17:15.253Z,1550787435.253 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:17:18.137Z,1550787438.137 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:17:20.153Z,1550787440.153 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:17:23.389Z,1550787443.389 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:17:26.214Z,1550787446.214 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:17:29.453Z,1550787449.453 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:17:32.273Z,1550787452.273 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:17:35.505Z,1550787455.505 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:17:38.333Z,1550787458.333 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:17:41.165Z,1550787461.165 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:17:43.181Z,1550787463.181 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:17:46.417Z,1550787466.417 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:17:49.265Z,1550787469.265 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:17:52.509Z,1550787472.509 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:17:55.329Z,1550787475.329 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:17:58.561Z,1550787478.561 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:18:01.389Z,1550787481.389 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:18:04.213Z,1550787484.213 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:18:04.232Z,1550787484.232 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-02-21T22:18:04.232Z,1550787484.232 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2019-02-21T22:18:04.232Z,1550787484.232 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-02-21T22:18:04.234Z,1550787484.234 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-02-21T22:18:04.234Z,1550787484.234 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4
2019-02-21T22:18:04.234Z,1550787484.234 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-02-21T22:18:04.235Z,1550787484.235 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-02-21T22:18:04.235Z,1550787484.235 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 4
2019-02-21T22:18:04.235Z,1550787484.235 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-02-21T22:18:04.278Z,1550787484.278 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-02-21T22:18:04.279Z,1550787484.279 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-02-21T22:18:04.279Z,1550787484.279 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-02-21T22:18:04.650Z,1550787484.650 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-02-21T22:18:04.650Z,1550787484.650 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2019-02-21T22:18:04.650Z,1550787484.650 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-02-21T22:18:04.650Z,1550787484.650 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4
2019-02-21T22:18:04.651Z,1550787484.651 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-02-21T22:18:04.651Z,1550787484.651 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 4
2019-02-21T22:18:05.040Z,1550787485.040 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-02-21T22:18:07.449Z,1550787487.449 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:18:10.277Z,1550787490.277 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:18:13.509Z,1550787493.509 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:18:16.337Z,1550787496.337 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:18:19.569Z,1550787499.569 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:18:22.397Z,1550787502.397 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:18:25.233Z,1550787505.233 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:18:27.245Z,1550787507.245 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:18:30.474Z,1550787510.474 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:18:33.301Z,1550787513.301 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:18:35.338Z,1550787515.338 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-02-21T22:13:34.0Z
2019-02-21T22:18:35.339Z,1550787515.339 [Default:CheckIn:Read_GPS] Stopped
2019-02-21T22:18:35.339Z,1550787515.339 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-02-21T22:18:35.793Z,1550787515.793 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-02-21T22:18:36.533Z,1550787516.533 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:18:39.361Z,1550787519.361 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:18:41.692Z,1550787521.692 [DataOverHttps](INFO): Sending 69 bytes from file Logs/20190221T220934/Courier0004.lzma
2019-02-21T22:18:42.498Z,1550787522.498 [DataOverHttps](INFO): Moved sent file to Logs/20190221T220934/Courier0004.lzma.bak
2019-02-21T22:18:42.498Z,1550787522.498 [DataOverHttps](INFO): SBD MOMSN=10066592
2019-02-21T22:18:42.593Z,1550787522.593 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:18:45.421Z,1550787525.421 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:18:48.253Z,1550787528.253 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:18:50.273Z,1550787530.273 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:18:52.294Z,1550787532.294 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:18:54.646Z,1550787534.646 [DataOverHttps](INFO): Sending 350 bytes from file Logs/20190218T224036/Express0001.lzma
2019-02-21T22:18:55.450Z,1550787535.450 [DataOverHttps](INFO): Moved sent file to Logs/20190218T224036/Express0001.lzma.bak
2019-02-21T22:18:55.450Z,1550787535.450 [DataOverHttps](INFO): SBD MOMSN=10066595
2019-02-21T22:18:55.525Z,1550787535.525 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:18:58.349Z,1550787538.349 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:19:01.585Z,1550787541.585 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:19:04.410Z,1550787544.410 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:19:07.641Z,1550787547.641 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:19:07.734Z,1550787547.734 [DataOverHttps](INFO): Sending 636 bytes from file Logs/20190221T010911/Express0001.lzma
2019-02-21T22:19:08.538Z,1550787548.538 [DataOverHttps](INFO): Moved sent file to Logs/20190221T010911/Express0001.lzma.bak
2019-02-21T22:19:08.539Z,1550787548.539 [DataOverHttps](INFO): SBD MOMSN=10066603
2019-02-21T22:19:10.470Z,1550787550.470 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:19:13.297Z,1550787553.297 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:19:15.321Z,1550787555.321 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:19:17.337Z,1550787557.337 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:19:20.569Z,1550787560.569 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:19:20.974Z,1550787560.974 [DataOverHttps](INFO): Sending 470 bytes from file Logs/20190221T011511/Express0001.lzma
2019-02-21T22:19:21.779Z,1550787561.779 [DataOverHttps](INFO): Moved sent file to Logs/20190221T011511/Express0001.lzma.bak
2019-02-21T22:19:21.779Z,1550787561.779 [DataOverHttps](INFO): SBD MOMSN=10066618
2019-02-21T22:19:23.401Z,1550787563.401 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:19:26.629Z,1550787566.629 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:19:29.461Z,1550787569.461 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:19:32.689Z,1550787572.689 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:19:33.684Z,1550787573.684 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20190221T201154/Express0001.lzma
2019-02-21T22:19:34.490Z,1550787574.490 [DataOverHttps](INFO): Moved sent file to Logs/20190221T201154/Express0001.lzma.bak
2019-02-21T22:19:34.490Z,1550787574.490 [DataOverHttps](INFO): SBD MOMSN=10066630
2019-02-21T22:19:35.521Z,1550787575.521 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:19:38.345Z,1550787578.345 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:19:40.369Z,1550787580.369 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:19:43.601Z,1550787583.601 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:19:46.425Z,1550787586.425 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:19:47.110Z,1550787587.110 [DataOverHttps](INFO): Sending 405 bytes from file Logs/20190221T202020/Express0001.lzma
2019-02-21T22:19:47.914Z,1550787587.914 [DataOverHttps](INFO): Moved sent file to Logs/20190221T202020/Express0001.lzma.bak
2019-02-21T22:19:47.914Z,1550787587.914 [DataOverHttps](INFO): SBD MOMSN=10066632
2019-02-21T22:19:49.657Z,1550787589.657 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:19:52.485Z,1550787592.485 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:19:55.717Z,1550787595.717 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:19:58.593Z,1550787598.593 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:19:59.946Z,1550787599.946 [DataOverHttps](INFO): Sending 426 bytes from file Logs/20190221T203040/Express0001.lzma
2019-02-21T22:20:00.750Z,1550787600.750 [DataOverHttps](INFO): Moved sent file to Logs/20190221T203040/Express0001.lzma.bak
2019-02-21T22:20:00.751Z,1550787600.751 [DataOverHttps](INFO): SBD MOMSN=10066640
2019-02-21T22:20:01.373Z,1550787601.373 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:20:03.393Z,1550787603.393 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:20:05.092Z,1550787605.092 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-02-21T22:20:05.092Z,1550787605.092 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2019-02-21T22:20:05.092Z,1550787605.092 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-02-21T22:20:05.106Z,1550787605.106 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-02-21T22:20:05.106Z,1550787605.106 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5
2019-02-21T22:20:05.106Z,1550787605.106 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-02-21T22:20:05.108Z,1550787605.108 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-02-21T22:20:05.108Z,1550787605.108 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 5
2019-02-21T22:20:05.108Z,1550787605.108 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-02-21T22:20:05.183Z,1550787605.183 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-02-21T22:20:05.184Z,1550787605.184 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-02-21T22:20:05.184Z,1550787605.184 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-02-21T22:20:05.413Z,1550787605.413 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:20:05.463Z,1550787605.463 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-02-21T22:20:05.463Z,1550787605.463 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2019-02-21T22:20:05.464Z,1550787605.464 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-02-21T22:20:05.464Z,1550787605.464 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5
2019-02-21T22:20:05.464Z,1550787605.464 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-02-21T22:20:05.464Z,1550787605.464 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 5
2019-02-21T22:20:05.852Z,1550787605.852 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-02-21T22:20:08.645Z,1550787608.645 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:20:11.473Z,1550787611.473 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:20:13.222Z,1550787613.222 [DataOverHttps](INFO): Sending 394 bytes from file Logs/20190221T203603/Express0001.lzma
2019-02-21T22:20:14.026Z,1550787614.026 [DataOverHttps](INFO): Moved sent file to Logs/20190221T203603/Express0001.lzma.bak
2019-02-21T22:20:14.026Z,1550787614.026 [DataOverHttps](INFO): SBD MOMSN=10066650
2019-02-21T22:20:14.705Z,1550787614.705 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:20:17.533Z,1550787617.533 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:20:20.769Z,1550787620.769 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:20:23.593Z,1550787623.593 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:20:26.421Z,1550787626.421 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:20:26.899Z,1550787626.899 [DataOverHttps](INFO): Sending 934 bytes from file Logs/20190221T215349/Express0001.lzma
2019-02-21T22:20:27.727Z,1550787627.727 [DataOverHttps](INFO): Moved sent file to Logs/20190221T215349/Express0001.lzma.bak
2019-02-21T22:20:27.727Z,1550787627.727 [DataOverHttps](INFO): SBD MOMSN=10066659
2019-02-21T22:20:28.441Z,1550787628.441 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:20:31.673Z,1550787631.673 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:20:34.501Z,1550787634.501 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:20:37.722Z,1550787637.722 [NAL9602](FAULT): GPS failed to acquire within timeout.
2019-02-21T22:20:37.722Z,1550787637.722 [NAL9602] Data Fault, FailCount= 1
2019-02-21T22:20:37.722Z,1550787637.722 [NAL9602](ERROR): Data Fault
2019-02-21T22:20:37.796Z,1550787637.796 [CBIT](ERROR): Data Fault in component: NAL9602
2019-02-21T22:20:38.126Z,1550787638.126 [NAL9602](INFO): Powering down
2019-02-21T22:20:38.967Z,1550787638.967 [CBIT](INFO): Clearing failed state for component NAL9602
2019-02-21T22:20:38.967Z,1550787638.967 [NAL9602] No Fault, FailCount= 1
2019-02-21T22:20:40.117Z,1550787640.117 [DataOverHttps](INFO): Sending 350 bytes from file Logs/20190221T215349/Express0005.lzma
2019-02-21T22:20:40.922Z,1550787640.922 [DataOverHttps](INFO): Moved sent file to Logs/20190221T215349/Express0005.lzma.bak
2019-02-21T22:20:40.922Z,1550787640.922 [DataOverHttps](INFO): SBD MOMSN=10066684
2019-02-21T22:20:53.276Z,1550787653.276 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20190221T215349/Express0008.lzma
2019-02-21T22:20:54.082Z,1550787654.082 [DataOverHttps](INFO): Moved sent file to Logs/20190221T215349/Express0008.lzma.bak
2019-02-21T22:20:54.082Z,1550787654.082 [DataOverHttps](INFO): SBD MOMSN=10066702
2019-02-21T22:21:06.818Z,1550787666.818 [DataOverHttps](INFO): Sending 931 bytes from file Logs/20190221T220610/Express0001.lzma
2019-02-21T22:21:07.623Z,1550787667.623 [DataOverHttps](INFO): Moved sent file to Logs/20190221T220610/Express0001.lzma.bak
2019-02-21T22:21:07.623Z,1550787667.623 [DataOverHttps](INFO): SBD MOMSN=10066705
2019-02-21T22:21:08.426Z,1550787668.426 [NAL9602](INFO): Powering up NAL9602
2019-02-21T22:21:19.334Z,1550787679.334 [NAL9602](INFO): NAL9602 initialized
2019-02-21T22:21:19.585Z,1550787679.585 [DataOverHttps](INFO): Sending 63 bytes from file Logs/20190221T220610/Express0005.lzma
2019-02-21T22:21:20.157Z,1550787680.157 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:21:20.390Z,1550787680.390 [DataOverHttps](INFO): Moved sent file to Logs/20190221T220610/Express0005.lzma.bak
2019-02-21T22:21:20.390Z,1550787680.390 [DataOverHttps](INFO): SBD MOMSN=10066730
2019-02-21T22:21:22.981Z,1550787682.981 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:21:26.213Z,1550787686.213 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:21:29.065Z,1550787689.065 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:21:32.285Z,1550787692.285 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:21:32.514Z,1550787692.514 [DataOverHttps](INFO): Sending 895 bytes from file Logs/20190221T220934/Express0001.lzma
2019-02-21T22:21:33.118Z,1550787693.118 [CBIT](INFO): Clearing failed state for component PNI_TCM
2019-02-21T22:21:33.118Z,1550787693.118 [PNI_TCM] No Fault, FailCount= 5
2019-02-21T22:21:33.318Z,1550787693.318 [DataOverHttps](INFO): Moved sent file to Logs/20190221T220934/Express0001.lzma.bak
2019-02-21T22:21:33.318Z,1550787693.318 [DataOverHttps](INFO): SBD MOMSN=10066733
2019-02-21T22:21:35.105Z,1550787695.105 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:21:37.929Z,1550787697.929 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:21:39.953Z,1550787699.953 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:21:40.779Z,1550787700.779 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2019-02-21T22:21:40.779Z,1550787700.779 [PNI_TCM] Data Fault, FailCount= 1
2019-02-21T22:21:40.779Z,1550787700.779 [PNI_TCM](ERROR): Data Fault
2019-02-21T22:21:40.796Z,1550787700.796 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-02-21T22:21:41.164Z,1550787701.164 [PNI_TCM](INFO): Powering down
2019-02-21T22:21:42.400Z,1550787702.400 [CBIT](INFO): Clearing failed state for component PNI_TCM
2019-02-21T22:21:42.400Z,1550787702.400 [PNI_TCM] No Fault, FailCount= 1
2019-02-21T22:21:43.181Z,1550787703.181 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:21:45.029Z,1550787705.029 [DataOverHttps](INFO): Sending 348 bytes from file Logs/20190221T220934/Express0005.lzma
2019-02-21T22:21:45.834Z,1550787705.834 [DataOverHttps](INFO): Moved sent file to Logs/20190221T220934/Express0005.lzma.bak
2019-02-21T22:21:45.834Z,1550787705.834 [DataOverHttps](INFO): SBD MOMSN=10066757
2019-02-21T22:21:46.009Z,1550787706.009 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:21:46.838Z,1550787706.838 [Default:CheckIn:Read_Iridium] Stopped
2019-02-21T22:21:46.838Z,1550787706.838 [Default:CheckIn:C.Wait] Running Loop=1
2019-02-21T22:21:46.838Z,1550787706.838 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-02-21T22:21:49.241Z,1550787709.241 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:21:50.063Z,1550787710.063 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2019-02-21T22:21:50.064Z,1550787710.064 [PNI_TCM] Data Fault, FailCount= 2
2019-02-21T22:21:50.064Z,1550787710.064 [PNI_TCM](ERROR): Data Fault
2019-02-21T22:21:50.087Z,1550787710.087 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-02-21T22:21:50.460Z,1550787710.460 [PNI_TCM](INFO): Powering down
2019-02-21T22:21:51.691Z,1550787711.691 [CBIT](INFO): Clearing failed state for component PNI_TCM
2019-02-21T22:21:51.691Z,1550787711.691 [PNI_TCM] No Fault, FailCount= 2
2019-02-21T22:21:52.077Z,1550787712.077 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:21:55.301Z,1550787715.301 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:21:58.169Z,1550787718.169 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:21:59.349Z,1550787719.349 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2019-02-21T22:21:59.349Z,1550787719.349 [PNI_TCM] Data Fault, FailCount= 3
2019-02-21T22:21:59.349Z,1550787719.349 [PNI_TCM](ERROR): Data Fault
2019-02-21T22:21:59.383Z,1550787719.383 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-02-21T22:21:59.752Z,1550787719.752 [PNI_TCM](INFO): Powering down
2019-02-21T22:22:00.961Z,1550787720.961 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:22:00.999Z,1550787720.999 [CBIT](INFO): Clearing failed state for component PNI_TCM
2019-02-21T22:22:00.999Z,1550787720.999 [PNI_TCM] No Fault, FailCount= 3
2019-02-21T22:22:02.981Z,1550787722.981 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:22:05.005Z,1550787725.005 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:22:06.221Z,1550787726.221 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-02-21T22:22:06.221Z,1550787726.221 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2019-02-21T22:22:06.221Z,1550787726.221 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-02-21T22:22:06.222Z,1550787726.222 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-02-21T22:22:06.222Z,1550787726.222 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6
2019-02-21T22:22:06.222Z,1550787726.222 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-02-21T22:22:06.224Z,1550787726.224 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-02-21T22:22:06.224Z,1550787726.224 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 6
2019-02-21T22:22:06.224Z,1550787726.224 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-02-21T22:22:06.234Z,1550787726.234 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-02-21T22:22:06.235Z,1550787726.235 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-02-21T22:22:06.235Z,1550787726.235 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-02-21T22:22:06.642Z,1550787726.642 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-02-21T22:22:06.642Z,1550787726.642 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2019-02-21T22:22:06.642Z,1550787726.642 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-02-21T22:22:06.642Z,1550787726.642 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6
2019-02-21T22:22:06.643Z,1550787726.643 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-02-21T22:22:06.643Z,1550787726.643 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 6
2019-02-21T22:22:07.032Z,1550787727.032 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-02-21T22:22:08.229Z,1550787728.229 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:22:08.655Z,1550787728.655 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2019-02-21T22:22:08.655Z,1550787728.655 [PNI_TCM] Data Fault, FailCount= 4
2019-02-21T22:22:08.655Z,1550787728.655 [PNI_TCM](ERROR): Data Fault
2019-02-21T22:22:08.675Z,1550787728.675 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-02-21T22:22:09.055Z,1550787729.055 [PNI_TCM](INFO): Powering down
2019-02-21T22:22:10.295Z,1550787730.295 [CBIT](INFO): Clearing failed state for component PNI_TCM
2019-02-21T22:22:10.295Z,1550787730.295 [PNI_TCM] No Fault, FailCount= 4
2019-02-21T22:22:11.129Z,1550787731.129 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:22:14.321Z,1550787734.321 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:22:17.121Z,1550787737.121 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:22:17.946Z,1550787737.946 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2019-02-21T22:22:17.946Z,1550787737.946 [PNI_TCM] Data Fault, FailCount= 5
2019-02-21T22:22:17.947Z,1550787737.947 [PNI_TCM](ERROR): Data Fault
2019-02-21T22:22:17.985Z,1550787737.985 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-02-21T22:22:17.985Z,1550787737.985 [CBIT](CRITICAL): Data Fault in component: PNI_TCM
2019-02-21T22:22:18.332Z,1550787738.332 [PNI_TCM](INFO): Powering down
2019-02-21T22:22:18.437Z,1550787738.437 [CBIT](INFO): Critical error at 20190221T222217
2019-02-21T22:22:20.353Z,1550787740.353 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:22:23.221Z,1550787743.221 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:22:26.049Z,1550787746.049 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:22:29.281Z,1550787749.281 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:22:32.117Z,1550787752.117 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:22:35.353Z,1550787755.353 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:22:38.201Z,1550787758.201 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:22:41.033Z,1550787761.033 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:22:43.049Z,1550787763.049 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:22:46.281Z,1550787766.281 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:22:49.109Z,1550787769.109 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:22:52.341Z,1550787772.341 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:22:55.169Z,1550787775.169 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:22:58.397Z,1550787778.397 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:23:01.229Z,1550787781.229 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:23:04.057Z,1550787784.057 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:23:06.089Z,1550787786.089 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:23:07.585Z,1550787787.585 [CommandLine](IMPORTANT): got command quit
2019-02-21T22:23:08.097Z,1550787788.097 [NAL9602](DEBUG): Fix Requested
2019-02-21T22:23:08.589Z,1550787788.589 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-21T22:23:08.590Z,1550787788.590 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-02-21T22:23:08.789Z,1550787788.789 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2019-02-21T22:23:08.789Z,1550787788.789 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-02-21T22:23:08.790Z,1550787788.790 [CommandLine](INFO): Join timeout helper Thread ID is 2442
2019-02-21T22:23:08.790Z,1550787788.790 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2019-02-21T22:23:08.790Z,1550787788.790 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-02-21T22:23:08.791Z,1550787788.791 [NavChartDb](INFO): Join timeout helper Thread ID is 2443
2019-02-21T22:23:09.021Z,1550787789.021 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-21T22:23:09.021Z,1550787789.021 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-02-21T22:23:09.033Z,1550787789.033 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2019-02-21T22:23:09.033Z,1550787789.033 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-02-21T22:23:09.033Z,1550787789.033 [Radio_Surface](INFO): Join timeout helper Thread ID is 2444
2019-02-21T22:23:09.337Z,1550787789.337 [Radio_Surface](INFO): Powering down
2019-02-21T22:23:09.338Z,1550787789.338 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-21T22:23:09.338Z,1550787789.338 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-02-21T22:23:09.349Z,1550787789.349 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2019-02-21T22:23:09.349Z,1550787789.349 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-02-21T22:23:09.349Z,1550787789.349 [DataOverHttps](INFO): Join timeout helper Thread ID is 2445
2019-02-21T22:23:09.717Z,1550787789.717 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-21T22:23:09.717Z,1550787789.717 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-02-21T22:23:09.729Z,1550787789.729 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2019-02-21T22:23:09.729Z,1550787789.729 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-02-21T22:23:09.729Z,1550787789.729 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 2446
2019-02-21T22:23:09.745Z,1550787789.745 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-21T22:23:09.745Z,1550787789.745 [WetLabsBB2FL](INFO): Powering down
2019-02-21T22:23:09.746Z,1550787789.746 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-02-21T22:23:09.754Z,1550787789.754 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2019-02-21T22:23:09.754Z,1550787789.754 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-02-21T22:23:09.754Z,1550787789.754 [CTD_Seabird](INFO): Join timeout helper Thread ID is 2447
2019-02-21T22:23:09.873Z,1550787789.873 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-21T22:23:09.873Z,1550787789.873 [CTD_Seabird](INFO): Powering down
2019-02-21T22:23:09.885Z,1550787789.885 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-02-21T22:23:09.898Z,1550787789.898 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2019-02-21T22:23:09.898Z,1550787789.898 [logger ThreadHandler](INFO): Thread cancelled.
2019-02-21T22:23:09.898Z,1550787789.898 [logger](INFO): Join timeout helper Thread ID is 2448
2019-02-21T22:23:09.969Z,1550787789.969 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-21T22:23:09.969Z,1550787789.969 [logger ThreadHandler](INFO): Thread cancelled.
2019-02-21T22:23:09.977Z,1550787789.977 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2019-02-21T22:23:09.978Z,1550787789.978 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-02-21T22:23:09.978Z,1550787789.978 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2019-02-21T22:23:09.978Z,1550787789.978 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-02-21T22:23:09.978Z,1550787789.978 [controlThread](INFO): Join timeout helper Thread ID is 2449
2019-02-21T22:23:10.093Z,1550787790.093 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-21T22:23:10.093Z,1550787790.093 [controlThread](DEBUG): Uninitializing ControlThread
2019-02-21T22:23:10.094Z,1550787790.094 [Aanderaa_O2](INFO): Powering down
2019-02-21T22:23:10.096Z,1550787790.096 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-02-21T22:23:10.213Z,1550787790.213 [NAL9602](INFO): Powering down
2019-02-21T22:23:10.215Z,1550787790.215 [PNI_TCM](INFO): Powering down
2019-02-21T22:23:10.216Z,1550787790.216 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2019-02-21T22:23:10.217Z,1550787790.217 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2019-02-21T22:23:10.218Z,1550787790.218 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2019-02-21T22:23:10.219Z,1550787790.219 [MissionManager](INFO): Uninitializing Mission Default
2019-02-21T22:23:10.219Z,1550787790.219 [Default] Stopped
2019-02-21T22:23:10.219Z,1550787790.219 [Default](DEBUG): Aggregate::uninitialize Default
2019-02-21T22:23:10.219Z,1550787790.219 [Default:B.GoToSurface] Stopped
2019-02-21T22:23:10.219Z,1550787790.219 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-02-21T22:23:10.219Z,1550787790.219 [Default:CheckIn] Stopped
2019-02-21T22:23:10.219Z,1550787790.219 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-02-21T22:23:10.219Z,1550787790.219 [Default:CheckIn:C.Wait] Stopped
2019-02-21T22:23:10.219Z,1550787790.219 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-02-21T22:23:10.222Z,1550787790.222 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2019-02-21T22:23:10.222Z,1550787790.222 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2019-02-21T22:23:10.223Z,1550787790.223 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2019-02-21T22:23:10.223Z,1550787790.223 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2019-02-21T22:23:10.223Z,1550787790.223 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-02-21T22:23:10.223Z,1550787790.223 [BuoyancyServo](INFO): Powering down
2019-02-21T22:23:10.237Z,1550787790.237 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-02-21T22:23:10.237Z,1550787790.237 [ElevatorServo](INFO): Powering down
2019-02-21T22:23:10.238Z,1550787790.238 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-02-21T22:23:10.238Z,1550787790.238 [MassServo](INFO): Powering down
2019-02-21T22:23:10.239Z,1550787790.239 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-02-21T22:23:10.239Z,1550787790.239 [RudderServo](INFO): Powering down
2019-02-21T22:23:10.240Z,1550787790.240 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2019-02-21T22:23:10.240Z,1550787790.240 [ThrusterServo](INFO): Powering down
2019-02-21T22:23:10.240Z,1550787790.240 [SBIT](DEBUG): Uninitialize SBIT Component.
2019-02-21T22:23:10.241Z,1550787790.241 [IBIT](DEBUG): Uninitialize IBIT Component.
2019-02-21T22:23:10.241Z,1550787790.241 [CBIT](DEBUG): Uninitialize CBIT Component.
2019-02-21T22:23:10.241Z,1550787790.241 [CBIT](DEBUG): Powering off loads.
2019-02-21T22:23:10.253Z,1550787790.253 [CBIT](DEBUG): Disabling WDT.
2019-02-21T22:23:10.265Z,1550787790.265 [CBIT](DEBUG): Opening all GF detection circuits.
2019-02-21T22:23:10.266Z,1550787790.266 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-02-21T22:23:10.303Z,1550787790.303 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-02-21T22:23:10.308Z,1550787790.308 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-02-21T22:23:10.382Z,1550787790.382 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-02-21T22:23:10.386Z,1550787790.386 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-02-21T22:23:10.431Z,1550787790.431 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-02-21T22:23:10.485Z,1550787790.485 [logger ThreadHandler](INFO): Thread cancelled.