2016-06-28T00:01:20.992Z,1467072080.992 [Supervisor](DEBUG): Initializing supervisor.
2016-06-28T00:01:20.996Z,1467072080.996 [SyncHandler](DEBUG): Created PCaller Thread at 4051A4E0
2016-06-28T00:01:20.997Z,1467072080.997 [SyncHandler](INFO): Protected caller Thread ID is 7070
2016-06-28T00:01:20.997Z,1467072080.997 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2016-06-28T00:01:20.999Z,1467072080.999 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4054A4E0
2016-06-28T00:01:20.999Z,1467072080.999 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 7071
2016-06-28T00:01:21.002Z,1467072081.002 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2016-06-28T00:01:21.014Z,1467072081.014 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2016-06-28T00:01:21.015Z,1467072081.015 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 4057A4E0
2016-06-28T00:01:21.015Z,1467072081.015 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 7072
2016-06-28T00:01:21.016Z,1467072081.016 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2016-06-28T00:01:21.017Z,1467072081.017 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405AA4E0
2016-06-28T00:01:21.017Z,1467072081.017 [logger ThreadHandler](INFO): Protected caller Thread ID is 7073
2016-06-28T00:01:21.019Z,1467072081.019 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2016-06-28T00:01:21.020Z,1467072081.020 [Supervisor](INFO): Looking for Config files in directory: Config/
2016-06-28T00:01:21.021Z,1467072081.021 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2016-06-28T00:01:21.105Z,1467072081.105 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2016-06-28T00:01:21.418Z,1467072081.418 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2016-06-28T00:01:21.418Z,1467072081.418 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2016-06-28T00:01:21.540Z,1467072081.540 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2016-06-28T00:01:21.541Z,1467072081.541 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2016-06-28T00:01:21.721Z,1467072081.721 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2016-06-28T00:01:21.722Z,1467072081.722 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2016-06-28T00:01:21.822Z,1467072081.822 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2016-06-28T00:01:21.822Z,1467072081.822 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2016-06-28T00:01:21.996Z,1467072081.996 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2016-06-28T00:01:21.996Z,1467072081.996 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2016-06-28T00:01:22.451Z,1467072082.451 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2016-06-28T00:01:22.451Z,1467072082.451 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2016-06-28T00:01:22.731Z,1467072082.731 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2016-06-28T00:01:22.732Z,1467072082.732 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2016-06-28T00:01:22.816Z,1467072082.816 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2016-06-28T00:01:22.817Z,1467072082.817 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2016-06-28T00:01:22.945Z,1467072082.945 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2016-06-28T00:01:22.946Z,1467072082.945 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2016-06-28T00:01:23.132Z,1467072083.132 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2016-06-28T00:01:23.132Z,1467072083.132 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2016-06-28T00:01:23.589Z,1467072083.589 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2016-06-28T00:01:23.589Z,1467072083.589 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2016-06-28T00:01:23.937Z,1467072083.937 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2016-06-28T00:01:23.938Z,1467072083.938 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2016-06-28T00:01:24.229Z,1467072084.229 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2016-06-28T00:01:24.230Z,1467072084.230 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2016-06-28T00:01:24.336Z,1467072084.336 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2016-06-28T00:01:24.339Z,1467072084.339 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/
2016-06-28T00:01:24.340Z,1467072084.340 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Control.cfg
2016-06-28T00:01:24.436Z,1467072084.436 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Navigation.cfg
2016-06-28T00:01:24.552Z,1467072084.552 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/secure.cfg
2016-06-28T00:01:24.638Z,1467072084.638 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/BIT.cfg
2016-06-28T00:01:24.736Z,1467072084.736 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Simulator.cfg
2016-06-28T00:01:24.823Z,1467072084.823 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Science.cfg
2016-06-28T00:01:24.963Z,1467072084.963 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/logger.cfg
2016-06-28T00:01:25.059Z,1467072085.059 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/vehicle.cfg
2016-06-28T00:01:25.218Z,1467072085.218 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Battery.cfg
2016-06-28T00:01:25.463Z,1467072085.463 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2016-06-28T00:01:25.464Z,1467072085.464 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Sensor.cfg
2016-06-28T00:01:25.631Z,1467072085.631 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Servo.cfg
2016-06-28T00:01:25.733Z,1467072085.733 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/root/
2016-06-28T00:01:25.734Z,1467072085.734 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2016-06-28T00:01:25.735Z,1467072085.736 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2016-06-28T00:01:25.761Z,1467072085.761 [DepthRateCalculator] Loaded
2016-06-28T00:01:25.761Z,1467072085.761 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2016-06-28T00:01:25.768Z,1467072085.768 [PitchRateCalculator] Loaded
2016-06-28T00:01:25.768Z,1467072085.768 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2016-06-28T00:01:25.780Z,1467072085.780 [SpeedCalculator] Loaded
2016-06-28T00:01:25.780Z,1467072085.780 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2016-06-28T00:01:25.796Z,1467072085.796 [TempGradientCalculator] Loaded
2016-06-28T00:01:25.796Z,1467072085.796 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2016-06-28T00:01:25.812Z,1467072085.812 [VerticalTemperatureHomogeneityIndexCalculator] Loaded
2016-06-28T00:01:25.813Z,1467072085.813 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread.
2016-06-28T00:01:25.819Z,1467072085.819 [YawRateCalculator] Loaded
2016-06-28T00:01:25.819Z,1467072085.819 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2016-06-28T00:01:25.820Z,1467072085.819 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2016-06-28T00:01:25.820Z,1467072085.820 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2016-06-28T00:01:25.922Z,1467072085.922 [DeadReckonUsingMultipleVelocitySources] Loaded
2016-06-28T00:01:25.922Z,1467072085.922 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2016-06-28T00:01:25.978Z,1467072085.978 [DeadReckonUsingSpeedCalculator] Loaded
2016-06-28T00:01:25.979Z,1467072085.978 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2016-06-28T00:01:25.996Z,1467072085.996 [NavChart] Loaded
2016-06-28T00:01:25.996Z,1467072085.996 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2016-06-28T00:01:26.000Z,1467072086.000 [UniversalFixResidualReporter] Loaded
2016-06-28T00:01:26.001Z,1467072086.001 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2016-06-28T00:01:26.001Z,1467072086.001 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2016-06-28T00:01:26.002Z,1467072086.002 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2016-06-28T00:01:26.100Z,1467072086.100 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2016-06-28T00:01:26.100Z,1467072086.100 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2016-06-28T00:01:26.125Z,1467072086.125 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2016-06-28T00:01:26.126Z,1467072086.126 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2016-06-28T00:01:26.132Z,1467072086.132 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2016-06-28T00:01:26.133Z,1467072086.133 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2016-06-28T00:01:26.482Z,1467072086.482 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2016-06-28T00:01:26.483Z,1467072086.483 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2016-06-28T00:01:26.604Z,1467072086.605 [SBIT](DEBUG): Construct Startup Built In Test.
2016-06-28T00:01:26.636Z,1467072086.636 [SBIT] Loaded
2016-06-28T00:01:26.637Z,1467072086.637 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2016-06-28T00:01:26.637Z,1467072086.637 [IBIT](DEBUG): Construct Initiated Built In Test.
2016-06-28T00:01:26.666Z,1467072086.666 [IBIT] Loaded
2016-06-28T00:01:26.666Z,1467072086.666 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2016-06-28T00:01:26.670Z,1467072086.670 [CBIT](DEBUG): Construct Continuous Built In Test.
2016-06-28T00:01:26.825Z,1467072086.825 [CBIT] Loaded
2016-06-28T00:01:26.825Z,1467072086.825 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2016-06-28T00:01:26.825Z,1467072086.825 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2016-06-28T00:01:26.826Z,1467072086.826 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2016-06-28T00:01:27.098Z,1467072087.099 [DataOverHttps] Loaded
2016-06-28T00:01:27.099Z,1467072087.099 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2016-06-28T00:01:27.127Z,1467072087.127 [Depth_Keller] Loaded
2016-06-28T00:01:27.127Z,1467072087.127 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2016-06-28T00:01:27.239Z,1467072087.239 [NAL9602] Loaded
2016-06-28T00:01:27.239Z,1467072087.239 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2016-06-28T00:01:27.250Z,1467072087.250 [Onboard] Loaded
2016-06-28T00:01:27.250Z,1467072087.250 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2016-06-28T00:01:27.257Z,1467072087.257 [Radio_Surface] Loaded
2016-06-28T00:01:27.258Z,1467072087.258 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2016-06-28T00:01:27.259Z,1467072087.259 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409234E0
2016-06-28T00:01:27.259Z,1467072087.259 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 7152
2016-06-28T00:01:27.309Z,1467072087.309 [PNI_TCM] Loaded
2016-06-28T00:01:27.310Z,1467072087.309 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread.
2016-06-28T00:01:27.380Z,1467072087.380 [Rowe_600LCM] Loaded
2016-06-28T00:01:27.381Z,1467072087.381 [ComponentRegistry](DEBUG): Component "Rowe_600LCM" handled in its own thread.
2016-06-28T00:01:27.382Z,1467072087.382 [Rowe_600LCM ThreadHandler](DEBUG): Created PCaller Thread at 409534E0
2016-06-28T00:01:27.382Z,1467072087.382 [Rowe_600LCM ThreadHandler](INFO): Protected caller Thread ID is 7153
2016-06-28T00:01:29.318Z,1467072089.318 [BPC1] Loaded
2016-06-28T00:01:29.319Z,1467072089.319 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2016-06-28T00:01:29.319Z,1467072089.319 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2016-06-28T00:01:29.320Z,1467072089.320 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2016-06-28T00:01:29.424Z,1467072089.424 [BuoyancyServo] Loaded
2016-06-28T00:01:29.425Z,1467072089.425 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2016-06-28T00:01:29.442Z,1467072089.442 [ElevatorServo] Loaded
2016-06-28T00:01:29.442Z,1467072089.442 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2016-06-28T00:01:29.458Z,1467072089.458 [MassServo] Loaded
2016-06-28T00:01:29.458Z,1467072089.458 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2016-06-28T00:01:29.474Z,1467072089.474 [RudderServo] Loaded
2016-06-28T00:01:29.475Z,1467072089.474 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2016-06-28T00:01:29.490Z,1467072089.490 [ThrusterServo] Loaded
2016-06-28T00:01:29.490Z,1467072089.490 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2016-06-28T00:01:29.491Z,1467072089.491 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2016-06-28T00:01:29.491Z,1467072089.491 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2016-06-28T00:01:29.541Z,1467072089.541 [VerticalControl](DEBUG): Construct VerticalControl.
2016-06-28T00:01:29.636Z,1467072089.635 [VerticalControl] Loaded
2016-06-28T00:01:29.636Z,1467072089.636 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2016-06-28T00:01:29.637Z,1467072089.636 [HorizontalControl](DEBUG): Construct HorizontalControl.
2016-06-28T00:01:29.699Z,1467072089.699 [HorizontalControl] Loaded
2016-06-28T00:01:29.699Z,1467072089.699 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2016-06-28T00:01:29.700Z,1467072089.700 [SpeedControl](DEBUG): Construct SpeedControl.
2016-06-28T00:01:29.702Z,1467072089.702 [SpeedControl] Loaded
2016-06-28T00:01:29.702Z,1467072089.702 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2016-06-28T00:01:29.703Z,1467072089.703 [LoopControl](DEBUG): Construct LoopControl.
2016-06-28T00:01:29.703Z,1467072089.703 [LoopControl] Loaded
2016-06-28T00:01:29.703Z,1467072089.704 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2016-06-28T00:01:29.704Z,1467072089.704 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2016-06-28T00:01:29.705Z,1467072089.705 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2016-06-28T00:01:29.799Z,1467072089.799 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC
2016-06-28T00:01:29.799Z,1467072089.799 [StratificationFrontDetector](DEBUG): (re)initializing
2016-06-28T00:01:29.800Z,1467072089.800 [StratificationFrontDetector] Loaded
2016-06-28T00:01:29.800Z,1467072089.800 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread.
2016-06-28T00:01:29.800Z,1467072089.800 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2016-06-28T00:01:29.801Z,1467072089.801 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2016-06-28T00:01:29.921Z,1467072089.921 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2016-06-28T00:01:29.925Z,1467072089.925 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2016-06-28T00:01:29.926Z,1467072089.926 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2016-06-28T00:01:29.933Z,1467072089.932 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2016-06-28T00:01:29.934Z,1467072089.934 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A5D4E0
2016-06-28T00:01:29.934Z,1467072089.934 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 7154
2016-06-28T00:01:29.939Z,1467072089.939 [Supervisor](INFO): Main Thread ID is 6578
2016-06-28T00:01:29.939Z,1467072089.939 [Supervisor](DEBUG): Running supervisor.
2016-06-28T00:01:29.940Z,1467072089.940 [CommandLine ThreadHandler](INFO): Handler Thread ID is 7155
2016-06-28T00:01:29.943Z,1467072089.943 [controlThread ThreadHandler](INFO): Handler Thread ID is 7156
2016-06-28T00:01:29.943Z,1467072089.943 [controlThread](DEBUG): Initializing ControlThread
2016-06-28T00:01:29.944Z,1467072089.944 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2016-06-28T00:01:29.945Z,1467072089.944 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2016-06-28T00:01:29.945Z,1467072089.945 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2016-06-28T00:01:29.945Z,1467072089.945 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2016-06-28T00:01:29.946Z,1467072089.946 [VerticalTemperatureHomogeneityIndexCalculator](DEBUG): (re)initializing
2016-06-28T00:01:29.947Z,1467072089.947 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2016-06-28T00:01:29.947Z,1467072089.947 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-06-28T00:01:29.948Z,1467072089.948 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-06-28T00:01:29.948Z,1467072089.948 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-06-28T00:01:29.949Z,1467072089.949 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2016-06-28T00:01:29.949Z,1467072089.949 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2016-06-28T00:01:29.950Z,1467072089.950 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2016-06-28T00:01:29.950Z,1467072089.950 [NavChart](DEBUG): Initialize NavChart Navigation.
2016-06-28T00:01:29.950Z,1467072089.950 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2016-06-28T00:01:29.951Z,1467072089.951 [SBIT](INFO): Initialize SBIT Component.
2016-06-28T00:01:29.951Z,1467072089.951 [SBIT](IMPORTANT): git: 2015-12-17-109-g257a154
2016-06-28T00:01:29.951Z,1467072089.951 [SBIT](INFO): git hash: 257a1547f8111cca91b00dd2487919c4d9436f7c
2016-06-28T00:01:29.953Z,1467072089.953 [SBIT](INFO): Kernel Reporting Different Release From Configuration.
Kernel Expected: 2.6.27.8
Kernel Reported: 2.6.27.8-00011-g2bc81df-dirty
2016-06-28T00:01:29.953Z,1467072089.953 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #639 PREEMPT Wed Mar 12 12:53:33 PDT 2014
Kernel Reported: #646 PREEMPT Thu Feb 11 17:01:12 PST 2016
2016-06-28T00:01:29.954Z,1467072089.954 [SBIT](INFO): Beginning SBIT in 20.000000 seconds.
2016-06-28T00:01:29.955Z,1467072089.955 [IBIT](INFO): Initialize IBIT Component.
2016-06-28T00:01:29.956Z,1467072089.956 [CBIT](DEBUG): Initialize CBIT Component.
2016-06-28T00:01:29.956Z,1467072089.956 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2016-06-28T00:01:29.957Z,1467072089.957 [logger ThreadHandler](INFO): Handler Thread ID is 7157
2016-06-28T00:01:29.984Z,1467072089.984 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 7158
2016-06-28T00:01:29.990Z,1467072089.990 [Radio_Surface](INFO): Powering up
2016-06-28T00:01:30.007Z,1467072090.007 [Rowe_600LCM ThreadHandler](INFO): Handler Thread ID is 7159
2016-06-28T00:01:30.008Z,1467072090.008 [Rowe_600LCM](INFO): Initializing
2016-06-28T00:01:30.009Z,1467072090.009 [Rowe_600LCM](INFO): Checking LCM
2016-06-28T00:01:30.009Z,1467072090.009 [Rowe_600LCM](INFO): LCM OK
2016-06-28T00:01:30.009Z,1467072090.009 [Rowe_600LCM](INFO): Powering up
2016-06-28T00:01:30.028Z,1467072090.028 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 7160
2016-06-28T00:01:30.032Z,1467072090.032 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources/ElectronicNavigationCharts
2016-06-28T00:01:30.033Z,1467072090.033 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2016-06-28T00:01:30.033Z,1467072090.033 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2MI01M.000
2016-06-28T00:01:30.033Z,1467072090.033 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2MI80M.000
2016-06-28T00:01:30.034Z,1467072090.034 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2016-06-28T00:01:30.034Z,1467072090.034 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2016-06-28T00:01:30.034Z,1467072090.034 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2016-06-28T00:01:30.034Z,1467072090.034 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4IN01M.000
2016-06-28T00:01:30.035Z,1467072090.035 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI56M.000
2016-06-28T00:01:30.035Z,1467072090.035 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI57M.000
2016-06-28T00:01:30.035Z,1467072090.035 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI59M.000
2016-06-28T00:01:30.036Z,1467072090.036 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI89M.000
2016-06-28T00:01:30.036Z,1467072090.036 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI90M.000
2016-06-28T00:01:30.036Z,1467072090.036 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4WI03M.000
2016-06-28T00:01:30.036Z,1467072090.036 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4WI06M.000
2016-06-28T00:01:30.036Z,1467072090.036 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4WI33M.000
2016-06-28T00:01:30.037Z,1467072090.037 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4WI34M.000
2016-06-28T00:01:30.037Z,1467072090.037 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2016-06-28T00:01:30.037Z,1467072090.037 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2016-06-28T00:01:30.037Z,1467072090.037 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2016-06-28T00:01:30.038Z,1467072090.037 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2016-06-28T00:01:30.046Z,1467072090.046 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2016-06-28T00:01:30.052Z,1467072090.052 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2016-06-28T00:01:30.053Z,1467072090.053 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2016-06-28T00:01:30.053Z,1467072090.053 [LoopControl](DEBUG): Initialize LoopControlComponent.
2016-06-28T00:01:30.054Z,1467072090.054 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2016-06-28T00:01:30.085Z,1467072090.085 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2016-06-28T00:01:30.107Z,1467072090.107 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="StartupSatComms">

        <Sequence/>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:latitude_fix/>
        </ReadDatum>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:platform_communications/>
        </ReadDatum>

    </Aggregate>

</Mission>


