2016-06-28T17:02:16.897Z,1467133336.897 [Supervisor](DEBUG): Initializing supervisor.
2016-06-28T17:02:16.900Z,1467133336.900 [SyncHandler](DEBUG): Created PCaller Thread at 4051A4E0
2016-06-28T17:02:16.901Z,1467133336.901 [SyncHandler](INFO): Protected caller Thread ID is 922
2016-06-28T17:02:16.901Z,1467133336.901 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2016-06-28T17:02:16.902Z,1467133336.902 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4054A4E0
2016-06-28T17:02:16.903Z,1467133336.903 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 923
2016-06-28T17:02:16.905Z,1467133336.905 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2016-06-28T17:02:16.917Z,1467133336.917 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2016-06-28T17:02:16.918Z,1467133336.918 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 4057A4E0
2016-06-28T17:02:16.918Z,1467133336.918 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 924
2016-06-28T17:02:16.919Z,1467133336.919 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2016-06-28T17:02:16.920Z,1467133336.920 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405AA4E0
2016-06-28T17:02:16.920Z,1467133336.920 [logger ThreadHandler](INFO): Protected caller Thread ID is 925
2016-06-28T17:02:16.922Z,1467133336.922 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2016-06-28T17:02:16.923Z,1467133336.923 [Supervisor](INFO): Looking for Config files in directory: Config/
2016-06-28T17:02:16.924Z,1467133336.924 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2016-06-28T17:02:17.009Z,1467133337.009 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2016-06-28T17:02:17.317Z,1467133337.317 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2016-06-28T17:02:17.318Z,1467133337.318 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2016-06-28T17:02:17.439Z,1467133337.439 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2016-06-28T17:02:17.439Z,1467133337.439 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2016-06-28T17:02:17.621Z,1467133337.621 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2016-06-28T17:02:17.622Z,1467133337.622 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2016-06-28T17:02:17.721Z,1467133337.721 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2016-06-28T17:02:17.722Z,1467133337.722 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2016-06-28T17:02:17.893Z,1467133337.893 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2016-06-28T17:02:17.893Z,1467133337.894 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2016-06-28T17:02:18.342Z,1467133338.342 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2016-06-28T17:02:18.343Z,1467133338.343 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2016-06-28T17:02:18.612Z,1467133338.612 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2016-06-28T17:02:18.613Z,1467133338.613 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2016-06-28T17:02:18.698Z,1467133338.698 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2016-06-28T17:02:18.698Z,1467133338.698 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2016-06-28T17:02:18.827Z,1467133338.827 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2016-06-28T17:02:18.827Z,1467133338.827 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2016-06-28T17:02:19.014Z,1467133339.014 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2016-06-28T17:02:19.014Z,1467133339.014 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2016-06-28T17:02:19.421Z,1467133339.421 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2016-06-28T17:02:19.421Z,1467133339.421 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2016-06-28T17:02:19.764Z,1467133339.764 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2016-06-28T17:02:19.765Z,1467133339.764 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2016-06-28T17:02:20.058Z,1467133340.058 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2016-06-28T17:02:20.058Z,1467133340.058 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2016-06-28T17:02:20.167Z,1467133340.167 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2016-06-28T17:02:20.169Z,1467133340.169 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/
2016-06-28T17:02:20.169Z,1467133340.170 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Control.cfg
2016-06-28T17:02:20.267Z,1467133340.267 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Navigation.cfg
2016-06-28T17:02:20.361Z,1467133340.361 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/secure.cfg
2016-06-28T17:02:20.448Z,1467133340.448 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/BIT.cfg
2016-06-28T17:02:20.548Z,1467133340.547 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Simulator.cfg
2016-06-28T17:02:20.636Z,1467133340.636 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Science.cfg
2016-06-28T17:02:20.776Z,1467133340.776 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/logger.cfg
2016-06-28T17:02:20.874Z,1467133340.874 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/vehicle.cfg
2016-06-28T17:02:21.043Z,1467133341.043 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Battery.cfg
2016-06-28T17:02:21.276Z,1467133341.276 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2016-06-28T17:02:21.277Z,1467133341.277 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Sensor.cfg
2016-06-28T17:02:21.448Z,1467133341.448 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Servo.cfg
2016-06-28T17:02:21.552Z,1467133341.552 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2016-06-28T17:02:21.553Z,1467133341.553 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2016-06-28T17:02:21.579Z,1467133341.579 [DepthRateCalculator] Loaded
2016-06-28T17:02:21.579Z,1467133341.579 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2016-06-28T17:02:21.585Z,1467133341.585 [PitchRateCalculator] Loaded
2016-06-28T17:02:21.586Z,1467133341.586 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2016-06-28T17:02:21.597Z,1467133341.597 [SpeedCalculator] Loaded
2016-06-28T17:02:21.598Z,1467133341.598 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2016-06-28T17:02:21.614Z,1467133341.614 [TempGradientCalculator] Loaded
2016-06-28T17:02:21.614Z,1467133341.614 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2016-06-28T17:02:21.631Z,1467133341.631 [VerticalTemperatureHomogeneityIndexCalculator] Loaded
2016-06-28T17:02:21.631Z,1467133341.631 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread.
2016-06-28T17:02:21.637Z,1467133341.637 [YawRateCalculator] Loaded
2016-06-28T17:02:21.637Z,1467133341.637 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2016-06-28T17:02:21.637Z,1467133341.638 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2016-06-28T17:02:21.638Z,1467133341.638 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2016-06-28T17:02:21.740Z,1467133341.740 [DeadReckonUsingMultipleVelocitySources] Loaded
2016-06-28T17:02:21.741Z,1467133341.741 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2016-06-28T17:02:21.797Z,1467133341.797 [DeadReckonUsingSpeedCalculator] Loaded
2016-06-28T17:02:21.797Z,1467133341.797 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2016-06-28T17:02:21.814Z,1467133341.814 [NavChart] Loaded
2016-06-28T17:02:21.815Z,1467133341.815 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2016-06-28T17:02:21.819Z,1467133341.819 [UniversalFixResidualReporter] Loaded
2016-06-28T17:02:21.819Z,1467133341.819 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2016-06-28T17:02:21.820Z,1467133341.820 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2016-06-28T17:02:21.820Z,1467133341.820 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2016-06-28T17:02:21.937Z,1467133341.937 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2016-06-28T17:02:21.938Z,1467133341.938 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2016-06-28T17:02:21.962Z,1467133341.963 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2016-06-28T17:02:21.963Z,1467133341.963 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2016-06-28T17:02:21.970Z,1467133341.970 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2016-06-28T17:02:21.970Z,1467133341.970 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2016-06-28T17:02:22.206Z,1467133342.206 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2016-06-28T17:02:22.207Z,1467133342.207 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2016-06-28T17:02:22.328Z,1467133342.328 [SBIT](DEBUG): Construct Startup Built In Test.
2016-06-28T17:02:22.360Z,1467133342.360 [SBIT] Loaded
2016-06-28T17:02:22.361Z,1467133342.361 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2016-06-28T17:02:22.361Z,1467133342.361 [IBIT](DEBUG): Construct Initiated Built In Test.
2016-06-28T17:02:22.390Z,1467133342.390 [IBIT] Loaded
2016-06-28T17:02:22.390Z,1467133342.390 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2016-06-28T17:02:22.394Z,1467133342.394 [CBIT](DEBUG): Construct Continuous Built In Test.
2016-06-28T17:02:22.551Z,1467133342.551 [CBIT] Loaded
2016-06-28T17:02:22.551Z,1467133342.551 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2016-06-28T17:02:22.552Z,1467133342.552 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2016-06-28T17:02:22.552Z,1467133342.552 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2016-06-28T17:02:22.849Z,1467133342.849 [DataOverHttps] Loaded
2016-06-28T17:02:22.849Z,1467133342.849 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2016-06-28T17:02:22.875Z,1467133342.875 [Depth_Keller] Loaded
2016-06-28T17:02:22.875Z,1467133342.875 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2016-06-28T17:02:22.968Z,1467133342.968 [NAL9602] Loaded
2016-06-28T17:02:22.968Z,1467133342.968 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2016-06-28T17:02:22.979Z,1467133342.979 [Onboard] Loaded
2016-06-28T17:02:22.979Z,1467133342.979 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2016-06-28T17:02:22.986Z,1467133342.986 [Radio_Surface] Loaded
2016-06-28T17:02:22.987Z,1467133342.987 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2016-06-28T17:02:22.988Z,1467133342.988 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409234E0
2016-06-28T17:02:22.988Z,1467133342.988 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1004
2016-06-28T17:02:23.038Z,1467133343.038 [PNI_TCM] Loaded
2016-06-28T17:02:23.038Z,1467133343.038 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread.
2016-06-28T17:02:23.109Z,1467133343.109 [Rowe_600LCM] Loaded
2016-06-28T17:02:23.110Z,1467133343.110 [ComponentRegistry](DEBUG): Component "Rowe_600LCM" handled in its own thread.
2016-06-28T17:02:23.111Z,1467133343.111 [Rowe_600LCM ThreadHandler](DEBUG): Created PCaller Thread at 409534E0
2016-06-28T17:02:23.111Z,1467133343.111 [Rowe_600LCM ThreadHandler](INFO): Protected caller Thread ID is 1005
2016-06-28T17:02:25.050Z,1467133345.050 [BPC1] Loaded
2016-06-28T17:02:25.050Z,1467133345.050 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2016-06-28T17:02:25.051Z,1467133345.051 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2016-06-28T17:02:25.052Z,1467133345.052 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2016-06-28T17:02:25.157Z,1467133345.157 [BuoyancyServo] Loaded
2016-06-28T17:02:25.157Z,1467133345.157 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2016-06-28T17:02:25.174Z,1467133345.174 [ElevatorServo] Loaded
2016-06-28T17:02:25.175Z,1467133345.175 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2016-06-28T17:02:25.191Z,1467133345.191 [MassServo] Loaded
2016-06-28T17:02:25.191Z,1467133345.191 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2016-06-28T17:02:25.208Z,1467133345.208 [RudderServo] Loaded
2016-06-28T17:02:25.208Z,1467133345.208 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2016-06-28T17:02:25.224Z,1467133345.224 [ThrusterServo] Loaded
2016-06-28T17:02:25.224Z,1467133345.224 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2016-06-28T17:02:25.225Z,1467133345.225 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2016-06-28T17:02:25.225Z,1467133345.225 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2016-06-28T17:02:25.275Z,1467133345.275 [VerticalControl](DEBUG): Construct VerticalControl.
2016-06-28T17:02:25.376Z,1467133345.376 [VerticalControl] Loaded
2016-06-28T17:02:25.376Z,1467133345.376 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2016-06-28T17:02:25.377Z,1467133345.377 [HorizontalControl](DEBUG): Construct HorizontalControl.
2016-06-28T17:02:25.438Z,1467133345.438 [HorizontalControl] Loaded
2016-06-28T17:02:25.438Z,1467133345.438 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2016-06-28T17:02:25.439Z,1467133345.439 [SpeedControl](DEBUG): Construct SpeedControl.
2016-06-28T17:02:25.441Z,1467133345.441 [SpeedControl] Loaded
2016-06-28T17:02:25.441Z,1467133345.441 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2016-06-28T17:02:25.442Z,1467133345.442 [LoopControl](DEBUG): Construct LoopControl.
2016-06-28T17:02:25.442Z,1467133345.442 [LoopControl] Loaded
2016-06-28T17:02:25.442Z,1467133345.442 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2016-06-28T17:02:25.443Z,1467133345.443 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2016-06-28T17:02:25.443Z,1467133345.443 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2016-06-28T17:02:25.521Z,1467133345.521 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC
2016-06-28T17:02:25.521Z,1467133345.521 [StratificationFrontDetector](DEBUG): (re)initializing
2016-06-28T17:02:25.522Z,1467133345.522 [StratificationFrontDetector] Loaded
2016-06-28T17:02:25.522Z,1467133345.522 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread.
2016-06-28T17:02:25.522Z,1467133345.522 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2016-06-28T17:02:25.523Z,1467133345.523 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2016-06-28T17:02:25.623Z,1467133345.623 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2016-06-28T17:02:25.627Z,1467133345.627 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2016-06-28T17:02:25.628Z,1467133345.628 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2016-06-28T17:02:25.635Z,1467133345.635 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2016-06-28T17:02:25.636Z,1467133345.636 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A5D4E0
2016-06-28T17:02:25.636Z,1467133345.636 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1006
2016-06-28T17:02:25.641Z,1467133345.641 [Supervisor](INFO): Main Thread ID is 764
2016-06-28T17:02:25.641Z,1467133345.641 [Supervisor](DEBUG): Running supervisor.
2016-06-28T17:02:25.642Z,1467133345.642 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1007
2016-06-28T17:02:25.645Z,1467133345.645 [controlThread ThreadHandler](INFO): Handler Thread ID is 1008
2016-06-28T17:02:25.645Z,1467133345.645 [controlThread](DEBUG): Initializing ControlThread
2016-06-28T17:02:25.646Z,1467133345.646 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2016-06-28T17:02:25.647Z,1467133345.647 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2016-06-28T17:02:25.647Z,1467133345.647 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2016-06-28T17:02:25.647Z,1467133345.647 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2016-06-28T17:02:25.648Z,1467133345.648 [VerticalTemperatureHomogeneityIndexCalculator](DEBUG): (re)initializing
2016-06-28T17:02:25.649Z,1467133345.649 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2016-06-28T17:02:25.649Z,1467133345.649 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-06-28T17:02:25.650Z,1467133345.650 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-06-28T17:02:25.650Z,1467133345.650 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-06-28T17:02:25.651Z,1467133345.651 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2016-06-28T17:02:25.651Z,1467133345.651 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2016-06-28T17:02:25.652Z,1467133345.652 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2016-06-28T17:02:25.652Z,1467133345.652 [NavChart](DEBUG): Initialize NavChart Navigation.
2016-06-28T17:02:25.653Z,1467133345.653 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2016-06-28T17:02:25.653Z,1467133345.653 [SBIT](INFO): Initialize SBIT Component.
2016-06-28T17:02:25.654Z,1467133345.654 [SBIT](IMPORTANT): git: 2015-12-17-108-g5bef090
2016-06-28T17:02:25.654Z,1467133345.654 [SBIT](INFO): git hash: 5bef0906e748577e5d4ac431bf22a986aa172b48
2016-06-28T17:02:25.655Z,1467133345.655 [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-28T17:02:25.656Z,1467133345.656 [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-28T17:02:25.657Z,1467133345.657 [SBIT](INFO): Beginning SBIT in 20.000000 seconds.
2016-06-28T17:02:25.657Z,1467133345.657 [IBIT](INFO): Initialize IBIT Component.
2016-06-28T17:02:25.658Z,1467133345.658 [CBIT](DEBUG): Initialize CBIT Component.
2016-06-28T17:02:25.659Z,1467133345.658 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2016-06-28T17:02:25.659Z,1467133345.659 [logger ThreadHandler](INFO): Handler Thread ID is 1009
2016-06-28T17:02:25.676Z,1467133345.676 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1010
2016-06-28T17:02:25.683Z,1467133345.683 [Radio_Surface](INFO): Powering up
2016-06-28T17:02:25.688Z,1467133345.688 [Rowe_600LCM ThreadHandler](INFO): Handler Thread ID is 1011
2016-06-28T17:02:25.688Z,1467133345.688 [Rowe_600LCM](INFO): Initializing
2016-06-28T17:02:25.689Z,1467133345.689 [Rowe_600LCM](INFO): Checking LCM
2016-06-28T17:02:25.689Z,1467133345.689 [Rowe_600LCM](INFO): LCM OK
2016-06-28T17:02:25.689Z,1467133345.690 [Rowe_600LCM](INFO): Powering up
2016-06-28T17:02:25.700Z,1467133345.700 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1012
2016-06-28T17:02:25.704Z,1467133345.704 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources/ElectronicNavigationCharts
2016-06-28T17:02:25.705Z,1467133345.705 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2016-06-28T17:02:25.705Z,1467133345.705 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2MI01M.000
2016-06-28T17:02:25.706Z,1467133345.706 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2MI80M.000
2016-06-28T17:02:25.706Z,1467133345.706 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2016-06-28T17:02:25.706Z,1467133345.706 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2016-06-28T17:02:25.706Z,1467133345.706 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2016-06-28T17:02:25.706Z,1467133345.707 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4IN01M.000
2016-06-28T17:02:25.707Z,1467133345.707 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI56M.000
2016-06-28T17:02:25.707Z,1467133345.707 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI57M.000
2016-06-28T17:02:25.707Z,1467133345.707 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI59M.000
2016-06-28T17:02:25.708Z,1467133345.708 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI89M.000
2016-06-28T17:02:25.708Z,1467133345.708 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI90M.000
2016-06-28T17:02:25.708Z,1467133345.708 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4WI03M.000
2016-06-28T17:02:25.708Z,1467133345.708 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4WI06M.000
2016-06-28T17:02:25.709Z,1467133345.708 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4WI33M.000
2016-06-28T17:02:25.709Z,1467133345.709 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4WI34M.000
2016-06-28T17:02:25.709Z,1467133345.709 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2016-06-28T17:02:25.709Z,1467133345.709 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2016-06-28T17:02:25.710Z,1467133345.710 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2016-06-28T17:02:25.710Z,1467133345.710 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2016-06-28T17:02:25.750Z,1467133345.750 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2016-06-28T17:02:25.752Z,1467133345.752 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2016-06-28T17:02:25.753Z,1467133345.753 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2016-06-28T17:02:25.753Z,1467133345.753 [LoopControl](DEBUG): Initialize LoopControlComponent.
2016-06-28T17:02:25.754Z,1467133345.754 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2016-06-28T17:02:25.789Z,1467133345.789 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2016-06-28T17:02:25.811Z,1467133345.811 [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-28T17:02:25.831Z,1467133345.832 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2016-06-28T17:02:25.894Z,1467133345.894 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2016-06-28T17:02:25.895Z,1467133345.895 [Default:A.Wait](DEBUG): Construct Wait.
2016-06-28T17:02:25.897Z,1467133345.897 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2016-06-28T17:02:25.935Z,1467133345.935 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2016-06-28T17:02:25.937Z,1467133345.937 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2016-06-28T17:02:25.959Z,1467133345.959 [Default:E.Execute](DEBUG): Construct Execute.
2016-06-28T17:02:25.963Z,1467133345.963 [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-28T17:02:25.976Z,1467133345.976 [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-28T17:02:26.000Z,1467133346.000 [Depth_Keller](ERROR): Pressure reading out of range: 1895.584351 decibar
2016-06-28T17:02:26.208Z,1467133346.208 [DepthRateCalculator](ERROR): Depth measurement is not active
2016-06-28T17:02:26.296Z,1467133346.296 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-06-28T17:02:26.320Z,1467133346.320 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-06-28T17:02:26.416Z,1467133346.416 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2016-06-28T17:02:26.416Z,1467133346.416 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2016-06-28T17:02:26.426Z,1467133346.426 [ElevatorServo](DEBUG): Initializing EZServoServo.
2016-06-28T17:02:26.427Z,1467133346.427 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2016-06-28T17:02:26.445Z,1467133346.445 [MassServo](DEBUG): Initializing EZServoServo.
2016-06-28T17:02:26.445Z,1467133346.445 [MassServo](DEBUG): Initializing MassServo.
2016-06-28T17:02:26.451Z,1467133346.451 [RudderServo](DEBUG): Initializing EZServoServo.
2016-06-28T17:02:26.451Z,1467133346.451 [RudderServo](DEBUG): Initializing RudderServo.
2016-06-28T17:02:26.480Z,1467133346.480 [ThrusterServo](DEBUG): Initializing EZServoServo.
2016-06-28T17:02:26.480Z,1467133346.480 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2016-06-28T17:02:26.758Z,1467133346.758 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-06-28T17:02:26.759Z,1467133346.759 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-06-28T17:02:27.027Z,1467133347.027 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-06-28T17:02:27.029Z,1467133347.029 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-06-28T17:02:27.437Z,1467133347.437 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-06-28T17:02:27.438Z,1467133347.438 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-06-28T17:02:27.892Z,1467133347.892 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-06-28T17:02:27.893Z,1467133347.893 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-06-28T17:02:28.217Z,1467133348.217 [NAL9602](INFO): Powering up NAL9602
2016-06-28T17:02:28.239Z,1467133348.239 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-06-28T17:02:28.240Z,1467133348.240 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-06-28T17:02:28.639Z,1467133348.639 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-06-28T17:02:28.640Z,1467133348.640 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-06-28T17:02:29.055Z,1467133349.055 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-06-28T17:02:29.068Z,1467133349.068 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-06-28T17:02:29.451Z,1467133349.451 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-06-28T17:02:29.460Z,1467133349.460 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-06-28T17:02:30.075Z,1467133350.075 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2016-06-28T17:02:30.203Z,1467133350.203 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:./bin/roweadcp -dev /dev/ttyB4 -b 38400 >& /dev/null &
2016-06-28T17:02:30.326Z,1467133350.326 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2016-06-28T17:02:30.339Z,1467133350.339 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2016-06-28T17:02:39.450Z,1467133359.450 [NAL9602](INFO): NAL9602 initialized
2016-06-28T17:02:39.548Z,1467133359.547 [PNI_TCM](ERROR): CRC does not match. Expected:0x8390 got:0x62221
2016-06-28T17:02:40.268Z,1467133360.267 [PNI_TCM](ERROR): CRC does not match. Expected:0x50271 got:0x62195
2016-06-28T17:02:40.268Z,1467133360.268 [PNI_TCM](ERROR): CRC does not match. Expected:0x20536 got:0x62175
2016-06-28T17:02:40.775Z,1467133360.775 [PNI_TCM](ERROR): CRC does not match. Expected:0x51216 got:0x62221
2016-06-28T17:02:41.206Z,1467133361.207 [PNI_TCM](ERROR): CRC does not match. Expected:0x54702 got:0x6464
2016-06-28T17:02:41.560Z,1467133361.560 [PNI_TCM](ERROR): CRC does not match. Expected:0x45834 got:0x6464
2016-06-28T17:02:42.242Z,1467133362.242 [PNI_TCM](ERROR): CRC does not match. Expected:0x63498 got:0x6464
2016-06-28T17:02:42.779Z,1467133362.779 [PNI_TCM](ERROR): CRC does not match. Expected:0x61209 got:0x6464
2016-06-28T17:02:42.793Z,1467133362.793 [PNI_TCM](ERROR): CRC does not match. Expected:0x57696 got:0x6464
2016-06-28T17:02:43.238Z,1467133363.238 [PNI_TCM](ERROR): CRC does not match. Expected:0x19082 got:0x6464
2016-06-28T17:02:43.566Z,1467133363.566 [PNI_TCM](ERROR): CRC does not match. Expected:0x63192 got:0x6464
2016-06-28T17:02:43.889Z,1467133363.889 [PNI_TCM](ERROR): CRC does not match. Expected:0x259 got:0x6464
2016-06-28T17:02:44.290Z,1467133364.290 [PNI_TCM](ERROR): CRC does not match. Expected:0x23863 got:0x6464
2016-06-28T17:02:44.290Z,1467133364.290 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-28T17:02:44.290Z,1467133364.290 [PNI_TCM] Data Fault, FailCount= 1
2016-06-28T17:02:44.291Z,1467133364.291 [PNI_TCM](ERROR): Data Fault
2016-06-28T17:02:44.316Z,1467133364.316 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.395000 seconds old.
2016-06-28T17:02:44.317Z,1467133364.317 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.395400 seconds old.
2016-06-28T17:02:44.343Z,1467133364.343 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-28T17:02:44.703Z,1467133364.703 [PNI_TCM](INFO): Powering down
2016-06-28T17:02:44.790Z,1467133364.790 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.869100 seconds old.
2016-06-28T17:02:44.803Z,1467133364.803 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.880900 seconds old.
2016-06-28T17:02:45.154Z,1467133365.155 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.233200 seconds old.
2016-06-28T17:02:45.167Z,1467133365.167 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.244700 seconds old.
2016-06-28T17:02:45.531Z,1467133365.531 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.610000 seconds old.
2016-06-28T17:02:45.541Z,1467133365.541 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.618800 seconds old.
2016-06-28T17:02:45.884Z,1467133365.884 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.963200 seconds old.
2016-06-28T17:02:45.885Z,1467133365.885 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.963600 seconds old.
2016-06-28T17:02:45.913Z,1467133365.913 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-28T17:02:45.914Z,1467133365.914 [PNI_TCM] No Fault, FailCount= 1
2016-06-28T17:02:46.285Z,1467133366.285 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.363500 seconds old.
2016-06-28T17:02:46.288Z,1467133366.288 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.366300 seconds old.
2016-06-28T17:02:46.314Z,1467133366.314 [SBIT](IMPORTANT): Beginning Startup BIT
2016-06-28T17:02:46.334Z,1467133366.334 [CBIT](IMPORTANT): Beginning GF scan
2016-06-28T17:02:46.758Z,1467133366.758 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.837000 seconds old.
2016-06-28T17:02:46.770Z,1467133366.770 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.847700 seconds old.
2016-06-28T17:02:47.022Z,1467133367.022 [CBIT](IMPORTANT): Open Volts:2.500954
Open Current:0.000542
2016-06-28T17:02:47.176Z,1467133367.176 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.245900 seconds old.
2016-06-28T17:02:47.188Z,1467133367.188 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.257600 seconds old.
2016-06-28T17:02:47.537Z,1467133367.537 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.615700 seconds old.
2016-06-28T17:02:47.549Z,1467133367.549 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.626600 seconds old.
2016-06-28T17:02:47.886Z,1467133367.885 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.964700 seconds old.
2016-06-28T17:02:47.887Z,1467133367.887 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.965100 seconds old.
2016-06-28T17:02:48.232Z,1467133368.232 [CBIT](IMPORTANT): A0 Volts:2.669642
A0 Current:0.107629
2016-06-28T17:02:48.327Z,1467133368.327 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.406200 seconds old.
2016-06-28T17:02:48.337Z,1467133368.337 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.415000 seconds old.
2016-06-28T17:02:48.852Z,1467133368.852 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.931300 seconds old.
2016-06-28T17:02:48.853Z,1467133368.853 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.931700 seconds old.
2016-06-28T17:02:49.721Z,1467133369.721 [CBIT](IMPORTANT): A1 Volts:2.029676
A1 Current:-0.299555
2016-06-28T17:02:51.225Z,1467133371.225 [CBIT](IMPORTANT): A2 Volts:2.669454
A2 Current:0.107443
2016-06-28T17:02:52.985Z,1467133372.985 [CBIT](IMPORTANT): A3 Volts:2.618320
A3 Current:0.075699
2016-06-28T17:02:53.163Z,1467133373.163 [PNI_TCM](ERROR): CRC does not match. Expected:0x38735 got:0x62378
2016-06-28T17:02:53.576Z,1467133373.576 [PNI_TCM](ERROR): CRC does not match. Expected:0x9741 got:0x62362
2016-06-28T17:02:53.913Z,1467133373.912 [PNI_TCM](ERROR): CRC does not match. Expected:0x15007 got:0x62361
2016-06-28T17:02:54.212Z,1467133374.212 [CBIT](IMPORTANT): B0 Volts:2.389436
B0 Current:-0.069893
2016-06-28T17:02:54.313Z,1467133374.313 [PNI_TCM](ERROR): CRC does not match. Expected:0x6482 got:0x62418
2016-06-28T17:02:54.806Z,1467133374.806 [PNI_TCM](ERROR): CRC does not match. Expected:0x4448 got:0x62370
2016-06-28T17:02:55.245Z,1467133375.245 [PNI_TCM](ERROR): CRC does not match. Expected:0x9162 got:0x62347
2016-06-28T17:02:55.640Z,1467133375.640 [CBIT](IMPORTANT): B1 Volts:2.285151
B1 Current:-0.136409
2016-06-28T17:02:55.692Z,1467133375.692 [PNI_TCM](ERROR): CRC does not match. Expected:0x57269 got:0x62365
2016-06-28T17:02:56.077Z,1467133376.077 [PNI_TCM](ERROR): CRC does not match. Expected:0x37793 got:0x62340
2016-06-28T17:02:56.567Z,1467133376.566 [PNI_TCM](ERROR): CRC does not match. Expected:0x29516 got:0x62343
2016-06-28T17:02:56.573Z,1467133376.573 [PNI_TCM](ERROR): CRC does not match. Expected:0x30451 got:0x6464
2016-06-28T17:02:56.989Z,1467133376.989 [CBIT](IMPORTANT): B2 Volts:2.282398
B2 Current:-0.138134
2016-06-28T17:02:57.208Z,1467133377.208 [PNI_TCM](ERROR): CRC does not match. Expected:0x25094 got:0x6464
2016-06-28T17:02:57.568Z,1467133377.568 [PNI_TCM](ERROR): CRC does not match. Expected:0x50244 got:0x6464
2016-06-28T17:02:57.896Z,1467133377.897 [PNI_TCM](ERROR): CRC does not match. Expected:0x27735 got:0x6464
2016-06-28T17:02:57.897Z,1467133377.897 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-28T17:02:57.897Z,1467133377.897 [PNI_TCM] Data Fault, FailCount= 1
2016-06-28T17:02:57.897Z,1467133377.897 [PNI_TCM](ERROR): Data Fault
2016-06-28T17:02:57.904Z,1467133377.904 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.318200 seconds old.
2016-06-28T17:02:57.920Z,1467133377.920 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.333600 seconds old.
2016-06-28T17:02:57.947Z,1467133377.947 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-28T17:02:58.302Z,1467133378.302 [PNI_TCM](INFO): Powering down
2016-06-28T17:02:58.324Z,1467133378.324 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.738500 seconds old.
2016-06-28T17:02:58.325Z,1467133378.325 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.738900 seconds old.
2016-06-28T17:02:58.561Z,1467133378.561 [CBIT](IMPORTANT): B3 Volts:1.776848
B3 Current:-0.459022
2016-06-28T17:02:58.740Z,1467133378.740 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.154900 seconds old.
2016-06-28T17:02:58.744Z,1467133378.744 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.157100 seconds old.
2016-06-28T17:02:58.857Z,1467133378.856 [CBIT](FAULT): Low side GF detected
mA:
CHAN A0 (Batt): 0.107629
CHAN A1 (24V): -0.299555
CHAN A2 (12V): 0.107443
CHAN A3 (5V): 0.075699
CHAN B0 (3.3V): -0.069893
CHAN B1 (3.15aV): -0.136409
CHAN B2 (3.15bV): -0.138134
CHAN B3 (GND): -0.459022
OPEN: 0.000542
Full Scale Calc: 4.765 mA, -1.589 mA
2016-06-28T17:02:59.151Z,1467133379.151 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.564600 seconds old.
2016-06-28T17:02:59.161Z,1467133379.161 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.574300 seconds old.
2016-06-28T17:02:59.565Z,1467133379.565 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.978600 seconds old.
2016-06-28T17:02:59.576Z,1467133379.576 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.989900 seconds old.
2016-06-28T17:02:59.605Z,1467133379.605 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-28T17:02:59.605Z,1467133379.605 [PNI_TCM] No Fault, FailCount= 1
2016-06-28T17:02:59.903Z,1467133379.903 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.318100 seconds old.
2016-06-28T17:02:59.905Z,1467133379.905 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.318500 seconds old.
2016-06-28T17:03:00.296Z,1467133380.296 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.710200 seconds old.
2016-06-28T17:03:00.297Z,1467133380.297 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.710600 seconds old.
2016-06-28T17:03:00.727Z,1467133380.727 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.141400 seconds old.
2016-06-28T17:03:00.728Z,1467133380.728 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.141900 seconds old.
2016-06-28T17:03:01.145Z,1467133381.145 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.559000 seconds old.
2016-06-28T17:03:01.148Z,1467133381.148 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.561500 seconds old.
2016-06-28T17:03:01.540Z,1467133381.540 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.954400 seconds old.
2016-06-28T17:03:01.553Z,1467133381.553 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.966200 seconds old.
2016-06-28T17:03:02.184Z,1467133382.184 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.598700 seconds old.
2016-06-28T17:03:02.185Z,1467133382.185 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.599100 seconds old.
2016-06-28T17:03:02.600Z,1467133382.601 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.014800 seconds old.
2016-06-28T17:03:02.615Z,1467133382.615 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.028300 seconds old.
2016-06-28T17:03:03.056Z,1467133383.056 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.461500 seconds old.
2016-06-28T17:03:03.068Z,1467133383.069 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.481800 seconds old.
2016-06-28T17:03:05.486Z,1467133385.486 [NAL9602](INFO): SBD MO Status=0, MOMSN=539, MT Status=0, MTMSN=0
2016-06-28T17:03:05.487Z,1467133385.487 [NAL9602](INFO): No messages in MT queue
2016-06-28T17:03:39.667Z,1467133419.667 [SBIT](IMPORTANT): SBIT PASSED
2016-06-28T17:03:40.023Z,1467133420.023 [MissionManager](IMPORTANT): Started mission Startup
2016-06-28T17:03:40.023Z,1467133420.023 [Startup] Running Loop=1
2016-06-28T17:03:40.027Z,1467133420.027 [Startup](DEBUG): Aggregate::initialize Startup
2016-06-28T17:03:40.027Z,1467133420.027 [Startup:A.GoToSurface] Running Loop=1
2016-06-28T17:03:40.028Z,1467133420.028 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2016-06-28T17:03:40.028Z,1467133420.028 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2016-06-28T17:03:40.029Z,1467133420.029 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2016-06-28T17:03:40.029Z,1467133420.029 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2016-06-28T17:03:40.029Z,1467133420.029 [Startup:A.GoToSurface](DEBUG): No pitch timeout specified. Using default value of 20.000000 seconds.
2016-06-28T17:03:40.030Z,1467133420.030 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2016-06-28T17:03:40.060Z,1467133420.060 [Startup:StartupSatComms] Running Loop=1
2016-06-28T17:03:40.060Z,1467133420.060 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2016-06-28T17:03:40.060Z,1467133420.060 [Startup:StartupSatComms:A] Running Loop=1
2016-06-28T17:03:40.629Z,1467133420.629 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2016-06-28T17:03:48.824Z,1467133428.824 [BPC1](ERROR): Failed to parse bank B battery data
2016-06-28T17:03:48.825Z,1467133428.825 [BPC1] Data Fault, FailCount= 1
2016-06-28T17:03:48.825Z,1467133428.825 [BPC1](ERROR): Data Fault
2016-06-28T17:03:49.054Z,1467133429.054 [CBIT](ERROR): Data Fault in component: BPC1
2016-06-28T17:03:50.064Z,1467133430.064 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-28T17:03:50.064Z,1467133430.064 [BPC1] No Fault, FailCount= 1
2016-06-28T17:04:37.720Z,1467133477.720 [PNI_TCM](ERROR): CRC does not match. Expected:0x39123 got:0x62233
2016-06-28T17:04:38.560Z,1467133478.560 [PNI_TCM](ERROR): CRC does not match. Expected:0x17698 got:0x62218
2016-06-28T17:04:38.562Z,1467133478.562 [PNI_TCM](ERROR): CRC does not match. Expected:0x28001 got:0x62327
2016-06-28T17:04:39.028Z,1467133479.028 [PNI_TCM](ERROR): CRC does not match. Expected:0x15963 got:0x62373
2016-06-28T17:04:39.382Z,1467133479.382 [PNI_TCM](ERROR): CRC does not match. Expected:0x35572 got:0x62327
2016-06-28T17:04:40.101Z,1467133480.101 [PNI_TCM](ERROR): CRC does not match. Expected:0x15963 got:0x62282
2016-06-28T17:04:40.145Z,1467133480.145 [Startup:StartupSatComms:A](INFO): Timed out from 2016-06-28T17:03:40.1Z
2016-06-28T17:04:40.146Z,1467133480.145 [Startup:StartupSatComms:A] Stopped
2016-06-28T17:04:40.146Z,1467133480.146 [Startup:StartupSatComms:B] Running Loop=1
2016-06-28T17:04:40.610Z,1467133480.610 [PNI_TCM](ERROR): CRC does not match. Expected:0x17241 got:0x62305
2016-06-28T17:04:40.611Z,1467133480.611 [PNI_TCM](ERROR): CRC does not match. Expected:0x29263 got:0x62458
2016-06-28T17:04:40.726Z,1467133480.726 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2016-06-28T17:04:41.504Z,1467133481.504 [PNI_TCM](ERROR): CRC does not match. Expected:0x955 got:0x62333
2016-06-28T17:04:41.505Z,1467133481.505 [PNI_TCM](ERROR): CRC does not match. Expected:0x63221 got:0x62291
2016-06-28T17:04:41.907Z,1467133481.907 [PNI_TCM](ERROR): CRC does not match. Expected:0x41908 got:0x62238
2016-06-28T17:04:42.338Z,1467133482.338 [PNI_TCM](ERROR): CRC does not match. Expected:0x60444 got:0x62219
2016-06-28T17:04:42.770Z,1467133482.770 [PNI_TCM](ERROR): CRC does not match. Expected:0x33733 got:0x62280
2016-06-28T17:04:42.771Z,1467133482.771 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-28T17:04:42.787Z,1467133482.787 [PNI_TCM] Data Fault, FailCount= 1
2016-06-28T17:04:42.788Z,1467133482.788 [PNI_TCM](ERROR): Data Fault
2016-06-28T17:04:42.828Z,1467133482.829 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.416100 seconds old.
2016-06-28T17:04:42.832Z,1467133482.832 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.405400 seconds old.
2016-06-28T17:04:42.917Z,1467133482.917 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-28T17:04:43.106Z,1467133483.106 [PNI_TCM](INFO): Powering down
2016-06-28T17:04:43.172Z,1467133483.172 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.760400 seconds old.
2016-06-28T17:04:43.185Z,1467133483.185 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.758200 seconds old.
2016-06-28T17:04:43.491Z,1467133483.491 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.080200 seconds old.
2016-06-28T17:04:43.493Z,1467133483.493 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.066800 seconds old.
2016-06-28T17:04:43.896Z,1467133483.895 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.484200 seconds old.
2016-06-28T17:04:43.897Z,1467133483.897 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.470900 seconds old.
2016-06-28T17:04:44.322Z,1467133484.322 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.910400 seconds old.
2016-06-28T17:04:44.323Z,1467133484.323 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.897000 seconds old.
2016-06-28T17:04:44.348Z,1467133484.348 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-28T17:04:44.348Z,1467133484.348 [PNI_TCM] No Fault, FailCount= 1
2016-06-28T17:04:44.692Z,1467133484.692 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.280700 seconds old.
2016-06-28T17:04:44.696Z,1467133484.696 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.269100 seconds old.
2016-06-28T17:04:45.181Z,1467133485.181 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.768900 seconds old.
2016-06-28T17:04:45.193Z,1467133485.194 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.767000 seconds old.
2016-06-28T17:04:45.658Z,1467133485.658 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.246100 seconds old.
2016-06-28T17:04:45.670Z,1467133485.670 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.243700 seconds old.
2016-06-28T17:04:45.893Z,1467133485.893 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.481700 seconds old.
2016-06-28T17:04:45.894Z,1467133485.894 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.468300 seconds old.
2016-06-28T17:04:46.398Z,1467133486.398 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.986400 seconds old.
2016-06-28T17:04:46.403Z,1467133486.403 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.976300 seconds old.
2016-06-28T17:04:46.856Z,1467133486.856 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.435900 seconds old.
2016-06-28T17:04:46.869Z,1467133486.869 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.442500 seconds old.
2016-06-28T17:04:47.136Z,1467133487.136 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.722700 seconds old.
2016-06-28T17:04:47.153Z,1467133487.153 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.726300 seconds old.
2016-06-28T17:04:47.492Z,1467133487.492 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.080400 seconds old.
2016-06-28T17:04:47.493Z,1467133487.493 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.067000 seconds old.
2016-06-28T17:04:55.167Z,1467133495.167 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:04:55.960Z,1467133495.960 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:04:59.193Z,1467133499.194 [PNI_TCM](ERROR): CRC does not match. Expected:0x5928 got:0x62271
2016-06-28T17:04:59.899Z,1467133499.899 [PNI_TCM](ERROR): CRC does not match. Expected:0x5540 got:0x62278
2016-06-28T17:05:00.413Z,1467133500.413 [PNI_TCM](ERROR): CRC does not match. Expected:0x52333 got:0x62225
2016-06-28T17:05:00.415Z,1467133500.415 [PNI_TCM](ERROR): CRC does not match. Expected:0x16613 got:0x62233
2016-06-28T17:05:00.840Z,1467133500.840 [PNI_TCM](ERROR): CRC does not match. Expected:0x17698 got:0x62195
2016-06-28T17:05:01.210Z,1467133501.210 [PNI_TCM](ERROR): CRC does not match. Expected:0x20536 got:0x62258
2016-06-28T17:05:01.925Z,1467133501.925 [PNI_TCM](ERROR): CRC does not match. Expected:0x29748 got:0x62360
2016-06-28T17:05:01.925Z,1467133501.925 [PNI_TCM](ERROR): CRC does not match. Expected:0x63478 got:0x62272
2016-06-28T17:05:03.335Z,1467133503.335 [PNI_TCM](ERROR): CRC does not match. Expected:0x35831 got:0x62365
2016-06-28T17:05:03.335Z,1467133503.335 [PNI_TCM](ERROR): CRC does not match. Expected:0x37793 got:0x62302
2016-06-28T17:05:03.335Z,1467133503.335 [PNI_TCM](ERROR): CRC does not match. Expected:0x49700 got:0x62268
2016-06-28T17:05:03.883Z,1467133503.883 [PNI_TCM](ERROR): CRC does not match. Expected:0x13929 got:0x62240
2016-06-28T17:05:03.883Z,1467133503.883 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-28T17:05:03.883Z,1467133503.883 [PNI_TCM] Data Fault, FailCount= 1
2016-06-28T17:05:03.883Z,1467133503.883 [PNI_TCM](ERROR): Data Fault
2016-06-28T17:05:03.940Z,1467133503.940 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.407800 seconds old.
2016-06-28T17:05:03.947Z,1467133503.947 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.415500 seconds old.
2016-06-28T17:05:03.992Z,1467133503.992 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-28T17:05:04.297Z,1467133504.297 [PNI_TCM](INFO): Powering down
2016-06-28T17:05:04.368Z,1467133504.368 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.832800 seconds old.
2016-06-28T17:05:04.380Z,1467133504.381 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.844000 seconds old.
2016-06-28T17:05:04.739Z,1467133504.739 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.212000 seconds old.
2016-06-28T17:05:04.743Z,1467133504.743 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.214500 seconds old.
2016-06-28T17:05:05.151Z,1467133505.151 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.623700 seconds old.
2016-06-28T17:05:05.173Z,1467133505.173 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.645100 seconds old.
2016-06-28T17:05:05.475Z,1467133505.475 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.948800 seconds old.
2016-06-28T17:05:05.477Z,1467133505.477 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.949500 seconds old.
2016-06-28T17:05:05.502Z,1467133505.502 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-28T17:05:05.502Z,1467133505.502 [PNI_TCM] No Fault, FailCount= 1
2016-06-28T17:05:05.900Z,1467133505.900 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.373900 seconds old.
2016-06-28T17:05:05.902Z,1467133505.902 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.374400 seconds old.
2016-06-28T17:05:06.384Z,1467133506.384 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.852900 seconds old.
2016-06-28T17:05:06.396Z,1467133506.396 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.860100 seconds old.
2016-06-28T17:05:06.722Z,1467133506.722 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.195500 seconds old.
2016-06-28T17:05:06.744Z,1467133506.744 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.207100 seconds old.
2016-06-28T17:05:07.145Z,1467133507.145 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.618200 seconds old.
2016-06-28T17:05:07.157Z,1467133507.157 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.629500 seconds old.
2016-06-28T17:05:07.480Z,1467133507.480 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.949000 seconds old.
2016-06-28T17:05:07.481Z,1467133507.481 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.953700 seconds old.
2016-06-28T17:05:07.895Z,1467133507.895 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.368100 seconds old.
2016-06-28T17:05:07.919Z,1467133507.919 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.391500 seconds old.
2016-06-28T17:05:08.272Z,1467133508.272 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.745600 seconds old.
2016-06-28T17:05:08.273Z,1467133508.273 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.746100 seconds old.
2016-06-28T17:05:08.676Z,1467133508.676 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.149200 seconds old.
2016-06-28T17:05:08.677Z,1467133508.677 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.149800 seconds old.
2016-06-28T17:05:19.107Z,1467133519.107 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:05:19.904Z,1467133519.904 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:05:25.725Z,1467133525.725 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-06-28T17:05:25.725Z,1467133525.725 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2016-06-28T17:05:25.725Z,1467133525.725 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-06-28T17:05:25.727Z,1467133525.727 [DeadReckonUsingSpeedCalculator](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-06-28T17:05:25.727Z,1467133525.727 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2016-06-28T17:05:25.727Z,1467133525.727 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2016-06-28T17:05:25.775Z,1467133525.775 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-06-28T17:05:25.775Z,1467133525.775 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2016-06-28T17:05:26.062Z,1467133526.062 [NAL9602](INFO): SBD MO Status=2, MOMSN=540, MT Status=2, MTMSN=0
2016-06-28T17:05:26.062Z,1467133526.062 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2016-06-28T17:05:26.153Z,1467133526.153 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-06-28T17:05:26.154Z,1467133526.154 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2016-06-28T17:05:26.154Z,1467133526.154 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2016-06-28T17:05:26.154Z,1467133526.154 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2016-06-28T17:05:26.613Z,1467133526.613 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-06-28T17:05:26.615Z,1467133526.615 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-06-28T17:05:26.624Z,1467133526.624 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-06-28T17:05:26.626Z,1467133526.625 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2016-06-28T17:05:26.636Z,1467133526.636 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2016-06-28T17:05:26.637Z,1467133526.637 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2016-06-28T17:05:40.615Z,1467133540.615 [Startup:StartupSatComms:B](INFO): Timed out from 2016-06-28T17:04:40.1Z
2016-06-28T17:05:40.615Z,1467133540.615 [Startup:StartupSatComms:B] Stopped
2016-06-28T17:05:40.616Z,1467133540.616 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2016-06-28T17:05:40.616Z,1467133540.616 [Startup:StartupSatComms] Stopped
2016-06-28T17:05:40.616Z,1467133540.616 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2016-06-28T17:05:40.619Z,1467133540.619 [Startup](INFO): Completed Startup
2016-06-28T17:05:40.619Z,1467133540.619 [Startup] Stopped
2016-06-28T17:05:40.640Z,1467133540.640 [Startup](DEBUG): Aggregate::uninitialize Startup
2016-06-28T17:05:40.640Z,1467133540.640 [Startup:A.GoToSurface] Stopped
2016-06-28T17:05:40.640Z,1467133540.640 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2016-06-28T17:05:41.154Z,1467133541.154 [MissionManager](IMPORTANT): Started mission Default
2016-06-28T17:05:41.155Z,1467133541.155 [Default] Running Loop=1
2016-06-28T17:05:41.160Z,1467133541.160 [Default](DEBUG): Aggregate::initialize Default
2016-06-28T17:05:41.160Z,1467133541.160 [Default:B.GoToSurface] Running Loop=1
2016-06-28T17:05:41.160Z,1467133541.160 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2016-06-28T17:05:41.161Z,1467133541.161 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2016-06-28T17:05:41.162Z,1467133541.162 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2016-06-28T17:05:41.163Z,1467133541.163 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2016-06-28T17:05:41.164Z,1467133541.164 [Default:B.GoToSurface](DEBUG): No pitch timeout specified. Using default value of 20.000000 seconds.
2016-06-28T17:05:41.165Z,1467133541.165 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2016-06-28T17:05:41.166Z,1467133541.165 [Default:A.Wait] Running Loop=1
2016-06-28T17:05:41.166Z,1467133541.166 [Default:A.Wait](DEBUG): Initialize Wait Component.
2016-06-28T17:05:47.856Z,1467133547.856 [PNI_TCM](ERROR): CRC does not match. Expected:0x1803 got:0x62176
2016-06-28T17:05:48.347Z,1467133548.348 [PNI_TCM](ERROR): CRC does not match. Expected:0x30843 got:0x62238
2016-06-28T17:05:48.370Z,1467133548.369 [PNI_TCM](ERROR): CRC does not match. Expected:0x60444 got:0x62332
2016-06-28T17:05:48.858Z,1467133548.858 [PNI_TCM](ERROR): CRC does not match. Expected:0x6225 got:0x62334
2016-06-28T17:05:49.257Z,1467133549.257 [PNI_TCM](ERROR): CRC does not match. Expected:0x54584 got:0x62268
2016-06-28T17:05:49.519Z,1467133549.519 [PNI_TCM](ERROR): CRC does not match. Expected:0x13929 got:0x62333
2016-06-28T17:05:49.923Z,1467133549.923 [PNI_TCM](ERROR): CRC does not match. Expected:0x63221 got:0x62315
2016-06-28T17:05:50.413Z,1467133550.413 [PNI_TCM](ERROR): CRC does not match. Expected:0x47841 got:0x62274
2016-06-28T17:05:50.775Z,1467133550.775 [PNI_TCM](ERROR): CRC does not match. Expected:0x18078 got:0x62334
2016-06-28T17:05:51.163Z,1467133551.163 [PNI_TCM](ERROR): CRC does not match. Expected:0x51477 got:0x6464
2016-06-28T17:05:51.515Z,1467133551.515 [PNI_TCM](ERROR): CRC does not match. Expected:0x1504 got:0x6464
2016-06-28T17:05:51.912Z,1467133551.912 [PNI_TCM](ERROR): CRC does not match. Expected:0x50495 got:0x6464
2016-06-28T17:05:52.377Z,1467133552.377 [PNI_TCM](ERROR): CRC does not match. Expected:0x20638 got:0x6464
2016-06-28T17:05:52.377Z,1467133552.378 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-28T17:05:52.378Z,1467133552.378 [PNI_TCM] Data Fault, FailCount= 1
2016-06-28T17:05:52.378Z,1467133552.378 [PNI_TCM](ERROR): Data Fault
2016-06-28T17:05:52.430Z,1467133552.430 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.510900 seconds old.
2016-06-28T17:05:52.450Z,1467133552.450 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.531000 seconds old.
2016-06-28T17:05:52.518Z,1467133552.518 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-28T17:05:52.729Z,1467133552.729 [PNI_TCM](INFO): Powering down
2016-06-28T17:05:52.765Z,1467133552.765 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.846700 seconds old.
2016-06-28T17:05:52.785Z,1467133552.785 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.865400 seconds old.
2016-06-28T17:05:53.175Z,1467133553.175 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.256200 seconds old.
2016-06-28T17:05:53.183Z,1467133553.183 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.263300 seconds old.
2016-06-28T17:05:53.502Z,1467133553.502 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.584100 seconds old.
2016-06-28T17:05:53.503Z,1467133553.503 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.584500 seconds old.
2016-06-28T17:05:53.911Z,1467133553.911 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.993500 seconds old.
2016-06-28T17:05:53.913Z,1467133553.913 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.993900 seconds old.
2016-06-28T17:05:53.925Z,1467133553.925 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-28T17:05:53.925Z,1467133553.925 [PNI_TCM] No Fault, FailCount= 1
2016-06-28T17:05:54.372Z,1467133554.372 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.453200 seconds old.
2016-06-28T17:05:54.375Z,1467133554.375 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.455900 seconds old.
2016-06-28T17:05:54.388Z,1467133554.388 [Default:A.Wait](INFO): Done Waiting.
2016-06-28T17:05:54.389Z,1467133554.389 [Default:A.Wait] Stopped
2016-06-28T17:05:54.389Z,1467133554.389 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2016-06-28T17:05:54.782Z,1467133554.782 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.863100 seconds old.
2016-06-28T17:05:54.790Z,1467133554.790 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.870400 seconds old.
2016-06-28T17:05:54.810Z,1467133554.810 [Default:CheckIn] Running Loop=1
2016-06-28T17:05:54.811Z,1467133554.811 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2016-06-28T17:05:54.811Z,1467133554.811 [Default:CheckIn:Read_GPS] Running Loop=1
2016-06-28T17:05:55.170Z,1467133555.170 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.252100 seconds old.
2016-06-28T17:05:55.174Z,1467133555.174 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.254600 seconds old.
2016-06-28T17:05:55.196Z,1467133555.196 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2016-06-28T17:05:55.524Z,1467133555.524 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.605800 seconds old.
2016-06-28T17:05:55.525Z,1467133555.525 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.606200 seconds old.
2016-06-28T17:05:55.920Z,1467133555.920 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.002100 seconds old.
2016-06-28T17:05:55.922Z,1467133555.922 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.002800 seconds old.
2016-06-28T17:05:56.331Z,1467133556.332 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.413600 seconds old.
2016-06-28T17:05:56.333Z,1467133556.333 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.414000 seconds old.
2016-06-28T17:05:56.776Z,1467133556.776 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.843800 seconds old.
2016-06-28T17:05:56.781Z,1467133556.781 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.861400 seconds old.
2016-06-28T17:05:57.140Z,1467133557.140 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.221600 seconds old.
2016-06-28T17:05:57.144Z,1467133557.144 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.225100 seconds old.
2016-06-28T17:05:59.169Z,1467133559.169 [BPC1](ERROR): Failed to parse bank B battery data
2016-06-28T17:05:59.169Z,1467133559.169 [BPC1] Data Fault, FailCount= 1
2016-06-28T17:05:59.169Z,1467133559.169 [BPC1](ERROR): Data Fault
2016-06-28T17:05:59.232Z,1467133559.232 [CBIT](ERROR): Data Fault in component: BPC1
2016-06-28T17:06:00.598Z,1467133560.598 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-28T17:06:00.599Z,1467133560.599 [BPC1] No Fault, FailCount= 1
2016-06-28T17:06:18.795Z,1467133578.795 [PNI_TCM](ERROR): CRC does not match. Expected:0x40171 got:0x62335
2016-06-28T17:06:19.163Z,1467133579.164 [PNI_TCM](ERROR): CRC does not match. Expected:0x15260 got:0x62333
2016-06-28T17:06:19.937Z,1467133579.937 [PNI_TCM](ERROR): CRC does not match. Expected:0x63221 got:0x62291
2016-06-28T17:06:19.938Z,1467133579.938 [PNI_TCM](ERROR): CRC does not match. Expected:0x41908 got:0x62309
2016-06-28T17:06:20.777Z,1467133580.777 [PNI_TCM](ERROR): CRC does not match. Expected:0x63676 got:0x62342
2016-06-28T17:06:20.784Z,1467133580.784 [PNI_TCM](ERROR): CRC does not match. Expected:0x48677 got:0x62280
2016-06-28T17:06:21.210Z,1467133581.210 [PNI_TCM](ERROR): CRC does not match. Expected:0x36400 got:0x62241
2016-06-28T17:06:21.563Z,1467133581.563 [PNI_TCM](ERROR): CRC does not match. Expected:0x17801 got:0x6464
2016-06-28T17:06:22.418Z,1467133582.418 [PNI_TCM](ERROR): CRC does not match. Expected:0x61637 got:0x6464
2016-06-28T17:06:22.419Z,1467133582.419 [PNI_TCM](ERROR): CRC does not match. Expected:0x56578 got:0x6464
2016-06-28T17:06:22.799Z,1467133582.799 [PNI_TCM](ERROR): CRC does not match. Expected:0x8670 got:0x6464
2016-06-28T17:06:23.201Z,1467133583.201 [PNI_TCM](ERROR): CRC does not match. Expected:0x33799 got:0x6464
2016-06-28T17:06:23.520Z,1467133583.520 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-28T17:06:23.520Z,1467133583.520 [PNI_TCM] Data Fault, FailCount= 1
2016-06-28T17:06:23.520Z,1467133583.520 [PNI_TCM](ERROR): Data Fault
2016-06-28T17:06:23.526Z,1467133583.526 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.306200 seconds old.
2016-06-28T17:06:23.528Z,1467133583.528 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.304000 seconds old.
2016-06-28T17:06:23.541Z,1467133583.541 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-28T17:06:23.905Z,1467133583.905 [PNI_TCM](INFO): Powering down
2016-06-28T17:06:23.920Z,1467133583.921 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.700600 seconds old.
2016-06-28T17:06:23.922Z,1467133583.922 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.698400 seconds old.
2016-06-28T17:06:24.366Z,1467133584.366 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.145400 seconds old.
2016-06-28T17:06:24.375Z,1467133584.375 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.150600 seconds old.
2016-06-28T17:06:24.815Z,1467133584.815 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.594300 seconds old.
2016-06-28T17:06:24.828Z,1467133584.828 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.600000 seconds old.
2016-06-28T17:06:25.172Z,1467133585.172 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.951400 seconds old.
2016-06-28T17:06:25.176Z,1467133585.175 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.951600 seconds old.
2016-06-28T17:06:25.217Z,1467133585.217 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-28T17:06:25.217Z,1467133585.217 [PNI_TCM] No Fault, FailCount= 1
2016-06-28T17:06:25.532Z,1467133585.532 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.312500 seconds old.
2016-06-28T17:06:25.534Z,1467133585.534 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.310300 seconds old.
2016-06-28T17:06:25.931Z,1467133585.931 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.711100 seconds old.
2016-06-28T17:06:25.933Z,1467133585.932 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.709100 seconds old.
2016-06-28T17:06:26.389Z,1467133586.389 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.168600 seconds old.
2016-06-28T17:06:26.421Z,1467133586.421 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.197300 seconds old.
2016-06-28T17:06:26.775Z,1467133586.775 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.554600 seconds old.
2016-06-28T17:06:26.788Z,1467133586.788 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.559800 seconds old.
2016-06-28T17:06:27.177Z,1467133587.177 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.956700 seconds old.
2016-06-28T17:06:27.181Z,1467133587.181 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.956900 seconds old.
2016-06-28T17:06:27.551Z,1467133587.551 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.330900 seconds old.
2016-06-28T17:06:27.552Z,1467133587.552 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.328700 seconds old.
2016-06-28T17:06:27.968Z,1467133587.968 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.747900 seconds old.
2016-06-28T17:06:27.971Z,1467133587.971 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.745700 seconds old.
2016-06-28T17:06:28.382Z,1467133588.382 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.161800 seconds old.
2016-06-28T17:06:28.390Z,1467133588.390 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.166100 seconds old.
2016-06-28T17:06:34.781Z,1467133594.782 [NAL9602](INFO): GPS fix at 20160628T170603: (36.802844, -121.788094)
2016-06-28T17:06:34.975Z,1467133594.975 [Default:CheckIn:Read_GPS] Stopped
2016-06-28T17:06:34.975Z,1467133594.975 [Default:CheckIn:Read_Iridium] Running Loop=1
2016-06-28T17:06:35.229Z,1467133595.229 [DeadReckonUsingMultipleVelocitySources](FAULT): Caught NaN! Will not write estimated position: latitude_ = nan, longitude_ = nan, depth_ = nan, horizontalPathLengthSinceLastFix_ = nan, latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-06-28T17:06:35.229Z,1467133595.229 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2016-06-28T17:06:35.229Z,1467133595.230 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-06-28T17:06:35.234Z,1467133595.234 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2016-06-28T17:06:35.259Z,1467133595.260 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-06-28T17:06:35.657Z,1467133595.657 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-06-28T17:06:35.657Z,1467133595.657 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2016-06-28T17:06:36.040Z,1467133596.040 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-06-28T17:06:36.040Z,1467133596.040 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-06-28T17:06:36.041Z,1467133596.041 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-06-28T17:06:57.622Z,1467133617.622 [PNI_TCM](ERROR): CRC does not match. Expected:0x7231 got:0x62258
2016-06-28T17:06:59.054Z,1467133619.054 [PNI_TCM](ERROR): CRC does not match. Expected:0x29748 got:0x62320
2016-06-28T17:06:59.056Z,1467133619.056 [PNI_TCM](ERROR): CRC does not match. Expected:0x38757 got:0x62436
2016-06-28T17:06:59.057Z,1467133619.057 [PNI_TCM](ERROR): CRC does not match. Expected:0x19048 got:0x62339
2016-06-28T17:06:59.248Z,1467133619.248 [PNI_TCM](ERROR): CRC does not match. Expected:0x55922 got:0x62310
2016-06-28T17:06:59.655Z,1467133619.655 [PNI_TCM](ERROR): CRC does not match. Expected:0x56177 got:0x62262
2016-06-28T17:07:00.082Z,1467133620.082 [PNI_TCM](ERROR): CRC does not match. Expected:0x65223 got:0x62251
2016-06-28T17:07:00.560Z,1467133620.560 [PNI_TCM](ERROR): CRC does not match. Expected:0x38105 got:0x62304
2016-06-28T17:07:00.971Z,1467133620.971 [PNI_TCM](ERROR): CRC does not match. Expected:0x40171 got:0x62249
2016-06-28T17:07:01.252Z,1467133621.252 [PNI_TCM](ERROR): CRC does not match. Expected:0x22960 got:0x62291
2016-06-28T17:07:01.668Z,1467133621.668 [PNI_TCM](ERROR): CRC does not match. Expected:0x41908 got:0x62301
2016-06-28T17:07:02.162Z,1467133622.162 [PNI_TCM](ERROR): CRC does not match. Expected:0x57833 got:0x62260
2016-06-28T17:07:03.134Z,1467133623.134 [PNI_TCM](ERROR): CRC does not match. Expected:0x13230 got:0x62347
2016-06-28T17:07:03.136Z,1467133623.136 [PNI_TCM](ERROR): CRC does not match. Expected:0x57269 got:0x62315
2016-06-28T17:07:03.136Z,1467133623.136 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-28T17:07:03.136Z,1467133623.136 [PNI_TCM] Data Fault, FailCount= 1
2016-06-28T17:07:03.137Z,1467133623.137 [PNI_TCM](ERROR): Data Fault
2016-06-28T17:07:03.188Z,1467133623.188 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.983500 seconds old.
2016-06-28T17:07:03.189Z,1467133623.189 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.981800 seconds old.
2016-06-28T17:07:03.232Z,1467133623.232 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-28T17:07:03.277Z,1467133623.277 [PNI_TCM](INFO): Powering down
2016-06-28T17:07:03.292Z,1467133623.292 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.087500 seconds old.
2016-06-28T17:07:03.293Z,1467133623.293 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.085800 seconds old.
2016-06-28T17:07:03.672Z,1467133623.672 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.467400 seconds old.
2016-06-28T17:07:03.673Z,1467133623.673 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.465700 seconds old.
2016-06-28T17:07:04.144Z,1467133624.144 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.926400 seconds old.
2016-06-28T17:07:04.147Z,1467133624.147 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.939400 seconds old.
2016-06-28T17:07:04.562Z,1467133624.562 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.356700 seconds old.
2016-06-28T17:07:04.566Z,1467133624.566 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.357700 seconds old.
2016-06-28T17:07:04.659Z,1467133624.659 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-28T17:07:04.659Z,1467133624.659 [PNI_TCM] No Fault, FailCount= 1
2016-06-28T17:07:04.989Z,1467133624.989 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.784300 seconds old.
2016-06-28T17:07:05.002Z,1467133625.002 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.794000 seconds old.
2016-06-28T17:07:05.280Z,1467133625.280 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.075300 seconds old.
2016-06-28T17:07:05.281Z,1467133625.281 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.073600 seconds old.
2016-06-28T17:07:05.706Z,1467133625.706 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.501800 seconds old.
2016-06-28T17:07:05.708Z,1467133625.708 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.500100 seconds old.
2016-06-28T17:07:06.081Z,1467133626.081 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.876600 seconds old.
2016-06-28T17:07:06.082Z,1467133626.082 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.874900 seconds old.
2016-06-28T17:07:06.542Z,1467133626.542 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.337200 seconds old.
2016-06-28T17:07:06.559Z,1467133626.559 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.350700 seconds old.
2016-06-28T17:07:07.460Z,1467133627.460 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.255400 seconds old.
2016-06-28T17:07:07.461Z,1467133627.461 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.253700 seconds old.
2016-06-28T17:07:07.656Z,1467133627.656 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.451500 seconds old.
2016-06-28T17:07:07.657Z,1467133627.657 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.449900 seconds old.
2016-06-28T17:07:08.028Z,1467133628.028 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.823700 seconds old.
2016-06-28T17:07:08.029Z,1467133628.029 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.822000 seconds old.
2016-06-28T17:07:39.206Z,1467133659.205 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.019800
2016-06-28T17:07:49.153Z,1467133669.153 [NAL9602](INFO): Powering down
2016-06-28T17:07:49.269Z,1467133669.269 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20160628T165200/Courier0008.lzma
2016-06-28T17:07:50.061Z,1467133670.061 [DataOverHttps](INFO): Moved sent file to Logs/20160628T165200/Courier0008.lzma.bak
2016-06-28T17:07:50.061Z,1467133670.061 [DataOverHttps](INFO): SBD MOMSN=4318799
2016-06-28T17:07:57.533Z,1467133677.533 [BPC1](ERROR): Failed to receive battery data
2016-06-28T17:07:57.533Z,1467133677.533 [BPC1] Communications Fault, FailCount= 1
2016-06-28T17:07:57.533Z,1467133677.533 [BPC1](ERROR): Communications Fault
2016-06-28T17:07:57.611Z,1467133677.611 [CBIT](ERROR): Communications Fault in component: BPC1
2016-06-28T17:07:58.652Z,1467133678.652 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-28T17:07:58.653Z,1467133678.653 [BPC1] No Fault, FailCount= 1
2016-06-28T17:08:05.072Z,1467133685.072 [DataOverHttps](INFO): Sending 212 bytes from file Logs/20160628T170216/Courier0004.lzma
2016-06-28T17:08:05.873Z,1467133685.873 [DataOverHttps](INFO): Moved sent file to Logs/20160628T170216/Courier0004.lzma.bak
2016-06-28T17:08:05.873Z,1467133685.874 [DataOverHttps](INFO): SBD MOMSN=4318801
2016-06-28T17:08:20.355Z,1467133700.355 [DataOverHttps](INFO): Sending 290 bytes from file Logs/20160628T165200/Express0009.lzma
2016-06-28T17:08:21.162Z,1467133701.162 [DataOverHttps](INFO): Moved sent file to Logs/20160628T165200/Express0009.lzma.bak
2016-06-28T17:08:21.162Z,1467133701.162 [DataOverHttps](INFO): SBD MOMSN=4318805
2016-06-28T17:08:38.909Z,1467133718.909 [BPC1](ERROR): Failed to receive battery data
2016-06-28T17:08:38.909Z,1467133718.909 [BPC1] Communications Fault, FailCount= 1
2016-06-28T17:08:38.909Z,1467133718.909 [BPC1](ERROR): Communications Fault
2016-06-28T17:08:39.016Z,1467133719.016 [CBIT](ERROR): Communications Fault in component: BPC1
2016-06-28T17:08:39.064Z,1467133719.064 [DataOverHttps](INFO): Sending 742 bytes from file Logs/20160628T170216/Express0001.lzma
2016-06-28T17:08:40.086Z,1467133720.086 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-28T17:08:40.086Z,1467133720.086 [BPC1] No Fault, FailCount= 1
2016-06-28T17:08:40.249Z,1467133720.249 [DataOverHttps](INFO): Moved sent file to Logs/20160628T170216/Express0001.lzma.bak
2016-06-28T17:08:40.249Z,1467133720.249 [DataOverHttps](INFO): SBD MOMSN=4318811
2016-06-28T17:08:57.080Z,1467133737.080 [DataOverHttps](INFO): Sending 464 bytes from file Logs/20160628T170216/Express0005.lzma
2016-06-28T17:08:57.880Z,1467133737.880 [DataOverHttps](INFO): Moved sent file to Logs/20160628T170216/Express0005.lzma.bak
2016-06-28T17:08:57.881Z,1467133737.881 [DataOverHttps](INFO): SBD MOMSN=4318831
2016-06-28T17:08:59.207Z,1467133739.207 [Default:CheckIn:Read_Iridium] Stopped
2016-06-28T17:08:59.207Z,1467133739.207 [Default:CheckIn:C.Wait] Running Loop=1
2016-06-28T17:08:59.207Z,1467133739.207 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2016-06-28T17:09:36.482Z,1467133776.482 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-06-28T17:09:36.482Z,1467133776.482 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2016-06-28T17:09:36.482Z,1467133776.483 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-06-28T17:09:36.581Z,1467133776.580 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-06-28T17:09:36.902Z,1467133776.902 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-06-28T17:09:36.902Z,1467133776.902 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2016-06-28T17:09:37.028Z,1467133777.028 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-06-28T17:09:37.029Z,1467133777.029 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-06-28T17:09:37.029Z,1467133777.029 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-06-28T17:10:44.598Z,1467133844.598 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:10:45.009Z,1467133845.010 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:10:45.420Z,1467133845.420 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:10:52.239Z,1467133852.239 [BPC1](ERROR): Failed to receive battery data
2016-06-28T17:10:52.248Z,1467133852.248 [BPC1] Communications Fault, FailCount= 1
2016-06-28T17:10:52.248Z,1467133852.248 [BPC1](ERROR): Communications Fault
2016-06-28T17:10:52.398Z,1467133852.398 [CBIT](ERROR): Communications Fault in component: BPC1
2016-06-28T17:10:53.334Z,1467133853.334 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-28T17:10:53.334Z,1467133853.334 [BPC1] No Fault, FailCount= 1
2016-06-28T17:11:06.578Z,1467133866.578 [PNI_TCM](ERROR): CRC does not match. Expected:0x17577 got:0x62215
2016-06-28T17:11:07.313Z,1467133867.313 [PNI_TCM](ERROR): CRC does not match. Expected:0x3313 got:0x62351
2016-06-28T17:11:07.759Z,1467133867.759 [PNI_TCM](ERROR): CRC does not match. Expected:0x21830 got:0x62293
2016-06-28T17:11:07.759Z,1467133867.759 [PNI_TCM](ERROR): CRC does not match. Expected:0x58414 got:0x62260
2016-06-28T17:11:08.666Z,1467133868.666 [PNI_TCM](ERROR): CRC does not match. Expected:0x13230 got:0x62350
2016-06-28T17:11:08.680Z,1467133868.680 [PNI_TCM](ERROR): CRC does not match. Expected:0x48098 got:0x62277
2016-06-28T17:11:09.072Z,1467133869.072 [PNI_TCM](ERROR): CRC does not match. Expected:0x61344 got:0x62313
2016-06-28T17:11:09.380Z,1467133869.380 [PNI_TCM](ERROR): CRC does not match. Expected:0x30600 got:0x62302
2016-06-28T17:11:09.861Z,1467133869.861 [PNI_TCM](ERROR): CRC does not match. Expected:0x49700 got:0x62278
2016-06-28T17:11:10.308Z,1467133870.307 [PNI_TCM](ERROR): CRC does not match. Expected:0x52333 got:0x62238
2016-06-28T17:11:10.720Z,1467133870.720 [PNI_TCM](ERROR): CRC does not match. Expected:0x60444 got:0x62174
2016-06-28T17:11:10.989Z,1467133870.989 [PNI_TCM](ERROR): CRC does not match. Expected:0x9908 got:0x62276
2016-06-28T17:11:11.387Z,1467133871.387 [PNI_TCM](ERROR): CRC does not match. Expected:0x260 got:0x62198
2016-06-28T17:11:11.387Z,1467133871.387 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-28T17:11:11.387Z,1467133871.387 [PNI_TCM] Data Fault, FailCount= 1
2016-06-28T17:11:11.387Z,1467133871.387 [PNI_TCM](ERROR): Data Fault
2016-06-28T17:11:11.424Z,1467133871.424 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.403300 seconds old.
2016-06-28T17:11:11.425Z,1467133871.425 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.403800 seconds old.
2016-06-28T17:11:11.460Z,1467133871.460 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-28T17:11:11.806Z,1467133871.806 [PNI_TCM](INFO): Powering down
2016-06-28T17:11:11.823Z,1467133871.823 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.802100 seconds old.
2016-06-28T17:11:11.830Z,1467133871.830 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.807900 seconds old.
2016-06-28T17:11:12.352Z,1467133872.352 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.286600 seconds old.
2016-06-28T17:11:12.370Z,1467133872.370 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.347400 seconds old.
2016-06-28T17:11:12.653Z,1467133872.653 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.631800 seconds old.
2016-06-28T17:11:12.656Z,1467133872.656 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.634000 seconds old.
2016-06-28T17:11:12.992Z,1467133872.992 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.971100 seconds old.
2016-06-28T17:11:12.000Z,1467133873.000 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.978400 seconds old.
2016-06-28T17:11:13.041Z,1467133873.041 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-28T17:11:13.041Z,1467133873.041 [PNI_TCM] No Fault, FailCount= 1
2016-06-28T17:11:13.399Z,1467133873.399 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.378400 seconds old.
2016-06-28T17:11:13.400Z,1467133873.401 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.379100 seconds old.
2016-06-28T17:11:13.878Z,1467133873.878 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.857300 seconds old.
2016-06-28T17:11:13.897Z,1467133873.897 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.874700 seconds old.
2016-06-28T17:11:14.276Z,1467133874.276 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.255200 seconds old.
2016-06-28T17:11:14.293Z,1467133874.293 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.271200 seconds old.
2016-06-28T17:11:14.689Z,1467133874.690 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.668500 seconds old.
2016-06-28T17:11:14.709Z,1467133874.709 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.687300 seconds old.
2016-06-28T17:11:14.989Z,1467133874.989 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.968500 seconds old.
2016-06-28T17:11:14.990Z,1467133874.990 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.968900 seconds old.
2016-06-28T17:11:15.426Z,1467133875.426 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.394700 seconds old.
2016-06-28T17:11:15.427Z,1467133875.427 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.405600 seconds old.
2016-06-28T17:11:15.863Z,1467133875.863 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.841900 seconds old.
2016-06-28T17:11:15.874Z,1467133875.874 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.852300 seconds old.
2016-06-28T17:11:16.219Z,1467133876.219 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.198000 seconds old.
2016-06-28T17:11:16.234Z,1467133876.234 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.211700 seconds old.
2016-06-28T17:12:08.224Z,1467133928.224 [BPC1](ERROR): Failed to receive battery data
2016-06-28T17:12:08.224Z,1467133928.224 [BPC1] Communications Fault, FailCount= 1
2016-06-28T17:12:08.224Z,1467133928.224 [BPC1](ERROR): Communications Fault
2016-06-28T17:12:08.398Z,1467133928.398 [CBIT](ERROR): Communications Fault in component: BPC1
2016-06-28T17:12:09.331Z,1467133929.331 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-28T17:12:09.331Z,1467133929.332 [BPC1] No Fault, FailCount= 1
2016-06-28T17:12:25.858Z,1467133945.858 [CBIT](DEBUG): EFC running - data check-sum false
2016-06-28T17:12:37.309Z,1467133957.309 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-06-28T17:12:37.309Z,1467133957.309 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2016-06-28T17:12:37.309Z,1467133957.309 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-06-28T17:12:37.350Z,1467133957.350 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-06-28T17:12:37.860Z,1467133957.860 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-06-28T17:12:37.860Z,1467133957.861 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2016-06-28T17:12:38.198Z,1467133958.198 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-06-28T17:12:38.204Z,1467133958.204 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-06-28T17:12:38.205Z,1467133958.205 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-06-28T17:12:44.582Z,1467133964.582 [PNI_TCM](ERROR): CRC does not match. Expected:0x45372 got:0x6464
2016-06-28T17:12:44.991Z,1467133964.991 [PNI_TCM](ERROR): CRC does not match. Expected:0x57165 got:0x6464
2016-06-28T17:12:45.746Z,1467133965.746 [PNI_TCM](ERROR): CRC does not match. Expected:0x8424 got:0x6464
2016-06-28T17:12:45.752Z,1467133965.752 [PNI_TCM](ERROR): CRC does not match. Expected:0x2957 got:0x6464
2016-06-28T17:12:46.149Z,1467133966.149 [PNI_TCM](ERROR): CRC does not match. Expected:0x60688 got:0x6464
2016-06-28T17:12:46.604Z,1467133966.604 [PNI_TCM](ERROR): CRC does not match. Expected:0x14324 got:0x6464
2016-06-28T17:12:47.301Z,1467133967.301 [PNI_TCM](ERROR): CRC does not match. Expected:0x10849 got:0x6464
2016-06-28T17:12:47.302Z,1467133967.302 [PNI_TCM](ERROR): CRC does not match. Expected:0x25771 got:0x6464
2016-06-28T17:12:47.748Z,1467133967.748 [PNI_TCM](ERROR): CRC does not match. Expected:0x25223 got:0x6464
2016-06-28T17:12:48.147Z,1467133968.147 [PNI_TCM](ERROR): CRC does not match. Expected:0x22277 got:0x6464
2016-06-28T17:12:48.530Z,1467133968.530 [PNI_TCM](ERROR): CRC does not match. Expected:0x4660 got:0x6464
2016-06-28T17:12:48.905Z,1467133968.905 [PNI_TCM](ERROR): CRC does not match. Expected:0x37813 got:0x6464
2016-06-28T17:12:49.297Z,1467133969.297 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-28T17:12:49.298Z,1467133969.297 [PNI_TCM] Data Fault, FailCount= 1
2016-06-28T17:12:49.298Z,1467133969.297 [PNI_TCM](ERROR): Data Fault
2016-06-28T17:12:49.304Z,1467133969.304 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.374500 seconds old.
2016-06-28T17:12:49.305Z,1467133969.305 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.375000 seconds old.
2016-06-28T17:12:49.327Z,1467133969.327 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-28T17:12:49.718Z,1467133969.718 [PNI_TCM](INFO): Powering down
2016-06-28T17:12:49.774Z,1467133969.773 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.843400 seconds old.
2016-06-28T17:12:49.781Z,1467133969.781 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.850600 seconds old.
2016-06-28T17:12:50.120Z,1467133970.120 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.189800 seconds old.
2016-06-28T17:12:50.125Z,1467133970.125 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.194500 seconds old.
2016-06-28T17:12:50.541Z,1467133970.541 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.611000 seconds old.
2016-06-28T17:12:50.564Z,1467133970.564 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.633700 seconds old.
2016-06-28T17:12:50.923Z,1467133970.923 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.994100 seconds old.
2016-06-28T17:12:50.925Z,1467133970.925 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.994600 seconds old.
2016-06-28T17:12:50.942Z,1467133970.943 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-28T17:12:50.943Z,1467133970.943 [PNI_TCM] No Fault, FailCount= 1
2016-06-28T17:12:51.298Z,1467133971.298 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.368700 seconds old.
2016-06-28T17:12:51.299Z,1467133971.299 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.369200 seconds old.
2016-06-28T17:12:51.751Z,1467133971.751 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.821600 seconds old.
2016-06-28T17:12:51.767Z,1467133971.767 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.836800 seconds old.
2016-06-28T17:12:52.154Z,1467133972.155 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.224600 seconds old.
2016-06-28T17:12:52.158Z,1467133972.158 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.227500 seconds old.
2016-06-28T17:12:52.545Z,1467133972.545 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.615000 seconds old.
2016-06-28T17:12:52.549Z,1467133972.549 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.618400 seconds old.
2016-06-28T17:12:52.902Z,1467133972.902 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.972300 seconds old.
2016-06-28T17:12:52.907Z,1467133972.907 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.976800 seconds old.
2016-06-28T17:12:53.327Z,1467133973.327 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.398000 seconds old.
2016-06-28T17:12:53.329Z,1467133973.329 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.398600 seconds old.
2016-06-28T17:12:53.747Z,1467133973.747 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.817300 seconds old.
2016-06-28T17:12:53.751Z,1467133973.751 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.820200 seconds old.
2016-06-28T17:12:54.149Z,1467133974.149 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.218900 seconds old.
2016-06-28T17:12:54.153Z,1467133974.153 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.222400 seconds old.
2016-06-28T17:13:24.153Z,1467134004.152 [PNI_TCM](ERROR): CRC does not match. Expected:0x7219 got:0x62134
2016-06-28T17:13:24.545Z,1467134004.545 [PNI_TCM](ERROR): CRC does not match. Expected:0x6743 got:0x62166
2016-06-28T17:13:25.295Z,1467134005.295 [PNI_TCM](ERROR): CRC does not match. Expected:0x9075 got:0x62188
2016-06-28T17:13:25.749Z,1467134005.749 [PNI_TCM](ERROR): CRC does not match. Expected:0x63311 got:0x62292
2016-06-28T17:13:25.750Z,1467134005.750 [PNI_TCM](ERROR): CRC does not match. Expected:0x2698 got:0x62497
2016-06-28T17:13:26.166Z,1467134006.165 [PNI_TCM](ERROR): CRC does not match. Expected:0x18100 got:0x62412
2016-06-28T17:13:26.545Z,1467134006.545 [PNI_TCM](ERROR): CRC does not match. Expected:0x22707 got:0x62299
2016-06-28T17:13:27.302Z,1467134007.302 [PNI_TCM](ERROR): CRC does not match. Expected:0x42611 got:0x62189
2016-06-28T17:13:27.302Z,1467134007.302 [PNI_TCM](ERROR): CRC does not match. Expected:0x6635 got:0x62268
2016-06-28T17:13:27.789Z,1467134007.789 [PNI_TCM](ERROR): CRC does not match. Expected:0x13929 got:0x62261
2016-06-28T17:13:28.193Z,1467134008.193 [PNI_TCM](ERROR): CRC does not match. Expected:0x49175 got:0x6464
2016-06-28T17:13:28.546Z,1467134008.546 [PNI_TCM](ERROR): CRC does not match. Expected:0x19665 got:0x6464
2016-06-28T17:13:28.916Z,1467134008.917 [PNI_TCM](ERROR): CRC does not match. Expected:0x5634 got:0x6464
2016-06-28T17:13:28.917Z,1467134008.917 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-28T17:13:28.917Z,1467134008.917 [PNI_TCM] Data Fault, FailCount= 1
2016-06-28T17:13:28.917Z,1467134008.917 [PNI_TCM](ERROR): Data Fault
2016-06-28T17:13:28.934Z,1467134008.934 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.381500 seconds old.
2016-06-28T17:13:28.935Z,1467134008.935 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.381900 seconds old.
2016-06-28T17:13:28.978Z,1467134008.977 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-28T17:13:29.288Z,1467134009.288 [PNI_TCM](INFO): Powering down
2016-06-28T17:13:29.314Z,1467134009.314 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.761400 seconds old.
2016-06-28T17:13:29.317Z,1467134009.317 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.763000 seconds old.
2016-06-28T17:13:29.743Z,1467134009.743 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.190300 seconds old.
2016-06-28T17:13:29.747Z,1467134009.747 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.193000 seconds old.
2016-06-28T17:13:30.147Z,1467134010.147 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.594300 seconds old.
2016-06-28T17:13:30.150Z,1467134010.151 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.596900 seconds old.
2016-06-28T17:13:30.546Z,1467134010.546 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.993200 seconds old.
2016-06-28T17:13:30.550Z,1467134010.550 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.996200 seconds old.
2016-06-28T17:13:30.602Z,1467134010.602 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-28T17:13:30.602Z,1467134010.602 [PNI_TCM] No Fault, FailCount= 1
2016-06-28T17:13:30.900Z,1467134010.900 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.347600 seconds old.
2016-06-28T17:13:30.903Z,1467134010.903 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.349200 seconds old.
2016-06-28T17:13:31.325Z,1467134011.325 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.772400 seconds old.
2016-06-28T17:13:31.326Z,1467134011.326 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.772800 seconds old.
2016-06-28T17:13:31.719Z,1467134011.719 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.166300 seconds old.
2016-06-28T17:13:31.724Z,1467134011.724 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.170700 seconds old.
2016-06-28T17:13:32.183Z,1467134012.183 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.630000 seconds old.
2016-06-28T17:13:32.213Z,1467134012.213 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.659400 seconds old.
2016-06-28T17:13:32.713Z,1467134012.713 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.159900 seconds old.
2016-06-28T17:13:32.717Z,1467134012.717 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.163300 seconds old.
2016-06-28T17:13:33.168Z,1467134013.168 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.615300 seconds old.
2016-06-28T17:13:33.169Z,1467134013.169 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.615700 seconds old.
2016-06-28T17:13:33.516Z,1467134013.516 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.963200 seconds old.
2016-06-28T17:13:33.533Z,1467134013.533 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.979300 seconds old.
2016-06-28T17:13:33.971Z,1467134013.971 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.417700 seconds old.
2016-06-28T17:13:34.018Z,1467134014.018 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.437700 seconds old.
2016-06-28T17:13:59.545Z,1467134039.545 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2016-06-28T17:13:59.546Z,1467134039.546 [Default:CheckIn:C.Wait] Stopped
2016-06-28T17:13:59.546Z,1467134039.546 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2016-06-28T17:13:59.547Z,1467134039.547 [Default:CheckIn:D] Running Loop=1
2016-06-28T17:13:59.940Z,1467134039.940 [Default:CheckIn:D] Stopped
2016-06-28T17:13:59.940Z,1467134039.940 [Default:CheckIn:E] Running Loop=1
2016-06-28T17:14:00.409Z,1467134040.409 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 8.312733 min 
2016-06-28T17:14:00.429Z,1467134040.429 [Default:CheckIn:E] Stopped
2016-06-28T17:14:00.430Z,1467134040.430 [Default:CheckIn](INFO): Completed Default:CheckIn
2016-06-28T17:14:00.430Z,1467134040.430 [Default:CheckIn] Stopped
2016-06-28T17:14:00.430Z,1467134040.430 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2016-06-28T17:14:00.431Z,1467134040.431 [Default:CheckIn](INFO): Running loop #2
2016-06-28T17:14:00.431Z,1467134040.431 [Default:CheckIn] Running Loop=2
2016-06-28T17:14:00.447Z,1467134040.447 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2016-06-28T17:14:00.448Z,1467134040.448 [Default:CheckIn:Read_GPS] Running Loop=1
2016-06-28T17:14:00.960Z,1467134040.960 [NAL9602](INFO): Powering up
2016-06-28T17:14:11.831Z,1467134051.831 [NAL9602](INFO): NAL9602 initialized
2016-06-28T17:14:19.045Z,1467134059.045 [BPC1](ERROR): Failed to parse message.
2016-06-28T17:14:19.045Z,1467134059.045 [BPC1](ERROR): Failed to parse bank A battery data
2016-06-28T17:14:19.046Z,1467134059.046 [BPC1] Data Fault, FailCount= 1
2016-06-28T17:14:19.046Z,1467134059.046 [BPC1](ERROR): Data Fault
2016-06-28T17:14:19.101Z,1467134059.101 [CBIT](ERROR): Data Fault in component: BPC1
2016-06-28T17:14:20.488Z,1467134060.488 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-28T17:14:20.488Z,1467134060.488 [BPC1] No Fault, FailCount= 1
2016-06-28T17:14:36.660Z,1467134076.660 [BPC1](ERROR): Failed to receive battery data
2016-06-28T17:14:36.660Z,1467134076.660 [BPC1] Communications Fault, FailCount= 2
2016-06-28T17:14:36.660Z,1467134076.660 [BPC1](ERROR): Communications Fault
2016-06-28T17:14:36.714Z,1467134076.714 [CBIT](ERROR): Communications Fault in component: BPC1
2016-06-28T17:14:38.122Z,1467134078.122 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-28T17:14:38.122Z,1467134078.122 [BPC1] No Fault, FailCount= 2
2016-06-28T17:15:35.196Z,1467134135.196 [BPC1](ERROR): Failed to parse bank B battery data
2016-06-28T17:15:35.196Z,1467134135.196 [BPC1] Data Fault, FailCount= 1
2016-06-28T17:15:35.196Z,1467134135.196 [BPC1](ERROR): Data Fault
2016-06-28T17:15:35.470Z,1467134135.470 [CBIT](ERROR): Data Fault in component: BPC1
2016-06-28T17:15:36.461Z,1467134136.461 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-28T17:15:36.461Z,1467134136.461 [BPC1] No Fault, FailCount= 1
2016-06-28T17:15:38.421Z,1467134138.421 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-06-28T17:15:38.421Z,1467134138.421 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2016-06-28T17:15:38.421Z,1467134138.421 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-06-28T17:15:38.481Z,1467134138.481 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-06-28T17:15:38.847Z,1467134138.847 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-06-28T17:15:38.848Z,1467134138.848 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2016-06-28T17:15:39.241Z,1467134139.241 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-06-28T17:15:39.243Z,1467134139.243 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-06-28T17:15:39.244Z,1467134139.244 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-06-28T17:16:08.003Z,1467134168.003 [PNI_TCM](ERROR): CRC does not match. Expected:0x2285 got:0x62383
2016-06-28T17:16:08.417Z,1467134168.417 [PNI_TCM](ERROR): CRC does not match. Expected:0x16986 got:0x62212
2016-06-28T17:16:08.778Z,1467134168.778 [PNI_TCM](ERROR): CRC does not match. Expected:0x12092 got:0x62424
2016-06-28T17:16:09.151Z,1467134169.151 [PNI_TCM](ERROR): CRC does not match. Expected:0x55758 got:0x62490
2016-06-28T17:16:09.605Z,1467134169.605 [PNI_TCM](ERROR): CRC does not match. Expected:0x31788 got:0x62317
2016-06-28T17:16:10.006Z,1467134170.006 [PNI_TCM](ERROR): CRC does not match. Expected:0x64891 got:0x62267
2016-06-28T17:16:10.757Z,1467134170.757 [PNI_TCM](ERROR): CRC does not match. Expected:0x40791 got:0x62304
2016-06-28T17:16:10.758Z,1467134170.758 [PNI_TCM](ERROR): CRC does not match. Expected:0x40171 got:0x62329
2016-06-28T17:16:11.156Z,1467134171.157 [PNI_TCM](ERROR): CRC does not match. Expected:0x31750 got:0x62323
2016-06-28T17:16:11.629Z,1467134171.629 [PNI_TCM](ERROR): CRC does not match. Expected:0x46248 got:0x62228
2016-06-28T17:16:12.027Z,1467134172.027 [PNI_TCM](ERROR): CRC does not match. Expected:0x9394 got:0x62188
2016-06-28T17:16:12.359Z,1467134172.359 [PNI_TCM](ERROR): CRC does not match. Expected:0x63311 got:0x62195
2016-06-28T17:16:12.762Z,1467134172.762 [PNI_TCM](ERROR): CRC does not match. Expected:0x20536 got:0x62247
2016-06-28T17:16:12.762Z,1467134172.762 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-28T17:16:12.762Z,1467134172.762 [PNI_TCM] Data Fault, FailCount= 1
2016-06-28T17:16:12.762Z,1467134172.762 [PNI_TCM](ERROR): Data Fault
2016-06-28T17:16:12.788Z,1467134172.788 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.411400 seconds old.
2016-06-28T17:16:12.789Z,1467134172.789 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.411900 seconds old.
2016-06-28T17:16:12.820Z,1467134172.820 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-28T17:16:13.144Z,1467134173.144 [PNI_TCM](INFO): Powering down
2016-06-28T17:16:13.156Z,1467134173.156 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.778900 seconds old.
2016-06-28T17:16:13.157Z,1467134173.157 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.779600 seconds old.
2016-06-28T17:16:13.593Z,1467134173.593 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.215800 seconds old.
2016-06-28T17:16:13.602Z,1467134173.602 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.224000 seconds old.
2016-06-28T17:16:13.986Z,1467134173.986 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.608600 seconds old.
2016-06-28T17:16:13.996Z,1467134173.996 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.617900 seconds old.
2016-06-28T17:16:14.342Z,1467134174.342 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.965200 seconds old.
2016-06-28T17:16:14.343Z,1467134174.343 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.965700 seconds old.
2016-06-28T17:16:14.357Z,1467134174.357 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-28T17:16:14.357Z,1467134174.357 [PNI_TCM] No Fault, FailCount= 1
2016-06-28T17:16:14.746Z,1467134174.746 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.369300 seconds old.
2016-06-28T17:16:14.748Z,1467134174.748 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.370600 seconds old.
2016-06-28T17:16:15.151Z,1467134175.151 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.774800 seconds old.
2016-06-28T17:16:15.153Z,1467134175.153 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.775400 seconds old.
2016-06-28T17:16:15.610Z,1467134175.610 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.232800 seconds old.
2016-06-28T17:16:15.613Z,1467134175.613 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.235500 seconds old.
2016-06-28T17:16:15.989Z,1467134175.989 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.611700 seconds old.
2016-06-28T17:16:15.997Z,1467134175.997 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.619400 seconds old.
2016-06-28T17:16:16.355Z,1467134176.355 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.978800 seconds old.
2016-06-28T17:16:16.357Z,1467134176.357 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.979300 seconds old.
2016-06-28T17:16:16.783Z,1467134176.783 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.406500 seconds old.
2016-06-28T17:16:16.785Z,1467134176.784 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.407100 seconds old.
2016-06-28T17:16:17.167Z,1467134177.167 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.790700 seconds old.
2016-06-28T17:16:17.169Z,1467134177.169 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.791400 seconds old.
2016-06-28T17:16:17.620Z,1467134177.620 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.243200 seconds old.
2016-06-28T17:16:17.624Z,1467134177.624 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.245800 seconds old.
2016-06-28T17:17:50.222Z,1467134270.222 [NAL9602](INFO): SBD MO Status=2, MOMSN=540, MT Status=2, MTMSN=0
2016-06-28T17:17:50.222Z,1467134270.222 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2016-06-28T17:18:02.290Z,1467134282.290 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:18:03.086Z,1467134283.086 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:18:03.497Z,1467134283.497 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:18:07.040Z,1467134287.040 [BPC1](ERROR): Failed to receive battery data
2016-06-28T17:18:07.040Z,1467134287.040 [BPC1] Communications Fault, FailCount= 1
2016-06-28T17:18:07.040Z,1467134287.040 [BPC1](ERROR): Communications Fault
2016-06-28T17:18:07.124Z,1467134287.124 [CBIT](ERROR): Communications Fault in component: BPC1
2016-06-28T17:18:08.413Z,1467134288.413 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-28T17:18:08.414Z,1467134288.414 [BPC1] No Fault, FailCount= 1
2016-06-28T17:18:15.910Z,1467134295.910 [NAL9602](INFO): SBD MO Status=2, MOMSN=540, MT Status=2, MTMSN=0
2016-06-28T17:18:15.911Z,1467134295.911 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2016-06-28T17:18:39.312Z,1467134319.312 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-06-28T17:18:39.313Z,1467134319.313 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2016-06-28T17:18:39.313Z,1467134319.313 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-06-28T17:18:39.384Z,1467134319.384 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-06-28T17:18:39.788Z,1467134319.787 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-06-28T17:18:39.788Z,1467134319.788 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2016-06-28T17:18:40.065Z,1467134320.065 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-06-28T17:18:40.065Z,1467134320.066 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-06-28T17:18:40.066Z,1467134320.066 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-06-28T17:19:00.546Z,1467134340.546 [Default:CheckIn:Read_GPS](INFO): Timed out from 2016-06-28T17:14:00.4Z
2016-06-28T17:19:00.546Z,1467134340.546 [Default:CheckIn:Read_GPS] Stopped
2016-06-28T17:19:00.546Z,1467134340.546 [Default:CheckIn:Read_Iridium] Running Loop=1
2016-06-28T17:19:07.251Z,1467134347.251 [DataOverHttps](INFO): Sending 195 bytes from file Logs/20160628T170216/Courier0008.lzma
2016-06-28T17:19:08.068Z,1467134348.068 [DataOverHttps](INFO): Moved sent file to Logs/20160628T170216/Courier0008.lzma.bak
2016-06-28T17:19:08.068Z,1467134348.068 [DataOverHttps](INFO): SBD MOMSN=4318875
2016-06-28T17:19:11.362Z,1467134351.362 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:11.773Z,1467134351.773 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:12.568Z,1467134352.568 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:13.366Z,1467134353.365 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:13.778Z,1467134353.778 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:14.188Z,1467134354.188 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:14.286Z,1467134354.286 [NAL9602](INFO): SBD MO Status=2, MOMSN=540, MT Status=2, MTMSN=0
2016-06-28T17:19:14.286Z,1467134354.286 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2016-06-28T17:19:14.986Z,1467134354.986 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:15.269Z,1467134355.269 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2016-06-28T17:19:15.398Z,1467134355.398 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:16.192Z,1467134356.192 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:17.005Z,1467134357.005 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:17.804Z,1467134357.804 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:18.608Z,1467134358.608 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:19.406Z,1467134359.406 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:19.842Z,1467134359.842 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:20.265Z,1467134360.265 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:21.062Z,1467134361.062 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:21.474Z,1467134361.474 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:21.886Z,1467134361.886 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:22.680Z,1467134362.680 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:23.382Z,1467134363.382 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:23.793Z,1467134363.793 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:24.093Z,1467134364.093 [NAL9602](INFO): Powering down
2016-06-28T17:19:24.200Z,1467134364.200 [DataOverHttps](INFO): Sending 308 bytes from file Logs/20160628T170216/Express0009.lzma
2016-06-28T17:19:24.596Z,1467134364.596 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:25.000Z,1467134365.000 [DataOverHttps](INFO): Moved sent file to Logs/20160628T170216/Express0009.lzma.bak
2016-06-28T17:19:25.001Z,1467134365.001 [DataOverHttps](INFO): SBD MOMSN=4318877
2016-06-28T17:19:25.317Z,1467134365.318 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:25.729Z,1467134365.729 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:26.071Z,1467134366.071 [Default:CheckIn:Read_Iridium] Stopped
2016-06-28T17:19:26.072Z,1467134366.072 [Default:CheckIn:C.Wait] Running Loop=1
2016-06-28T17:19:26.072Z,1467134366.072 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2016-06-28T17:19:26.526Z,1467134366.526 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:27.326Z,1467134367.326 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:27.740Z,1467134367.740 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:28.164Z,1467134368.164 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:28.961Z,1467134368.961 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:29.394Z,1467134369.394 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:29.802Z,1467134369.802 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:30.596Z,1467134370.596 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:31.395Z,1467134371.395 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:31.810Z,1467134371.810 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:32.222Z,1467134372.222 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:33.017Z,1467134373.017 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:33.425Z,1467134373.425 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:33.840Z,1467134373.840 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:34.636Z,1467134374.636 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:35.306Z,1467134375.306 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:35.729Z,1467134375.729 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:36.524Z,1467134376.524 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:37.326Z,1467134377.326 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:37.738Z,1467134377.738 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:38.533Z,1467134378.533 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:39.330Z,1467134379.330 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:39.742Z,1467134379.742 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:40.152Z,1467134380.152 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:40.950Z,1467134380.950 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:41.363Z,1467134381.363 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:41.778Z,1467134381.778 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:42.572Z,1467134382.572 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:43.369Z,1467134383.369 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:43.802Z,1467134383.802 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:44.214Z,1467134384.214 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:45.009Z,1467134385.010 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:45.418Z,1467134385.418 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:45.829Z,1467134385.829 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:46.624Z,1467134386.624 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:47.295Z,1467134387.295 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:47.706Z,1467134387.706 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:48.502Z,1467134388.502 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:49.297Z,1467134389.297 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:49.718Z,1467134389.718 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:50.128Z,1467134390.128 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:50.926Z,1467134390.926 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:51.338Z,1467134391.338 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:51.749Z,1467134391.749 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:52.544Z,1467134392.544 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:53.342Z,1467134393.342 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:53.758Z,1467134393.758 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:54.176Z,1467134394.176 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:54.972Z,1467134394.972 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:55.766Z,1467134395.766 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:56.182Z,1467134396.182 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:56.978Z,1467134396.978 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:57.394Z,1467134397.394 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:57.805Z,1467134397.805 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:58.600Z,1467134398.600 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:59.306Z,1467134399.306 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:19:59.718Z,1467134399.718 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:20:00.512Z,1467134400.512 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:20:01.310Z,1467134401.309 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:20:01.721Z,1467134401.721 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:20:02.516Z,1467134402.516 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:20:03.314Z,1467134403.314 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:20:03.726Z,1467134403.726 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:20:04.520Z,1467134404.520 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:20:05.312Z,1467134405.312 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:20:05.734Z,1467134405.734 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:20:06.528Z,1467134406.528 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:20:07.326Z,1467134407.326 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:20:07.786Z,1467134407.786 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:20:08.206Z,1467134408.206 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:20:09.001Z,1467134409.001 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:20:09.413Z,1467134409.413 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:20:09.821Z,1467134409.821 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:20:10.624Z,1467134410.624 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:20:11.278Z,1467134411.278 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:20:11.698Z,1467134411.698 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:20:12.493Z,1467134412.493 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:20:13.250Z,1467134413.250 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:20:13.661Z,1467134413.661 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:20:14.468Z,1467134414.468 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:20:15.241Z,1467134415.241 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:20:15.654Z,1467134415.654 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:20:16.448Z,1467134416.448 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:20:17.246Z,1467134417.246 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:20:17.658Z,1467134417.658 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:20:33.981Z,1467134433.981 [BPC1](ERROR): Failed to receive battery data
2016-06-28T17:20:33.981Z,1467134433.981 [BPC1] Communications Fault, FailCount= 1
2016-06-28T17:20:33.981Z,1467134433.981 [BPC1](ERROR): Communications Fault
2016-06-28T17:20:34.140Z,1467134434.140 [CBIT](ERROR): Communications Fault in component: BPC1
2016-06-28T17:20:35.624Z,1467134435.624 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-28T17:20:35.624Z,1467134435.625 [BPC1] No Fault, FailCount= 1
2016-06-28T17:20:40.416Z,1467134440.416 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:20:41.214Z,1467134441.214 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:20:41.634Z,1467134441.634 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:20:43.640Z,1467134443.640 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:20:44.054Z,1467134444.054 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:20:44.464Z,1467134444.464 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:21:38.051Z,1467134498.051 [BPC1](ERROR): Failed to receive battery data
2016-06-28T17:21:38.052Z,1467134498.052 [BPC1] Communications Fault, FailCount= 1
2016-06-28T17:21:38.052Z,1467134498.052 [BPC1](ERROR): Communications Fault
2016-06-28T17:21:38.156Z,1467134498.156 [CBIT](ERROR): Communications Fault in component: BPC1
2016-06-28T17:21:39.653Z,1467134499.653 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-28T17:21:39.654Z,1467134499.654 [BPC1] No Fault, FailCount= 1
2016-06-28T17:21:40.146Z,1467134500.146 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-06-28T17:21:40.146Z,1467134500.146 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2016-06-28T17:21:40.146Z,1467134500.146 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-06-28T17:21:40.196Z,1467134500.196 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-06-28T17:21:40.580Z,1467134500.580 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-06-28T17:21:40.580Z,1467134500.580 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2016-06-28T17:21:41.230Z,1467134501.230 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-06-28T17:21:41.245Z,1467134501.245 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-06-28T17:21:41.246Z,1467134501.246 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-06-28T17:22:26.122Z,1467134546.122 [CBIT](DEBUG): EFC running - data check-sum false
2016-06-28T17:22:57.501Z,1467134577.501 [PNI_TCM](ERROR): CRC does not match. Expected:0x44133 got:0x1084
2016-06-28T17:22:58.196Z,1467134578.196 [PNI_TCM](ERROR): CRC does not match. Expected:0x4341 got:0x1109
2016-06-28T17:22:58.706Z,1467134578.706 [PNI_TCM](ERROR): CRC does not match. Expected:0x49842 got:0x1112
2016-06-28T17:22:58.720Z,1467134578.720 [PNI_TCM](ERROR): CRC does not match. Expected:0x41762 got:0x1078
2016-06-28T17:22:59.090Z,1467134579.090 [PNI_TCM](ERROR): CRC does not match. Expected:0x55387 got:0x1094
2016-06-28T17:22:59.562Z,1467134579.562 [PNI_TCM](ERROR): CRC does not match. Expected:0x60145 got:0x1100
2016-06-28T17:22:59.870Z,1467134579.870 [PNI_TCM](ERROR): CRC does not match. Expected:0x8799 got:0x1084
2016-06-28T17:23:00.239Z,1467134580.239 [PNI_TCM](ERROR): CRC does not match. Expected:0x4341 got:0x1057
2016-06-28T17:23:00.737Z,1467134580.737 [PNI_TCM](ERROR): CRC does not match. Expected:0x31467 got:0x1104
2016-06-28T17:23:01.220Z,1467134581.220 [PNI_TCM](ERROR): CRC does not match. Expected:0x42725 got:0x1137
2016-06-28T17:23:01.574Z,1467134581.574 [PNI_TCM](ERROR): CRC does not match. Expected:0x24413 got:0x1118
2016-06-28T17:23:01.883Z,1467134581.883 [PNI_TCM](ERROR): CRC does not match. Expected:0x58552 got:0x1147
2016-06-28T17:23:02.278Z,1467134582.279 [PNI_TCM](ERROR): CRC does not match. Expected:0x38899 got:0x1153
2016-06-28T17:23:02.279Z,1467134582.279 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-28T17:23:02.279Z,1467134582.279 [PNI_TCM] Data Fault, FailCount= 1
2016-06-28T17:23:02.279Z,1467134582.279 [PNI_TCM](ERROR): Data Fault
2016-06-28T17:23:02.335Z,1467134582.335 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.445600 seconds old.
2016-06-28T17:23:02.336Z,1467134582.336 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.446200 seconds old.
2016-06-28T17:23:02.359Z,1467134582.359 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-28T17:23:02.709Z,1467134582.709 [PNI_TCM](INFO): Powering down
2016-06-28T17:23:02.768Z,1467134582.768 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.874200 seconds old.
2016-06-28T17:23:02.776Z,1467134582.776 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.885900 seconds old.
2016-06-28T17:23:03.155Z,1467134583.155 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.265700 seconds old.
2016-06-28T17:23:03.162Z,1467134583.162 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.271500 seconds old.
2016-06-28T17:23:03.535Z,1467134583.535 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.645300 seconds old.
2016-06-28T17:23:03.547Z,1467134583.547 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.656300 seconds old.
2016-06-28T17:23:03.872Z,1467134583.872 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.982800 seconds old.
2016-06-28T17:23:03.873Z,1467134583.873 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.983300 seconds old.
2016-06-28T17:23:03.907Z,1467134583.907 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-28T17:23:03.908Z,1467134583.908 [PNI_TCM] No Fault, FailCount= 1
2016-06-28T17:23:04.277Z,1467134584.277 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.387700 seconds old.
2016-06-28T17:23:04.278Z,1467134584.278 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.388200 seconds old.
2016-06-28T17:23:04.752Z,1467134584.752 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.850200 seconds old.
2016-06-28T17:23:04.755Z,1467134584.755 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.864900 seconds old.
2016-06-28T17:23:05.179Z,1467134585.179 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.289800 seconds old.
2016-06-28T17:23:05.188Z,1467134585.188 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.297000 seconds old.
2016-06-28T17:23:05.643Z,1467134585.643 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.753300 seconds old.
2016-06-28T17:23:05.665Z,1467134585.665 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.775000 seconds old.
2016-06-28T17:23:05.891Z,1467134585.891 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.002200 seconds old.
2016-06-28T17:23:05.904Z,1467134585.904 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.014000 seconds old.
2016-06-28T17:23:06.300Z,1467134586.300 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.411100 seconds old.
2016-06-28T17:23:06.301Z,1467134586.302 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.411600 seconds old.
2016-06-28T17:23:06.676Z,1467134586.676 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.786400 seconds old.
2016-06-28T17:23:06.677Z,1467134586.677 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.787100 seconds old.
2016-06-28T17:23:07.141Z,1467134587.141 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.251100 seconds old.
2016-06-28T17:23:07.145Z,1467134587.145 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.254500 seconds old.
2016-06-28T17:23:36.714Z,1467134616.714 [BPC1](ERROR): Failed to receive battery data
2016-06-28T17:23:36.715Z,1467134616.714 [BPC1] Communications Fault, FailCount= 1
2016-06-28T17:23:36.715Z,1467134616.715 [BPC1](ERROR): Communications Fault
2016-06-28T17:23:36.845Z,1467134616.845 [CBIT](ERROR): Communications Fault in component: BPC1
2016-06-28T17:23:37.718Z,1467134617.718 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-28T17:23:37.718Z,1467134617.718 [BPC1] No Fault, FailCount= 1
2016-06-28T17:24:26.647Z,1467134666.647 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2016-06-28T17:24:26.648Z,1467134666.648 [Default:CheckIn:C.Wait] Stopped
2016-06-28T17:24:26.648Z,1467134666.648 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2016-06-28T17:24:26.649Z,1467134666.648 [Default:CheckIn:D] Running Loop=1
2016-06-28T17:24:27.080Z,1467134667.080 [Default:CheckIn:D] Stopped
2016-06-28T17:24:27.080Z,1467134667.080 [Default:CheckIn:E] Running Loop=1
2016-06-28T17:24:27.425Z,1467134667.425 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 18.765332 min 
2016-06-28T17:24:27.426Z,1467134667.426 [Default:CheckIn:E] Stopped
2016-06-28T17:24:27.426Z,1467134667.426 [Default:CheckIn](INFO): Completed Default:CheckIn
2016-06-28T17:24:27.426Z,1467134667.426 [Default:CheckIn] Stopped
2016-06-28T17:24:27.427Z,1467134667.427 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2016-06-28T17:24:27.432Z,1467134667.432 [Default:CheckIn](INFO): Running loop #3
2016-06-28T17:24:27.432Z,1467134667.432 [Default:CheckIn] Running Loop=3
2016-06-28T17:24:27.433Z,1467134667.432 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2016-06-28T17:24:27.433Z,1467134667.433 [Default:CheckIn:Read_GPS] Running Loop=1
2016-06-28T17:24:33.364Z,1467134673.364 [NAL9602](INFO): Powering up
2016-06-28T17:24:41.307Z,1467134681.307 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-06-28T17:24:41.307Z,1467134681.307 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2016-06-28T17:24:41.308Z,1467134681.307 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-06-28T17:24:41.390Z,1467134681.390 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-06-28T17:24:41.701Z,1467134681.701 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-06-28T17:24:41.701Z,1467134681.701 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2016-06-28T17:24:42.018Z,1467134682.018 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-06-28T17:24:42.019Z,1467134682.019 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-06-28T17:24:42.019Z,1467134682.019 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-06-28T17:24:44.395Z,1467134684.395 [NAL9602](INFO): NAL9602 initialized
2016-06-28T17:24:45.199Z,1467134685.199 [NAL9602](FAULT): GPS failed to acquire within timeout.
2016-06-28T17:24:45.200Z,1467134685.200 [NAL9602] Data Fault, FailCount= 1
2016-06-28T17:24:45.200Z,1467134685.200 [NAL9602](ERROR): Data Fault
2016-06-28T17:24:45.415Z,1467134685.415 [CBIT](ERROR): Data Fault in component: NAL9602
2016-06-28T17:24:45.597Z,1467134685.597 [NAL9602](INFO): Powering down
2016-06-28T17:24:46.644Z,1467134686.644 [CBIT](INFO): Clearing failed state for component NAL9602
2016-06-28T17:24:46.644Z,1467134686.644 [NAL9602] No Fault, FailCount= 1
2016-06-28T17:24:50.794Z,1467134690.794 [NAL9602](INFO): Powering up NAL9602
2016-06-28T17:24:53.306Z,1467134693.306 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:24:54.100Z,1467134694.100 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:25:01.696Z,1467134701.696 [NAL9602](INFO): NAL9602 initialized
2016-06-28T17:25:31.190Z,1467134731.190 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:25:31.602Z,1467134731.602 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:25:32.012Z,1467134732.012 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:25:36.152Z,1467134736.152 [BPC1](ERROR): Failed to receive battery data
2016-06-28T17:25:36.152Z,1467134736.152 [BPC1] Communications Fault, FailCount= 1
2016-06-28T17:25:36.152Z,1467134736.152 [BPC1](ERROR): Communications Fault
2016-06-28T17:25:36.175Z,1467134736.175 [CBIT](ERROR): Communications Fault in component: BPC1
2016-06-28T17:25:37.290Z,1467134737.290 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-28T17:25:37.290Z,1467134737.290 [BPC1] No Fault, FailCount= 1
2016-06-28T17:25:43.174Z,1467134743.174 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:25:43.586Z,1467134743.586 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:25:43.996Z,1467134743.996 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:25:55.166Z,1467134755.166 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:25:55.577Z,1467134755.578 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:25:55.988Z,1467134755.988 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-28T17:27:36.831Z,1467134856.831 [BPC1](ERROR): Failed to receive battery data
2016-06-28T17:27:36.888Z,1467134856.888 [BPC1] Communications Fault, FailCount= 1
2016-06-28T17:27:36.888Z,1467134856.888 [BPC1](ERROR): Communications Fault
2016-06-28T17:27:37.154Z,1467134857.154 [CBIT](ERROR): Communications Fault in component: BPC1
2016-06-28T17:27:37.976Z,1467134857.976 [DataOverHttps](IMPORTANT): SBD MTMSN=20160628T172709
2016-06-28T17:27:38.057Z,1467134858.057 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-28T17:27:38.057Z,1467134858.057 [BPC1] No Fault, FailCount= 1
2016-06-28T17:27:43.822Z,1467134863.822 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-06-28T17:27:43.822Z,1467134863.822 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2016-06-28T17:27:43.822Z,1467134863.822 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-06-28T17:27:43.874Z,1467134863.875 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-06-28T17:27:43.967Z,1467134863.967 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-06-28T17:27:43.968Z,1467134863.968 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8