2019-07-22T17:18:22.590Z,1563815902.590 [Supervisor](DEBUG): Initializing supervisor.
2019-07-22T17:18:22.594Z,1563815902.594 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-07-22T17:18:22.594Z,1563815902.594 [SyncHandler](INFO): Protected caller Thread ID is 7880
2019-07-22T17:18:22.595Z,1563815902.595 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2019-07-22T17:18:22.596Z,1563815902.596 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2019-07-22T17:18:22.596Z,1563815902.596 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 7881
2019-07-22T17:18:22.600Z,1563815902.600 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2019-07-22T17:18:22.612Z,1563815902.612 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2019-07-22T17:18:22.613Z,1563815902.613 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2019-07-22T17:18:22.613Z,1563815902.613 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 7882
2019-07-22T17:18:22.614Z,1563815902.614 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2019-07-22T17:18:22.615Z,1563815902.615 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2019-07-22T17:18:22.615Z,1563815902.615 [logger ThreadHandler](INFO): Protected caller Thread ID is 7883
2019-07-22T17:18:22.617Z,1563815902.617 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2019-07-22T17:18:22.618Z,1563815902.618 [Supervisor](INFO): Looking for Config files in directory: Config/
2019-07-22T17:18:22.620Z,1563815902.620 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2019-07-22T17:18:22.783Z,1563815902.783 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2019-07-22T17:18:22.783Z,1563815902.783 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2019-07-22T17:18:22.993Z,1563815902.993 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2019-07-22T17:18:22.993Z,1563815902.993 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2019-07-22T17:18:23.168Z,1563815903.168 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2019-07-22T17:18:23.169Z,1563815903.169 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2019-07-22T17:18:23.824Z,1563815903.824 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2019-07-22T17:18:23.825Z,1563815903.825 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2019-07-22T17:18:24.277Z,1563815904.277 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2019-07-22T17:18:24.278Z,1563815904.278 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2019-07-22T17:18:24.763Z,1563815904.763 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2019-07-22T17:18:24.764Z,1563815904.764 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2019-07-22T17:18:25.078Z,1563815905.078 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2019-07-22T17:18:25.078Z,1563815905.078 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2019-07-22T17:18:25.422Z,1563815905.422 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2019-07-22T17:18:25.422Z,1563815905.422 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2019-07-22T17:18:25.816Z,1563815905.816 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2019-07-22T17:18:25.817Z,1563815905.817 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2019-07-22T17:18:25.970Z,1563815905.970 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2019-07-22T17:18:25.970Z,1563815905.970 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2019-07-22T17:18:26.080Z,1563815906.080 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2019-07-22T17:18:26.080Z,1563815906.080 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2019-07-22T17:18:26.165Z,1563815906.165 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2019-07-22T17:18:26.270Z,1563815906.270 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2019-07-22T17:18:26.271Z,1563815906.271 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2019-07-22T17:18:26.480Z,1563815906.480 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2019-07-22T17:18:26.480Z,1563815906.480 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2019-07-22T17:18:26.743Z,1563815906.743 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2019-07-22T17:18:26.746Z,1563815906.746 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2019-07-22T17:18:26.746Z,1563815906.746 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2019-07-22T17:18:27.293Z,1563815907.293 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2019-07-22T17:18:27.697Z,1563815907.697 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2019-07-22T17:18:27.698Z,1563815907.698 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2019-07-22T17:18:27.797Z,1563815907.797 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2019-07-22T17:18:27.969Z,1563815907.969 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2019-07-22T17:18:28.181Z,1563815908.181 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2019-07-22T17:18:28.270Z,1563815908.270 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2019-07-22T17:18:28.373Z,1563815908.373 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2019-07-22T17:18:28.470Z,1563815908.470 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2019-07-22T17:18:28.629Z,1563815908.629 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2019-07-22T17:18:28.738Z,1563815908.738 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2019-07-22T17:18:28.842Z,1563815908.842 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/
2019-07-22T17:18:28.842Z,1563815908.842 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2019-07-22T17:18:28.854Z,1563815908.854 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2019-07-22T17:18:28.950Z,1563815908.950 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2019-07-22T17:18:28.950Z,1563815908.950 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2019-07-22T17:18:29.057Z,1563815909.057 [BuoyancyServo] Loaded
2019-07-22T17:18:29.057Z,1563815909.057 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2019-07-22T17:18:29.072Z,1563815909.072 [ElevatorServo] Loaded
2019-07-22T17:18:29.072Z,1563815909.072 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2019-07-22T17:18:29.087Z,1563815909.087 [MassServo] Loaded
2019-07-22T17:18:29.087Z,1563815909.087 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2019-07-22T17:18:29.102Z,1563815909.102 [RudderServo] Loaded
2019-07-22T17:18:29.102Z,1563815909.102 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2019-07-22T17:18:29.117Z,1563815909.117 [ThrusterServo] Loaded
2019-07-22T17:18:29.117Z,1563815909.117 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2019-07-22T17:18:29.117Z,1563815909.117 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2019-07-22T17:18:29.118Z,1563815909.118 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2019-07-22T17:18:29.253Z,1563815909.253 [SBIT](DEBUG): Construct Startup Built In Test.
2019-07-22T17:18:29.282Z,1563815909.282 [SBIT] Loaded
2019-07-22T17:18:29.283Z,1563815909.283 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2019-07-22T17:18:29.283Z,1563815909.283 [IBIT](DEBUG): Construct Initiated Built In Test.
2019-07-22T17:18:29.311Z,1563815909.311 [IBIT] Loaded
2019-07-22T17:18:29.311Z,1563815909.311 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2019-07-22T17:18:29.314Z,1563815909.314 [CBIT](DEBUG): Construct Continuous Built In Test.
2019-07-22T17:18:29.697Z,1563815909.697 [CBIT] Loaded
2019-07-22T17:18:29.698Z,1563815909.698 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2019-07-22T17:18:29.698Z,1563815909.698 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2019-07-22T17:18:29.699Z,1563815909.699 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2019-07-22T17:18:29.887Z,1563815909.887 [Aanderaa_O2] Loaded
2019-07-22T17:18:29.887Z,1563815909.887 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2019-07-22T17:18:29.916Z,1563815909.916 [ESPComponent] Loaded
2019-07-22T17:18:29.917Z,1563815909.917 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2019-07-22T17:18:29.931Z,1563815909.931 [PAR_Licor] Loaded
2019-07-22T17:18:29.931Z,1563815909.931 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2019-07-22T17:18:29.932Z,1563815909.932 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2019-07-22T17:18:29.932Z,1563815909.932 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2019-07-22T17:18:29.973Z,1563815909.973 [DepthRateCalculator] Loaded
2019-07-22T17:18:29.973Z,1563815909.973 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2019-07-22T17:18:29.979Z,1563815909.979 [PitchRateCalculator] Loaded
2019-07-22T17:18:29.979Z,1563815909.979 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2019-07-22T17:18:29.995Z,1563815909.995 [SpeedCalculator] Loaded
2019-07-22T17:18:29.995Z,1563815909.995 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2019-07-22T17:18:30.016Z,1563815910.016 [TempGradientCalculator] Loaded
2019-07-22T17:18:30.016Z,1563815910.016 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2019-07-22T17:18:30.022Z,1563815910.022 [YawRateCalculator] Loaded
2019-07-22T17:18:30.022Z,1563815910.022 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2019-07-22T17:18:30.055Z,1563815910.055 [ElevatorOffsetCalculator] Loaded
2019-07-22T17:18:30.055Z,1563815910.055 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2019-07-22T17:18:30.056Z,1563815910.056 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2019-07-22T17:18:30.056Z,1563815910.056 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2019-07-22T17:18:30.088Z,1563815910.088 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2019-07-22T17:18:30.089Z,1563815910.089 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2019-07-22T17:18:30.192Z,1563815910.192 [DeadReckonUsingMultipleVelocitySources] Loaded
2019-07-22T17:18:30.192Z,1563815910.192 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2019-07-22T17:18:30.213Z,1563815910.213 [NavChart] Loaded
2019-07-22T17:18:30.213Z,1563815910.213 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2019-07-22T17:18:30.217Z,1563815910.217 [UniversalFixResidualReporter] Loaded
2019-07-22T17:18:30.217Z,1563815910.217 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2019-07-22T17:18:30.218Z,1563815910.218 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2019-07-22T17:18:30.218Z,1563815910.218 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2019-07-22T17:18:30.709Z,1563815910.709 [AHRS_M2] Loaded
2019-07-22T17:18:30.709Z,1563815910.709 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2019-07-22T17:18:30.814Z,1563815910.814 [DataOverHttps] Loaded
2019-07-22T17:18:30.814Z,1563815910.814 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2019-07-22T17:18:30.816Z,1563815910.816 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409134E0
2019-07-22T17:18:30.816Z,1563815910.816 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 7963
2019-07-22T17:18:30.829Z,1563815910.829 [Depth_Keller] Loaded
2019-07-22T17:18:30.829Z,1563815910.829 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2019-07-22T17:18:30.919Z,1563815910.919 [NAL9602] Loaded
2019-07-22T17:18:30.919Z,1563815910.919 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2019-07-22T17:18:30.924Z,1563815910.924 [Onboard] Loaded
2019-07-22T17:18:30.925Z,1563815910.925 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2019-07-22T17:18:30.928Z,1563815910.928 [Radio_Surface] Loaded
2019-07-22T17:18:30.928Z,1563815910.928 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2019-07-22T17:18:30.929Z,1563815910.929 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409434E0
2019-07-22T17:18:30.930Z,1563815910.930 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 7964
2019-07-22T17:18:31.055Z,1563815911.055 [DAT] Loaded
2019-07-22T17:18:31.055Z,1563815911.055 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2019-07-22T17:18:32.303Z,1563815912.303 [BPC1] Loaded
2019-07-22T17:18:32.304Z,1563815912.304 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2019-07-22T17:18:32.304Z,1563815912.304 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2019-07-22T17:18:32.305Z,1563815912.305 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2019-07-22T17:18:32.677Z,1563815912.677 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2019-07-22T17:18:32.678Z,1563815912.678 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2019-07-22T17:18:32.846Z,1563815912.846 [VerticalControl](DEBUG): Construct VerticalControl.
2019-07-22T17:18:32.930Z,1563815912.930 [VerticalControl] Loaded
2019-07-22T17:18:32.930Z,1563815912.930 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2019-07-22T17:18:32.931Z,1563815912.931 [HorizontalControl](DEBUG): Construct HorizontalControl.
2019-07-22T17:18:32.988Z,1563815912.988 [HorizontalControl] Loaded
2019-07-22T17:18:32.988Z,1563815912.988 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2019-07-22T17:18:32.989Z,1563815912.989 [SpeedControl](DEBUG): Construct SpeedControl.
2019-07-22T17:18:32.990Z,1563815912.990 [SpeedControl] Loaded
2019-07-22T17:18:32.991Z,1563815912.991 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2019-07-22T17:18:32.991Z,1563815912.991 [LoopControl](DEBUG): Construct LoopControl.
2019-07-22T17:18:32.992Z,1563815912.992 [LoopControl] Loaded
2019-07-22T17:18:32.992Z,1563815912.992 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2019-07-22T17:18:32.993Z,1563815912.993 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2019-07-22T17:18:32.993Z,1563815912.993 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2019-07-22T17:18:33.007Z,1563815913.007 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2019-07-22T17:18:33.008Z,1563815913.008 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2019-07-22T17:18:33.291Z,1563815913.291 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2019-07-22T17:18:33.295Z,1563815913.295 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2019-07-22T17:18:33.296Z,1563815913.296 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2019-07-22T17:18:33.303Z,1563815913.303 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2019-07-22T17:18:33.304Z,1563815913.304 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A7E4E0
2019-07-22T17:18:33.304Z,1563815913.304 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 7965
2019-07-22T17:18:33.310Z,1563815913.310 [Supervisor](INFO): Main Thread ID is 7879
2019-07-22T17:18:33.310Z,1563815913.310 [Supervisor](DEBUG): Running supervisor.
2019-07-22T17:18:33.311Z,1563815913.311 [CommandLine ThreadHandler](INFO): Handler Thread ID is 7966
2019-07-22T17:18:33.313Z,1563815913.313 [controlThread ThreadHandler](INFO): Handler Thread ID is 7967
2019-07-22T17:18:33.314Z,1563815913.314 [controlThread](DEBUG): Initializing ControlThread
2019-07-22T17:18:33.316Z,1563815913.316 [SBIT](INFO): Initialize SBIT Component.
2019-07-22T17:18:33.316Z,1563815913.316 [SBIT](IMPORTANT): git: 2019-07-16
2019-07-22T17:18:33.316Z,1563815913.316 [SBIT](INFO): git hash: 5dde538a58d6fd4f55501de4ce986b4d4d3b120b
2019-07-22T17:18:33.317Z,1563815913.317 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2019-07-22T17:18:33.318Z,1563815913.318 [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-07-22T17:18:33.319Z,1563815913.319 [SBIT](INFO): Beginning SBIT in 48.000000 seconds.
2019-07-22T17:18:33.320Z,1563815913.320 [IBIT](INFO): Initialize IBIT Component.
2019-07-22T17:18:33.320Z,1563815913.320 [CBIT](DEBUG): Initialize CBIT Component.
2019-07-22T17:18:33.321Z,1563815913.321 [logger ThreadHandler](INFO): Handler Thread ID is 7968
2019-07-22T17:18:33.331Z,1563815913.331 [CBIT](DEBUG): Initialized mux pins.
2019-07-22T17:18:33.331Z,1563815913.331 [CBIT](DEBUG): Initializing the watchdog timer.
2019-07-22T17:18:33.340Z,1563815913.340 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 7969
2019-07-22T17:18:33.341Z,1563815913.341 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2019-07-22T17:18:33.355Z,1563815913.355 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2019-07-22T17:18:33.355Z,1563815913.355 [CBIT](DEBUG): Initializing heartbeat.
2019-07-22T17:18:33.356Z,1563815913.356 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 7970
2019-07-22T17:18:33.368Z,1563815913.368 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 7971
2019-07-22T17:18:33.375Z,1563815913.375 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2019-07-22T17:18:33.375Z,1563815913.375 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2019-07-22T17:18:33.376Z,1563815913.376 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2019-07-22T17:18:33.376Z,1563815913.376 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2019-07-22T17:18:33.376Z,1563815913.376 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2019-07-22T17:18:33.376Z,1563815913.376 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2019-07-22T17:18:33.376Z,1563815913.376 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2019-07-22T17:18:33.377Z,1563815913.377 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2019-07-22T17:18:33.377Z,1563815913.377 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2019-07-22T17:18:33.377Z,1563815913.377 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2019-07-22T17:18:33.377Z,1563815913.377 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2019-07-22T17:18:33.377Z,1563815913.377 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2019-07-22T17:18:33.377Z,1563815913.377 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2019-07-22T17:18:33.378Z,1563815913.378 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2019-07-22T17:18:33.378Z,1563815913.378 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2019-07-22T17:18:33.378Z,1563815913.378 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2019-07-22T17:18:33.427Z,1563815913.427 [CBIT](DEBUG): Deactivating GF circuits.
2019-07-22T17:18:33.428Z,1563815913.428 [CBIT](DEBUG): Deactivating emergency mode.
2019-07-22T17:18:33.463Z,1563815913.463 [CBIT](DEBUG): Backplane powered.
2019-07-22T17:18:33.468Z,1563815913.468 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2019-07-22T17:18:33.468Z,1563815913.468 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2019-07-22T17:18:33.468Z,1563815913.468 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2019-07-22T17:18:33.469Z,1563815913.469 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2019-07-22T17:18:33.469Z,1563815913.469 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2019-07-22T17:18:33.470Z,1563815913.470 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2019-07-22T17:18:33.471Z,1563815913.471 [NavChart](DEBUG): Initialize NavChart Navigation.
2019-07-22T17:18:33.471Z,1563815913.471 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2019-07-22T17:18:33.481Z,1563815913.481 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2019-07-22T17:18:33.482Z,1563815913.482 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2019-07-22T17:18:33.483Z,1563815913.483 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2019-07-22T17:18:33.488Z,1563815913.488 [LoopControl](DEBUG): Initialize LoopControlComponent.
2019-07-22T17:18:33.489Z,1563815913.489 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2019-07-22T17:18:33.525Z,1563815913.525 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2019-07-22T17:18:33.576Z,1563815913.576 [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-07-22T17:18:33.576Z,1563815913.576 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2019-07-22T17:18:33.628Z,1563815913.628 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2019-07-22T17:18:33.629Z,1563815913.629 [Default:A.Wait](DEBUG): Construct Wait.
2019-07-22T17:18:33.631Z,1563815913.631 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2019-07-22T17:18:33.677Z,1563815913.677 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2019-07-22T17:18:33.680Z,1563815913.680 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2019-07-22T17:18:33.700Z,1563815913.700 [Default:E.Execute](DEBUG): Construct Execute.
2019-07-22T17:18:33.714Z,1563815913.714 [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-07-22T17:18:33.719Z,1563815913.719 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,ESPComponent,PAR_Licor,AHRS_M2,Depth_Keller,NAL9602,Onboard,DAT,BPC1,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2019-07-22T17:18:33.760Z,1563815913.760 [Radio_Surface](INFO): Powering up
2019-07-22T17:18:33.781Z,1563815913.781 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-07-22T17:18:34.038Z,1563815914.038 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2019-07-22T17:18:34.038Z,1563815914.038 [DAT](INFO): Powering up
2019-07-22T17:18:34.039Z,1563815914.039 [DAT](DEBUG): Initializing DAT.
2019-07-22T17:18:34.124Z,1563815914.124 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2019-07-22T17:18:34.159Z,1563815914.159 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-07-22T17:18:34.172Z,1563815914.172 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-07-22T17:18:34.173Z,1563815914.173 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-07-22T17:18:34.184Z,1563815914.184 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-07-22T17:18:34.185Z,1563815914.185 [MassServo](DEBUG): Initializing EZServoServo.
2019-07-22T17:18:34.196Z,1563815914.196 [MassServo](DEBUG): Initializing MassServo.
2019-07-22T17:18:34.197Z,1563815914.197 [RudderServo](DEBUG): Initializing EZServoServo.
2019-07-22T17:18:34.208Z,1563815914.208 [RudderServo](DEBUG): Initializing RudderServo.
2019-07-22T17:18:34.209Z,1563815914.209 [ThrusterServo](DEBUG): Initializing EZServoServo.
2019-07-22T17:18:34.220Z,1563815914.220 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2019-07-22T17:18:37.180Z,1563815917.180 [Aanderaa_O2](INFO): Powering down
2019-07-22T17:18:46.694Z,1563815926.694 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005447
2019-07-22T17:18:49.343Z,1563815929.343 [DAT](INFO): setting local address to 3
2019-07-22T17:18:49.744Z,1563815929.744 [DAT](INFO): set local address to 3
2019-07-22T17:19:01.041Z,1563815941.041 [NAL9602](INFO): Powering up NAL9602
2019-07-22T17:19:11.949Z,1563815951.949 [NAL9602](INFO): NAL9602 initialized
2019-07-22T17:19:12.768Z,1563815952.768 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:19:22.097Z,1563815962.097 [SBIT](IMPORTANT): Beginning Startup BIT
2019-07-22T17:19:22.101Z,1563815962.101 [CBIT](IMPORTANT): Beginning ground fault scan
2019-07-22T17:19:32.843Z,1563815972.843 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.010265
CHAN A1 (24V): -0.023997
CHAN A2 (12V): -0.005499
CHAN A3 (5V): -0.002789
CHAN B0 (3.3V): -0.001687
CHAN B1 (3.15aV): -0.000788
CHAN B2 (3.15bV): -0.000861
CHAN B3 (GND): 0.000356
OPEN: 0.007693
Full Scale Calc: 4.765 mA, -1.589 mA
2019-07-22T17:20:16.101Z,1563816016.101 [SBIT](IMPORTANT): SBIT PASSED
2019-07-22T17:20:16.143Z,1563816016.143 [CommandLine](IMPORTANT): got command configSet list
2019-07-22T17:20:16.144Z,1563816016.144 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2019-07-22T17:20:16.146Z,1563816016.146 [CommandLine](IMPORTANT): BuoyancyServo.fastPumpCoefficient=6 none;

2019-07-22T17:20:16.146Z,1563816016.146 [CommandLine](IMPORTANT): BuoyancyServo.fastPumpDepth=5 meter;

2019-07-22T17:20:16.147Z,1563816016.147 [CommandLine](IMPORTANT): CTD_NeilBrown.loadAtStartup=0 bool;

2019-07-22T17:20:16.147Z,1563816016.147 [CommandLine](IMPORTANT): CTD_Seabird.loadAtStartup=0 bool;

2019-07-22T17:20:16.147Z,1563816016.147 [CommandLine](IMPORTANT): DVL_micro.loadAtStartup=0 bool;

2019-07-22T17:20:16.147Z,1563816016.147 [CommandLine](IMPORTANT): DropWeight.loadAtStartup=0 bool;

2019-07-22T17:20:16.147Z,1563816016.147 [CommandLine](IMPORTANT): VerticalControl.buoyancyNeutral=378 cubic_centimeter;

2019-07-22T17:20:16.147Z,1563816016.147 [CommandLine](IMPORTANT): VerticalControl.kiDepthBuoy=0.3 reciprocal_second;

2019-07-22T17:20:16.147Z,1563816016.147 [CommandLine](IMPORTANT): VerticalControl.massDefault=-7 millimeter;

2019-07-22T17:20:16.147Z,1563816016.147 [CommandLine](IMPORTANT): WetLabsBB2FL.loadAtStartup=0 bool;

2019-07-22T17:20:16.441Z,1563816016.441 [MissionManager](IMPORTANT): Started mission Startup
2019-07-22T17:20:16.441Z,1563816016.441 [Startup] Running Loop=1
2019-07-22T17:20:16.441Z,1563816016.441 [Startup](DEBUG): Aggregate::initialize Startup
2019-07-22T17:20:16.441Z,1563816016.441 [Startup:A.GoToSurface] Running Loop=1
2019-07-22T17:20:16.441Z,1563816016.441 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-07-22T17:20:16.442Z,1563816016.442 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-07-22T17:20:16.442Z,1563816016.442 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-07-22T17:20:16.443Z,1563816016.443 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-07-22T17:20:16.443Z,1563816016.443 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-07-22T17:20:16.452Z,1563816016.452 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-07-22T17:20:16.453Z,1563816016.453 [Startup:StartupSatComms] Running Loop=1
2019-07-22T17:20:16.453Z,1563816016.453 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2019-07-22T17:20:16.453Z,1563816016.453 [Startup:StartupSatComms:A] Running Loop=1
2019-07-22T17:20:16.849Z,1563816016.849 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2019-07-22T17:21:10.236Z,1563816070.236 [CommandLine](IMPORTANT): got command gfscan
2019-07-22T17:21:10.559Z,1563816070.559 [CBIT](IMPORTANT): Beginning ground fault scan
2019-07-22T17:21:16.618Z,1563816076.618 [Startup:StartupSatComms:A](INFO): Timed out from 2019-07-22T17:20:16.5Z
2019-07-22T17:21:16.618Z,1563816076.618 [Startup:StartupSatComms:A] Stopped
2019-07-22T17:21:16.618Z,1563816076.618 [Startup:StartupSatComms:B] Running Loop=1
2019-07-22T17:21:17.029Z,1563816077.029 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-07-22T17:21:21.488Z,1563816081.488 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.008639
CHAN A1 (24V): -0.023449
CHAN A2 (12V): -0.005625
CHAN A3 (5V): -0.002310
CHAN B0 (3.3V): -0.000878
CHAN B1 (3.15aV): -0.001108
CHAN B2 (3.15bV): -0.001164
CHAN B3 (GND): 0.000143
OPEN: 0.007527
Full Scale Calc: 4.765 mA, -1.589 mA
2019-07-22T17:21:25.187Z,1563816085.187 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190719T222618/Courier0040.lzma
2019-07-22T17:21:25.993Z,1563816085.993 [DataOverHttps](INFO): Moved sent file to Logs/20190719T222618/Courier0040.lzma.bak
2019-07-22T17:21:25.993Z,1563816085.993 [DataOverHttps](INFO): SBD MOMSN=11463035
2019-07-22T17:21:33.612Z,1563816093.612 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2019-07-22T17:21:33.612Z,1563816093.612 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-22T17:21:33.622Z,1563816093.622 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-22T17:21:33.000Z,1563816094.000 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-22T17:21:33.000Z,1563816094.000 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2019-07-22T17:21:45.757Z,1563816105.757 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20190719T222618/Express0041.lzma
2019-07-22T17:21:46.561Z,1563816106.561 [DataOverHttps](INFO): Moved sent file to Logs/20190719T222618/Express0041.lzma.bak
2019-07-22T17:21:46.561Z,1563816106.561 [DataOverHttps](INFO): SBD MOMSN=11463037
2019-07-22T17:22:03.373Z,1563816123.373 [DataOverHttps](INFO): Sending 824 bytes from file Logs/20190722T171822/Express0001.lzma
2019-07-22T17:22:04.177Z,1563816124.177 [DataOverHttps](INFO): Moved sent file to Logs/20190722T171822/Express0001.lzma.bak
2019-07-22T17:22:04.177Z,1563816124.177 [DataOverHttps](INFO): SBD MOMSN=11463041
2019-07-22T17:22:08.874Z,1563816128.874 [Startup:StartupSatComms:B] Stopped
2019-07-22T17:22:08.874Z,1563816128.874 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2019-07-22T17:22:08.874Z,1563816128.874 [Startup:StartupSatComms] Stopped
2019-07-22T17:22:08.874Z,1563816128.874 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2019-07-22T17:22:08.875Z,1563816128.875 [Startup](INFO): Completed Startup
2019-07-22T17:22:08.875Z,1563816128.875 [MissionManager](INFO): Startup is completed.
2019-07-22T17:22:08.875Z,1563816128.875 [MissionManager](INFO): Uninitializing Mission Startup
2019-07-22T17:22:08.875Z,1563816128.875 [Startup] Stopped
2019-07-22T17:22:08.884Z,1563816128.884 [Startup](DEBUG): Aggregate::uninitialize Startup
2019-07-22T17:22:08.884Z,1563816128.884 [Startup:A.GoToSurface] Stopped
2019-07-22T17:22:08.884Z,1563816128.884 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-07-22T17:22:09.182Z,1563816129.182 [MissionManager](IMPORTANT): Started mission Default
2019-07-22T17:22:09.182Z,1563816129.182 [Default] Running Loop=1
2019-07-22T17:22:09.182Z,1563816129.182 [Default](DEBUG): Aggregate::initialize Default
2019-07-22T17:22:09.182Z,1563816129.182 [Default:B.GoToSurface] Running Loop=1
2019-07-22T17:22:09.182Z,1563816129.182 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-07-22T17:22:09.183Z,1563816129.183 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-07-22T17:22:09.183Z,1563816129.183 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-07-22T17:22:09.187Z,1563816129.187 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-07-22T17:22:09.188Z,1563816129.188 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-07-22T17:22:09.188Z,1563816129.188 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-07-22T17:22:09.188Z,1563816129.188 [Default:A.Wait] Running Loop=1
2019-07-22T17:22:09.189Z,1563816129.189 [Default:A.Wait](DEBUG): Initialize Wait Component.
2019-07-22T17:22:22.589Z,1563816142.589 [Default:A.Wait](INFO): Done Waiting.
2019-07-22T17:22:22.590Z,1563816142.590 [Default:A.Wait] Stopped
2019-07-22T17:22:22.590Z,1563816142.590 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2019-07-22T17:22:22.913Z,1563816142.913 [Default:CheckIn] Running Loop=1
2019-07-22T17:22:22.913Z,1563816142.913 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-07-22T17:22:22.913Z,1563816142.913 [Default:CheckIn:Read_GPS] Running Loop=1
2019-07-22T17:22:23.301Z,1563816143.301 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2019-07-22T17:24:15.165Z,1563816255.165 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-07-22T17:24:15.983Z,1563816255.983 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:24:18.811Z,1563816258.811 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:24:21.635Z,1563816261.635 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:24:23.665Z,1563816263.665 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:24:26.083Z,1563816266.083 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:24:28.919Z,1563816268.919 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:24:32.144Z,1563816272.144 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:24:34.590Z,1563816274.590 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2019-07-22T17:24:34.590Z,1563816274.590 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-22T17:24:34.600Z,1563816274.600 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-22T17:24:34.971Z,1563816274.971 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:24:35.015Z,1563816275.015 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-22T17:24:35.015Z,1563816275.015 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2019-07-22T17:24:38.203Z,1563816278.203 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:24:41.032Z,1563816281.032 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:24:44.267Z,1563816284.267 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:24:47.091Z,1563816287.091 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:24:49.919Z,1563816289.919 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:24:52.747Z,1563816292.747 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:24:54.783Z,1563816294.783 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:24:58.003Z,1563816298.003 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:25:00.843Z,1563816300.843 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:25:04.063Z,1563816304.063 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:25:06.887Z,1563816306.888 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:25:09.711Z,1563816309.711 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:25:11.737Z,1563816311.737 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:25:14.160Z,1563816314.160 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:25:16.988Z,1563816316.988 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:25:20.232Z,1563816320.232 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:25:23.048Z,1563816323.048 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:25:26.279Z,1563816326.279 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:25:29.104Z,1563816329.104 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:25:31.935Z,1563816331.935 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:25:34.782Z,1563816334.782 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:25:37.996Z,1563816337.996 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:25:40.824Z,1563816340.824 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:25:44.055Z,1563816344.055 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:25:46.883Z,1563816346.883 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:25:50.119Z,1563816350.119 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:25:52.944Z,1563816352.944 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:25:56.172Z,1563816356.172 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:25:59.019Z,1563816359.019 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:26:02.235Z,1563816362.235 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:26:05.063Z,1563816365.063 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:26:08.299Z,1563816368.299 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:26:11.131Z,1563816371.131 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:26:14.359Z,1563816374.359 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:26:17.183Z,1563816377.183 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:26:17.206Z,1563816377.206 [BPC1](ERROR): Battery stick #38 (s/n: 0139) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2019-07-22T17:26:17.207Z,1563816377.207 [BPC1](ERROR): Battery stick #39 (s/n: 00F0) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2019-07-22T17:26:17.208Z,1563816377.208 [BPC1](INFO): Calculating totals. Valid battery stick count: 55. Valid reserve battery stick count: 5.
2019-07-22T17:26:17.211Z,1563816377.211 [BPC1](INFO): Received data from all battery sticks.
2019-07-22T17:26:20.007Z,1563816380.007 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:26:22.839Z,1563816382.839 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:26:24.863Z,1563816384.863 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:26:26.879Z,1563816386.879 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:26:30.111Z,1563816390.111 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:26:32.939Z,1563816392.939 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:26:36.171Z,1563816396.171 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:26:38.996Z,1563816398.996 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:26:42.232Z,1563816402.232 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:26:45.059Z,1563816405.059 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:26:47.883Z,1563816407.883 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:26:50.311Z,1563816410.311 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:26:53.139Z,1563816413.139 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:26:56.367Z,1563816416.367 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:26:59.203Z,1563816419.203 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:27:02.431Z,1563816422.431 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:27:05.263Z,1563816425.263 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:27:08.091Z,1563816428.091 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:27:10.911Z,1563816430.911 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:27:12.939Z,1563816432.939 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:27:14.955Z,1563816434.955 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:27:18.183Z,1563816438.183 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:27:21.015Z,1563816441.015 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:27:23.039Z,1563816443.039 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-07-22T17:22:22.9Z
2019-07-22T17:27:23.039Z,1563816443.039 [Default:CheckIn:Read_GPS] Stopped
2019-07-22T17:27:23.039Z,1563816443.039 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-07-22T17:27:23.459Z,1563816443.459 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-07-22T17:27:24.244Z,1563816444.244 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:27:27.072Z,1563816447.072 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:27:29.455Z,1563816449.455 [DataOverHttps](INFO): Sending 187 bytes from file Logs/20190722T171822/Courier0004.lzma
2019-07-22T17:27:30.261Z,1563816450.261 [DataOverHttps](INFO): Moved sent file to Logs/20190722T171822/Courier0004.lzma.bak
2019-07-22T17:27:30.261Z,1563816450.261 [DataOverHttps](INFO): SBD MOMSN=11463067
2019-07-22T17:27:30.323Z,1563816450.323 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:27:33.132Z,1563816453.132 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:27:35.568Z,1563816455.568 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2019-07-22T17:27:35.569Z,1563816455.569 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-22T17:27:35.578Z,1563816455.578 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-22T17:27:35.959Z,1563816455.959 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:27:36.011Z,1563816456.011 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-22T17:27:36.011Z,1563816456.011 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2019-07-22T17:27:38.387Z,1563816458.387 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:27:41.211Z,1563816461.211 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:27:44.447Z,1563816464.447 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:27:46.176Z,1563816466.176 [DataOverHttps](INFO): Sending 343 bytes from file Logs/20190722T171822/Express0005.lzma
2019-07-22T17:27:46.981Z,1563816466.981 [DataOverHttps](INFO): Moved sent file to Logs/20190722T171822/Express0005.lzma.bak
2019-07-22T17:27:46.981Z,1563816466.981 [DataOverHttps](INFO): SBD MOMSN=11463069
2019-07-22T17:27:47.275Z,1563816467.275 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:27:50.511Z,1563816470.511 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:27:51.347Z,1563816471.347 [Default:CheckIn:Read_Iridium] Stopped
2019-07-22T17:27:51.347Z,1563816471.347 [Default:CheckIn:C.Wait] Running Loop=1
2019-07-22T17:27:51.347Z,1563816471.347 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-07-22T17:27:53.332Z,1563816473.332 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:27:56.163Z,1563816476.163 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:27:59.003Z,1563816479.003 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:28:01.008Z,1563816481.008 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:28:03.028Z,1563816483.028 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:28:06.263Z,1563816486.263 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:28:09.088Z,1563816489.088 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:28:12.327Z,1563816492.327 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:28:15.147Z,1563816495.147 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:28:18.380Z,1563816498.380 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:28:21.211Z,1563816501.211 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:28:24.039Z,1563816504.039 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:28:26.463Z,1563816506.463 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:28:29.291Z,1563816509.291 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:28:32.523Z,1563816512.523 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:28:35.363Z,1563816515.363 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:28:38.580Z,1563816518.580 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:28:41.407Z,1563816521.407 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:28:44.235Z,1563816524.235 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:28:47.071Z,1563816527.071 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:28:49.087Z,1563816529.087 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:28:51.107Z,1563816531.107 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:28:54.339Z,1563816534.339 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:28:57.171Z,1563816537.171 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:29:00.399Z,1563816540.399 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:29:03.227Z,1563816543.227 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:29:06.459Z,1563816546.459 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:29:09.308Z,1563816549.308 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:29:12.111Z,1563816552.111 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:29:14.529Z,1563816554.529 [NAL9602](FAULT): GPS failed to acquire within timeout.
2019-07-22T17:29:14.529Z,1563816554.529 [NAL9602] Data Fault, FailCount= 1
2019-07-22T17:29:14.529Z,1563816554.529 [NAL9602](ERROR): Data Fault
2019-07-22T17:29:14.565Z,1563816554.565 [CBIT](ERROR): Data Fault in component: NAL9602
2019-07-22T17:29:14.933Z,1563816554.933 [NAL9602](INFO): Powering down
2019-07-22T17:29:15.764Z,1563816555.764 [CBIT](INFO): Clearing failed state for component NAL9602
2019-07-22T17:29:15.764Z,1563816555.764 [NAL9602] No Fault, FailCount= 1
2019-07-22T17:29:45.233Z,1563816585.233 [NAL9602](INFO): Powering up NAL9602
2019-07-22T17:29:56.141Z,1563816596.141 [NAL9602](INFO): NAL9602 initialized
2019-07-22T17:29:56.960Z,1563816596.960 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:29:59.384Z,1563816599.384 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:30:02.612Z,1563816602.612 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:30:05.443Z,1563816605.443 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:30:08.268Z,1563816608.268 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:30:10.288Z,1563816610.288 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:30:12.316Z,1563816612.316 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:30:14.336Z,1563816614.336 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:30:16.360Z,1563816616.360 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:30:19.584Z,1563816619.584 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:30:22.408Z,1563816622.408 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:30:25.647Z,1563816625.647 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:30:28.471Z,1563816628.471 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:30:31.703Z,1563816631.703 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:30:34.527Z,1563816634.527 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:30:36.621Z,1563816636.621 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2019-07-22T17:30:36.623Z,1563816636.623 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-22T17:30:36.720Z,1563816636.720 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-22T17:30:36.971Z,1563816636.971 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-22T17:30:36.987Z,1563816636.987 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2019-07-22T17:30:37.388Z,1563816637.388 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:30:39.380Z,1563816639.380 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:30:42.608Z,1563816642.608 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:30:45.435Z,1563816645.435 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:30:48.675Z,1563816648.675 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:30:51.499Z,1563816651.499 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:30:54.731Z,1563816654.731 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:30:57.559Z,1563816657.559 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:31:00.391Z,1563816660.391 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:31:02.407Z,1563816662.407 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:31:05.639Z,1563816665.639 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:31:08.467Z,1563816668.467 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:31:11.695Z,1563816671.695 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:31:14.527Z,1563816674.527 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:31:17.759Z,1563816677.759 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:31:20.587Z,1563816680.587 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:31:23.415Z,1563816683.415 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:31:25.435Z,1563816685.435 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:31:28.667Z,1563816688.667 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:31:31.495Z,1563816691.495 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:31:34.731Z,1563816694.731 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:31:37.555Z,1563816697.555 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:31:39.189Z,1563816699.189 [CBIT](FAULT): WATER ALARM AUX.
2019-07-22T17:31:39.189Z,1563816699.189 [CBIT](ERROR): WATER DETECTED IN PRESSURE HULL. Alarm Count: 1
2019-07-22T17:31:39.600Z,1563816699.600 [CBIT](FAULT): WATER ALARM AUX.
2019-07-22T17:31:39.600Z,1563816699.600 [CBIT](ERROR): WATER DETECTED IN PRESSURE HULL. Alarm Count: 2
2019-07-22T17:31:40.016Z,1563816700.016 [CBIT](FAULT): WATER ALARM AUX.
2019-07-22T17:31:40.017Z,1563816700.017 [CBIT](ERROR): WATER DETECTED IN PRESSURE HULL. Alarm Count: 3
2019-07-22T17:31:40.430Z,1563816700.430 [CBIT](FAULT): WATER ALARM AUX.
2019-07-22T17:31:40.444Z,1563816700.444 [CBIT](CRITICAL): WATER DETECTED IN PRESSURE HULL. BURNWIRE ACTIVATED
2019-07-22T17:31:40.445Z,1563816700.445 [Supervisor](INFO): Stop Mission called by CBIT::checkLeak
2019-07-22T17:31:40.449Z,1563816700.449 [CommandLine](IMPORTANT): got command ! echo 0 > /dev/loadA6
2019-07-22T17:31:40.464Z,1563816700.464 [CBIT](IMPORTANT): Powered off ESP with command: ! echo 0 > /dev/loadA6
2019-07-22T17:31:40.795Z,1563816700.795 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:31:40.867Z,1563816700.867 [CommandLine](FAULT): Scheduling is paused
2019-07-22T17:31:40.868Z,1563816700.868 [CBIT](INFO): Critical error at 20190722T173140
2019-07-22T17:31:43.628Z,1563816703.628 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:31:46.451Z,1563816706.451 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:31:48.483Z,1563816708.483 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:31:50.492Z,1563816710.492 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:31:53.715Z,1563816713.715 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:31:56.551Z,1563816716.551 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:31:59.779Z,1563816719.779 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:32:02.603Z,1563816722.603 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:32:05.431Z,1563816725.431 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:32:08.667Z,1563816728.667 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:32:11.492Z,1563816731.492 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:32:14.719Z,1563816734.719 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:32:17.551Z,1563816737.551 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:32:20.784Z,1563816740.783 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:32:23.615Z,1563816743.615 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:32:26.847Z,1563816746.847 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:32:29.667Z,1563816749.667 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:32:32.903Z,1563816752.903 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:32:35.727Z,1563816755.727 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:32:38.963Z,1563816758.963 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:32:41.791Z,1563816761.791 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:32:45.023Z,1563816765.023 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:32:47.855Z,1563816767.855 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:32:50.683Z,1563816770.683 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:32:51.901Z,1563816771.901 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-07-22T17:32:51.901Z,1563816771.901 [Default:CheckIn:C.Wait] Stopped
2019-07-22T17:32:51.901Z,1563816771.901 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-07-22T17:32:51.901Z,1563816771.901 [Default:CheckIn:D] Running Loop=1
2019-07-22T17:32:52.305Z,1563816772.305 [Default:CheckIn:D] Stopped
2019-07-22T17:32:52.305Z,1563816772.305 [Default:CheckIn:E] Running Loop=1
2019-07-22T17:32:52.707Z,1563816772.707 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.718717 min 
2019-07-22T17:32:52.707Z,1563816772.707 [Default:CheckIn:E] Stopped
2019-07-22T17:32:52.707Z,1563816772.707 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-07-22T17:32:52.707Z,1563816772.707 [Default:CheckIn] Stopped
2019-07-22T17:32:52.708Z,1563816772.708 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-07-22T17:32:52.708Z,1563816772.708 [Default:CheckIn](INFO): Running loop #2
2019-07-22T17:32:52.708Z,1563816772.708 [Default:CheckIn] Running Loop=2
2019-07-22T17:32:52.708Z,1563816772.708 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-07-22T17:32:52.708Z,1563816772.708 [Default:CheckIn:Read_GPS] Running Loop=1
2019-07-22T17:32:53.507Z,1563816773.507 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:32:56.739Z,1563816776.739 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:32:59.571Z,1563816779.571 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:33:02.799Z,1563816782.799 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:33:05.623Z,1563816785.623 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:33:08.345Z,1563816788.345 [CommandLine](IMPORTANT): got command failComponent
2019-07-22T17:33:08.346Z,1563816788.346 [CommandLine](IMPORTANT): Failed components:
2019-07-22T17:33:08.346Z,1563816788.346 [CommandLine](IMPORTANT): No failed Components.
2019-07-22T17:33:08.860Z,1563816788.860 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:33:11.695Z,1563816791.695 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:33:14.923Z,1563816794.923 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:33:17.747Z,1563816797.747 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:33:20.979Z,1563816800.979 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:33:23.807Z,1563816803.807 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:33:27.039Z,1563816807.039 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:33:29.867Z,1563816809.867 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:33:33.099Z,1563816813.099 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:33:35.932Z,1563816815.932 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:33:37.560Z,1563816817.560 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2019-07-22T17:33:37.560Z,1563816817.560 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-22T17:33:37.570Z,1563816817.570 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-22T17:33:37.970Z,1563816817.970 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-22T17:33:37.970Z,1563816817.970 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2019-07-22T17:33:38.755Z,1563816818.755 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:33:41.580Z,1563816821.580 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:33:44.819Z,1563816824.819 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:33:47.651Z,1563816827.651 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:33:50.879Z,1563816830.879 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:33:51.493Z,1563816831.493 [CommandLine](IMPORTANT): got command show variable CBIT
2019-07-22T17:33:51.501Z,1563816831.501 [CommandLine](IMPORTANT): CBIT.GFActive (bool)
2019-07-22T17:33:51.520Z,1563816831.520 [CommandLine](IMPORTANT): CBITMainGroundfault.ad (none)
2019-07-22T17:33:51.520Z,1563816831.520 [CommandLine](IMPORTANT): CBITMainGroundfault.adRes (bit)
2019-07-22T17:33:51.520Z,1563816831.520 [CommandLine](IMPORTANT): CBITMainGroundfault.adTimeout (millisecond)
2019-07-22T17:33:51.521Z,1563816831.521 [CommandLine](IMPORTANT): CBITMainGroundfault.adVref (volt)
2019-07-22T17:33:51.521Z,1563816831.521 [CommandLine](IMPORTANT): CBITWaterAlarmBow.ad (none)
2019-07-22T17:33:51.521Z,1563816831.521 [CommandLine](IMPORTANT): CBITWaterAlarmBow.adRes (bit)
2019-07-22T17:33:51.522Z,1563816831.522 [CommandLine](IMPORTANT): CBITWaterAlarmBow.adVref (volt)
2019-07-22T17:33:51.522Z,1563816831.522 [CommandLine](IMPORTANT): CBITWaterAlarmStern.ad (none)
2019-07-22T17:33:51.523Z,1563816831.523 [CommandLine](IMPORTANT): CBITWaterAlarmStern.adRes (bit)
2019-07-22T17:33:51.523Z,1563816831.523 [CommandLine](IMPORTANT): CBITWaterAlarmStern.adVref (volt)
2019-07-22T17:33:51.523Z,1563816831.523 [CommandLine](IMPORTANT): CBITWaterAlarmAux.ad (none)
2019-07-22T17:33:51.524Z,1563816831.524 [CommandLine](IMPORTANT): CBITWaterAlarmAux.adRes (bit)
2019-07-22T17:33:51.524Z,1563816831.524 [CommandLine](IMPORTANT): CBITWaterAlarmAux.adVref (volt)
2019-07-22T17:33:51.557Z,1563816831.557 [CommandLine](IMPORTANT): CBIT.loadAtStartup (bool)
2019-07-22T17:33:51.558Z,1563816831.558 [CommandLine](IMPORTANT): CBIT.simulateHardware (bool)
2019-07-22T17:33:51.558Z,1563816831.558 [CommandLine](IMPORTANT): CBIT.stopDepth (meter)
2019-07-22T17:33:51.558Z,1563816831.558 [CommandLine](IMPORTANT): CBIT.abortDepth (meter)
2019-07-22T17:33:51.559Z,1563816831.559 [CommandLine](IMPORTANT): CBIT.humidityThreshold (percent)
2019-07-22T17:33:51.559Z,1563816831.559 [CommandLine](IMPORTANT): CBIT.pressureThreshold (pound_per_square_inch)
2019-07-22T17:33:51.560Z,1563816831.560 [CommandLine](IMPORTANT): CBIT.tempThreshold (fahrenheit)
2019-07-22T17:33:51.560Z,1563816831.560 [CommandLine](IMPORTANT): CBIT.abortDepthTimeout (second)
2019-07-22T17:33:51.560Z,1563816831.560 [CommandLine](IMPORTANT): CBIT.battFailReport (count)
2019-07-22T17:33:51.561Z,1563816831.561 [CommandLine](IMPORTANT): CBIT.battTempThreshold (celsius)
2019-07-22T17:33:51.561Z,1563816831.561 [CommandLine](IMPORTANT): CBIT.envTimeout (second)
2019-07-22T17:33:51.562Z,1563816831.562 [CommandLine](IMPORTANT): CBIT.runElevOffsetCalc (bool)
2019-07-22T17:33:51.562Z,1563816831.562 [CommandLine](IMPORTANT): CBIT.runFaultClassifier (bool)
2019-07-22T17:33:51.562Z,1563816831.562 [CommandLine](IMPORTANT): CBIT.vehicleOpen (bool)
2019-07-22T17:33:51.563Z,1563816831.563 [CommandLine](IMPORTANT): CBIT.gfChanA0_Threshold (milliampere)
2019-07-22T17:33:51.563Z,1563816831.563 [CommandLine](IMPORTANT): CBIT.gfChanA1_Threshold (milliampere)
2019-07-22T17:33:51.600Z,1563816831.600 [CommandLine](IMPORTANT): CBIT.gfChanA2_Threshold (milliampere)
2019-07-22T17:33:51.600Z,1563816831.600 [CommandLine](IMPORTANT): CBIT.gfChanA3_Threshold (milliampere)
2019-07-22T17:33:51.600Z,1563816831.600 [CommandLine](IMPORTANT): CBIT.gfChanB0_Threshold (milliampere)
2019-07-22T17:33:51.601Z,1563816831.601 [CommandLine](IMPORTANT): CBIT.gfChanB1_Threshold (milliampere)
2019-07-22T17:33:51.601Z,1563816831.601 [CommandLine](IMPORTANT): CBIT.gfChanB2_Threshold (milliampere)
2019-07-22T17:33:51.602Z,1563816831.602 [CommandLine](IMPORTANT): CBIT.gfChanB3_Threshold (milliampere)
2019-07-22T17:33:51.602Z,1563816831.602 [CommandLine](IMPORTANT): CBIT.gfScanTimeout (hour)
2019-07-22T17:33:51.602Z,1563816831.602 [CommandLine](IMPORTANT): CBIT.gfBattOffset (microampere)
2019-07-22T17:33:51.603Z,1563816831.603 [CommandLine](IMPORTANT): CBIT.gf24Offset (microampere)
2019-07-22T17:33:51.603Z,1563816831.603 [CommandLine](IMPORTANT): CBIT.gf12Offset (microampere)
2019-07-22T17:33:51.603Z,1563816831.603 [CommandLine](IMPORTANT): CBIT.gf5Offset (microampere)
2019-07-22T17:33:51.604Z,1563816831.604 [CommandLine](IMPORTANT): CBIT.gf3_3Offset (microampere)
2019-07-22T17:33:51.604Z,1563816831.604 [CommandLine](IMPORTANT): CBIT.gf3_15Offset (microampere)
2019-07-22T17:33:51.605Z,1563816831.605 [CommandLine](IMPORTANT): CBIT.gfCommOffset (microampere)
2019-07-22T17:33:51.624Z,1563816831.624 [CommandLine](IMPORTANT): CBIT.empiricalFaultElevOffset (radian)
2019-07-22T17:33:51.632Z,1563816831.632 [CommandLine](IMPORTANT): CBIT.shorePowerOn (bool)
2019-07-22T17:33:51.632Z,1563816831.632 [CommandLine](IMPORTANT): CBIT.platform_fault (enum)
2019-07-22T17:33:51.632Z,1563816831.632 [CommandLine](IMPORTANT): CBIT.platform_fault_leak (enum)
2019-07-22T17:33:51.633Z,1563816831.633 [CommandLine](IMPORTANT): CBIT.GFCHANA0Current (milliampere)
2019-07-22T17:33:51.633Z,1563816831.633 [CommandLine](IMPORTANT): CBIT.GFCHANA1Current (milliampere)
2019-07-22T17:33:51.633Z,1563816831.633 [CommandLine](IMPORTANT): CBIT.GFCHANA2Current (milliampere)
2019-07-22T17:33:51.634Z,1563816831.634 [CommandLine](IMPORTANT): CBIT.GFCHANA3Current (milliampere)
2019-07-22T17:33:51.634Z,1563816831.634 [CommandLine](IMPORTANT): CBIT.GFCHANB0Current (milliampere)
2019-07-22T17:33:51.635Z,1563816831.635 [CommandLine](IMPORTANT): CBIT.GFCHANB1Current (milliampere)
2019-07-22T17:33:51.635Z,1563816831.635 [CommandLine](IMPORTANT): CBIT.GFCHANB2Current (milliampere)
2019-07-22T17:33:51.640Z,1563816831.640 [CommandLine](IMPORTANT): CBIT.GFCHANB3Current (milliampere)
2019-07-22T17:33:51.640Z,1563816831.640 [CommandLine](IMPORTANT): CBIT.GFCHANOpenCurrent (milliampere)
2019-07-22T17:33:51.640Z,1563816831.640 [CommandLine](IMPORTANT): CBIT.empericalClassifierFaultDetected (enum)
2019-07-22T17:33:51.641Z,1563816831.641 [CommandLine](IMPORTANT): CBIT.binnedDepthRate (meter_per_second)
2019-07-22T17:33:53.711Z,1563816833.711 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:33:56.936Z,1563816836.936 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:33:59.763Z,1563816839.763 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:34:02.991Z,1563816842.991 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:34:04.809Z,1563816844.809 [CommandLine](IMPORTANT): got command burn off
2019-07-22T17:34:04.809Z,1563816844.809 [CommandLine](IMPORTANT): Deactivating dropweight wire
2019-07-22T17:34:05.823Z,1563816845.823 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:34:09.055Z,1563816849.055 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:34:11.880Z,1563816851.880 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:34:15.111Z,1563816855.111 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:34:17.951Z,1563816857.951 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:34:21.172Z,1563816861.172 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:34:24.003Z,1563816864.003 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:34:26.835Z,1563816866.835 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:34:29.655Z,1563816869.655 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:34:32.891Z,1563816872.891 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:34:35.715Z,1563816875.715 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:34:38.951Z,1563816878.951 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:34:41.780Z,1563816881.780 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:34:45.023Z,1563816885.023 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:34:47.839Z,1563816887.839 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:34:51.071Z,1563816891.071 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:34:53.895Z,1563816893.895 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:34:57.131Z,1563816897.131 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:34:59.955Z,1563816899.955 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:35:03.191Z,1563816903.191 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:35:06.019Z,1563816906.019 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:35:08.851Z,1563816908.851 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:35:12.076Z,1563816912.076 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:35:14.912Z,1563816914.912 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:35:17.744Z,1563816917.744 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:35:20.972Z,1563816920.972 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:35:23.804Z,1563816923.804 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:35:27.032Z,1563816927.032 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:35:29.867Z,1563816929.867 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:35:33.103Z,1563816933.103 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:35:35.923Z,1563816935.923 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:35:39.159Z,1563816939.159 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:35:41.999Z,1563816941.999 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:35:45.215Z,1563816945.215 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:35:48.047Z,1563816948.047 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:35:51.279Z,1563816951.279 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:35:54.107Z,1563816954.107 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:35:56.927Z,1563816956.927 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:35:59.759Z,1563816959.759 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:36:01.780Z,1563816961.780 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:36:03.799Z,1563816963.799 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:36:07.031Z,1563816967.031 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:36:09.859Z,1563816969.859 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:36:13.088Z,1563816973.088 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:36:15.931Z,1563816975.931 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:36:19.159Z,1563816979.159 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:36:21.979Z,1563816981.979 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:36:24.803Z,1563816984.803 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:36:27.227Z,1563816987.227 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:36:30.059Z,1563816990.059 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:36:33.287Z,1563816993.287 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:36:36.127Z,1563816996.127 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:36:38.558Z,1563816998.558 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2019-07-22T17:36:38.558Z,1563816998.558 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-22T17:36:38.568Z,1563816998.568 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-22T17:36:38.969Z,1563816998.969 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-22T17:36:38.969Z,1563816998.969 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2019-07-22T17:36:39.356Z,1563816999.356 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:36:42.191Z,1563817002.191 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:36:45.008Z,1563817005.008 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:36:47.831Z,1563817007.831 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:36:49.863Z,1563817009.863 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:36:51.875Z,1563817011.875 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:36:55.103Z,1563817015.103 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:36:57.935Z,1563817017.935 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:37:01.163Z,1563817021.163 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:37:03.999Z,1563817023.999 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:37:07.228Z,1563817027.228 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:37:10.055Z,1563817030.055 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:37:12.883Z,1563817032.883 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:37:15.308Z,1563817035.308 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:37:18.131Z,1563817038.131 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:37:21.372Z,1563817041.372 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:37:24.192Z,1563817044.192 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:37:27.431Z,1563817047.431 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:37:30.252Z,1563817050.252 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:37:33.083Z,1563817053.083 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:37:35.911Z,1563817055.911 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:37:37.936Z,1563817057.936 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:37:39.947Z,1563817059.947 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:37:43.183Z,1563817063.183 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:37:46.007Z,1563817066.007 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:37:49.243Z,1563817069.243 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:37:52.072Z,1563817072.072 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:37:52.911Z,1563817072.911 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-07-22T17:32:52.7Z
2019-07-22T17:37:52.911Z,1563817072.911 [Default:CheckIn:Read_GPS] Stopped
2019-07-22T17:37:52.911Z,1563817072.911 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-07-22T17:37:55.308Z,1563817075.308 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:37:58.128Z,1563817078.128 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:38:00.955Z,1563817080.955 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:38:03.419Z,1563817083.419 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:38:03.692Z,1563817083.692 [DataOverHttps](INFO): Sending 109 bytes from file Logs/20190722T171822/Courier0007.lzma
2019-07-22T17:38:04.501Z,1563817084.501 [DataOverHttps](INFO): Moved sent file to Logs/20190722T171822/Courier0007.lzma.bak
2019-07-22T17:38:04.501Z,1563817084.501 [DataOverHttps](INFO): SBD MOMSN=11463083
2019-07-22T17:38:06.207Z,1563817086.207 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:38:09.443Z,1563817089.443 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:38:12.271Z,1563817092.271 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:38:15.504Z,1563817095.504 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:38:18.339Z,1563817098.339 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:38:21.155Z,1563817101.155 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:38:21.325Z,1563817101.325 [DataOverHttps](INFO): Sending 1022 bytes from file Logs/20190722T171822/Express0008.lzma
2019-07-22T17:38:22.129Z,1563817102.129 [DataOverHttps](INFO): Moved sent file to Logs/20190722T171822/Express0008.lzma.bak
2019-07-22T17:38:22.129Z,1563817102.129 [DataOverHttps](INFO): SBD MOMSN=11463086
2019-07-22T17:38:23.984Z,1563817103.984 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:38:26.016Z,1563817106.016 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:38:26.860Z,1563817106.860 [Default:CheckIn:Read_Iridium] Stopped
2019-07-22T17:38:26.860Z,1563817106.860 [Default:CheckIn:C.Wait] Running Loop=1
2019-07-22T17:38:26.860Z,1563817106.860 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-07-22T17:38:28.027Z,1563817108.027 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:38:31.259Z,1563817111.259 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:38:34.088Z,1563817114.088 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:38:37.315Z,1563817117.315 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:38:40.147Z,1563817120.147 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:38:43.376Z,1563817123.376 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:38:46.207Z,1563817126.207 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:38:49.031Z,1563817129.031 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:38:51.459Z,1563817131.459 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:38:54.291Z,1563817134.291 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:38:57.519Z,1563817137.519 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:39:00.347Z,1563817140.347 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:39:03.579Z,1563817143.579 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:39:06.407Z,1563817146.407 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:39:09.247Z,1563817149.247 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:39:12.060Z,1563817152.060 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:39:14.083Z,1563817154.083 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:39:16.103Z,1563817156.103 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:39:19.331Z,1563817159.332 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:39:22.167Z,1563817162.167 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:39:25.395Z,1563817165.395 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:39:28.227Z,1563817168.227 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:39:31.455Z,1563817171.455 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:39:34.287Z,1563817174.287 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:39:37.123Z,1563817177.123 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:39:39.539Z,1563817179.539 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:39:39.559Z,1563817179.559 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2019-07-22T17:39:39.560Z,1563817179.560 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-22T17:39:39.569Z,1563817179.569 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-22T17:39:39.976Z,1563817179.976 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-22T17:39:39.977Z,1563817179.977 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2019-07-22T17:39:42.360Z,1563817182.360 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:39:45.595Z,1563817185.595 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:39:48.423Z,1563817188.423 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:39:51.655Z,1563817191.655 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:39:54.483Z,1563817194.483 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:39:57.301Z,1563817197.301 [NAL9602](FAULT): GPS failed to acquire within timeout.
2019-07-22T17:39:57.301Z,1563817197.301 [NAL9602] Data Fault, FailCount= 2
2019-07-22T17:39:57.301Z,1563817197.301 [NAL9602](ERROR): Data Fault
2019-07-22T17:39:57.366Z,1563817197.366 [CBIT](ERROR): Data Fault in component: NAL9602
2019-07-22T17:39:57.704Z,1563817197.704 [NAL9602](INFO): Powering down
2019-07-22T17:39:58.541Z,1563817198.541 [CBIT](INFO): Clearing failed state for component NAL9602
2019-07-22T17:39:58.541Z,1563817198.541 [NAL9602] No Fault, FailCount= 2
2019-07-22T17:40:28.023Z,1563817228.023 [NAL9602](INFO): Powering up NAL9602
2019-07-22T17:40:38.913Z,1563817238.913 [NAL9602](INFO): NAL9602 initialized
2019-07-22T17:40:39.735Z,1563817239.735 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:40:42.155Z,1563817242.155 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:40:45.387Z,1563817245.387 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:40:48.211Z,1563817248.211 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:40:51.451Z,1563817251.451 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:40:54.275Z,1563817254.275 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:40:57.104Z,1563817257.104 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:41:00.335Z,1563817260.335 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:41:03.163Z,1563817263.163 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:41:06.395Z,1563817266.395 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:41:09.223Z,1563817269.223 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:41:12.451Z,1563817272.451 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:41:15.284Z,1563817275.284 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:41:18.111Z,1563817278.111 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:41:21.347Z,1563817281.347 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:41:24.171Z,1563817284.171 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:41:27.415Z,1563817287.415 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:41:30.235Z,1563817290.235 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:41:33.479Z,1563817293.479 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:41:36.295Z,1563817296.295 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:41:39.527Z,1563817299.527 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:41:42.351Z,1563817302.351 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:41:45.175Z,1563817305.175 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:41:47.203Z,1563817307.203 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:41:50.435Z,1563817310.435 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:41:53.259Z,1563817313.259 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:41:56.495Z,1563817316.495 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:41:59.319Z,1563817319.319 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:42:02.551Z,1563817322.551 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:42:05.375Z,1563817325.375 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:42:08.207Z,1563817328.207 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:42:11.439Z,1563817331.439 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:42:14.271Z,1563817334.271 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:42:17.503Z,1563817337.503 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:42:20.327Z,1563817340.327 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:42:23.559Z,1563817343.559 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:42:26.387Z,1563817346.387 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:42:29.619Z,1563817349.619 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:42:32.451Z,1563817352.451 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:42:35.275Z,1563817355.275 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:42:38.507Z,1563817358.507 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:42:40.537Z,1563817360.537 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2019-07-22T17:42:40.537Z,1563817360.537 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-22T17:42:40.547Z,1563817360.547 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-22T17:42:40.957Z,1563817360.957 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-22T17:42:40.957Z,1563817360.957 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2019-07-22T17:42:41.339Z,1563817361.339 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:42:44.563Z,1563817364.563 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:42:47.399Z,1563817367.399 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:42:49.415Z,1563817369.415 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:42:51.839Z,1563817371.839 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:42:54.668Z,1563817374.668 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:42:57.899Z,1563817377.899 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:43:00.731Z,1563817380.731 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:43:03.555Z,1563817383.555 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:43:06.383Z,1563817386.383 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:43:09.619Z,1563817389.619 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:43:12.443Z,1563817392.443 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:43:15.671Z,1563817395.671 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:43:18.503Z,1563817398.503 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:43:21.739Z,1563817401.739 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:43:24.567Z,1563817404.567 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:43:27.402Z,1563817407.402 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-07-22T17:43:27.402Z,1563817407.402 [Default:CheckIn:C.Wait] Stopped
2019-07-22T17:43:27.402Z,1563817407.402 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-07-22T17:43:27.402Z,1563817407.402 [Default:CheckIn:D] Running Loop=1
2019-07-22T17:43:27.803Z,1563817407.803 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:43:27.833Z,1563817407.833 [Default:CheckIn:D] Stopped
2019-07-22T17:43:27.833Z,1563817407.833 [Default:CheckIn:E] Running Loop=1
2019-07-22T17:43:28.237Z,1563817408.237 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.310844 min 
2019-07-22T17:43:28.237Z,1563817408.237 [Default:CheckIn:E] Stopped
2019-07-22T17:43:28.237Z,1563817408.237 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-07-22T17:43:28.237Z,1563817408.237 [Default:CheckIn] Stopped
2019-07-22T17:43:28.238Z,1563817408.238 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-07-22T17:43:28.238Z,1563817408.238 [Default:CheckIn](INFO): Running loop #3
2019-07-22T17:43:28.238Z,1563817408.238 [Default:CheckIn] Running Loop=3
2019-07-22T17:43:28.238Z,1563817408.238 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-07-22T17:43:28.238Z,1563817408.238 [Default:CheckIn:Read_GPS] Running Loop=1
2019-07-22T17:43:30.639Z,1563817410.639 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:43:33.859Z,1563817413.859 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:43:36.687Z,1563817416.687 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:43:39.915Z,1563817419.915 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:43:42.743Z,1563817422.743 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:43:45.975Z,1563817425.975 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:43:48.803Z,1563817428.803 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:43:51.631Z,1563817431.631 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:43:54.459Z,1563817434.459 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:43:57.695Z,1563817437.695 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:44:00.515Z,1563817440.515 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:44:03.751Z,1563817443.751 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:44:06.580Z,1563817446.580 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:44:09.811Z,1563817449.811 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:44:12.639Z,1563817452.639 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:44:15.871Z,1563817455.871 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:44:18.699Z,1563817458.699 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:44:21.931Z,1563817461.931 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:44:24.771Z,1563817464.771 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:44:27.999Z,1563817467.999 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:44:30.823Z,1563817470.823 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:44:34.051Z,1563817474.051 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:44:36.883Z,1563817476.883 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:44:39.707Z,1563817479.707 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:44:42.531Z,1563817482.531 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:44:45.763Z,1563817485.763 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:44:48.600Z,1563817488.600 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:44:50.694Z,1563817490.694 [CommandLine](IMPORTANT): got command restart application
2019-07-22T17:44:51.700Z,1563817491.700 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2019-07-22T17:44:51.700Z,1563817491.700 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-07-22T17:44:51.828Z,1563817491.828 [NAL9602](DEBUG): Fix Requested
2019-07-22T17:44:51.843Z,1563817491.843 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2019-07-22T17:44:51.844Z,1563817491.844 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-07-22T17:44:51.844Z,1563817491.844 [CommandLine](INFO): Join timeout helper Thread ID is 8031
2019-07-22T17:44:51.845Z,1563817491.845 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2019-07-22T17:44:51.845Z,1563817491.845 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-07-22T17:44:51.846Z,1563817491.846 [NavChartDb](INFO): Join timeout helper Thread ID is 8032
2019-07-22T17:44:52.060Z,1563817492.060 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2019-07-22T17:44:52.060Z,1563817492.060 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-07-22T17:44:52.079Z,1563817492.079 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2019-07-22T17:44:52.080Z,1563817492.080 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-07-22T17:44:52.080Z,1563817492.080 [Radio_Surface](INFO): Join timeout helper Thread ID is 8033
2019-07-22T17:44:52.388Z,1563817492.388 [Radio_Surface](INFO): Powering down
2019-07-22T17:44:52.388Z,1563817492.388 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2019-07-22T17:44:52.389Z,1563817492.389 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-07-22T17:44:52.391Z,1563817492.391 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2019-07-22T17:44:52.392Z,1563817492.392 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-07-22T17:44:52.392Z,1563817492.392 [DataOverHttps](INFO): Join timeout helper Thread ID is 8034
2019-07-22T17:44:52.588Z,1563817492.588 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2019-07-22T17:44:52.588Z,1563817492.588 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-07-22T17:44:52.591Z,1563817492.591 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2019-07-22T17:44:52.592Z,1563817492.592 [logger ThreadHandler](INFO): Thread cancelled.
2019-07-22T17:44:52.592Z,1563817492.592 [logger](INFO): Join timeout helper Thread ID is 8035
2019-07-22T17:44:52.652Z,1563817492.652 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2019-07-22T17:44:52.652Z,1563817492.652 [logger ThreadHandler](INFO): Thread cancelled.
2019-07-22T17:44:52.660Z,1563817492.660 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2019-07-22T17:44:52.661Z,1563817492.661 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-07-22T17:44:52.661Z,1563817492.661 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2019-07-22T17:44:52.661Z,1563817492.661 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-07-22T17:44:52.661Z,1563817492.661 [controlThread](INFO): Join timeout helper Thread ID is 8036
2019-07-22T17:44:52.669Z,1563817492.669 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2019-07-22T17:44:52.670Z,1563817492.670 [controlThread](DEBUG): Uninitializing ControlThread
2019-07-22T17:44:52.670Z,1563817492.670 [Aanderaa_O2](INFO): Powering down
2019-07-22T17:44:52.692Z,1563817492.692 [AHRS_M2](INFO): Powering down
2019-07-22T17:44:52.764Z,1563817492.764 [NAL9602](INFO): Powering down
2019-07-22T17:44:52.848Z,1563817492.848 [DAT](INFO): Powering down
2019-07-22T17:44:52.968Z,1563817492.968 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2019-07-22T17:44:52.969Z,1563817492.969 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2019-07-22T17:44:52.970Z,1563817492.970 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2019-07-22T17:44:52.970Z,1563817492.970 [MissionManager](INFO): Uninitializing Mission Default
2019-07-22T17:44:52.970Z,1563817492.970 [Default] Stopped
2019-07-22T17:44:52.970Z,1563817492.970 [Default](DEBUG): Aggregate::uninitialize Default
2019-07-22T17:44:52.970Z,1563817492.970 [Default:B.GoToSurface] Stopped
2019-07-22T17:44:52.970Z,1563817492.970 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-07-22T17:44:52.970Z,1563817492.970 [Default:CheckIn] Stopped
2019-07-22T17:44:52.971Z,1563817492.971 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-07-22T17:44:52.971Z,1563817492.971 [Default:CheckIn:Read_GPS] Stopped
2019-07-22T17:44:52.973Z,1563817492.973 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2019-07-22T17:44:52.973Z,1563817492.973 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2019-07-22T17:44:52.974Z,1563817492.974 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2019-07-22T17:44:52.974Z,1563817492.974 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2019-07-22T17:44:52.974Z,1563817492.974 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-07-22T17:44:52.974Z,1563817492.974 [BuoyancyServo](INFO): Powering down
2019-07-22T17:44:52.988Z,1563817492.988 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-07-22T17:44:52.988Z,1563817492.988 [ElevatorServo](INFO): Powering down
2019-07-22T17:44:52.989Z,1563817492.989 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-07-22T17:44:52.989Z,1563817492.989 [MassServo](INFO): Powering down
2019-07-22T17:44:52.989Z,1563817492.989 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-07-22T17:44:52.990Z,1563817492.990 [RudderServo](INFO): Powering down
2019-07-22T17:44:52.990Z,1563817492.990 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2019-07-22T17:44:52.990Z,1563817492.990 [ThrusterServo](INFO): Powering down
2019-07-22T17:44:52.991Z,1563817492.991 [SBIT](DEBUG): Uninitialize SBIT Component.
2019-07-22T17:44:52.992Z,1563817492.992 [IBIT](DEBUG): Uninitialize IBIT Component.
2019-07-22T17:44:52.992Z,1563817492.992 [CBIT](DEBUG): Uninitialize CBIT Component.
2019-07-22T17:44:52.992Z,1563817492.992 [CBIT](DEBUG): Powering off loads.
2019-07-22T17:44:53.003Z,1563817493.003 [CBIT](DEBUG): Disabling WDT.
2019-07-22T17:44:53.015Z,1563817493.015 [CBIT](DEBUG): Opening all GF detection circuits.
2019-07-22T17:44:53.016Z,1563817493.016 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-07-22T17:44:53.118Z,1563817493.118 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-07-22T17:44:53.124Z,1563817493.124 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-07-22T17:44:53.174Z,1563817493.174 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-07-22T17:44:53.219Z,1563817493.219 [logger ThreadHandler](INFO): Thread cancelled.