2016-06-28T00:01:30.124Z,1467072090.124 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2016-06-28T00:01:30.178Z,1467072090.178 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2016-06-28T00:01:30.195Z,1467072090.195 [Default:A.Wait](DEBUG): Construct Wait.
2016-06-28T00:01:30.197Z,1467072090.197 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2016-06-28T00:01:30.223Z,1467072090.223 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2016-06-28T00:01:30.226Z,1467072090.226 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2016-06-28T00:01:30.255Z,1467072090.255 [Default:E.Execute](DEBUG): Construct Execute.
2016-06-28T00:01:30.259Z,1467072090.259 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
xmlns:Guidance="Tethys/Guidance"
xmlns:Units="Tethys/Units"
xmlns:Universal="Tethys/Universal"
xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
Id="Default">

    <DefineArg Name="ElapsedSinceDefaultStarted"><Units:minute/><Value>0</Value></DefineArg>

    <Guidance:Wait>
        <Sequence/>
        <Description>
            Wait a moment to see if the scheduler starts a new mission before
            starting to actually run Default.
        </Description>
        <Setting><Guidance:Wait.duration/><Units:second/><Value>13</Value></Setting>
    </Guidance:Wait>

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

        <ReadDatum Id="Read_GPS">
            <Sequence/>
            <Timeout Duration="P5M"/>
            <Universal:time_fix/>
        </ReadDatum>

        <ReadDatum Id="Read_Iridium">
            <Sequence/>
            <Timeout Duration="P2H">
                <Guidance:Execute>
                    <Sequence/>
                    <Setting><Guidance:Execute.command/><String>Burn 300</String></Setting>
                </Guidance:Execute>
                <Syslog Severity="Critical">Dropped weight due to communications timeout.</Syslog>
            </Timeout>
            <Universal:platform_communications/>
        </ReadDatum>

        <Guidance:Wait>
            <Sequence/>
            <Setting><Guidance:Wait.duration/><Units:minute/><Value>5</Value></Setting>
        </Guidance:Wait>

        <Assign><Sequence/><Arg Name="ElapsedSinceDefaultStarted"/><Elapsed><Universal:mission_started/></Elapsed></Assign>

        <Syslog Severity="Important">Default mission has been running for <Arg Name="ElapsedSinceDefaultStarted"/><Units:minute/></Syslog>

    </Aggregate>

    <Syslog Severity="Important">Restarting logs and Default mission.</Syslog>

    <Guidance:Execute>
        <Sequence/>
        <Setting><Guidance:Execute.command/><String>restart logs</String></Setting>
    </Guidance:Execute>

</Mission>


