2019-03-27T16:26:17.679Z,1553703977.679 [Supervisor](DEBUG): Initializing supervisor.
2019-03-27T16:26:17.682Z,1553703977.682 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-03-27T16:26:17.683Z,1553703977.683 [SyncHandler](INFO): Protected caller Thread ID is 7956
2019-03-27T16:26:17.683Z,1553703977.683 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2019-03-27T16:26:17.684Z,1553703977.684 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2019-03-27T16:26:17.684Z,1553703977.684 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 7957
2019-03-27T16:26:17.687Z,1553703977.687 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2019-03-27T16:26:17.698Z,1553703977.698 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2019-03-27T16:26:17.699Z,1553703977.699 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2019-03-27T16:26:17.699Z,1553703977.699 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 7958
2019-03-27T16:26:17.700Z,1553703977.700 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2019-03-27T16:26:17.701Z,1553703977.701 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2019-03-27T16:26:17.702Z,1553703977.702 [logger ThreadHandler](INFO): Protected caller Thread ID is 7959
2019-03-27T16:26:17.704Z,1553703977.704 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2019-03-27T16:26:17.704Z,1553703977.704 [Supervisor](INFO): Looking for Config files in directory: Config/
2019-03-27T16:26:17.706Z,1553703977.706 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2019-03-27T16:26:18.129Z,1553703978.129 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2019-03-27T16:26:18.129Z,1553703978.129 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2019-03-27T16:26:18.586Z,1553703978.586 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2019-03-27T16:26:18.586Z,1553703978.586 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2019-03-27T16:26:18.779Z,1553703978.779 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2019-03-27T16:26:18.779Z,1553703978.779 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2019-03-27T16:26:18.924Z,1553703978.924 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2019-03-27T16:26:18.925Z,1553703978.925 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2019-03-27T16:26:19.373Z,1553703979.373 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2019-03-27T16:26:19.373Z,1553703979.373 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2019-03-27T16:26:19.470Z,1553703979.470 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2019-03-27T16:26:19.471Z,1553703979.471 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2019-03-27T16:26:19.614Z,1553703979.614 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2019-03-27T16:26:19.614Z,1553703979.614 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2019-03-27T16:26:19.716Z,1553703979.716 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2019-03-27T16:26:19.716Z,1553703979.716 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2019-03-27T16:26:19.821Z,1553703979.821 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2019-03-27T16:26:19.822Z,1553703979.822 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2019-03-27T16:26:20.330Z,1553703980.330 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2019-03-27T16:26:20.330Z,1553703980.330 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2019-03-27T16:26:20.826Z,1553703980.826 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2019-03-27T16:26:20.827Z,1553703980.827 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2019-03-27T16:26:21.244Z,1553703981.244 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2019-03-27T16:26:21.245Z,1553703981.245 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2019-03-27T16:26:21.459Z,1553703981.459 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2019-03-27T16:26:22.530Z,1553703982.530 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2019-03-27T16:26:22.530Z,1553703982.530 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2019-03-27T16:26:23.111Z,1553703983.111 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2019-03-27T16:26:23.113Z,1553703983.113 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/
2019-03-27T16:26:23.114Z,1553703983.114 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg
2019-03-27T16:26:23.201Z,1553703983.201 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg
2019-03-27T16:26:23.358Z,1553703983.358 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg
2019-03-27T16:26:23.458Z,1553703983.458 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg
2019-03-27T16:26:23.636Z,1553703983.636 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg
2019-03-27T16:26:23.721Z,1553703983.721 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg
2019-03-27T16:26:23.946Z,1553703983.946 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2019-03-27T16:26:23.947Z,1553703983.947 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg
2019-03-27T16:26:24.063Z,1553703984.063 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg
2019-03-27T16:26:24.162Z,1553703984.162 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg
2019-03-27T16:26:24.258Z,1553703984.258 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg
2019-03-27T16:26:24.361Z,1553703984.361 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg
2019-03-27T16:26:24.471Z,1553703984.471 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/root/
2019-03-27T16:26:24.472Z,1553703984.472 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2019-03-27T16:26:24.476Z,1553703984.476 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2019-03-27T16:26:24.517Z,1553703984.517 [DepthRateCalculator] Loaded
2019-03-27T16:26:24.517Z,1553703984.517 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2019-03-27T16:26:24.523Z,1553703984.523 [PitchRateCalculator] Loaded
2019-03-27T16:26:24.523Z,1553703984.523 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2019-03-27T16:26:24.538Z,1553703984.538 [SpeedCalculator] Loaded
2019-03-27T16:26:24.538Z,1553703984.538 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2019-03-27T16:26:24.558Z,1553703984.558 [TempGradientCalculator] Loaded
2019-03-27T16:26:24.558Z,1553703984.558 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2019-03-27T16:26:24.564Z,1553703984.564 [YawRateCalculator] Loaded
2019-03-27T16:26:24.564Z,1553703984.564 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2019-03-27T16:26:24.603Z,1553703984.603 [ElevatorOffsetCalculator] Loaded
2019-03-27T16:26:24.603Z,1553703984.603 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2019-03-27T16:26:24.603Z,1553703984.603 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2019-03-27T16:26:24.604Z,1553703984.604 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2019-03-27T16:26:24.826Z,1553703984.826 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2019-03-27T16:26:24.826Z,1553703984.826 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2019-03-27T16:26:25.149Z,1553703985.149 [DataOverHttps] Loaded
2019-03-27T16:26:25.149Z,1553703985.149 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2019-03-27T16:26:25.150Z,1553703985.150 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 407DA4E0
2019-03-27T16:26:25.151Z,1553703985.151 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 8038
2019-03-27T16:26:25.187Z,1553703985.187 [Depth_Keller] Loaded
2019-03-27T16:26:25.188Z,1553703985.188 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2019-03-27T16:26:25.281Z,1553703985.281 [NAL9602] Loaded
2019-03-27T16:26:25.282Z,1553703985.282 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2019-03-27T16:26:25.297Z,1553703985.297 [Onboard] Loaded
2019-03-27T16:26:25.297Z,1553703985.297 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2019-03-27T16:26:25.303Z,1553703985.303 [Radio_Surface] Loaded
2019-03-27T16:26:25.303Z,1553703985.303 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2019-03-27T16:26:25.304Z,1553703985.304 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4080A4E0
2019-03-27T16:26:25.305Z,1553703985.305 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 8039
2019-03-27T16:26:25.314Z,1553703985.314 [FDI](DEBUG): LcmSlateWriter::add(): fdi_control_run
2019-03-27T16:26:25.319Z,1553703985.319 [FDI](INFO): created writer for : fdi_control_run
2019-03-27T16:26:25.321Z,1553703985.321 [FDI] Loaded
2019-03-27T16:26:25.321Z,1553703985.321 [ComponentRegistry](DEBUG): SyncComponent "FDI" handled in the control thread.
2019-03-27T16:26:27.699Z,1553703987.699 [BPC1] Loaded
2019-03-27T16:26:27.699Z,1553703987.699 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2019-03-27T16:26:27.700Z,1553703987.700 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2019-03-27T16:26:27.700Z,1553703987.700 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2019-03-27T16:26:27.761Z,1553703987.761 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2019-03-27T16:26:27.762Z,1553703987.762 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2019-03-27T16:26:27.859Z,1553703987.859 [DeadReckonUsingMultipleVelocitySources] Loaded
2019-03-27T16:26:27.860Z,1553703987.860 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2019-03-27T16:26:27.917Z,1553703987.917 [DeadReckonUsingSpeedCalculator] Loaded
2019-03-27T16:26:27.917Z,1553703987.917 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2019-03-27T16:26:27.936Z,1553703987.936 [NavChart] Loaded
2019-03-27T16:26:27.937Z,1553703987.937 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2019-03-27T16:26:27.941Z,1553703987.941 [UniversalFixResidualReporter] Loaded
2019-03-27T16:26:27.941Z,1553703987.941 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2019-03-27T16:26:27.941Z,1553703987.941 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2019-03-27T16:26:27.942Z,1553703987.942 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2019-03-27T16:26:28.178Z,1553703988.178 [CTD_NeilBrown] Loaded
2019-03-27T16:26:28.178Z,1553703988.178 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2019-03-27T16:26:28.179Z,1553703988.179 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 4095E4E0
2019-03-27T16:26:28.180Z,1553703988.180 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 8040
2019-03-27T16:26:28.226Z,1553703988.226 [WetLabsBB2FL] Loaded
2019-03-27T16:26:28.226Z,1553703988.226 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2019-03-27T16:26:28.227Z,1553703988.227 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 4098E4E0
2019-03-27T16:26:28.227Z,1553703988.227 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 8041
2019-03-27T16:26:28.228Z,1553703988.228 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2019-03-27T16:26:28.228Z,1553703988.228 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2019-03-27T16:26:28.292Z,1553703988.292 [VerticalControl](DEBUG): Construct VerticalControl.
2019-03-27T16:26:28.386Z,1553703988.386 [VerticalControl] Loaded
2019-03-27T16:26:28.386Z,1553703988.386 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2019-03-27T16:26:28.387Z,1553703988.387 [HorizontalControl](DEBUG): Construct HorizontalControl.
2019-03-27T16:26:28.452Z,1553703988.452 [HorizontalControl] Loaded
2019-03-27T16:26:28.453Z,1553703988.453 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2019-03-27T16:26:28.453Z,1553703988.453 [SpeedControl](DEBUG): Construct SpeedControl.
2019-03-27T16:26:28.458Z,1553703988.458 [SpeedControl] Loaded
2019-03-27T16:26:28.459Z,1553703988.459 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2019-03-27T16:26:28.459Z,1553703988.459 [LoopControl](DEBUG): Construct LoopControl.
2019-03-27T16:26:28.460Z,1553703988.460 [LoopControl] Loaded
2019-03-27T16:26:28.460Z,1553703988.460 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2019-03-27T16:26:28.460Z,1553703988.460 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2019-03-27T16:26:28.461Z,1553703988.461 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2019-03-27T16:26:28.474Z,1553703988.474 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2019-03-27T16:26:28.474Z,1553703988.474 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2019-03-27T16:26:28.603Z,1553703988.603 [SBIT](DEBUG): Construct Startup Built In Test.
2019-03-27T16:26:28.614Z,1553703988.614 [SBIT] Loaded
2019-03-27T16:26:28.614Z,1553703988.614 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2019-03-27T16:26:28.615Z,1553703988.615 [IBIT](DEBUG): Construct Initiated Built In Test.
2019-03-27T16:26:28.626Z,1553703988.626 [IBIT] Loaded
2019-03-27T16:26:28.627Z,1553703988.627 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2019-03-27T16:26:28.630Z,1553703988.630 [CBIT](DEBUG): Construct Continuous Built In Test.
2019-03-27T16:26:28.765Z,1553703988.765 [CBIT] Loaded
2019-03-27T16:26:28.765Z,1553703988.765 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2019-03-27T16:26:28.765Z,1553703988.765 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2019-03-27T16:26:28.766Z,1553703988.766 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2019-03-27T16:26:28.858Z,1553703988.858 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2019-03-27T16:26:28.859Z,1553703988.859 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2019-03-27T16:26:28.885Z,1553703988.885 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2019-03-27T16:26:28.885Z,1553703988.885 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2019-03-27T16:26:28.977Z,1553703988.977 [BuoyancyServo] Loaded
2019-03-27T16:26:28.978Z,1553703988.978 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2019-03-27T16:26:28.989Z,1553703988.989 [ElevatorServo] Loaded
2019-03-27T16:26:28.989Z,1553703988.989 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2019-03-27T16:26:28.995Z,1553703988.995 [MassServo](DEBUG): LcmSlateWriter::add(): platform_mass_position
2019-03-27T16:26:28.000Z,1553703989.000 [MassServo](INFO): created writer for : platform_mass_position
2019-03-27T16:26:29.000Z,1553703989.000 [MassServo](DEBUG): LcmSlateWriter::add(): fdi_state
2019-03-27T16:26:29.005Z,1553703989.005 [MassServo](INFO): created writer for : fdi_state
2019-03-27T16:26:29.005Z,1553703989.005 [MassServo](DEBUG): LcmSlateWriter::add(): platform_mass_position_delta
2019-03-27T16:26:29.010Z,1553703989.010 [MassServo](INFO): created writer for : platform_mass_position_delta
2019-03-27T16:26:29.011Z,1553703989.011 [MassServo] Loaded
2019-03-27T16:26:29.011Z,1553703989.011 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2019-03-27T16:26:29.022Z,1553703989.022 [RudderServo] Loaded
2019-03-27T16:26:29.022Z,1553703989.022 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2019-03-27T16:26:29.033Z,1553703989.033 [ThrusterServo] Loaded
2019-03-27T16:26:29.033Z,1553703989.033 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2019-03-27T16:26:29.033Z,1553703989.033 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2019-03-27T16:26:29.037Z,1553703989.037 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2019-03-27T16:26:29.038Z,1553703989.038 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2019-03-27T16:26:29.044Z,1553703989.044 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2019-03-27T16:26:29.045Z,1553703989.045 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AB54E0
2019-03-27T16:26:29.045Z,1553703989.045 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 8042
2019-03-27T16:26:29.050Z,1553703989.050 [Supervisor](INFO): Main Thread ID is 2533
2019-03-27T16:26:29.050Z,1553703989.050 [Supervisor](DEBUG): Running supervisor.
2019-03-27T16:26:29.051Z,1553703989.051 [CommandLine ThreadHandler](INFO): Handler Thread ID is 8043
2019-03-27T16:26:29.054Z,1553703989.054 [controlThread ThreadHandler](INFO): Handler Thread ID is 8044
2019-03-27T16:26:29.054Z,1553703989.054 [controlThread](DEBUG): Initializing ControlThread
2019-03-27T16:26:29.055Z,1553703989.055 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2019-03-27T16:26:29.056Z,1553703989.056 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2019-03-27T16:26:29.056Z,1553703989.056 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2019-03-27T16:26:29.056Z,1553703989.056 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2019-03-27T16:26:29.057Z,1553703989.057 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2019-03-27T16:26:29.057Z,1553703989.057 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2019-03-27T16:26:29.062Z,1553703989.062 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-27T16:26:29.063Z,1553703989.063 [NavChart](DEBUG): Initialize NavChart Navigation.
2019-03-27T16:26:29.063Z,1553703989.063 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2019-03-27T16:26:29.063Z,1553703989.063 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2019-03-27T16:26:29.065Z,1553703989.065 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2019-03-27T16:26:29.066Z,1553703989.066 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2019-03-27T16:26:29.066Z,1553703989.066 [LoopControl](DEBUG): Initialize LoopControlComponent.
2019-03-27T16:26:29.066Z,1553703989.066 [SBIT](INFO): Initialize SBIT Component.
2019-03-27T16:26:29.067Z,1553703989.067 [SBIT](IMPORTANT): git: 2019-03-04-50-ga8fcf12
2019-03-27T16:26:29.067Z,1553703989.067 [SBIT](INFO): git hash: a8fcf12d1d799d37995c6548ef1dcffc42c8f0a3
2019-03-27T16:26:29.067Z,1553703989.067 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2019-03-27T16:26:29.067Z,1553703989.067 [SBIT](IMPORTANT): Kernel Version:#2 PREEMPT Thu Jan 11 20:13:48 PST 2018
2019-03-27T16:26:29.069Z,1553703989.069 [SBIT](INFO): Beginning SBIT in 28.000000 seconds.
2019-03-27T16:26:29.069Z,1553703989.069 [IBIT](INFO): Initialize IBIT Component.
2019-03-27T16:26:29.070Z,1553703989.070 [CBIT](DEBUG): Initialize CBIT Component.
2019-03-27T16:26:29.071Z,1553703989.071 [logger ThreadHandler](INFO): Handler Thread ID is 8045
2019-03-27T16:26:29.081Z,1553703989.081 [CBIT](DEBUG): Initialized mux pins.
2019-03-27T16:26:29.081Z,1553703989.081 [CBIT](DEBUG): Initializing the watchdog timer.
2019-03-27T16:26:29.089Z,1553703989.089 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 8046
2019-03-27T16:26:29.090Z,1553703989.090 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2019-03-27T16:26:29.101Z,1553703989.101 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 8047
2019-03-27T16:26:29.105Z,1553703989.105 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2019-03-27T16:26:29.105Z,1553703989.105 [CBIT](DEBUG): Initializing heartbeat.
2019-03-27T16:26:29.113Z,1553703989.113 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 8048
2019-03-27T16:26:29.121Z,1553703989.121 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 8049
2019-03-27T16:26:29.122Z,1553703989.122 [WetLabsBB2FL](INFO): Powering down
2019-03-27T16:26:29.153Z,1553703989.153 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 8050
2019-03-27T16:26:29.157Z,1553703989.157 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2019-03-27T16:26:29.157Z,1553703989.157 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2019-03-27T16:26:29.157Z,1553703989.157 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2019-03-27T16:26:29.157Z,1553703989.157 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2019-03-27T16:26:29.157Z,1553703989.157 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2019-03-27T16:26:29.158Z,1553703989.158 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2019-03-27T16:26:29.158Z,1553703989.158 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2019-03-27T16:26:29.158Z,1553703989.158 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2019-03-27T16:26:29.158Z,1553703989.158 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2019-03-27T16:26:29.158Z,1553703989.158 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2019-03-27T16:26:29.159Z,1553703989.159 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2019-03-27T16:26:29.159Z,1553703989.159 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2019-03-27T16:26:29.159Z,1553703989.159 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2019-03-27T16:26:29.159Z,1553703989.159 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2019-03-27T16:26:29.160Z,1553703989.160 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2019-03-27T16:26:29.160Z,1553703989.160 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2019-03-27T16:26:29.177Z,1553703989.177 [CBIT](DEBUG): Deactivating GF circuits.
2019-03-27T16:26:29.177Z,1553703989.177 [CBIT](DEBUG): Deactivating emergency mode.
2019-03-27T16:26:29.215Z,1553703989.215 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2019-03-27T16:26:29.224Z,1553703989.224 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2019-03-27T16:26:29.235Z,1553703989.235 [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-03-27T16:26:29.236Z,1553703989.236 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2019-03-27T16:26:29.306Z,1553703989.306 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2019-03-27T16:26:29.307Z,1553703989.307 [Default:A.Wait](DEBUG): Construct Wait.
2019-03-27T16:26:29.325Z,1553703989.325 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2019-03-27T16:26:29.352Z,1553703989.352 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2019-03-27T16:26:29.370Z,1553703989.370 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2019-03-27T16:26:29.376Z,1553703989.376 [Default:E.Execute](DEBUG): Construct Execute.
2019-03-27T16:26:29.395Z,1553703989.395 [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-03-27T16:26:29.399Z,1553703989.399 [controlThread](DEBUG): Component order: CycleStarter,Depth_Keller,NAL9602,Onboard,FDI,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2019-03-27T16:26:29.434Z,1553703989.434 [Depth_Keller](ERROR): Pressure reading out of range: 1628.471313 decibar
2019-03-27T16:26:29.494Z,1553703989.494 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-03-27T16:26:29.505Z,1553703989.505 [Radio_Surface](INFO): Powering up
2019-03-27T16:26:29.543Z,1553703989.543 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-03-27T16:26:29.549Z,1553703989.549 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-03-27T16:26:29.550Z,1553703989.550 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-03-27T16:26:29.565Z,1553703989.565 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-03-27T16:26:29.566Z,1553703989.566 [MassServo](DEBUG): Initializing EZServoServo.
2019-03-27T16:26:29.581Z,1553703989.581 [MassServo](DEBUG): Initializing MassServo.
2019-03-27T16:26:29.582Z,1553703989.582 [RudderServo](DEBUG): Initializing EZServoServo.
2019-03-27T16:26:29.589Z,1553703989.589 [RudderServo](DEBUG): Initializing RudderServo.
2019-03-27T16:26:29.590Z,1553703989.590 [ThrusterServo](DEBUG): Initializing EZServoServo.
2019-03-27T16:26:29.598Z,1553703989.598 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2019-03-27T16:26:29.837Z,1553703989.837 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-03-27T16:26:30.553Z,1553703990.553 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2019-03-27T16:26:30.553Z,1553703990.553 [RudderServo](FAULT): Rudder failed to initialize
2019-03-27T16:26:30.553Z,1553703990.553 [RudderServo] Communications Fault, FailCount= 1
2019-03-27T16:26:30.553Z,1553703990.553 [RudderServo](ERROR): Communications Fault
2019-03-27T16:26:30.657Z,1553703990.657 [CBIT](ERROR): Communications Fault in component: RudderServo
2019-03-27T16:26:30.822Z,1553703990.822 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-03-27T16:26:30.822Z,1553703990.822 [RudderServo](INFO): Powering down
2019-03-27T16:26:31.501Z,1553703991.501 [RudderServo](DEBUG): Initializing EZServoServo.
2019-03-27T16:26:31.618Z,1553703991.618 [RudderServo](DEBUG): Initializing RudderServo.
2019-03-27T16:26:31.622Z,1553703991.622 [CBIT](INFO): Clearing failed state for component RudderServo
2019-03-27T16:26:31.622Z,1553703991.622 [RudderServo] No Fault, FailCount= 1
2019-03-27T16:26:36.425Z,1553703996.425 [RudderServo](FAULT): Overload Error
2019-03-27T16:26:36.425Z,1553703996.425 [RudderServo] Hardware Fault, FailCount= 2
2019-03-27T16:26:36.425Z,1553703996.425 [RudderServo](ERROR): Hardware Fault
2019-03-27T16:26:36.465Z,1553703996.465 [CBIT](ERROR): Hardware Fault in component: RudderServo
2019-03-27T16:26:36.791Z,1553703996.791 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-03-27T16:26:36.791Z,1553703996.791 [RudderServo](INFO): Powering down
2019-03-27T16:26:37.599Z,1553703997.599 [RudderServo](DEBUG): Initializing EZServoServo.
2019-03-27T16:26:37.718Z,1553703997.718 [RudderServo](DEBUG): Initializing RudderServo.
2019-03-27T16:26:37.722Z,1553703997.722 [CBIT](INFO): Clearing failed state for component RudderServo
2019-03-27T16:26:37.722Z,1553703997.722 [RudderServo] No Fault, FailCount= 2
2019-03-27T16:26:42.449Z,1553704002.449 [RudderServo](FAULT): Overload Error
2019-03-27T16:26:42.449Z,1553704002.449 [RudderServo] Hardware Fault, FailCount= 3
2019-03-27T16:26:42.449Z,1553704002.449 [RudderServo](ERROR): Hardware Fault
2019-03-27T16:26:42.489Z,1553704002.489 [CBIT](ERROR): Hardware Fault in component: RudderServo
2019-03-27T16:26:42.489Z,1553704002.489 [CBIT](CRITICAL): Hardware Fault in component: RudderServo
2019-03-27T16:26:42.827Z,1553704002.827 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-03-27T16:26:42.827Z,1553704002.827 [RudderServo](INFO): Powering down
2019-03-27T16:26:42.833Z,1553704002.833 [CommandLine](FAULT): Scheduling is paused
2019-03-27T16:26:42.833Z,1553704002.833 [CBIT](INFO): Critical error at 20190327T162642
2019-03-27T16:26:42.834Z,1553704002.834 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2019-03-27T16:26:43.635Z,1553704003.635 [RudderServo](DEBUG): Initializing EZServoServo.
2019-03-27T16:26:43.754Z,1553704003.754 [RudderServo](DEBUG): Initializing RudderServo.
2019-03-27T16:26:55.310Z,1553704015.310 [NAL9602](INFO): Powering up NAL9602
2019-03-27T16:26:57.770Z,1553704017.770 [SBIT](IMPORTANT): Beginning Startup BIT
2019-03-27T16:26:57.775Z,1553704017.775 [CBIT](IMPORTANT): Beginning ground fault scan
2019-03-27T16:26:59.801Z,1553704019.801 [ElevatorServo](FAULT): Overload Error
2019-03-27T16:26:59.801Z,1553704019.801 [ElevatorServo] Hardware Fault, FailCount= 1
2019-03-27T16:26:59.801Z,1553704019.801 [ElevatorServo](ERROR): Hardware Fault
2019-03-27T16:27:00.227Z,1553704020.227 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2019-03-27T16:27:00.297Z,1553704020.297 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-03-27T16:27:00.297Z,1553704020.297 [ElevatorServo](INFO): Powering down
2019-03-27T16:27:01.065Z,1553704021.065 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-03-27T16:27:01.182Z,1553704021.182 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-03-27T16:27:01.227Z,1553704021.227 [CBIT](INFO): Clearing failed state for component ElevatorServo
2019-03-27T16:27:01.227Z,1553704021.227 [ElevatorServo] No Fault, FailCount= 1
2019-03-27T16:27:06.294Z,1553704026.294 [NAL9602](INFO): NAL9602 initialized
2019-03-27T16:27:06.341Z,1553704026.341 [ElevatorServo](FAULT): Overload Error
2019-03-27T16:27:06.341Z,1553704026.341 [ElevatorServo] Hardware Fault, FailCount= 2
2019-03-27T16:27:06.341Z,1553704026.341 [ElevatorServo](ERROR): Hardware Fault
2019-03-27T16:27:06.452Z,1553704026.452 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2019-03-27T16:27:06.737Z,1553704026.737 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-03-27T16:27:06.737Z,1553704026.737 [ElevatorServo](INFO): Powering down
2019-03-27T16:27:07.113Z,1553704027.113 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:27:07.561Z,1553704027.561 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-03-27T16:27:07.686Z,1553704027.686 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-03-27T16:27:07.731Z,1553704027.731 [CBIT](INFO): Clearing failed state for component ElevatorServo
2019-03-27T16:27:07.731Z,1553704027.731 [ElevatorServo] No Fault, FailCount= 2
2019-03-27T16:27:08.842Z,1553704028.842 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.007085
CHAN A1 (24V): 0.001815
CHAN A2 (12V): -0.005363
CHAN A3 (5V): -0.003149
CHAN B0 (3.3V): -0.000819
CHAN B1 (3.15aV): -0.001517
CHAN B2 (3.15bV): -0.001059
CHAN B3 (GND): -0.000253
OPEN: -0.001322
Full Scale Calc: 4.765 mA, -1.589 mA
2019-03-27T16:27:10.894Z,1553704030.894 [SBIT](ERROR): Could not read rudderAngleReader_.
2019-03-27T16:27:12.809Z,1553704032.809 [ElevatorServo](FAULT): Overload Error
2019-03-27T16:27:12.809Z,1553704032.809 [ElevatorServo] Hardware Fault, FailCount= 3
2019-03-27T16:27:12.809Z,1553704032.809 [ElevatorServo](ERROR): Hardware Fault
2019-03-27T16:27:13.235Z,1553704033.235 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2019-03-27T16:27:13.235Z,1553704033.235 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo
2019-03-27T16:27:13.297Z,1553704033.297 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-03-27T16:27:13.297Z,1553704033.297 [ElevatorServo](INFO): Powering down
2019-03-27T16:27:13.341Z,1553704033.341 [CBIT](INFO): Critical error at 20190327T162713
2019-03-27T16:27:14.098Z,1553704034.098 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-03-27T16:27:14.222Z,1553704034.222 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-03-27T16:27:37.535Z,1553704057.535 [SBIT](ERROR): Could not read elevatorAngleReader_.
2019-03-27T16:27:37.535Z,1553704057.535 [SBIT](ERROR): Could not read rudderAngleReader_.
2019-03-27T16:27:37.535Z,1553704057.535 [SBIT](FAULT): Control surface position failure.
2019-03-27T16:27:51.320Z,1553704071.320 [SBIT](ERROR): Could not read elevatorAngleReader_.
2019-03-27T16:27:51.321Z,1553704071.321 [SBIT](ERROR): Could not read rudderAngleReader_.
2019-03-27T16:27:51.321Z,1553704071.321 [SBIT](FAULT): Control surface position failure.
2019-03-27T16:27:51.703Z,1553704071.703 [SBIT](CRITICAL): SBIT FAILED
2019-03-27T16:27:51.718Z,1553704071.718 [CBIT](INFO): Critical error at 20190327T162751
2019-03-27T16:27:51.723Z,1553704071.723 [CommandLine](IMPORTANT): got command configSet list
2019-03-27T16:27:51.723Z,1553704071.723 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2019-03-27T16:27:51.724Z,1553704071.724 [CommandLine](IMPORTANT): AHRS_M2.loadAtStartup=0 bool;

2019-03-27T16:27:51.724Z,1553704071.724 [CommandLine](IMPORTANT): CTD_Seabird.loadAtStartup=0 bool;

2019-03-27T16:27:51.725Z,1553704071.725 [CommandLine](IMPORTANT): DropWeight.loadAtStartup=0 bool;

2019-03-27T16:27:52.086Z,1553704072.086 [MissionManager](IMPORTANT): Started mission Startup
2019-03-27T16:27:52.087Z,1553704072.087 [Startup] Running Loop=1
2019-03-27T16:27:52.087Z,1553704072.087 [Startup](DEBUG): Aggregate::initialize Startup
2019-03-27T16:27:52.087Z,1553704072.087 [Startup:A.GoToSurface] Running Loop=1
2019-03-27T16:27:52.087Z,1553704072.087 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-03-27T16:27:52.088Z,1553704072.088 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-03-27T16:27:52.088Z,1553704072.088 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-03-27T16:27:52.088Z,1553704072.088 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-03-27T16:27:52.089Z,1553704072.089 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-03-27T16:27:52.089Z,1553704072.089 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-03-27T16:27:52.091Z,1553704072.091 [Startup:StartupSatComms] Running Loop=1
2019-03-27T16:27:52.091Z,1553704072.091 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2019-03-27T16:27:52.091Z,1553704072.091 [Startup:StartupSatComms:A] Running Loop=1
2019-03-27T16:27:52.498Z,1553704072.498 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2019-03-27T16:28:29.253Z,1553704109.253 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-27T16:28:29.253Z,1553704109.253 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2019-03-27T16:28:29.254Z,1553704109.254 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-27T16:28:29.255Z,1553704109.255 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-27T16:28:29.255Z,1553704109.255 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2019-03-27T16:28:29.255Z,1553704109.255 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-27T16:28:29.267Z,1553704109.267 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-27T16:28:29.267Z,1553704109.267 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-27T16:28:29.674Z,1553704109.674 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-27T16:28:29.674Z,1553704109.674 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2019-03-27T16:28:29.674Z,1553704109.674 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-27T16:28:29.675Z,1553704109.675 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2019-03-27T16:28:30.064Z,1553704110.064 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-27T16:28:52.282Z,1553704132.282 [Startup:StartupSatComms:A](INFO): Timed out from 2019-03-27T16:27:52.1Z
2019-03-27T16:28:52.282Z,1553704132.282 [Startup:StartupSatComms:A] Stopped
2019-03-27T16:28:52.282Z,1553704132.282 [Startup:StartupSatComms:B] Running Loop=1
2019-03-27T16:28:52.686Z,1553704132.686 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-03-27T16:28:55.018Z,1553704135.018 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004460
2019-03-27T16:29:01.740Z,1553704141.740 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190326T233928/Courier0289.lzma
2019-03-27T16:29:02.547Z,1553704142.547 [DataOverHttps](INFO): Moved sent file to Logs/20190326T233928/Courier0289.lzma.bak
2019-03-27T16:29:02.547Z,1553704142.547 [DataOverHttps](INFO): SBD MOMSN=10256625
2019-03-27T16:29:14.676Z,1553704154.676 [DataOverHttps](INFO): Sending 138 bytes from file Logs/20190327T162617/Courier0000.lzma
2019-03-27T16:29:15.483Z,1553704155.483 [DataOverHttps](INFO): Moved sent file to Logs/20190327T162617/Courier0000.lzma.bak
2019-03-27T16:29:15.483Z,1553704155.483 [DataOverHttps](INFO): SBD MOMSN=10256627
2019-03-27T16:29:29.081Z,1553704169.081 [DataOverHttps](INFO): Sending 262 bytes from file Logs/20190326T233928/Express0287.lzma
2019-03-27T16:29:29.883Z,1553704169.883 [DataOverHttps](INFO): Moved sent file to Logs/20190326T233928/Express0287.lzma.bak
2019-03-27T16:29:29.883Z,1553704169.883 [DataOverHttps](INFO): SBD MOMSN=10256633
2019-03-27T16:29:44.584Z,1553704184.584 [DataOverHttps](INFO): Sending 78 bytes from file Logs/20190326T233928/Express0290.lzma
2019-03-27T16:29:45.391Z,1553704185.391 [DataOverHttps](INFO): Moved sent file to Logs/20190326T233928/Express0290.lzma.bak
2019-03-27T16:29:45.391Z,1553704185.391 [DataOverHttps](INFO): SBD MOMSN=10256647
2019-03-27T16:29:52.670Z,1553704192.670 [Startup:StartupSatComms:B](INFO): Timed out from 2019-03-27T16:28:52.3Z
2019-03-27T16:29:52.671Z,1553704192.671 [Startup:StartupSatComms:B] Stopped
2019-03-27T16:29:52.671Z,1553704192.671 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2019-03-27T16:29:52.671Z,1553704192.671 [Startup:StartupSatComms] Stopped
2019-03-27T16:29:52.671Z,1553704192.671 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2019-03-27T16:29:52.672Z,1553704192.672 [Startup](INFO): Completed Startup
2019-03-27T16:29:52.672Z,1553704192.672 [MissionManager](INFO): Startup is completed.
2019-03-27T16:29:52.672Z,1553704192.672 [MissionManager](INFO): Uninitializing Mission Startup
2019-03-27T16:29:52.672Z,1553704192.672 [Startup] Stopped
2019-03-27T16:29:52.672Z,1553704192.672 [Startup](DEBUG): Aggregate::uninitialize Startup
2019-03-27T16:29:52.672Z,1553704192.672 [Startup:A.GoToSurface] Stopped
2019-03-27T16:29:52.672Z,1553704192.672 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-03-27T16:29:52.989Z,1553704192.989 [MissionManager](IMPORTANT): Started mission Default
2019-03-27T16:29:52.989Z,1553704192.989 [Default] Running Loop=1
2019-03-27T16:29:52.990Z,1553704192.990 [Default](DEBUG): Aggregate::initialize Default
2019-03-27T16:29:52.990Z,1553704192.990 [Default:B.GoToSurface] Running Loop=1
2019-03-27T16:29:52.990Z,1553704192.990 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-03-27T16:29:52.990Z,1553704192.990 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-03-27T16:29:52.990Z,1553704192.990 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-03-27T16:29:52.991Z,1553704192.991 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-03-27T16:29:52.991Z,1553704192.991 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-03-27T16:29:52.991Z,1553704192.991 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-03-27T16:29:52.991Z,1553704192.991 [Default:A.Wait] Running Loop=1
2019-03-27T16:29:52.992Z,1553704192.992 [Default:A.Wait](DEBUG): Initialize Wait Component.
2019-03-27T16:29:59.470Z,1553704199.470 [DataOverHttps](INFO): Sending 925 bytes from file Logs/20190327T162617/Express0001.lzma
2019-03-27T16:30:00.274Z,1553704200.274 [DataOverHttps](INFO): Moved sent file to Logs/20190327T162617/Express0001.lzma.bak
2019-03-27T16:30:00.274Z,1553704200.274 [DataOverHttps](INFO): SBD MOMSN=10256650
2019-03-27T16:30:05.995Z,1553704205.995 [Default:A.Wait](INFO): Done Waiting.
2019-03-27T16:30:05.995Z,1553704205.995 [Default:A.Wait] Stopped
2019-03-27T16:30:05.995Z,1553704205.995 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2019-03-27T16:30:06.314Z,1553704206.314 [Default:CheckIn] Running Loop=1
2019-03-27T16:30:06.314Z,1553704206.314 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-03-27T16:30:06.314Z,1553704206.314 [Default:CheckIn:Read_GPS] Running Loop=1
2019-03-27T16:30:06.714Z,1553704206.714 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2019-03-27T16:30:30.112Z,1553704230.112 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-27T16:30:30.113Z,1553704230.113 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2019-03-27T16:30:30.113Z,1553704230.113 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-27T16:30:30.114Z,1553704230.114 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-27T16:30:30.114Z,1553704230.114 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2019-03-27T16:30:30.114Z,1553704230.114 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-27T16:30:30.125Z,1553704230.125 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-27T16:30:30.125Z,1553704230.125 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-27T16:30:30.529Z,1553704230.529 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-27T16:30:30.529Z,1553704230.529 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2019-03-27T16:30:30.530Z,1553704230.530 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-27T16:30:30.530Z,1553704230.530 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2019-03-27T16:30:30.924Z,1553704230.924 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-27T16:32:09.478Z,1553704329.478 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-03-27T16:32:10.289Z,1553704330.289 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:32:15.545Z,1553704335.545 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:32:18.373Z,1553704338.373 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:32:21.609Z,1553704341.609 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:32:24.437Z,1553704344.437 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:32:27.669Z,1553704347.669 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:32:30.497Z,1553704350.497 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:32:30.932Z,1553704350.932 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-27T16:32:30.932Z,1553704350.932 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2019-03-27T16:32:30.932Z,1553704350.932 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-27T16:32:30.933Z,1553704350.933 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-27T16:32:30.934Z,1553704350.934 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2019-03-27T16:32:30.934Z,1553704350.934 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-27T16:32:30.945Z,1553704350.945 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-27T16:32:30.945Z,1553704350.945 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-27T16:32:31.338Z,1553704351.338 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-27T16:32:31.338Z,1553704351.338 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2019-03-27T16:32:31.338Z,1553704351.338 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-27T16:32:31.338Z,1553704351.338 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2019-03-27T16:32:31.716Z,1553704351.716 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-27T16:32:33.325Z,1553704353.325 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:32:36.557Z,1553704356.557 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:32:39.377Z,1553704359.377 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:32:42.617Z,1553704362.617 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:32:45.445Z,1553704365.445 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:32:48.273Z,1553704368.273 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:32:50.289Z,1553704370.289 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:32:52.309Z,1553704372.309 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:32:54.329Z,1553704374.329 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:32:57.565Z,1553704377.565 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:33:00.389Z,1553704380.389 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:33:03.625Z,1553704383.625 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:33:06.449Z,1553704386.449 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:33:09.281Z,1553704389.281 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:33:11.297Z,1553704391.297 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:33:13.321Z,1553704393.321 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:33:16.553Z,1553704396.553 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:33:19.373Z,1553704399.373 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:33:22.613Z,1553704402.613 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:33:25.445Z,1553704405.445 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:33:28.261Z,1553704408.261 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:33:30.289Z,1553704410.289 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:33:32.309Z,1553704412.309 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:33:34.329Z,1553704414.329 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:33:37.557Z,1553704417.557 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:33:40.385Z,1553704420.385 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:33:43.621Z,1553704423.621 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:33:46.445Z,1553704426.445 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:33:49.277Z,1553704429.277 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:33:51.297Z,1553704431.297 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:33:53.317Z,1553704433.317 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:33:54.540Z,1553704434.540 [BPC1](INFO): Calculating totals. Valid battery stick count: 51. Valid reserve battery stick count: 6.
2019-03-27T16:33:56.549Z,1553704436.549 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:33:59.371Z,1553704439.371 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:34:02.613Z,1553704442.613 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:34:05.433Z,1553704445.433 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:34:08.265Z,1553704448.265 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:34:10.281Z,1553704450.281 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:34:12.305Z,1553704452.305 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:34:14.321Z,1553704454.321 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:34:17.557Z,1553704457.557 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:34:20.385Z,1553704460.385 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:34:23.617Z,1553704463.617 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:34:26.445Z,1553704466.445 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:34:29.273Z,1553704469.273 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:34:31.293Z,1553704471.293 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:34:31.719Z,1553704471.719 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-27T16:34:31.719Z,1553704471.719 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2019-03-27T16:34:31.719Z,1553704471.719 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-27T16:34:31.720Z,1553704471.720 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-27T16:34:31.720Z,1553704471.720 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4
2019-03-27T16:34:31.720Z,1553704471.720 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-27T16:34:31.731Z,1553704471.731 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-27T16:34:31.731Z,1553704471.731 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-27T16:34:32.129Z,1553704472.129 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-27T16:34:32.130Z,1553704472.130 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2019-03-27T16:34:32.130Z,1553704472.130 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-27T16:34:32.130Z,1553704472.130 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4
2019-03-27T16:34:32.512Z,1553704472.512 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-27T16:34:33.305Z,1553704473.305 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:34:36.545Z,1553704476.545 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:34:39.369Z,1553704479.369 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:34:42.605Z,1553704482.605 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:34:45.425Z,1553704485.425 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:34:48.665Z,1553704488.665 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:34:51.485Z,1553704491.485 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:34:54.317Z,1553704494.317 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:34:57.553Z,1553704497.553 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:35:00.377Z,1553704500.377 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:35:03.605Z,1553704503.605 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:35:06.437Z,1553704506.437 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:35:06.462Z,1553704506.462 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-03-27T16:30:06.3Z
2019-03-27T16:35:06.462Z,1553704506.462 [Default:CheckIn:Read_GPS] Stopped
2019-03-27T16:35:06.462Z,1553704506.462 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-03-27T16:35:06.869Z,1553704506.869 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-03-27T16:35:09.269Z,1553704509.269 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:35:11.288Z,1553704511.288 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:35:13.077Z,1553704513.077 [DataOverHttps](INFO): Sending 187 bytes from file Logs/20190327T162617/Courier0004.lzma
2019-03-27T16:35:13.301Z,1553704513.301 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:35:13.882Z,1553704513.882 [DataOverHttps](INFO): Moved sent file to Logs/20190327T162617/Courier0004.lzma.bak
2019-03-27T16:35:13.882Z,1553704513.882 [DataOverHttps](INFO): SBD MOMSN=10256712
2019-03-27T16:35:16.545Z,1553704516.545 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:35:19.365Z,1553704519.365 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:35:22.601Z,1553704522.601 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:35:25.425Z,1553704525.425 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:35:27.373Z,1553704527.373 [DataOverHttps](INFO): Sending 279 bytes from file Logs/20190327T162617/Express0005.lzma
2019-03-27T16:35:28.178Z,1553704528.178 [DataOverHttps](INFO): Moved sent file to Logs/20190327T162617/Express0005.lzma.bak
2019-03-27T16:35:28.178Z,1553704528.178 [DataOverHttps](INFO): SBD MOMSN=10256714
2019-03-27T16:35:28.657Z,1553704528.657 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:35:31.489Z,1553704531.489 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:35:32.321Z,1553704532.321 [Default:CheckIn:Read_Iridium] Stopped
2019-03-27T16:35:32.321Z,1553704532.321 [Default:CheckIn:C.Wait] Running Loop=1
2019-03-27T16:35:32.321Z,1553704532.321 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-03-27T16:35:34.313Z,1553704534.313 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:35:37.545Z,1553704537.545 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:35:40.377Z,1553704540.377 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:35:43.605Z,1553704543.605 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:35:46.437Z,1553704546.437 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:35:49.669Z,1553704549.669 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:35:52.493Z,1553704552.493 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:35:55.325Z,1553704555.325 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:35:58.557Z,1553704558.557 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:36:01.385Z,1553704561.385 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:36:04.617Z,1553704564.617 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:36:07.445Z,1553704567.445 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:36:10.265Z,1553704570.265 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:36:12.293Z,1553704572.293 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:36:14.313Z,1553704574.313 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:36:17.541Z,1553704577.541 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:36:20.369Z,1553704580.369 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:36:23.605Z,1553704583.605 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:36:26.433Z,1553704586.433 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:36:29.665Z,1553704589.665 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:36:32.493Z,1553704592.493 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:36:32.515Z,1553704592.515 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-27T16:36:32.515Z,1553704592.515 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2019-03-27T16:36:32.515Z,1553704592.515 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-27T16:36:32.516Z,1553704592.516 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-27T16:36:32.516Z,1553704592.516 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5
2019-03-27T16:36:32.516Z,1553704592.516 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-27T16:36:32.527Z,1553704592.527 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-27T16:36:32.528Z,1553704592.528 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-27T16:36:32.933Z,1553704592.933 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-27T16:36:32.933Z,1553704592.933 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2019-03-27T16:36:32.934Z,1553704592.934 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-27T16:36:32.934Z,1553704592.934 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5
2019-03-27T16:36:33.316Z,1553704593.316 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-27T16:36:35.321Z,1553704595.321 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:36:38.553Z,1553704598.553 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:36:41.377Z,1553704601.377 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:36:44.609Z,1553704604.609 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:36:47.441Z,1553704607.441 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:36:50.261Z,1553704610.261 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:36:52.285Z,1553704612.285 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:36:54.305Z,1553704614.305 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:36:57.537Z,1553704617.537 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:37:00.369Z,1553704620.369 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:37:03.601Z,1553704623.601 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:37:06.429Z,1553704626.429 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:37:09.647Z,1553704629.647 [NAL9602](FAULT): GPS failed to acquire within timeout.
2019-03-27T16:37:09.648Z,1553704629.648 [NAL9602] Data Fault, FailCount= 1
2019-03-27T16:37:09.648Z,1553704629.648 [NAL9602](ERROR): Data Fault
2019-03-27T16:37:09.683Z,1553704629.683 [CBIT](ERROR): Data Fault in component: NAL9602
2019-03-27T16:37:10.050Z,1553704630.050 [NAL9602](INFO): Powering down
2019-03-27T16:37:10.891Z,1553704630.891 [CBIT](INFO): Clearing failed state for component NAL9602
2019-03-27T16:37:10.891Z,1553704630.891 [NAL9602] No Fault, FailCount= 1
2019-03-27T16:37:40.347Z,1553704660.347 [NAL9602](INFO): Powering up NAL9602
2019-03-27T16:37:51.262Z,1553704671.262 [NAL9602](INFO): NAL9602 initialized
2019-03-27T16:37:52.081Z,1553704672.081 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:37:54.501Z,1553704674.501 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:37:57.329Z,1553704677.329 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:37:59.349Z,1553704679.349 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:38:02.581Z,1553704682.581 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:38:05.409Z,1553704685.409 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:38:08.641Z,1553704688.641 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:38:11.469Z,1553704691.469 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:38:14.701Z,1553704694.701 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:38:17.529Z,1553704697.529 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:38:20.353Z,1553704700.353 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:38:23.593Z,1553704703.593 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:38:26.413Z,1553704706.413 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:38:29.653Z,1553704709.653 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:38:32.475Z,1553704712.475 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:38:33.700Z,1553704713.700 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-27T16:38:33.700Z,1553704713.700 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2019-03-27T16:38:33.700Z,1553704713.700 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-27T16:38:33.702Z,1553704713.702 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-27T16:38:33.702Z,1553704713.702 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6
2019-03-27T16:38:33.702Z,1553704713.702 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-27T16:38:33.713Z,1553704713.713 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-27T16:38:33.714Z,1553704713.714 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-27T16:38:34.121Z,1553704714.121 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-27T16:38:34.121Z,1553704714.121 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2019-03-27T16:38:34.122Z,1553704714.122 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-27T16:38:34.122Z,1553704714.122 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6
2019-03-27T16:38:34.508Z,1553704714.508 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-27T16:38:35.713Z,1553704715.713 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:38:38.541Z,1553704718.541 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:38:41.369Z,1553704721.369 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:38:44.593Z,1553704724.593 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:38:47.429Z,1553704727.429 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:38:50.653Z,1553704730.653 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:38:53.489Z,1553704733.489 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:38:56.313Z,1553704736.313 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:38:58.337Z,1553704738.337 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:39:00.353Z,1553704740.353 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:39:03.585Z,1553704743.585 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:39:06.409Z,1553704746.409 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:39:09.649Z,1553704749.649 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:39:12.469Z,1553704752.469 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:39:15.705Z,1553704755.705 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:39:18.529Z,1553704758.529 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:39:21.365Z,1553704761.365 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:39:24.591Z,1553704764.591 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:39:27.425Z,1553704767.425 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:39:30.649Z,1553704770.649 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:39:33.481Z,1553704773.481 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:39:36.309Z,1553704776.309 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:39:38.333Z,1553704778.333 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:39:40.345Z,1553704780.345 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:39:43.585Z,1553704783.585 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:39:46.405Z,1553704786.405 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:39:49.641Z,1553704789.641 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:39:52.465Z,1553704792.465 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:39:55.705Z,1553704795.705 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:39:58.525Z,1553704798.525 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:40:01.361Z,1553704801.361 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:40:04.585Z,1553704804.585 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:40:07.417Z,1553704807.417 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:40:10.645Z,1553704810.645 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:40:13.481Z,1553704813.481 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:40:16.705Z,1553704816.705 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:40:19.541Z,1553704819.541 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:40:22.365Z,1553704822.365 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:40:25.605Z,1553704825.605 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:40:28.425Z,1553704828.425 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:40:31.657Z,1553704831.657 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:40:32.889Z,1553704832.889 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-03-27T16:40:32.890Z,1553704832.890 [Default:CheckIn:C.Wait] Stopped
2019-03-27T16:40:32.890Z,1553704832.890 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-03-27T16:40:32.890Z,1553704832.890 [Default:CheckIn:D] Running Loop=1
2019-03-27T16:40:33.277Z,1553704833.277 [Default:CheckIn:D] Stopped
2019-03-27T16:40:33.278Z,1553704833.278 [Default:CheckIn:E] Running Loop=1
2019-03-27T16:40:33.690Z,1553704833.690 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.671466 min 
2019-03-27T16:40:33.690Z,1553704833.690 [Default:CheckIn:E] Stopped
2019-03-27T16:40:33.690Z,1553704833.690 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-03-27T16:40:33.690Z,1553704833.690 [Default:CheckIn] Stopped
2019-03-27T16:40:33.690Z,1553704833.690 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-03-27T16:40:33.690Z,1553704833.690 [Default:CheckIn](INFO): Running loop #2
2019-03-27T16:40:33.691Z,1553704833.691 [Default:CheckIn] Running Loop=2
2019-03-27T16:40:33.691Z,1553704833.691 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-03-27T16:40:33.691Z,1553704833.691 [Default:CheckIn:Read_GPS] Running Loop=1
2019-03-27T16:40:34.485Z,1553704834.485 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:40:34.916Z,1553704834.916 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-27T16:40:34.916Z,1553704834.916 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2019-03-27T16:40:34.916Z,1553704834.916 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-27T16:40:34.918Z,1553704834.918 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-27T16:40:34.918Z,1553704834.918 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7
2019-03-27T16:40:34.918Z,1553704834.918 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-27T16:40:34.929Z,1553704834.929 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-27T16:40:34.929Z,1553704834.929 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-27T16:40:35.333Z,1553704835.333 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-27T16:40:35.333Z,1553704835.333 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2019-03-27T16:40:35.334Z,1553704835.334 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-27T16:40:35.334Z,1553704835.334 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7
2019-03-27T16:40:35.709Z,1553704835.709 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-27T16:40:37.309Z,1553704837.309 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:40:39.336Z,1553704839.336 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:40:41.353Z,1553704841.353 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:40:44.581Z,1553704844.581 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:40:47.417Z,1553704847.417 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:40:50.641Z,1553704850.641 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:40:53.477Z,1553704853.477 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:40:56.701Z,1553704856.701 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:40:59.533Z,1553704859.533 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:41:02.361Z,1553704862.361 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:41:05.593Z,1553704865.593 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:41:08.421Z,1553704868.421 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:41:11.657Z,1553704871.657 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:41:14.481Z,1553704874.481 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:41:17.309Z,1553704877.309 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:41:19.329Z,1553704879.329 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:41:21.353Z,1553704881.353 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:41:24.577Z,1553704884.577 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:41:27.409Z,1553704887.409 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:41:30.639Z,1553704890.639 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:41:33.473Z,1553704893.473 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:41:36.701Z,1553704896.701 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:41:39.529Z,1553704899.529 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:41:42.357Z,1553704902.357 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:41:42.795Z,1553704902.795 [CBIT](INFO): Clearing failed state for component RudderServo
2019-03-27T16:41:42.795Z,1553704902.795 [RudderServo] No Fault, FailCount= 3
2019-03-27T16:41:45.593Z,1553704905.593 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:41:47.249Z,1553704907.249 [RudderServo](FAULT): Overload Error
2019-03-27T16:41:47.249Z,1553704907.249 [RudderServo] Hardware Fault, FailCount= 1
2019-03-27T16:41:47.249Z,1553704907.249 [RudderServo](ERROR): Hardware Fault
2019-03-27T16:41:47.305Z,1553704907.305 [CBIT](ERROR): Hardware Fault in component: RudderServo
2019-03-27T16:41:47.636Z,1553704907.636 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-03-27T16:41:47.636Z,1553704907.636 [RudderServo](INFO): Powering down
2019-03-27T16:41:48.417Z,1553704908.417 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:41:48.450Z,1553704908.450 [RudderServo](DEBUG): Initializing EZServoServo.
2019-03-27T16:41:48.570Z,1553704908.570 [RudderServo](DEBUG): Initializing RudderServo.
2019-03-27T16:41:48.574Z,1553704908.574 [CBIT](INFO): Clearing failed state for component RudderServo
2019-03-27T16:41:48.574Z,1553704908.574 [RudderServo] No Fault, FailCount= 1
2019-03-27T16:41:51.653Z,1553704911.653 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:41:53.301Z,1553704913.301 [RudderServo](FAULT): Overload Error
2019-03-27T16:41:53.301Z,1553704913.301 [RudderServo] Hardware Fault, FailCount= 2
2019-03-27T16:41:53.301Z,1553704913.301 [RudderServo](ERROR): Hardware Fault
2019-03-27T16:41:53.349Z,1553704913.349 [CBIT](ERROR): Hardware Fault in component: RudderServo
2019-03-27T16:41:53.692Z,1553704913.692 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-03-27T16:41:53.692Z,1553704913.692 [RudderServo](INFO): Powering down
2019-03-27T16:41:54.477Z,1553704914.477 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:41:54.502Z,1553704914.502 [RudderServo](DEBUG): Initializing EZServoServo.
2019-03-27T16:41:54.622Z,1553704914.622 [RudderServo](DEBUG): Initializing RudderServo.
2019-03-27T16:41:54.626Z,1553704914.626 [CBIT](INFO): Clearing failed state for component RudderServo
2019-03-27T16:41:54.626Z,1553704914.626 [RudderServo] No Fault, FailCount= 2
2019-03-27T16:41:57.301Z,1553704917.301 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:41:59.325Z,1553704919.325 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:41:59.381Z,1553704919.381 [RudderServo](FAULT): Overload Error
2019-03-27T16:41:59.381Z,1553704919.381 [RudderServo] Hardware Fault, FailCount= 3
2019-03-27T16:41:59.381Z,1553704919.381 [RudderServo](ERROR): Hardware Fault
2019-03-27T16:41:59.421Z,1553704919.421 [CBIT](ERROR): Hardware Fault in component: RudderServo
2019-03-27T16:41:59.421Z,1553704919.421 [CBIT](CRITICAL): Hardware Fault in component: RudderServo
2019-03-27T16:41:59.763Z,1553704919.763 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-03-27T16:41:59.763Z,1553704919.763 [RudderServo](INFO): Powering down
2019-03-27T16:41:59.766Z,1553704919.766 [CBIT](INFO): Critical error at 20190327T164159
2019-03-27T16:42:00.556Z,1553704920.556 [RudderServo](DEBUG): Initializing EZServoServo.
2019-03-27T16:42:00.674Z,1553704920.674 [RudderServo](DEBUG): Initializing RudderServo.
2019-03-27T16:42:01.345Z,1553704921.345 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:42:03.361Z,1553704923.361 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:42:06.597Z,1553704926.597 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:42:09.425Z,1553704929.425 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:42:12.657Z,1553704932.657 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:42:13.103Z,1553704933.103 [CBIT](INFO): Clearing failed state for component ElevatorServo
2019-03-27T16:42:13.103Z,1553704933.103 [ElevatorServo] No Fault, FailCount= 3
2019-03-27T16:42:15.485Z,1553704935.485 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:42:17.553Z,1553704937.553 [ElevatorServo](FAULT): Overload Error
2019-03-27T16:42:17.553Z,1553704937.553 [ElevatorServo] Hardware Fault, FailCount= 1
2019-03-27T16:42:17.553Z,1553704937.553 [ElevatorServo](ERROR): Hardware Fault
2019-03-27T16:42:17.606Z,1553704937.606 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2019-03-27T16:42:17.930Z,1553704937.930 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-03-27T16:42:17.930Z,1553704937.930 [ElevatorServo](INFO): Powering down
2019-03-27T16:42:18.313Z,1553704938.313 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:42:18.741Z,1553704938.741 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-03-27T16:42:18.862Z,1553704938.862 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-03-27T16:42:18.867Z,1553704938.867 [CBIT](INFO): Clearing failed state for component ElevatorServo
2019-03-27T16:42:18.867Z,1553704938.867 [ElevatorServo] No Fault, FailCount= 1
2019-03-27T16:42:20.329Z,1553704940.329 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:42:22.353Z,1553704942.353 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:42:24.025Z,1553704944.025 [ElevatorServo](FAULT): Overload Error
2019-03-27T16:42:24.025Z,1553704944.025 [ElevatorServo] Hardware Fault, FailCount= 2
2019-03-27T16:42:24.025Z,1553704944.025 [ElevatorServo](ERROR): Hardware Fault
2019-03-27T16:42:24.067Z,1553704944.067 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2019-03-27T16:42:24.394Z,1553704944.394 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-03-27T16:42:24.394Z,1553704944.394 [ElevatorServo](INFO): Powering down
2019-03-27T16:42:25.191Z,1553704945.191 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-03-27T16:42:25.314Z,1553704945.314 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-03-27T16:42:25.319Z,1553704945.319 [CBIT](INFO): Clearing failed state for component ElevatorServo
2019-03-27T16:42:25.319Z,1553704945.319 [ElevatorServo] No Fault, FailCount= 2
2019-03-27T16:42:25.589Z,1553704945.589 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:42:28.413Z,1553704948.413 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:42:30.481Z,1553704950.481 [ElevatorServo](FAULT): Overload Error
2019-03-27T16:42:30.481Z,1553704950.481 [ElevatorServo] Hardware Fault, FailCount= 3
2019-03-27T16:42:30.481Z,1553704950.481 [ElevatorServo](ERROR): Hardware Fault
2019-03-27T16:42:30.522Z,1553704950.522 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2019-03-27T16:42:30.522Z,1553704950.522 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo
2019-03-27T16:42:30.858Z,1553704950.858 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-03-27T16:42:30.858Z,1553704950.858 [ElevatorServo](INFO): Powering down
2019-03-27T16:42:30.861Z,1553704950.861 [CBIT](INFO): Critical error at 20190327T164230
2019-03-27T16:42:31.645Z,1553704951.645 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:42:31.674Z,1553704951.674 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-03-27T16:42:31.794Z,1553704951.794 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-03-27T16:42:34.473Z,1553704954.473 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:42:36.103Z,1553704956.103 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-27T16:42:36.103Z,1553704956.103 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2019-03-27T16:42:36.103Z,1553704956.103 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-27T16:42:36.105Z,1553704956.105 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-27T16:42:36.105Z,1553704956.105 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 8
2019-03-27T16:42:36.105Z,1553704956.105 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-27T16:42:36.116Z,1553704956.116 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-27T16:42:36.116Z,1553704956.116 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-27T16:42:36.522Z,1553704956.522 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-27T16:42:36.522Z,1553704956.522 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2019-03-27T16:42:36.522Z,1553704956.522 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-27T16:42:36.522Z,1553704956.522 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 8
2019-03-27T16:42:36.904Z,1553704956.904 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-27T16:42:37.709Z,1553704957.709 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:42:40.533Z,1553704960.533 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:42:43.357Z,1553704963.357 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:42:46.593Z,1553704966.593 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:42:49.417Z,1553704969.417 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:42:52.657Z,1553704972.657 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:42:55.477Z,1553704975.477 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:42:58.313Z,1553704978.313 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:43:00.329Z,1553704980.329 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:43:02.349Z,1553704982.349 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:43:05.585Z,1553704985.585 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:43:08.409Z,1553704988.409 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:43:11.641Z,1553704991.641 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:43:14.469Z,1553704994.469 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:43:17.705Z,1553704997.705 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:43:20.529Z,1553705000.529 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:43:23.353Z,1553705003.353 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:43:26.589Z,1553705006.589 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:43:29.413Z,1553705009.413 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:43:32.649Z,1553705012.649 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:43:35.473Z,1553705015.473 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:43:38.709Z,1553705018.709 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:43:41.540Z,1553705021.540 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:43:44.365Z,1553705024.365 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:43:47.597Z,1553705027.597 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:43:50.425Z,1553705030.425 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:43:53.657Z,1553705033.657 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:43:56.485Z,1553705036.485 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:43:59.313Z,1553705039.313 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:44:01.337Z,1553705041.337 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:44:03.349Z,1553705043.349 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:44:06.585Z,1553705046.585 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:44:09.409Z,1553705049.409 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:44:12.649Z,1553705052.649 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:44:15.473Z,1553705055.473 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:44:18.705Z,1553705058.705 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:44:21.533Z,1553705061.533 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:44:24.365Z,1553705064.365 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:44:27.589Z,1553705067.589 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:44:30.421Z,1553705070.421 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:44:33.657Z,1553705073.657 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:44:36.485Z,1553705076.485 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:44:36.912Z,1553705076.912 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-27T16:44:36.912Z,1553705076.912 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2019-03-27T16:44:36.912Z,1553705076.912 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-27T16:44:36.913Z,1553705076.913 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-27T16:44:36.913Z,1553705076.913 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 9
2019-03-27T16:44:36.913Z,1553705076.913 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-27T16:44:36.924Z,1553705076.924 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-27T16:44:36.924Z,1553705076.924 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-27T16:44:37.323Z,1553705077.323 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-27T16:44:37.323Z,1553705077.323 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2019-03-27T16:44:37.323Z,1553705077.323 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-27T16:44:37.323Z,1553705077.323 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 9
2019-03-27T16:44:37.704Z,1553705077.704 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-27T16:44:39.309Z,1553705079.309 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:44:41.329Z,1553705081.329 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:44:43.349Z,1553705083.349 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:44:46.581Z,1553705086.581 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:44:49.405Z,1553705089.405 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:44:52.641Z,1553705092.641 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:44:55.465Z,1553705095.465 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:44:58.701Z,1553705098.701 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:45:01.529Z,1553705101.529 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:45:04.365Z,1553705104.365 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:45:07.589Z,1553705107.589 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:45:10.421Z,1553705110.421 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:45:13.653Z,1553705113.653 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:45:16.481Z,1553705116.481 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:45:19.305Z,1553705119.305 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:45:21.325Z,1553705121.325 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:45:23.341Z,1553705123.341 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:45:26.577Z,1553705126.577 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:45:29.401Z,1553705129.401 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:45:32.637Z,1553705132.637 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:45:33.861Z,1553705133.861 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-03-27T16:40:33.7Z
2019-03-27T16:45:33.861Z,1553705133.861 [Default:CheckIn:Read_GPS] Stopped
2019-03-27T16:45:33.861Z,1553705133.861 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-03-27T16:45:35.465Z,1553705135.465 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:45:38.697Z,1553705138.697 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:45:40.616Z,1553705140.616 [DataOverHttps](INFO): Sending 94 bytes from file Logs/20190327T162617/Courier0007.lzma
2019-03-27T16:45:41.422Z,1553705141.422 [DataOverHttps](INFO): Moved sent file to Logs/20190327T162617/Courier0007.lzma.bak
2019-03-27T16:45:41.422Z,1553705141.422 [DataOverHttps](INFO): SBD MOMSN=10256724
2019-03-27T16:45:41.537Z,1553705141.537 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:45:44.353Z,1553705144.353 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:45:47.585Z,1553705147.585 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:45:50.417Z,1553705150.417 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:45:53.641Z,1553705153.641 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:45:54.961Z,1553705154.961 [DataOverHttps](INFO): Sending 337 bytes from file Logs/20190327T162617/Express0008.lzma
2019-03-27T16:45:55.779Z,1553705155.779 [DataOverHttps](INFO): Moved sent file to Logs/20190327T162617/Express0008.lzma.bak
2019-03-27T16:45:55.780Z,1553705155.780 [DataOverHttps](INFO): SBD MOMSN=10256728
2019-03-27T16:45:56.473Z,1553705156.473 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:45:59.301Z,1553705159.301 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:45:59.737Z,1553705159.737 [Default:CheckIn:Read_Iridium] Stopped
2019-03-27T16:45:59.737Z,1553705159.737 [Default:CheckIn:C.Wait] Running Loop=1
2019-03-27T16:45:59.737Z,1553705159.737 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-03-27T16:46:01.321Z,1553705161.321 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:46:03.341Z,1553705163.341 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:46:05.361Z,1553705165.361 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:46:08.597Z,1553705168.597 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:46:11.421Z,1553705171.421 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:46:14.657Z,1553705174.657 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:46:17.481Z,1553705177.481 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:46:20.305Z,1553705180.305 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:46:22.329Z,1553705182.329 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:46:24.349Z,1553705184.349 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:46:27.585Z,1553705187.585 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:46:30.417Z,1553705190.417 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:46:33.645Z,1553705193.645 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:46:36.469Z,1553705196.469 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:46:38.105Z,1553705198.105 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-27T16:46:38.105Z,1553705198.105 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2019-03-27T16:46:38.105Z,1553705198.105 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-27T16:46:38.107Z,1553705198.107 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-27T16:46:38.107Z,1553705198.107 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 10
2019-03-27T16:46:38.107Z,1553705198.107 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-27T16:46:38.118Z,1553705198.118 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-27T16:46:38.119Z,1553705198.119 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-27T16:46:38.506Z,1553705198.506 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-27T16:46:38.507Z,1553705198.507 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2019-03-27T16:46:38.507Z,1553705198.507 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-27T16:46:38.507Z,1553705198.507 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 10
2019-03-27T16:46:38.912Z,1553705198.912 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-27T16:46:39.705Z,1553705199.705 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:46:42.529Z,1553705202.529 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:46:45.361Z,1553705205.361 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:46:48.593Z,1553705208.593 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:46:51.417Z,1553705211.417 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:46:54.649Z,1553705214.649 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:46:57.481Z,1553705217.481 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:47:00.309Z,1553705220.309 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:47:02.329Z,1553705222.329 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:47:04.349Z,1553705224.349 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:47:07.581Z,1553705227.581 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:47:10.409Z,1553705230.409 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:47:13.641Z,1553705233.641 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:47:16.465Z,1553705236.465 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:47:19.697Z,1553705239.697 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:47:22.537Z,1553705242.537 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:47:24.444Z,1553705244.444 [CommandLine](IMPORTANT): got command failComponent hardware MassServo
2019-03-27T16:47:24.444Z,1553705244.444 [MassServo] Hardware Fault, FailCount= 1
2019-03-27T16:47:24.444Z,1553705244.444 [MassServo](ERROR): Hardware Fault
2019-03-27T16:47:24.445Z,1553705244.445 [CommandLine](IMPORTANT): MassServo failureMode is Hardware Fault
2019-03-27T16:47:24.598Z,1553705244.598 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-03-27T16:47:24.598Z,1553705244.598 [MassServo](INFO): Powering down
2019-03-27T16:47:24.607Z,1553705244.607 [CBIT](ERROR): Hardware Fault in component: MassServo
2019-03-27T16:47:25.353Z,1553705245.353 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:47:25.392Z,1553705245.392 [CBIT](INFO): Clearing failed state for component MassServo
2019-03-27T16:47:25.392Z,1553705245.392 [MassServo] No Fault, FailCount= 1
2019-03-27T16:47:25.804Z,1553705245.804 [MassServo](DEBUG): Initializing EZServoServo.
2019-03-27T16:47:25.805Z,1553705245.805 [MassServo](DEBUG): Initializing MassServo.
2019-03-27T16:47:28.589Z,1553705248.589 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:47:31.413Z,1553705251.413 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:47:34.649Z,1553705254.649 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:47:37.473Z,1553705257.473 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:47:40.144Z,1553705260.144 [CommandLine](IMPORTANT): got command failComponent none MassServo
2019-03-27T16:47:40.145Z,1553705260.145 [CommandLine](IMPORTANT): MassServo failureMode is No Fault
2019-03-27T16:47:40.301Z,1553705260.301 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:47:42.321Z,1553705262.321 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:47:44.341Z,1553705264.341 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:47:47.577Z,1553705267.577 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:47:50.401Z,1553705270.401 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:47:53.626Z,1553705273.626 [NAL9602](FAULT): GPS failed to acquire within timeout.
2019-03-27T16:47:53.626Z,1553705273.626 [NAL9602] Data Fault, FailCount= 2
2019-03-27T16:47:53.626Z,1553705273.626 [NAL9602](ERROR): Data Fault
2019-03-27T16:47:53.656Z,1553705273.656 [CBIT](ERROR): Data Fault in component: NAL9602
2019-03-27T16:47:54.030Z,1553705274.030 [NAL9602](INFO): Powering down
2019-03-27T16:47:54.878Z,1553705274.878 [CBIT](INFO): Clearing failed state for component NAL9602
2019-03-27T16:47:54.878Z,1553705274.878 [NAL9602] No Fault, FailCount= 2
2019-03-27T16:48:24.330Z,1553705304.330 [NAL9602](INFO): Powering up NAL9602
2019-03-27T16:48:35.238Z,1553705315.238 [NAL9602](INFO): NAL9602 initialized
2019-03-27T16:48:36.057Z,1553705316.057 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:48:38.477Z,1553705318.477 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:48:38.912Z,1553705318.912 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-27T16:48:38.912Z,1553705318.912 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 11
2019-03-27T16:48:38.913Z,1553705318.913 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-27T16:48:38.924Z,1553705318.924 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-27T16:48:39.308Z,1553705319.307 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-27T16:48:39.308Z,1553705319.308 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2019-03-27T16:48:39.308Z,1553705319.308 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-27T16:48:39.319Z,1553705319.319 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-27T16:48:39.319Z,1553705319.319 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-27T16:48:39.319Z,1553705319.319 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 11
2019-03-27T16:48:39.703Z,1553705319.703 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-27T16:48:39.714Z,1553705319.714 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-27T16:48:39.714Z,1553705319.714 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2019-03-27T16:48:41.309Z,1553705321.309 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:48:43.325Z,1553705323.325 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:48:45.349Z,1553705325.349 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:48:48.577Z,1553705328.577 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:48:51.405Z,1553705331.405 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:48:54.641Z,1553705334.641 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:48:57.465Z,1553705337.465 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:49:00.701Z,1553705340.701 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:49:03.525Z,1553705343.525 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:49:06.353Z,1553705346.353 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:49:09.589Z,1553705349.589 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:49:12.413Z,1553705352.413 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:49:15.649Z,1553705355.649 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:49:18.473Z,1553705358.473 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:49:21.305Z,1553705361.305 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:49:23.321Z,1553705363.321 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:49:25.341Z,1553705365.341 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:49:28.577Z,1553705368.577 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:49:31.401Z,1553705371.401 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:49:34.637Z,1553705374.637 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:49:37.465Z,1553705377.465 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:49:40.693Z,1553705380.693 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:49:43.521Z,1553705383.521 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:49:46.349Z,1553705386.349 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:49:49.581Z,1553705389.581 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:49:52.409Z,1553705392.409 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:49:55.641Z,1553705395.641 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:49:58.469Z,1553705398.469 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:50:01.297Z,1553705401.297 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:50:03.317Z,1553705403.317 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:50:05.337Z,1553705405.337 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:50:08.573Z,1553705408.573 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:50:11.401Z,1553705411.401 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:50:14.633Z,1553705414.633 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:50:17.457Z,1553705417.457 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:50:20.285Z,1553705420.285 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:50:22.309Z,1553705422.309 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:50:24.329Z,1553705424.329 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:50:26.345Z,1553705426.345 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:50:29.581Z,1553705429.581 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:50:32.405Z,1553705432.405 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:50:35.641Z,1553705435.641 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:50:38.465Z,1553705438.465 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:50:40.090Z,1553705440.090 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-27T16:50:40.090Z,1553705440.090 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 12
2019-03-27T16:50:40.090Z,1553705440.090 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-27T16:50:40.101Z,1553705440.101 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-27T16:50:40.497Z,1553705440.497 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-27T16:50:40.497Z,1553705440.497 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2019-03-27T16:50:40.497Z,1553705440.497 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-27T16:50:40.508Z,1553705440.508 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-27T16:50:40.508Z,1553705440.508 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-27T16:50:40.508Z,1553705440.508 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 12
2019-03-27T16:50:40.896Z,1553705440.896 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-27T16:50:40.906Z,1553705440.906 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-27T16:50:40.906Z,1553705440.906 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2019-03-27T16:50:41.297Z,1553705441.297 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:50:43.313Z,1553705443.313 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:50:45.337Z,1553705445.337 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:50:48.569Z,1553705448.569 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:50:51.393Z,1553705451.393 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:50:54.629Z,1553705454.629 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:50:57.457Z,1553705457.457 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:51:00.294Z,1553705460.294 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-03-27T16:51:00.294Z,1553705460.294 [Default:CheckIn:C.Wait] Stopped
2019-03-27T16:51:00.294Z,1553705460.294 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-03-27T16:51:00.294Z,1553705460.294 [Default:CheckIn:D] Running Loop=1
2019-03-27T16:51:00.685Z,1553705460.685 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:51:00.711Z,1553705460.711 [Default:CheckIn:D] Stopped
2019-03-27T16:51:00.712Z,1553705460.712 [Default:CheckIn:E] Running Loop=1
2019-03-27T16:51:01.117Z,1553705461.117 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.128699 min 
2019-03-27T16:51:01.118Z,1553705461.118 [Default:CheckIn:E] Stopped
2019-03-27T16:51:01.118Z,1553705461.118 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-03-27T16:51:01.118Z,1553705461.118 [Default:CheckIn] Stopped
2019-03-27T16:51:01.118Z,1553705461.118 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-03-27T16:51:01.118Z,1553705461.118 [Default:CheckIn](INFO): Running loop #3
2019-03-27T16:51:01.118Z,1553705461.118 [Default:CheckIn] Running Loop=3
2019-03-27T16:51:01.118Z,1553705461.118 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-03-27T16:51:01.118Z,1553705461.118 [Default:CheckIn:Read_GPS] Running Loop=1
2019-03-27T16:51:03.517Z,1553705463.517 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:51:06.341Z,1553705466.341 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:51:09.577Z,1553705469.577 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:51:12.401Z,1553705472.401 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:51:15.633Z,1553705475.633 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:51:18.461Z,1553705478.461 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:51:21.293Z,1553705481.293 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:51:23.309Z,1553705483.309 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:51:25.329Z,1553705485.329 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:51:27.035Z,1553705487.035 [CommandLine](IMPORTANT): got command run /mnt/mmc/LRAUV/Missions/Maintenance/FDI_run.xml
2019-03-27T16:51:27.035Z,1553705487.035 [MissionManager](INFO): Loading Mission: /mnt/mmc/LRAUV/Missions/Maintenance/FDI_run.xml
2019-03-27T16:51:27.047Z,1553705487.047 [FDI_on:TestDrive:C.Wait](DEBUG): Construct Wait.
2019-03-27T16:51:27.050Z,1553705487.050 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Sensor="Tethys/Sensor"
       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/Sensor http://okeanids.mbari.org/tethys/Xml/Sensor.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="FDI_on">

    <Aggregate Id="TestDrive">

        <Parallel/>

        <ReadData Strategy="MinError">
            <Sensor:FDI.powerFDI/>
        </ReadData>

        <ReadData Strategy="MinError">
            <Sensor:FDI.runFDI/>
        </ReadData>
        
        <Guidance:Wait>
            <Sequence/>
            <Setting><Guidance:Wait.duration/><Units:minute/><Value>20</Value></Setting>
        </Guidance:Wait>

    </Aggregate>

</Mission>


2019-03-27T16:51:27.052Z,1553705487.052 [CommandLine](IMPORTANT): Running /mnt/mmc/LRAUV/Missions/Maintenance/FDI_run.xml
2019-03-27T16:51:27.381Z,1553705487.381 [Default] Stopped
2019-03-27T16:51:27.382Z,1553705487.382 [Default](DEBUG): Aggregate::uninitialize Default
2019-03-27T16:51:27.382Z,1553705487.382 [Default:B.GoToSurface] Stopped
2019-03-27T16:51:27.382Z,1553705487.382 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-03-27T16:51:27.382Z,1553705487.382 [Default:CheckIn] Stopped
2019-03-27T16:51:27.382Z,1553705487.382 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-03-27T16:51:27.382Z,1553705487.382 [Default:CheckIn:Read_GPS] Stopped
2019-03-27T16:51:27.382Z,1553705487.382 [MissionManager](IMPORTANT): Started mission FDI_on
2019-03-27T16:51:27.382Z,1553705487.382 [FDI_on] Running Loop=1
2019-03-27T16:51:27.383Z,1553705487.383 [FDI_on](DEBUG): Aggregate::initialize FDI_on
2019-03-27T16:51:27.383Z,1553705487.383 [FDI_on:TestDrive] Running Loop=1
2019-03-27T16:51:27.383Z,1553705487.383 [FDI_on:TestDrive](DEBUG): Aggregate::initialize FDI_on:TestDrive
2019-03-27T16:51:27.383Z,1553705487.383 [FDI_on:TestDrive:A] Running Loop=1
2019-03-27T16:51:27.383Z,1553705487.383 [FDI_on:TestDrive:B] Running Loop=1
2019-03-27T16:51:27.383Z,1553705487.383 [FDI_on:TestDrive:C.Wait] Running Loop=1
2019-03-27T16:51:27.383Z,1553705487.383 [FDI_on:TestDrive:C.Wait](DEBUG): Initialize Wait Component.
2019-03-27T16:51:27.383Z,1553705487.383 [FDI_on:TestDrive] Running Loop=1
2019-03-27T16:51:27.383Z,1553705487.383 [FDI_on:TestDrive:B] Running Loop=1
2019-03-27T16:51:27.384Z,1553705487.384 [FDI_on:TestDrive:B](DEBUG): Initialize ReadDataComponent to sense FDI.runFDI
2019-03-27T16:51:27.384Z,1553705487.384 [FDI_on:TestDrive:A] Running Loop=1
2019-03-27T16:51:27.389Z,1553705487.389 [FDI_on:TestDrive:A](DEBUG): Initialize ReadDataComponent to sense FDI.powerFDI
2019-03-27T16:51:27.757Z,1553705487.757 [FDI](INFO): Powering up
2019-03-27T16:51:28.569Z,1553705488.569 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:51:31.393Z,1553705491.393 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:51:34.625Z,1553705494.625 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:51:37.453Z,1553705497.453 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:51:40.685Z,1553705500.685 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:51:43.513Z,1553705503.513 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:51:46.337Z,1553705506.337 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:51:49.573Z,1553705509.573 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:51:52.397Z,1553705512.397 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:51:55.633Z,1553705515.633 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:51:58.457Z,1553705518.457 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:52:01.285Z,1553705521.285 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:52:03.305Z,1553705523.305 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:52:05.329Z,1553705525.329 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:52:07.349Z,1553705527.349 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:52:10.577Z,1553705530.577 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:52:13.409Z,1553705533.409 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:52:16.637Z,1553705536.637 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:52:19.469Z,1553705539.469 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:52:22.297Z,1553705542.297 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:52:24.321Z,1553705544.321 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:52:26.333Z,1553705546.333 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:52:29.569Z,1553705549.569 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:52:32.393Z,1553705552.393 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:52:35.629Z,1553705555.629 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:52:38.453Z,1553705558.453 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:52:41.294Z,1553705561.294 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-27T16:52:41.294Z,1553705561.294 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 13
2019-03-27T16:52:41.294Z,1553705561.294 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-27T16:52:41.305Z,1553705561.305 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-27T16:52:41.685Z,1553705561.685 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:52:41.708Z,1553705561.708 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-27T16:52:41.708Z,1553705561.708 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13
2019-03-27T16:52:41.708Z,1553705561.708 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-27T16:52:41.719Z,1553705561.719 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-27T16:52:41.719Z,1553705561.719 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-27T16:52:41.719Z,1553705561.719 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 13
2019-03-27T16:52:42.116Z,1553705562.116 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-27T16:52:42.125Z,1553705562.125 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-27T16:52:42.126Z,1553705562.126 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13
2019-03-27T16:52:44.513Z,1553705564.513 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:52:47.345Z,1553705567.345 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:52:50.573Z,1553705570.573 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:52:53.405Z,1553705573.405 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:52:56.633Z,1553705576.633 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:52:59.465Z,1553705579.465 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:53:02.693Z,1553705582.693 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:53:05.525Z,1553705585.525 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:53:08.353Z,1553705588.353 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:53:11.589Z,1553705591.589 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:53:14.409Z,1553705594.409 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:53:17.645Z,1553705597.645 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:53:20.473Z,1553705600.473 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:53:23.301Z,1553705603.301 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:53:25.321Z,1553705605.321 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:53:27.341Z,1553705607.341 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:53:30.569Z,1553705610.569 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:53:33.401Z,1553705613.401 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:53:36.633Z,1553705616.633 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:53:39.461Z,1553705619.461 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:53:42.689Z,1553705622.689 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:53:45.521Z,1553705625.521 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:53:48.345Z,1553705628.345 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:53:51.581Z,1553705631.581 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:53:54.405Z,1553705634.405 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:53:57.641Z,1553705637.641 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:54:00.469Z,1553705640.469 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:54:03.297Z,1553705643.297 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:54:05.317Z,1553705645.317 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:54:07.337Z,1553705647.337 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:54:10.565Z,1553705650.565 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:54:13.397Z,1553705653.397 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:54:16.625Z,1553705656.625 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:54:19.457Z,1553705659.457 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:54:22.685Z,1553705662.685 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:54:25.517Z,1553705665.517 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:54:28.341Z,1553705668.341 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:54:31.577Z,1553705671.577 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:54:34.405Z,1553705674.405 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:54:37.637Z,1553705677.637 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:54:40.465Z,1553705680.465 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:54:42.500Z,1553705682.500 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-27T16:54:42.501Z,1553705682.501 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 14
2019-03-27T16:54:42.501Z,1553705682.501 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-27T16:54:42.512Z,1553705682.512 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-27T16:54:42.904Z,1553705682.904 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-27T16:54:42.904Z,1553705682.904 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14
2019-03-27T16:54:42.904Z,1553705682.904 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-27T16:54:42.915Z,1553705682.915 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-27T16:54:42.915Z,1553705682.915 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-27T16:54:42.915Z,1553705682.915 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 14
2019-03-27T16:54:43.289Z,1553705683.289 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:54:43.316Z,1553705683.316 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-27T16:54:43.326Z,1553705683.326 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-27T16:54:43.326Z,1553705683.326 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14
2019-03-27T16:54:45.313Z,1553705685.313 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:54:47.333Z,1553705687.333 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:54:50.561Z,1553705690.561 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:54:53.393Z,1553705693.393 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:54:56.621Z,1553705696.621 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:54:59.449Z,1553705699.449 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:55:02.681Z,1553705702.681 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:55:05.513Z,1553705705.513 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:55:08.341Z,1553705708.341 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:55:11.573Z,1553705711.573 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:55:14.401Z,1553705714.401 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:55:17.633Z,1553705717.633 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:55:20.465Z,1553705720.465 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:55:23.285Z,1553705723.285 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:55:25.309Z,1553705725.309 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:55:27.333Z,1553705727.333 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:55:29.345Z,1553705729.345 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:55:32.577Z,1553705732.577 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:55:35.405Z,1553705735.405 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:55:38.641Z,1553705738.641 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:55:41.465Z,1553705741.465 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:55:44.297Z,1553705744.297 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:55:46.313Z,1553705746.313 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:55:48.337Z,1553705748.337 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:55:51.569Z,1553705751.569 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:55:54.397Z,1553705754.397 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:55:57.629Z,1553705757.629 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:56:00.457Z,1553705760.457 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:56:03.285Z,1553705763.285 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:56:05.305Z,1553705765.305 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:56:07.321Z,1553705767.321 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:56:09.341Z,1553705769.341 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:56:12.577Z,1553705772.577 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:56:15.401Z,1553705775.401 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:56:18.637Z,1553705778.637 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:56:21.461Z,1553705781.461 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:56:24.293Z,1553705784.293 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:56:26.309Z,1553705786.309 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:56:28.333Z,1553705788.333 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:56:31.561Z,1553705791.561 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:56:34.389Z,1553705794.389 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:56:37.625Z,1553705797.625 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:56:40.453Z,1553705800.453 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:56:43.681Z,1553705803.681 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:56:43.715Z,1553705803.715 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-27T16:56:43.715Z,1553705803.715 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 15
2019-03-27T16:56:43.715Z,1553705803.715 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-27T16:56:43.738Z,1553705803.738 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-27T16:56:44.112Z,1553705804.112 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-27T16:56:44.112Z,1553705804.112 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15
2019-03-27T16:56:44.112Z,1553705804.112 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-27T16:56:44.172Z,1553705804.172 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-27T16:56:44.173Z,1553705804.173 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-27T16:56:44.173Z,1553705804.173 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 15
2019-03-27T16:56:44.511Z,1553705804.511 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-27T16:56:44.532Z,1553705804.532 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-27T16:56:44.532Z,1553705804.532 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15
2019-03-27T16:56:46.513Z,1553705806.513 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:56:48.121Z,1553705808.121 [CommandLine](IMPORTANT): got command stop
2019-03-27T16:56:48.121Z,1553705808.121 [CommandLine](IMPORTANT): Scheduling is paused
2019-03-27T16:56:48.121Z,1553705808.121 [Supervisor](INFO): Stop Mission called by CommandLine::commandStop
2019-03-27T16:56:48.149Z,1553705808.149 [MissionManager](INFO): MissionManager is completed.
2019-03-27T16:56:48.149Z,1553705808.149 [MissionManager](INFO): Uninitializing Mission FDI_on
2019-03-27T16:56:48.149Z,1553705808.149 [FDI_on] Stopped
2019-03-27T16:56:48.150Z,1553705808.150 [FDI_on](DEBUG): Aggregate::uninitialize FDI_on
2019-03-27T16:56:48.150Z,1553705808.150 [FDI_on:TestDrive] Stopped
2019-03-27T16:56:48.150Z,1553705808.150 [FDI_on:TestDrive](DEBUG): Aggregate::uninitialize FDI_on:TestDrive
2019-03-27T16:56:48.150Z,1553705808.150 [FDI_on:TestDrive:A] Stopped
2019-03-27T16:56:48.150Z,1553705808.150 [FDI_on:TestDrive:B] Stopped
2019-03-27T16:56:48.150Z,1553705808.150 [FDI_on:TestDrive:C.Wait] Stopped
2019-03-27T16:56:48.150Z,1553705808.150 [FDI_on:TestDrive:C.Wait](DEBUG): Uninitialize Wait Component.
2019-03-27T16:56:48.550Z,1553705808.550 [MissionManager](IMPORTANT): Started mission Default
2019-03-27T16:56:48.550Z,1553705808.550 [Default] Running Loop=1
2019-03-27T16:56:48.550Z,1553705808.550 [Default](DEBUG): Aggregate::initialize Default
2019-03-27T16:56:48.550Z,1553705808.550 [Default:B.GoToSurface] Running Loop=1
2019-03-27T16:56:48.550Z,1553705808.550 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-03-27T16:56:48.550Z,1553705808.550 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-03-27T16:56:48.551Z,1553705808.551 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-03-27T16:56:48.551Z,1553705808.551 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-03-27T16:56:48.551Z,1553705808.551 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-03-27T16:56:48.552Z,1553705808.552 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-03-27T16:56:48.552Z,1553705808.552 [Default:A.Wait] Running Loop=1
2019-03-27T16:56:48.552Z,1553705808.552 [Default:A.Wait](DEBUG): Initialize Wait Component.
2019-03-27T16:56:49.340Z,1553705809.340 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:56:49.354Z,1553705809.354 [FDI](INFO): Powering down
2019-03-27T16:56:52.577Z,1553705812.577 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:56:55.397Z,1553705815.397 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:56:58.633Z,1553705818.633 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:56:59.471Z,1553705819.471 [CBIT](INFO): Clearing failed state for component RudderServo
2019-03-27T16:56:59.471Z,1553705819.471 [RudderServo] No Fault, FailCount= 3
2019-03-27T16:57:01.457Z,1553705821.457 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:57:01.890Z,1553705821.890 [Default:A.Wait](INFO): Done Waiting.
2019-03-27T16:57:01.890Z,1553705821.890 [Default:A.Wait] Stopped
2019-03-27T16:57:01.890Z,1553705821.890 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2019-03-27T16:57:02.289Z,1553705822.289 [Default:CheckIn] Running Loop=1
2019-03-27T16:57:02.290Z,1553705822.290 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-03-27T16:57:02.290Z,1553705822.290 [Default:CheckIn:Read_GPS] Running Loop=1
2019-03-27T16:57:04.289Z,1553705824.289 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:57:06.305Z,1553705826.305 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:57:08.329Z,1553705828.329 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:57:11.561Z,1553705831.561 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:57:14.389Z,1553705834.389 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:57:17.617Z,1553705837.617 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:57:20.445Z,1553705840.445 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:57:23.677Z,1553705843.677 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:57:26.509Z,1553705846.509 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:57:29.333Z,1553705849.333 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:57:30.568Z,1553705850.568 [CBIT](INFO): Clearing failed state for component ElevatorServo
2019-03-27T16:57:30.568Z,1553705850.568 [ElevatorServo] No Fault, FailCount= 3
2019-03-27T16:57:32.565Z,1553705852.565 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:57:35.033Z,1553705855.033 [ElevatorServo](FAULT): Overload Error
2019-03-27T16:57:35.033Z,1553705855.033 [ElevatorServo] Hardware Fault, FailCount= 1
2019-03-27T16:57:35.033Z,1553705855.033 [ElevatorServo](ERROR): Hardware Fault
2019-03-27T16:57:35.075Z,1553705855.075 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2019-03-27T16:57:35.393Z,1553705855.393 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:57:35.422Z,1553705855.422 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-03-27T16:57:35.422Z,1553705855.422 [ElevatorServo](INFO): Powering down
2019-03-27T16:57:36.230Z,1553705856.230 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-03-27T16:57:36.346Z,1553705856.346 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-03-27T16:57:36.351Z,1553705856.351 [CBIT](INFO): Clearing failed state for component ElevatorServo
2019-03-27T16:57:36.351Z,1553705856.351 [ElevatorServo] No Fault, FailCount= 1
2019-03-27T16:57:38.629Z,1553705858.629 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:57:41.453Z,1553705861.453 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:57:41.509Z,1553705861.509 [ElevatorServo](FAULT): Overload Error
2019-03-27T16:57:41.509Z,1553705861.509 [ElevatorServo] Hardware Fault, FailCount= 2
2019-03-27T16:57:41.509Z,1553705861.509 [ElevatorServo](ERROR): Hardware Fault
2019-03-27T16:57:41.550Z,1553705861.550 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2019-03-27T16:57:41.902Z,1553705861.902 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-03-27T16:57:41.902Z,1553705861.902 [ElevatorServo](INFO): Powering down
2019-03-27T16:57:42.674Z,1553705862.674 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-03-27T16:57:42.790Z,1553705862.790 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-03-27T16:57:42.795Z,1553705862.795 [CBIT](INFO): Clearing failed state for component ElevatorServo
2019-03-27T16:57:42.795Z,1553705862.795 [ElevatorServo] No Fault, FailCount= 2
2019-03-27T16:57:44.689Z,1553705864.689 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:57:47.517Z,1553705867.517 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:57:47.981Z,1553705867.981 [ElevatorServo](FAULT): Overload Error
2019-03-27T16:57:47.981Z,1553705867.981 [ElevatorServo] Hardware Fault, FailCount= 3
2019-03-27T16:57:47.981Z,1553705867.981 [ElevatorServo](ERROR): Hardware Fault
2019-03-27T16:57:48.022Z,1553705868.022 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2019-03-27T16:57:48.023Z,1553705868.023 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo
2019-03-27T16:57:48.353Z,1553705868.353 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-03-27T16:57:48.353Z,1553705868.353 [ElevatorServo](INFO): Powering down
2019-03-27T16:57:48.357Z,1553705868.357 [CommandLine](FAULT): Scheduling is paused
2019-03-27T16:57:48.357Z,1553705868.357 [CBIT](INFO): Critical error at 20190327T165748
2019-03-27T16:57:49.150Z,1553705869.150 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-03-27T16:57:49.266Z,1553705869.266 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-03-27T16:57:50.345Z,1553705870.345 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:57:53.573Z,1553705873.573 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:57:56.405Z,1553705876.405 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:57:59.470Z,1553705879.470 [CommandLine](IMPORTANT): got command restart application
2019-03-27T16:57:59.637Z,1553705879.637 [NAL9602](DEBUG): Fix Requested
2019-03-27T16:58:00.481Z,1553705880.481 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-27T16:58:00.481Z,1553705880.481 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-03-27T16:58:00.525Z,1553705880.525 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2019-03-27T16:58:00.525Z,1553705880.525 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-03-27T16:58:00.525Z,1553705880.525 [CommandLine](INFO): Join timeout helper Thread ID is 8088
2019-03-27T16:58:00.533Z,1553705880.533 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2019-03-27T16:58:00.533Z,1553705880.533 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-03-27T16:58:00.533Z,1553705880.533 [NavChartDb](INFO): Join timeout helper Thread ID is 8089
2019-03-27T16:58:00.629Z,1553705880.629 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-27T16:58:00.629Z,1553705880.629 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-03-27T16:58:00.641Z,1553705880.641 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2019-03-27T16:58:00.641Z,1553705880.641 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-03-27T16:58:00.641Z,1553705880.641 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 8090
2019-03-27T16:58:00.681Z,1553705880.681 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-27T16:58:00.681Z,1553705880.681 [WetLabsBB2FL](INFO): Powering down
2019-03-27T16:58:00.682Z,1553705880.682 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-03-27T16:58:00.701Z,1553705880.701 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2019-03-27T16:58:00.701Z,1553705880.701 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-03-27T16:58:00.701Z,1553705880.701 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 8091
2019-03-27T16:58:00.801Z,1553705880.801 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-27T16:58:00.801Z,1553705880.801 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-03-27T16:58:00.821Z,1553705880.821 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2019-03-27T16:58:00.821Z,1553705880.821 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-03-27T16:58:00.821Z,1553705880.821 [Radio_Surface](INFO): Join timeout helper Thread ID is 8092
2019-03-27T16:58:01.061Z,1553705881.061 [Radio_Surface](INFO): Powering down
2019-03-27T16:58:01.062Z,1553705881.062 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-27T16:58:01.062Z,1553705881.062 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-03-27T16:58:01.066Z,1553705881.066 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2019-03-27T16:58:01.066Z,1553705881.066 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-03-27T16:58:01.066Z,1553705881.066 [DataOverHttps](INFO): Join timeout helper Thread ID is 8093
2019-03-27T16:58:01.209Z,1553705881.209 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-27T16:58:01.209Z,1553705881.209 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-03-27T16:58:01.225Z,1553705881.225 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2019-03-27T16:58:01.226Z,1553705881.226 [logger ThreadHandler](INFO): Thread cancelled.
2019-03-27T16:58:01.226Z,1553705881.226 [logger](INFO): Join timeout helper Thread ID is 8094
2019-03-27T16:58:01.241Z,1553705881.241 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-27T16:58:01.241Z,1553705881.241 [logger ThreadHandler](INFO): Thread cancelled.
2019-03-27T16:58:01.247Z,1553705881.247 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2019-03-27T16:58:01.247Z,1553705881.247 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-03-27T16:58:01.247Z,1553705881.247 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2019-03-27T16:58:01.247Z,1553705881.247 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-03-27T16:58:01.248Z,1553705881.248 [controlThread](INFO): Join timeout helper Thread ID is 8095
2019-03-27T16:58:01.275Z,1553705881.275 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-27T16:58:01.275Z,1553705881.275 [controlThread](DEBUG): Uninitializing ControlThread
2019-03-27T16:58:01.276Z,1553705881.276 [NAL9602](INFO): Powering down
2019-03-27T16:58:01.277Z,1553705881.277 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2019-03-27T16:58:01.278Z,1553705881.278 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2019-03-27T16:58:01.279Z,1553705881.279 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2019-03-27T16:58:01.279Z,1553705881.279 [MissionManager](INFO): Uninitializing Mission Default
2019-03-27T16:58:01.279Z,1553705881.279 [Default] Stopped
2019-03-27T16:58:01.280Z,1553705881.280 [Default](DEBUG): Aggregate::uninitialize Default
2019-03-27T16:58:01.280Z,1553705881.280 [Default:B.GoToSurface] Stopped
2019-03-27T16:58:01.280Z,1553705881.280 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-03-27T16:58:01.280Z,1553705881.280 [Default:CheckIn] Stopped
2019-03-27T16:58:01.280Z,1553705881.280 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-03-27T16:58:01.280Z,1553705881.280 [Default:CheckIn:Read_GPS] Stopped
2019-03-27T16:58:01.282Z,1553705881.282 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2019-03-27T16:58:01.283Z,1553705881.283 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2019-03-27T16:58:01.283Z,1553705881.283 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2019-03-27T16:58:01.283Z,1553705881.283 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2019-03-27T16:58:01.283Z,1553705881.283 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-03-27T16:58:01.283Z,1553705881.283 [BuoyancyServo](INFO): Powering down
2019-03-27T16:58:01.297Z,1553705881.297 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-03-27T16:58:01.297Z,1553705881.297 [ElevatorServo](INFO): Powering down
2019-03-27T16:58:01.298Z,1553705881.298 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-03-27T16:58:01.298Z,1553705881.298 [MassServo](INFO): Powering down
2019-03-27T16:58:01.299Z,1553705881.299 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-03-27T16:58:01.299Z,1553705881.299 [RudderServo](INFO): Powering down
2019-03-27T16:58:01.299Z,1553705881.299 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2019-03-27T16:58:01.299Z,1553705881.299 [ThrusterServo](INFO): Powering down
2019-03-27T16:58:01.300Z,1553705881.300 [SBIT](DEBUG): Uninitialize SBIT Component.
2019-03-27T16:58:01.301Z,1553705881.301 [IBIT](DEBUG): Uninitialize IBIT Component.
2019-03-27T16:58:01.301Z,1553705881.301 [CBIT](DEBUG): Uninitialize CBIT Component.
2019-03-27T16:58:01.301Z,1553705881.301 [CBIT](DEBUG): Powering off loads.
2019-03-27T16:58:01.313Z,1553705881.313 [CBIT](DEBUG): Disabling WDT.
2019-03-27T16:58:01.325Z,1553705881.325 [CBIT](DEBUG): Opening all GF detection circuits.
2019-03-27T16:58:01.325Z,1553705881.325 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-03-27T16:58:01.387Z,1553705881.387 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-03-27T16:58:01.393Z,1553705881.393 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-03-27T16:58:01.428Z,1553705881.428 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-03-27T16:58:01.430Z,1553705881.430 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-03-27T16:58:01.594Z,1553705881.594 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-03-27T16:58:01.647Z,1553705881.647 [logger ThreadHandler](INFO): Thread cancelled.