2018-10-31T19:23:45.751Z,1541013825.751 [Supervisor](DEBUG): Initializing supervisor.
2018-10-31T19:23:45.754Z,1541013825.754 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2018-10-31T19:23:45.755Z,1541013825.755 [SyncHandler](INFO): Protected caller Thread ID is 2979
2018-10-31T19:23:45.755Z,1541013825.755 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2018-10-31T19:23:45.756Z,1541013825.756 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2018-10-31T19:23:45.757Z,1541013825.757 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 2980
2018-10-31T19:23:45.761Z,1541013825.761 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2018-10-31T19:23:45.773Z,1541013825.773 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2018-10-31T19:23:45.774Z,1541013825.774 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2018-10-31T19:23:45.775Z,1541013825.775 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 2981
2018-10-31T19:23:45.775Z,1541013825.775 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2018-10-31T19:23:45.776Z,1541013825.776 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2018-10-31T19:23:45.777Z,1541013825.777 [logger ThreadHandler](INFO): Protected caller Thread ID is 2982
2018-10-31T19:23:45.779Z,1541013825.779 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2018-10-31T19:23:45.779Z,1541013825.779 [Supervisor](INFO): Looking for Config files in directory: Config/
2018-10-31T19:23:45.781Z,1541013825.781 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2018-10-31T19:23:45.973Z,1541013825.973 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2018-10-31T19:23:45.974Z,1541013825.974 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2018-10-31T19:23:46.119Z,1541013826.119 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2018-10-31T19:23:46.120Z,1541013826.120 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2018-10-31T19:23:46.464Z,1541013826.464 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2018-10-31T19:23:46.465Z,1541013826.465 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2018-10-31T19:23:46.802Z,1541013826.802 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2018-10-31T19:23:46.802Z,1541013826.802 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2018-10-31T19:23:46.882Z,1541013826.882 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2018-10-31T19:23:47.092Z,1541013827.092 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2018-10-31T19:23:47.093Z,1541013827.093 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2018-10-31T19:23:47.192Z,1541013827.192 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2018-10-31T19:23:47.192Z,1541013827.192 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2018-10-31T19:23:47.538Z,1541013827.538 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2018-10-31T19:23:47.539Z,1541013827.539 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2018-10-31T19:23:48.020Z,1541013828.020 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2018-10-31T19:23:48.021Z,1541013828.021 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2018-10-31T19:23:48.351Z,1541013828.351 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2018-10-31T19:23:48.352Z,1541013828.352 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2018-10-31T19:23:48.858Z,1541013828.858 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2018-10-31T19:23:48.859Z,1541013828.859 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2018-10-31T19:23:49.068Z,1541013829.068 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2018-10-31T19:23:49.069Z,1541013829.069 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2018-10-31T19:23:49.167Z,1541013829.167 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2018-10-31T19:23:49.168Z,1541013829.168 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2018-10-31T19:23:49.661Z,1541013829.661 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2018-10-31T19:23:49.662Z,1541013829.662 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2018-10-31T19:23:49.768Z,1541013829.768 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2018-10-31T19:23:49.770Z,1541013829.770 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/
2018-10-31T19:23:49.771Z,1541013829.771 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Battery.cfg
2018-10-31T19:23:50.002Z,1541013830.002 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2018-10-31T19:23:50.003Z,1541013830.003 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/BIT.cfg
2018-10-31T19:23:50.102Z,1541013830.102 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Navigation.cfg
2018-10-31T19:23:50.197Z,1541013830.197 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Control.cfg
2018-10-31T19:23:50.299Z,1541013830.299 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Simulator.cfg
2018-10-31T19:23:50.385Z,1541013830.385 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Science.cfg
2018-10-31T19:23:50.521Z,1541013830.521 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Sensor.cfg
2018-10-31T19:23:50.699Z,1541013830.699 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Servo.cfg
2018-10-31T19:23:50.810Z,1541013830.810 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/logger.cfg
2018-10-31T19:23:50.910Z,1541013830.910 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/secure.cfg
2018-10-31T19:23:50.993Z,1541013830.993 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/vehicle.cfg
2018-10-31T19:23:51.195Z,1541013831.195 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/root/
2018-10-31T19:23:51.195Z,1541013831.195 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2018-10-31T19:23:51.205Z,1541013831.205 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2018-10-31T19:23:51.370Z,1541013831.370 [SBIT](DEBUG): Construct Startup Built In Test.
2018-10-31T19:23:51.401Z,1541013831.401 [SBIT] Loaded
2018-10-31T19:23:51.402Z,1541013831.402 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2018-10-31T19:23:51.402Z,1541013831.402 [IBIT](DEBUG): Construct Initiated Built In Test.
2018-10-31T19:23:51.430Z,1541013831.430 [IBIT] Loaded
2018-10-31T19:23:51.431Z,1541013831.431 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2018-10-31T19:23:51.434Z,1541013831.434 [CBIT](DEBUG): Construct Continuous Built In Test.
2018-10-31T19:23:51.595Z,1541013831.595 [CBIT] Loaded
2018-10-31T19:23:51.595Z,1541013831.595 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2018-10-31T19:23:51.596Z,1541013831.596 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2018-10-31T19:23:51.596Z,1541013831.596 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2018-10-31T19:23:56.620Z,1541013836.620 [VerticalControl](DEBUG): Construct VerticalControl.
2018-10-31T19:23:56.723Z,1541013836.723 [VerticalControl] Loaded
2018-10-31T19:23:56.723Z,1541013836.723 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2018-10-31T19:23:56.724Z,1541013836.724 [HorizontalControl](DEBUG): Construct HorizontalControl.
2018-10-31T19:23:56.786Z,1541013836.786 [HorizontalControl] Loaded
2018-10-31T19:23:56.786Z,1541013836.786 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2018-10-31T19:23:56.787Z,1541013836.787 [SpeedControl](DEBUG): Construct SpeedControl.
2018-10-31T19:23:56.792Z,1541013836.792 [SpeedControl] Loaded
2018-10-31T19:23:56.793Z,1541013836.793 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2018-10-31T19:23:56.793Z,1541013836.793 [LoopControl](DEBUG): Construct LoopControl.
2018-10-31T19:23:56.794Z,1541013836.794 [LoopControl] Loaded
2018-10-31T19:23:56.794Z,1541013836.794 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2018-10-31T19:23:56.795Z,1541013836.795 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2018-10-31T19:23:56.795Z,1541013836.795 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2018-10-31T19:23:56.854Z,1541013836.854 [DepthRateCalculator] Loaded
2018-10-31T19:23:56.855Z,1541013836.855 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2018-10-31T19:23:56.860Z,1541013836.860 [PitchRateCalculator] Loaded
2018-10-31T19:23:56.860Z,1541013836.860 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2018-10-31T19:23:56.876Z,1541013836.876 [SpeedCalculator] Loaded
2018-10-31T19:23:56.877Z,1541013836.877 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2018-10-31T19:23:56.899Z,1541013836.899 [TempGradientCalculator] Loaded
2018-10-31T19:23:56.899Z,1541013836.899 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2018-10-31T19:23:56.904Z,1541013836.904 [YawRateCalculator] Loaded
2018-10-31T19:23:56.905Z,1541013836.905 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2018-10-31T19:23:56.935Z,1541013836.935 [ElevatorOffsetCalculator] Loaded
2018-10-31T19:23:56.936Z,1541013836.936 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2018-10-31T19:23:56.936Z,1541013836.936 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2018-10-31T19:23:56.937Z,1541013836.937 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2018-10-31T19:23:57.044Z,1541013837.044 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2018-10-31T19:23:57.045Z,1541013837.045 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2018-10-31T19:23:57.344Z,1541013837.344 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2018-10-31T19:23:57.345Z,1541013837.345 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2018-10-31T19:23:57.462Z,1541013837.462 [DeadReckonUsingMultipleVelocitySources] Loaded
2018-10-31T19:23:57.462Z,1541013837.462 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2018-10-31T19:23:57.518Z,1541013837.518 [DeadReckonUsingSpeedCalculator] Loaded
2018-10-31T19:23:57.518Z,1541013837.518 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2018-10-31T19:23:57.535Z,1541013837.535 [NavChart] Loaded
2018-10-31T19:23:57.536Z,1541013837.536 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2018-10-31T19:23:57.540Z,1541013837.540 [UniversalFixResidualReporter] Loaded
2018-10-31T19:23:57.540Z,1541013837.540 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2018-10-31T19:23:57.540Z,1541013837.540 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2018-10-31T19:23:57.541Z,1541013837.541 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2018-10-31T19:23:57.565Z,1541013837.565 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2018-10-31T19:23:57.566Z,1541013837.566 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2018-10-31T19:23:57.867Z,1541013837.867 [CTD_NeilBrown] Loaded
2018-10-31T19:23:57.867Z,1541013837.867 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2018-10-31T19:23:57.869Z,1541013837.869 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 406DC4E0
2018-10-31T19:23:57.869Z,1541013837.869 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 3061
2018-10-31T19:23:57.915Z,1541013837.915 [WetLabsSeaOWL_UV_A] Loaded
2018-10-31T19:23:57.916Z,1541013837.916 [ComponentRegistry](DEBUG): Component "WetLabsSeaOWL_UV_A" handled in its own thread.
2018-10-31T19:23:57.917Z,1541013837.917 [WetLabsSeaOWL_UV_A ThreadHandler](DEBUG): Created PCaller Thread at 4070C4E0
2018-10-31T19:23:57.917Z,1541013837.917 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Protected caller Thread ID is 3062
2018-10-31T19:23:57.918Z,1541013837.918 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2018-10-31T19:23:57.918Z,1541013837.918 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2018-10-31T19:23:58.322Z,1541013838.322 [AHRS_M2] Loaded
2018-10-31T19:23:58.323Z,1541013838.323 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2018-10-31T19:23:58.624Z,1541013838.624 [DataOverHttps] Loaded
2018-10-31T19:23:58.625Z,1541013838.625 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2018-10-31T19:23:58.638Z,1541013838.638 [Depth_Keller] Loaded
2018-10-31T19:23:58.638Z,1541013838.638 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2018-10-31T19:23:58.643Z,1541013838.643 [DropWeight] Loaded
2018-10-31T19:23:58.644Z,1541013838.644 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2018-10-31T19:23:58.740Z,1541013838.740 [NAL9602] Loaded
2018-10-31T19:23:58.740Z,1541013838.740 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2018-10-31T19:23:58.746Z,1541013838.746 [Onboard] Loaded
2018-10-31T19:23:58.746Z,1541013838.746 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2018-10-31T19:23:58.753Z,1541013838.753 [Radio_Surface] Loaded
2018-10-31T19:23:58.753Z,1541013838.753 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2018-10-31T19:23:58.754Z,1541013838.754 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4096D4E0
2018-10-31T19:23:58.755Z,1541013838.755 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 3063
2018-10-31T19:23:58.784Z,1541013838.784 [RDI_Pathfinder] Loaded
2018-10-31T19:23:58.784Z,1541013838.784 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2018-10-31T19:23:58.791Z,1541013838.791 [SCPI] Loaded
2018-10-31T19:23:58.791Z,1541013838.791 [ComponentRegistry](DEBUG): SyncComponent "SCPI" handled in the control thread.
2018-10-31T19:24:00.671Z,1541013840.671 [BPC1] Loaded
2018-10-31T19:24:00.671Z,1541013840.671 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2018-10-31T19:24:00.672Z,1541013840.672 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2018-10-31T19:24:00.672Z,1541013840.672 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2018-10-31T19:24:00.799Z,1541013840.799 [BuoyancyServo] Loaded
2018-10-31T19:24:00.799Z,1541013840.799 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2018-10-31T19:24:00.811Z,1541013840.811 [ElevatorServo] Loaded
2018-10-31T19:24:00.811Z,1541013840.811 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2018-10-31T19:24:00.822Z,1541013840.822 [MassServo] Loaded
2018-10-31T19:24:00.823Z,1541013840.823 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2018-10-31T19:24:00.834Z,1541013840.834 [RudderServo] Loaded
2018-10-31T19:24:00.834Z,1541013840.834 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2018-10-31T19:24:00.845Z,1541013840.845 [ThrusterServo] Loaded
2018-10-31T19:24:00.846Z,1541013840.846 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2018-10-31T19:24:00.846Z,1541013840.846 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2018-10-31T19:24:00.847Z,1541013840.847 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2018-10-31T19:24:00.981Z,1541013840.981 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2018-10-31T19:24:00.982Z,1541013840.982 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2018-10-31T19:24:01.021Z,1541013841.021 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2018-10-31T19:24:01.024Z,1541013841.024 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2018-10-31T19:24:01.025Z,1541013841.025 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2018-10-31T19:24:01.032Z,1541013841.032 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2018-10-31T19:24:01.033Z,1541013841.033 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A164E0
2018-10-31T19:24:01.034Z,1541013841.034 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 3064
2018-10-31T19:24:01.039Z,1541013841.039 [Supervisor](INFO): Main Thread ID is 2829
2018-10-31T19:24:01.039Z,1541013841.039 [Supervisor](DEBUG): Running supervisor.
2018-10-31T19:24:01.039Z,1541013841.039 [CommandLine ThreadHandler](INFO): Handler Thread ID is 3065
2018-10-31T19:24:01.042Z,1541013841.042 [controlThread ThreadHandler](INFO): Handler Thread ID is 3066
2018-10-31T19:24:01.042Z,1541013841.042 [controlThread](DEBUG): Initializing ControlThread
2018-10-31T19:24:01.043Z,1541013841.043 [SBIT](INFO): Initialize SBIT Component.
2018-10-31T19:24:01.044Z,1541013841.044 [SBIT](IMPORTANT): git: 2018-10-09-47-gb031a61
2018-10-31T19:24:01.044Z,1541013841.044 [SBIT](INFO): git hash: b031a61a3b9dd9d2ca8d26728acee3a82fbd82a1
2018-10-31T19:24:01.044Z,1541013841.044 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2018-10-31T19:24:01.044Z,1541013841.044 [SBIT](IMPORTANT): Kernel Version:#2 PREEMPT Thu Jan 11 20:13:48 PST 2018
2018-10-31T19:24:01.046Z,1541013841.046 [SBIT](INFO): Beginning SBIT in 28.000000 seconds.
2018-10-31T19:24:01.046Z,1541013841.046 [IBIT](INFO): Initialize IBIT Component.
2018-10-31T19:24:01.047Z,1541013841.047 [CBIT](DEBUG): Initialize CBIT Component.
2018-10-31T19:24:01.047Z,1541013841.047 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2018-10-31T19:24:01.048Z,1541013841.048 [logger ThreadHandler](INFO): Handler Thread ID is 3067
2018-10-31T19:24:01.077Z,1541013841.077 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 3068
2018-10-31T19:24:01.078Z,1541013841.078 [CTD_NeilBrown](INFO): Powering down
2018-10-31T19:24:01.097Z,1541013841.097 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Handler Thread ID is 3069
2018-10-31T19:24:01.098Z,1541013841.098 [WetLabsSeaOWL_UV_A](INFO): Powering down
2018-10-31T19:24:01.131Z,1541013841.131 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 3070
2018-10-31T19:24:01.136Z,1541013841.136 [Radio_Surface](INFO): Powering up
2018-10-31T19:24:01.142Z,1541013841.142 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 3071
2018-10-31T19:24:01.145Z,1541013841.145 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2018-10-31T19:24:01.145Z,1541013841.145 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2018-10-31T19:24:01.145Z,1541013841.145 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2018-10-31T19:24:01.145Z,1541013841.145 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2018-10-31T19:24:01.146Z,1541013841.146 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2018-10-31T19:24:01.146Z,1541013841.146 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2018-10-31T19:24:01.146Z,1541013841.146 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2018-10-31T19:24:01.146Z,1541013841.146 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2018-10-31T19:24:01.146Z,1541013841.146 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2018-10-31T19:24:01.147Z,1541013841.147 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2018-10-31T19:24:01.147Z,1541013841.147 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2018-10-31T19:24:01.147Z,1541013841.147 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2018-10-31T19:24:01.147Z,1541013841.147 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2018-10-31T19:24:01.147Z,1541013841.147 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2018-10-31T19:24:01.148Z,1541013841.148 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2018-10-31T19:24:01.148Z,1541013841.148 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2018-10-31T19:24:01.153Z,1541013841.153 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2018-10-31T19:24:01.155Z,1541013841.155 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2018-10-31T19:24:01.156Z,1541013841.156 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2018-10-31T19:24:01.156Z,1541013841.156 [LoopControl](DEBUG): Initialize LoopControlComponent.
2018-10-31T19:24:01.156Z,1541013841.156 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-10-31T19:24:01.157Z,1541013841.157 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2018-10-31T19:24:01.157Z,1541013841.157 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2018-10-31T19:24:01.158Z,1541013841.158 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2018-10-31T19:24:01.158Z,1541013841.158 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2018-10-31T19:24:01.159Z,1541013841.159 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2018-10-31T19:24:01.159Z,1541013841.159 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-10-31T19:24:01.160Z,1541013841.160 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-10-31T19:24:01.160Z,1541013841.160 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-10-31T19:24:01.161Z,1541013841.161 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-31T19:24:01.161Z,1541013841.161 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-31T19:24:01.162Z,1541013841.162 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-31T19:24:01.162Z,1541013841.162 [NavChart](DEBUG): Initialize NavChart Navigation.
2018-10-31T19:24:01.162Z,1541013841.162 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2018-10-31T19:24:01.169Z,1541013841.169 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2018-10-31T19:24:01.197Z,1541013841.197 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2018-10-31T19:24:01.225Z,1541013841.225 [MissionManager](DEBUG):
2018-10-31T19:24:01.225Z,1541013841.225 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2018-10-31T19:24:01.296Z,1541013841.296 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2018-10-31T19:24:01.317Z,1541013841.317 [Default:A.Wait](DEBUG): Construct Wait.
2018-10-31T19:24:01.319Z,1541013841.319 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2018-10-31T19:24:01.338Z,1541013841.338 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2018-10-31T19:24:01.341Z,1541013841.341 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2018-10-31T19:24:01.370Z,1541013841.370 [Default:E.Execute](DEBUG): Construct Execute.
2018-10-31T19:24:01.390Z,1541013841.390 [MissionManager](DEBUG):
0
Wait a moment to see if the scheduler starts a new mission before
starting to actually run Default.
13
Burn on
Dropped weight due to communications timeout.
5
Default mission has been running for
Restarting logs and Default mission.
restart logs
2018-10-31T19:24:01.395Z,1541013841.395 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,RDI_Pathfinder,SCPI,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,
2018-10-31T19:24:01.416Z,1541013841.416 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-10-31T19:24:01.646Z,1541013841.646 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2018-10-31T19:24:01.670Z,1541013841.670 [Depth_Keller](ERROR): Pressure reading out of range: 1913.424561 decibar
2018-10-31T19:24:01.849Z,1541013841.849 [DepthRateCalculator](ERROR): Depth measurement is not active
2018-10-31T19:24:02.053Z,1541013842.053 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2018-10-31T19:24:02.057Z,1541013842.057 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2018-10-31T19:24:02.081Z,1541013842.081 [ElevatorServo](DEBUG): Initializing EZServoServo.
2018-10-31T19:24:02.089Z,1541013842.089 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2018-10-31T19:24:02.111Z,1541013842.111 [MassServo](DEBUG): Initializing EZServoServo.
2018-10-31T19:24:02.125Z,1541013842.125 [MassServo](DEBUG): Initializing MassServo.
2018-10-31T19:24:02.143Z,1541013842.143 [RudderServo](DEBUG): Initializing EZServoServo.
2018-10-31T19:24:02.149Z,1541013842.149 [RudderServo](DEBUG): Initializing RudderServo.
2018-10-31T19:24:02.171Z,1541013842.171 [ThrusterServo](DEBUG): Initializing EZServoServo.
2018-10-31T19:24:02.177Z,1541013842.177 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2018-10-31T19:24:02.325Z,1541013842.325 [DropWeight](CRITICAL): DROP WEIGHT MISSING.
2018-10-31T19:24:02.325Z,1541013842.325 [DropWeight] Hardware Fault, FailCount= 1
2018-10-31T19:24:02.325Z,1541013842.325 [DropWeight](ERROR): Hardware Fault
2018-10-31T19:24:02.357Z,1541013842.357 [DepthRateCalculator](ERROR): Depth measurement is not active
2018-10-31T19:24:02.386Z,1541013842.386 [CommandLine](FAULT): Scheduling is paused
2018-10-31T19:24:02.387Z,1541013842.387 [CBIT](INFO): Critical error at 20181031T192402
2018-10-31T19:24:02.387Z,1541013842.387 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2018-10-31T19:24:02.389Z,1541013842.389 [CBIT](ERROR): Hardware Fault in component: DropWeight
2018-10-31T19:24:02.390Z,1541013842.390 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2018-10-31T19:24:03.115Z,1541013843.115 [CBIT](INFO): Critical error at 20181031T192402
2018-10-31T19:24:05.049Z,1541013845.049 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:24:05.469Z,1541013845.469 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:24:05.937Z,1541013845.937 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:24:06.445Z,1541013846.445 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:24:07.257Z,1541013847.257 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:24:11.310Z,1541013851.310 [CBIT](CRITICAL): Environmental Failure. Press:14.824734 PSI. Humidity:35%. Temp:25 C. ABORTING MISSION
2018-10-31T19:24:11.701Z,1541013851.701 [CBIT](INFO): Critical error at 20181031T192411
2018-10-31T19:24:17.205Z,1541013857.205 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2018-10-31T19:24:17.205Z,1541013857.205 [AHRS_M2] Data Fault, FailCount= 1
2018-10-31T19:24:17.205Z,1541013857.205 [AHRS_M2](ERROR): Data Fault
2018-10-31T19:24:17.366Z,1541013857.366 [CBIT](ERROR): Data Fault in component: AHRS_M2
2018-10-31T19:24:17.594Z,1541013857.594 [AHRS_M2](INFO): Powering down
2018-10-31T19:24:18.937Z,1541013858.937 [CommandLine](IMPORTANT): got command show best depth
2018-10-31T19:24:18.938Z,1541013858.938 [CommandLine](IMPORTANT): depth best is Depth_Keller.depth
2018-10-31T19:24:21.274Z,1541013861.274 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-10-31T19:24:21.274Z,1541013861.274 [AHRS_M2] No Fault, FailCount= 1
2018-10-31T19:24:21.594Z,1541013861.594 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-10-31T19:24:24.413Z,1541013864.413 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2018-10-31T19:24:24.414Z,1541013864.414 [RDI_Pathfinder] Communications Fault, FailCount= 1
2018-10-31T19:24:24.414Z,1541013864.414 [RDI_Pathfinder](ERROR): Communications Fault
2018-10-31T19:24:24.458Z,1541013864.458 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2018-10-31T19:24:25.117Z,1541013865.117 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:24:25.209Z,1541013865.209 [RDI_Pathfinder](INFO): Powering down
2018-10-31T19:24:25.593Z,1541013865.593 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:24:25.989Z,1541013865.989 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:24:26.077Z,1541013866.077 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-10-31T19:24:26.077Z,1541013866.077 [RDI_Pathfinder] No Fault, FailCount= 1
2018-10-31T19:24:26.413Z,1541013866.413 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:24:26.853Z,1541013866.853 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:24:27.257Z,1541013867.257 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:24:27.685Z,1541013867.685 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:24:28.101Z,1541013868.101 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:24:28.513Z,1541013868.513 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:24:28.921Z,1541013868.921 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:24:28.926Z,1541013868.926 [NAL9602](INFO): Powering up NAL9602
2018-10-31T19:24:29.337Z,1541013869.337 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:24:29.749Z,1541013869.749 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:24:29.848Z,1541013869.848 [SBIT](IMPORTANT): Beginning Startup BIT
2018-10-31T19:24:29.852Z,1541013869.852 [CBIT](IMPORTANT): Beginning ground fault scan
2018-10-31T19:24:30.205Z,1541013870.205 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:24:30.687Z,1541013870.687 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:24:31.099Z,1541013871.099 [CommandLine](IMPORTANT): got command show variable depth_keller
2018-10-31T19:24:31.122Z,1541013871.122 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:24:31.243Z,1541013871.243 [CommandLine](IMPORTANT): Depth_Keller.loadAtStartup (bool)
2018-10-31T19:24:31.243Z,1541013871.243 [CommandLine](IMPORTANT): Depth_Keller.simulateHardware (bool)
2018-10-31T19:24:31.243Z,1541013871.243 [CommandLine](IMPORTANT): Depth_Keller.maxPressBound (decibar)
2018-10-31T19:24:31.244Z,1541013871.244 [CommandLine](IMPORTANT): Depth_Keller.minPressBound (decibar)
2018-10-31T19:24:31.244Z,1541013871.244 [CommandLine](IMPORTANT): Depth_Keller.offset (decibar)
2018-10-31T19:24:31.253Z,1541013871.253 [CommandLine](IMPORTANT): Depth_Keller.power (watt)
2018-10-31T19:24:31.253Z,1541013871.253 [CommandLine](IMPORTANT): Depth_Keller.scale (micropascal)
2018-10-31T19:24:31.339Z,1541013871.339 [CommandLine](IMPORTANT): Depth_Keller.loadControl (none)
2018-10-31T19:24:31.339Z,1541013871.339 [CommandLine](IMPORTANT): Depth_Keller.ad (none)
2018-10-31T19:24:31.340Z,1541013871.340 [CommandLine](IMPORTANT): Depth_Keller.adRes (bit)
2018-10-31T19:24:31.340Z,1541013871.340 [CommandLine](IMPORTANT): Depth_Keller.adTimeout (millisecond)
2018-10-31T19:24:31.340Z,1541013871.340 [CommandLine](IMPORTANT): Depth_Keller.adVref (volt)
2018-10-31T19:24:31.412Z,1541013871.412 [CommandLine](IMPORTANT): Depth_Keller.depth (meter)
2018-10-31T19:24:31.413Z,1541013871.413 [CommandLine](IMPORTANT): Depth_Keller.sea_water_pressure (decibar)
2018-10-31T19:24:31.461Z,1541013871.461 [CommandLine](IMPORTANT): Depth_Keller.durationOfLastRun (second)
2018-10-31T19:24:31.633Z,1541013871.633 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:24:31.633Z,1541013871.633 [AHRS_M2](FAULT): Failed to initialize within timeout.
2018-10-31T19:24:31.633Z,1541013871.633 [AHRS_M2] Communications Fault, FailCount= 2
2018-10-31T19:24:31.633Z,1541013871.633 [AHRS_M2](ERROR): Communications Fault
2018-10-31T19:24:31.842Z,1541013871.842 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2018-10-31T19:24:31.961Z,1541013871.961 [AHRS_M2](INFO): Powering down
2018-10-31T19:24:35.538Z,1541013875.538 [CommandLine](IMPORTANT): got command show best depth
2018-10-31T19:24:35.538Z,1541013875.538 [CommandLine](IMPORTANT): depth best is Depth_Keller.depth
2018-10-31T19:24:35.783Z,1541013875.783 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-10-31T19:24:35.784Z,1541013875.784 [AHRS_M2] No Fault, FailCount= 2
2018-10-31T19:24:35.954Z,1541013875.954 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-10-31T19:24:38.010Z,1541013878.010 [CommandLine](IMPORTANT): got command get depth
2018-10-31T19:24:38.010Z,1541013878.010 [CommandLine](IMPORTANT): depth 0.268299 m
2018-10-31T19:24:39.477Z,1541013879.477 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:24:40.029Z,1541013880.029 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:24:40.461Z,1541013880.461 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:24:40.466Z,1541013880.466 [NAL9602](INFO): NAL9602 initialized
2018-10-31T19:24:40.905Z,1541013880.905 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:24:41.266Z,1541013881.266 [CommandLine](IMPORTANT): got command get depth
2018-10-31T19:24:41.266Z,1541013881.266 [CommandLine](IMPORTANT): depth 0.253375 m
2018-10-31T19:24:41.517Z,1541013881.517 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:24:41.642Z,1541013881.642 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.010092
CHAN A1 (24V): 0.004117
CHAN A2 (12V): -0.007279
CHAN A3 (5V): -0.001934
CHAN B0 (3.3V): 0.000381
CHAN B1 (3.15aV): -0.000063
CHAN B2 (3.15bV): 0.000199
CHAN B3 (GND): 0.002021
OPEN: 0.004802
Full Scale Calc: 4.765 mA, -1.589 mA
2018-10-31T19:24:41.753Z,1541013881.753 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:24:42.361Z,1541013882.361 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:24:42.837Z,1541013882.837 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:24:42.940Z,1541013882.940 [SBIT](FAULT): Mass: EXPECTED:0.009000 ACTUAL:0.003951
2018-10-31T19:24:43.273Z,1541013883.273 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:24:43.733Z,1541013883.733 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:24:44.365Z,1541013884.365 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:24:49.152Z,1541013889.152 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2018-10-31T19:24:49.152Z,1541013889.152 [RDI_Pathfinder] Communications Fault, FailCount= 2
2018-10-31T19:24:49.152Z,1541013889.152 [RDI_Pathfinder](ERROR): Communications Fault
2018-10-31T19:24:49.278Z,1541013889.278 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2018-10-31T19:24:49.621Z,1541013889.621 [RDI_Pathfinder](INFO): Powering down
2018-10-31T19:24:50.538Z,1541013890.538 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-10-31T19:24:50.538Z,1541013890.538 [RDI_Pathfinder] No Fault, FailCount= 2
2018-10-31T19:24:54.313Z,1541013894.313 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2018-10-31T19:24:54.313Z,1541013894.313 [AHRS_M2] Data Fault, FailCount= 3
2018-10-31T19:24:54.313Z,1541013894.313 [AHRS_M2](ERROR): Data Fault
2018-10-31T19:24:54.409Z,1541013894.409 [CBIT](ERROR): Data Fault in component: AHRS_M2
2018-10-31T19:24:54.702Z,1541013894.702 [AHRS_M2](INFO): Powering down
2018-10-31T19:24:58.353Z,1541013898.353 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-10-31T19:24:58.353Z,1541013898.353 [AHRS_M2] No Fault, FailCount= 3
2018-10-31T19:24:58.702Z,1541013898.702 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-10-31T19:25:01.997Z,1541013901.997 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:25:02.163Z,1541013902.163 [CommandLine](IMPORTANT): got command failComponent
2018-10-31T19:25:02.164Z,1541013902.164 [CommandLine](IMPORTANT): Failed components:
2018-10-31T19:25:02.164Z,1541013902.164 [CommandLine](IMPORTANT): DropWeight: Hardware Fault
2018-10-31T19:25:02.401Z,1541013902.401 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:25:02.797Z,1541013902.797 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:25:03.197Z,1541013903.197 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:25:03.597Z,1541013903.597 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:25:03.997Z,1541013903.997 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:25:04.401Z,1541013904.401 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:25:04.801Z,1541013904.801 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:25:05.197Z,1541013905.197 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:25:05.601Z,1541013905.601 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:25:06.001Z,1541013906.001 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:25:06.405Z,1541013906.405 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:25:06.801Z,1541013906.801 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:25:07.198Z,1541013907.198 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:25:07.598Z,1541013907.598 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:25:08.001Z,1541013908.001 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:25:08.401Z,1541013908.401 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:25:08.801Z,1541013908.801 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:25:08.801Z,1541013908.801 [AHRS_M2](FAULT): Failed to initialize within timeout.
2018-10-31T19:25:08.801Z,1541013908.801 [AHRS_M2] Communications Fault, FailCount= 4
2018-10-31T19:25:08.801Z,1541013908.801 [AHRS_M2](ERROR): Communications Fault
2018-10-31T19:25:08.918Z,1541013908.918 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2018-10-31T19:25:09.102Z,1541013909.102 [AHRS_M2](INFO): Powering down
2018-10-31T19:25:12.938Z,1541013912.938 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-10-31T19:25:12.938Z,1541013912.938 [AHRS_M2] No Fault, FailCount= 4
2018-10-31T19:25:13.194Z,1541013913.194 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-10-31T19:25:13.227Z,1541013913.227 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2018-10-31T19:25:13.227Z,1541013913.227 [RDI_Pathfinder] Communications Fault, FailCount= 3
2018-10-31T19:25:13.227Z,1541013913.227 [RDI_Pathfinder](ERROR): Communications Fault
2018-10-31T19:25:13.342Z,1541013913.342 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2018-10-31T19:25:13.342Z,1541013913.342 [CBIT](CRITICAL): Communications Fault in component: RDI_Pathfinder
2018-10-31T19:25:13.693Z,1541013913.693 [RDI_Pathfinder](INFO): Powering down
2018-10-31T19:25:13.820Z,1541013913.820 [CBIT](INFO): Critical error at 20181031T192513
2018-10-31T19:25:16.493Z,1541013916.493 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:25:23.684Z,1541013923.684 [SBIT](CRITICAL): SBIT FAILED
2018-10-31T19:25:23.704Z,1541013923.704 [CBIT](INFO): Critical error at 20181031T192523
2018-10-31T19:25:23.770Z,1541013923.770 [CommandLine](IMPORTANT): got command configSet list
2018-10-31T19:25:23.770Z,1541013923.770 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2018-10-31T19:25:23.771Z,1541013923.771 [CommandLine](IMPORTANT): Aanderaa_O2.loadAtStartup=0 bool;
2018-10-31T19:25:23.771Z,1541013923.771 [CommandLine](IMPORTANT): BPC1.batterySamplingInterval=1 minute;
2018-10-31T19:25:23.771Z,1541013923.771 [CommandLine](IMPORTANT): CTD_NeilBrown.minSalinityBound=-10 practical_salinity_unit;
2018-10-31T19:25:23.771Z,1541013923.771 [CommandLine](IMPORTANT): Express linearApproximation concentration_of_colored_dissolved_organic_matter_in_sea_water_expressed_as_equivalent_mass_fraction_of_quinine_sulfate_dihydrate 1.000000 part_per_billion;
2018-10-31T19:25:23.771Z,1541013923.771 [CommandLine](IMPORTANT): IBIT.batteryVoltageThreshold=13.7 volt;
2018-10-31T19:25:23.771Z,1541013923.771 [CommandLine](IMPORTANT): NAL9602.gpsFailTimeout=10 minute;
2018-10-31T19:25:23.772Z,1541013923.772 [CommandLine](IMPORTANT): RDI_PathfinderUp.loadAtStartup=0 bool;
2018-10-31T19:25:23.772Z,1541013923.772 [CommandLine](IMPORTANT): VerticalControl.buoyancyNeutral=200 cubic_centimeter;
2018-10-31T19:25:23.772Z,1541013923.772 [CommandLine](IMPORTANT): VerticalControl.massDefault=2 millimeter;
2018-10-31T19:25:24.043Z,1541013924.043 [MissionManager](IMPORTANT): Started mission Startup
2018-10-31T19:25:24.043Z,1541013924.043 [Startup] Running Loop=1
2018-10-31T19:25:24.043Z,1541013924.043 [Startup](DEBUG): Aggregate::initialize Startup
2018-10-31T19:25:24.043Z,1541013924.043 [Startup:A.GoToSurface] Running Loop=1
2018-10-31T19:25:24.043Z,1541013924.043 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2018-10-31T19:25:24.044Z,1541013924.044 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2018-10-31T19:25:24.044Z,1541013924.044 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2018-10-31T19:25:24.045Z,1541013924.045 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2018-10-31T19:25:24.045Z,1541013924.045 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2018-10-31T19:25:24.046Z,1541013924.046 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2018-10-31T19:25:24.052Z,1541013924.052 [Startup:StartupSatComms] Running Loop=1
2018-10-31T19:25:24.052Z,1541013924.052 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2018-10-31T19:25:24.052Z,1541013924.052 [Startup:StartupSatComms:A] Running Loop=1
2018-10-31T19:25:24.443Z,1541013924.443 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2018-10-31T19:25:27.205Z,1541013927.205 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2018-10-31T19:25:27.205Z,1541013927.205 [AHRS_M2] Data Fault, FailCount= 5
2018-10-31T19:25:27.205Z,1541013927.205 [AHRS_M2](ERROR): Data Fault
2018-10-31T19:25:27.290Z,1541013927.290 [CBIT](ERROR): Data Fault in component: AHRS_M2
2018-10-31T19:25:27.290Z,1541013927.290 [CBIT](CRITICAL): Data Fault in component: AHRS_M2
2018-10-31T19:25:27.594Z,1541013927.594 [AHRS_M2](INFO): Powering down
2018-10-31T19:25:27.709Z,1541013927.709 [CBIT](INFO): Critical error at 20181031T192527
2018-10-31T19:26:01.237Z,1541013961.237 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-31T19:26:01.237Z,1541013961.237 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2018-10-31T19:26:01.237Z,1541013961.237 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-10-31T19:26:01.238Z,1541013961.238 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-31T19:26:01.239Z,1541013961.239 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2018-10-31T19:26:01.239Z,1541013961.239 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-31T19:26:01.309Z,1541013961.309 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-10-31T19:26:01.309Z,1541013961.309 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-31T19:26:01.644Z,1541013961.644 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-10-31T19:26:01.644Z,1541013961.644 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2018-10-31T19:26:01.645Z,1541013961.645 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-31T19:26:01.661Z,1541013961.661 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2018-10-31T19:26:02.044Z,1541013962.044 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-10-31T19:26:02.060Z,1541013962.060 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-10-31T19:26:02.060Z,1541013962.060 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-10-31T19:26:02.060Z,1541013962.060 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-31T19:26:02.061Z,1541013962.061 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-31T19:26:02.061Z,1541013962.061 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-31T19:26:26.020Z,1541013986.020 [Startup:StartupSatComms:A](INFO): Timed out from 2018-10-31T19:25:24.1Z
2018-10-31T19:26:26.020Z,1541013986.020 [Startup:StartupSatComms:A] Stopped
2018-10-31T19:26:26.020Z,1541013986.020 [Startup:StartupSatComms:B] Running Loop=1
2018-10-31T19:26:26.126Z,1541013986.126 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2018-10-31T19:26:26.843Z,1541013986.843 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004356
2018-10-31T19:26:30.940Z,1541013990.940 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20181009T210039/Courier0007.lzma
2018-10-31T19:26:31.739Z,1541013991.739 [DataOverHttps](INFO): Moved sent file to Logs/20181009T210039/Courier0007.lzma.bak
2018-10-31T19:26:31.739Z,1541013991.739 [DataOverHttps](INFO): SBD MOMSN=8757366
2018-10-31T19:26:40.547Z,1541014000.547 [DataOverHttps](INFO): Sending 312 bytes from file Logs/20181009T211719/Courier0000.lzma
2018-10-31T19:26:41.343Z,1541014001.343 [DataOverHttps](INFO): Moved sent file to Logs/20181009T211719/Courier0000.lzma.bak
2018-10-31T19:26:41.343Z,1541014001.343 [DataOverHttps](INFO): SBD MOMSN=8757368
2018-10-31T19:26:50.336Z,1541014010.336 [DataOverHttps](INFO): Sending 128 bytes from file Logs/20181009T211719/Courier0004.lzma
2018-10-31T19:26:51.135Z,1541014011.135 [DataOverHttps](INFO): Moved sent file to Logs/20181009T211719/Courier0004.lzma.bak
2018-10-31T19:26:51.135Z,1541014011.135 [DataOverHttps](INFO): SBD MOMSN=8757374
2018-10-31T19:27:00.134Z,1541014020.134 [DataOverHttps](INFO): Sending 333 bytes from file Logs/20181009T213951/Courier0000.lzma
2018-10-31T19:27:08.904Z,1541014028.904 [DataOverHttps](INFO): Moved sent file to Logs/20181009T213951/Courier0000.lzma.bak
2018-10-31T19:27:08.904Z,1541014028.904 [DataOverHttps](INFO): SBD MOMSN=8757377
2018-10-31T19:27:17.458Z,1541014037.458 [DataOverHttps](INFO): Sending 203 bytes from file Logs/20181009T213951/Courier0004.lzma
2018-10-31T19:27:18.239Z,1541014038.239 [DataOverHttps](INFO): Moved sent file to Logs/20181009T213951/Courier0004.lzma.bak
2018-10-31T19:27:18.239Z,1541014038.239 [DataOverHttps](INFO): SBD MOMSN=8757384
2018-10-31T19:27:27.035Z,1541014047.035 [Startup:StartupSatComms:B](INFO): Timed out from 2018-10-31T19:26:26.0Z
2018-10-31T19:27:27.035Z,1541014047.035 [Startup:StartupSatComms:B] Stopped
2018-10-31T19:27:27.036Z,1541014047.036 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2018-10-31T19:27:27.036Z,1541014047.036 [Startup:StartupSatComms] Stopped
2018-10-31T19:27:27.036Z,1541014047.036 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2018-10-31T19:27:27.037Z,1541014047.037 [Startup](INFO): Completed Startup
2018-10-31T19:27:27.037Z,1541014047.037 [MissionManager](INFO): Startup is completed.
2018-10-31T19:27:27.037Z,1541014047.037 [MissionManager](INFO): Uninitializing Mission Startup
2018-10-31T19:27:27.037Z,1541014047.037 [Startup] Stopped
2018-10-31T19:27:27.038Z,1541014047.038 [Startup](DEBUG): Aggregate::uninitialize Startup
2018-10-31T19:27:27.038Z,1541014047.038 [Startup:A.GoToSurface] Stopped
2018-10-31T19:27:27.038Z,1541014047.038 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2018-10-31T19:27:27.100Z,1541014047.100 [DataOverHttps](INFO): Sending 169 bytes from file Logs/20181031T182710/Courier0000.lzma
2018-10-31T19:27:27.147Z,1541014047.147 [MissionManager](IMPORTANT): Started mission Default
2018-10-31T19:27:27.148Z,1541014047.148 [Default] Running Loop=1
2018-10-31T19:27:27.148Z,1541014047.148 [Default](DEBUG): Aggregate::initialize Default
2018-10-31T19:27:27.148Z,1541014047.148 [Default:B.GoToSurface] Running Loop=1
2018-10-31T19:27:27.148Z,1541014047.148 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2018-10-31T19:27:27.148Z,1541014047.148 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2018-10-31T19:27:27.148Z,1541014047.148 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2018-10-31T19:27:27.150Z,1541014047.150 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2018-10-31T19:27:27.150Z,1541014047.150 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2018-10-31T19:27:27.150Z,1541014047.150 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2018-10-31T19:27:27.151Z,1541014047.151 [Default:A.Wait] Running Loop=1
2018-10-31T19:27:27.151Z,1541014047.151 [Default:A.Wait](DEBUG): Initialize Wait Component.
2018-10-31T19:27:27.859Z,1541014047.859 [DataOverHttps](INFO): Moved sent file to Logs/20181031T182710/Courier0000.lzma.bak
2018-10-31T19:27:27.859Z,1541014047.859 [DataOverHttps](INFO): SBD MOMSN=8757388
2018-10-31T19:27:40.244Z,1541014060.244 [Default:A.Wait](INFO): Done Waiting.
2018-10-31T19:27:40.244Z,1541014060.244 [Default:A.Wait] Stopped
2018-10-31T19:27:40.244Z,1541014060.244 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2018-10-31T19:27:40.648Z,1541014060.648 [Default:CheckIn] Running Loop=1
2018-10-31T19:27:40.648Z,1541014060.648 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-10-31T19:27:40.648Z,1541014060.648 [Default:CheckIn:Read_GPS] Running Loop=1
2018-10-31T19:27:41.049Z,1541014061.049 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2018-10-31T19:28:02.285Z,1541014082.285 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-31T19:28:02.285Z,1541014082.285 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2018-10-31T19:28:02.285Z,1541014082.285 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-10-31T19:28:02.292Z,1541014082.292 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-31T19:28:02.292Z,1541014082.292 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2018-10-31T19:28:02.292Z,1541014082.292 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-31T19:28:02.312Z,1541014082.312 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-10-31T19:28:02.313Z,1541014082.313 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-31T19:28:02.696Z,1541014082.696 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-10-31T19:28:02.696Z,1541014082.696 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2018-10-31T19:28:02.696Z,1541014082.696 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-31T19:28:02.696Z,1541014082.696 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2018-10-31T19:28:03.080Z,1541014083.080 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-10-31T19:28:03.081Z,1541014083.081 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-10-31T19:28:03.081Z,1541014083.081 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-10-31T19:28:03.082Z,1541014083.082 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-31T19:28:03.082Z,1541014083.082 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-31T19:28:03.083Z,1541014083.083 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-31T19:28:13.398Z,1541014093.398 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-10-31T19:28:13.398Z,1541014093.398 [RDI_Pathfinder] No Fault, FailCount= 3
2018-10-31T19:28:26.557Z,1541014106.557 [RDI_Pathfinder](FAULT): DVL failed to acquire valid data within timeout.
2018-10-31T19:28:26.557Z,1541014106.557 [RDI_Pathfinder] Data Fault, FailCount= 1
2018-10-31T19:28:26.557Z,1541014106.557 [RDI_Pathfinder](ERROR): Data Fault
2018-10-31T19:28:26.612Z,1541014106.612 [CBIT](ERROR): Data Fault in component: RDI_Pathfinder
2018-10-31T19:28:27.025Z,1541014107.025 [RDI_Pathfinder](INFO): Powering down
2018-10-31T19:28:27.797Z,1541014107.797 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-10-31T19:28:27.798Z,1541014107.798 [RDI_Pathfinder] No Fault, FailCount= 1
2018-10-31T19:28:52.264Z,1541014132.264 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2018-10-31T19:28:52.264Z,1541014132.264 [RDI_Pathfinder] Communications Fault, FailCount= 2
2018-10-31T19:28:52.264Z,1541014132.264 [RDI_Pathfinder](ERROR): Communications Fault
2018-10-31T19:28:52.284Z,1541014132.284 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2018-10-31T19:28:52.737Z,1541014132.737 [RDI_Pathfinder](INFO): Powering down
2018-10-31T19:28:53.482Z,1541014133.482 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-10-31T19:28:53.482Z,1541014133.482 [RDI_Pathfinder] No Fault, FailCount= 2
2018-10-31T19:29:17.335Z,1541014157.335 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2018-10-31T19:29:17.335Z,1541014157.335 [RDI_Pathfinder] Communications Fault, FailCount= 3
2018-10-31T19:29:17.335Z,1541014157.335 [RDI_Pathfinder](ERROR): Communications Fault
2018-10-31T19:29:17.387Z,1541014157.387 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2018-10-31T19:29:17.387Z,1541014157.387 [CBIT](CRITICAL): Communications Fault in component: RDI_Pathfinder
2018-10-31T19:29:17.538Z,1541014157.538 [RDI_Pathfinder](INFO): Powering down
2018-10-31T19:29:17.560Z,1541014157.560 [CBIT](INFO): Critical error at 20181031T192917
2018-10-31T19:29:43.802Z,1541014183.802 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2018-10-31T19:30:03.412Z,1541014203.412 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-31T19:30:03.412Z,1541014203.412 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2018-10-31T19:30:03.412Z,1541014203.412 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-10-31T19:30:03.421Z,1541014203.421 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-31T19:30:03.421Z,1541014203.421 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2018-10-31T19:30:03.421Z,1541014203.421 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-31T19:30:03.434Z,1541014203.434 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-10-31T19:30:03.435Z,1541014203.435 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-31T19:30:03.840Z,1541014203.840 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-10-31T19:30:03.840Z,1541014203.840 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2018-10-31T19:30:03.840Z,1541014203.840 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-31T19:30:03.840Z,1541014203.840 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2018-10-31T19:30:04.224Z,1541014204.224 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-10-31T19:30:04.225Z,1541014204.225 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-10-31T19:30:04.225Z,1541014204.225 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-10-31T19:30:04.226Z,1541014204.226 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-31T19:30:04.226Z,1541014204.226 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-31T19:30:04.226Z,1541014204.226 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-31T19:30:28.150Z,1541014228.150 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-10-31T19:30:28.150Z,1541014228.150 [AHRS_M2] No Fault, FailCount= 5
2018-10-31T19:30:28.157Z,1541014228.157 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-10-31T19:30:31.445Z,1541014231.445 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:30:31.853Z,1541014231.853 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:30:32.234Z,1541014232.234 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:30:32.633Z,1541014232.633 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:30:33.429Z,1541014233.429 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:30:34.229Z,1541014234.229 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:30:35.429Z,1541014235.429 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:30:36.629Z,1541014236.629 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:30:37.829Z,1541014237.829 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:30:39.029Z,1541014239.029 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:30:40.229Z,1541014240.229 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:30:41.429Z,1541014241.429 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:30:42.629Z,1541014242.629 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:30:43.369Z,1541014243.369 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2018-10-31T19:30:43.369Z,1541014243.369 [AHRS_M2] Data Fault, FailCount= 1
2018-10-31T19:30:43.369Z,1541014243.369 [AHRS_M2](ERROR): Data Fault
2018-10-31T19:30:43.461Z,1541014243.461 [CBIT](ERROR): Data Fault in component: AHRS_M2
2018-10-31T19:30:43.758Z,1541014243.758 [AHRS_M2](INFO): Powering down
2018-10-31T19:30:47.418Z,1541014247.418 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-10-31T19:30:47.419Z,1541014247.419 [AHRS_M2] No Fault, FailCount= 1
2018-10-31T19:30:47.758Z,1541014247.758 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-10-31T19:30:51.429Z,1541014251.429 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:31:02.957Z,1541014262.957 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2018-10-31T19:31:02.957Z,1541014262.957 [AHRS_M2] Data Fault, FailCount= 2
2018-10-31T19:31:02.957Z,1541014262.957 [AHRS_M2](ERROR): Data Fault
2018-10-31T19:31:03.074Z,1541014263.074 [CBIT](ERROR): Data Fault in component: AHRS_M2
2018-10-31T19:31:03.346Z,1541014263.346 [AHRS_M2](INFO): Powering down
2018-10-31T19:31:06.993Z,1541014266.993 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-10-31T19:31:06.993Z,1541014266.993 [AHRS_M2] No Fault, FailCount= 2
2018-10-31T19:31:07.346Z,1541014267.346 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-10-31T19:31:11.017Z,1541014271.017 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:31:20.957Z,1541014280.957 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2018-10-31T19:31:20.957Z,1541014280.957 [AHRS_M2] Data Fault, FailCount= 3
2018-10-31T19:31:20.957Z,1541014280.957 [AHRS_M2](ERROR): Data Fault
2018-10-31T19:31:21.046Z,1541014281.046 [CBIT](ERROR): Data Fault in component: AHRS_M2
2018-10-31T19:31:21.346Z,1541014281.346 [AHRS_M2](INFO): Powering down
2018-10-31T19:31:25.048Z,1541014285.048 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-10-31T19:31:25.048Z,1541014285.048 [AHRS_M2] No Fault, FailCount= 3
2018-10-31T19:31:25.346Z,1541014285.346 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-10-31T19:31:25.786Z,1541014285.786 [BPC1](INFO): Calculating totals. Valid battery stick count: 54. Valid reserve battery stick count: 6.
2018-10-31T19:31:29.017Z,1541014289.017 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:31:38.933Z,1541014298.933 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2018-10-31T19:31:38.933Z,1541014298.933 [AHRS_M2] Data Fault, FailCount= 4
2018-10-31T19:31:38.933Z,1541014298.933 [AHRS_M2](ERROR): Data Fault
2018-10-31T19:31:39.009Z,1541014299.009 [CBIT](ERROR): Data Fault in component: AHRS_M2
2018-10-31T19:31:39.322Z,1541014299.322 [AHRS_M2](INFO): Powering down
2018-10-31T19:31:42.982Z,1541014302.982 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-10-31T19:31:42.982Z,1541014302.982 [AHRS_M2] No Fault, FailCount= 4
2018-10-31T19:31:43.322Z,1541014303.322 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-10-31T19:31:46.993Z,1541014306.993 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:31:56.933Z,1541014316.933 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2018-10-31T19:31:56.933Z,1541014316.933 [AHRS_M2] Data Fault, FailCount= 5
2018-10-31T19:31:56.933Z,1541014316.933 [AHRS_M2](ERROR): Data Fault
2018-10-31T19:31:57.025Z,1541014317.025 [CBIT](ERROR): Data Fault in component: AHRS_M2
2018-10-31T19:31:57.025Z,1541014317.025 [CBIT](CRITICAL): Data Fault in component: AHRS_M2
2018-10-31T19:31:57.322Z,1541014317.322 [AHRS_M2](INFO): Powering down
2018-10-31T19:31:57.436Z,1541014317.436 [CBIT](INFO): Critical error at 20181031T193157
2018-10-31T19:32:04.578Z,1541014324.578 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-31T19:32:04.578Z,1541014324.578 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2018-10-31T19:32:04.578Z,1541014324.578 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-10-31T19:32:04.580Z,1541014324.580 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-31T19:32:04.580Z,1541014324.580 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4
2018-10-31T19:32:04.580Z,1541014324.580 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-31T19:32:04.592Z,1541014324.592 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-10-31T19:32:04.592Z,1541014324.592 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-31T19:32:04.994Z,1541014324.994 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-10-31T19:32:04.994Z,1541014324.994 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2018-10-31T19:32:04.995Z,1541014324.995 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-31T19:32:04.995Z,1541014324.995 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4
2018-10-31T19:32:05.344Z,1541014325.344 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-10-31T19:32:05.344Z,1541014325.344 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-10-31T19:32:05.344Z,1541014325.344 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-10-31T19:32:05.345Z,1541014325.345 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-31T19:32:05.346Z,1541014325.346 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-31T19:32:05.346Z,1541014325.346 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-31T19:32:17.739Z,1541014337.739 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-10-31T19:32:17.739Z,1541014337.739 [RDI_Pathfinder] No Fault, FailCount= 3
2018-10-31T19:32:30.489Z,1541014350.489 [RDI_Pathfinder](FAULT): DVL failed to acquire valid data within timeout.
2018-10-31T19:32:30.489Z,1541014350.489 [RDI_Pathfinder] Data Fault, FailCount= 1
2018-10-31T19:32:30.490Z,1541014350.490 [RDI_Pathfinder](ERROR): Data Fault
2018-10-31T19:32:30.514Z,1541014350.514 [CBIT](ERROR): Data Fault in component: RDI_Pathfinder
2018-10-31T19:32:30.961Z,1541014350.961 [RDI_Pathfinder](INFO): Powering down
2018-10-31T19:32:31.717Z,1541014351.717 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-10-31T19:32:31.717Z,1541014351.717 [RDI_Pathfinder] No Fault, FailCount= 1
2018-10-31T19:32:40.907Z,1541014360.907 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-10-31T19:27:40.6Z
2018-10-31T19:32:40.908Z,1541014360.908 [Default:CheckIn:Read_GPS] Stopped
2018-10-31T19:32:40.908Z,1541014360.908 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-10-31T19:32:41.315Z,1541014361.315 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2018-10-31T19:32:45.188Z,1541014365.188 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20181031T183314/Courier0000.lzma
2018-10-31T19:32:45.987Z,1541014365.987 [DataOverHttps](INFO): Moved sent file to Logs/20181031T183314/Courier0000.lzma.bak
2018-10-31T19:32:45.987Z,1541014365.987 [DataOverHttps](INFO): SBD MOMSN=8757447
2018-10-31T19:32:54.732Z,1541014374.732 [DataOverHttps](INFO): Sending 169 bytes from file Logs/20181031T183941/Courier0000.lzma
2018-10-31T19:32:55.164Z,1541014375.164 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2018-10-31T19:32:55.164Z,1541014375.164 [RDI_Pathfinder] Communications Fault, FailCount= 2
2018-10-31T19:32:55.164Z,1541014375.164 [RDI_Pathfinder](ERROR): Communications Fault
2018-10-31T19:32:55.232Z,1541014375.232 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2018-10-31T19:32:55.531Z,1541014375.531 [DataOverHttps](INFO): Moved sent file to Logs/20181031T183941/Courier0000.lzma.bak
2018-10-31T19:32:55.531Z,1541014375.531 [DataOverHttps](INFO): SBD MOMSN=8757452
2018-10-31T19:32:55.645Z,1541014375.645 [RDI_Pathfinder](INFO): Powering down
2018-10-31T19:32:56.405Z,1541014376.405 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-10-31T19:32:56.405Z,1541014376.405 [RDI_Pathfinder] No Fault, FailCount= 2
2018-10-31T19:33:04.235Z,1541014384.235 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20181031T190557/Courier0000.lzma
2018-10-31T19:33:05.027Z,1541014385.027 [DataOverHttps](INFO): Moved sent file to Logs/20181031T190557/Courier0000.lzma.bak
2018-10-31T19:33:05.027Z,1541014385.027 [DataOverHttps](INFO): SBD MOMSN=8757457
2018-10-31T19:33:13.778Z,1541014393.778 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20181031T190913/Courier0000.lzma
2018-10-31T19:33:14.559Z,1541014394.559 [DataOverHttps](INFO): Moved sent file to Logs/20181031T190913/Courier0000.lzma.bak
2018-10-31T19:33:14.559Z,1541014394.559 [DataOverHttps](INFO): SBD MOMSN=8757462
2018-10-31T19:33:23.253Z,1541014403.253 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20181031T191513/Courier0000.lzma
2018-10-31T19:33:24.024Z,1541014404.024 [DataOverHttps](INFO): Moved sent file to Logs/20181031T191513/Courier0000.lzma.bak
2018-10-31T19:33:24.024Z,1541014404.024 [DataOverHttps](INFO): SBD MOMSN=8757466
2018-10-31T19:33:24.059Z,1541014404.059 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2018-10-31T19:33:24.059Z,1541014404.059 [RDI_Pathfinder] Communications Fault, FailCount= 3
2018-10-31T19:33:24.059Z,1541014404.059 [RDI_Pathfinder](ERROR): Communications Fault
2018-10-31T19:33:24.137Z,1541014404.137 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2018-10-31T19:33:24.137Z,1541014404.137 [CBIT](CRITICAL): Communications Fault in component: RDI_Pathfinder
2018-10-31T19:33:25.017Z,1541014405.017 [RDI_Pathfinder](INFO): Powering down
2018-10-31T19:33:25.051Z,1541014405.051 [CBIT](INFO): Critical error at 20181031T193324
2018-10-31T19:33:32.924Z,1541014412.924 [DataOverHttps](INFO): Sending 284 bytes from file Logs/20181031T192345/Courier0000.lzma
2018-10-31T19:33:33.723Z,1541014413.723 [DataOverHttps](INFO): Moved sent file to Logs/20181031T192345/Courier0000.lzma.bak
2018-10-31T19:33:33.723Z,1541014413.723 [DataOverHttps](INFO): SBD MOMSN=8757470
2018-10-31T19:33:42.387Z,1541014422.387 [DataOverHttps](INFO): Sending 262 bytes from file Logs/20181031T192345/Courier0004.lzma
2018-10-31T19:33:43.187Z,1541014423.187 [DataOverHttps](INFO): Moved sent file to Logs/20181031T192345/Courier0004.lzma.bak
2018-10-31T19:33:43.187Z,1541014423.187 [DataOverHttps](INFO): SBD MOMSN=8757479
2018-10-31T19:33:53.082Z,1541014433.082 [DataOverHttps](INFO): Sending 203 bytes from file Logs/20181009T210039/Express0008.lzma
2018-10-31T19:33:53.566Z,1541014433.566 [DataOverHttps](INFO): Moved sent file to Logs/20181009T210039/Express0008.lzma.bak
2018-10-31T19:33:53.566Z,1541014433.566 [DataOverHttps](INFO): SBD MOMSN=8757483
2018-10-31T19:34:02.506Z,1541014442.506 [DataOverHttps](INFO): Sending 1278 bytes from file Logs/20181009T211719/Express0001.lzma
2018-10-31T19:34:03.299Z,1541014443.299 [DataOverHttps](INFO): Moved sent file to Logs/20181009T211719/Express0001.lzma.bak
2018-10-31T19:34:03.299Z,1541014443.299 [DataOverHttps](INFO): SBD MOMSN=8757488
2018-10-31T19:34:07.653Z,1541014447.653 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-31T19:34:07.653Z,1541014447.653 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2018-10-31T19:34:07.653Z,1541014447.653 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-10-31T19:34:07.655Z,1541014447.655 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-31T19:34:07.655Z,1541014447.655 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5
2018-10-31T19:34:07.655Z,1541014447.655 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-31T19:34:07.718Z,1541014447.718 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-10-31T19:34:07.719Z,1541014447.719 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-31T19:34:07.803Z,1541014447.803 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-10-31T19:34:07.803Z,1541014447.803 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2018-10-31T19:34:07.804Z,1541014447.804 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-31T19:34:07.804Z,1541014447.804 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5
2018-10-31T19:34:08.176Z,1541014448.176 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-10-31T19:34:08.192Z,1541014448.192 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-10-31T19:34:08.192Z,1541014448.192 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-10-31T19:34:08.193Z,1541014448.193 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-31T19:34:08.193Z,1541014448.193 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-31T19:34:08.194Z,1541014448.194 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-31T19:34:12.466Z,1541014452.466 [DataOverHttps](INFO): Sending 207 bytes from file Logs/20181009T211719/Express0005.lzma
2018-10-31T19:34:13.263Z,1541014453.263 [DataOverHttps](INFO): Moved sent file to Logs/20181009T211719/Express0005.lzma.bak
2018-10-31T19:34:13.264Z,1541014453.264 [DataOverHttps](INFO): SBD MOMSN=8757533
2018-10-31T19:34:22.197Z,1541014462.197 [DataOverHttps](INFO): Sending 1265 bytes from file Logs/20181009T213951/Express0001.lzma
2018-10-31T19:34:22.991Z,1541014462.991 [DataOverHttps](INFO): Moved sent file to Logs/20181009T213951/Express0001.lzma.bak
2018-10-31T19:34:22.991Z,1541014462.991 [DataOverHttps](INFO): SBD MOMSN=8757541
2018-10-31T19:34:34.525Z,1541014474.525 [DataOverHttps](INFO): Sending 262 bytes from file Logs/20181009T213951/Express0005.lzma
2018-10-31T19:34:35.047Z,1541014475.047 [DataOverHttps](INFO): Moved sent file to Logs/20181009T213951/Express0005.lzma.bak
2018-10-31T19:34:35.047Z,1541014475.047 [DataOverHttps](INFO): SBD MOMSN=8757585
2018-10-31T19:34:44.089Z,1541014484.089 [DataOverHttps](INFO): Sending 1607 bytes from file Logs/20181031T182710/Express0001.lzma
2018-10-31T19:34:44.486Z,1541014484.486 [NAL9602](FAULT): GPS failed to acquire within timeout.
2018-10-31T19:34:44.486Z,1541014484.486 [NAL9602] Data Fault, FailCount= 1
2018-10-31T19:34:44.486Z,1541014484.486 [NAL9602](ERROR): Data Fault
2018-10-31T19:34:44.549Z,1541014484.549 [CBIT](ERROR): Data Fault in component: NAL9602
2018-10-31T19:34:44.883Z,1541014484.883 [DataOverHttps](INFO): Moved sent file to Logs/20181031T182710/Express0001.lzma.bak
2018-10-31T19:34:44.883Z,1541014484.883 [DataOverHttps](INFO): SBD MOMSN=8757609
2018-10-31T19:34:44.890Z,1541014484.890 [NAL9602](INFO): Powering down
2018-10-31T19:34:46.082Z,1541014486.082 [CBIT](INFO): Clearing failed state for component NAL9602
2018-10-31T19:34:46.082Z,1541014486.082 [NAL9602] No Fault, FailCount= 1
2018-10-31T19:34:53.844Z,1541014493.844 [DataOverHttps](INFO): Sending 1357 bytes from file Logs/20181031T183314/Express0001.lzma
2018-10-31T19:34:54.639Z,1541014494.639 [DataOverHttps](INFO): Moved sent file to Logs/20181031T183314/Express0001.lzma.bak
2018-10-31T19:34:54.639Z,1541014494.639 [DataOverHttps](INFO): SBD MOMSN=8757669
2018-10-31T19:35:08.343Z,1541014508.343 [DataOverHttps](INFO): Sending 1346 bytes from file Logs/20181031T183941/Express0001.lzma
2018-10-31T19:35:09.107Z,1541014509.107 [DataOverHttps](INFO): Moved sent file to Logs/20181031T183941/Express0001.lzma.bak
2018-10-31T19:35:09.107Z,1541014509.107 [DataOverHttps](INFO): SBD MOMSN=8757718
2018-10-31T19:35:15.054Z,1541014515.054 [NAL9602](INFO): Powering up NAL9602
2018-10-31T19:35:23.536Z,1541014523.536 [DataOverHttps](INFO): Sending 1141 bytes from file Logs/20181031T190557/Express0001.lzma
2018-10-31T19:35:24.076Z,1541014524.076 [DataOverHttps](INFO): Moved sent file to Logs/20181031T190557/Express0001.lzma.bak
2018-10-31T19:35:24.076Z,1541014524.076 [DataOverHttps](INFO): SBD MOMSN=8757767
2018-10-31T19:35:28.197Z,1541014528.197 [NAL9602](INFO): NAL9602 initialized
2018-10-31T19:35:33.018Z,1541014533.018 [DataOverHttps](INFO): Sending 707 bytes from file Logs/20181031T190913/Express0001.lzma
2018-10-31T19:35:33.815Z,1541014533.815 [DataOverHttps](INFO): Moved sent file to Logs/20181031T190913/Express0001.lzma.bak
2018-10-31T19:35:33.815Z,1541014533.815 [DataOverHttps](INFO): SBD MOMSN=8757799
2018-10-31T19:35:42.920Z,1541014542.920 [DataOverHttps](INFO): Sending 1555 bytes from file Logs/20181031T191513/Express0001.lzma
2018-10-31T19:35:43.715Z,1541014543.715 [DataOverHttps](INFO): Moved sent file to Logs/20181031T191513/Express0001.lzma.bak
2018-10-31T19:35:43.715Z,1541014543.715 [DataOverHttps](INFO): SBD MOMSN=8757818
2018-10-31T19:35:52.670Z,1541014552.670 [DataOverHttps](INFO): Sending 1544 bytes from file Logs/20181031T192345/Express0001.lzma
2018-10-31T19:35:53.443Z,1541014553.443 [DataOverHttps](INFO): Moved sent file to Logs/20181031T192345/Express0001.lzma.bak
2018-10-31T19:35:53.443Z,1541014553.443 [DataOverHttps](INFO): SBD MOMSN=8757881
2018-10-31T19:36:02.435Z,1541014562.435 [DataOverHttps](INFO): Sending 356 bytes from file Logs/20181031T192345/Express0005.lzma
2018-10-31T19:36:03.235Z,1541014563.235 [DataOverHttps](INFO): Moved sent file to Logs/20181031T192345/Express0005.lzma.bak
2018-10-31T19:36:03.235Z,1541014563.235 [DataOverHttps](INFO): SBD MOMSN=8757938
2018-10-31T19:36:04.279Z,1541014564.279 [Default:CheckIn:Read_Iridium] Stopped
2018-10-31T19:36:04.279Z,1541014564.279 [Default:CheckIn:C.Wait] Running Loop=1
2018-10-31T19:36:04.279Z,1541014564.279 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-10-31T19:36:08.276Z,1541014568.276 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-31T19:36:08.276Z,1541014568.276 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2018-10-31T19:36:08.277Z,1541014568.277 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-10-31T19:36:08.278Z,1541014568.278 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-31T19:36:08.278Z,1541014568.278 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6
2018-10-31T19:36:08.278Z,1541014568.278 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-31T19:36:08.291Z,1541014568.291 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-10-31T19:36:08.292Z,1541014568.292 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-31T19:36:08.689Z,1541014568.689 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-10-31T19:36:08.689Z,1541014568.689 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2018-10-31T19:36:08.689Z,1541014568.689 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-31T19:36:08.689Z,1541014568.689 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6
2018-10-31T19:36:09.069Z,1541014569.069 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-10-31T19:36:09.069Z,1541014569.069 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-10-31T19:36:09.070Z,1541014569.070 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-10-31T19:36:09.070Z,1541014569.070 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-31T19:36:09.071Z,1541014569.071 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-31T19:36:09.071Z,1541014569.071 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-31T19:36:24.282Z,1541014584.282 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-10-31T19:36:24.282Z,1541014584.282 [RDI_Pathfinder] No Fault, FailCount= 3
2018-10-31T19:36:37.070Z,1541014597.070 [RDI_Pathfinder](FAULT): DVL failed to acquire valid data within timeout.
2018-10-31T19:36:37.070Z,1541014597.070 [RDI_Pathfinder] Data Fault, FailCount= 1
2018-10-31T19:36:37.070Z,1541014597.070 [RDI_Pathfinder](ERROR): Data Fault
2018-10-31T19:36:37.090Z,1541014597.090 [CBIT](ERROR): Data Fault in component: RDI_Pathfinder
2018-10-31T19:36:37.541Z,1541014597.541 [RDI_Pathfinder](INFO): Powering down
2018-10-31T19:36:38.297Z,1541014598.297 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-10-31T19:36:38.298Z,1541014598.298 [RDI_Pathfinder] No Fault, FailCount= 1
2018-10-31T19:36:57.057Z,1541014617.057 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-10-31T19:36:57.057Z,1541014617.057 [AHRS_M2] No Fault, FailCount= 5
2018-10-31T19:36:57.398Z,1541014617.398 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-10-31T19:37:00.693Z,1541014620.693 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:37:01.097Z,1541014621.097 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:37:01.130Z,1541014621.130 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2018-10-31T19:37:01.130Z,1541014621.130 [RDI_Pathfinder] Communications Fault, FailCount= 2
2018-10-31T19:37:01.130Z,1541014621.130 [RDI_Pathfinder](ERROR): Communications Fault
2018-10-31T19:37:01.183Z,1541014621.183 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2018-10-31T19:37:01.482Z,1541014621.482 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:37:01.577Z,1541014621.577 [RDI_Pathfinder](INFO): Powering down
2018-10-31T19:37:01.886Z,1541014621.886 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:37:02.293Z,1541014622.293 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:37:02.348Z,1541014622.348 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-10-31T19:37:02.348Z,1541014622.348 [RDI_Pathfinder] No Fault, FailCount= 2
2018-10-31T19:37:02.693Z,1541014622.693 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:37:03.093Z,1541014623.093 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:37:03.493Z,1541014623.493 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:37:03.897Z,1541014623.897 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:37:04.293Z,1541014624.293 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:37:04.693Z,1541014624.693 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:37:05.093Z,1541014625.093 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:37:05.493Z,1541014625.493 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:37:05.897Z,1541014625.897 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:37:06.293Z,1541014626.293 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:37:06.693Z,1541014626.693 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:37:07.093Z,1541014627.093 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:37:07.493Z,1541014627.493 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:37:07.493Z,1541014627.493 [AHRS_M2](FAULT): Failed to initialize within timeout.
2018-10-31T19:37:07.493Z,1541014627.493 [AHRS_M2] Communications Fault, FailCount= 1
2018-10-31T19:37:07.493Z,1541014627.493 [AHRS_M2](ERROR): Communications Fault
2018-10-31T19:37:07.534Z,1541014627.534 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2018-10-31T19:37:07.799Z,1541014627.799 [AHRS_M2](INFO): Powering down
2018-10-31T19:37:11.437Z,1541014631.437 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-10-31T19:37:11.437Z,1541014631.437 [AHRS_M2] No Fault, FailCount= 1
2018-10-31T19:37:11.800Z,1541014631.800 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-10-31T19:37:15.097Z,1541014635.097 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:37:18.253Z,1541014638.253 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:37:25.426Z,1541014645.426 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2018-10-31T19:37:25.426Z,1541014645.426 [RDI_Pathfinder] Communications Fault, FailCount= 3
2018-10-31T19:37:25.426Z,1541014645.426 [RDI_Pathfinder](ERROR): Communications Fault
2018-10-31T19:37:25.450Z,1541014645.450 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2018-10-31T19:37:25.450Z,1541014645.450 [CBIT](CRITICAL): Communications Fault in component: RDI_Pathfinder
2018-10-31T19:37:25.801Z,1541014645.801 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2018-10-31T19:37:25.801Z,1541014645.801 [AHRS_M2] Data Fault, FailCount= 2
2018-10-31T19:37:25.801Z,1541014645.801 [AHRS_M2](ERROR): Data Fault
2018-10-31T19:37:25.913Z,1541014645.913 [RDI_Pathfinder](INFO): Powering down
2018-10-31T19:37:25.937Z,1541014645.937 [CBIT](INFO): Critical error at 20181031T193725
2018-10-31T19:37:25.939Z,1541014645.939 [CBIT](ERROR): Data Fault in component: AHRS_M2
2018-10-31T19:37:26.190Z,1541014646.190 [AHRS_M2](INFO): Powering down
2018-10-31T19:37:29.850Z,1541014649.850 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-10-31T19:37:29.850Z,1541014649.850 [AHRS_M2] No Fault, FailCount= 2
2018-10-31T19:37:30.190Z,1541014650.190 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-10-31T19:37:33.861Z,1541014653.861 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:37:43.801Z,1541014663.801 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2018-10-31T19:37:43.801Z,1541014663.801 [AHRS_M2] Data Fault, FailCount= 3
2018-10-31T19:37:43.801Z,1541014663.801 [AHRS_M2](ERROR): Data Fault
2018-10-31T19:37:43.880Z,1541014663.880 [CBIT](ERROR): Data Fault in component: AHRS_M2
2018-10-31T19:37:44.190Z,1541014664.190 [AHRS_M2](INFO): Powering down
2018-10-31T19:37:47.850Z,1541014667.850 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-10-31T19:37:47.850Z,1541014667.850 [AHRS_M2] No Fault, FailCount= 3
2018-10-31T19:37:48.190Z,1541014668.190 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-10-31T19:37:53.821Z,1541014673.821 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:38:03.761Z,1541014683.761 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2018-10-31T19:38:03.761Z,1541014683.761 [AHRS_M2] Data Fault, FailCount= 4
2018-10-31T19:38:03.761Z,1541014683.761 [AHRS_M2](ERROR): Data Fault
2018-10-31T19:38:03.843Z,1541014683.843 [CBIT](ERROR): Data Fault in component: AHRS_M2
2018-10-31T19:38:04.150Z,1541014684.150 [AHRS_M2](INFO): Powering down
2018-10-31T19:38:07.802Z,1541014687.802 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-10-31T19:38:07.802Z,1541014687.802 [AHRS_M2] No Fault, FailCount= 4
2018-10-31T19:38:08.150Z,1541014688.150 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-10-31T19:38:09.401Z,1541014689.401 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-31T19:38:09.401Z,1541014689.401 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2018-10-31T19:38:09.401Z,1541014689.401 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-10-31T19:38:09.403Z,1541014689.403 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-31T19:38:09.403Z,1541014689.403 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7
2018-10-31T19:38:09.403Z,1541014689.403 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-31T19:38:09.415Z,1541014689.415 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-10-31T19:38:09.415Z,1541014689.415 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-31T19:38:09.812Z,1541014689.812 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-10-31T19:38:09.812Z,1541014689.812 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2018-10-31T19:38:09.813Z,1541014689.813 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-31T19:38:09.813Z,1541014689.813 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7
2018-10-31T19:38:10.189Z,1541014690.189 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-10-31T19:38:10.190Z,1541014690.190 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-10-31T19:38:10.190Z,1541014690.190 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-10-31T19:38:10.190Z,1541014690.190 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-31T19:38:10.191Z,1541014690.191 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-31T19:38:10.191Z,1541014690.191 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-31T19:38:11.821Z,1541014691.821 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:38:21.761Z,1541014701.761 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2018-10-31T19:38:21.761Z,1541014701.761 [AHRS_M2] Data Fault, FailCount= 5
2018-10-31T19:38:21.761Z,1541014701.761 [AHRS_M2](ERROR): Data Fault
2018-10-31T19:38:21.858Z,1541014701.858 [CBIT](ERROR): Data Fault in component: AHRS_M2
2018-10-31T19:38:21.858Z,1541014701.858 [CBIT](CRITICAL): Data Fault in component: AHRS_M2
2018-10-31T19:38:22.150Z,1541014702.150 [AHRS_M2](INFO): Powering down
2018-10-31T19:38:22.266Z,1541014702.266 [CBIT](INFO): Critical error at 20181031T193821
2018-10-31T19:39:03.622Z,1541014743.622 [CBIT](INFO): Clearing failed state for component DropWeight
2018-10-31T19:39:03.622Z,1541014743.622 [DropWeight] No Fault, FailCount= 1
2018-10-31T19:40:10.438Z,1541014810.438 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-31T19:40:10.438Z,1541014810.438 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2018-10-31T19:40:10.438Z,1541014810.438 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-10-31T19:40:10.440Z,1541014810.440 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-31T19:40:10.440Z,1541014810.440 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 8
2018-10-31T19:40:10.440Z,1541014810.440 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-31T19:40:10.452Z,1541014810.452 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-10-31T19:40:10.453Z,1541014810.453 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-31T19:40:10.854Z,1541014810.854 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-10-31T19:40:10.854Z,1541014810.854 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2018-10-31T19:40:10.855Z,1541014810.855 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-31T19:40:10.855Z,1541014810.855 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 8
2018-10-31T19:40:14.168Z,1541014814.168 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-10-31T19:40:14.169Z,1541014814.169 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-10-31T19:40:14.169Z,1541014814.169 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-10-31T19:40:14.170Z,1541014814.170 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-31T19:40:14.170Z,1541014814.170 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-31T19:40:14.170Z,1541014814.170 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-31T19:40:25.510Z,1541014825.510 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-10-31T19:40:25.510Z,1541014825.510 [RDI_Pathfinder] No Fault, FailCount= 3
2018-10-31T19:40:38.675Z,1541014838.675 [RDI_Pathfinder](FAULT): DVL failed to acquire valid data within timeout.
2018-10-31T19:40:38.676Z,1541014838.676 [RDI_Pathfinder] Data Fault, FailCount= 1
2018-10-31T19:40:38.676Z,1541014838.676 [RDI_Pathfinder](ERROR): Data Fault
2018-10-31T19:40:38.734Z,1541014838.734 [CBIT](ERROR): Data Fault in component: RDI_Pathfinder
2018-10-31T19:40:39.145Z,1541014839.145 [RDI_Pathfinder](INFO): Powering down
2018-10-31T19:40:39.920Z,1541014839.920 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-10-31T19:40:39.920Z,1541014839.920 [RDI_Pathfinder] No Fault, FailCount= 1
2018-10-31T19:41:03.006Z,1541014863.006 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2018-10-31T19:41:03.006Z,1541014863.006 [RDI_Pathfinder] Communications Fault, FailCount= 2
2018-10-31T19:41:03.006Z,1541014863.006 [RDI_Pathfinder](ERROR): Communications Fault
2018-10-31T19:41:03.070Z,1541014863.070 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2018-10-31T19:41:03.477Z,1541014863.477 [RDI_Pathfinder](INFO): Powering down
2018-10-31T19:41:04.255Z,1541014864.255 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-10-31T19:41:04.255Z,1541014864.255 [RDI_Pathfinder] No Fault, FailCount= 2
2018-10-31T19:41:04.640Z,1541014864.640 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-10-31T19:41:04.640Z,1541014864.640 [Default:CheckIn:C.Wait] Stopped
2018-10-31T19:41:04.641Z,1541014864.641 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-10-31T19:41:04.645Z,1541014864.645 [Default:CheckIn:D] Running Loop=1
2018-10-31T19:41:05.029Z,1541014865.029 [Default:CheckIn:D] Stopped
2018-10-31T19:41:05.050Z,1541014865.050 [Default:CheckIn:E] Running Loop=1
2018-10-31T19:41:05.419Z,1541014865.419 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 13.631319 min
2018-10-31T19:41:05.421Z,1541014865.421 [Default:CheckIn:E] Stopped
2018-10-31T19:41:05.422Z,1541014865.422 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-10-31T19:41:05.422Z,1541014865.422 [Default:CheckIn] Stopped
2018-10-31T19:41:05.422Z,1541014865.422 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-10-31T19:41:05.422Z,1541014865.422 [Default:CheckIn](INFO): Running loop #2
2018-10-31T19:41:05.422Z,1541014865.422 [Default:CheckIn] Running Loop=2
2018-10-31T19:41:05.422Z,1541014865.422 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-10-31T19:41:05.422Z,1541014865.422 [Default:CheckIn:Read_GPS] Running Loop=1
2018-10-31T19:41:27.362Z,1541014887.362 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2018-10-31T19:41:27.362Z,1541014887.362 [RDI_Pathfinder] Communications Fault, FailCount= 3
2018-10-31T19:41:27.362Z,1541014887.362 [RDI_Pathfinder](ERROR): Communications Fault
2018-10-31T19:41:27.440Z,1541014887.440 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2018-10-31T19:41:27.440Z,1541014887.440 [CBIT](CRITICAL): Communications Fault in component: RDI_Pathfinder
2018-10-31T19:41:27.829Z,1541014887.829 [RDI_Pathfinder](INFO): Powering down
2018-10-31T19:41:27.872Z,1541014887.872 [CBIT](INFO): Critical error at 20181031T194127
2018-10-31T19:42:14.488Z,1541014934.488 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-31T19:42:14.488Z,1541014934.488 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2018-10-31T19:42:14.488Z,1541014934.488 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-10-31T19:42:14.490Z,1541014934.490 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-31T19:42:14.490Z,1541014934.490 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 9
2018-10-31T19:42:14.490Z,1541014934.490 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-31T19:42:14.517Z,1541014934.517 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-10-31T19:42:14.518Z,1541014934.518 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-31T19:42:14.921Z,1541014934.921 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-10-31T19:42:14.922Z,1541014934.922 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2018-10-31T19:42:14.922Z,1541014934.922 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-31T19:42:14.922Z,1541014934.922 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 9
2018-10-31T19:42:15.276Z,1541014935.276 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-10-31T19:42:15.277Z,1541014935.277 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-10-31T19:42:15.277Z,1541014935.277 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-10-31T19:42:15.278Z,1541014935.278 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-31T19:42:15.278Z,1541014935.278 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-31T19:42:15.278Z,1541014935.278 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-31T19:43:22.049Z,1541015002.049 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-10-31T19:43:22.049Z,1541015002.049 [AHRS_M2] No Fault, FailCount= 5
2018-10-31T19:43:22.382Z,1541015002.382 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-10-31T19:43:25.677Z,1541015005.677 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:43:26.453Z,1541015006.453 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:43:27.253Z,1541015007.253 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:43:28.445Z,1541015008.445 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:43:29.645Z,1541015009.645 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:43:30.845Z,1541015010.845 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:43:32.045Z,1541015012.045 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:43:33.245Z,1541015013.245 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:43:34.445Z,1541015014.445 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:43:35.645Z,1541015015.645 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:43:36.393Z,1541015016.393 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2018-10-31T19:43:36.393Z,1541015016.393 [AHRS_M2] Data Fault, FailCount= 1
2018-10-31T19:43:36.393Z,1541015016.393 [AHRS_M2](ERROR): Data Fault
2018-10-31T19:43:36.494Z,1541015016.494 [CBIT](ERROR): Data Fault in component: AHRS_M2
2018-10-31T19:43:36.782Z,1541015016.782 [AHRS_M2](INFO): Powering down
2018-10-31T19:43:40.494Z,1541015020.494 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-10-31T19:43:40.494Z,1541015020.494 [AHRS_M2] No Fault, FailCount= 1
2018-10-31T19:43:40.782Z,1541015020.782 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-10-31T19:43:54.023Z,1541015034.023 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2018-10-31T19:43:55.173Z,1541015035.173 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2018-10-31T19:43:55.173Z,1541015035.173 [AHRS_M2] Data Fault, FailCount= 2
2018-10-31T19:43:55.173Z,1541015035.173 [AHRS_M2](ERROR): Data Fault
2018-10-31T19:43:55.250Z,1541015035.250 [CBIT](ERROR): Data Fault in component: AHRS_M2
2018-10-31T19:43:55.562Z,1541015035.562 [AHRS_M2](INFO): Powering down
2018-10-31T19:43:59.215Z,1541015039.215 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-10-31T19:43:59.215Z,1541015039.215 [AHRS_M2] No Fault, FailCount= 2
2018-10-31T19:43:59.562Z,1541015039.562 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-10-31T19:44:03.233Z,1541015043.233 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:44:13.173Z,1541015053.173 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2018-10-31T19:44:13.173Z,1541015053.173 [AHRS_M2] Data Fault, FailCount= 3
2018-10-31T19:44:13.173Z,1541015053.173 [AHRS_M2](ERROR): Data Fault
2018-10-31T19:44:13.251Z,1541015053.251 [CBIT](ERROR): Data Fault in component: AHRS_M2
2018-10-31T19:44:13.562Z,1541015053.562 [AHRS_M2](INFO): Powering down
2018-10-31T19:44:15.593Z,1541015055.593 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-31T19:44:15.593Z,1541015055.593 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2018-10-31T19:44:15.593Z,1541015055.593 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-10-31T19:44:15.595Z,1541015055.595 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-31T19:44:15.595Z,1541015055.595 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 10
2018-10-31T19:44:15.595Z,1541015055.595 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-31T19:44:15.644Z,1541015055.644 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-10-31T19:44:15.650Z,1541015055.650 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-31T19:44:16.030Z,1541015056.030 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-10-31T19:44:16.030Z,1541015056.030 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2018-10-31T19:44:16.031Z,1541015056.031 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-31T19:44:16.031Z,1541015056.031 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 10
2018-10-31T19:44:16.404Z,1541015056.404 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-10-31T19:44:16.413Z,1541015056.413 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-10-31T19:44:16.413Z,1541015056.413 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-10-31T19:44:16.414Z,1541015056.414 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-31T19:44:16.414Z,1541015056.414 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-31T19:44:16.415Z,1541015056.415 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-31T19:44:19.932Z,1541015059.932 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-10-31T19:44:19.932Z,1541015059.932 [AHRS_M2] No Fault, FailCount= 3
2018-10-31T19:44:19.954Z,1541015059.954 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-10-31T19:44:23.629Z,1541015063.629 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:44:27.638Z,1541015067.638 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-10-31T19:44:27.638Z,1541015067.638 [RDI_Pathfinder] No Fault, FailCount= 3
2018-10-31T19:44:33.173Z,1541015073.173 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2018-10-31T19:44:33.173Z,1541015073.173 [AHRS_M2] Data Fault, FailCount= 4
2018-10-31T19:44:33.173Z,1541015073.173 [AHRS_M2](ERROR): Data Fault
2018-10-31T19:44:33.260Z,1541015073.260 [CBIT](ERROR): Data Fault in component: AHRS_M2
2018-10-31T19:44:33.558Z,1541015073.558 [AHRS_M2](INFO): Powering down
2018-10-31T19:44:37.212Z,1541015077.212 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-10-31T19:44:37.212Z,1541015077.212 [AHRS_M2] No Fault, FailCount= 4
2018-10-31T19:44:37.558Z,1541015077.558 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-10-31T19:44:40.396Z,1541015080.396 [RDI_Pathfinder](FAULT): DVL failed to acquire valid data within timeout.
2018-10-31T19:44:40.396Z,1541015080.396 [RDI_Pathfinder] Data Fault, FailCount= 1
2018-10-31T19:44:40.396Z,1541015080.396 [RDI_Pathfinder](ERROR): Data Fault
2018-10-31T19:44:40.455Z,1541015080.455 [CBIT](ERROR): Data Fault in component: RDI_Pathfinder
2018-10-31T19:44:40.889Z,1541015080.889 [RDI_Pathfinder](INFO): Powering down
2018-10-31T19:44:41.221Z,1541015081.221 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:44:41.629Z,1541015081.629 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-10-31T19:44:41.629Z,1541015081.629 [RDI_Pathfinder] No Fault, FailCount= 1
2018-10-31T19:44:51.169Z,1541015091.169 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2018-10-31T19:44:51.169Z,1541015091.169 [AHRS_M2] Data Fault, FailCount= 5
2018-10-31T19:44:51.169Z,1541015091.169 [AHRS_M2](ERROR): Data Fault
2018-10-31T19:44:51.237Z,1541015091.237 [CBIT](ERROR): Data Fault in component: AHRS_M2
2018-10-31T19:44:51.237Z,1541015091.237 [CBIT](CRITICAL): Data Fault in component: AHRS_M2
2018-10-31T19:44:51.558Z,1541015091.558 [AHRS_M2](INFO): Powering down
2018-10-31T19:44:51.688Z,1541015091.688 [CBIT](INFO): Critical error at 20181031T194451
2018-10-31T19:45:05.158Z,1541015105.158 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2018-10-31T19:45:05.158Z,1541015105.158 [RDI_Pathfinder] Communications Fault, FailCount= 2
2018-10-31T19:45:05.158Z,1541015105.158 [RDI_Pathfinder](ERROR): Communications Fault
2018-10-31T19:45:05.219Z,1541015105.219 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2018-10-31T19:45:05.606Z,1541015105.606 [RDI_Pathfinder](INFO): Powering down
2018-10-31T19:45:06.376Z,1541015106.376 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-10-31T19:45:06.376Z,1541015106.376 [RDI_Pathfinder] No Fault, FailCount= 2
2018-10-31T19:45:30.204Z,1541015130.204 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2018-10-31T19:45:30.204Z,1541015130.204 [RDI_Pathfinder] Communications Fault, FailCount= 3
2018-10-31T19:45:30.204Z,1541015130.204 [RDI_Pathfinder](ERROR): Communications Fault
2018-10-31T19:45:30.372Z,1541015130.372 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2018-10-31T19:45:30.373Z,1541015130.373 [CBIT](CRITICAL): Communications Fault in component: RDI_Pathfinder
2018-10-31T19:45:30.436Z,1541015130.436 [NAL9602](FAULT): GPS failed to acquire within timeout.
2018-10-31T19:45:30.436Z,1541015130.436 [NAL9602] Data Fault, FailCount= 2
2018-10-31T19:45:30.436Z,1541015130.436 [NAL9602](ERROR): Data Fault
2018-10-31T19:45:30.521Z,1541015130.521 [RDI_Pathfinder](INFO): Powering down
2018-10-31T19:45:30.594Z,1541015130.594 [CBIT](INFO): Critical error at 20181031T194530
2018-10-31T19:45:30.597Z,1541015130.597 [CBIT](ERROR): Data Fault in component: NAL9602
2018-10-31T19:45:30.786Z,1541015130.786 [NAL9602](INFO): Powering down
2018-10-31T19:45:31.622Z,1541015131.622 [CBIT](INFO): Clearing failed state for component NAL9602
2018-10-31T19:45:31.622Z,1541015131.622 [NAL9602] No Fault, FailCount= 2
2018-10-31T19:46:00.790Z,1541015160.790 [NAL9602](INFO): Powering up NAL9602
2018-10-31T19:46:05.541Z,1541015165.541 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-10-31T19:41:05.4Z
2018-10-31T19:46:05.541Z,1541015165.541 [Default:CheckIn:Read_GPS] Stopped
2018-10-31T19:46:05.541Z,1541015165.541 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-10-31T19:46:10.456Z,1541015170.456 [DataOverHttps](INFO): Sending 128 bytes from file Logs/20181031T192345/Courier0007.lzma
2018-10-31T19:46:11.231Z,1541015171.231 [DataOverHttps](INFO): Moved sent file to Logs/20181031T192345/Courier0007.lzma.bak
2018-10-31T19:46:11.231Z,1541015171.231 [DataOverHttps](INFO): SBD MOMSN=8758019
2018-10-31T19:46:12.236Z,1541015172.236 [NAL9602](INFO): NAL9602 initialized
2018-10-31T19:46:16.702Z,1541015176.702 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-31T19:46:16.702Z,1541015176.702 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2018-10-31T19:46:16.702Z,1541015176.702 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-10-31T19:46:16.703Z,1541015176.703 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-31T19:46:16.704Z,1541015176.704 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 11
2018-10-31T19:46:16.704Z,1541015176.704 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-31T19:46:16.716Z,1541015176.716 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-10-31T19:46:16.717Z,1541015176.717 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-31T19:46:17.132Z,1541015177.132 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-10-31T19:46:17.132Z,1541015177.132 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2018-10-31T19:46:17.133Z,1541015177.133 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-31T19:46:17.133Z,1541015177.133 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 11
2018-10-31T19:46:20.175Z,1541015180.175 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-10-31T19:46:20.176Z,1541015180.176 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-10-31T19:46:20.176Z,1541015180.176 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-10-31T19:46:20.176Z,1541015180.176 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-31T19:46:20.177Z,1541015180.177 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-31T19:46:20.177Z,1541015180.177 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-31T19:46:20.258Z,1541015180.258 [DataOverHttps](INFO): Sending 416 bytes from file Logs/20181031T192345/Express0008.lzma
2018-10-31T19:46:21.047Z,1541015181.047 [DataOverHttps](INFO): Moved sent file to Logs/20181031T192345/Express0008.lzma.bak
2018-10-31T19:46:21.047Z,1541015181.047 [DataOverHttps](INFO): SBD MOMSN=8758027
2018-10-31T19:46:22.091Z,1541015182.091 [Default:CheckIn:Read_Iridium] Stopped
2018-10-31T19:46:22.091Z,1541015182.091 [Default:CheckIn:C.Wait] Running Loop=1
2018-10-31T19:46:22.091Z,1541015182.091 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-10-31T19:48:20.542Z,1541015300.542 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-31T19:48:20.543Z,1541015300.543 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2018-10-31T19:48:20.543Z,1541015300.543 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-10-31T19:48:20.544Z,1541015300.544 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-31T19:48:20.544Z,1541015300.544 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 12
2018-10-31T19:48:20.544Z,1541015300.544 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-31T19:48:20.557Z,1541015300.557 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-10-31T19:48:20.557Z,1541015300.557 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-31T19:48:20.953Z,1541015300.953 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-10-31T19:48:20.953Z,1541015300.953 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2018-10-31T19:48:20.954Z,1541015300.954 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-31T19:48:20.954Z,1541015300.954 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 12
2018-10-31T19:48:21.340Z,1541015301.340 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-10-31T19:48:21.340Z,1541015301.340 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-10-31T19:48:21.340Z,1541015301.340 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-10-31T19:48:21.341Z,1541015301.341 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-31T19:48:21.341Z,1541015301.341 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-31T19:48:21.342Z,1541015301.342 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-31T19:48:30.570Z,1541015310.570 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-10-31T19:48:30.570Z,1541015310.570 [RDI_Pathfinder] No Fault, FailCount= 3
2018-10-31T19:48:43.327Z,1541015323.327 [RDI_Pathfinder](FAULT): DVL failed to acquire valid data within timeout.
2018-10-31T19:48:43.327Z,1541015323.327 [RDI_Pathfinder] Data Fault, FailCount= 1
2018-10-31T19:48:43.327Z,1541015323.327 [RDI_Pathfinder](ERROR): Data Fault
2018-10-31T19:48:43.346Z,1541015323.346 [CBIT](ERROR): Data Fault in component: RDI_Pathfinder
2018-10-31T19:48:46.497Z,1541015326.497 [RDI_Pathfinder](INFO): Powering down
2018-10-31T19:48:47.002Z,1541015327.002 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-10-31T19:48:47.002Z,1541015327.002 [RDI_Pathfinder] No Fault, FailCount= 1
2018-10-31T19:48:54.188Z,1541015334.188 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2018-10-31T19:49:09.791Z,1541015349.791 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2018-10-31T19:49:09.791Z,1541015349.791 [RDI_Pathfinder] Communications Fault, FailCount= 2
2018-10-31T19:49:09.791Z,1541015349.791 [RDI_Pathfinder](ERROR): Communications Fault
2018-10-31T19:49:09.818Z,1541015349.818 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2018-10-31T19:49:10.257Z,1541015350.257 [RDI_Pathfinder](INFO): Powering down
2018-10-31T19:49:11.010Z,1541015351.010 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-10-31T19:49:11.011Z,1541015351.011 [RDI_Pathfinder] No Fault, FailCount= 2
2018-10-31T19:49:33.711Z,1541015373.711 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2018-10-31T19:49:33.711Z,1541015373.711 [RDI_Pathfinder] Communications Fault, FailCount= 3
2018-10-31T19:49:33.711Z,1541015373.711 [RDI_Pathfinder](ERROR): Communications Fault
2018-10-31T19:49:33.762Z,1541015373.762 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2018-10-31T19:49:33.762Z,1541015373.762 [CBIT](CRITICAL): Communications Fault in component: RDI_Pathfinder
2018-10-31T19:49:34.181Z,1541015374.181 [RDI_Pathfinder](INFO): Powering down
2018-10-31T19:49:34.220Z,1541015374.220 [CBIT](INFO): Critical error at 20181031T194933
2018-10-31T19:49:51.321Z,1541015391.321 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-10-31T19:49:51.322Z,1541015391.322 [AHRS_M2] No Fault, FailCount= 5
2018-10-31T19:49:51.678Z,1541015391.678 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-10-31T19:49:56.925Z,1541015396.925 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:49:57.321Z,1541015397.321 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:49:57.721Z,1541015397.721 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:49:58.125Z,1541015398.125 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:49:58.521Z,1541015398.521 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:49:58.913Z,1541015398.913 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:49:59.301Z,1541015399.301 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:49:59.717Z,1541015399.717 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:50:00.121Z,1541015400.121 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:50:00.501Z,1541015400.501 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:50:00.912Z,1541015400.912 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:50:01.301Z,1541015401.301 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:50:01.714Z,1541015401.714 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:50:01.714Z,1541015401.714 [AHRS_M2](FAULT): Failed to initialize within timeout.
2018-10-31T19:50:01.715Z,1541015401.715 [AHRS_M2] Communications Fault, FailCount= 1
2018-10-31T19:50:01.715Z,1541015401.715 [AHRS_M2](ERROR): Communications Fault
2018-10-31T19:50:01.806Z,1541015401.806 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2018-10-31T19:50:02.026Z,1541015402.026 [AHRS_M2](INFO): Powering down
2018-10-31T19:50:05.716Z,1541015405.716 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-10-31T19:50:05.716Z,1541015405.716 [AHRS_M2] No Fault, FailCount= 1
2018-10-31T19:50:06.026Z,1541015406.026 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-10-31T19:50:09.321Z,1541015409.321 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:50:09.713Z,1541015409.713 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-10-31T19:50:10.497Z,1541015410.497 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:50:11.297Z,1541015411.297 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:50:12.497Z,1541015412.497 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:50:13.698Z,1541015413.698 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:50:20.437Z,1541015420.437 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2018-10-31T19:50:20.437Z,1541015420.437 [AHRS_M2] Data Fault, FailCount= 2
2018-10-31T19:50:20.437Z,1541015420.437 [AHRS_M2](ERROR): Data Fault
2018-10-31T19:50:20.486Z,1541015420.486 [CBIT](ERROR): Data Fault in component: AHRS_M2
2018-10-31T19:50:20.826Z,1541015420.826 [AHRS_M2](INFO): Powering down
2018-10-31T19:50:21.665Z,1541015421.665 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-31T19:50:21.665Z,1541015421.665 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13
2018-10-31T19:50:21.665Z,1541015421.665 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-10-31T19:50:21.667Z,1541015421.667 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-31T19:50:21.667Z,1541015421.667 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 13
2018-10-31T19:50:21.667Z,1541015421.667 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-31T19:50:21.696Z,1541015421.696 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-10-31T19:50:21.696Z,1541015421.696 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-31T19:50:22.096Z,1541015422.096 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-10-31T19:50:22.096Z,1541015422.096 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13
2018-10-31T19:50:22.097Z,1541015422.097 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-31T19:50:22.097Z,1541015422.097 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 13
2018-10-31T19:50:22.468Z,1541015422.468 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-10-31T19:50:22.469Z,1541015422.469 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-10-31T19:50:22.469Z,1541015422.469 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-10-31T19:50:22.470Z,1541015422.470 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-31T19:50:22.470Z,1541015422.470 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-31T19:50:22.470Z,1541015422.470 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-31T19:50:24.481Z,1541015424.481 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-10-31T19:50:24.482Z,1541015424.482 [AHRS_M2] No Fault, FailCount= 2
2018-10-31T19:50:24.826Z,1541015424.826 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-10-31T19:50:28.486Z,1541015428.486 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:50:38.377Z,1541015438.377 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2018-10-31T19:50:38.377Z,1541015438.377 [AHRS_M2] Data Fault, FailCount= 3
2018-10-31T19:50:38.377Z,1541015438.377 [AHRS_M2](ERROR): Data Fault
2018-10-31T19:50:38.465Z,1541015438.465 [CBIT](ERROR): Data Fault in component: AHRS_M2
2018-10-31T19:50:38.766Z,1541015438.766 [AHRS_M2](INFO): Powering down
2018-10-31T19:50:42.420Z,1541015442.420 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-10-31T19:50:42.420Z,1541015442.420 [AHRS_M2] No Fault, FailCount= 3
2018-10-31T19:50:42.766Z,1541015442.766 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-10-31T19:50:46.429Z,1541015446.429 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:50:56.377Z,1541015456.377 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2018-10-31T19:50:56.377Z,1541015456.377 [AHRS_M2] Data Fault, FailCount= 4
2018-10-31T19:50:56.377Z,1541015456.377 [AHRS_M2](ERROR): Data Fault
2018-10-31T19:50:56.472Z,1541015456.472 [CBIT](ERROR): Data Fault in component: AHRS_M2
2018-10-31T19:50:56.766Z,1541015456.766 [AHRS_M2](INFO): Powering down
2018-10-31T19:51:00.405Z,1541015460.405 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-10-31T19:51:00.405Z,1541015460.405 [AHRS_M2] No Fault, FailCount= 4
2018-10-31T19:51:00.766Z,1541015460.766 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-10-31T19:51:04.437Z,1541015464.437 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-10-31T19:51:14.021Z,1541015474.021 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2018-10-31T19:51:14.021Z,1541015474.021 [AHRS_M2] Data Fault, FailCount= 5
2018-10-31T19:51:14.021Z,1541015474.021 [AHRS_M2](ERROR): Data Fault
2018-10-31T19:51:14.098Z,1541015474.098 [CBIT](ERROR): Data Fault in component: AHRS_M2
2018-10-31T19:51:14.099Z,1541015474.099 [CBIT](CRITICAL): Data Fault in component: AHRS_M2
2018-10-31T19:51:14.410Z,1541015474.410 [AHRS_M2](INFO): Powering down
2018-10-31T19:51:14.526Z,1541015474.526 [CBIT](INFO): Critical error at 20181031T195114
2018-10-31T19:51:22.458Z,1541015482.458 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-10-31T19:51:22.459Z,1541015482.459 [Default:CheckIn:C.Wait] Stopped
2018-10-31T19:51:22.459Z,1541015482.459 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-10-31T19:51:22.459Z,1541015482.459 [Default:CheckIn:D] Running Loop=1
2018-10-31T19:51:22.863Z,1541015482.863 [Default:CheckIn:D] Stopped
2018-10-31T19:51:22.863Z,1541015482.863 [Default:CheckIn:E] Running Loop=1
2018-10-31T19:51:23.243Z,1541015483.243 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 23.928589 min
2018-10-31T19:51:23.243Z,1541015483.243 [Default:CheckIn:E] Stopped
2018-10-31T19:51:23.244Z,1541015483.244 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-10-31T19:51:23.244Z,1541015483.244 [Default:CheckIn] Stopped
2018-10-31T19:51:23.244Z,1541015483.244 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-10-31T19:51:23.244Z,1541015483.244 [Default:CheckIn](INFO): Running loop #3
2018-10-31T19:51:23.244Z,1541015483.244 [Default:CheckIn] Running Loop=3
2018-10-31T19:51:23.244Z,1541015483.244 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-10-31T19:51:23.244Z,1541015483.244 [Default:CheckIn:Read_GPS] Running Loop=1
2018-10-31T19:52:22.813Z,1541015542.813 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-31T19:52:22.813Z,1541015542.813 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14
2018-10-31T19:52:22.813Z,1541015542.813 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-10-31T19:52:22.815Z,1541015542.815 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-31T19:52:22.815Z,1541015542.815 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 14
2018-10-31T19:52:22.815Z,1541015542.815 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-31T19:52:22.828Z,1541015542.828 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-10-31T19:52:22.828Z,1541015542.828 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-31T19:52:23.237Z,1541015543.237 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-10-31T19:52:23.237Z,1541015543.237 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14
2018-10-31T19:52:23.237Z,1541015543.237 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-31T19:52:23.238Z,1541015543.238 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 14
2018-10-31T19:52:23.613Z,1541015543.613 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-10-31T19:52:23.614Z,1541015543.614 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-10-31T19:52:23.614Z,1541015543.614 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-10-31T19:52:23.614Z,1541015543.614 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-31T19:52:23.615Z,1541015543.615 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-31T19:52:23.615Z,1541015543.615 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-31T19:52:34.034Z,1541015554.034 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-10-31T19:52:34.034Z,1541015554.034 [RDI_Pathfinder] No Fault, FailCount= 3
2018-10-31T19:52:47.195Z,1541015567.195 [RDI_Pathfinder](FAULT): DVL failed to acquire valid data within timeout.
2018-10-31T19:52:47.195Z,1541015567.195 [RDI_Pathfinder] Data Fault, FailCount= 1
2018-10-31T19:52:47.195Z,1541015567.195 [RDI_Pathfinder](ERROR): Data Fault
2018-10-31T19:52:47.237Z,1541015567.237 [CBIT](ERROR): Data Fault in component: RDI_Pathfinder
2018-10-31T19:52:47.669Z,1541015567.669 [RDI_Pathfinder](INFO): Powering down
2018-10-31T19:52:48.401Z,1541015568.401 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-10-31T19:52:48.401Z,1541015568.401 [RDI_Pathfinder] No Fault, FailCount= 1
2018-10-31T19:53:05.226Z,1541015585.226 [CommandLine](IMPORTANT): got command quit
2018-10-31T19:53:06.232Z,1541015586.232 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2018-10-31T19:53:06.232Z,1541015586.232 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-10-31T19:53:06.233Z,1541015586.233 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2018-10-31T19:53:06.233Z,1541015586.233 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-10-31T19:53:06.234Z,1541015586.234 [CommandLine](INFO): Join timeout helper Thread ID is 3163
2018-10-31T19:53:06.234Z,1541015586.234 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2018-10-31T19:53:06.234Z,1541015586.234 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-10-31T19:53:06.235Z,1541015586.235 [NavChartDb](INFO): Join timeout helper Thread ID is 3164
2018-10-31T19:53:06.282Z,1541015586.282 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2018-10-31T19:53:06.282Z,1541015586.282 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-10-31T19:53:06.302Z,1541015586.302 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2018-10-31T19:53:06.302Z,1541015586.302 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-10-31T19:53:06.302Z,1541015586.302 [Radio_Surface](INFO): Join timeout helper Thread ID is 3165
2018-10-31T19:53:06.445Z,1541015586.445 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2018-10-31T19:53:06.445Z,1541015586.445 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-10-31T19:53:06.465Z,1541015586.465 [ComponentRegistry](INFO): Shutting down WetLabsSeaOWL_UV_A ThreadHandler
2018-10-31T19:53:06.465Z,1541015586.465 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2018-10-31T19:53:06.466Z,1541015586.466 [WetLabsSeaOWL_UV_A](INFO): Join timeout helper Thread ID is 3166
2018-10-31T19:53:06.466Z,1541015586.466 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Uninitializing protected caller thread.
2018-10-31T19:53:06.466Z,1541015586.466 [WetLabsSeaOWL_UV_A](INFO): Powering down
2018-10-31T19:53:06.467Z,1541015586.467 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2018-10-31T19:53:06.467Z,1541015586.467 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2018-10-31T19:53:06.468Z,1541015586.468 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2018-10-31T19:53:06.468Z,1541015586.468 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 3167
2018-10-31T19:53:06.857Z,1541015586.857 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2018-10-31T19:53:06.857Z,1541015586.857 [CTD_NeilBrown](INFO): Powering down
2018-10-31T19:53:06.858Z,1541015586.858 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2018-10-31T19:53:06.874Z,1541015586.874 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2018-10-31T19:53:06.874Z,1541015586.874 [logger ThreadHandler](INFO): Thread cancelled.
2018-10-31T19:53:06.874Z,1541015586.874 [logger](INFO): Join timeout helper Thread ID is 3168
2018-10-31T19:53:06.875Z,1541015586.875 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2018-10-31T19:53:06.875Z,1541015586.875 [logger ThreadHandler](INFO): Thread cancelled.
2018-10-31T19:53:06.876Z,1541015586.876 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2018-10-31T19:53:06.876Z,1541015586.876 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-10-31T19:53:06.876Z,1541015586.876 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2018-10-31T19:53:06.876Z,1541015586.876 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-10-31T19:53:06.877Z,1541015586.877 [controlThread](INFO): Join timeout helper Thread ID is 3169
2018-10-31T19:53:07.097Z,1541015587.097 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2018-10-31T19:53:07.097Z,1541015587.097 [controlThread](DEBUG): Uninitializing ControlThread
2018-10-31T19:53:07.098Z,1541015587.098 [AHRS_M2](INFO): Powering down
2018-10-31T19:53:07.099Z,1541015587.099 [NAL9602](INFO): Powering down
2018-10-31T19:53:07.169Z,1541015587.169 [RDI_Pathfinder](INFO): Powering down
2018-10-31T19:53:07.170Z,1541015587.170 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-10-31T19:53:07.171Z,1541015587.171 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2018-10-31T19:53:07.172Z,1541015587.172 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2018-10-31T19:53:07.172Z,1541015587.172 [MissionManager](INFO): Uninitializing Mission Default
2018-10-31T19:53:07.172Z,1541015587.172 [Default] Stopped
2018-10-31T19:53:07.173Z,1541015587.173 [Default](DEBUG): Aggregate::uninitialize Default
2018-10-31T19:53:07.173Z,1541015587.173 [Default:B.GoToSurface] Stopped
2018-10-31T19:53:07.173Z,1541015587.173 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2018-10-31T19:53:07.173Z,1541015587.173 [Default:CheckIn] Stopped
2018-10-31T19:53:07.173Z,1541015587.173 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-10-31T19:53:07.173Z,1541015587.173 [Default:CheckIn:Read_GPS] Stopped
2018-10-31T19:53:07.176Z,1541015587.176 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2018-10-31T19:53:07.177Z,1541015587.177 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2018-10-31T19:53:07.177Z,1541015587.177 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2018-10-31T19:53:07.178Z,1541015587.178 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2018-10-31T19:53:07.178Z,1541015587.178 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2018-10-31T19:53:07.178Z,1541015587.178 [BuoyancyServo](INFO): Powering down
2018-10-31T19:53:07.193Z,1541015587.193 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2018-10-31T19:53:07.193Z,1541015587.193 [ElevatorServo](INFO): Powering down
2018-10-31T19:53:07.194Z,1541015587.194 [MassServo](DEBUG): Uninitialize Mass Servo.
2018-10-31T19:53:07.194Z,1541015587.194 [MassServo](INFO): Powering down
2018-10-31T19:53:07.195Z,1541015587.195 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2018-10-31T19:53:07.195Z,1541015587.195 [RudderServo](INFO): Powering down
2018-10-31T19:53:07.196Z,1541015587.196 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2018-10-31T19:53:07.196Z,1541015587.196 [ThrusterServo](INFO): Powering down
2018-10-31T19:53:07.197Z,1541015587.197 [SBIT](DEBUG): Uninitialize SBIT Component.
2018-10-31T19:53:07.197Z,1541015587.197 [IBIT](DEBUG): Uninitialize IBIT Component.
2018-10-31T19:53:07.197Z,1541015587.197 [CBIT](DEBUG): Uninitialize CBIT Component.
2018-10-31T19:53:07.198Z,1541015587.198 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-10-31T19:53:07.264Z,1541015587.264 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2018-10-31T19:53:07.268Z,1541015587.268 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2018-10-31T19:53:07.326Z,1541015587.326 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-10-31T19:53:07.369Z,1541015587.369 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-10-31T19:53:07.424Z,1541015587.424 [logger ThreadHandler](INFO): Thread cancelled.