2016-06-28T00:01:30.284Z,1467072090.284 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,NAL9602,Onboard,PNI_TCM,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,VerticalTemperatureHomogeneityIndexCalculator,YawRateCalculator,StratificationFrontDetector,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2016-06-28T00:01:30.618Z,1467072090.618 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-06-28T00:01:30.667Z,1467072090.667 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-06-28T00:01:30.788Z,1467072090.788 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2016-06-28T00:01:30.788Z,1467072090.788 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2016-06-28T00:01:30.794Z,1467072090.794 [ElevatorServo](DEBUG): Initializing EZServoServo.
2016-06-28T00:01:30.794Z,1467072090.794 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2016-06-28T00:01:30.820Z,1467072090.820 [MassServo](DEBUG): Initializing EZServoServo.
2016-06-28T00:01:30.820Z,1467072090.820 [MassServo](DEBUG): Initializing MassServo.
2016-06-28T00:01:30.830Z,1467072090.830 [RudderServo](DEBUG): Initializing EZServoServo.
2016-06-28T00:01:30.835Z,1467072090.835 [RudderServo](DEBUG): Initializing RudderServo.
2016-06-28T00:01:30.857Z,1467072090.857 [ThrusterServo](DEBUG): Initializing EZServoServo.
2016-06-28T00:01:30.857Z,1467072090.857 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2016-06-28T00:01:31.155Z,1467072091.155 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-06-28T00:01:31.156Z,1467072091.157 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-06-28T00:01:31.376Z,1467072091.376 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-06-28T00:01:31.378Z,1467072091.378 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-06-28T00:01:31.851Z,1467072091.851 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-06-28T00:01:31.859Z,1467072091.859 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-06-28T00:01:32.248Z,1467072092.247 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-06-28T00:01:32.249Z,1467072092.249 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-06-28T00:01:32.605Z,1467072092.605 [NAL9602](INFO): Powering up NAL9602
2016-06-28T00:01:32.627Z,1467072092.627 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-06-28T00:01:32.628Z,1467072092.628 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-06-28T00:01:33.027Z,1467072093.027 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-06-28T00:01:33.028Z,1467072093.028 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-06-28T00:01:33.441Z,1467072093.441 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-06-28T00:01:33.442Z,1467072093.442 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-06-28T00:01:34.388Z,1467072094.388 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2016-06-28T00:01:34.527Z,1467072094.527 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:./bin/roweadcp -dev /dev/ttyB4 -b 38400 >& /dev/null &
2016-06-28T00:01:34.566Z,1467072094.566 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2016-06-28T00:01:34.580Z,1467072094.580 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2016-06-28T00:01:43.828Z,1467072103.828 [NAL9602](INFO): NAL9602 initialized
2016-06-28T00:01:50.306Z,1467072110.306 [SBIT](IMPORTANT): Beginning Startup BIT
2016-06-28T00:01:50.310Z,1467072110.310 [CBIT](IMPORTANT): Beginning GF scan
2016-06-28T00:01:50.876Z,1467072110.876 [CBIT](IMPORTANT): Open Volts:2.499757
Open Current:0.000663
2016-06-28T00:01:52.816Z,1467072112.816 [CBIT](IMPORTANT): A0 Volts:2.670329
A0 Current:0.107641
2016-06-28T00:01:54.432Z,1467072114.432 [CBIT](IMPORTANT): A1 Volts:2.013915
A1 Current:-0.309747
2016-06-28T00:01:55.892Z,1467072115.892 [CBIT](IMPORTANT): A2 Volts:2.668958
A2 Current:0.107800
2016-06-28T00:01:57.704Z,1467072117.704 [CBIT](IMPORTANT): A3 Volts:2.618606
A3 Current:0.075203
2016-06-28T00:01:58.944Z,1467072118.944 [CBIT](IMPORTANT): B0 Volts:2.389965
B0 Current:-0.070140
2016-06-28T00:02:00.355Z,1467072120.355 [CBIT](IMPORTANT): B1 Volts:2.285302
B1 Current:-0.136829
2016-06-28T00:02:01.585Z,1467072121.585 [CBIT](IMPORTANT): B2 Volts:2.282708
B2 Current:-0.138413
2016-06-28T00:02:03.083Z,1467072123.083 [CBIT](IMPORTANT): B3 Volts:1.776972
B3 Current:-0.459760
2016-06-28T00:02:03.494Z,1467072123.494 [CBIT](FAULT): Low side GF detected
mA:
CHAN A0 (Batt): 0.107641
CHAN A1 (24V): -0.309747
CHAN A2 (12V): 0.107800
CHAN A3 (5V): 0.075203
CHAN B0 (3.3V): -0.070140
CHAN B1 (3.15aV): -0.136829
CHAN B2 (3.15bV): -0.138413
CHAN B3 (GND): -0.459760
OPEN: 0.000663
Full Scale Calc: 4.765 mA, -1.589 mA
2016-06-28T00:02:12.234Z,1467072132.234 [PNI_TCM](ERROR): CRC does not match. Expected:0x49826 got:0x29456
2016-06-28T00:02:12.634Z,1467072132.634 [PNI_TCM](ERROR): CRC does not match. Expected:0x63741 got:0x29458
2016-06-28T00:02:13.014Z,1467072133.014 [PNI_TCM](ERROR): CRC does not match. Expected:0x13716 got:0x29460
2016-06-28T00:02:13.509Z,1467072133.509 [PNI_TCM](ERROR): CRC does not match. Expected:0x29198 got:0x29453
2016-06-28T00:02:13.958Z,1467072133.958 [PNI_TCM](ERROR): CRC does not match. Expected:0x37603 got:0x29445
2016-06-28T00:02:14.223Z,1467072134.223 [PNI_TCM](ERROR): CRC does not match. Expected:0x38692 got:0x29448
2016-06-28T00:02:14.624Z,1467072134.624 [PNI_TCM](ERROR): CRC does not match. Expected:0x63156 got:0x29446
2016-06-28T00:02:15.036Z,1467072135.036 [PNI_TCM](ERROR): CRC does not match. Expected:0x46313 got:0x29446
2016-06-28T00:02:15.532Z,1467072135.532 [PNI_TCM](ERROR): CRC does not match. Expected:0x46313 got:0x29445
2016-06-28T00:02:15.932Z,1467072135.932 [PNI_TCM](ERROR): CRC does not match. Expected:0x38692 got:0x29442
2016-06-28T00:02:16.250Z,1467072136.250 [PNI_TCM](ERROR): CRC does not match. Expected:0x15898 got:0x29449
2016-06-28T00:02:16.650Z,1467072136.650 [PNI_TCM](ERROR): CRC does not match. Expected:0x6160 got:0x29455
2016-06-28T00:02:17.051Z,1467072137.051 [PNI_TCM](ERROR): CRC does not match. Expected:0x24458 got:0x29449
2016-06-28T00:02:17.451Z,1467072137.451 [PNI_TCM](ERROR): CRC does not match. Expected:0x6160 got:0x29437
2016-06-28T00:02:17.961Z,1467072137.961 [PNI_TCM](ERROR): CRC does not match. Expected:0x17625 got:0x29430
2016-06-28T00:02:18.287Z,1467072138.287 [PNI_TCM](ERROR): CRC does not match. Expected:0x25299 got:0x29446
2016-06-28T00:02:18.646Z,1467072138.646 [PNI_TCM](ERROR): CRC does not match. Expected:0x46313 got:0x29451
2016-06-28T00:02:19.040Z,1467072139.040 [PNI_TCM](ERROR): CRC does not match. Expected:0x54649 got:0x29446
2016-06-28T00:02:19.481Z,1467072139.481 [PNI_TCM](ERROR): CRC does not match. Expected:0x46313 got:0x29446
2016-06-28T00:02:19.927Z,1467072139.927 [PNI_TCM](ERROR): CRC does not match. Expected:0x46313 got:0x29452
2016-06-28T00:02:20.240Z,1467072140.240 [PNI_TCM](ERROR): CRC does not match. Expected:0x31815 got:0x29448
2016-06-28T00:02:20.636Z,1467072140.636 [PNI_TCM](ERROR): CRC does not match. Expected:0x63156 got:0x29446
2016-06-28T00:02:21.158Z,1467072141.158 [PNI_TCM](ERROR): CRC does not match. Expected:0x46313 got:0x29445
2016-06-28T00:02:21.555Z,1467072141.555 [PNI_TCM](ERROR): CRC does not match. Expected:0x38692 got:0x29449
2016-06-28T00:02:21.556Z,1467072141.556 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-28T00:02:21.556Z,1467072141.556 [PNI_TCM] Data Fault, FailCount= 1
2016-06-28T00:02:21.556Z,1467072141.556 [PNI_TCM](ERROR): Data Fault
2016-06-28T00:02:21.607Z,1467072141.607 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.397300 seconds old.
2016-06-28T00:02:21.620Z,1467072141.620 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.399200 seconds old.
2016-06-28T00:02:21.721Z,1467072141.721 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-28T00:02:21.878Z,1467072141.878 [PNI_TCM](INFO): Powering down
2016-06-28T00:02:21.926Z,1467072141.926 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.717100 seconds old.
2016-06-28T00:02:21.938Z,1467072141.938 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.716600 seconds old.
2016-06-28T00:02:22.243Z,1467072142.243 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.034700 seconds old.
2016-06-28T00:02:22.245Z,1467072142.245 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.024000 seconds old.
2016-06-28T00:02:22.679Z,1467072142.679 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.470600 seconds old.
2016-06-28T00:02:22.684Z,1467072142.684 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.462700 seconds old.
2016-06-28T00:02:23.037Z,1467072143.037 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.827800 seconds old.
2016-06-28T00:02:23.053Z,1467072143.053 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.831600 seconds old.
2016-06-28T00:02:23.167Z,1467072143.167 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-28T00:02:23.167Z,1467072143.167 [PNI_TCM] No Fault, FailCount= 1
2016-06-28T00:02:23.508Z,1467072143.508 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.298900 seconds old.
2016-06-28T00:02:23.520Z,1467072143.520 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.298800 seconds old.
2016-06-28T00:02:23.874Z,1467072143.874 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.664600 seconds old.
2016-06-28T00:02:23.880Z,1467072143.880 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.659300 seconds old.
2016-06-28T00:02:24.258Z,1467072144.258 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.049500 seconds old.
2016-06-28T00:02:24.264Z,1467072144.264 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.042900 seconds old.
2016-06-28T00:02:24.649Z,1467072144.649 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.440300 seconds old.
2016-06-28T00:02:24.650Z,1467072144.650 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.429600 seconds old.
2016-06-28T00:02:25.054Z,1467072145.054 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.844900 seconds old.
2016-06-28T00:02:25.060Z,1467072145.060 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.839300 seconds old.
2016-06-28T00:02:25.526Z,1467072145.526 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.316700 seconds old.
2016-06-28T00:02:25.538Z,1467072145.538 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.316600 seconds old.
2016-06-28T00:02:25.877Z,1467072145.877 [BPC1](ERROR): Failed to parse bank A battery data
2016-06-28T00:02:25.877Z,1467072145.877 [BPC1] Data Fault, FailCount= 1
2016-06-28T00:02:25.878Z,1467072145.878 [BPC1](ERROR): Data Fault
2016-06-28T00:02:25.942Z,1467072145.942 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.732500 seconds old.
2016-06-28T00:02:25.963Z,1467072145.963 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.733600 seconds old.
2016-06-28T00:02:26.062Z,1467072146.062 [CBIT](ERROR): Data Fault in component: BPC1
2016-06-28T00:02:26.243Z,1467072146.243 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.034500 seconds old.
2016-06-28T00:02:26.245Z,1467072146.245 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.023800 seconds old.
2016-06-28T00:02:27.284Z,1467072147.284 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-28T00:02:27.284Z,1467072147.284 [BPC1] No Fault, FailCount= 1
2016-06-28T00:02:44.132Z,1467072164.132 [SBIT](IMPORTANT): SBIT PASSED
2016-06-28T00:02:44.225Z,1467072164.225 [MissionManager](IMPORTANT): Started mission Startup
2016-06-28T00:02:44.225Z,1467072164.225 [Startup] Running Loop=1
2016-06-28T00:02:44.226Z,1467072164.226 [Startup](DEBUG): Aggregate::initialize Startup
2016-06-28T00:02:44.226Z,1467072164.226 [Startup:A.GoToSurface] Running Loop=1
2016-06-28T00:02:44.226Z,1467072164.226 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2016-06-28T00:02:44.226Z,1467072164.226 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2016-06-28T00:02:44.227Z,1467072164.227 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2016-06-28T00:02:44.235Z,1467072164.235 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2016-06-28T00:02:44.236Z,1467072164.236 [Startup:A.GoToSurface](DEBUG): No pitch timeout specified. Using default value of 20.000000 seconds.
2016-06-28T00:02:44.236Z,1467072164.236 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2016-06-28T00:02:44.250Z,1467072164.250 [Startup:StartupSatComms] Running Loop=1
2016-06-28T00:02:44.250Z,1467072164.250 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2016-06-28T00:02:44.250Z,1467072164.250 [Startup:StartupSatComms:A] Running Loop=1
2016-06-28T00:02:44.627Z,1467072164.627 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2016-06-28T00:03:08.841Z,1467072188.841 [CommandLine](IMPORTANT): got command show best platform_magnetic_orientation
2016-06-28T00:03:08.841Z,1467072188.841 [CommandLine](IMPORTANT): platform_magnetic_orientation best is PNI_TCM.platform_magnetic_orientation
2016-06-28T00:03:49.728Z,1467072229.728 [Startup:StartupSatComms:A](INFO): Timed out from 2016-06-28T00:02:44.3Z
2016-06-28T00:03:49.728Z,1467072229.728 [Startup:StartupSatComms:A] Stopped
2016-06-28T00:03:49.728Z,1467072229.728 [Startup:StartupSatComms:B] Running Loop=1
2016-06-28T00:03:50.079Z,1467072230.079 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2016-06-28T00:03:50.797Z,1467072230.797 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003900
2016-06-28T00:04:02.095Z,1467072242.095 [DataOverHttps](INFO): Sending 91 bytes from file Logs/20160627T232825/Courier0016.lzma
2016-06-28T00:04:02.661Z,1467072242.661 [DataOverHttps](INFO): Moved sent file to Logs/20160627T232825/Courier0016.lzma.bak
2016-06-28T00:04:02.661Z,1467072242.661 [DataOverHttps](INFO): SBD MOMSN=4312831
2016-06-28T00:04:27.790Z,1467072267.790 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:04:28.584Z,1467072268.584 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:04:28.834Z,1467072268.834 [DataOverHttps](INFO): Sending 224 bytes from file Logs/20160627T232825/Express0017.lzma
2016-06-28T00:04:29.640Z,1467072269.640 [DataOverHttps](INFO): Moved sent file to Logs/20160627T232825/Express0017.lzma.bak
2016-06-28T00:04:29.641Z,1467072269.641 [DataOverHttps](INFO): SBD MOMSN=4312834
2016-06-28T00:04:30.771Z,1467072270.770 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-06-28T00:04:30.771Z,1467072270.771 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2016-06-28T00:04:30.771Z,1467072270.771 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-06-28T00:04:30.777Z,1467072270.777 [DeadReckonUsingSpeedCalculator](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-06-28T00:04:30.777Z,1467072270.777 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2016-06-28T00:04:30.777Z,1467072270.777 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2016-06-28T00:04:30.826Z,1467072270.826 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-06-28T00:04:30.826Z,1467072270.826 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2016-06-28T00:04:31.189Z,1467072271.189 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-06-28T00:04:31.190Z,1467072271.190 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2016-06-28T00:04:31.191Z,1467072271.191 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2016-06-28T00:04:31.191Z,1467072271.191 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2016-06-28T00:04:40.764Z,1467072280.764 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-06-28T00:04:40.764Z,1467072280.764 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-06-28T00:04:40.764Z,1467072280.764 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-06-28T00:04:40.765Z,1467072280.765 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2016-06-28T00:04:40.765Z,1467072280.765 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2016-06-28T00:04:40.766Z,1467072280.766 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2016-06-28T00:04:52.317Z,1467072292.317 [Startup:StartupSatComms:B](INFO): Timed out from 2016-06-28T00:03:49.7Z
2016-06-28T00:04:52.317Z,1467072292.317 [Startup:StartupSatComms:B] Stopped
2016-06-28T00:04:52.317Z,1467072292.317 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2016-06-28T00:04:52.317Z,1467072292.317 [Startup:StartupSatComms] Stopped
2016-06-28T00:04:52.317Z,1467072292.317 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2016-06-28T00:04:52.318Z,1467072292.318 [Startup](INFO): Completed Startup
2016-06-28T00:04:52.318Z,1467072292.318 [Startup] Stopped
2016-06-28T00:04:52.319Z,1467072292.319 [Startup](DEBUG): Aggregate::uninitialize Startup
2016-06-28T00:04:52.319Z,1467072292.319 [Startup:A.GoToSurface] Stopped
2016-06-28T00:04:52.319Z,1467072292.319 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2016-06-28T00:04:52.345Z,1467072292.345 [DataOverHttps](INFO): Sending 805 bytes from file Logs/20160628T000120/Express0001.lzma
2016-06-28T00:04:52.442Z,1467072292.442 [MissionManager](IMPORTANT): Started mission Default
2016-06-28T00:04:52.442Z,1467072292.443 [Default] Running Loop=1
2016-06-28T00:04:52.443Z,1467072292.443 [Default](DEBUG): Aggregate::initialize Default
2016-06-28T00:04:52.443Z,1467072292.443 [Default:B.GoToSurface] Running Loop=1
2016-06-28T00:04:52.443Z,1467072292.443 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2016-06-28T00:04:52.443Z,1467072292.443 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2016-06-28T00:04:52.444Z,1467072292.444 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2016-06-28T00:04:52.444Z,1467072292.444 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2016-06-28T00:04:52.444Z,1467072292.444 [Default:B.GoToSurface](DEBUG): No pitch timeout specified. Using default value of 20.000000 seconds.
2016-06-28T00:04:52.445Z,1467072292.445 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2016-06-28T00:04:52.445Z,1467072292.445 [Default:A.Wait] Running Loop=1
2016-06-28T00:04:52.445Z,1467072292.445 [Default:A.Wait](DEBUG): Initialize Wait Component.
2016-06-28T00:04:53.192Z,1467072293.192 [DataOverHttps](INFO): Moved sent file to Logs/20160628T000120/Express0001.lzma.bak
2016-06-28T00:04:53.192Z,1467072293.192 [DataOverHttps](INFO): SBD MOMSN=4312842
2016-06-28T00:05:05.841Z,1467072305.841 [Default:A.Wait](INFO): Done Waiting.
2016-06-28T00:05:05.842Z,1467072305.842 [Default:A.Wait] Stopped
2016-06-28T00:05:05.843Z,1467072305.843 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2016-06-28T00:05:06.330Z,1467072306.330 [Default:CheckIn] Running Loop=1
2016-06-28T00:05:06.330Z,1467072306.330 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2016-06-28T00:05:06.331Z,1467072306.331 [Default:CheckIn:Read_GPS] Running Loop=1
2016-06-28T00:05:06.499Z,1467072306.499 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2016-06-28T00:05:17.642Z,1467072317.642 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:05:18.437Z,1467072318.437 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:05:22.305Z,1467072322.305 [BPC1](ERROR): Failed to receive battery data
2016-06-28T00:05:22.305Z,1467072322.305 [BPC1] Communications Fault, FailCount= 1
2016-06-28T00:05:22.305Z,1467072322.305 [BPC1](ERROR): Communications Fault
2016-06-28T00:05:22.394Z,1467072322.394 [CBIT](ERROR): Communications Fault in component: BPC1
2016-06-28T00:05:23.715Z,1467072323.714 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-28T00:05:23.735Z,1467072323.735 [BPC1] No Fault, FailCount= 1
2016-06-28T00:05:59.912Z,1467072359.912 [BPC1](ERROR): Failed to receive battery data
2016-06-28T00:05:59.912Z,1467072359.912 [BPC1] Communications Fault, FailCount= 1
2016-06-28T00:05:59.912Z,1467072359.912 [BPC1](ERROR): Communications Fault
2016-06-28T00:05:59.931Z,1467072359.931 [CBIT](ERROR): Communications Fault in component: BPC1
2016-06-28T00:06:00.908Z,1467072360.908 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-28T00:06:00.908Z,1467072360.908 [BPC1] No Fault, FailCount= 1
2016-06-28T00:06:47.161Z,1467072407.161 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2016-06-28T00:07:41.270Z,1467072461.270 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-06-28T00:07:41.270Z,1467072461.270 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2016-06-28T00:07:41.270Z,1467072461.270 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-06-28T00:07:41.284Z,1467072461.284 [DeadReckonUsingSpeedCalculator](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-06-28T00:07:41.284Z,1467072461.284 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2016-06-28T00:07:41.284Z,1467072461.284 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2016-06-28T00:07:41.361Z,1467072461.361 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-06-28T00:07:41.361Z,1467072461.361 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2016-06-28T00:07:41.688Z,1467072461.688 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-06-28T00:07:41.689Z,1467072461.689 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2016-06-28T00:07:41.690Z,1467072461.690 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2016-06-28T00:07:41.690Z,1467072461.690 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2016-06-28T00:07:42.064Z,1467072462.064 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-06-28T00:07:42.065Z,1467072462.065 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-06-28T00:07:42.066Z,1467072462.066 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-06-28T00:07:42.068Z,1467072462.068 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2016-06-28T00:07:42.069Z,1467072462.069 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2016-06-28T00:07:42.070Z,1467072462.070 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2016-06-28T00:08:23.293Z,1467072503.293 [PNI_TCM](ERROR): CRC does not match. Expected:0x47978 got:0x1868
2016-06-28T00:08:23.678Z,1467072503.678 [PNI_TCM](ERROR): CRC does not match. Expected:0x25829 got:0x64062
2016-06-28T00:08:24.062Z,1467072504.062 [PNI_TCM](ERROR): CRC does not match. Expected:0x45701 got:0x39731
2016-06-28T00:08:24.465Z,1467072504.465 [PNI_TCM](ERROR): CRC does not match. Expected:0x29467 got:0x43463
2016-06-28T00:08:24.946Z,1467072504.945 [PNI_TCM](ERROR): CRC does not match. Expected:0x29584 got:0x64746
2016-06-28T00:08:24.947Z,1467072504.947 [PNI_TCM](ERROR): CRC does not match. Expected:0x50766 got:0x2464
2016-06-28T00:08:25.651Z,1467072505.651 [PNI_TCM](ERROR): CRC does not match. Expected:0x15524 got:0x39260
2016-06-28T00:08:26.052Z,1467072506.052 [PNI_TCM](ERROR): CRC does not match. Expected:0x26146 got:0x38539
2016-06-28T00:08:26.451Z,1467072506.451 [PNI_TCM](ERROR): CRC does not match. Expected:0x28062 got:0x40618
2016-06-28T00:08:26.906Z,1467072506.906 [PNI_TCM](ERROR): CRC does not match. Expected:0x43893 got:0x47370
2016-06-28T00:08:27.358Z,1467072507.358 [PNI_TCM](ERROR): CRC does not match. Expected:0x62340 got:0x42883
2016-06-28T00:08:27.359Z,1467072507.359 [PNI_TCM](ERROR): CRC does not match. Expected:0x36486 got:0x4587
2016-06-28T00:08:28.048Z,1467072508.048 [PNI_TCM](ERROR): CRC does not match. Expected:0x47072 got:0x16277
2016-06-28T00:08:28.448Z,1467072508.448 [PNI_TCM](ERROR): CRC does not match. Expected:0x56874 got:0x44862
2016-06-28T00:08:28.849Z,1467072508.849 [PNI_TCM](ERROR): CRC does not match. Expected:0x23987 got:0x60732
2016-06-28T00:08:29.310Z,1467072509.310 [PNI_TCM](ERROR): CRC does not match. Expected:0x22110 got:0x9066
2016-06-28T00:08:29.765Z,1467072509.765 [PNI_TCM](ERROR): CRC does not match. Expected:0x23593 got:0x64813
2016-06-28T00:08:29.767Z,1467072509.767 [PNI_TCM](ERROR): CRC does not match. Expected:0x63098 got:0x40018
2016-06-28T00:08:30.459Z,1467072510.459 [PNI_TCM](ERROR): CRC does not match. Expected:0x36823 got:0x47607
2016-06-28T00:08:30.940Z,1467072510.940 [PNI_TCM](ERROR): CRC does not match. Expected:0x42828 got:0x49996
2016-06-28T00:08:30.941Z,1467072510.941 [PNI_TCM](ERROR): CRC does not match. Expected:0x5513 got:0x54288
2016-06-28T00:08:31.333Z,1467072511.333 [PNI_TCM](ERROR): CRC does not match. Expected:0x57838 got:0x54061
2016-06-28T00:08:32.052Z,1467072512.052 [PNI_TCM](ERROR): CRC does not match. Expected:0x57190 got:0x4784
2016-06-28T00:08:32.451Z,1467072512.451 [PNI_TCM](ERROR): CRC does not match. Expected:0x39602 got:0x11034
2016-06-28T00:08:32.451Z,1467072512.451 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-28T00:08:32.451Z,1467072512.451 [PNI_TCM] Data Fault, FailCount= 1
2016-06-28T00:08:32.451Z,1467072512.451 [PNI_TCM](ERROR): Data Fault
2016-06-28T00:08:32.458Z,1467072512.458 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.349000 seconds old.
2016-06-28T00:08:32.459Z,1467072512.459 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.349500 seconds old.
2016-06-28T00:08:32.557Z,1467072512.557 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-28T00:08:32.883Z,1467072512.883 [PNI_TCM](INFO): Powering down
2016-06-28T00:08:32.949Z,1467072512.949 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.839400 seconds old.
2016-06-28T00:08:32.958Z,1467072512.958 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.848200 seconds old.
2016-06-28T00:08:33.323Z,1467072513.323 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.213700 seconds old.
2016-06-28T00:08:33.326Z,1467072513.326 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.216500 seconds old.
2016-06-28T00:08:33.695Z,1467072513.695 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.586400 seconds old.
2016-06-28T00:08:33.697Z,1467072513.697 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.587100 seconds old.
2016-06-28T00:08:34.079Z,1467072514.079 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.970300 seconds old.
2016-06-28T00:08:34.080Z,1467072514.080 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.970900 seconds old.
2016-06-28T00:08:34.093Z,1467072514.092 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-28T00:08:34.093Z,1467072514.093 [PNI_TCM] No Fault, FailCount= 1
2016-06-28T00:08:34.461Z,1467072514.461 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.351800 seconds old.
2016-06-28T00:08:34.466Z,1467072514.466 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.355100 seconds old.
2016-06-28T00:08:34.907Z,1467072514.907 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.797600 seconds old.
2016-06-28T00:08:34.928Z,1467072514.928 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.805400 seconds old.
2016-06-28T00:08:35.320Z,1467072515.320 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.210900 seconds old.
2016-06-28T00:08:35.324Z,1467072515.324 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.213300 seconds old.
2016-06-28T00:08:35.679Z,1467072515.679 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.566200 seconds old.
2016-06-28T00:08:35.681Z,1467072515.681 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.571000 seconds old.
2016-06-28T00:08:36.075Z,1467072516.075 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.966300 seconds old.
2016-06-28T00:08:36.077Z,1467072516.077 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.967000 seconds old.
2016-06-28T00:08:36.504Z,1467072516.504 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.395000 seconds old.
2016-06-28T00:08:36.530Z,1467072516.530 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.420000 seconds old.
2016-06-28T00:08:36.904Z,1467072516.904 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.790400 seconds old.
2016-06-28T00:08:36.909Z,1467072516.908 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.798300 seconds old.
2016-06-28T00:08:37.310Z,1467072517.310 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.200300 seconds old.
2016-06-28T00:08:37.318Z,1467072517.318 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.207700 seconds old.
2016-06-28T00:09:01.324Z,1467072541.325 [BPC1](ERROR): Failed to parse bank B battery data
2016-06-28T00:09:01.325Z,1467072541.325 [BPC1] Data Fault, FailCount= 1
2016-06-28T00:09:01.325Z,1467072541.325 [BPC1](ERROR): Data Fault
2016-06-28T00:09:01.477Z,1467072541.477 [CBIT](ERROR): Data Fault in component: BPC1
2016-06-28T00:09:02.431Z,1467072542.431 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-28T00:09:02.431Z,1467072542.431 [BPC1] No Fault, FailCount= 1
2016-06-28T00:09:25.290Z,1467072565.290 [PNI_TCM](ERROR): CRC does not match. Expected:0x63389 got:0x29435
2016-06-28T00:09:25.980Z,1467072565.980 [PNI_TCM](ERROR): CRC does not match. Expected:0x835 got:0x29437
2016-06-28T00:09:26.401Z,1467072566.401 [PNI_TCM](ERROR): CRC does not match. Expected:0x17625 got:0x29436
2016-06-28T00:09:26.889Z,1467072566.889 [PNI_TCM](ERROR): CRC does not match. Expected:0x43645 got:0x29435
2016-06-28T00:09:26.890Z,1467072566.890 [PNI_TCM](ERROR): CRC does not match. Expected:0x835 got:0x29424
2016-06-28T00:09:27.585Z,1467072567.585 [PNI_TCM](ERROR): CRC does not match. Expected:0x9545 got:0x29439
2016-06-28T00:09:27.984Z,1467072567.984 [PNI_TCM](ERROR): CRC does not match. Expected:0x35248 got:0x29447
2016-06-28T00:09:28.395Z,1467072568.395 [PNI_TCM](ERROR): CRC does not match. Expected:0x23117 got:0x29447
2016-06-28T00:09:28.799Z,1467072568.799 [PNI_TCM](ERROR): CRC does not match. Expected:0x23117 got:0x29438
2016-06-28T00:09:29.255Z,1467072569.256 [PNI_TCM](ERROR): CRC does not match. Expected:0x26388 got:0x29429
2016-06-28T00:09:29.257Z,1467072569.257 [PNI_TCM](ERROR): CRC does not match. Expected:0x16670 got:0x29439
2016-06-28T00:09:29.636Z,1467072569.636 [PNI_TCM](ERROR): CRC does not match. Expected:0x35248 got:0x29440
2016-06-28T00:09:30.491Z,1467072570.491 [PNI_TCM](ERROR): CRC does not match. Expected:0x62323 got:0x29444
2016-06-28T00:09:30.492Z,1467072570.492 [PNI_TCM](ERROR): CRC does not match. Expected:0x31104 got:0x29440
2016-06-28T00:09:30.866Z,1467072570.866 [PNI_TCM](ERROR): CRC does not match. Expected:0x62323 got:0x29435
2016-06-28T00:09:31.249Z,1467072571.249 [PNI_TCM](ERROR): CRC does not match. Expected:0x835 got:0x29432
2016-06-28T00:09:31.987Z,1467072571.987 [PNI_TCM](ERROR): CRC does not match. Expected:0x8334 got:0x29442
2016-06-28T00:09:32.484Z,1467072572.484 [PNI_TCM](ERROR): CRC does not match. Expected:0x15898 got:0x29438
2016-06-28T00:09:32.485Z,1467072572.485 [PNI_TCM](ERROR): CRC does not match. Expected:0x26388 got:0x29431
2016-06-28T00:09:32.894Z,1467072572.894 [PNI_TCM](ERROR): CRC does not match. Expected:0x57371 got:0x6464
2016-06-28T00:09:33.242Z,1467072573.242 [PNI_TCM](ERROR): CRC does not match. Expected:0x11928 got:0x6464
2016-06-28T00:09:33.986Z,1467072573.986 [PNI_TCM](ERROR): CRC does not match. Expected:0x43170 got:0x33388
2016-06-28T00:09:34.458Z,1467072574.457 [PNI_TCM](ERROR): CRC does not match. Expected:0x39864 got:0x41878
2016-06-28T00:09:34.459Z,1467072574.459 [PNI_TCM](ERROR): CRC does not match. Expected:0x10926 got:0x50509
2016-06-28T00:09:34.881Z,1467072574.881 [PNI_TCM](ERROR): CRC does not match. Expected:0x33886 got:0x10263
2016-06-28T00:09:34.881Z,1467072574.881 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-28T00:09:34.882Z,1467072574.882 [PNI_TCM] Data Fault, FailCount= 1
2016-06-28T00:09:34.882Z,1467072574.882 [PNI_TCM](ERROR): Data Fault
2016-06-28T00:09:34.928Z,1467072574.928 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.410100 seconds old.
2016-06-28T00:09:34.936Z,1467072574.936 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.420900 seconds old.
2016-06-28T00:09:35.068Z,1467072575.068 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-28T00:09:35.221Z,1467072575.221 [PNI_TCM](INFO): Powering down
2016-06-28T00:09:35.288Z,1467072575.288 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.770000 seconds old.
2016-06-28T00:09:35.308Z,1467072575.308 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.775800 seconds old.
2016-06-28T00:09:35.587Z,1467072575.587 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.074600 seconds old.
2016-06-28T00:09:35.589Z,1467072575.589 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.073500 seconds old.
2016-06-28T00:09:35.983Z,1467072575.983 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.470400 seconds old.
2016-06-28T00:09:35.985Z,1467072575.985 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.469500 seconds old.
2016-06-28T00:09:36.451Z,1467072576.451 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.929500 seconds old.
2016-06-28T00:09:36.460Z,1467072576.460 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.939900 seconds old.
2016-06-28T00:09:36.544Z,1467072576.544 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-28T00:09:36.544Z,1467072576.544 [PNI_TCM] No Fault, FailCount= 1
2016-06-28T00:09:36.828Z,1467072576.828 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.314800 seconds old.
2016-06-28T00:09:36.831Z,1467072576.831 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.315500 seconds old.
2016-06-28T00:09:37.240Z,1467072577.240 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.722300 seconds old.
2016-06-28T00:09:37.249Z,1467072577.249 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.732800 seconds old.
2016-06-28T00:09:37.627Z,1467072577.627 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.102300 seconds old.
2016-06-28T00:09:37.628Z,1467072577.628 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.112900 seconds old.
2016-06-28T00:09:37.987Z,1467072577.987 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.474000 seconds old.
2016-06-28T00:09:37.988Z,1467072577.988 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.472900 seconds old.
2016-06-28T00:09:38.400Z,1467072578.400 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.886900 seconds old.
2016-06-28T00:09:38.401Z,1467072578.401 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.885800 seconds old.
2016-06-28T00:09:38.880Z,1467072578.880 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.366400 seconds old.
2016-06-28T00:09:38.883Z,1467072578.883 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.367400 seconds old.
2016-06-28T00:09:39.257Z,1467072579.257 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.743500 seconds old.
2016-06-28T00:09:39.262Z,1467072579.262 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.746000 seconds old.
2016-06-28T00:09:39.587Z,1467072579.587 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.074700 seconds old.
2016-06-28T00:09:39.589Z,1467072579.589 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.073600 seconds old.
2016-06-28T00:10:06.616Z,1467072606.616 [Default:CheckIn:Read_GPS](INFO): Timed out from 2016-06-28T00:05:06.3Z
2016-06-28T00:10:06.617Z,1467072606.617 [Default:CheckIn:Read_GPS] Stopped
2016-06-28T00:10:06.617Z,1467072606.617 [Default:CheckIn:Read_Iridium] Running Loop=1
2016-06-28T00:10:07.037Z,1467072607.037 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2016-06-28T00:10:13.648Z,1467072613.648 [DataOverHttps](INFO): Sending 195 bytes from file Logs/20160628T000120/Courier0004.lzma
2016-06-28T00:10:14.460Z,1467072614.460 [DataOverHttps](INFO): Moved sent file to Logs/20160628T000120/Courier0004.lzma.bak
2016-06-28T00:10:14.461Z,1467072614.461 [DataOverHttps](INFO): SBD MOMSN=4312864
2016-06-28T00:10:28.920Z,1467072628.920 [DataOverHttps](INFO): Sending 344 bytes from file Logs/20160628T000120/Express0005.lzma
2016-06-28T00:10:29.710Z,1467072629.710 [DataOverHttps](INFO): Moved sent file to Logs/20160628T000120/Express0005.lzma.bak
2016-06-28T00:10:29.711Z,1467072629.711 [DataOverHttps](INFO): SBD MOMSN=4312866
2016-06-28T00:10:30.299Z,1467072630.299 [Default:CheckIn:Read_Iridium] Stopped
2016-06-28T00:10:30.299Z,1467072630.299 [Default:CheckIn:C.Wait] Running Loop=1
2016-06-28T00:10:30.299Z,1467072630.299 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2016-06-28T00:10:42.195Z,1467072642.195 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-06-28T00:10:42.195Z,1467072642.195 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2016-06-28T00:10:42.195Z,1467072642.195 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-06-28T00:10:42.197Z,1467072642.197 [DeadReckonUsingSpeedCalculator](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-06-28T00:10:42.197Z,1467072642.197 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2016-06-28T00:10:42.197Z,1467072642.197 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2016-06-28T00:10:42.210Z,1467072642.210 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-06-28T00:10:42.210Z,1467072642.210 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2016-06-28T00:10:42.694Z,1467072642.694 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-06-28T00:10:42.695Z,1467072642.695 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2016-06-28T00:10:42.708Z,1467072642.708 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2016-06-28T00:10:42.708Z,1467072642.708 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2016-06-28T00:10:43.089Z,1467072643.089 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-06-28T00:10:43.090Z,1467072643.090 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-06-28T00:10:43.096Z,1467072643.096 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-06-28T00:10:43.097Z,1467072643.097 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2016-06-28T00:10:43.098Z,1467072643.098 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2016-06-28T00:10:43.104Z,1467072643.104 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2016-06-28T00:10:54.536Z,1467072654.536 [CommandLine](IMPORTANT): got command show best platform_magnetic_orientation
2016-06-28T00:10:54.537Z,1467072654.537 [CommandLine](IMPORTANT): platform_magnetic_orientation best is PNI_TCM.platform_magnetic_orientation
2016-06-28T00:10:56.795Z,1467072656.795 [PNI_TCM](ERROR): CRC does not match. Expected:0x52857 got:0x29441
2016-06-28T00:10:57.154Z,1467072657.155 [PNI_TCM](ERROR): CRC does not match. Expected:0x15489 got:0x6464
2016-06-28T00:10:57.897Z,1467072657.897 [PNI_TCM](ERROR): CRC does not match. Expected:0x5522 got:0x6464
2016-06-28T00:10:58.421Z,1467072658.421 [PNI_TCM](ERROR): CRC does not match. Expected:0x18340 got:0x6464
2016-06-28T00:10:58.423Z,1467072658.422 [PNI_TCM](ERROR): CRC does not match. Expected:0x22873 got:0x6464
2016-06-28T00:10:58.947Z,1467072658.947 [PNI_TCM](ERROR): CRC does not match. Expected:0x49592 got:0x6464
2016-06-28T00:10:59.421Z,1467072659.421 [PNI_TCM](ERROR): CRC does not match. Expected:0x19557 got:0x6464
2016-06-28T00:10:59.823Z,1467072659.823 [PNI_TCM](ERROR): CRC does not match. Expected:0x50050 got:0x6464
2016-06-28T00:11:00.222Z,1467072660.222 [PNI_TCM](ERROR): CRC does not match. Expected:0x35904 got:0x6464
2016-06-28T00:11:00.681Z,1467072660.681 [PNI_TCM](ERROR): CRC does not match. Expected:0x7918 got:0x6464
2016-06-28T00:11:01.067Z,1467072661.067 [PNI_TCM](ERROR): CRC does not match. Expected:0x1509 got:0x6464
2016-06-28T00:11:01.412Z,1467072661.412 [PNI_TCM](ERROR): CRC does not match. Expected:0x8131 got:0x6464
2016-06-28T00:11:01.805Z,1467072661.805 [PNI_TCM](ERROR): CRC does not match. Expected:0x10662 got:0x6464
2016-06-28T00:11:02.207Z,1467072662.207 [PNI_TCM](ERROR): CRC does not match. Expected:0x195 got:0x6464
2016-06-28T00:11:02.723Z,1467072662.723 [PNI_TCM](ERROR): CRC does not match. Expected:0x30911 got:0x6464
2016-06-28T00:11:02.728Z,1467072662.728 [PNI_TCM](ERROR): CRC does not match. Expected:0x734 got:0x6464
2016-06-28T00:11:03.423Z,1467072663.423 [PNI_TCM](ERROR): CRC does not match. Expected:0x20767 got:0x6464
2016-06-28T00:11:03.807Z,1467072663.807 [PNI_TCM](ERROR): CRC does not match. Expected:0x17501 got:0x6464
2016-06-28T00:11:04.204Z,1467072664.204 [PNI_TCM](ERROR): CRC does not match. Expected:0x50305 got:0x6464
2016-06-28T00:11:04.607Z,1467072664.607 [PNI_TCM](ERROR): CRC does not match. Expected:0x26661 got:0x6464
2016-06-28T00:11:05.081Z,1467072665.081 [PNI_TCM](ERROR): CRC does not match. Expected:0x61360 got:0x6464
2016-06-28T00:11:05.472Z,1467072665.472 [PNI_TCM](ERROR): CRC does not match. Expected:0x32212 got:0x6464
2016-06-28T00:11:05.831Z,1467072665.831 [PNI_TCM](ERROR): CRC does not match. Expected:0x47253 got:0x6464
2016-06-28T00:11:06.219Z,1467072666.219 [PNI_TCM](ERROR): CRC does not match. Expected:0x58138 got:0x6464
2016-06-28T00:11:06.646Z,1467072666.646 [PNI_TCM](ERROR): CRC does not match. Expected:0x23293 got:0x6464
2016-06-28T00:11:06.647Z,1467072666.647 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-28T00:11:06.659Z,1467072666.659 [PNI_TCM] Data Fault, FailCount= 1
2016-06-28T00:11:06.659Z,1467072666.659 [PNI_TCM](ERROR): Data Fault
2016-06-28T00:11:06.678Z,1467072666.678 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.365800 seconds old.
2016-06-28T00:11:06.688Z,1467072666.688 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.372600 seconds old.
2016-06-28T00:11:06.799Z,1467072666.799 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-28T00:11:07.024Z,1467072667.024 [PNI_TCM](INFO): Powering down
2016-06-28T00:11:07.053Z,1467072667.053 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.740200 seconds old.
2016-06-28T00:11:07.065Z,1467072667.065 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.749300 seconds old.
2016-06-28T00:11:07.403Z,1467072667.403 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.091300 seconds old.
2016-06-28T00:11:07.405Z,1467072667.405 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.089800 seconds old.
2016-06-28T00:11:07.815Z,1467072667.815 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.503200 seconds old.
2016-06-28T00:11:07.817Z,1467072667.816 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.501700 seconds old.
2016-06-28T00:11:08.208Z,1467072668.208 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.896000 seconds old.
2016-06-28T00:11:08.209Z,1467072668.209 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.894500 seconds old.
2016-06-28T00:11:08.230Z,1467072668.230 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-28T00:11:08.230Z,1467072668.230 [PNI_TCM] No Fault, FailCount= 1
2016-06-28T00:11:08.696Z,1467072668.696 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.383400 seconds old.
2016-06-28T00:11:08.708Z,1467072668.708 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.384300 seconds old.
2016-06-28T00:11:09.058Z,1467072669.058 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.745800 seconds old.
2016-06-28T00:11:09.063Z,1467072669.063 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.747400 seconds old.
2016-06-28T00:11:09.435Z,1467072669.435 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.123500 seconds old.
2016-06-28T00:11:09.437Z,1467072669.437 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.122000 seconds old.
2016-06-28T00:11:09.820Z,1467072669.820 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.508000 seconds old.
2016-06-28T00:11:09.821Z,1467072669.821 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.506500 seconds old.
2016-06-28T00:11:10.200Z,1467072670.200 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.888000 seconds old.
2016-06-28T00:11:10.201Z,1467072670.201 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.886500 seconds old.
2016-06-28T00:11:10.681Z,1467072670.681 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.368200 seconds old.
2016-06-28T00:11:10.689Z,1467072670.690 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.373600 seconds old.
2016-06-28T00:11:11.070Z,1467072671.070 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.757200 seconds old.
2016-06-28T00:11:11.078Z,1467072671.078 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.763000 seconds old.
2016-06-28T00:11:11.423Z,1467072671.423 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.111200 seconds old.
2016-06-28T00:11:11.424Z,1467072671.424 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.109700 seconds old.
2016-06-28T00:11:17.481Z,1467072677.481 [PNI_TCM](ERROR): CRC does not match. Expected:0x27802 got:0x29441
2016-06-28T00:11:18.220Z,1467072678.220 [PNI_TCM](ERROR): CRC does not match. Expected:0x7639 got:0x29430
2016-06-28T00:11:18.679Z,1467072678.679 [PNI_TCM](ERROR): CRC does not match. Expected:0x25299 got:0x29432
2016-06-28T00:11:18.680Z,1467072678.680 [PNI_TCM](ERROR): CRC does not match. Expected:0x8334 got:0x29425
2016-06-28T00:11:19.081Z,1467072679.081 [PNI_TCM](ERROR): CRC does not match. Expected:0x52205 got:0x29436
2016-06-28T00:11:19.818Z,1467072679.818 [PNI_TCM](ERROR): CRC does not match. Expected:0x43645 got:0x29445
2016-06-28T00:11:20.333Z,1467072680.333 [PNI_TCM](ERROR): CRC does not match. Expected:0x38692 got:0x29452
2016-06-28T00:11:20.335Z,1467072680.335 [PNI_TCM](ERROR): CRC does not match. Expected:0x31815 got:0x29445
2016-06-28T00:11:20.661Z,1467072680.661 [PNI_TCM](ERROR): CRC does not match. Expected:0x38692 got:0x29438
2016-06-28T00:11:21.075Z,1467072681.075 [PNI_TCM](ERROR): CRC does not match. Expected:0x26388 got:0x29445
2016-06-28T00:11:21.808Z,1467072681.808 [PNI_TCM](ERROR): CRC does not match. Expected:0x38692 got:0x29448
2016-06-28T00:11:22.243Z,1467072682.243 [PNI_TCM](ERROR): CRC does not match. Expected:0x63156 got:0x29444
2016-06-28T00:11:22.683Z,1467072682.683 [PNI_TCM](ERROR): CRC does not match. Expected:0x31104 got:0x29433
2016-06-28T00:11:22.697Z,1467072682.697 [PNI_TCM](ERROR): CRC does not match. Expected:0x52778 got:0x29434
2016-06-28T00:11:23.094Z,1467072683.094 [PNI_TCM](ERROR): CRC does not match. Expected:0x60903 got:0x29437
2016-06-28T00:11:23.804Z,1467072683.804 [PNI_TCM](ERROR): CRC does not match. Expected:0x17625 got:0x29435
2016-06-28T00:11:24.306Z,1467072684.306 [PNI_TCM](ERROR): CRC does not match. Expected:0x835 got:0x29446
2016-06-28T00:11:24.316Z,1467072684.316 [PNI_TCM](ERROR): CRC does not match. Expected:0x46313 got:0x29444
2016-06-28T00:11:24.685Z,1467072684.685 [PNI_TCM](ERROR): CRC does not match. Expected:0x31104 got:0x29441
2016-06-28T00:11:25.120Z,1467072685.120 [PNI_TCM](ERROR): CRC does not match. Expected:0x7639 got:0x29442
2016-06-28T00:11:25.800Z,1467072685.800 [PNI_TCM](ERROR): CRC does not match. Expected:0x43816 got:0x6464
2016-06-28T00:11:26.220Z,1467072686.220 [PNI_TCM](ERROR): CRC does not match. Expected:0x59141 got:0x6464
2016-06-28T00:11:26.696Z,1467072686.696 [PNI_TCM](ERROR): CRC does not match. Expected:0x11712 got:0x6464
2016-06-28T00:11:26.697Z,1467072686.697 [PNI_TCM](ERROR): CRC does not match. Expected:0x52918 got:0x6464
2016-06-28T00:11:27.413Z,1467072687.413 [PNI_TCM](ERROR): CRC does not match. Expected:0x12062 got:0x6464
2016-06-28T00:11:27.413Z,1467072687.413 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-28T00:11:27.413Z,1467072687.413 [PNI_TCM] Data Fault, FailCount= 1
2016-06-28T00:11:27.414Z,1467072687.414 [PNI_TCM](ERROR): Data Fault
2016-06-28T00:11:27.420Z,1467072687.420 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.334500 seconds old.
2016-06-28T00:11:27.421Z,1467072687.421 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.333500 seconds old.
2016-06-28T00:11:27.434Z,1467072687.434 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-28T00:11:27.797Z,1467072687.797 [PNI_TCM](INFO): Powering down
2016-06-28T00:11:27.823Z,1467072687.823 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.738400 seconds old.
2016-06-28T00:11:27.825Z,1467072687.825 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.737300 seconds old.
2016-06-28T00:11:28.227Z,1467072688.227 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.142300 seconds old.
2016-06-28T00:11:28.229Z,1467072688.229 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.141200 seconds old.
2016-06-28T00:11:28.627Z,1467072688.627 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.542300 seconds old.
2016-06-28T00:11:28.629Z,1467072688.629 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.541200 seconds old.
2016-06-28T00:11:29.076Z,1467072689.076 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.990700 seconds old.
2016-06-28T00:11:29.085Z,1467072689.085 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.996500 seconds old.
2016-06-28T00:11:29.180Z,1467072689.180 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-28T00:11:29.180Z,1467072689.180 [PNI_TCM] No Fault, FailCount= 1
2016-06-28T00:11:29.455Z,1467072689.455 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.369000 seconds old.
2016-06-28T00:11:29.468Z,1467072689.468 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.380500 seconds old.
2016-06-28T00:11:29.803Z,1467072689.803 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.718300 seconds old.
2016-06-28T00:11:29.805Z,1467072689.805 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.717300 seconds old.
2016-06-28T00:11:30.290Z,1467072690.290 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.203900 seconds old.
2016-06-28T00:11:30.298Z,1467072690.298 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.209900 seconds old.
2016-06-28T00:11:30.374Z,1467072690.374 [CBIT](DEBUG): EFC running - data check-sum false
2016-06-28T00:11:30.670Z,1467072690.671 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.585100 seconds old.
2016-06-28T00:11:30.675Z,1467072690.675 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.586700 seconds old.
2016-06-28T00:11:31.085Z,1467072691.085 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.999600 seconds old.
2016-06-28T00:11:31.094Z,1467072691.093 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.005400 seconds old.
2016-06-28T00:11:35.832Z,1467072695.832 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 8.747100 seconds old.
2016-06-28T00:11:35.834Z,1467072695.833 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 8.746000 seconds old.
2016-06-28T00:11:35.928Z,1467072695.928 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 8.842500 seconds old.
2016-06-28T00:11:35.929Z,1467072695.929 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 8.841400 seconds old.
2016-06-28T00:11:36.406Z,1467072696.406 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 9.320300 seconds old.
2016-06-28T00:11:36.414Z,1467072696.414 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 9.326100 seconds old.
2016-06-28T00:11:41.066Z,1467072701.066 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:11:41.478Z,1467072701.478 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:11:45.485Z,1467072705.485 [NAL9602](FAULT): GPS failed to acquire within timeout.
2016-06-28T00:11:45.485Z,1467072705.485 [NAL9602] Data Fault, FailCount= 1
2016-06-28T00:11:45.485Z,1467072705.485 [NAL9602](ERROR): Data Fault
2016-06-28T00:11:45.562Z,1467072705.562 [CBIT](ERROR): Data Fault in component: NAL9602
2016-06-28T00:11:45.884Z,1467072705.884 [NAL9602](INFO): Powering down
2016-06-28T00:11:46.891Z,1467072706.891 [CBIT](INFO): Clearing failed state for component NAL9602
2016-06-28T00:11:46.895Z,1467072706.895 [NAL9602] No Fault, FailCount= 1
2016-06-28T00:11:51.100Z,1467072711.099 [NAL9602](INFO): Powering up NAL9602
2016-06-28T00:11:53.046Z,1467072713.046 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:11:53.453Z,1467072713.453 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:11:53.864Z,1467072713.864 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:12:01.885Z,1467072721.885 [NAL9602](INFO): NAL9602 initialized
2016-06-28T00:12:29.193Z,1467072749.193 [PNI_TCM](ERROR): CRC does not match. Expected:0x835 got:0x29448
2016-06-28T00:12:29.593Z,1467072749.593 [PNI_TCM](ERROR): CRC does not match. Expected:0x63156 got:0x29458
2016-06-28T00:12:30.419Z,1467072750.419 [PNI_TCM](ERROR): CRC does not match. Expected:0x13716 got:0x29455
2016-06-28T00:12:30.421Z,1467072750.421 [PNI_TCM](ERROR): CRC does not match. Expected:0x24458 got:0x29455
2016-06-28T00:12:30.800Z,1467072750.800 [PNI_TCM](ERROR): CRC does not match. Expected:0x24458 got:0x29448
2016-06-28T00:12:31.197Z,1467072751.197 [PNI_TCM](ERROR): CRC does not match. Expected:0x63156 got:0x29447
2016-06-28T00:12:35.928Z,1467072755.928 [PNI_TCM](ERROR): CRC does not match. Expected:0x51075 got:0x6464
2016-06-28T00:12:35.929Z,1467072755.929 [PNI_TCM](ERROR): CRC does not match. Expected:0x52652 got:0x6464
2016-06-28T00:12:35.929Z,1467072755.929 [PNI_TCM](ERROR): CRC does not match. Expected:0x53857 got:0x6464
2016-06-28T00:12:35.930Z,1467072755.930 [PNI_TCM](ERROR): CRC does not match. Expected:0x8882 got:0x6464
2016-06-28T00:12:35.930Z,1467072755.930 [PNI_TCM](ERROR): CRC does not match. Expected:0x27241 got:0x6464
2016-06-28T00:12:35.930Z,1467072755.930 [PNI_TCM](ERROR): CRC does not match. Expected:0x64525 got:0x6464
2016-06-28T00:12:35.931Z,1467072755.931 [PNI_TCM](ERROR): CRC does not match. Expected:0x52251 got:0x6464
2016-06-28T00:12:35.931Z,1467072755.931 [PNI_TCM](ERROR): CRC does not match. Expected:0x34151 got:0x6464
2016-06-28T00:12:35.932Z,1467072755.932 [PNI_TCM](ERROR): CRC does not match. Expected:0x51644 got:0x6464
2016-06-28T00:12:35.933Z,1467072755.933 [PNI_TCM](ERROR): CRC does not match. Expected:0x15474 got:0x6464
2016-06-28T00:12:35.934Z,1467072755.934 [PNI_TCM](ERROR): CRC does not match. Expected:0x10713 got:0x6464
2016-06-28T00:12:36.249Z,1467072756.249 [PNI_TCM](ERROR): CRC does not match. Expected:0x33614 got:0x6464
2016-06-28T00:12:36.553Z,1467072756.553 [PNI_TCM](ERROR): CRC does not match. Expected:0x13302 got:0x6464
2016-06-28T00:12:36.997Z,1467072756.997 [PNI_TCM](ERROR): CRC does not match. Expected:0x55527 got:0x6464
2016-06-28T00:12:37.308Z,1467072757.308 [PNI_TCM](ERROR): CRC does not match. Expected:0x27263 got:0x6464
2016-06-28T00:12:37.705Z,1467072757.704 [PNI_TCM](ERROR): CRC does not match. Expected:0x8277 got:0x6464
2016-06-28T00:12:38.106Z,1467072758.106 [PNI_TCM](ERROR): CRC does not match. Expected:0x24439 got:0x6464
2016-06-28T00:12:38.624Z,1467072758.624 [PNI_TCM](ERROR): CRC does not match. Expected:0x22801 got:0x6464
2016-06-28T00:12:39.028Z,1467072759.028 [PNI_TCM](ERROR): CRC does not match. Expected:0x34763 got:0x6464
2016-06-28T00:12:39.029Z,1467072759.029 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-28T00:12:39.029Z,1467072759.029 [PNI_TCM] Data Fault, FailCount= 1
2016-06-28T00:12:39.029Z,1467072759.029 [PNI_TCM](ERROR): Data Fault
2016-06-28T00:12:39.061Z,1467072759.061 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.400800 seconds old.
2016-06-28T00:12:39.069Z,1467072759.069 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.398500 seconds old.
2016-06-28T00:12:39.154Z,1467072759.154 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-28T00:12:39.305Z,1467072759.305 [PNI_TCM](INFO): Powering down
2016-06-28T00:12:39.319Z,1467072759.319 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.660500 seconds old.
2016-06-28T00:12:39.321Z,1467072759.321 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.650800 seconds old.
2016-06-28T00:12:39.715Z,1467072759.715 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.056500 seconds old.
2016-06-28T00:12:39.717Z,1467072759.717 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.046800 seconds old.
2016-06-28T00:12:40.111Z,1467072760.111 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.451700 seconds old.
2016-06-28T00:12:40.112Z,1467072760.112 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.442000 seconds old.
2016-06-28T00:12:40.510Z,1467072760.510 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.850900 seconds old.
2016-06-28T00:12:40.511Z,1467072760.511 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.841400 seconds old.
2016-06-28T00:12:40.527Z,1467072760.527 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-28T00:12:40.527Z,1467072760.527 [PNI_TCM] No Fault, FailCount= 1
2016-06-28T00:12:40.968Z,1467072760.968 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.303200 seconds old.
2016-06-28T00:12:40.976Z,1467072760.976 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.301000 seconds old.
2016-06-28T00:12:41.331Z,1467072761.330 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.670900 seconds old.
2016-06-28T00:12:41.337Z,1467072761.337 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.666300 seconds old.
2016-06-28T00:12:41.720Z,1467072761.720 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.061400 seconds old.
2016-06-28T00:12:41.722Z,1467072761.722 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.051700 seconds old.
2016-06-28T00:12:42.138Z,1467072762.138 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.478600 seconds old.
2016-06-28T00:12:42.173Z,1467072762.173 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.502200 seconds old.
2016-06-28T00:12:42.559Z,1467072762.559 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.899500 seconds old.
2016-06-28T00:12:42.573Z,1467072762.573 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.902700 seconds old.
2016-06-28T00:12:42.960Z,1467072762.960 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.295400 seconds old.
2016-06-28T00:12:42.964Z,1467072762.964 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.293900 seconds old.
2016-06-28T00:12:43.300Z,1467072763.300 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.640200 seconds old.
2016-06-28T00:12:43.301Z,1467072763.301 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.631300 seconds old.
2016-06-28T00:12:43.700Z,1467072763.700 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.040200 seconds old.
2016-06-28T00:12:43.701Z,1467072763.701 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.031100 seconds old.
2016-06-28T00:13:07.723Z,1467072787.723 [PNI_TCM](ERROR): CRC does not match. Expected:0x38692 got:0x29447
2016-06-28T00:13:08.182Z,1467072788.182 [PNI_TCM](ERROR): CRC does not match. Expected:0x23117 got:0x29454
2016-06-28T00:13:08.183Z,1467072788.183 [PNI_TCM](ERROR): CRC does not match. Expected:0x45358 got:0x29461
2016-06-28T00:13:08.605Z,1467072788.605 [PNI_TCM](ERROR): CRC does not match. Expected:0x40106 got:0x29476
2016-06-28T00:13:09.015Z,1467072789.016 [PNI_TCM](ERROR): CRC does not match. Expected:0x28316 got:0x29452
2016-06-28T00:13:09.725Z,1467072789.725 [PNI_TCM](ERROR): CRC does not match. Expected:0x31815 got:0x29448
2016-06-28T00:13:10.217Z,1467072790.217 [PNI_TCM](ERROR): CRC does not match. Expected:0x63156 got:0x29449
2016-06-28T00:13:10.219Z,1467072790.218 [PNI_TCM](ERROR): CRC does not match. Expected:0x6160 got:0x29450
2016-06-28T00:13:10.597Z,1467072790.597 [PNI_TCM](ERROR): CRC does not match. Expected:0x15325 got:0x29450
2016-06-28T00:13:11.005Z,1467072791.005 [PNI_TCM](ERROR): CRC does not match. Expected:0x15325 got:0x29454
2016-06-28T00:13:11.719Z,1467072791.718 [PNI_TCM](ERROR): CRC does not match. Expected:0x45358 got:0x29461
2016-06-28T00:13:12.262Z,1467072792.262 [PNI_TCM](ERROR): CRC does not match. Expected:0x40106 got:0x29459
2016-06-28T00:13:12.272Z,1467072792.272 [PNI_TCM](ERROR): CRC does not match. Expected:0x56112 got:0x29466
2016-06-28T00:13:12.650Z,1467072792.650 [PNI_TCM](ERROR): CRC does not match. Expected:0x12371 got:0x29445
2016-06-28T00:13:13.033Z,1467072793.033 [PNI_TCM](ERROR): CRC does not match. Expected:0x38692 got:0x29444
2016-06-28T00:13:13.720Z,1467072793.720 [PNI_TCM](ERROR): CRC does not match. Expected:0x31104 got:0x29449
2016-06-28T00:13:14.192Z,1467072794.192 [PNI_TCM](ERROR): CRC does not match. Expected:0x6160 got:0x29455
2016-06-28T00:13:14.193Z,1467072794.193 [PNI_TCM](ERROR): CRC does not match. Expected:0x24458 got:0x29445
2016-06-28T00:13:14.597Z,1467072794.597 [PNI_TCM](ERROR): CRC does not match. Expected:0x38692 got:0x29443
2016-06-28T00:13:15.000Z,1467072795.000 [PNI_TCM](ERROR): CRC does not match. Expected:0x53438 got:0x29449
2016-06-28T00:13:15.729Z,1467072795.729 [PNI_TCM](ERROR): CRC does not match. Expected:0x6160 got:0x29449
2016-06-28T00:13:15.732Z,1467072795.732 [PNI_TCM](ERROR): CRC does not match. Expected:0x6160 got:0x29450
2016-06-28T00:13:16.598Z,1467072796.598 [PNI_TCM](ERROR): CRC does not match. Expected:0x15325 got:0x29445
2016-06-28T00:13:16.599Z,1467072796.599 [PNI_TCM](ERROR): CRC does not match. Expected:0x38692 got:0x29429
2016-06-28T00:13:16.603Z,1467072796.603 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-28T00:13:16.604Z,1467072796.604 [PNI_TCM] Data Fault, FailCount= 1
2016-06-28T00:13:16.604Z,1467072796.604 [PNI_TCM](ERROR): Data Fault
2016-06-28T00:13:16.636Z,1467072796.635 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.504400 seconds old.
2016-06-28T00:13:16.639Z,1467072796.639 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.506800 seconds old.
2016-06-28T00:13:16.702Z,1467072796.702 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-28T00:13:16.953Z,1467072796.953 [PNI_TCM](INFO): Powering down
2016-06-28T00:13:16.993Z,1467072796.993 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.862200 seconds old.
2016-06-28T00:13:17.002Z,1467072797.002 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.869800 seconds old.
2016-06-28T00:13:17.374Z,1467072797.374 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.242900 seconds old.
2016-06-28T00:13:17.382Z,1467072797.382 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.249700 seconds old.
2016-06-28T00:13:17.723Z,1467072797.723 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.592500 seconds old.
2016-06-28T00:13:17.725Z,1467072797.724 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.592700 seconds old.
2016-06-28T00:13:18.213Z,1467072798.213 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.081300 seconds old.
2016-06-28T00:13:18.217Z,1467072798.217 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.084200 seconds old.
2016-06-28T00:13:18.286Z,1467072798.286 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-28T00:13:18.286Z,1467072798.286 [PNI_TCM] No Fault, FailCount= 1
2016-06-28T00:13:18.575Z,1467072798.575 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.442800 seconds old.
2016-06-28T00:13:18.588Z,1467072798.588 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.455900 seconds old.
2016-06-28T00:13:18.978Z,1467072798.978 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.846500 seconds old.
2016-06-28T00:13:18.981Z,1467072798.981 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.849200 seconds old.
2016-06-28T00:13:19.368Z,1467072799.368 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.236900 seconds old.
2016-06-28T00:13:19.369Z,1467072799.369 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.237100 seconds old.
2016-06-28T00:13:19.771Z,1467072799.771 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.640500 seconds old.
2016-06-28T00:13:19.784Z,1467072799.784 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.651700 seconds old.
2016-06-28T00:13:20.182Z,1467072800.182 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.050800 seconds old.
2016-06-28T00:13:20.185Z,1467072800.185 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.053100 seconds old.
2016-06-28T00:13:20.607Z,1467072800.607 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.471800 seconds old.
2016-06-28T00:13:20.615Z,1467072800.615 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.478600 seconds old.
2016-06-28T00:13:20.973Z,1467072800.973 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.841600 seconds old.
2016-06-28T00:13:20.981Z,1467072800.981 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.848600 seconds old.
2016-06-28T00:13:21.340Z,1467072801.340 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.209300 seconds old.
2016-06-28T00:13:21.341Z,1467072801.341 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.209500 seconds old.
2016-06-28T00:13:23.720Z,1467072803.720 [PNI_TCM](ERROR): CRC does not match. Expected:0x2899 got:0x6464
2016-06-28T00:13:24.189Z,1467072804.189 [PNI_TCM](ERROR): CRC does not match. Expected:0x61507 got:0x6464
2016-06-28T00:13:24.190Z,1467072804.190 [PNI_TCM](ERROR): CRC does not match. Expected:0x40533 got:0x6464
2016-06-28T00:13:24.604Z,1467072804.604 [PNI_TCM](ERROR): CRC does not match. Expected:0x29116 got:0x6464
2016-06-28T00:13:25.002Z,1467072805.002 [PNI_TCM](ERROR): CRC does not match. Expected:0x57225 got:0x6464
2016-06-28T00:13:25.718Z,1467072805.718 [PNI_TCM](ERROR): CRC does not match. Expected:0x14906 got:0x6464
2016-06-28T00:13:26.243Z,1467072806.243 [PNI_TCM](ERROR): CRC does not match. Expected:0x4194 got:0x6464
2016-06-28T00:13:26.248Z,1467072806.248 [PNI_TCM](ERROR): CRC does not match. Expected:0x25423 got:0x6464
2016-06-28T00:13:26.593Z,1467072806.593 [PNI_TCM](ERROR): CRC does not match. Expected:0x15693 got:0x6464
2016-06-28T00:13:26.971Z,1467072806.971 [PNI_TCM](ERROR): CRC does not match. Expected:0x15660 got:0x6464
2016-06-28T00:13:27.723Z,1467072807.723 [PNI_TCM](ERROR): CRC does not match. Expected:0x52293 got:0x6464
2016-06-28T00:13:28.127Z,1467072808.127 [PNI_TCM](ERROR): CRC does not match. Expected:0x11680 got:0x6464
2016-06-28T00:13:28.637Z,1467072808.637 [PNI_TCM](ERROR): CRC does not match. Expected:0x64412 got:0x6464
2016-06-28T00:13:28.638Z,1467072808.638 [PNI_TCM](ERROR): CRC does not match. Expected:0x25556 got:0x6464
2016-06-28T00:13:28.996Z,1467072808.996 [PNI_TCM](ERROR): CRC does not match. Expected:0x61128 got:0x6464
2016-06-28T00:13:29.399Z,1467072809.399 [PNI_TCM](ERROR): CRC does not match. Expected:0x40393 got:0x6464
2016-06-28T00:13:30.199Z,1467072810.199 [PNI_TCM](ERROR): CRC does not match. Expected:0x11635 got:0x6464
2016-06-28T00:13:30.204Z,1467072810.204 [PNI_TCM](ERROR): CRC does not match. Expected:0x34161 got:0x6464
2016-06-28T00:13:30.611Z,1467072810.611 [PNI_TCM](ERROR): CRC does not match. Expected:0x7804 got:0x6464
2016-06-28T00:13:31.031Z,1467072811.030 [PNI_TCM](ERROR): CRC does not match. Expected:0x53382 got:0x6464
2016-06-28T00:13:36.502Z,1467072816.502 [PNI_TCM](ERROR): CRC does not match. Expected:0x2072 got:0x6464
2016-06-28T00:13:36.507Z,1467072816.507 [PNI_TCM](ERROR): CRC does not match. Expected:0x17693 got:0x6464
2016-06-28T00:13:36.508Z,1467072816.509 [PNI_TCM](ERROR): CRC does not match. Expected:0x64697 got:0x6464
2016-06-28T00:13:36.510Z,1467072816.510 [PNI_TCM](ERROR): CRC does not match. Expected:0x6972 got:0x6464
2016-06-28T00:13:36.511Z,1467072816.511 [PNI_TCM](ERROR): CRC does not match. Expected:0x8763 got:0x6464
2016-06-28T00:13:36.517Z,1467072816.517 [PNI_TCM](ERROR): CRC does not match. Expected:0x10181 got:0x6464
2016-06-28T00:13:36.518Z,1467072816.518 [PNI_TCM](ERROR): CRC does not match. Expected:0x34757 got:0x6464
2016-06-28T00:13:36.523Z,1467072816.523 [PNI_TCM](ERROR): CRC does not match. Expected:0x51520 got:0x6464
2016-06-28T00:13:36.525Z,1467072816.525 [PNI_TCM](ERROR): CRC does not match. Expected:0x56586 got:0x6464
2016-06-28T00:13:36.525Z,1467072816.525 [PNI_TCM](ERROR): CRC does not match. Expected:0x39884 got:0x6464
2016-06-28T00:13:36.526Z,1467072816.526 [PNI_TCM](ERROR): CRC does not match. Expected:0x39464 got:0x6464
2016-06-28T00:13:36.532Z,1467072816.532 [PNI_TCM](ERROR): CRC does not match. Expected:0x25433 got:0x6464
2016-06-28T00:13:36.533Z,1467072816.533 [PNI_TCM](ERROR): CRC does not match. Expected:0x32107 got:0x6464
2016-06-28T00:13:36.534Z,1467072816.534 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-28T00:13:36.534Z,1467072816.534 [PNI_TCM] Data Fault, FailCount= 1
2016-06-28T00:13:36.534Z,1467072816.534 [PNI_TCM](ERROR): Data Fault
2016-06-28T00:13:36.711Z,1467072816.711 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.375500 seconds old.
2016-06-28T00:13:36.728Z,1467072816.728 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.391000 seconds old.
2016-06-28T00:13:36.782Z,1467072816.782 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-28T00:13:36.894Z,1467072816.894 [PNI_TCM](INFO): Powering down
2016-06-28T00:13:36.936Z,1467072816.936 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.596000 seconds old.
2016-06-28T00:13:36.946Z,1467072816.946 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.608900 seconds old.
2016-06-28T00:13:37.292Z,1467072817.292 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.957300 seconds old.
2016-06-28T00:13:37.293Z,1467072817.293 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.957500 seconds old.
2016-06-28T00:13:37.663Z,1467072817.663 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 6.328400 seconds old.
2016-06-28T00:13:37.665Z,1467072817.665 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 6.328800 seconds old.
2016-06-28T00:13:38.102Z,1467072818.102 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 6.766700 seconds old.
2016-06-28T00:13:38.148Z,1467072818.148 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 6.806700 seconds old.
2016-06-28T00:13:38.226Z,1467072818.226 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-28T00:13:38.227Z,1467072818.227 [PNI_TCM] No Fault, FailCount= 1
2016-06-28T00:13:38.524Z,1467072818.524 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 7.188800 seconds old.
2016-06-28T00:13:38.529Z,1467072818.529 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 7.192100 seconds old.
2016-06-28T00:13:38.922Z,1467072818.921 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 7.586300 seconds old.
2016-06-28T00:13:38.929Z,1467072818.930 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 7.593000 seconds old.
2016-06-28T00:13:39.269Z,1467072819.269 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 7.934600 seconds old.
2016-06-28T00:13:39.271Z,1467072819.271 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 7.934900 seconds old.
2016-06-28T00:13:39.671Z,1467072819.671 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 8.336400 seconds old.
2016-06-28T00:13:39.673Z,1467072819.673 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 8.336600 seconds old.
2016-06-28T00:13:40.055Z,1467072820.055 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 8.720600 seconds old.
2016-06-28T00:13:40.057Z,1467072820.057 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 8.720800 seconds old.
2016-06-28T00:13:40.493Z,1467072820.493 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 9.157700 seconds old.
2016-06-28T00:13:40.498Z,1467072820.498 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 9.161300 seconds old.
2016-06-28T00:13:40.874Z,1467072820.874 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 9.538800 seconds old.
2016-06-28T00:13:40.903Z,1467072820.903 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 9.565900 seconds old.
2016-06-28T00:13:41.307Z,1467072821.307 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 9.971100 seconds old.
2016-06-28T00:13:41.319Z,1467072821.319 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 9.978500 seconds old.
2016-06-28T00:13:43.265Z,1467072823.265 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-06-28T00:13:43.265Z,1467072823.265 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2016-06-28T00:13:43.265Z,1467072823.265 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-06-28T00:13:43.267Z,1467072823.267 [DeadReckonUsingSpeedCalculator](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-06-28T00:13:43.267Z,1467072823.267 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4
2016-06-28T00:13:43.267Z,1467072823.267 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2016-06-28T00:13:43.280Z,1467072823.280 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-06-28T00:13:43.280Z,1467072823.280 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2016-06-28T00:13:43.677Z,1467072823.677 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-06-28T00:13:43.678Z,1467072823.678 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2016-06-28T00:13:43.683Z,1467072823.683 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2016-06-28T00:13:43.683Z,1467072823.683 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4
2016-06-28T00:13:44.196Z,1467072824.196 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-06-28T00:13:44.197Z,1467072824.197 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-06-28T00:13:44.198Z,1467072824.198 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-06-28T00:13:44.200Z,1467072824.200 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2016-06-28T00:13:44.201Z,1467072824.201 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2016-06-28T00:13:44.202Z,1467072824.202 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2016-06-28T00:13:55.259Z,1467072835.259 [PNI_TCM](ERROR): CRC does not match. Expected:0x38692 got:0x29442
2016-06-28T00:13:56.200Z,1467072836.200 [PNI_TCM](ERROR): CRC does not match. Expected:0x15898 got:0x29438
2016-06-28T00:13:56.201Z,1467072836.201 [PNI_TCM](ERROR): CRC does not match. Expected:0x26388 got:0x29441
2016-06-28T00:13:56.554Z,1467072836.554 [PNI_TCM](ERROR): CRC does not match. Expected:0x7639 got:0x29448
2016-06-28T00:13:56.953Z,1467072836.953 [PNI_TCM](ERROR): CRC does not match. Expected:0x63156 got:0x29441
2016-06-28T00:13:57.637Z,1467072837.637 [PNI_TCM](ERROR): CRC does not match. Expected:0x7639 got:0x29437
2016-06-28T00:13:58.096Z,1467072838.096 [PNI_TCM](ERROR): CRC does not match. Expected:0x17625 got:0x29429
2016-06-28T00:13:58.097Z,1467072838.098 [PNI_TCM](ERROR): CRC does not match. Expected:0x16670 got:0x29426
2016-06-28T00:13:58.526Z,1467072838.526 [PNI_TCM](ERROR): CRC does not match. Expected:0x59424 got:0x29437
2016-06-28T00:13:58.923Z,1467072838.923 [PNI_TCM](ERROR): CRC does not match. Expected:0x17625 got:0x29455
2016-06-28T00:13:59.642Z,1467072839.642 [PNI_TCM](ERROR): CRC does not match. Expected:0x24458 got:0x29455
2016-06-28T00:14:00.173Z,1467072840.173 [PNI_TCM](ERROR): CRC does not match. Expected:0x24458 got:0x29446
2016-06-28T00:14:00.174Z,1467072840.174 [PNI_TCM](ERROR): CRC does not match. Expected:0x46313 got:0x29433
2016-06-28T00:14:00.541Z,1467072840.541 [PNI_TCM](ERROR): CRC does not match. Expected:0x52778 got:0x29434
2016-06-28T00:14:00.974Z,1467072840.974 [PNI_TCM](ERROR): CRC does not match. Expected:0x60903 got:0x29450
2016-06-28T00:14:01.259Z,1467072841.259 [PNI_TCM](ERROR): CRC does not match. Expected:0x15325 got:0x29446
2016-06-28T00:14:01.649Z,1467072841.649 [PNI_TCM](ERROR): CRC does not match. Expected:0x46313 got:0x29445
2016-06-28T00:14:02.133Z,1467072842.133 [PNI_TCM](ERROR): CRC does not match. Expected:0x38692 got:0x29422
2016-06-28T00:14:02.532Z,1467072842.532 [PNI_TCM](ERROR): CRC does not match. Expected:0x27802 got:0x29409
2016-06-28T00:14:02.909Z,1467072842.909 [PNI_TCM](ERROR): CRC does not match. Expected:0x49251 got:0x29434
2016-06-28T00:14:03.254Z,1467072843.254 [PNI_TCM](ERROR): CRC does not match. Expected:0x60903 got:0x29432
2016-06-28T00:14:04.036Z,1467072844.036 [PNI_TCM](ERROR): CRC does not match. Expected:0x8334 got:0x29432
2016-06-28T00:14:04.535Z,1467072844.535 [PNI_TCM](ERROR): CRC does not match. Expected:0x8334 got:0x29437
2016-06-28T00:14:04.540Z,1467072844.540 [PNI_TCM](ERROR): CRC does not match. Expected:0x17625 got:0x29433
2016-06-28T00:14:04.541Z,1467072844.541 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-28T00:14:04.541Z,1467072844.541 [PNI_TCM] Data Fault, FailCount= 1
2016-06-28T00:14:04.541Z,1467072844.541 [PNI_TCM](ERROR): Data Fault
2016-06-28T00:14:04.566Z,1467072844.566 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.491000 seconds old.
2016-06-28T00:14:04.580Z,1467072844.580 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.499100 seconds old.
2016-06-28T00:14:04.656Z,1467072844.657 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-28T00:14:04.870Z,1467072844.870 [PNI_TCM](INFO): Powering down
2016-06-28T00:14:04.959Z,1467072844.959 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.883600 seconds old.
2016-06-28T00:14:04.964Z,1467072844.964 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.888600 seconds old.
2016-06-28T00:14:05.335Z,1467072845.335 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.259500 seconds old.
2016-06-28T00:14:05.339Z,1467072845.339 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.262900 seconds old.
2016-06-28T00:14:05.640Z,1467072845.639 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.565100 seconds old.
2016-06-28T00:14:05.641Z,1467072845.641 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.565300 seconds old.
2016-06-28T00:14:06.137Z,1467072846.137 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.061700 seconds old.
2016-06-28T00:14:06.141Z,1467072846.141 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.065400 seconds old.
2016-06-28T00:14:06.217Z,1467072846.217 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-28T00:14:06.217Z,1467072846.217 [PNI_TCM] No Fault, FailCount= 1
2016-06-28T00:14:06.483Z,1467072846.483 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.407600 seconds old.
2016-06-28T00:14:06.494Z,1467072846.494 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.417200 seconds old.
2016-06-28T00:14:06.917Z,1467072846.917 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.841600 seconds old.
2016-06-28T00:14:06.921Z,1467072846.921 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.844900 seconds old.
2016-06-28T00:14:07.307Z,1467072847.307 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.224600 seconds old.
2016-06-28T00:14:07.308Z,1467072847.308 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.232900 seconds old.
2016-06-28T00:14:07.640Z,1467072847.640 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.565400 seconds old.
2016-06-28T00:14:07.641Z,1467072847.641 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.565700 seconds old.
2016-06-28T00:14:08.133Z,1467072848.133 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.058200 seconds old.
2016-06-28T00:14:08.141Z,1467072848.141 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.065400 seconds old.
2016-06-28T00:14:08.520Z,1467072848.520 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.445300 seconds old.
2016-06-28T00:14:08.524Z,1467072848.524 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.447900 seconds old.
2016-06-28T00:14:08.902Z,1467072848.902 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.827100 seconds old.
2016-06-28T00:14:08.911Z,1467072848.911 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.834800 seconds old.
2016-06-28T00:14:09.248Z,1467072849.248 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.173300 seconds old.
2016-06-28T00:14:09.249Z,1467072849.249 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.173600 seconds old.
2016-06-28T00:14:13.041Z,1467072853.041 [PNI_TCM](ERROR): CRC does not match. Expected:0x27254 got:0x29435
2016-06-28T00:14:13.645Z,1467072853.645 [PNI_TCM](ERROR): CRC does not match. Expected:0x835 got:0x29441
2016-06-28T00:14:14.121Z,1467072854.121 [PNI_TCM](ERROR): CRC does not match. Expected:0x7639 got:0x29441
2016-06-28T00:14:14.122Z,1467072854.122 [PNI_TCM](ERROR): CRC does not match. Expected:0x7639 got:0x29438
2016-06-28T00:14:14.516Z,1467072854.516 [PNI_TCM](ERROR): CRC does not match. Expected:0x26388 got:0x29445
2016-06-28T00:14:14.914Z,1467072854.914 [PNI_TCM](ERROR): CRC does not match. Expected:0x38692 got:0x29444
2016-06-28T00:14:15.642Z,1467072855.642 [PNI_TCM](ERROR): CRC does not match. Expected:0x31104 got:0x29442
2016-06-28T00:14:16.039Z,1467072856.039 [PNI_TCM](ERROR): CRC does not match. Expected:0x15898 got:0x29437
2016-06-28T00:14:16.532Z,1467072856.532 [PNI_TCM](ERROR): CRC does not match. Expected:0x17625 got:0x29442
2016-06-28T00:14:16.533Z,1467072856.533 [PNI_TCM](ERROR): CRC does not match. Expected:0x15898 got:0x29429
2016-06-28T00:14:16.916Z,1467072856.917 [PNI_TCM](ERROR): CRC does not match. Expected:0x16670 got:0x29432
2016-06-28T00:14:17.326Z,1467072857.326 [PNI_TCM](ERROR): CRC does not match. Expected:0x8334 got:0x29443
2016-06-28T00:14:18.117Z,1467072858.117 [PNI_TCM](ERROR): CRC does not match. Expected:0x53438 got:0x29437
2016-06-28T00:14:18.119Z,1467072858.119 [PNI_TCM](ERROR): CRC does not match. Expected:0x17625 got:0x29430
2016-06-28T00:14:18.515Z,1467072858.514 [PNI_TCM](ERROR): CRC does not match. Expected:0x25299 got:0x29424
2016-06-28T00:14:18.968Z,1467072858.968 [PNI_TCM](ERROR): CRC does not match. Expected:0x9545 got:0x29427
2016-06-28T00:14:19.646Z,1467072859.646 [PNI_TCM](ERROR): CRC does not match. Expected:0x45170 got:0x6464
2016-06-28T00:14:20.127Z,1467072860.127 [PNI_TCM](ERROR): CRC does not match. Expected:0x24452 got:0x6464
2016-06-28T00:14:20.128Z,1467072860.128 [PNI_TCM](ERROR): CRC does not match. Expected:0x36904 got:0x6464
2016-06-28T00:14:20.493Z,1467072860.493 [PNI_TCM](ERROR): CRC does not match. Expected:0x45914 got:0x6464
2016-06-28T00:14:20.904Z,1467072860.904 [PNI_TCM](ERROR): CRC does not match. Expected:0x4646 got:0x6464
2016-06-28T00:14:21.637Z,1467072861.636 [PNI_TCM](ERROR): CRC does not match. Expected:0x41272 got:0x6464
2016-06-28T00:14:22.144Z,1467072862.144 [PNI_TCM](ERROR): CRC does not match. Expected:0x36442 got:0x6464
2016-06-28T00:14:22.144Z,1467072862.144 [PNI_TCM](ERROR): CRC does not match. Expected:0x45304 got:0x6464
2016-06-28T00:14:22.145Z,1467072862.145 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-28T00:14:22.145Z,1467072862.145 [PNI_TCM] Data Fault, FailCount= 1
2016-06-28T00:14:22.145Z,1467072862.145 [PNI_TCM](ERROR): Data Fault
2016-06-28T00:14:22.217Z,1467072862.217 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.536500 seconds old.
2016-06-28T00:14:22.229Z,1467072862.229 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.547700 seconds old.
2016-06-28T00:14:22.339Z,1467072862.339 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-28T00:14:22.486Z,1467072862.486 [PNI_TCM](INFO): Powering down
2016-06-28T00:14:22.525Z,1467072862.525 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.844600 seconds old.
2016-06-28T00:14:22.538Z,1467072862.537 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.856000 seconds old.
2016-06-28T00:14:22.923Z,1467072862.923 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.226200 seconds old.
2016-06-28T00:14:22.936Z,1467072862.936 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.255000 seconds old.
2016-06-28T00:14:23.260Z,1467072863.260 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.580400 seconds old.
2016-06-28T00:14:23.262Z,1467072863.262 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.580800 seconds old.
2016-06-28T00:14:23.642Z,1467072863.642 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.961800 seconds old.
2016-06-28T00:14:23.643Z,1467072863.643 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.962200 seconds old.
2016-06-28T00:14:23.656Z,1467072863.656 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-28T00:14:23.656Z,1467072863.656 [PNI_TCM] No Fault, FailCount= 1
2016-06-28T00:14:24.106Z,1467072864.106 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.425300 seconds old.
2016-06-28T00:14:24.120Z,1467072864.120 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.434100 seconds old.
2016-06-28T00:14:24.502Z,1467072864.502 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.821600 seconds old.
2016-06-28T00:14:24.506Z,1467072864.506 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.824200 seconds old.
2016-06-28T00:14:24.923Z,1467072864.922 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.241900 seconds old.
2016-06-28T00:14:24.951Z,1467072864.951 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.265700 seconds old.
2016-06-28T00:14:25.243Z,1467072865.243 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.563100 seconds old.
2016-06-28T00:14:25.244Z,1467072865.244 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.563600 seconds old.
2016-06-28T00:14:25.669Z,1467072865.669 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.975200 seconds old.
2016-06-28T00:14:25.671Z,1467072865.671 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.989800 seconds old.
2016-06-28T00:14:26.178Z,1467072866.178 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.497000 seconds old.
2016-06-28T00:14:26.189Z,1467072866.189 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.507400 seconds old.
2016-06-28T00:14:26.534Z,1467072866.534 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.853100 seconds old.
2016-06-28T00:14:26.542Z,1467072866.542 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.860000 seconds old.
2016-06-28T00:14:26.893Z,1467072866.893 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.212800 seconds old.
2016-06-28T00:14:26.897Z,1467072866.897 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.215900 seconds old.
2016-06-28T00:15:08.945Z,1467072908.944 [BPC1](ERROR): Failed to receive battery data
2016-06-28T00:15:08.945Z,1467072908.945 [BPC1] Communications Fault, FailCount= 1
2016-06-28T00:15:08.945Z,1467072908.945 [BPC1](ERROR): Communications Fault
2016-06-28T00:15:08.992Z,1467072908.992 [CBIT](ERROR): Communications Fault in component: BPC1
2016-06-28T00:15:10.333Z,1467072910.333 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-28T00:15:10.333Z,1467072910.333 [BPC1] No Fault, FailCount= 1
2016-06-28T00:15:31.018Z,1467072931.017 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2016-06-28T00:15:31.018Z,1467072931.018 [Default:CheckIn:C.Wait] Stopped
2016-06-28T00:15:31.018Z,1467072931.018 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2016-06-28T00:15:31.018Z,1467072931.018 [Default:CheckIn:D] Running Loop=1
2016-06-28T00:15:31.415Z,1467072931.415 [Default:CheckIn:D] Stopped
2016-06-28T00:15:31.415Z,1467072931.415 [Default:CheckIn:E] Running Loop=1
2016-06-28T00:15:31.834Z,1467072931.833 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.649504 min 
2016-06-28T00:15:31.851Z,1467072931.851 [Default:CheckIn:E] Stopped
2016-06-28T00:15:31.851Z,1467072931.851 [Default:CheckIn](INFO): Completed Default:CheckIn
2016-06-28T00:15:31.852Z,1467072931.852 [Default:CheckIn] Stopped
2016-06-28T00:15:31.852Z,1467072931.852 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2016-06-28T00:15:31.852Z,1467072931.852 [Default:CheckIn](INFO): Running loop #2
2016-06-28T00:15:31.853Z,1467072931.852 [Default:CheckIn] Running Loop=2
2016-06-28T00:15:31.853Z,1467072931.853 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2016-06-28T00:15:31.853Z,1467072931.853 [Default:CheckIn:Read_GPS] Running Loop=1
2016-06-28T00:16:26.266Z,1467072986.266 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:16:26.677Z,1467072986.677 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:16:44.568Z,1467073004.569 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-06-28T00:16:44.569Z,1467073004.569 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2016-06-28T00:16:44.569Z,1467073004.569 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-06-28T00:16:44.585Z,1467073004.585 [DeadReckonUsingSpeedCalculator](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-06-28T00:16:44.585Z,1467073004.585 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5
2016-06-28T00:16:44.585Z,1467073004.585 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2016-06-28T00:16:44.660Z,1467073004.660 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-06-28T00:16:44.662Z,1467073004.662 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2016-06-28T00:16:44.890Z,1467073004.890 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-06-28T00:16:44.890Z,1467073004.890 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2016-06-28T00:16:44.891Z,1467073004.891 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2016-06-28T00:16:44.891Z,1467073004.891 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5
2016-06-28T00:16:45.281Z,1467073005.281 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-06-28T00:16:45.282Z,1467073005.282 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-06-28T00:16:45.282Z,1467073005.282 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-06-28T00:16:45.282Z,1467073005.282 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2016-06-28T00:16:45.287Z,1467073005.287 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2016-06-28T00:16:45.287Z,1467073005.287 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2016-06-28T00:17:04.558Z,1467073024.558 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:17:04.973Z,1467073024.973 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:17:05.384Z,1467073025.384 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:17:37.894Z,1467073057.894 [BPC1](ERROR): Failed to receive battery data
2016-06-28T00:17:37.895Z,1467073057.895 [BPC1] Communications Fault, FailCount= 1
2016-06-28T00:17:37.895Z,1467073057.895 [BPC1](ERROR): Communications Fault
2016-06-28T00:17:38.008Z,1467073058.008 [CBIT](ERROR): Communications Fault in component: BPC1
2016-06-28T00:17:39.002Z,1467073059.002 [PNI_TCM](ERROR): CRC does not match. Expected:0x55971 got:0x29441
2016-06-28T00:17:39.021Z,1467073059.021 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-28T00:17:39.022Z,1467073059.022 [BPC1] No Fault, FailCount= 1
2016-06-28T00:17:39.393Z,1467073059.393 [PNI_TCM](ERROR): CRC does not match. Expected:0x7639 got:0x29448
2016-06-28T00:17:40.292Z,1467073060.292 [PNI_TCM](ERROR): CRC does not match. Expected:0x63156 got:0x29442
2016-06-28T00:17:40.293Z,1467073060.293 [PNI_TCM](ERROR): CRC does not match. Expected:0x15898 got:0x29433
2016-06-28T00:17:40.503Z,1467073060.503 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:17:40.675Z,1467073060.675 [PNI_TCM](ERROR): CRC does not match. Expected:0x52778 got:0x29432
2016-06-28T00:17:40.913Z,1467073060.913 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:17:41.066Z,1467073061.066 [PNI_TCM](ERROR): CRC does not match. Expected:0x8334 got:0x29434
2016-06-28T00:17:41.324Z,1467073061.324 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:17:41.873Z,1467073061.873 [PNI_TCM](ERROR): CRC does not match. Expected:0x60903 got:0x29443
2016-06-28T00:17:41.874Z,1467073061.874 [PNI_TCM](ERROR): CRC does not match. Expected:0x53438 got:0x29439
2016-06-28T00:17:42.296Z,1467073062.296 [PNI_TCM](ERROR): CRC does not match. Expected:0x35248 got:0x29439
2016-06-28T00:17:42.718Z,1467073062.718 [PNI_TCM](ERROR): CRC does not match. Expected:0x35248 got:0x29438
2016-06-28T00:17:43.402Z,1467073063.402 [PNI_TCM](ERROR): CRC does not match. Expected:0x26388 got:0x29439
2016-06-28T00:17:43.403Z,1467073063.403 [PNI_TCM](ERROR): CRC does not match. Expected:0x35248 got:0x29436
2016-06-28T00:17:43.873Z,1467073063.872 [PNI_TCM](ERROR): CRC does not match. Expected:0x43645 got:0x29444
2016-06-28T00:17:44.252Z,1467073064.253 [PNI_TCM](ERROR): CRC does not match. Expected:0x31104 got:0x29442
2016-06-28T00:17:44.674Z,1467073064.674 [PNI_TCM](ERROR): CRC does not match. Expected:0x15898 got:0x29438
2016-06-28T00:17:45.003Z,1467073065.003 [PNI_TCM](ERROR): CRC does not match. Expected:0x26388 got:0x29433
2016-06-28T00:17:45.402Z,1467073065.402 [PNI_TCM](ERROR): CRC does not match. Expected:0x52778 got:0x29434
2016-06-28T00:17:45.857Z,1467073065.857 [PNI_TCM](ERROR): CRC does not match. Expected:0x60903 got:0x29432
2016-06-28T00:17:46.290Z,1467073066.290 [PNI_TCM](ERROR): CRC does not match. Expected:0x8334 got:0x29434
2016-06-28T00:17:46.639Z,1467073066.639 [PNI_TCM](ERROR): CRC does not match. Expected:0x60903 got:0x29443
2016-06-28T00:17:47.008Z,1467073067.008 [PNI_TCM](ERROR): CRC does not match. Expected:0x53438 got:0x29441
2016-06-28T00:17:47.396Z,1467073067.396 [PNI_TCM](ERROR): CRC does not match. Expected:0x7639 got:0x29444
2016-06-28T00:17:47.841Z,1467073067.841 [PNI_TCM](ERROR): CRC does not match. Expected:0x48708 got:0x6464
2016-06-28T00:17:48.278Z,1467073068.277 [PNI_TCM](ERROR): CRC does not match. Expected:0x65023 got:0x6464
2016-06-28T00:17:48.278Z,1467073068.278 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-28T00:17:48.278Z,1467073068.279 [PNI_TCM] Data Fault, FailCount= 1
2016-06-28T00:17:48.279Z,1467073068.279 [PNI_TCM](ERROR): Data Fault
2016-06-28T00:17:48.323Z,1467073068.323 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.438000 seconds old.
2016-06-28T00:17:48.344Z,1467073068.344 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.452300 seconds old.
2016-06-28T00:17:48.426Z,1467073068.426 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-28T00:17:48.610Z,1467073068.611 [PNI_TCM](INFO): Powering down
2016-06-28T00:17:48.634Z,1467073068.634 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.749200 seconds old.
2016-06-28T00:17:48.642Z,1467073068.642 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.754800 seconds old.
2016-06-28T00:17:48.991Z,1467073068.991 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.107300 seconds old.
2016-06-28T00:17:48.993Z,1467073068.993 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.105900 seconds old.
2016-06-28T00:17:49.409Z,1467073069.409 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.525000 seconds old.
2016-06-28T00:17:49.410Z,1467073069.410 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.523600 seconds old.
2016-06-28T00:17:49.835Z,1467073069.835 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.950500 seconds old.
2016-06-28T00:17:49.848Z,1467073069.848 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.956100 seconds old.
2016-06-28T00:17:49.906Z,1467073069.906 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-28T00:17:49.906Z,1467073069.907 [PNI_TCM] No Fault, FailCount= 1
2016-06-28T00:17:50.254Z,1467073070.253 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.368800 seconds old.
2016-06-28T00:17:50.262Z,1467073070.262 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.374800 seconds old.
2016-06-28T00:17:50.630Z,1467073070.630 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.744600 seconds old.
2016-06-28T00:17:50.638Z,1467073070.638 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.751100 seconds old.
2016-06-28T00:17:51.012Z,1467073071.012 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.128300 seconds old.
2016-06-28T00:17:51.013Z,1467073071.013 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.126900 seconds old.
2016-06-28T00:17:51.400Z,1467073071.400 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.516200 seconds old.
2016-06-28T00:17:51.401Z,1467073071.401 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.515000 seconds old.
2016-06-28T00:17:51.797Z,1467073071.797 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.912900 seconds old.
2016-06-28T00:17:51.798Z,1467073071.798 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.911500 seconds old.
2016-06-28T00:17:52.257Z,1467073072.257 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.372300 seconds old.
2016-06-28T00:17:52.261Z,1467073072.261 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.373600 seconds old.
2016-06-28T00:17:52.650Z,1467073072.650 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.765100 seconds old.
2016-06-28T00:17:52.664Z,1467073072.664 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.776300 seconds old.
2016-06-28T00:17:53.048Z,1467073073.048 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.158600 seconds old.
2016-06-28T00:17:53.056Z,1467073073.056 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.169000 seconds old.
2016-06-28T00:17:54.689Z,1467073074.689 [BPC1](ERROR): Failed to parse bank B battery data
2016-06-28T00:17:54.690Z,1467073074.690 [BPC1] Data Fault, FailCount= 2
2016-06-28T00:17:54.690Z,1467073074.690 [BPC1](ERROR): Data Fault
2016-06-28T00:17:54.743Z,1467073074.743 [CBIT](ERROR): Data Fault in component: BPC1
2016-06-28T00:17:56.014Z,1467073076.014 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-28T00:17:56.014Z,1467073076.014 [BPC1] No Fault, FailCount= 2
2016-06-28T00:18:12.668Z,1467073092.668 [PNI_TCM](ERROR): CRC does not match. Expected:0x44300 got:0x29433
2016-06-28T00:18:13.010Z,1467073093.010 [PNI_TCM](ERROR): CRC does not match. Expected:0x8286 got:0x6464
2016-06-28T00:18:13.849Z,1467073093.849 [PNI_TCM](ERROR): CRC does not match. Expected:0x51971 got:0x6464
2016-06-28T00:18:13.850Z,1467073093.850 [PNI_TCM](ERROR): CRC does not match. Expected:0x59182 got:0x6464
2016-06-28T00:18:14.266Z,1467073094.266 [PNI_TCM](ERROR): CRC does not match. Expected:0x20413 got:0x42607
2016-06-28T00:18:14.650Z,1467073094.649 [PNI_TCM](ERROR): CRC does not match. Expected:0x46670 got:0x42359
2016-06-28T00:18:15.416Z,1467073095.416 [PNI_TCM](ERROR): CRC does not match. Expected:0x62280 got:0x41755
2016-06-28T00:18:15.416Z,1467073095.416 [PNI_TCM](ERROR): CRC does not match. Expected:0x24012 got:0x47374
2016-06-28T00:18:15.814Z,1467073095.814 [PNI_TCM](ERROR): CRC does not match. Expected:0x9619 got:0x27614
2016-06-28T00:18:16.271Z,1467073096.272 [PNI_TCM](ERROR): CRC does not match. Expected:0x9164 got:0x40118
2016-06-28T00:18:16.659Z,1467073096.659 [PNI_TCM](ERROR): CRC does not match. Expected:0x56925 got:0x32109
2016-06-28T00:18:17.057Z,1467073097.057 [PNI_TCM](ERROR): CRC does not match. Expected:0x5056 got:0x57988
2016-06-28T00:18:17.400Z,1467073097.400 [PNI_TCM](ERROR): CRC does not match. Expected:0x22353 got:0x43442
2016-06-28T00:18:17.893Z,1467073097.893 [PNI_TCM](ERROR): CRC does not match. Expected:0x55170 got:0x18759
2016-06-28T00:18:18.308Z,1467073098.308 [PNI_TCM](ERROR): CRC does not match. Expected:0x6369 got:0x17140
2016-06-28T00:18:18.664Z,1467073098.664 [PNI_TCM](ERROR): CRC does not match. Expected:0x17300 got:0x17140
2016-06-28T00:18:18.000Z,1467073099.000 [PNI_TCM](ERROR): CRC does not match. Expected:0x62174 got:0x17140
2016-06-28T00:18:19.396Z,1467073099.396 [PNI_TCM](ERROR): CRC does not match. Expected:0x41245 got:0x17140
2016-06-28T00:18:19.874Z,1467073099.874 [PNI_TCM](ERROR): CRC does not match. Expected:0x43616 got:0x17140
2016-06-28T00:18:20.266Z,1467073100.266 [PNI_TCM](ERROR): CRC does not match. Expected:0x41452 got:0x17140
2016-06-28T00:18:20.652Z,1467073100.652 [PNI_TCM](ERROR): CRC does not match. Expected:0x13556 got:0x106
2016-06-28T00:18:21.005Z,1467073101.005 [PNI_TCM](ERROR): CRC does not match. Expected:0x12461 got:0x85
2016-06-28T00:18:21.413Z,1467073101.413 [PNI_TCM](ERROR): CRC does not match. Expected:0x48335 got:0x178
2016-06-28T00:18:21.870Z,1467073101.870 [PNI_TCM](ERROR): CRC does not match. Expected:0x49327 got:0x87
2016-06-28T00:18:21.871Z,1467073101.871 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-28T00:18:21.875Z,1467073101.875 [PNI_TCM] Data Fault, FailCount= 1
2016-06-28T00:18:21.876Z,1467073101.876 [PNI_TCM](ERROR): Data Fault
2016-06-28T00:18:21.924Z,1467073101.924 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.498600 seconds old.
2016-06-28T00:18:21.953Z,1467073101.953 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.531300 seconds old.
2016-06-28T00:18:22.119Z,1467073102.118 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-28T00:18:22.242Z,1467073102.241 [PNI_TCM](INFO): Powering down
2016-06-28T00:18:22.293Z,1467073102.293 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.872400 seconds old.
2016-06-28T00:18:22.296Z,1467073102.296 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.874800 seconds old.
2016-06-28T00:18:22.657Z,1467073102.657 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.236900 seconds old.
2016-06-28T00:18:22.658Z,1467073102.658 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.237300 seconds old.
2016-06-28T00:18:23.051Z,1467073103.051 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.631500 seconds old.
2016-06-28T00:18:23.053Z,1467073103.053 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.631900 seconds old.
2016-06-28T00:18:23.404Z,1467073103.404 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.984400 seconds old.
2016-06-28T00:18:23.406Z,1467073103.406 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.984800 seconds old.
2016-06-28T00:18:23.442Z,1467073103.442 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-28T00:18:23.442Z,1467073103.442 [PNI_TCM] No Fault, FailCount= 1
2016-06-28T00:18:23.884Z,1467073103.884 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.463700 seconds old.
2016-06-28T00:18:23.888Z,1467073103.888 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.466800 seconds old.
2016-06-28T00:18:24.244Z,1467073104.244 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.824000 seconds old.
2016-06-28T00:18:24.252Z,1467073104.252 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.830700 seconds old.
2016-06-28T00:18:24.656Z,1467073104.656 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.236000 seconds old.
2016-06-28T00:18:24.657Z,1467073104.657 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.236400 seconds old.
2016-06-28T00:18:25.036Z,1467073105.036 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.615600 seconds old.
2016-06-28T00:18:25.037Z,1467073105.037 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.616000 seconds old.
2016-06-28T00:18:25.414Z,1467073105.414 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.993900 seconds old.
2016-06-28T00:18:25.415Z,1467073105.415 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.994500 seconds old.
2016-06-28T00:18:25.862Z,1467073105.862 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.441400 seconds old.
2016-06-28T00:18:25.866Z,1467073105.866 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.444600 seconds old.
2016-06-28T00:18:26.260Z,1467073106.260 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.835100 seconds old.
2016-06-28T00:18:26.264Z,1467073106.264 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.843000 seconds old.
2016-06-28T00:18:26.636Z,1467073106.636 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.215200 seconds old.
2016-06-28T00:18:26.641Z,1467073106.641 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.219400 seconds old.
2016-06-28T00:18:29.124Z,1467073109.124 [PNI_TCM](ERROR): CRC does not match. Expected:0x40365 got:0x29441
2016-06-28T00:18:29.124Z,1467073109.124 [PNI_TCM](ERROR): CRC does not match. Expected:0x7639 got:0x29441
2016-06-28T00:18:29.854Z,1467073109.854 [PNI_TCM](ERROR): CRC does not match. Expected:0x7639 got:0x29444
2016-06-28T00:18:29.855Z,1467073109.855 [PNI_TCM](ERROR): CRC does not match. Expected:0x31104 got:0x29434
2016-06-28T00:18:30.639Z,1467073110.639 [PNI_TCM](ERROR): CRC does not match. Expected:0x60903 got:0x29430
2016-06-28T00:18:30.999Z,1467073110.999 [PNI_TCM](ERROR): CRC does not match. Expected:0x25299 got:0x29450
2016-06-28T00:18:31.410Z,1467073111.410 [PNI_TCM](ERROR): CRC does not match. Expected:0x15325 got:0x29453
2016-06-28T00:18:31.865Z,1467073111.865 [PNI_TCM](ERROR): CRC does not match. Expected:0x37603 got:0x29441
2016-06-28T00:18:31.866Z,1467073111.866 [PNI_TCM](ERROR): CRC does not match. Expected:0x7639 got:0x29430
2016-06-28T00:18:32.288Z,1467073112.288 [PNI_TCM](ERROR): CRC does not match. Expected:0x25299 got:0x29433
2016-06-28T00:18:32.647Z,1467073112.648 [PNI_TCM](ERROR): CRC does not match. Expected:0x52778 got:0x29434
2016-06-28T00:18:37.432Z,1467073117.432 [PNI_TCM](ERROR): CRC does not match. Expected:0x60903 got:0x29436
2016-06-28T00:18:37.432Z,1467073117.432 [PNI_TCM](ERROR): CRC does not match. Expected:0x43645 got:0x29434
2016-06-28T00:18:37.432Z,1467073117.432 [PNI_TCM](ERROR): CRC does not match. Expected:0x60903 got:0x29445
2016-06-28T00:18:37.433Z,1467073117.433 [PNI_TCM](ERROR): CRC does not match. Expected:0x38692 got:0x29439
2016-06-28T00:18:37.433Z,1467073117.433 [PNI_TCM](ERROR): CRC does not match. Expected:0x35248 got:0x29440
2016-06-28T00:18:37.433Z,1467073117.434 [PNI_TCM](ERROR): CRC does not match. Expected:0x62323 got:0x29444
2016-06-28T00:18:37.434Z,1467073117.434 [PNI_TCM](ERROR): CRC does not match. Expected:0x31104 got:0x29439
2016-06-28T00:18:37.434Z,1467073117.434 [PNI_TCM](ERROR): CRC does not match. Expected:0x35248 got:0x29439
2016-06-28T00:18:37.435Z,1467073117.435 [PNI_TCM](ERROR): CRC does not match. Expected:0x35248 got:0x29432
2016-06-28T00:18:37.435Z,1467073117.435 [PNI_TCM](ERROR): CRC does not match. Expected:0x8334 got:0x29436
2016-06-28T00:18:37.435Z,1467073117.435 [PNI_TCM](ERROR): CRC does not match. Expected:0x43645 got:0x29446
2016-06-28T00:18:37.436Z,1467073117.436 [PNI_TCM](ERROR): CRC does not match. Expected:0x46313 got:0x29446
2016-06-28T00:18:38.048Z,1467073118.048 [PNI_TCM](ERROR): CRC does not match. Expected:0x46313 got:0x29435
2016-06-28T00:18:38.472Z,1467073118.472 [PNI_TCM](ERROR): CRC does not match. Expected:0x835 got:0x29433
2016-06-28T00:18:38.472Z,1467073118.472 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-28T00:18:38.473Z,1467073118.473 [PNI_TCM] Data Fault, FailCount= 1
2016-06-28T00:18:38.473Z,1467073118.473 [PNI_TCM](ERROR): Data Fault
2016-06-28T00:18:38.533Z,1467073118.533 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.449200 seconds old.
2016-06-28T00:18:38.542Z,1467073118.542 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.440000 seconds old.
2016-06-28T00:18:38.634Z,1467073118.634 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-28T00:18:38.773Z,1467073118.773 [PNI_TCM](INFO): Powering down
2016-06-28T00:18:38.798Z,1467073118.798 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.714700 seconds old.
2016-06-28T00:18:38.799Z,1467073118.799 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.698200 seconds old.
2016-06-28T00:18:39.211Z,1467073119.211 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.128000 seconds old.
2016-06-28T00:18:39.213Z,1467073119.213 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.111300 seconds old.
2016-06-28T00:18:39.619Z,1467073119.619 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.536000 seconds old.
2016-06-28T00:18:39.621Z,1467073119.621 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.519500 seconds old.
2016-06-28T00:18:40.052Z,1467073120.052 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.967700 seconds old.
2016-06-28T00:18:40.057Z,1467073120.057 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.955500 seconds old.
2016-06-28T00:18:40.139Z,1467073120.139 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-28T00:18:40.140Z,1467073120.139 [PNI_TCM] No Fault, FailCount= 1
2016-06-28T00:18:40.460Z,1467073120.460 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.376600 seconds old.
2016-06-28T00:18:40.469Z,1467073120.469 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.366900 seconds old.
2016-06-28T00:18:40.845Z,1467073120.845 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.761700 seconds old.
2016-06-28T00:18:40.854Z,1467073120.854 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.751700 seconds old.
2016-06-28T00:18:41.203Z,1467073121.203 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.120000 seconds old.
2016-06-28T00:18:41.205Z,1467073121.205 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.103500 seconds old.
2016-06-28T00:18:41.641Z,1467073121.641 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.557700 seconds old.
2016-06-28T00:18:41.646Z,1467073121.646 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.544400 seconds old.
2016-06-28T00:18:42.062Z,1467073122.062 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.977800 seconds old.
2016-06-28T00:18:42.070Z,1467073122.070 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.968200 seconds old.
2016-06-28T00:18:42.458Z,1467073122.458 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.374000 seconds old.
2016-06-28T00:18:42.465Z,1467073122.466 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.363700 seconds old.
2016-06-28T00:18:42.787Z,1467073122.787 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.704100 seconds old.
2016-06-28T00:18:42.789Z,1467073122.789 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.687400 seconds old.
2016-06-28T00:18:43.195Z,1467073123.195 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.112300 seconds old.
2016-06-28T00:18:43.197Z,1467073123.197 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.095600 seconds old.
2016-06-28T00:19:41.988Z,1467073181.988 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2016-06-28T00:19:41.989Z,1467073181.989 [Rowe_600LCM] Communications Fault, FailCount= 1
2016-06-28T00:19:41.989Z,1467073181.989 [Rowe_600LCM](ERROR): Communications Fault
2016-06-28T00:19:42.056Z,1467073182.056 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2016-06-28T00:19:42.337Z,1467073182.337 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.4 s old, using for 20.0 s.
2016-06-28T00:19:42.396Z,1467073182.396 [Rowe_600LCM](INFO): Powering down
2016-06-28T00:19:42.670Z,1467073182.670 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.7 s old, using for 20.0 s.
2016-06-28T00:19:43.066Z,1467073183.066 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.1 s old, using for 20.0 s.
2016-06-28T00:19:43.480Z,1467073183.480 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.5 s old, using for 20.0 s.
2016-06-28T00:19:43.873Z,1467073183.873 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.9 s old, using for 20.0 s.
2016-06-28T00:19:43.886Z,1467073183.886 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2016-06-28T00:19:43.886Z,1467073183.886 [Rowe_600LCM] No Fault, FailCount= 1
2016-06-28T00:19:44.011Z,1467073184.011 [Rowe_600LCM](INFO): Initializing
2016-06-28T00:19:44.012Z,1467073184.012 [Rowe_600LCM](INFO): Checking LCM
2016-06-28T00:19:44.012Z,1467073184.012 [Rowe_600LCM](INFO): LCM OK
2016-06-28T00:19:44.012Z,1467073184.012 [Rowe_600LCM](INFO): Powering up
2016-06-28T00:19:44.265Z,1467073184.265 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.3 s old, using for 20.0 s.
2016-06-28T00:19:44.670Z,1467073184.670 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.7 s old, using for 20.0 s.
2016-06-28T00:19:45.072Z,1467073185.072 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.1 s old, using for 20.0 s.
2016-06-28T00:19:45.461Z,1467073185.461 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.5 s old, using for 20.0 s.
2016-06-28T00:19:45.463Z,1467073185.463 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-06-28T00:19:45.463Z,1467073185.463 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2016-06-28T00:19:45.463Z,1467073185.463 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-06-28T00:19:45.469Z,1467073185.469 [DeadReckonUsingSpeedCalculator](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-06-28T00:19:45.469Z,1467073185.469 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6
2016-06-28T00:19:45.469Z,1467073185.469 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2016-06-28T00:19:45.494Z,1467073185.494 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-06-28T00:19:45.494Z,1467073185.494 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2016-06-28T00:19:45.884Z,1467073185.884 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-06-28T00:19:45.884Z,1467073185.884 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2016-06-28T00:19:45.884Z,1467073185.884 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2016-06-28T00:19:45.884Z,1467073185.884 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6
2016-06-28T00:19:46.312Z,1467073186.312 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-06-28T00:19:46.312Z,1467073186.312 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-06-28T00:19:46.313Z,1467073186.313 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-06-28T00:19:46.313Z,1467073186.313 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2016-06-28T00:19:46.313Z,1467073186.313 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2016-06-28T00:19:46.314Z,1467073186.314 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2016-06-28T00:19:46.674Z,1467073186.674 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.7 s old, using for 20.0 s.
2016-06-28T00:19:47.078Z,1467073187.078 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.1 s old, using for 20.0 s.
2016-06-28T00:19:47.453Z,1467073187.453 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.5 s old, using for 20.0 s.
2016-06-28T00:19:47.856Z,1467073187.856 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.9 s old, using for 20.0 s.
2016-06-28T00:19:48.143Z,1467073188.143 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2016-06-28T00:19:48.198Z,1467073188.198 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:./bin/roweadcp -dev /dev/ttyB4 -b 38400 >& /dev/null &
2016-06-28T00:19:48.200Z,1467073188.200 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2016-06-28T00:19:48.201Z,1467073188.201 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2016-06-28T00:19:48.287Z,1467073188.287 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.3 s old, using for 20.0 s.
2016-06-28T00:20:31.924Z,1467073231.924 [Default:CheckIn:Read_GPS](INFO): Timed out from 2016-06-28T00:15:31.9Z
2016-06-28T00:20:31.924Z,1467073231.924 [Default:CheckIn:Read_GPS] Stopped
2016-06-28T00:20:31.925Z,1467073231.925 [Default:CheckIn:Read_Iridium] Running Loop=1
2016-06-28T00:20:37.179Z,1467073237.179 [DataOverHttps](INFO): Sending 45 bytes from file Logs/20160628T000120/Courier0008.lzma
2016-06-28T00:20:37.960Z,1467073237.960 [DataOverHttps](INFO): Moved sent file to Logs/20160628T000120/Courier0008.lzma.bak
2016-06-28T00:20:37.960Z,1467073237.960 [DataOverHttps](INFO): SBD MOMSN=4312897
2016-06-28T00:20:48.242Z,1467073248.242 [DataOverHttps](INFO): Sending 492 bytes from file Logs/20160628T000120/Express0009.lzma
2016-06-28T00:20:49.043Z,1467073249.043 [DataOverHttps](INFO): Moved sent file to Logs/20160628T000120/Express0009.lzma.bak
2016-06-28T00:20:49.043Z,1467073249.043 [DataOverHttps](INFO): SBD MOMSN=4312899
2016-06-28T00:20:49.653Z,1467073249.653 [Default:CheckIn:Read_Iridium] Stopped
2016-06-28T00:20:49.653Z,1467073249.653 [Default:CheckIn:C.Wait] Running Loop=1
2016-06-28T00:20:49.653Z,1467073249.653 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2016-06-28T00:21:30.488Z,1467073290.488 [CBIT](DEBUG): EFC running - data check-sum false
2016-06-28T00:21:44.384Z,1467073304.384 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2016-06-28T00:21:44.384Z,1467073304.384 [Rowe_600LCM] Communications Fault, FailCount= 2
2016-06-28T00:21:44.384Z,1467073304.384 [Rowe_600LCM](ERROR): Communications Fault
2016-06-28T00:21:44.484Z,1467073304.484 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.4 s old, using for 20.0 s.
2016-06-28T00:21:44.523Z,1467073304.523 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2016-06-28T00:21:44.803Z,1467073304.803 [Rowe_600LCM](INFO): Powering down
2016-06-28T00:21:44.868Z,1467073304.868 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.8 s old, using for 20.0 s.
2016-06-28T00:21:45.249Z,1467073305.249 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.2 s old, using for 20.0 s.
2016-06-28T00:21:45.648Z,1467073305.648 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.6 s old, using for 20.0 s.
2016-06-28T00:21:46.044Z,1467073306.044 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.0 s old, using for 20.0 s.
2016-06-28T00:21:46.057Z,1467073306.057 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2016-06-28T00:21:46.057Z,1467073306.057 [Rowe_600LCM] No Fault, FailCount= 2
2016-06-28T00:21:46.423Z,1467073306.423 [Rowe_600LCM](INFO): Initializing
2016-06-28T00:21:46.424Z,1467073306.424 [Rowe_600LCM](INFO): Checking LCM
2016-06-28T00:21:46.424Z,1467073306.424 [Rowe_600LCM](INFO): LCM OK
2016-06-28T00:21:46.424Z,1467073306.424 [Rowe_600LCM](INFO): Powering up
2016-06-28T00:21:46.452Z,1467073306.452 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.4 s old, using for 20.0 s.
2016-06-28T00:21:46.842Z,1467073306.842 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.8 s old, using for 20.0 s.
2016-06-28T00:21:47.248Z,1467073307.248 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.2 s old, using for 20.0 s.
2016-06-28T00:21:47.648Z,1467073307.648 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.6 s old, using for 20.0 s.
2016-06-28T00:21:48.051Z,1467073308.050 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.0 s old, using for 20.0 s.
2016-06-28T00:21:48.456Z,1467073308.456 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.4 s old, using for 20.0 s.
2016-06-28T00:21:48.852Z,1467073308.852 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.8 s old, using for 20.0 s.
2016-06-28T00:21:49.241Z,1467073309.241 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.2 s old, using for 20.0 s.
2016-06-28T00:21:49.638Z,1467073309.638 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.6 s old, using for 20.0 s.
2016-06-28T00:21:50.043Z,1467073310.043 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.0 s old, using for 20.0 s.
2016-06-28T00:21:50.440Z,1467073310.440 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.4 s old, using for 20.0 s.
2016-06-28T00:21:50.593Z,1467073310.593 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2016-06-28T00:21:50.654Z,1467073310.654 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:./bin/roweadcp -dev /dev/ttyB4 -b 38400 >& /dev/null &
2016-06-28T00:21:50.656Z,1467073310.656 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2016-06-28T00:21:50.657Z,1467073310.657 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2016-06-28T00:22:03.686Z,1467073323.685 [NAL9602](FAULT): GPS failed to acquire within timeout.
2016-06-28T00:22:03.686Z,1467073323.686 [NAL9602] Data Fault, FailCount= 2
2016-06-28T00:22:03.686Z,1467073323.686 [NAL9602](ERROR): Data Fault
2016-06-28T00:22:03.804Z,1467073323.804 [CBIT](ERROR): Data Fault in component: NAL9602
2016-06-28T00:22:04.089Z,1467073324.089 [NAL9602](INFO): Powering down
2016-06-28T00:22:04.954Z,1467073324.954 [CBIT](INFO): Clearing failed state for component NAL9602
2016-06-28T00:22:04.955Z,1467073324.954 [NAL9602] No Fault, FailCount= 2
2016-06-28T00:22:09.285Z,1467073329.285 [NAL9602](INFO): Powering up NAL9602
2016-06-28T00:22:20.086Z,1467073340.086 [NAL9602](INFO): NAL9602 initialized
2016-06-28T00:22:23.717Z,1467073343.717 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:24.136Z,1467073344.136 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:24.518Z,1467073344.518 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:24.920Z,1467073344.920 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:25.313Z,1467073345.313 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:25.729Z,1467073345.729 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:26.112Z,1467073346.112 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:26.502Z,1467073346.502 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:26.919Z,1467073346.919 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:27.325Z,1467073347.325 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:27.725Z,1467073347.725 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:28.107Z,1467073348.107 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:28.502Z,1467073348.501 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:28.901Z,1467073348.901 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:29.309Z,1467073349.309 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:29.709Z,1467073349.709 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:30.124Z,1467073350.124 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:30.520Z,1467073350.520 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:30.920Z,1467073350.920 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:31.317Z,1467073351.317 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:31.717Z,1467073351.717 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:32.121Z,1467073352.121 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:32.502Z,1467073352.502 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:32.916Z,1467073352.916 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:33.320Z,1467073353.320 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:33.744Z,1467073353.744 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:34.116Z,1467073354.116 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:35.707Z,1467073355.707 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:36.126Z,1467073356.126 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:36.520Z,1467073356.520 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:36.916Z,1467073356.916 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:37.319Z,1467073357.319 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:37.711Z,1467073357.711 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:38.112Z,1467073358.112 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:38.502Z,1467073358.502 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:38.920Z,1467073358.920 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:39.334Z,1467073359.334 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:39.728Z,1467073359.728 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:40.108Z,1467073360.108 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:40.502Z,1467073360.502 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:40.902Z,1467073360.902 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:41.314Z,1467073361.314 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:41.723Z,1467073361.723 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:42.144Z,1467073362.144 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:42.517Z,1467073362.517 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:42.919Z,1467073362.919 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:43.318Z,1467073363.318 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:43.723Z,1467073363.723 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:45.317Z,1467073365.316 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:45.733Z,1467073365.733 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:46.112Z,1467073366.112 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:22:46.561Z,1467073366.561 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-06-28T00:22:46.561Z,1467073366.561 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2016-06-28T00:22:46.562Z,1467073366.562 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-06-28T00:22:46.569Z,1467073366.569 [DeadReckonUsingSpeedCalculator](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-06-28T00:22:46.569Z,1467073366.569 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7
2016-06-28T00:22:46.569Z,1467073366.569 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2016-06-28T00:22:46.611Z,1467073366.611 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-06-28T00:22:46.615Z,1467073366.615 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2016-06-28T00:22:46.935Z,1467073366.935 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-06-28T00:22:46.935Z,1467073366.935 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2016-06-28T00:22:46.936Z,1467073366.936 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2016-06-28T00:22:46.936Z,1467073366.936 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7
2016-06-28T00:22:47.373Z,1467073367.373 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-06-28T00:22:47.374Z,1467073367.374 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-06-28T00:22:47.374Z,1467073367.374 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-06-28T00:22:47.375Z,1467073367.375 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2016-06-28T00:22:47.380Z,1467073367.380 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2016-06-28T00:22:47.380Z,1467073367.380 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2016-06-28T00:23:47.085Z,1467073427.085 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2016-06-28T00:23:47.085Z,1467073427.085 [Rowe_600LCM] Communications Fault, FailCount= 3
2016-06-28T00:23:47.085Z,1467073427.085 [Rowe_600LCM](ERROR): Communications Fault
2016-06-28T00:23:47.173Z,1467073427.173 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.5 s old, using for 20.0 s.
2016-06-28T00:23:47.226Z,1467073427.226 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2016-06-28T00:23:47.489Z,1467073427.489 [Rowe_600LCM](INFO): Powering down
2016-06-28T00:23:47.547Z,1467073427.547 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.8 s old, using for 20.0 s.
2016-06-28T00:23:47.927Z,1467073427.927 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.2 s old, using for 20.0 s.
2016-06-28T00:23:48.336Z,1467073428.336 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.6 s old, using for 20.0 s.
2016-06-28T00:23:48.727Z,1467073428.727 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.0 s old, using for 20.0 s.
2016-06-28T00:23:48.740Z,1467073428.740 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2016-06-28T00:23:48.740Z,1467073428.740 [Rowe_600LCM] No Fault, FailCount= 3
2016-06-28T00:23:49.103Z,1467073429.103 [Rowe_600LCM](INFO): Initializing
2016-06-28T00:23:49.104Z,1467073429.104 [Rowe_600LCM](INFO): Checking LCM
2016-06-28T00:23:49.104Z,1467073429.104 [Rowe_600LCM](INFO): LCM OK
2016-06-28T00:23:49.104Z,1467073429.104 [Rowe_600LCM](INFO): Powering up
2016-06-28T00:23:49.128Z,1467073429.128 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.4 s old, using for 20.0 s.
2016-06-28T00:23:49.513Z,1467073429.513 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.8 s old, using for 20.0 s.
2016-06-28T00:23:49.909Z,1467073429.909 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.2 s old, using for 20.0 s.
2016-06-28T00:23:50.312Z,1467073430.312 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.6 s old, using for 20.0 s.
2016-06-28T00:23:50.746Z,1467073430.746 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.0 s old, using for 20.0 s.
2016-06-28T00:23:53.291Z,1467073433.291 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2016-06-28T00:23:53.406Z,1467073433.406 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:./bin/roweadcp -dev /dev/ttyB4 -b 38400 >& /dev/null &
2016-06-28T00:23:53.407Z,1467073433.407 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2016-06-28T00:23:53.408Z,1467073433.408 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2016-06-28T00:24:46.865Z,1467073486.865 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:24:47.660Z,1467073487.660 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:24:55.754Z,1467073495.754 [BPC1](ERROR): Failed to receive battery data
2016-06-28T00:24:55.754Z,1467073495.754 [BPC1] Communications Fault, FailCount= 1
2016-06-28T00:24:55.754Z,1467073495.754 [BPC1](ERROR): Communications Fault
2016-06-28T00:24:55.810Z,1467073495.810 [CBIT](ERROR): Communications Fault in component: BPC1
2016-06-28T00:24:57.033Z,1467073497.033 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-28T00:24:57.033Z,1467073497.033 [BPC1] No Fault, FailCount= 1
2016-06-28T00:25:44.945Z,1467073544.945 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:25:45.337Z,1467073545.337 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:25:45.748Z,1467073545.748 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:25:46.166Z,1467073546.166 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:25:46.560Z,1467073546.560 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:25:46.947Z,1467073546.947 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:25:47.333Z,1467073547.333 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:25:47.738Z,1467073547.738 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:25:47.753Z,1467073547.753 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-06-28T00:25:47.753Z,1467073547.753 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2016-06-28T00:25:47.754Z,1467073547.754 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-06-28T00:25:47.756Z,1467073547.756 [DeadReckonUsingSpeedCalculator](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-06-28T00:25:47.756Z,1467073547.756 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 8
2016-06-28T00:25:47.756Z,1467073547.756 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2016-06-28T00:25:47.797Z,1467073547.797 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-06-28T00:25:47.798Z,1467073547.798 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2016-06-28T00:25:48.142Z,1467073548.142 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:25:48.180Z,1467073548.180 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-06-28T00:25:48.181Z,1467073548.181 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2016-06-28T00:25:48.181Z,1467073548.181 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2016-06-28T00:25:48.181Z,1467073548.181 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 8
2016-06-28T00:25:48.574Z,1467073548.574 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:25:48.596Z,1467073548.596 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-06-28T00:25:48.597Z,1467073548.597 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-06-28T00:25:48.598Z,1467073548.598 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-06-28T00:25:48.599Z,1467073548.599 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2016-06-28T00:25:48.599Z,1467073548.599 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2016-06-28T00:25:48.600Z,1467073548.600 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2016-06-28T00:25:48.723Z,1467073548.723 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:25:48.968Z,1467073548.968 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:25:49.128Z,1467073549.128 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:25:49.132Z,1467073549.132 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2016-06-28T00:25:49.132Z,1467073549.132 [Rowe_600LCM] Communications Fault, FailCount= 4
2016-06-28T00:25:49.132Z,1467073549.132 [Rowe_600LCM](ERROR): Communications Fault
2016-06-28T00:25:49.356Z,1467073549.356 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:25:49.387Z,1467073549.387 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.4 s old, using for 20.0 s.
2016-06-28T00:25:49.429Z,1467073549.429 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2016-06-28T00:25:49.535Z,1467073549.535 [Rowe_600LCM](INFO): Powering down
2016-06-28T00:25:49.740Z,1467073549.740 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:25:49.764Z,1467073549.764 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.8 s old, using for 20.0 s.
2016-06-28T00:25:50.141Z,1467073550.141 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:25:50.161Z,1467073550.161 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.2 s old, using for 20.0 s.
2016-06-28T00:25:50.164Z,1467073550.164 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2016-06-28T00:25:50.164Z,1467073550.164 [Default:CheckIn:C.Wait] Stopped
2016-06-28T00:25:50.164Z,1467073550.164 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2016-06-28T00:25:50.164Z,1467073550.164 [Default:CheckIn:D] Running Loop=1
2016-06-28T00:25:50.343Z,1467073550.343 [Rowe_600LCM](FAULT): LCB fault:  Software Overcurrent.
2016-06-28T00:25:50.344Z,1467073550.344 [Rowe_600LCM] Hardware Fault, FailCount= 4
2016-06-28T00:25:50.344Z,1467073550.344 [Rowe_600LCM](ERROR): Hardware Fault
2016-06-28T00:25:50.552Z,1467073550.552 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:25:50.566Z,1467073550.566 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.6 s old, using for 20.0 s.
2016-06-28T00:25:50.570Z,1467073550.570 [Default:CheckIn:D] Stopped
2016-06-28T00:25:50.570Z,1467073550.570 [Default:CheckIn:E] Running Loop=1
2016-06-28T00:25:50.971Z,1467073550.971 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.0 s old, using for 20.0 s.
2016-06-28T00:25:50.974Z,1467073550.974 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 20.968781 min 
2016-06-28T00:25:50.975Z,1467073550.975 [Default:CheckIn:E] Stopped
2016-06-28T00:25:50.975Z,1467073550.975 [Default:CheckIn](INFO): Completed Default:CheckIn
2016-06-28T00:25:50.975Z,1467073550.975 [Default:CheckIn] Stopped
2016-06-28T00:25:50.975Z,1467073550.975 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2016-06-28T00:25:50.975Z,1467073550.975 [Default:CheckIn](INFO): Running loop #3
2016-06-28T00:25:50.975Z,1467073550.975 [Default:CheckIn] Running Loop=3
2016-06-28T00:25:50.976Z,1467073550.976 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2016-06-28T00:25:50.976Z,1467073550.976 [Default:CheckIn:Read_GPS] Running Loop=1
2016-06-28T00:25:50.986Z,1467073550.986 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2016-06-28T00:25:50.986Z,1467073550.986 [Rowe_600LCM] No Fault, FailCount= 4
2016-06-28T00:25:51.151Z,1467073551.151 [Rowe_600LCM](INFO): Initializing
2016-06-28T00:25:51.152Z,1467073551.152 [Rowe_600LCM](INFO): Checking LCM
2016-06-28T00:25:51.152Z,1467073551.152 [Rowe_600LCM](INFO): LCM OK
2016-06-28T00:25:51.152Z,1467073551.152 [Rowe_600LCM](INFO): Powering up
2016-06-28T00:25:54.217Z,1467073554.217 [BPC1](ERROR): Failed to parse bank A battery data
2016-06-28T00:25:54.217Z,1467073554.217 [BPC1] Data Fault, FailCount= 1
2016-06-28T00:25:54.217Z,1467073554.217 [BPC1](ERROR): Data Fault
2016-06-28T00:25:54.224Z,1467073554.224 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.2 s old, using for 20.0 s.
2016-06-28T00:25:54.238Z,1467073554.238 [CBIT](ERROR): Data Fault in component: BPC1
2016-06-28T00:25:54.359Z,1467073554.359 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.4 s old, using for 20.0 s.
2016-06-28T00:25:54.713Z,1467073554.713 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.7 s old, using for 20.0 s.
2016-06-28T00:25:55.085Z,1467073555.085 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T00:25:55.115Z,1467073555.115 [DeadReckonUsingM