2019-03-19T01:01:51.304Z,1552957311.304 [Supervisor](DEBUG): Initializing supervisor.
2019-03-19T01:01:51.307Z,1552957311.307 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-03-19T01:01:51.307Z,1552957311.307 [SyncHandler](INFO): Protected caller Thread ID is 1309
2019-03-19T01:01:51.308Z,1552957311.308 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2019-03-19T01:01:51.309Z,1552957311.309 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2019-03-19T01:01:51.309Z,1552957311.309 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1310
2019-03-19T01:01:51.312Z,1552957311.312 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2019-03-19T01:01:51.323Z,1552957311.323 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2019-03-19T01:01:51.324Z,1552957311.324 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2019-03-19T01:01:51.325Z,1552957311.325 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1311
2019-03-19T01:01:51.326Z,1552957311.326 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2019-03-19T01:01:51.327Z,1552957311.327 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2019-03-19T01:01:51.327Z,1552957311.327 [logger ThreadHandler](INFO): Protected caller Thread ID is 1312
2019-03-19T01:01:51.329Z,1552957311.329 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2019-03-19T01:01:51.329Z,1552957311.329 [Supervisor](INFO): Looking for Config files in directory: Config/
2019-03-19T01:01:51.331Z,1552957311.331 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2019-03-19T01:01:51.767Z,1552957311.767 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2019-03-19T01:01:51.768Z,1552957311.768 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2019-03-19T01:01:52.240Z,1552957312.240 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2019-03-19T01:01:52.241Z,1552957312.241 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2019-03-19T01:01:52.436Z,1552957312.436 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2019-03-19T01:01:52.437Z,1552957312.437 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2019-03-19T01:01:52.584Z,1552957312.584 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2019-03-19T01:01:52.584Z,1552957312.584 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2019-03-19T01:01:53.105Z,1552957313.105 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2019-03-19T01:01:53.105Z,1552957313.105 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2019-03-19T01:01:53.405Z,1552957313.405 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2019-03-19T01:01:53.405Z,1552957313.405 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2019-03-19T01:01:53.551Z,1552957313.551 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2019-03-19T01:01:53.551Z,1552957313.551 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2019-03-19T01:01:53.651Z,1552957313.651 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2019-03-19T01:01:53.652Z,1552957313.652 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2019-03-19T01:01:53.757Z,1552957313.757 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2019-03-19T01:01:53.757Z,1552957313.757 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2019-03-19T01:01:54.146Z,1552957314.146 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2019-03-19T01:01:54.147Z,1552957314.147 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2019-03-19T01:01:54.347Z,1552957314.347 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2019-03-19T01:01:54.348Z,1552957314.348 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2019-03-19T01:01:54.569Z,1552957314.569 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2019-03-19T01:01:54.570Z,1552957314.570 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2019-03-19T01:01:54.651Z,1552957314.651 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2019-03-19T01:01:54.998Z,1552957314.998 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2019-03-19T01:01:54.999Z,1552957314.999 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2019-03-19T01:01:55.320Z,1552957315.320 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2019-03-19T01:01:55.322Z,1552957315.322 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/
2019-03-19T01:01:55.323Z,1552957315.323 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg
2019-03-19T01:01:55.408Z,1552957315.408 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg
2019-03-19T01:01:55.563Z,1552957315.563 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg
2019-03-19T01:01:55.662Z,1552957315.662 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg
2019-03-19T01:01:55.840Z,1552957315.840 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg
2019-03-19T01:01:55.924Z,1552957315.924 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg
2019-03-19T01:01:56.151Z,1552957316.151 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2019-03-19T01:01:56.151Z,1552957316.151 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg
2019-03-19T01:01:56.267Z,1552957316.267 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg
2019-03-19T01:01:56.367Z,1552957316.367 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg
2019-03-19T01:01:56.462Z,1552957316.462 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg
2019-03-19T01:01:56.564Z,1552957316.564 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg
2019-03-19T01:01:56.675Z,1552957316.675 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/root/
2019-03-19T01:01:56.675Z,1552957316.675 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2019-03-19T01:01:56.680Z,1552957316.680 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2019-03-19T01:01:56.722Z,1552957316.722 [DepthRateCalculator] Loaded
2019-03-19T01:01:56.722Z,1552957316.722 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2019-03-19T01:01:56.728Z,1552957316.728 [PitchRateCalculator] Loaded
2019-03-19T01:01:56.728Z,1552957316.728 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2019-03-19T01:01:56.744Z,1552957316.744 [SpeedCalculator] Loaded
2019-03-19T01:01:56.744Z,1552957316.744 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2019-03-19T01:01:56.765Z,1552957316.765 [TempGradientCalculator] Loaded
2019-03-19T01:01:56.765Z,1552957316.765 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2019-03-19T01:01:56.771Z,1552957316.771 [YawRateCalculator] Loaded
2019-03-19T01:01:56.771Z,1552957316.771 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2019-03-19T01:01:56.811Z,1552957316.811 [ElevatorOffsetCalculator] Loaded
2019-03-19T01:01:56.811Z,1552957316.811 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2019-03-19T01:01:56.811Z,1552957316.811 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2019-03-19T01:01:56.812Z,1552957316.812 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2019-03-19T01:01:57.042Z,1552957317.042 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2019-03-19T01:01:57.043Z,1552957317.043 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2019-03-19T01:01:57.347Z,1552957317.347 [DataOverHttps] Loaded
2019-03-19T01:01:57.347Z,1552957317.347 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2019-03-19T01:01:57.348Z,1552957317.348 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 407CE4E0
2019-03-19T01:01:57.349Z,1552957317.349 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1391
2019-03-19T01:01:57.388Z,1552957317.388 [Depth_Keller] Loaded
2019-03-19T01:01:57.388Z,1552957317.388 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2019-03-19T01:01:57.484Z,1552957317.484 [NAL9602] Loaded
2019-03-19T01:01:57.484Z,1552957317.484 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2019-03-19T01:01:57.499Z,1552957317.499 [Onboard] Loaded
2019-03-19T01:01:57.500Z,1552957317.500 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2019-03-19T01:01:57.506Z,1552957317.506 [Radio_Surface] Loaded
2019-03-19T01:01:57.506Z,1552957317.506 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2019-03-19T01:01:57.507Z,1552957317.507 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 407FE4E0
2019-03-19T01:01:57.508Z,1552957317.508 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1392
2019-03-19T01:01:59.889Z,1552957319.889 [BPC1] Loaded
2019-03-19T01:01:59.889Z,1552957319.889 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2019-03-19T01:01:59.890Z,1552957319.890 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2019-03-19T01:01:59.890Z,1552957319.890 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2019-03-19T01:01:59.951Z,1552957319.951 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2019-03-19T01:01:59.952Z,1552957319.952 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2019-03-19T01:02:00.053Z,1552957320.053 [DeadReckonUsingMultipleVelocitySources] Loaded
2019-03-19T01:02:00.053Z,1552957320.053 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2019-03-19T01:02:00.111Z,1552957320.111 [DeadReckonUsingSpeedCalculator] Loaded
2019-03-19T01:02:00.111Z,1552957320.111 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2019-03-19T01:02:00.132Z,1552957320.132 [NavChart] Loaded
2019-03-19T01:02:00.132Z,1552957320.132 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2019-03-19T01:02:00.136Z,1552957320.136 [UniversalFixResidualReporter] Loaded
2019-03-19T01:02:00.136Z,1552957320.136 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2019-03-19T01:02:00.137Z,1552957320.137 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2019-03-19T01:02:00.137Z,1552957320.137 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2019-03-19T01:02:00.378Z,1552957320.378 [CTD_NeilBrown] Loaded
2019-03-19T01:02:00.378Z,1552957320.378 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2019-03-19T01:02:00.379Z,1552957320.379 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 409524E0
2019-03-19T01:02:00.380Z,1552957320.380 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 1393
2019-03-19T01:02:00.428Z,1552957320.428 [WetLabsBB2FL] Loaded
2019-03-19T01:02:00.428Z,1552957320.428 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2019-03-19T01:02:00.429Z,1552957320.429 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 409824E0
2019-03-19T01:02:00.429Z,1552957320.429 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1394
2019-03-19T01:02:00.430Z,1552957320.430 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2019-03-19T01:02:00.431Z,1552957320.431 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2019-03-19T01:02:00.495Z,1552957320.495 [VerticalControl](DEBUG): Construct VerticalControl.
2019-03-19T01:02:00.593Z,1552957320.593 [VerticalControl] Loaded
2019-03-19T01:02:00.593Z,1552957320.593 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2019-03-19T01:02:00.594Z,1552957320.594 [HorizontalControl](DEBUG): Construct HorizontalControl.
2019-03-19T01:02:00.660Z,1552957320.660 [HorizontalControl] Loaded
2019-03-19T01:02:00.661Z,1552957320.661 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2019-03-19T01:02:00.661Z,1552957320.661 [SpeedControl](DEBUG): Construct SpeedControl.
2019-03-19T01:02:00.667Z,1552957320.667 [SpeedControl] Loaded
2019-03-19T01:02:00.667Z,1552957320.667 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2019-03-19T01:02:00.668Z,1552957320.668 [LoopControl](DEBUG): Construct LoopControl.
2019-03-19T01:02:00.668Z,1552957320.668 [LoopControl] Loaded
2019-03-19T01:02:00.668Z,1552957320.668 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2019-03-19T01:02:00.669Z,1552957320.669 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2019-03-19T01:02:00.669Z,1552957320.669 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2019-03-19T01:02:00.682Z,1552957320.682 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2019-03-19T01:02:00.683Z,1552957320.683 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2019-03-19T01:02:00.813Z,1552957320.813 [SBIT](DEBUG): Construct Startup Built In Test.
2019-03-19T01:02:00.825Z,1552957320.825 [SBIT] Loaded
2019-03-19T01:02:00.825Z,1552957320.825 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2019-03-19T01:02:00.826Z,1552957320.826 [IBIT](DEBUG): Construct Initiated Built In Test.
2019-03-19T01:02:00.837Z,1552957320.837 [IBIT] Loaded
2019-03-19T01:02:00.837Z,1552957320.837 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2019-03-19T01:02:00.841Z,1552957320.841 [CBIT](DEBUG): Construct Continuous Built In Test.
2019-03-19T01:02:00.977Z,1552957320.977 [CBIT] Loaded
2019-03-19T01:02:00.978Z,1552957320.978 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2019-03-19T01:02:00.978Z,1552957320.978 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2019-03-19T01:02:00.979Z,1552957320.979 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2019-03-19T01:02:01.075Z,1552957321.075 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2019-03-19T01:02:01.076Z,1552957321.076 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2019-03-19T01:02:01.102Z,1552957321.102 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2019-03-19T01:02:01.103Z,1552957321.103 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2019-03-19T01:02:01.200Z,1552957321.200 [BuoyancyServo] Loaded
2019-03-19T01:02:01.200Z,1552957321.200 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2019-03-19T01:02:01.211Z,1552957321.211 [ElevatorServo] Loaded
2019-03-19T01:02:01.212Z,1552957321.212 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2019-03-19T01:02:01.218Z,1552957321.218 [MassServo](DEBUG): LcmSlateWriter::add(): platform_mass_position
2019-03-19T01:02:01.223Z,1552957321.223 [MassServo](INFO): created writer for : platform_mass_position
2019-03-19T01:02:01.224Z,1552957321.224 [MassServo](DEBUG): LcmSlateWriter::add(): fdi_state
2019-03-19T01:02:01.229Z,1552957321.229 [MassServo](INFO): created writer for : fdi_state
2019-03-19T01:02:01.230Z,1552957321.230 [MassServo] Loaded
2019-03-19T01:02:01.230Z,1552957321.230 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2019-03-19T01:02:01.241Z,1552957321.241 [RudderServo] Loaded
2019-03-19T01:02:01.242Z,1552957321.242 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2019-03-19T01:02:01.253Z,1552957321.253 [ThrusterServo] Loaded
2019-03-19T01:02:01.253Z,1552957321.253 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2019-03-19T01:02:01.253Z,1552957321.253 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2019-03-19T01:02:01.257Z,1552957321.257 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2019-03-19T01:02:01.258Z,1552957321.258 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2019-03-19T01:02:01.264Z,1552957321.264 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2019-03-19T01:02:01.265Z,1552957321.265 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AA94E0
2019-03-19T01:02:01.266Z,1552957321.266 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1395
2019-03-19T01:02:01.270Z,1552957321.270 [Supervisor](INFO): Main Thread ID is 798
2019-03-19T01:02:01.270Z,1552957321.270 [Supervisor](DEBUG): Running supervisor.
2019-03-19T01:02:01.271Z,1552957321.271 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1396
2019-03-19T01:02:01.274Z,1552957321.274 [controlThread ThreadHandler](INFO): Handler Thread ID is 1397
2019-03-19T01:02:01.275Z,1552957321.275 [controlThread](DEBUG): Initializing ControlThread
2019-03-19T01:02:01.276Z,1552957321.276 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2019-03-19T01:02:01.276Z,1552957321.276 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2019-03-19T01:02:01.276Z,1552957321.276 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2019-03-19T01:02:01.277Z,1552957321.277 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2019-03-19T01:02:01.277Z,1552957321.277 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2019-03-19T01:02:01.278Z,1552957321.278 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2019-03-19T01:02:01.282Z,1552957321.282 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-19T01:02:01.283Z,1552957321.283 [NavChart](DEBUG): Initialize NavChart Navigation.
2019-03-19T01:02:01.283Z,1552957321.283 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2019-03-19T01:02:01.283Z,1552957321.283 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2019-03-19T01:02:01.285Z,1552957321.285 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2019-03-19T01:02:01.286Z,1552957321.286 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2019-03-19T01:02:01.286Z,1552957321.286 [LoopControl](DEBUG): Initialize LoopControlComponent.
2019-03-19T01:02:01.286Z,1552957321.286 [SBIT](INFO): Initialize SBIT Component.
2019-03-19T01:02:01.287Z,1552957321.287 [SBIT](IMPORTANT): git: 2019-03-04-46-gd6610ff
2019-03-19T01:02:01.287Z,1552957321.287 [SBIT](INFO): git hash: d6610ff838e6b7a25a908fc1e9fd291f97bf1870
2019-03-19T01:02:01.287Z,1552957321.287 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2019-03-19T01:02:01.287Z,1552957321.287 [SBIT](IMPORTANT): Kernel Version:#2 PREEMPT Thu Jan 11 20:13:48 PST 2018
2019-03-19T01:02:01.289Z,1552957321.289 [SBIT](INFO): Beginning SBIT in 28.000000 seconds.
2019-03-19T01:02:01.289Z,1552957321.289 [IBIT](INFO): Initialize IBIT Component.
2019-03-19T01:02:01.290Z,1552957321.290 [CBIT](DEBUG): Initialize CBIT Component.
2019-03-19T01:02:01.291Z,1552957321.291 [logger ThreadHandler](INFO): Handler Thread ID is 1398
2019-03-19T01:02:01.301Z,1552957321.301 [CBIT](DEBUG): Initialized mux pins.
2019-03-19T01:02:01.301Z,1552957321.301 [CBIT](DEBUG): Initializing the watchdog timer.
2019-03-19T01:02:01.309Z,1552957321.309 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1399
2019-03-19T01:02:01.310Z,1552957321.310 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2019-03-19T01:02:01.321Z,1552957321.321 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1400
2019-03-19T01:02:01.325Z,1552957321.325 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2019-03-19T01:02:01.325Z,1552957321.325 [CBIT](DEBUG): Initializing heartbeat.
2019-03-19T01:02:01.333Z,1552957321.333 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 1401
2019-03-19T01:02:01.341Z,1552957321.341 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1402
2019-03-19T01:02:01.342Z,1552957321.342 [WetLabsBB2FL](INFO): Powering down
2019-03-19T01:02:01.373Z,1552957321.373 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1403
2019-03-19T01:02:01.376Z,1552957321.376 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2019-03-19T01:02:01.376Z,1552957321.376 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2019-03-19T01:02:01.377Z,1552957321.377 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2019-03-19T01:02:01.377Z,1552957321.377 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2019-03-19T01:02:01.377Z,1552957321.377 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2019-03-19T01:02:01.377Z,1552957321.377 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2019-03-19T01:02:01.378Z,1552957321.378 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2019-03-19T01:02:01.378Z,1552957321.378 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2019-03-19T01:02:01.378Z,1552957321.378 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2019-03-19T01:02:01.378Z,1552957321.378 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2019-03-19T01:02:01.378Z,1552957321.378 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2019-03-19T01:02:01.378Z,1552957321.378 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2019-03-19T01:02:01.379Z,1552957321.379 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2019-03-19T01:02:01.379Z,1552957321.379 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2019-03-19T01:02:01.379Z,1552957321.379 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2019-03-19T01:02:01.379Z,1552957321.379 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2019-03-19T01:02:01.397Z,1552957321.397 [CBIT](DEBUG): Deactivating GF circuits.
2019-03-19T01:02:01.397Z,1552957321.397 [CBIT](DEBUG): Deactivating emergency mode.
2019-03-19T01:02:01.435Z,1552957321.435 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2019-03-19T01:02:01.445Z,1552957321.445 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2019-03-19T01:02:01.456Z,1552957321.456 [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-19T01:02:01.473Z,1552957321.473 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2019-03-19T01:02:01.545Z,1552957321.545 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2019-03-19T01:02:01.546Z,1552957321.546 [Default:A.Wait](DEBUG): Construct Wait.
2019-03-19T01:02:01.548Z,1552957321.548 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2019-03-19T01:02:01.567Z,1552957321.567 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2019-03-19T01:02:01.613Z,1552957321.613 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2019-03-19T01:02:01.619Z,1552957321.619 [Default:E.Execute](DEBUG): Construct Execute.
2019-03-19T01:02:01.644Z,1552957321.644 [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-19T01:02:01.656Z,1552957321.656 [controlThread](DEBUG): Component order: CycleStarter,Depth_Keller,NAL9602,Onboard,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-19T01:02:01.675Z,1552957321.675 [Depth_Keller](ERROR): Pressure reading out of range: 1628.471313 decibar
2019-03-19T01:02:01.725Z,1552957321.725 [Radio_Surface](INFO): Powering up
2019-03-19T01:02:01.726Z,1552957321.726 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-03-19T01:02:01.774Z,1552957321.774 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-03-19T01:02:01.789Z,1552957321.789 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-03-19T01:02:01.790Z,1552957321.790 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-03-19T01:02:01.805Z,1552957321.805 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-03-19T01:02:01.806Z,1552957321.806 [MassServo](DEBUG): Initializing EZServoServo.
2019-03-19T01:02:01.813Z,1552957321.813 [MassServo](DEBUG): Initializing MassServo.
2019-03-19T01:02:01.814Z,1552957321.814 [RudderServo](DEBUG): Initializing EZServoServo.
2019-03-19T01:02:01.821Z,1552957321.821 [RudderServo](DEBUG): Initializing RudderServo.
2019-03-19T01:02:01.822Z,1552957321.822 [ThrusterServo](DEBUG): Initializing EZServoServo.
2019-03-19T01:02:01.829Z,1552957321.829 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2019-03-19T01:02:06.605Z,1552957326.605 [RudderServo](FAULT): Overload Error
2019-03-19T01:02:06.605Z,1552957326.605 [RudderServo] Hardware Fault, FailCount= 1
2019-03-19T01:02:06.605Z,1552957326.605 [RudderServo](ERROR): Hardware Fault
2019-03-19T01:02:06.645Z,1552957326.645 [CBIT](ERROR): Hardware Fault in component: RudderServo
2019-03-19T01:02:06.974Z,1552957326.974 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-03-19T01:02:06.974Z,1552957326.974 [RudderServo](INFO): Powering down
2019-03-19T01:02:07.786Z,1552957327.786 [RudderServo](DEBUG): Initializing EZServoServo.
2019-03-19T01:02:07.906Z,1552957327.906 [RudderServo](DEBUG): Initializing RudderServo.
2019-03-19T01:02:07.910Z,1552957327.910 [CBIT](INFO): Clearing failed state for component RudderServo
2019-03-19T01:02:07.910Z,1552957327.910 [RudderServo] No Fault, FailCount= 1
2019-03-19T01:02:12.617Z,1552957332.617 [RudderServo](FAULT): Overload Error
2019-03-19T01:02:12.617Z,1552957332.617 [RudderServo] Hardware Fault, FailCount= 2
2019-03-19T01:02:12.617Z,1552957332.617 [RudderServo](ERROR): Hardware Fault
2019-03-19T01:02:12.657Z,1552957332.657 [CBIT](ERROR): Hardware Fault in component: RudderServo
2019-03-19T01:02:12.998Z,1552957332.998 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-03-19T01:02:12.998Z,1552957332.998 [RudderServo](INFO): Powering down
2019-03-19T01:02:13.809Z,1552957333.809 [RudderServo](DEBUG): Initializing EZServoServo.
2019-03-19T01:02:13.930Z,1552957333.930 [RudderServo](DEBUG): Initializing RudderServo.
2019-03-19T01:02:13.934Z,1552957333.934 [CBIT](INFO): Clearing failed state for component RudderServo
2019-03-19T01:02:13.934Z,1552957333.934 [RudderServo] No Fault, FailCount= 2
2019-03-19T01:02:18.677Z,1552957338.677 [RudderServo](FAULT): Overload Error
2019-03-19T01:02:18.677Z,1552957338.677 [RudderServo] Hardware Fault, FailCount= 3
2019-03-19T01:02:18.677Z,1552957338.677 [RudderServo](ERROR): Hardware Fault
2019-03-19T01:02:18.717Z,1552957338.717 [CBIT](ERROR): Hardware Fault in component: RudderServo
2019-03-19T01:02:18.717Z,1552957338.717 [CBIT](CRITICAL): Hardware Fault in component: RudderServo
2019-03-19T01:02:19.062Z,1552957339.062 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-03-19T01:02:19.062Z,1552957339.062 [RudderServo](INFO): Powering down
2019-03-19T01:02:19.064Z,1552957339.064 [CommandLine](FAULT): Scheduling is paused
2019-03-19T01:02:19.064Z,1552957339.064 [CBIT](INFO): Critical error at 20190319T010218
2019-03-19T01:02:19.077Z,1552957339.077 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2019-03-19T01:02:19.879Z,1552957339.879 [RudderServo](DEBUG): Initializing EZServoServo.
2019-03-19T01:02:19.998Z,1552957339.998 [RudderServo](DEBUG): Initializing RudderServo.
2019-03-19T01:02:27.518Z,1552957347.518 [NAL9602](INFO): Powering up NAL9602
2019-03-19T01:02:29.966Z,1552957349.966 [SBIT](IMPORTANT): Beginning Startup BIT
2019-03-19T01:02:29.971Z,1552957349.971 [CBIT](IMPORTANT): Beginning ground fault scan
2019-03-19T01:02:32.017Z,1552957352.017 [ElevatorServo](FAULT): Overload Error
2019-03-19T01:02:32.017Z,1552957352.017 [ElevatorServo] Hardware Fault, FailCount= 1
2019-03-19T01:02:32.017Z,1552957352.017 [ElevatorServo](ERROR): Hardware Fault
2019-03-19T01:02:32.438Z,1552957352.438 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2019-03-19T01:02:32.473Z,1552957352.473 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-03-19T01:02:32.473Z,1552957352.473 [ElevatorServo](INFO): Powering down
2019-03-19T01:02:33.281Z,1552957353.281 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-03-19T01:02:33.398Z,1552957353.398 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-03-19T01:02:33.441Z,1552957353.441 [CBIT](INFO): Clearing failed state for component ElevatorServo
2019-03-19T01:02:33.441Z,1552957353.441 [ElevatorServo] No Fault, FailCount= 1
2019-03-19T01:02:38.209Z,1552957358.209 [ElevatorServo](FAULT): Overload Error
2019-03-19T01:02:38.209Z,1552957358.209 [ElevatorServo] Hardware Fault, FailCount= 2
2019-03-19T01:02:38.209Z,1552957358.209 [ElevatorServo](ERROR): Hardware Fault
2019-03-19T01:02:38.254Z,1552957358.254 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2019-03-19T01:02:38.510Z,1552957358.510 [NAL9602](INFO): NAL9602 initialized
2019-03-19T01:02:38.571Z,1552957358.571 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-03-19T01:02:38.571Z,1552957358.571 [ElevatorServo](INFO): Powering down
2019-03-19T01:02:39.329Z,1552957359.329 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:02:39.354Z,1552957359.354 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-03-19T01:02:39.470Z,1552957359.470 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-03-19T01:02:39.514Z,1552957359.514 [CBIT](INFO): Clearing failed state for component ElevatorServo
2019-03-19T01:02:39.514Z,1552957359.514 [ElevatorServo] No Fault, FailCount= 2
2019-03-19T01:02:41.009Z,1552957361.009 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.007327
CHAN A1 (24V): 0.001851
CHAN A2 (12V): -0.005779
CHAN A3 (5V): -0.002855
CHAN B0 (3.3V): -0.001004
CHAN B1 (3.15aV): -0.001528
CHAN B2 (3.15bV): -0.000928
CHAN B3 (GND): -0.000577
OPEN: -0.001138
Full Scale Calc: 4.765 mA, -1.589 mA
2019-03-19T01:02:43.083Z,1552957363.083 [SBIT](ERROR): Could not read rudderAngleReader_.
2019-03-19T01:02:44.633Z,1552957364.633 [ElevatorServo](FAULT): Overload Error
2019-03-19T01:02:44.633Z,1552957364.633 [ElevatorServo] Hardware Fault, FailCount= 3
2019-03-19T01:02:44.633Z,1552957364.633 [ElevatorServo](ERROR): Hardware Fault
2019-03-19T01:02:44.673Z,1552957364.673 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2019-03-19T01:02:44.674Z,1552957364.674 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo
2019-03-19T01:02:45.001Z,1552957365.001 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-03-19T01:02:45.002Z,1552957365.002 [ElevatorServo](INFO): Powering down
2019-03-19T01:02:45.025Z,1552957365.025 [CBIT](INFO): Critical error at 20190319T010244
2019-03-19T01:02:45.805Z,1552957365.805 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-03-19T01:02:45.922Z,1552957365.922 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-03-19T01:03:09.804Z,1552957389.804 [SBIT](ERROR): Could not read elevatorAngleReader_.
2019-03-19T01:03:09.805Z,1552957389.805 [SBIT](ERROR): Could not read rudderAngleReader_.
2019-03-19T01:03:09.805Z,1552957389.805 [SBIT](FAULT): Control surface position failure.
2019-03-19T01:03:23.594Z,1552957403.594 [SBIT](ERROR): Could not read elevatorAngleReader_.
2019-03-19T01:03:23.594Z,1552957403.594 [SBIT](ERROR): Could not read rudderAngleReader_.
2019-03-19T01:03:23.594Z,1552957403.594 [SBIT](FAULT): Control surface position failure.
2019-03-19T01:03:23.994Z,1552957403.994 [SBIT](CRITICAL): SBIT FAILED
2019-03-19T01:03:24.009Z,1552957404.009 [CBIT](INFO): Critical error at 20190319T010323
2019-03-19T01:03:24.035Z,1552957404.035 [CommandLine](IMPORTANT): got command configSet list
2019-03-19T01:03:24.035Z,1552957404.035 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2019-03-19T01:03:24.037Z,1552957404.037 [CommandLine](IMPORTANT): AHRS_M2.loadAtStartup=0 bool;

2019-03-19T01:03:24.037Z,1552957404.037 [CommandLine](IMPORTANT): CTD_Seabird.loadAtStartup=0 bool;

2019-03-19T01:03:24.039Z,1552957404.039 [CommandLine](IMPORTANT): DropWeight.loadAtStartup=0 bool;

2019-03-19T01:03:24.361Z,1552957404.361 [MissionManager](IMPORTANT): Started mission Startup
2019-03-19T01:03:24.361Z,1552957404.361 [Startup] Running Loop=1
2019-03-19T01:03:24.362Z,1552957404.362 [Startup](DEBUG): Aggregate::initialize Startup
2019-03-19T01:03:24.362Z,1552957404.362 [Startup:A.GoToSurface] Running Loop=1
2019-03-19T01:03:24.362Z,1552957404.362 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-03-19T01:03:24.362Z,1552957404.362 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-03-19T01:03:24.363Z,1552957404.363 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-03-19T01:03:24.363Z,1552957404.363 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-03-19T01:03:24.363Z,1552957404.363 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-03-19T01:03:24.364Z,1552957404.364 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-03-19T01:03:24.365Z,1552957404.365 [Startup:StartupSatComms] Running Loop=1
2019-03-19T01:03:24.366Z,1552957404.366 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2019-03-19T01:03:24.366Z,1552957404.366 [Startup:StartupSatComms:A] Running Loop=1
2019-03-19T01:03:24.758Z,1552957404.758 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2019-03-19T01:04:01.520Z,1552957441.520 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-19T01:04:01.520Z,1552957441.520 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2019-03-19T01:04:01.520Z,1552957441.520 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-19T01:04:01.522Z,1552957441.522 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-19T01:04:01.522Z,1552957441.522 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2019-03-19T01:04:01.522Z,1552957441.522 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-19T01:04:01.532Z,1552957441.532 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-19T01:04:01.532Z,1552957441.532 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-19T01:04:01.941Z,1552957441.941 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-19T01:04:01.941Z,1552957441.941 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2019-03-19T01:04:01.942Z,1552957441.942 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-19T01:04:01.942Z,1552957441.942 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2019-03-19T01:04:02.316Z,1552957442.316 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-19T01:04:24.546Z,1552957464.546 [Startup:StartupSatComms:A](INFO): Timed out from 2019-03-19T01:03:24.4Z
2019-03-19T01:04:24.546Z,1552957464.546 [Startup:StartupSatComms:A] Stopped
2019-03-19T01:04:24.546Z,1552957464.546 [Startup:StartupSatComms:B] Running Loop=1
2019-03-19T01:04:24.946Z,1552957464.946 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-03-19T01:04:27.234Z,1552957467.234 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004441
2019-03-19T01:04:33.536Z,1552957473.536 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190319T004758/Courier0007.lzma
2019-03-19T01:04:34.342Z,1552957474.342 [DataOverHttps](INFO): Moved sent file to Logs/20190319T004758/Courier0007.lzma.bak
2019-03-19T01:04:34.342Z,1552957474.342 [DataOverHttps](INFO): SBD MOMSN=10190336
2019-03-19T01:04:45.660Z,1552957485.660 [DataOverHttps](INFO): Sending 138 bytes from file Logs/20190319T010151/Courier0000.lzma
2019-03-19T01:04:46.466Z,1552957486.466 [DataOverHttps](INFO): Moved sent file to Logs/20190319T010151/Courier0000.lzma.bak
2019-03-19T01:04:46.466Z,1552957486.466 [DataOverHttps](INFO): SBD MOMSN=10190338
2019-03-19T01:04:59.125Z,1552957499.125 [DataOverHttps](INFO): Sending 341 bytes from file Logs/20190319T004758/Express0008.lzma
2019-03-19T01:04:59.930Z,1552957499.930 [DataOverHttps](INFO): Moved sent file to Logs/20190319T004758/Express0008.lzma.bak
2019-03-19T01:04:59.930Z,1552957499.930 [DataOverHttps](INFO): SBD MOMSN=10190344
2019-03-19T01:05:13.534Z,1552957513.534 [DataOverHttps](INFO): Sending 911 bytes from file Logs/20190319T010151/Express0001.lzma
2019-03-19T01:05:14.338Z,1552957514.338 [DataOverHttps](INFO): Moved sent file to Logs/20190319T010151/Express0001.lzma.bak
2019-03-19T01:05:14.338Z,1552957514.338 [DataOverHttps](INFO): SBD MOMSN=10190357
2019-03-19T01:05:17.909Z,1552957517.909 [Startup:StartupSatComms:B] Stopped
2019-03-19T01:05:17.909Z,1552957517.909 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2019-03-19T01:05:17.910Z,1552957517.910 [Startup:StartupSatComms] Stopped
2019-03-19T01:05:17.910Z,1552957517.910 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2019-03-19T01:05:17.910Z,1552957517.910 [Startup](INFO): Completed Startup
2019-03-19T01:05:17.911Z,1552957517.911 [MissionManager](INFO): Startup is completed.
2019-03-19T01:05:17.911Z,1552957517.911 [MissionManager](INFO): Uninitializing Mission Startup
2019-03-19T01:05:17.911Z,1552957517.911 [Startup] Stopped
2019-03-19T01:05:17.911Z,1552957517.911 [Startup](DEBUG): Aggregate::uninitialize Startup
2019-03-19T01:05:17.911Z,1552957517.911 [Startup:A.GoToSurface] Stopped
2019-03-19T01:05:17.911Z,1552957517.911 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-03-19T01:05:18.317Z,1552957518.317 [MissionManager](IMPORTANT): Started mission Default
2019-03-19T01:05:18.318Z,1552957518.318 [Default] Running Loop=1
2019-03-19T01:05:18.318Z,1552957518.318 [Default](DEBUG): Aggregate::initialize Default
2019-03-19T01:05:18.318Z,1552957518.318 [Default:B.GoToSurface] Running Loop=1
2019-03-19T01:05:18.318Z,1552957518.318 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-03-19T01:05:18.318Z,1552957518.318 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-03-19T01:05:18.319Z,1552957518.319 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-03-19T01:05:18.319Z,1552957518.319 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-03-19T01:05:18.319Z,1552957518.319 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-03-19T01:05:18.319Z,1552957518.319 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-03-19T01:05:18.320Z,1552957518.320 [Default:A.Wait] Running Loop=1
2019-03-19T01:05:18.320Z,1552957518.320 [Default:A.Wait](DEBUG): Initialize Wait Component.
2019-03-19T01:05:31.652Z,1552957531.652 [Default:A.Wait](INFO): Done Waiting.
2019-03-19T01:05:31.652Z,1552957531.652 [Default:A.Wait] Stopped
2019-03-19T01:05:31.652Z,1552957531.652 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2019-03-19T01:05:32.050Z,1552957532.050 [Default:CheckIn] Running Loop=1
2019-03-19T01:05:32.050Z,1552957532.050 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-03-19T01:05:32.050Z,1552957532.050 [Default:CheckIn:Read_GPS] Running Loop=1
2019-03-19T01:05:32.459Z,1552957532.459 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2019-03-19T01:06:02.352Z,1552957562.352 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-19T01:06:02.352Z,1552957562.352 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2019-03-19T01:06:02.352Z,1552957562.352 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-19T01:06:02.353Z,1552957562.353 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-19T01:06:02.354Z,1552957562.354 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2019-03-19T01:06:02.354Z,1552957562.354 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-19T01:06:02.363Z,1552957562.363 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-19T01:06:02.364Z,1552957562.364 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-19T01:06:02.769Z,1552957562.769 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-19T01:06:02.769Z,1552957562.769 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2019-03-19T01:06:02.769Z,1552957562.769 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-19T01:06:02.769Z,1552957562.769 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2019-03-19T01:06:03.160Z,1552957563.160 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-19T01:07:41.714Z,1552957661.714 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-03-19T01:07:42.537Z,1552957662.537 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:07:45.769Z,1552957665.769 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:07:48.593Z,1552957668.593 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:07:51.425Z,1552957671.425 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:07:53.445Z,1552957673.445 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:07:56.677Z,1552957676.677 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:07:59.497Z,1552957679.497 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:08:02.737Z,1552957682.737 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:08:03.168Z,1552957683.168 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-19T01:08:03.168Z,1552957683.168 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2019-03-19T01:08:03.169Z,1552957683.169 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-19T01:08:03.170Z,1552957683.170 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-19T01:08:03.170Z,1552957683.170 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2019-03-19T01:08:03.170Z,1552957683.170 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-19T01:08:03.180Z,1552957683.180 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-19T01:08:03.181Z,1552957683.181 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-19T01:08:03.573Z,1552957683.573 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-19T01:08:03.573Z,1552957683.573 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2019-03-19T01:08:03.574Z,1552957683.574 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-19T01:08:03.574Z,1552957683.574 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2019-03-19T01:08:03.960Z,1552957683.960 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-19T01:08:05.565Z,1552957685.565 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:08:08.393Z,1552957688.393 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:08:10.413Z,1552957690.413 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:08:12.433Z,1552957692.433 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:08:15.665Z,1552957695.665 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:08:18.493Z,1552957698.493 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:08:21.725Z,1552957701.725 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:08:24.549Z,1552957704.549 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:08:26.307Z,1552957706.307 [CommandLine](IMPORTANT): got command failComponent hardware MassServo
2019-03-19T01:08:26.307Z,1552957706.307 [MassServo] Hardware Fault, FailCount= 1
2019-03-19T01:08:26.307Z,1552957706.307 [MassServo](ERROR): Hardware Fault
2019-03-19T01:08:26.308Z,1552957706.308 [CommandLine](IMPORTANT): MassServo failureMode is Hardware Fault
2019-03-19T01:08:26.583Z,1552957706.583 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-03-19T01:08:26.584Z,1552957706.584 [MassServo](INFO): Powering down
2019-03-19T01:08:26.588Z,1552957706.588 [CBIT](ERROR): Hardware Fault in component: MassServo
2019-03-19T01:08:27.406Z,1552957707.406 [CBIT](INFO): Clearing failed state for component MassServo
2019-03-19T01:08:27.406Z,1552957707.406 [MassServo] No Fault, FailCount= 1
2019-03-19T01:08:27.781Z,1552957707.781 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:08:27.814Z,1552957707.814 [MassServo](DEBUG): Initializing EZServoServo.
2019-03-19T01:08:27.815Z,1552957707.815 [MassServo](DEBUG): Initializing MassServo.
2019-03-19T01:08:30.617Z,1552957710.617 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:08:33.437Z,1552957713.437 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:08:36.673Z,1552957716.673 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:08:39.493Z,1552957719.493 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:08:42.733Z,1552957722.733 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:08:45.561Z,1552957725.561 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:08:48.389Z,1552957728.389 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:08:50.409Z,1552957730.409 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:08:52.429Z,1552957732.429 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:08:54.445Z,1552957734.445 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:08:57.685Z,1552957737.685 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:08:59.083Z,1552957739.083 [CommandLine](IMPORTANT): got command failComponent none MassServo
2019-03-19T01:08:59.083Z,1552957739.083 [CommandLine](IMPORTANT): MassServo failureMode is No Fault
2019-03-19T01:09:00.505Z,1552957740.505 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:09:03.745Z,1552957743.745 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:09:06.569Z,1552957746.569 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:09:09.401Z,1552957749.401 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:09:11.421Z,1552957751.421 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:09:13.433Z,1552957753.433 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:09:16.665Z,1552957756.665 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:09:19.493Z,1552957759.493 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:09:22.725Z,1552957762.725 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:09:25.577Z,1552957765.577 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:09:26.781Z,1552957766.781 [BPC1](INFO): Calculating totals. Valid battery stick count: 54. Valid reserve battery stick count: 6.
2019-03-19T01:09:27.203Z,1552957767.203 [CommandLine](IMPORTANT): got command maintain control VerticalControl.massPositionAction 2.000000 centimeter
2019-03-19T01:09:27.205Z,1552957767.205 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.massPositionAction" handled in the control thread.
2019-03-19T01:09:27.603Z,1552957767.603 [controlThread](DEBUG): Component order: CycleStarter,Depth_Keller,NAL9602,Onboard,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.massPositionAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2019-03-19T01:09:28.793Z,1552957768.793 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:09:31.645Z,1552957771.645 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:09:34.469Z,1552957774.469 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:09:37.705Z,1552957777.705 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:09:40.533Z,1552957780.533 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:09:43.761Z,1552957783.761 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:09:46.593Z,1552957786.593 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:09:49.421Z,1552957789.421 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:09:51.441Z,1552957791.441 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:09:54.665Z,1552957794.665 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:09:57.501Z,1552957797.501 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:10:00.733Z,1552957800.733 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:10:03.565Z,1552957803.565 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:10:03.986Z,1552957803.986 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-19T01:10:03.986Z,1552957803.986 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2019-03-19T01:10:03.987Z,1552957803.987 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-19T01:10:03.988Z,1552957803.988 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-19T01:10:03.988Z,1552957803.988 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4
2019-03-19T01:10:03.988Z,1552957803.988 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-19T01:10:03.999Z,1552957803.999 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-19T01:10:03.999Z,1552957803.999 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-19T01:10:04.402Z,1552957804.402 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-19T01:10:04.402Z,1552957804.402 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2019-03-19T01:10:04.402Z,1552957804.402 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-19T01:10:04.402Z,1552957804.402 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4
2019-03-19T01:10:04.780Z,1552957804.780 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-19T01:10:06.389Z,1552957806.389 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:10:08.405Z,1552957808.405 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:10:10.425Z,1552957810.425 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:10:10.484Z,1552957810.484 [CommandLine](IMPORTANT): got command maintain control VerticalControl.massPositionAction 0.000000 centimeter
2019-03-19T01:10:12.449Z,1552957812.449 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:10:15.717Z,1552957815.717 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:10:18.549Z,1552957818.549 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:10:21.777Z,1552957821.777 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:10:24.601Z,1552957824.601 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:10:27.425Z,1552957827.425 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:10:30.665Z,1552957830.665 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:10:32.298Z,1552957832.298 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-03-19T01:05:32.1Z
2019-03-19T01:10:32.298Z,1552957832.298 [Default:CheckIn:Read_GPS] Stopped
2019-03-19T01:10:32.298Z,1552957832.298 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-03-19T01:10:32.705Z,1552957832.705 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-03-19T01:10:33.529Z,1552957833.529 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:10:36.761Z,1552957836.761 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:10:38.268Z,1552957838.268 [DataOverHttps](INFO): Sending 187 bytes from file Logs/20190319T010151/Courier0004.lzma
2019-03-19T01:10:39.074Z,1552957839.074 [DataOverHttps](INFO): Moved sent file to Logs/20190319T010151/Courier0004.lzma.bak
2019-03-19T01:10:39.074Z,1552957839.074 [DataOverHttps](INFO): SBD MOMSN=10190383
2019-03-19T01:10:39.589Z,1552957839.589 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:10:42.417Z,1552957842.417 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:10:44.437Z,1552957844.437 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:10:47.673Z,1552957847.673 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:10:50.500Z,1552957850.500 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:10:52.693Z,1552957852.693 [DataOverHttps](INFO): Sending 422 bytes from file Logs/20190319T010151/Express0005.lzma
2019-03-19T01:10:53.498Z,1552957853.498 [DataOverHttps](INFO): Moved sent file to Logs/20190319T010151/Express0005.lzma.bak
2019-03-19T01:10:53.498Z,1552957853.498 [DataOverHttps](INFO): SBD MOMSN=10190385
2019-03-19T01:10:53.733Z,1552957853.733 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:10:56.557Z,1552957856.557 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:10:56.985Z,1552957856.985 [Default:CheckIn:Read_Iridium] Stopped
2019-03-19T01:10:56.985Z,1552957856.985 [Default:CheckIn:C.Wait] Running Loop=1
2019-03-19T01:10:56.985Z,1552957856.985 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-03-19T01:10:59.385Z,1552957859.385 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:11:01.405Z,1552957861.405 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:11:03.429Z,1552957863.429 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:11:05.445Z,1552957865.445 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:11:08.677Z,1552957868.677 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:11:11.513Z,1552957871.513 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:11:14.737Z,1552957874.737 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:11:14.798Z,1552957874.798 [CommandLine](IMPORTANT): got command failComponent hardware MassServo
2019-03-19T01:11:14.798Z,1552957874.798 [MassServo] Hardware Fault, FailCount= 1
2019-03-19T01:11:14.798Z,1552957874.798 [MassServo](ERROR): Hardware Fault
2019-03-19T01:11:14.798Z,1552957874.798 [CommandLine](IMPORTANT): MassServo failureMode is Hardware Fault
2019-03-19T01:11:15.179Z,1552957875.179 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-03-19T01:11:15.179Z,1552957875.179 [MassServo](INFO): Powering down
2019-03-19T01:11:15.183Z,1552957875.183 [CBIT](ERROR): Hardware Fault in component: MassServo
2019-03-19T01:11:15.964Z,1552957875.964 [CBIT](INFO): Clearing failed state for component MassServo
2019-03-19T01:11:15.964Z,1552957875.964 [MassServo] No Fault, FailCount= 1
2019-03-19T01:11:16.366Z,1552957876.366 [MassServo](DEBUG): Initializing EZServoServo.
2019-03-19T01:11:16.367Z,1552957876.367 [MassServo](DEBUG): Initializing MassServo.
2019-03-19T01:11:17.573Z,1552957877.573 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:11:20.397Z,1552957880.397 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:11:22.417Z,1552957882.417 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:11:24.429Z,1552957884.429 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:11:27.669Z,1552957887.669 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:11:30.493Z,1552957890.493 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:11:31.031Z,1552957891.031 [CommandLine](IMPORTANT): got command failComponent none MassServo
2019-03-19T01:11:31.032Z,1552957891.032 [CommandLine](IMPORTANT): MassServo failureMode is No Fault
2019-03-19T01:11:33.729Z,1552957893.729 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:11:36.549Z,1552957896.549 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:11:39.385Z,1552957899.385 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:11:41.405Z,1552957901.405 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:11:43.421Z,1552957903.421 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:11:45.445Z,1552957905.445 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:11:48.673Z,1552957908.673 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:11:51.505Z,1552957911.505 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:11:54.737Z,1552957914.737 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:11:57.561Z,1552957917.561 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:12:00.393Z,1552957920.393 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:12:02.409Z,1552957922.409 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:12:04.433Z,1552957924.433 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:12:04.860Z,1552957924.860 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-19T01:12:04.860Z,1552957924.860 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2019-03-19T01:12:04.860Z,1552957924.860 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-19T01:12:04.861Z,1552957924.861 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-19T01:12:04.862Z,1552957924.862 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5
2019-03-19T01:12:04.862Z,1552957924.862 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-19T01:12:04.872Z,1552957924.872 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-19T01:12:04.872Z,1552957924.872 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-19T01:12:05.273Z,1552957925.273 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-19T01:12:05.273Z,1552957925.273 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2019-03-19T01:12:05.274Z,1552957925.274 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-19T01:12:05.274Z,1552957925.274 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5
2019-03-19T01:12:05.656Z,1552957925.656 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-19T01:12:07.665Z,1552957927.665 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:12:10.489Z,1552957930.489 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:12:13.725Z,1552957933.725 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:12:16.549Z,1552957936.549 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:12:19.785Z,1552957939.785 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:12:22.609Z,1552957942.609 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:12:25.441Z,1552957945.441 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:12:28.669Z,1552957948.669 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:12:31.501Z,1552957951.501 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:12:34.729Z,1552957954.729 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:12:37.557Z,1552957957.557 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:12:40.378Z,1552957960.378 [NAL9602](FAULT): GPS failed to acquire within timeout.
2019-03-19T01:12:40.378Z,1552957960.378 [NAL9602] Data Fault, FailCount= 1
2019-03-19T01:12:40.378Z,1552957960.378 [NAL9602](ERROR): Data Fault
2019-03-19T01:12:40.438Z,1552957960.438 [CBIT](ERROR): Data Fault in component: NAL9602
2019-03-19T01:12:40.774Z,1552957960.774 [NAL9602](INFO): Powering down
2019-03-19T01:12:41.618Z,1552957961.618 [CBIT](INFO): Clearing failed state for component NAL9602
2019-03-19T01:12:41.618Z,1552957961.618 [NAL9602] No Fault, FailCount= 1
2019-03-19T01:13:11.082Z,1552957991.082 [NAL9602](INFO): Powering up NAL9602
2019-03-19T01:13:21.990Z,1552958001.990 [NAL9602](INFO): NAL9602 initialized
2019-03-19T01:13:22.809Z,1552958002.809 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:13:25.233Z,1552958005.233 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:13:28.062Z,1552958008.062 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:13:31.293Z,1552958011.293 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:13:34.125Z,1552958014.125 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:13:37.353Z,1552958017.353 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:13:40.177Z,1552958020.177 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:13:43.005Z,1552958023.005 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:13:46.241Z,1552958026.241 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:13:49.065Z,1552958029.065 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:13:52.301Z,1552958032.301 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:13:55.129Z,1552958035.129 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:13:57.957Z,1552958037.957 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:13:59.973Z,1552958039.973 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:14:01.993Z,1552958041.993 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:14:04.013Z,1552958044.013 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:14:06.040Z,1552958046.040 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-19T01:14:06.040Z,1552958046.040 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2019-03-19T01:14:06.041Z,1552958046.041 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-19T01:14:06.042Z,1552958046.042 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-19T01:14:06.042Z,1552958046.042 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6
2019-03-19T01:14:06.042Z,1552958046.042 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-19T01:14:06.053Z,1552958046.053 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-19T01:14:06.053Z,1552958046.053 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-19T01:14:06.466Z,1552958046.466 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-19T01:14:06.466Z,1552958046.466 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2019-03-19T01:14:06.466Z,1552958046.466 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-19T01:14:06.466Z,1552958046.466 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6
2019-03-19T01:14:06.852Z,1552958046.852 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-19T01:14:07.249Z,1552958047.249 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:14:10.077Z,1552958050.077 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:14:13.309Z,1552958053.309 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:14:16.141Z,1552958056.141 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:14:18.961Z,1552958058.961 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:14:20.985Z,1552958060.985 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:14:23.001Z,1552958063.001 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:14:26.233Z,1552958066.233 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:14:29.061Z,1552958069.061 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:14:32.297Z,1552958072.297 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:14:35.121Z,1552958075.121 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:14:38.353Z,1552958078.353 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:14:41.185Z,1552958081.185 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:14:44.013Z,1552958084.013 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:14:47.249Z,1552958087.249 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:14:50.073Z,1552958090.073 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:14:53.301Z,1552958093.301 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:14:56.133Z,1552958096.133 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:14:58.961Z,1552958098.961 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:15:00.985Z,1552958100.985 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:15:02.997Z,1552958102.997 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:15:06.233Z,1552958106.233 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:15:09.057Z,1552958109.057 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:15:12.289Z,1552958112.289 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:15:15.121Z,1552958115.121 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:15:18.353Z,1552958118.353 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:15:21.181Z,1552958121.181 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:15:24.009Z,1552958124.009 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:15:27.241Z,1552958127.241 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:15:30.069Z,1552958130.069 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:15:33.301Z,1552958133.301 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:15:36.129Z,1552958136.129 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:15:38.953Z,1552958138.953 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:15:40.977Z,1552958140.977 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:15:42.993Z,1552958142.993 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:15:45.017Z,1552958145.017 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:15:48.245Z,1552958148.245 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:15:51.077Z,1552958151.077 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:15:54.309Z,1552958154.309 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:15:57.137Z,1552958157.137 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:15:57.556Z,1552958157.556 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-03-19T01:15:57.556Z,1552958157.556 [Default:CheckIn:C.Wait] Stopped
2019-03-19T01:15:57.556Z,1552958157.556 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-03-19T01:15:57.556Z,1552958157.556 [Default:CheckIn:D] Running Loop=1
2019-03-19T01:15:57.966Z,1552958157.966 [Default:CheckIn:D] Stopped
2019-03-19T01:15:57.966Z,1552958157.966 [Default:CheckIn:E] Running Loop=1
2019-03-19T01:15:58.358Z,1552958158.358 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.660796 min 
2019-03-19T01:15:58.358Z,1552958158.358 [Default:CheckIn:E] Stopped
2019-03-19T01:15:58.358Z,1552958158.358 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-03-19T01:15:58.358Z,1552958158.358 [Default:CheckIn] Stopped
2019-03-19T01:15:58.358Z,1552958158.358 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-03-19T01:15:58.359Z,1552958158.359 [Default:CheckIn](INFO): Running loop #2
2019-03-19T01:15:58.359Z,1552958158.359 [Default:CheckIn] Running Loop=2
2019-03-19T01:15:58.359Z,1552958158.359 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-03-19T01:15:58.359Z,1552958158.359 [Default:CheckIn:Read_GPS] Running Loop=1
2019-03-19T01:15:59.961Z,1552958159.961 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:16:01.985Z,1552958161.985 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:16:04.005Z,1552958164.005 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:16:07.237Z,1552958167.237 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:16:07.260Z,1552958167.260 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-19T01:16:07.260Z,1552958167.260 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2019-03-19T01:16:07.260Z,1552958167.260 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-19T01:16:07.262Z,1552958167.262 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-19T01:16:07.262Z,1552958167.262 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7
2019-03-19T01:16:07.262Z,1552958167.262 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-19T01:16:07.272Z,1552958167.272 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-19T01:16:07.272Z,1552958167.272 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-19T01:16:07.676Z,1552958167.676 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-19T01:16:07.676Z,1552958167.676 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2019-03-19T01:16:07.676Z,1552958167.676 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-19T01:16:07.677Z,1552958167.677 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7
2019-03-19T01:16:08.064Z,1552958168.064 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-19T01:16:10.065Z,1552958170.065 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:16:13.297Z,1552958173.297 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:16:16.125Z,1552958176.125 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:16:18.953Z,1552958178.953 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:16:20.973Z,1552958180.973 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:16:22.989Z,1552958182.989 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:16:25.009Z,1552958185.009 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:16:28.245Z,1552958188.245 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:16:31.073Z,1552958191.073 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:16:34.305Z,1552958194.305 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:16:37.129Z,1552958197.129 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:16:39.957Z,1552958199.957 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:16:41.984Z,1552958201.984 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:16:43.997Z,1552958203.997 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:16:46.021Z,1552958206.021 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:16:49.253Z,1552958209.253 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:16:52.081Z,1552958212.081 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:16:55.309Z,1552958215.309 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:16:58.137Z,1552958218.137 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:17:00.969Z,1552958220.969 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:17:02.985Z,1552958222.985 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:17:05.009Z,1552958225.009 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:17:08.241Z,1552958228.241 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:17:11.065Z,1552958231.065 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:17:14.301Z,1552958234.301 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:17:17.129Z,1552958237.129 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:17:18.755Z,1552958238.755 [CBIT](INFO): Clearing failed state for component RudderServo
2019-03-19T01:17:18.755Z,1552958238.755 [RudderServo] No Fault, FailCount= 3
2019-03-19T01:17:19.953Z,1552958239.953 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:17:21.977Z,1552958241.977 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:17:23.233Z,1552958243.233 [RudderServo](FAULT): Overload Error
2019-03-19T01:17:23.233Z,1552958243.233 [RudderServo] Hardware Fault, FailCount= 1
2019-03-19T01:17:23.233Z,1552958243.233 [RudderServo](ERROR): Hardware Fault
2019-03-19T01:17:23.273Z,1552958243.273 [CBIT](ERROR): Hardware Fault in component: RudderServo
2019-03-19T01:17:23.612Z,1552958243.612 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-03-19T01:17:23.612Z,1552958243.612 [RudderServo](INFO): Powering down
2019-03-19T01:17:23.997Z,1552958243.997 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:17:24.445Z,1552958244.445 [RudderServo](DEBUG): Initializing EZServoServo.
2019-03-19T01:17:24.566Z,1552958244.566 [RudderServo](DEBUG): Initializing RudderServo.
2019-03-19T01:17:24.570Z,1552958244.570 [CBIT](INFO): Clearing failed state for component RudderServo
2019-03-19T01:17:24.570Z,1552958244.570 [RudderServo] No Fault, FailCount= 1
2019-03-19T01:17:26.013Z,1552958246.013 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:17:29.245Z,1552958249.245 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:17:29.297Z,1552958249.297 [RudderServo](FAULT): Overload Error
2019-03-19T01:17:29.297Z,1552958249.297 [RudderServo] Hardware Fault, FailCount= 2
2019-03-19T01:17:29.297Z,1552958249.297 [RudderServo](ERROR): Hardware Fault
2019-03-19T01:17:29.337Z,1552958249.337 [CBIT](ERROR): Hardware Fault in component: RudderServo
2019-03-19T01:17:29.683Z,1552958249.683 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-03-19T01:17:29.683Z,1552958249.683 [RudderServo](INFO): Powering down
2019-03-19T01:17:30.484Z,1552958250.484 [RudderServo](DEBUG): Initializing EZServoServo.
2019-03-19T01:17:30.602Z,1552958250.602 [RudderServo](DEBUG): Initializing RudderServo.
2019-03-19T01:17:30.607Z,1552958250.607 [CBIT](INFO): Clearing failed state for component RudderServo
2019-03-19T01:17:30.607Z,1552958250.607 [RudderServo] No Fault, FailCount= 2
2019-03-19T01:17:32.073Z,1552958252.073 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:17:35.305Z,1552958255.305 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:17:35.357Z,1552958255.357 [RudderServo](FAULT): Overload Error
2019-03-19T01:17:35.357Z,1552958255.357 [RudderServo] Hardware Fault, FailCount= 3
2019-03-19T01:17:35.357Z,1552958255.357 [RudderServo](ERROR): Hardware Fault
2019-03-19T01:17:35.401Z,1552958255.401 [CBIT](ERROR): Hardware Fault in component: RudderServo
2019-03-19T01:17:35.401Z,1552958255.401 [CBIT](CRITICAL): Hardware Fault in component: RudderServo
2019-03-19T01:17:35.739Z,1552958255.739 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-03-19T01:17:35.739Z,1552958255.739 [RudderServo](INFO): Powering down
2019-03-19T01:17:35.741Z,1552958255.741 [CBIT](INFO): Critical error at 20190319T011735
2019-03-19T01:17:36.539Z,1552958256.539 [RudderServo](DEBUG): Initializing EZServoServo.
2019-03-19T01:17:36.666Z,1552958256.666 [RudderServo](DEBUG): Initializing RudderServo.
2019-03-19T01:17:38.133Z,1552958258.133 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:17:40.965Z,1552958260.965 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:17:42.981Z,1552958262.981 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:17:45.005Z,1552958265.005 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:17:45.033Z,1552958265.033 [CBIT](INFO): Clearing failed state for component ElevatorServo
2019-03-19T01:17:45.033Z,1552958265.033 [ElevatorServo] No Fault, FailCount= 3
2019-03-19T01:17:48.237Z,1552958268.237 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:17:49.489Z,1552958269.489 [ElevatorServo](FAULT): Overload Error
2019-03-19T01:17:49.489Z,1552958269.489 [ElevatorServo] Hardware Fault, FailCount= 1
2019-03-19T01:17:49.489Z,1552958269.489 [ElevatorServo](ERROR): Hardware Fault
2019-03-19T01:17:49.533Z,1552958269.533 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2019-03-19T01:17:49.866Z,1552958269.866 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-03-19T01:17:49.866Z,1552958269.866 [ElevatorServo](INFO): Powering down
2019-03-19T01:17:50.678Z,1552958270.678 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-03-19T01:17:50.798Z,1552958270.798 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-03-19T01:17:50.803Z,1552958270.803 [CBIT](INFO): Clearing failed state for component ElevatorServo
2019-03-19T01:17:50.803Z,1552958270.803 [ElevatorServo] No Fault, FailCount= 1
2019-03-19T01:17:51.061Z,1552958271.061 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:17:54.297Z,1552958274.297 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:17:55.953Z,1552958275.953 [ElevatorServo](FAULT): Overload Error
2019-03-19T01:17:55.953Z,1552958275.953 [ElevatorServo] Hardware Fault, FailCount= 2
2019-03-19T01:17:55.953Z,1552958275.953 [ElevatorServo](ERROR): Hardware Fault
2019-03-19T01:17:56.005Z,1552958276.005 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2019-03-19T01:17:56.334Z,1552958276.334 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-03-19T01:17:56.334Z,1552958276.334 [ElevatorServo](INFO): Powering down
2019-03-19T01:17:57.125Z,1552958277.125 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:17:57.155Z,1552958277.155 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-03-19T01:17:57.270Z,1552958277.270 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-03-19T01:17:57.274Z,1552958277.274 [CBIT](INFO): Clearing failed state for component ElevatorServo
2019-03-19T01:17:57.274Z,1552958277.274 [ElevatorServo] No Fault, FailCount= 2
2019-03-19T01:17:59.949Z,1552958279.949 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:18:01.973Z,1552958281.973 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:18:02.429Z,1552958282.429 [ElevatorServo](FAULT): Overload Error
2019-03-19T01:18:02.429Z,1552958282.429 [ElevatorServo] Hardware Fault, FailCount= 3
2019-03-19T01:18:02.429Z,1552958282.429 [ElevatorServo](ERROR): Hardware Fault
2019-03-19T01:18:02.470Z,1552958282.470 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2019-03-19T01:18:02.471Z,1552958282.471 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo
2019-03-19T01:18:02.811Z,1552958282.811 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-03-19T01:18:02.811Z,1552958282.811 [ElevatorServo](INFO): Powering down
2019-03-19T01:18:02.813Z,1552958282.813 [CBIT](INFO): Critical error at 20190319T011802
2019-03-19T01:18:03.602Z,1552958283.602 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-03-19T01:18:03.718Z,1552958283.718 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-03-19T01:18:03.993Z,1552958283.993 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:18:06.009Z,1552958286.009 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:18:08.444Z,1552958288.444 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-19T01:18:08.444Z,1552958288.444 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2019-03-19T01:18:08.444Z,1552958288.444 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-19T01:18:08.445Z,1552958288.445 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-19T01:18:08.445Z,1552958288.445 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 8
2019-03-19T01:18:08.446Z,1552958288.446 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-19T01:18:08.519Z,1552958288.519 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-19T01:18:08.520Z,1552958288.520 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-19T01:18:08.861Z,1552958288.861 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-19T01:18:08.861Z,1552958288.861 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2019-03-19T01:18:08.862Z,1552958288.862 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-19T01:18:08.862Z,1552958288.862 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 8
2019-03-19T01:18:09.241Z,1552958289.241 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:18:09.260Z,1552958289.260 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-19T01:18:12.069Z,1552958292.069 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:18:15.305Z,1552958295.305 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:18:18.133Z,1552958298.133 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:18:20.961Z,1552958300.961 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:18:22.977Z,1552958302.977 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:18:25.001Z,1552958305.001 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:18:28.237Z,1552958308.237 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:18:31.057Z,1552958311.057 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:18:34.293Z,1552958314.293 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:18:37.121Z,1552958317.121 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:18:40.353Z,1552958320.353 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:18:43.177Z,1552958323.177 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:18:46.009Z,1552958326.009 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:18:49.245Z,1552958329.245 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:18:52.065Z,1552958332.065 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:18:55.297Z,1552958335.297 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:18:58.129Z,1552958338.129 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:19:00.957Z,1552958340.957 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:19:02.973Z,1552958342.973 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:19:04.997Z,1552958344.997 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:19:08.229Z,1552958348.229 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:19:11.057Z,1552958351.057 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:19:14.289Z,1552958354.289 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:19:17.117Z,1552958357.117 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:19:20.345Z,1552958360.345 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:19:23.177Z,1552958363.177 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:19:26.001Z,1552958366.001 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:19:29.233Z,1552958369.233 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:19:32.061Z,1552958372.061 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:19:35.297Z,1552958375.297 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:19:38.121Z,1552958378.121 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:19:41.353Z,1552958381.353 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:19:44.181Z,1552958384.181 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:19:47.013Z,1552958387.013 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:19:50.245Z,1552958390.245 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:19:53.073Z,1552958393.073 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:19:56.301Z,1552958396.301 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:19:59.133Z,1552958399.133 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:20:01.961Z,1552958401.961 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:20:03.981Z,1552958403.981 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:20:05.997Z,1552958405.997 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:20:09.233Z,1552958409.233 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:20:09.662Z,1552958409.662 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-19T01:20:09.662Z,1552958409.662 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2019-03-19T01:20:09.662Z,1552958409.662 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-19T01:20:09.664Z,1552958409.664 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-19T01:20:09.664Z,1552958409.664 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 9
2019-03-19T01:20:09.664Z,1552958409.664 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-19T01:20:09.674Z,1552958409.674 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-19T01:20:09.674Z,1552958409.674 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-19T01:20:10.085Z,1552958410.085 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-19T01:20:10.085Z,1552958410.085 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2019-03-19T01:20:10.086Z,1552958410.086 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-19T01:20:10.086Z,1552958410.086 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 9
2019-03-19T01:20:10.452Z,1552958410.452 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-19T01:20:12.057Z,1552958412.057 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:20:15.293Z,1552958415.293 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:20:18.121Z,1552958418.121 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:20:20.949Z,1552958420.949 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:20:22.965Z,1552958422.965 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:20:24.985Z,1552958424.985 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:20:27.009Z,1552958427.009 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:20:30.237Z,1552958430.237 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:20:33.069Z,1552958433.069 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:20:36.301Z,1552958436.301 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:20:39.129Z,1552958439.129 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:20:41.953Z,1552958441.953 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:20:43.977Z,1552958443.977 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:20:45.993Z,1552958445.993 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:20:48.017Z,1552958448.017 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:20:51.249Z,1552958451.249 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:20:54.077Z,1552958454.077 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:20:57.309Z,1552958457.309 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:20:58.531Z,1552958458.531 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-03-19T01:15:58.4Z
2019-03-19T01:20:58.531Z,1552958458.531 [Default:CheckIn:Read_GPS] Stopped
2019-03-19T01:20:58.531Z,1552958458.531 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-03-19T01:21:00.133Z,1552958460.133 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:21:02.961Z,1552958462.961 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:21:04.981Z,1552958464.981 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:21:05.052Z,1552958465.052 [DataOverHttps](INFO): Sending 93 bytes from file Logs/20190319T010151/Courier0007.lzma
2019-03-19T01:21:05.858Z,1552958465.858 [DataOverHttps](INFO): Moved sent file to Logs/20190319T010151/Courier0007.lzma.bak
2019-03-19T01:21:05.858Z,1552958465.858 [DataOverHttps](INFO): SBD MOMSN=10190402
2019-03-19T01:21:07.001Z,1552958467.001 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:21:10.233Z,1552958470.233 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:21:13.061Z,1552958473.061 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:21:16.293Z,1552958476.293 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:21:18.809Z,1552958478.809 [DataOverHttps](INFO): Sending 420 bytes from file Logs/20190319T010151/Express0008.lzma
2019-03-19T01:21:19.125Z,1552958479.125 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:21:19.614Z,1552958479.614 [DataOverHttps](INFO): Moved sent file to Logs/20190319T010151/Express0008.lzma.bak
2019-03-19T01:21:19.614Z,1552958479.614 [DataOverHttps](INFO): SBD MOMSN=10190406
2019-03-19T01:21:21.949Z,1552958481.949 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:21:22.778Z,1552958482.778 [Default:CheckIn:Read_Iridium] Stopped
2019-03-19T01:21:22.778Z,1552958482.778 [Default:CheckIn:C.Wait] Running Loop=1
2019-03-19T01:21:22.778Z,1552958482.778 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-03-19T01:21:23.969Z,1552958483.969 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:21:25.989Z,1552958485.989 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:21:28.009Z,1552958488.009 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:21:31.245Z,1552958491.245 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:21:34.069Z,1552958494.069 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:21:37.305Z,1552958497.305 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:21:40.129Z,1552958500.129 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:21:42.957Z,1552958502.957 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:21:44.981Z,1552958504.981 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:21:47.001Z,1552958507.001 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:21:50.233Z,1552958510.233 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:21:53.061Z,1552958513.061 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:21:56.293Z,1552958516.293 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:21:59.121Z,1552958519.121 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:22:01.945Z,1552958521.945 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:22:03.969Z,1552958523.969 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:22:05.985Z,1552958525.985 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:22:09.220Z,1552958529.220 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:22:10.844Z,1552958530.844 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-19T01:22:10.844Z,1552958530.844 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2019-03-19T01:22:10.844Z,1552958530.844 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-19T01:22:10.845Z,1552958530.845 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-19T01:22:10.845Z,1552958530.845 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 10
2019-03-19T01:22:10.845Z,1552958530.845 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-19T01:22:10.856Z,1552958530.856 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-19T01:22:10.856Z,1552958530.856 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-19T01:22:11.261Z,1552958531.261 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-19T01:22:11.261Z,1552958531.261 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2019-03-19T01:22:11.262Z,1552958531.262 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-19T01:22:11.262Z,1552958531.262 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 10
2019-03-19T01:22:11.652Z,1552958531.652 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-19T01:22:12.045Z,1552958532.045 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:22:15.281Z,1552958535.281 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:22:18.105Z,1552958538.105 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:22:21.337Z,1552958541.337 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:22:24.169Z,1552958544.169 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:22:26.993Z,1552958546.993 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:22:30.229Z,1552958550.229 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:22:33.057Z,1552958553.057 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:22:36.289Z,1552958556.289 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:22:39.117Z,1552958559.117 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:22:42.345Z,1552958562.345 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:22:45.173Z,1552958565.173 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:22:48.005Z,1552958568.005 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:22:51.237Z,1552958571.237 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:22:54.065Z,1552958574.065 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:22:57.295Z,1552958577.295 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:23:00.125Z,1552958580.125 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:23:03.357Z,1552958583.357 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:23:06.185Z,1552958586.185 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:23:09.009Z,1552958589.009 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:23:12.241Z,1552958592.241 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:23:15.069Z,1552958595.069 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:23:18.301Z,1552958598.301 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:23:21.129Z,1552958601.129 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:23:23.950Z,1552958603.950 [NAL9602](FAULT): GPS failed to acquire within timeout.
2019-03-19T01:23:23.950Z,1552958603.950 [NAL9602] Data Fault, FailCount= 2
2019-03-19T01:23:23.950Z,1552958603.950 [NAL9602](ERROR): Data Fault
2019-03-19T01:23:23.979Z,1552958603.979 [CBIT](ERROR): Data Fault in component: NAL9602
2019-03-19T01:23:24.351Z,1552958604.351 [NAL9602](INFO): Powering down
2019-03-19T01:23:25.196Z,1552958605.196 [CBIT](INFO): Clearing failed state for component NAL9602
2019-03-19T01:23:25.196Z,1552958605.196 [NAL9602] No Fault, FailCount= 2
2019-03-19T01:23:54.650Z,1552958634.650 [NAL9602](INFO): Powering up NAL9602
2019-03-19T01:24:05.556Z,1552958645.556 [NAL9602](INFO): NAL9602 initialized
2019-03-19T01:24:05.800Z,1552958645.800 [CommandLine](IMPORTANT): got command restart application
2019-03-19T01:24:06.385Z,1552958646.385 [NAL9602](DEBUG): Fix Requested
2019-03-19T01:24:06.805Z,1552958646.805 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-19T01:24:06.805Z,1552958646.805 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-03-19T01:24:06.981Z,1552958646.981 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2019-03-19T01:24:06.981Z,1552958646.981 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-03-19T01:24:06.982Z,1552958646.982 [CommandLine](INFO): Join timeout helper Thread ID is 1456
2019-03-19T01:24:06.982Z,1552958646.982 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2019-03-19T01:24:06.982Z,1552958646.982 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-03-19T01:24:06.983Z,1552958646.983 [NavChartDb](INFO): Join timeout helper Thread ID is 1457
2019-03-19T01:24:07.085Z,1552958647.085 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-19T01:24:07.085Z,1552958647.085 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-03-19T01:24:07.101Z,1552958647.101 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2019-03-19T01:24:07.101Z,1552958647.101 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-03-19T01:24:07.101Z,1552958647.101 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1458
2019-03-19T01:24:07.265Z,1552958647.265 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-19T01:24:07.265Z,1552958647.265 [WetLabsBB2FL](INFO): Powering down
2019-03-19T01:24:07.266Z,1552958647.266 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-03-19T01:24:07.269Z,1552958647.269 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2019-03-19T01:24:07.269Z,1552958647.269 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-03-19T01:24:07.269Z,1552958647.269 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 1459
2019-03-19T01:24:07.389Z,1552958647.389 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-19T01:24:07.389Z,1552958647.389 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-03-19T01:24:07.409Z,1552958647.409 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2019-03-19T01:24:07.409Z,1552958647.409 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-03-19T01:24:07.409Z,1552958647.409 [Radio_Surface](INFO): Join timeout helper Thread ID is 1460
2019-03-19T01:24:07.749Z,1552958647.749 [Radio_Surface](INFO): Powering down
2019-03-19T01:24:07.750Z,1552958647.750 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-19T01:24:07.750Z,1552958647.750 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-03-19T01:24:07.770Z,1552958647.770 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2019-03-19T01:24:07.770Z,1552958647.770 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-03-19T01:24:07.770Z,1552958647.770 [DataOverHttps](INFO): Join timeout helper Thread ID is 1461
2019-03-19T01:24:08.121Z,1552958648.121 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-19T01:24:08.121Z,1552958648.121 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-03-19T01:24:08.129Z,1552958648.129 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2019-03-19T01:24:08.130Z,1552958648.130 [logger ThreadHandler](INFO): Thread cancelled.
2019-03-19T01:24:08.130Z,1552958648.130 [logger](INFO): Join timeout helper Thread ID is 1462
2019-03-19T01:24:08.173Z,1552958648.173 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-19T01:24:08.173Z,1552958648.173 [logger ThreadHandler](INFO): Thread cancelled.
2019-03-19T01:24:08.189Z,1552958648.189 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2019-03-19T01:24:08.190Z,1552958648.190 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-03-19T01:24:08.190Z,1552958648.190 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2019-03-19T01:24:08.190Z,1552958648.190 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-03-19T01:24:08.190Z,1552958648.190 [controlThread](INFO): Join timeout helper Thread ID is 1463
2019-03-19T01:24:08.377Z,1552958648.377 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-19T01:24:08.377Z,1552958648.377 [controlThread](DEBUG): Uninitializing ControlThread
2019-03-19T01:24:08.377Z,1552958648.377 [NAL9602](INFO): Powering down
2019-03-19T01:24:08.379Z,1552958648.379 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2019-03-19T01:24:08.379Z,1552958648.379 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2019-03-19T01:24:08.380Z,1552958648.380 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2019-03-19T01:24:08.380Z,1552958648.380 [MissionManager](INFO): Uninitializing Mission Default
2019-03-19T01:24:08.380Z,1552958648.380 [Default] Stopped
2019-03-19T01:24:08.381Z,1552958648.381 [Default](DEBUG): Aggregate::uninitialize Default
2019-03-19T01:24:08.381Z,1552958648.381 [Default:B.GoToSurface] Stopped
2019-03-19T01:24:08.381Z,1552958648.381 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-03-19T01:24:08.381Z,1552958648.381 [Default:CheckIn] Stopped
2019-03-19T01:24:08.381Z,1552958648.381 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-03-19T01:24:08.381Z,1552958648.381 [Default:CheckIn:C.Wait] Stopped
2019-03-19T01:24:08.381Z,1552958648.381 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-03-19T01:24:08.383Z,1552958648.383 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2019-03-19T01:24:08.384Z,1552958648.384 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2019-03-19T01:24:08.384Z,1552958648.384 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2019-03-19T01:24:08.384Z,1552958648.384 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2019-03-19T01:24:08.384Z,1552958648.384 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-03-19T01:24:08.385Z,1552958648.385 [BuoyancyServo](INFO): Powering down
2019-03-19T01:24:08.397Z,1552958648.397 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-03-19T01:24:08.397Z,1552958648.397 [ElevatorServo](INFO): Powering down
2019-03-19T01:24:08.398Z,1552958648.398 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-03-19T01:24:08.398Z,1552958648.398 [MassServo](INFO): Powering down
2019-03-19T01:24:08.399Z,1552958648.399 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-03-19T01:24:08.399Z,1552958648.399 [RudderServo](INFO): Powering down
2019-03-19T01:24:08.400Z,1552958648.400 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2019-03-19T01:24:08.400Z,1552958648.400 [ThrusterServo](INFO): Powering down
2019-03-19T01:24:08.400Z,1552958648.400 [SBIT](DEBUG): Uninitialize SBIT Component.
2019-03-19T01:24:08.401Z,1552958648.401 [IBIT](DEBUG): Uninitialize IBIT Component.
2019-03-19T01:24:08.401Z,1552958648.401 [CBIT](DEBUG): Uninitialize CBIT Component.
2019-03-19T01:24:08.401Z,1552958648.401 [CBIT](DEBUG): Powering off loads.
2019-03-19T01:24:08.413Z,1552958648.413 [CBIT](DEBUG): Disabling WDT.
2019-03-19T01:24:08.425Z,1552958648.425 [CBIT](DEBUG): Opening all GF detection circuits.
2019-03-19T01:24:08.425Z,1552958648.425 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-03-19T01:24:08.491Z,1552958648.491 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-03-19T01:24:08.497Z,1552958648.497 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-03-19T01:24:08.528Z,1552958648.528 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-03-19T01:24:08.530Z,1552958648.530 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-03-19T01:24:08.815Z,1552958648.815 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-03-19T01:24:08.870Z,1552958648.870 [logger ThreadHandler](INFO): Thread cancelled.