2016-06-29T17:15:42.918Z,1467220542.918 [Supervisor](DEBUG): Initializing supervisor.
2016-06-29T17:15:42.921Z,1467220542.921 [SyncHandler](DEBUG): Created PCaller Thread at 4051A4E0
2016-06-29T17:15:42.922Z,1467220542.922 [SyncHandler](INFO): Protected caller Thread ID is 768
2016-06-29T17:15:42.922Z,1467220542.922 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2016-06-29T17:15:42.923Z,1467220542.923 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4054A4E0
2016-06-29T17:15:42.924Z,1467220542.924 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 769
2016-06-29T17:15:42.926Z,1467220542.926 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2016-06-29T17:15:42.938Z,1467220542.938 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2016-06-29T17:15:42.939Z,1467220542.939 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 4057A4E0
2016-06-29T17:15:42.939Z,1467220542.939 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 770
2016-06-29T17:15:42.940Z,1467220542.940 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2016-06-29T17:15:42.941Z,1467220542.941 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405AA4E0
2016-06-29T17:15:42.941Z,1467220542.941 [logger ThreadHandler](INFO): Protected caller Thread ID is 771
2016-06-29T17:15:42.943Z,1467220542.943 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2016-06-29T17:15:42.944Z,1467220542.944 [Supervisor](INFO): Looking for Config files in directory: Config/
2016-06-29T17:15:42.949Z,1467220542.949 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2016-06-29T17:15:43.034Z,1467220543.034 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2016-06-29T17:15:43.344Z,1467220543.344 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2016-06-29T17:15:43.345Z,1467220543.345 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2016-06-29T17:15:43.466Z,1467220543.466 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2016-06-29T17:15:43.467Z,1467220543.467 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2016-06-29T17:15:43.647Z,1467220543.647 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2016-06-29T17:15:43.649Z,1467220543.649 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2016-06-29T17:15:43.749Z,1467220543.749 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2016-06-29T17:15:43.750Z,1467220543.750 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2016-06-29T17:15:43.920Z,1467220543.920 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2016-06-29T17:15:43.922Z,1467220543.922 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2016-06-29T17:15:44.371Z,1467220544.371 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2016-06-29T17:15:44.372Z,1467220544.372 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2016-06-29T17:15:44.640Z,1467220544.640 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2016-06-29T17:15:44.641Z,1467220544.641 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2016-06-29T17:15:44.726Z,1467220544.726 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2016-06-29T17:15:44.729Z,1467220544.728 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2016-06-29T17:15:44.857Z,1467220544.857 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2016-06-29T17:15:44.858Z,1467220544.858 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2016-06-29T17:15:45.045Z,1467220545.045 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2016-06-29T17:15:45.046Z,1467220545.046 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2016-06-29T17:15:45.452Z,1467220545.453 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2016-06-29T17:15:45.453Z,1467220545.453 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2016-06-29T17:15:45.798Z,1467220545.798 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2016-06-29T17:15:45.799Z,1467220545.799 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2016-06-29T17:15:51.322Z,1467220551.322 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2016-06-29T17:15:51.323Z,1467220551.323 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2016-06-29T17:15:51.432Z,1467220551.432 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2016-06-29T17:15:51.434Z,1467220551.434 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/
2016-06-29T17:15:51.438Z,1467220551.438 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Control.cfg
2016-06-29T17:15:51.536Z,1467220551.536 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Navigation.cfg
2016-06-29T17:15:51.631Z,1467220551.631 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/secure.cfg
2016-06-29T17:15:51.719Z,1467220551.719 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/BIT.cfg
2016-06-29T17:15:51.819Z,1467220551.819 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Simulator.cfg
2016-06-29T17:15:51.954Z,1467220551.954 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Science.cfg
2016-06-29T17:15:52.094Z,1467220552.095 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/logger.cfg
2016-06-29T17:15:52.193Z,1467220552.193 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/vehicle.cfg
2016-06-29T17:15:52.353Z,1467220552.353 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Battery.cfg
2016-06-29T17:15:52.580Z,1467220552.580 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2016-06-29T17:15:52.581Z,1467220552.581 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Sensor.cfg
2016-06-29T17:15:52.750Z,1467220552.750 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Servo.cfg
2016-06-29T17:15:52.853Z,1467220552.853 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2016-06-29T17:15:52.857Z,1467220552.856 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2016-06-29T17:15:52.897Z,1467220552.897 [DepthRateCalculator] Loaded
2016-06-29T17:15:52.897Z,1467220552.897 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2016-06-29T17:15:52.904Z,1467220552.904 [PitchRateCalculator] Loaded
2016-06-29T17:15:52.904Z,1467220552.904 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2016-06-29T17:15:52.916Z,1467220552.916 [SpeedCalculator] Loaded
2016-06-29T17:15:52.916Z,1467220552.916 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2016-06-29T17:15:52.932Z,1467220552.932 [TempGradientCalculator] Loaded
2016-06-29T17:15:52.932Z,1467220552.932 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2016-06-29T17:15:52.948Z,1467220552.948 [VerticalTemperatureHomogeneityIndexCalculator] Loaded
2016-06-29T17:15:52.948Z,1467220552.948 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread.
2016-06-29T17:15:52.955Z,1467220552.954 [YawRateCalculator] Loaded
2016-06-29T17:15:52.955Z,1467220552.955 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2016-06-29T17:15:52.955Z,1467220552.955 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2016-06-29T17:15:52.956Z,1467220552.956 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2016-06-29T17:15:53.077Z,1467220553.077 [DeadReckonUsingMultipleVelocitySources] Loaded
2016-06-29T17:15:53.077Z,1467220553.077 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2016-06-29T17:15:53.131Z,1467220553.131 [DeadReckonUsingSpeedCalculator] Loaded
2016-06-29T17:15:53.132Z,1467220553.132 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2016-06-29T17:15:53.149Z,1467220553.149 [NavChart] Loaded
2016-06-29T17:15:53.149Z,1467220553.149 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2016-06-29T17:15:53.153Z,1467220553.153 [UniversalFixResidualReporter] Loaded
2016-06-29T17:15:53.154Z,1467220553.154 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2016-06-29T17:15:53.154Z,1467220553.154 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2016-06-29T17:15:53.155Z,1467220553.155 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2016-06-29T17:15:53.292Z,1467220553.292 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2016-06-29T17:15:53.293Z,1467220553.293 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2016-06-29T17:15:53.333Z,1467220553.333 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2016-06-29T17:15:53.334Z,1467220553.334 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2016-06-29T17:15:53.343Z,1467220553.343 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2016-06-29T17:15:53.344Z,1467220553.344 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2016-06-29T17:15:53.615Z,1467220553.615 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2016-06-29T17:15:53.616Z,1467220553.616 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2016-06-29T17:15:53.763Z,1467220553.763 [SBIT](DEBUG): Construct Startup Built In Test.
2016-06-29T17:15:53.794Z,1467220553.794 [SBIT] Loaded
2016-06-29T17:15:53.795Z,1467220553.795 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2016-06-29T17:15:53.795Z,1467220553.795 [IBIT](DEBUG): Construct Initiated Built In Test.
2016-06-29T17:15:53.823Z,1467220553.823 [IBIT] Loaded
2016-06-29T17:15:53.824Z,1467220553.824 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2016-06-29T17:15:53.827Z,1467220553.828 [CBIT](DEBUG): Construct Continuous Built In Test.
2016-06-29T17:15:53.979Z,1467220553.979 [CBIT] Loaded
2016-06-29T17:15:53.979Z,1467220553.979 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2016-06-29T17:15:53.980Z,1467220553.980 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2016-06-29T17:15:53.980Z,1467220553.980 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2016-06-29T17:15:54.598Z,1467220554.598 [DataOverHttps] Loaded
2016-06-29T17:15:54.598Z,1467220554.598 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2016-06-29T17:15:54.622Z,1467220554.622 [Depth_Keller] Loaded
2016-06-29T17:15:54.623Z,1467220554.623 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2016-06-29T17:15:54.715Z,1467220554.714 [NAL9602] Loaded
2016-06-29T17:15:54.715Z,1467220554.715 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2016-06-29T17:15:54.725Z,1467220554.725 [Onboard] Loaded
2016-06-29T17:15:54.725Z,1467220554.725 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2016-06-29T17:15:54.733Z,1467220554.733 [Radio_Surface] Loaded
2016-06-29T17:15:54.733Z,1467220554.733 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2016-06-29T17:15:54.734Z,1467220554.734 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409234E0
2016-06-29T17:15:54.734Z,1467220554.734 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 851
2016-06-29T17:15:54.928Z,1467220554.928 [PNI_TCM] Loaded
2016-06-29T17:15:54.929Z,1467220554.929 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread.
2016-06-29T17:15:55.288Z,1467220555.288 [Rowe_600LCM] Loaded
2016-06-29T17:15:55.288Z,1467220555.288 [ComponentRegistry](DEBUG): Component "Rowe_600LCM" handled in its own thread.
2016-06-29T17:15:55.289Z,1467220555.289 [Rowe_600LCM ThreadHandler](DEBUG): Created PCaller Thread at 409534E0
2016-06-29T17:15:55.290Z,1467220555.290 [Rowe_600LCM ThreadHandler](INFO): Protected caller Thread ID is 852
2016-06-29T17:15:57.106Z,1467220557.106 [BPC1] Loaded
2016-06-29T17:15:57.106Z,1467220557.106 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2016-06-29T17:15:57.106Z,1467220557.106 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2016-06-29T17:15:57.107Z,1467220557.107 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2016-06-29T17:16:03.037Z,1467220563.037 [BuoyancyServo] Loaded
2016-06-29T17:16:03.037Z,1467220563.037 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2016-06-29T17:16:03.054Z,1467220563.054 [ElevatorServo] Loaded
2016-06-29T17:16:03.054Z,1467220563.054 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2016-06-29T17:16:03.070Z,1467220563.070 [MassServo] Loaded
2016-06-29T17:16:03.070Z,1467220563.070 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2016-06-29T17:16:03.086Z,1467220563.086 [RudderServo] Loaded
2016-06-29T17:16:03.086Z,1467220563.086 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2016-06-29T17:16:03.102Z,1467220563.102 [ThrusterServo] Loaded
2016-06-29T17:16:03.102Z,1467220563.102 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2016-06-29T17:16:03.102Z,1467220563.102 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2016-06-29T17:16:03.103Z,1467220563.103 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2016-06-29T17:16:03.172Z,1467220563.172 [VerticalControl](DEBUG): Construct VerticalControl.
2016-06-29T17:16:03.265Z,1467220563.265 [VerticalControl] Loaded
2016-06-29T17:16:03.266Z,1467220563.266 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2016-06-29T17:16:03.266Z,1467220563.266 [HorizontalControl](DEBUG): Construct HorizontalControl.
2016-06-29T17:16:03.327Z,1467220563.327 [HorizontalControl] Loaded
2016-06-29T17:16:03.327Z,1467220563.328 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2016-06-29T17:16:03.328Z,1467220563.328 [SpeedControl](DEBUG): Construct SpeedControl.
2016-06-29T17:16:03.330Z,1467220563.330 [SpeedControl] Loaded
2016-06-29T17:16:03.331Z,1467220563.330 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2016-06-29T17:16:03.331Z,1467220563.331 [LoopControl](DEBUG): Construct LoopControl.
2016-06-29T17:16:03.332Z,1467220563.332 [LoopControl] Loaded
2016-06-29T17:16:03.332Z,1467220563.332 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2016-06-29T17:16:03.332Z,1467220563.332 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2016-06-29T17:16:03.333Z,1467220563.333 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2016-06-29T17:16:03.449Z,1467220563.449 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC
2016-06-29T17:16:03.449Z,1467220563.449 [StratificationFrontDetector](DEBUG): (re)initializing
2016-06-29T17:16:03.449Z,1467220563.449 [StratificationFrontDetector] Loaded
2016-06-29T17:16:03.450Z,1467220563.450 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread.
2016-06-29T17:16:03.450Z,1467220563.450 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2016-06-29T17:16:03.451Z,1467220563.451 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2016-06-29T17:16:03.581Z,1467220563.581 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2016-06-29T17:16:03.585Z,1467220563.585 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2016-06-29T17:16:03.586Z,1467220563.586 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2016-06-29T17:16:03.593Z,1467220563.593 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2016-06-29T17:16:03.594Z,1467220563.594 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A5D4E0
2016-06-29T17:16:03.595Z,1467220563.595 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 853
2016-06-29T17:16:03.599Z,1467220563.599 [Supervisor](INFO): Main Thread ID is 764
2016-06-29T17:16:03.600Z,1467220563.599 [Supervisor](DEBUG): Running supervisor.
2016-06-29T17:16:03.600Z,1467220563.600 [CommandLine ThreadHandler](INFO): Handler Thread ID is 854
2016-06-29T17:16:03.603Z,1467220563.603 [controlThread ThreadHandler](INFO): Handler Thread ID is 855
2016-06-29T17:16:03.604Z,1467220563.603 [controlThread](DEBUG): Initializing ControlThread
2016-06-29T17:16:03.604Z,1467220563.604 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2016-06-29T17:16:03.605Z,1467220563.605 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2016-06-29T17:16:03.605Z,1467220563.605 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2016-06-29T17:16:03.605Z,1467220563.605 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2016-06-29T17:16:03.606Z,1467220563.606 [VerticalTemperatureHomogeneityIndexCalculator](DEBUG): (re)initializing
2016-06-29T17:16:03.607Z,1467220563.607 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2016-06-29T17:16:03.607Z,1467220563.607 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-06-29T17:16:03.608Z,1467220563.608 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-06-29T17:16:03.608Z,1467220563.608 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-06-29T17:16:03.609Z,1467220563.609 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2016-06-29T17:16:03.609Z,1467220563.609 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2016-06-29T17:16:03.610Z,1467220563.610 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2016-06-29T17:16:03.610Z,1467220563.610 [NavChart](DEBUG): Initialize NavChart Navigation.
2016-06-29T17:16:03.610Z,1467220563.610 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2016-06-29T17:16:03.611Z,1467220563.611 [SBIT](INFO): Initialize SBIT Component.
2016-06-29T17:16:03.611Z,1467220563.611 [SBIT](IMPORTANT): git: 2015-12-17-108-g5bef090
2016-06-29T17:16:03.611Z,1467220563.611 [SBIT](INFO): git hash: 5bef0906e748577e5d4ac431bf22a986aa172b48
2016-06-29T17:16:03.613Z,1467220563.613 [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-29T17:16:03.613Z,1467220563.613 [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-29T17:16:03.614Z,1467220563.614 [SBIT](INFO): Beginning SBIT in 20.000000 seconds.
2016-06-29T17:16:03.615Z,1467220563.615 [IBIT](INFO): Initialize IBIT Component.
2016-06-29T17:16:03.616Z,1467220563.616 [CBIT](DEBUG): Initialize CBIT Component.
2016-06-29T17:16:03.616Z,1467220563.616 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL.
2016-06-29T17:16:03.616Z,1467220563.616 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2016-06-29T17:16:03.617Z,1467220563.617 [logger ThreadHandler](INFO): Handler Thread ID is 856
2016-06-29T17:16:03.644Z,1467220563.644 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 857
2016-06-29T17:16:03.650Z,1467220563.650 [Radio_Surface](INFO): Powering up
2016-06-29T17:16:03.668Z,1467220563.668 [Rowe_600LCM ThreadHandler](INFO): Handler Thread ID is 858
2016-06-29T17:16:03.668Z,1467220563.668 [Rowe_600LCM](INFO): Initializing
2016-06-29T17:16:03.669Z,1467220563.669 [Rowe_600LCM](INFO): Checking LCM
2016-06-29T17:16:03.669Z,1467220563.669 [Rowe_600LCM](INFO): LCM OK
2016-06-29T17:16:03.669Z,1467220563.669 [Rowe_600LCM](INFO): Powering up
2016-06-29T17:16:03.688Z,1467220563.688 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 859
2016-06-29T17:16:03.699Z,1467220563.699 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources/ElectronicNavigationCharts
2016-06-29T17:16:03.706Z,1467220563.706 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2016-06-29T17:16:03.708Z,1467220563.708 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2016-06-29T17:16:03.709Z,1467220563.709 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2016-06-29T17:16:03.709Z,1467220563.709 [LoopControl](DEBUG): Initialize LoopControlComponent.
2016-06-29T17:16:03.710Z,1467220563.710 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2016-06-29T17:16:03.737Z,1467220563.737 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2016-06-29T17:16:03.738Z,1467220563.738 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2MI01M.000
2016-06-29T17:16:03.738Z,1467220563.738 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2MI80M.000
2016-06-29T17:16:03.738Z,1467220563.738 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2016-06-29T17:16:03.738Z,1467220563.738 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2016-06-29T17:16:03.739Z,1467220563.739 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2016-06-29T17:16:03.739Z,1467220563.739 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4IN01M.000
2016-06-29T17:16:03.739Z,1467220563.739 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI56M.000
2016-06-29T17:16:03.740Z,1467220563.740 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI57M.000
2016-06-29T17:16:03.740Z,1467220563.740 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI59M.000
2016-06-29T17:16:03.740Z,1467220563.740 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI89M.000
2016-06-29T17:16:03.740Z,1467220563.740 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI90M.000
2016-06-29T17:16:03.741Z,1467220563.741 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4WI03M.000
2016-06-29T17:16:03.741Z,1467220563.741 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4WI06M.000
2016-06-29T17:16:03.741Z,1467220563.741 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4WI33M.000
2016-06-29T17:16:03.741Z,1467220563.741 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4WI34M.000
2016-06-29T17:16:03.742Z,1467220563.741 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2016-06-29T17:16:03.742Z,1467220563.742 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2016-06-29T17:16:03.742Z,1467220563.742 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2016-06-29T17:16:03.742Z,1467220563.742 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2016-06-29T17:16:03.780Z,1467220563.780 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2016-06-29T17:16:03.814Z,1467220563.814 [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-29T17:16:03.815Z,1467220563.815 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2016-06-29T17:16:03.908Z,1467220563.908 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2016-06-29T17:16:03.909Z,1467220563.909 [Default:A.Wait](DEBUG): Construct Wait.
2016-06-29T17:16:03.911Z,1467220563.911 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2016-06-29T17:16:03.929Z,1467220563.929 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2016-06-29T17:16:03.956Z,1467220563.956 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2016-06-29T17:16:03.962Z,1467220563.962 [Default:E.Execute](DEBUG): Construct Execute.
2016-06-29T17:16:03.981Z,1467220563.981 [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-29T17:16:03.986Z,1467220563.986 [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-29T17:16:04.058Z,1467220564.058 [Depth_Keller](ERROR): Pressure reading out of range: 1895.584351 decibar
2016-06-29T17:16:04.088Z,1467220564.088 [NAL9602](INFO): Powering up NAL9602
2016-06-29T17:16:04.242Z,1467220564.241 [DepthRateCalculator](ERROR): Depth measurement is not active
2016-06-29T17:16:04.332Z,1467220564.332 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-06-29T17:16:04.551Z,1467220564.551 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-06-29T17:16:04.647Z,1467220564.648 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2016-06-29T17:16:04.651Z,1467220564.651 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2016-06-29T17:16:04.678Z,1467220564.678 [ElevatorServo](DEBUG): Initializing EZServoServo.
2016-06-29T17:16:04.683Z,1467220564.684 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2016-06-29T17:16:04.697Z,1467220564.697 [MassServo](DEBUG): Initializing EZServoServo.
2016-06-29T17:16:04.703Z,1467220564.703 [MassServo](DEBUG): Initializing MassServo.
2016-06-29T17:16:04.709Z,1467220564.709 [RudderServo](DEBUG): Initializing EZServoServo.
2016-06-29T17:16:04.715Z,1467220564.716 [RudderServo](DEBUG): Initializing RudderServo.
2016-06-29T17:16:04.740Z,1467220564.740 [ThrusterServo](DEBUG): Initializing EZServoServo.
2016-06-29T17:16:04.748Z,1467220564.747 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2016-06-29T17:16:05.074Z,1467220565.074 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-06-29T17:16:05.075Z,1467220565.076 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-06-29T17:16:05.277Z,1467220565.277 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-06-29T17:16:05.278Z,1467220565.278 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-06-29T17:16:05.611Z,1467220565.611 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2016-06-29T17:16:05.611Z,1467220565.611 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2016-06-29T17:16:05.611Z,1467220565.611 [BuoyancyServo] Communications Fault, FailCount= 1
2016-06-29T17:16:05.612Z,1467220565.612 [BuoyancyServo](ERROR): Communications Fault
2016-06-29T17:16:05.823Z,1467220565.823 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2016-06-29T17:16:05.876Z,1467220565.876 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-06-29T17:16:05.877Z,1467220565.877 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-06-29T17:16:05.899Z,1467220565.899 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2016-06-29T17:16:05.900Z,1467220565.900 [BuoyancyServo](INFO): Powering down
2016-06-29T17:16:06.275Z,1467220566.275 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-06-29T17:16:06.276Z,1467220566.276 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-06-29T17:16:06.659Z,1467220566.659 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-06-29T17:16:06.660Z,1467220566.660 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-06-29T17:16:07.059Z,1467220567.059 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-06-29T17:16:07.060Z,1467220567.060 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-06-29T17:16:07.472Z,1467220567.472 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-06-29T17:16:07.473Z,1467220567.473 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-06-29T17:16:08.049Z,1467220568.049 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2016-06-29T17:16:08.162Z,1467220568.162 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:./bin/roweadcp -dev /dev/ttyB4 -b 38400 >& /dev/null &
2016-06-29T17:16:08.463Z,1467220568.463 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2016-06-29T17:16:08.463Z,1467220568.464 [BuoyancyServo] No Fault, FailCount= 1
2016-06-29T17:16:08.773Z,1467220568.773 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2016-06-29T17:16:08.773Z,1467220568.773 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2016-06-29T17:16:09.018Z,1467220569.017 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2016-06-29T17:16:09.019Z,1467220569.019 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2016-06-29T17:16:15.047Z,1467220575.046 [NAL9602](INFO): NAL9602 initialized
2016-06-29T17:16:24.143Z,1467220584.143 [SBIT](IMPORTANT): Beginning Startup BIT
2016-06-29T17:16:24.163Z,1467220584.163 [CBIT](IMPORTANT): Beginning GF scan
2016-06-29T17:16:24.712Z,1467220584.712 [CBIT](IMPORTANT): Open Volts:2.500758
Open Current:0.000774
2016-06-29T17:16:26.664Z,1467220586.664 [CBIT](IMPORTANT): A0 Volts:2.664261
A0 Current:0.104256
2016-06-29T17:16:28.248Z,1467220588.247 [CBIT](IMPORTANT): A1 Volts:2.036791
A1 Current:-0.294255
2016-06-29T17:16:29.617Z,1467220589.617 [CBIT](IMPORTANT): A2 Volts:2.664394
A2 Current:0.104792
2016-06-29T17:16:31.477Z,1467220591.477 [CBIT](IMPORTANT): A3 Volts:2.621074
A3 Current:0.076982
2016-06-29T17:16:31.933Z,1467220591.934 [NAL9602](INFO): SBD MO Status=0, MOMSN=808, MT Status=0, MTMSN=0
2016-06-29T17:16:31.934Z,1467220591.934 [NAL9602](INFO): No messages in MT queue
2016-06-29T17:16:33.015Z,1467220593.015 [CBIT](IMPORTANT): B0 Volts:2.389326
B0 Current:-0.070031
2016-06-29T17:16:34.292Z,1467220594.292 [CBIT](IMPORTANT): B1 Volts:2.280476
B1 Current:-0.138884
2016-06-29T17:16:35.557Z,1467220595.556 [CBIT](IMPORTANT): B2 Volts:2.277281
B2 Current:-0.140625
2016-06-29T17:16:37.123Z,1467220597.124 [CBIT](IMPORTANT): B3 Volts:1.754603
B3 Current:-0.473276
2016-06-29T17:16:37.298Z,1467220597.297 [CBIT](FAULT): Low side GF detected
mA:
CHAN A0 (Batt): 0.104256
CHAN A1 (24V): -0.294255
CHAN A2 (12V): 0.104792
CHAN A3 (5V): 0.076982
CHAN B0 (3.3V): -0.070031
CHAN B1 (3.15aV): -0.138884
CHAN B2 (3.15bV): -0.140625
CHAN B3 (GND): -0.473276
OPEN: 0.000774
Full Scale Calc: 4.765 mA, -1.589 mA
2016-06-29T17:16:41.320Z,1467220601.320 [NAL9602](INFO): GPS fix at 20160629T171601: (36.802561, -121.786967)
2016-06-29T17:16:41.955Z,1467220601.955 [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-29T17:16:41.955Z,1467220601.955 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2016-06-29T17:16:41.955Z,1467220601.955 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-06-29T17:16:42.077Z,1467220602.077 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-06-29T17:16:42.296Z,1467220602.296 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-06-29T17:16:42.296Z,1467220602.296 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2016-06-29T17:16:42.595Z,1467220602.595 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-06-29T17:16:42.596Z,1467220602.596 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-06-29T17:16:42.596Z,1467220602.596 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-06-29T17:16:49.196Z,1467220609.196 [NAL9602](INFO): Powering down
2016-06-29T17:16:49.660Z,1467220609.660 [BPC1](ERROR): Failed to receive battery data
2016-06-29T17:16:49.660Z,1467220609.660 [BPC1] Communications Fault, FailCount= 1
2016-06-29T17:16:49.661Z,1467220609.661 [BPC1](ERROR): Communications Fault
2016-06-29T17:16:49.907Z,1467220609.907 [CBIT](ERROR): Communications Fault in component: BPC1
2016-06-29T17:16:51.044Z,1467220611.044 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-29T17:16:51.044Z,1467220611.044 [BPC1] No Fault, FailCount= 1
2016-06-29T17:17:17.851Z,1467220637.851 [SBIT](IMPORTANT): SBIT PASSED
2016-06-29T17:17:18.052Z,1467220638.052 [MissionManager](IMPORTANT): Started mission Startup
2016-06-29T17:17:18.052Z,1467220638.052 [Startup] Running Loop=1
2016-06-29T17:17:18.052Z,1467220638.053 [Startup](DEBUG): Aggregate::initialize Startup
2016-06-29T17:17:18.053Z,1467220638.053 [Startup:A.GoToSurface] Running Loop=1
2016-06-29T17:17:18.053Z,1467220638.053 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2016-06-29T17:17:18.053Z,1467220638.053 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2016-06-29T17:17:18.054Z,1467220638.054 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2016-06-29T17:17:18.054Z,1467220638.054 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2016-06-29T17:17:18.054Z,1467220638.055 [Startup:A.GoToSurface](DEBUG): No pitch timeout specified. Using default value of 20.000000 seconds.
2016-06-29T17:17:18.055Z,1467220638.055 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2016-06-29T17:17:18.069Z,1467220638.069 [Startup:StartupSatComms] Running Loop=1
2016-06-29T17:17:18.069Z,1467220638.069 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2016-06-29T17:17:18.069Z,1467220638.069 [Startup:StartupSatComms:A] Running Loop=1
2016-06-29T17:17:18.436Z,1467220638.436 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2016-06-29T17:17:18.802Z,1467220638.802 [NAL9602](INFO): Powering up
2016-06-29T17:17:29.649Z,1467220649.649 [NAL9602](INFO): NAL9602 initialized
2016-06-29T17:17:38.076Z,1467220658.076 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:17:38.457Z,1467220658.457 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:17:38.886Z,1467220658.886 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:17:40.450Z,1467220660.450 [NAL9602](INFO): SBD MO Status=0, MOMSN=809, MT Status=0, MTMSN=0
2016-06-29T17:17:40.450Z,1467220660.450 [NAL9602](INFO): No messages in MT queue
2016-06-29T17:17:50.338Z,1467220670.338 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:17:50.704Z,1467220670.704 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:17:51.106Z,1467220671.106 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:17:51.520Z,1467220671.520 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:17:51.889Z,1467220671.889 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:17:52.290Z,1467220672.290 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:17:52.688Z,1467220672.688 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:17:53.124Z,1467220673.124 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:17:53.549Z,1467220673.549 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:17:53.900Z,1467220673.901 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:17:54.294Z,1467220674.294 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:17:54.696Z,1467220674.696 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:17:55.120Z,1467220675.120 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:17:55.513Z,1467220675.513 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:17:55.900Z,1467220675.900 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:17:56.304Z,1467220676.304 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:17:56.700Z,1467220676.700 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:17:57.112Z,1467220677.112 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:17:57.546Z,1467220677.546 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:17:57.894Z,1467220677.894 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:17:58.304Z,1467220678.304 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:18:11.422Z,1467220691.422 [PNI_TCM](ERROR): CRC does not match. Expected:0x63062 got:0x14966
2016-06-29T17:18:11.851Z,1467220691.851 [PNI_TCM](ERROR): CRC does not match. Expected:0x21674 got:0x14960
2016-06-29T17:18:12.494Z,1467220692.494 [PNI_TCM](ERROR): CRC does not match. Expected:0x4912 got:0x14959
2016-06-29T17:18:12.899Z,1467220692.899 [PNI_TCM](ERROR): CRC does not match. Expected:0x46151 got:0x14992
2016-06-29T17:18:13.408Z,1467220693.408 [PNI_TCM](ERROR): CRC does not match. Expected:0x30308 got:0x15001
2016-06-29T17:18:13.410Z,1467220693.411 [PNI_TCM](ERROR): CRC does not match. Expected:0x40199 got:0x14936
2016-06-29T17:18:13.834Z,1467220693.834 [PNI_TCM](ERROR): CRC does not match. Expected:0x491 got:0x14924
2016-06-29T17:18:14.213Z,1467220694.213 [PNI_TCM](ERROR): CRC does not match. Expected:0x32918 got:0x14982
2016-06-29T17:18:14.546Z,1467220694.546 [PNI_TCM](ERROR): CRC does not match. Expected:0x14960 got:0x15003
2016-06-29T17:18:15.026Z,1467220695.026 [PNI_TCM](ERROR): CRC does not match. Expected:0x20590 got:0x14948
2016-06-29T17:18:15.621Z,1467220695.621 [PNI_TCM](ERROR): CRC does not match. Expected:0x37453 got:0x14912
2016-06-29T17:18:15.873Z,1467220695.873 [PNI_TCM](ERROR): CRC does not match. Expected:0x4002 got:0x14980
2016-06-29T17:18:16.267Z,1467220696.267 [PNI_TCM](ERROR): CRC does not match. Expected:0x63257 got:0x15012
2016-06-29T17:18:16.268Z,1467220696.267 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-29T17:18:16.268Z,1467220696.268 [PNI_TCM] Data Fault, FailCount= 1
2016-06-29T17:18:16.268Z,1467220696.268 [PNI_TCM](ERROR): Data Fault
2016-06-29T17:18:16.287Z,1467220696.287 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.366700 seconds old.
2016-06-29T17:18:16.288Z,1467220696.288 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.367200 seconds old.
2016-06-29T17:18:16.348Z,1467220696.348 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-29T17:18:16.656Z,1467220696.656 [PNI_TCM](INFO): Powering down
2016-06-29T17:18:16.688Z,1467220696.688 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.767300 seconds old.
2016-06-29T17:18:16.696Z,1467220696.696 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.770000 seconds old.
2016-06-29T17:18:17.086Z,1467220697.086 [PNI_TCM](FAULT): LCB fault:  Software Overcurrent.
2016-06-29T17:18:17.086Z,1467220697.086 [PNI_TCM] Hardware Fault, FailCount= 1
2016-06-29T17:18:17.087Z,1467220697.087 [PNI_TCM](ERROR): Hardware Fault
2016-06-29T17:18:17.164Z,1467220697.164 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.233800 seconds old.
2016-06-29T17:18:17.176Z,1467220697.176 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.254700 seconds old.
2016-06-29T17:18:17.487Z,1467220697.487 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.566400 seconds old.
2016-06-29T17:18:17.498Z,1467220697.498 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.576200 seconds old.
2016-06-29T17:18:17.856Z,1467220697.856 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.936100 seconds old.
2016-06-29T17:18:17.858Z,1467220697.858 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.936600 seconds old.
2016-06-29T17:18:17.903Z,1467220697.903 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-29T17:18:17.904Z,1467220697.904 [PNI_TCM] No Fault, FailCount= 1
2016-06-29T17:18:18.252Z,1467220698.251 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.331300 seconds old.
2016-06-29T17:18:18.253Z,1467220698.253 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.331800 seconds old.
2016-06-29T17:18:18.285Z,1467220698.285 [Startup:StartupSatComms:A](INFO): Timed out from 2016-06-29T17:17:18.1Z
2016-06-29T17:18:18.285Z,1467220698.285 [Startup:StartupSatComms:A] Stopped
2016-06-29T17:18:18.285Z,1467220698.285 [Startup:StartupSatComms:B] Running Loop=1
2016-06-29T17:18:18.647Z,1467220698.647 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.727000 seconds old.
2016-06-29T17:18:18.649Z,1467220698.648 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.727500 seconds old.
2016-06-29T17:18:18.680Z,1467220698.680 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2016-06-29T17:18:20.010Z,1467220700.010 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.090400 seconds old.
2016-06-29T17:18:20.012Z,1467220700.012 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.091100 seconds old.
2016-06-29T17:18:20.378Z,1467220700.378 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.457700 seconds old.
2016-06-29T17:18:20.383Z,1467220700.383 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.462300 seconds old.
2016-06-29T17:18:20.854Z,1467220700.854 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.933400 seconds old.
2016-06-29T17:18:20.890Z,1467220700.890 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.968300 seconds old.
2016-06-29T17:18:21.266Z,1467220701.266 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.345000 seconds old.
2016-06-29T17:18:21.277Z,1467220701.277 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.355700 seconds old.
2016-06-29T17:18:21.654Z,1467220701.654 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.733100 seconds old.
2016-06-29T17:18:21.666Z,1467220701.666 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.744600 seconds old.
2016-06-29T17:18:21.972Z,1467220701.972 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 6.051900 seconds old.
2016-06-29T17:18:21.974Z,1467220701.974 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 6.052400 seconds old.
2016-06-29T17:18:55.736Z,1467220735.736 [PNI_TCM](ERROR): CRC does not match. Expected:0x53114 got:0x6464
2016-06-29T17:18:56.326Z,1467220736.326 [PNI_TCM](ERROR): CRC does not match. Expected:0x29748 got:0x6464
2016-06-29T17:18:56.733Z,1467220736.733 [NAL9602](INFO): SBD MO Status=1, MOMSN=810, MT Status=0, MTMSN=0
2016-06-29T17:18:56.785Z,1467220736.785 [NAL9602](INFO): Sent 212 bytes from file Logs/20160629T170447/Courier0000.lzma
2016-06-29T17:18:56.786Z,1467220736.786 [NAL9602](INFO): Packets left to send: 0
2016-06-29T17:18:56.804Z,1467220736.804 [NAL9602](DEBUG): Stored copy of sent data in Logs/20160629T170447/Courier0000.lzma.parts/0000.sbd
2016-06-29T17:18:56.804Z,1467220736.804 [NAL9602](DEBUG): Completed sending Logs/20160629T170447/Courier0000.lzma
2016-06-29T17:18:56.923Z,1467220736.923 [PNI_TCM](ERROR): CRC does not match. Expected:0x6669 got:0x6464
2016-06-29T17:18:56.932Z,1467220736.932 [PNI_TCM](ERROR): CRC does not match. Expected:0x52706 got:0x6464
2016-06-29T17:18:57.969Z,1467220737.969 [PNI_TCM](ERROR): CRC does not match. Expected:0x55156 got:0x6464
2016-06-29T17:18:57.971Z,1467220737.971 [PNI_TCM](ERROR): CRC does not match. Expected:0x59592 got:0x6464
2016-06-29T17:19:00.111Z,1467220740.111 [PNI_TCM](ERROR): CRC does not match. Expected:0x43785 got:0x6464
2016-06-29T17:19:00.112Z,1467220740.112 [PNI_TCM](ERROR): CRC does not match. Expected:0x46553 got:0x6464
2016-06-29T17:19:00.112Z,1467220740.112 [PNI_TCM](ERROR): CRC does not match. Expected:0x62709 got:0x6464
2016-06-29T17:19:00.112Z,1467220740.112 [PNI_TCM](ERROR): CRC does not match. Expected:0x39264 got:0x6464
2016-06-29T17:19:00.113Z,1467220740.113 [PNI_TCM](ERROR): CRC does not match. Expected:0x639 got:0x6464
2016-06-29T17:19:00.113Z,1467220740.113 [PNI_TCM](ERROR): CRC does not match. Expected:0x60177 got:0x6464
2016-06-29T17:19:00.279Z,1467220740.279 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-29T17:19:00.280Z,1467220740.280 [PNI_TCM] Data Fault, FailCount= 1
2016-06-29T17:19:00.280Z,1467220740.280 [PNI_TCM](ERROR): Data Fault
2016-06-29T17:19:00.294Z,1467220740.294 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.117300 seconds old.
2016-06-29T17:19:00.303Z,1467220740.303 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.117800 seconds old.
2016-06-29T17:19:00.333Z,1467220740.333 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-29T17:19:00.657Z,1467220740.657 [PNI_TCM](INFO): Powering down
2016-06-29T17:19:00.667Z,1467220740.667 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.491200 seconds old.
2016-06-29T17:19:00.669Z,1467220740.669 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.491700 seconds old.
2016-06-29T17:19:01.095Z,1467220741.095 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.917800 seconds old.
2016-06-29T17:19:01.098Z,1467220741.098 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.920800 seconds old.
2016-06-29T17:19:01.495Z,1467220741.495 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.317900 seconds old.
2016-06-29T17:19:01.509Z,1467220741.509 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.331600 seconds old.
2016-06-29T17:19:01.928Z,1467220741.928 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.751500 seconds old.
2016-06-29T17:19:01.945Z,1467220741.945 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.767000 seconds old.
2016-06-29T17:19:02.062Z,1467220742.062 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-29T17:19:02.062Z,1467220742.062 [PNI_TCM] No Fault, FailCount= 1
2016-06-29T17:19:02.291Z,1467220742.291 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.115000 seconds old.
2016-06-29T17:19:02.293Z,1467220742.293 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.115500 seconds old.
2016-06-29T17:19:02.746Z,1467220742.746 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.569600 seconds old.
2016-06-29T17:19:02.756Z,1467220742.756 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.578800 seconds old.
2016-06-29T17:19:03.130Z,1467220743.129 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.952800 seconds old.
2016-06-29T17:19:03.141Z,1467220743.141 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.963800 seconds old.
2016-06-29T17:19:03.508Z,1467220743.508 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.322700 seconds old.
2016-06-29T17:19:03.512Z,1467220743.511 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.334000 seconds old.
2016-06-29T17:19:03.881Z,1467220743.881 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.704500 seconds old.
2016-06-29T17:19:03.882Z,1467220743.882 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.705000 seconds old.
2016-06-29T17:19:04.288Z,1467220744.288 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.111300 seconds old.
2016-06-29T17:19:04.289Z,1467220744.289 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.111800 seconds old.
2016-06-29T17:19:04.738Z,1467220744.738 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.561800 seconds old.
2016-06-29T17:19:04.749Z,1467220744.749 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.570700 seconds old.
2016-06-29T17:19:05.123Z,1467220745.123 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.945700 seconds old.
2016-06-29T17:19:05.135Z,1467220745.135 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.957200 seconds old.
2016-06-29T17:19:06.652Z,1467220746.652 [NAL9602](INFO): SBD MO Status=1, MOMSN=811, MT Status=0, MTMSN=0
2016-06-29T17:19:06.701Z,1467220746.701 [NAL9602](INFO): Sent 18 bytes from file Logs/20160629T170447/Courier0004.lzma
2016-06-29T17:19:06.701Z,1467220746.701 [NAL9602](INFO): Packets left to send: 0
2016-06-29T17:19:06.706Z,1467220746.706 [NAL9602](DEBUG): Stored copy of sent data in Logs/20160629T170447/Courier0004.lzma.parts/0000.sbd
2016-06-29T17:19:06.706Z,1467220746.707 [NAL9602](DEBUG): Completed sending Logs/20160629T170447/Courier0004.lzma
2016-06-29T17:19:18.504Z,1467220758.504 [Startup:StartupSatComms:B](INFO): Timed out from 2016-06-29T17:18:18.3Z
2016-06-29T17:19:18.504Z,1467220758.504 [Startup:StartupSatComms:B] Stopped
2016-06-29T17:19:18.504Z,1467220758.504 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2016-06-29T17:19:18.504Z,1467220758.504 [Startup:StartupSatComms] Stopped
2016-06-29T17:19:18.504Z,1467220758.504 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2016-06-29T17:19:18.505Z,1467220758.505 [Startup](INFO): Completed Startup
2016-06-29T17:19:18.505Z,1467220758.505 [Startup] Stopped
2016-06-29T17:19:18.506Z,1467220758.506 [Startup](DEBUG): Aggregate::uninitialize Startup
2016-06-29T17:19:18.506Z,1467220758.506 [Startup:A.GoToSurface] Stopped
2016-06-29T17:19:18.506Z,1467220758.506 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2016-06-29T17:19:19.061Z,1467220759.061 [MissionManager](IMPORTANT): Started mission Default
2016-06-29T17:19:19.061Z,1467220759.061 [Default] Running Loop=1
2016-06-29T17:19:19.062Z,1467220759.062 [Default](DEBUG): Aggregate::initialize Default
2016-06-29T17:19:19.062Z,1467220759.062 [Default:B.GoToSurface] Running Loop=1
2016-06-29T17:19:19.062Z,1467220759.062 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2016-06-29T17:19:19.071Z,1467220759.071 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2016-06-29T17:19:19.072Z,1467220759.072 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2016-06-29T17:19:19.073Z,1467220759.073 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2016-06-29T17:19:19.074Z,1467220759.074 [Default:B.GoToSurface](DEBUG): No pitch timeout specified. Using default value of 20.000000 seconds.
2016-06-29T17:19:19.084Z,1467220759.084 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2016-06-29T17:19:19.085Z,1467220759.085 [Default:A.Wait] Running Loop=1
2016-06-29T17:19:19.085Z,1467220759.085 [Default:A.Wait](DEBUG): Initialize Wait Component.
2016-06-29T17:19:28.517Z,1467220768.517 [NAL9602](INFO): SBD MO Status=1, MOMSN=812, MT Status=0, MTMSN=0
2016-06-29T17:19:28.572Z,1467220768.572 [NAL9602](INFO): Sent 18 bytes from file Logs/20160629T171016/Courier0000.lzma
2016-06-29T17:19:28.572Z,1467220768.572 [NAL9602](INFO): Packets left to send: 0
2016-06-29T17:19:28.573Z,1467220768.573 [NAL9602](DEBUG): Stored copy of sent data in Logs/20160629T171016/Courier0000.lzma.parts/0000.sbd
2016-06-29T17:19:28.574Z,1467220768.574 [NAL9602](DEBUG): Completed sending Logs/20160629T171016/Courier0000.lzma
2016-06-29T17:19:32.229Z,1467220772.229 [Default:A.Wait](INFO): Done Waiting.
2016-06-29T17:19:32.229Z,1467220772.229 [Default:A.Wait] Stopped
2016-06-29T17:19:32.229Z,1467220772.229 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2016-06-29T17:19:32.815Z,1467220772.815 [Default:CheckIn] Running Loop=1
2016-06-29T17:19:32.816Z,1467220772.816 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2016-06-29T17:19:32.816Z,1467220772.816 [Default:CheckIn:Read_GPS] Running Loop=1
2016-06-29T17:19:33.188Z,1467220773.188 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2016-06-29T17:19:34.572Z,1467220774.572 [NAL9602](INFO): GPS fix at 20160629T171856: (36.802571, -121.786979)
2016-06-29T17:19:34.678Z,1467220774.678 [Default:CheckIn:Read_GPS] Stopped
2016-06-29T17:19:34.678Z,1467220774.678 [Default:CheckIn:Read_Iridium] Running Loop=1
2016-06-29T17:19:35.201Z,1467220775.201 [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-29T17:19:35.202Z,1467220775.202 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2016-06-29T17:19:35.202Z,1467220775.202 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-06-29T17:19:35.248Z,1467220775.248 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2016-06-29T17:19:35.332Z,1467220775.332 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-06-29T17:19:36.166Z,1467220776.166 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-06-29T17:19:36.166Z,1467220776.166 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2016-06-29T17:19:36.525Z,1467220776.525 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-06-29T17:19:36.525Z,1467220776.525 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-06-29T17:19:36.526Z,1467220776.526 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-06-29T17:19:51.449Z,1467220791.449 [NAL9602](INFO): SBD MO Status=1, MOMSN=813, MT Status=0, MTMSN=0
2016-06-29T17:19:51.501Z,1467220791.501 [NAL9602](INFO): Sent 213 bytes from file Logs/20160629T171542/Courier0000.lzma
2016-06-29T17:19:51.502Z,1467220791.502 [NAL9602](INFO): Packets left to send: 0
2016-06-29T17:19:56.304Z,1467220796.304 [NAL9602](DEBUG): Stored copy of sent data in Logs/20160629T171542/Courier0000.lzma.parts/0000.sbd
2016-06-29T17:19:56.304Z,1467220796.304 [NAL9602](DEBUG): Completed sending Logs/20160629T171542/Courier0000.lzma
2016-06-29T17:20:07.137Z,1467220807.136 [PNI_TCM](ERROR): CRC does not match. Expected:0x3470 got:0x14989
2016-06-29T17:20:07.616Z,1467220807.616 [PNI_TCM](ERROR): CRC does not match. Expected:0x7290 got:0x14958
2016-06-29T17:20:07.874Z,1467220807.874 [PNI_TCM](ERROR): CRC does not match. Expected:0x23267 got:0x14930
2016-06-29T17:20:08.270Z,1467220808.270 [PNI_TCM](ERROR): CRC does not match. Expected:0x51525 got:0x14936
2016-06-29T17:20:08.762Z,1467220808.762 [PNI_TCM](ERROR): CRC does not match. Expected:0x491 got:0x14949
2016-06-29T17:20:09.163Z,1467220809.163 [PNI_TCM](ERROR): CRC does not match. Expected:0x31977 got:0x14965
2016-06-29T17:20:09.510Z,1467220809.510 [PNI_TCM](ERROR): CRC does not match. Expected:0x30567 got:0x14925
2016-06-29T17:20:09.863Z,1467220809.863 [PNI_TCM](ERROR): CRC does not match. Expected:0x28210 got:0x14907
2016-06-29T17:20:10.286Z,1467220810.286 [PNI_TCM](ERROR): CRC does not match. Expected:0x6914 got:0x14912
2016-06-29T17:20:10.660Z,1467220810.660 [NAL9602](INFO): SBD MO Status=1, MOMSN=814, MT Status=0, MTMSN=0
2016-06-29T17:20:10.721Z,1467220810.721 [NAL9602](INFO): Sent 61 bytes from file Logs/20160629T171542/Courier0004.lzma
2016-06-29T17:20:10.721Z,1467220810.721 [NAL9602](INFO): Packets left to send: 0
2016-06-29T17:20:10.731Z,1467220810.731 [NAL9602](DEBUG): Stored copy of sent data in Logs/20160629T171542/Courier0004.lzma.parts/0000.sbd
2016-06-29T17:20:10.732Z,1467220810.732 [NAL9602](DEBUG): Completed sending Logs/20160629T171542/Courier0004.lzma
2016-06-29T17:20:10.861Z,1467220810.861 [PNI_TCM](ERROR): CRC does not match. Expected:0x4002 got:0x14941
2016-06-29T17:20:12.021Z,1467220812.021 [PNI_TCM](ERROR): CRC does not match. Expected:0x26044 got:0x15002
2016-06-29T17:20:12.021Z,1467220812.021 [PNI_TCM](ERROR): CRC does not match. Expected:0x48842 got:0x14970
2016-06-29T17:20:12.022Z,1467220812.022 [PNI_TCM](ERROR): CRC does not match. Expected:0x56222 got:0x14894
2016-06-29T17:20:12.022Z,1467220812.022 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-29T17:20:12.022Z,1467220812.022 [PNI_TCM] Data Fault, FailCount= 1
2016-06-29T17:20:12.022Z,1467220812.022 [PNI_TCM](ERROR): Data Fault
2016-06-29T17:20:12.028Z,1467220812.028 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.138200 seconds old.
2016-06-29T17:20:12.030Z,1467220812.030 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.132800 seconds old.
2016-06-29T17:20:12.072Z,1467220812.072 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-29T17:20:12.134Z,1467220812.134 [PNI_TCM](INFO): Powering down
2016-06-29T17:20:12.151Z,1467220812.151 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.261500 seconds old.
2016-06-29T17:20:12.153Z,1467220812.153 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.256100 seconds old.
2016-06-29T17:20:14.614Z,1467220814.614 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.723900 seconds old.
2016-06-29T17:20:14.624Z,1467220814.624 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.727200 seconds old.
2016-06-29T17:20:14.794Z,1467220814.794 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.903400 seconds old.
2016-06-29T17:20:14.804Z,1467220814.804 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.906800 seconds old.
2016-06-29T17:20:14.874Z,1467220814.874 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-29T17:20:14.875Z,1467220814.875 [PNI_TCM] No Fault, FailCount= 1
2016-06-29T17:20:15.338Z,1467220815.338 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.447300 seconds old.
2016-06-29T17:20:15.347Z,1467220815.346 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.449200 seconds old.
2016-06-29T17:20:15.591Z,1467220815.591 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.701000 seconds old.
2016-06-29T17:20:15.596Z,1467220815.596 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.699000 seconds old.
2016-06-29T17:20:15.987Z,1467220815.987 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.097100 seconds old.
2016-06-29T17:20:15.989Z,1467220815.989 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.092000 seconds old.
2016-06-29T17:20:16.350Z,1467220816.350 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.459700 seconds old.
2016-06-29T17:20:16.351Z,1467220816.351 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.454300 seconds old.
2016-06-29T17:20:16.797Z,1467220816.797 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.906300 seconds old.
2016-06-29T17:20:16.802Z,1467220816.802 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.903900 seconds old.
2016-06-29T17:20:17.236Z,1467220817.236 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 6.345400 seconds old.
2016-06-29T17:20:17.239Z,1467220817.239 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 6.342000 seconds old.
2016-06-29T17:20:17.596Z,1467220817.596 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 6.701000 seconds old.
2016-06-29T17:20:17.600Z,1467220817.600 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 6.703300 seconds old.
2016-06-29T17:20:17.949Z,1467220817.949 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 7.059000 seconds old.
2016-06-29T17:20:17.950Z,1467220817.950 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 7.053600 seconds old.
2016-06-29T17:20:19.564Z,1467220819.564 [NAL9602](INFO): SBD MO Status=1, MOMSN=815, MT Status=0, MTMSN=0
2016-06-29T17:20:19.616Z,1467220819.616 [NAL9602](INFO): Sent 133 bytes from file Logs/20160629T165051/Express0005.lzma
2016-06-29T17:20:19.616Z,1467220819.616 [NAL9602](INFO): Packets left to send: 0
2016-06-29T17:20:19.617Z,1467220819.617 [NAL9602](DEBUG): Stored copy of sent data in Logs/20160629T165051/Express0005.lzma.parts/0000.sbd
2016-06-29T17:20:19.618Z,1467220819.618 [NAL9602](DEBUG): Completed sending Logs/20160629T165051/Express0005.lzma
2016-06-29T17:20:27.488Z,1467220827.488 [NAL9602](INFO): SBD MO Status=1, MOMSN=816, MT Status=0, MTMSN=0
2016-06-29T17:20:27.536Z,1467220827.536 [NAL9602](INFO): Sent 332 bytes from file Logs/20160629T165334/Express0001.lzma
2016-06-29T17:20:27.537Z,1467220827.537 [NAL9602](INFO): Packets left to send: 1
2016-06-29T17:20:27.541Z,1467220827.541 [NAL9602](DEBUG): Stored copy of sent data in Logs/20160629T165334/Express0001.lzma.parts/0001.sbd
2016-06-29T17:20:36.366Z,1467220836.366 [NAL9602](INFO): SBD MO Status=1, MOMSN=817, MT Status=0, MTMSN=0
2016-06-29T17:20:36.417Z,1467220836.417 [NAL9602](INFO): Sent 177 bytes from file Logs/20160629T165334/Express0001.lzma
2016-06-29T17:20:36.417Z,1467220836.417 [NAL9602](INFO): Packets left to send: 0
2016-06-29T17:20:36.418Z,1467220836.418 [NAL9602](DEBUG): Stored copy of sent data in Logs/20160629T165334/Express0001.lzma.parts/0000.sbd
2016-06-29T17:20:36.418Z,1467220836.418 [NAL9602](DEBUG): Completed sending Logs/20160629T165334/Express0001.lzma
2016-06-29T17:20:57.365Z,1467220857.365 [NAL9602](INFO): SBD MO Status=2, MOMSN=818, MT Status=2, MTMSN=0
2016-06-29T17:20:57.365Z,1467220857.365 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2016-06-29T17:21:21.853Z,1467220881.853 [NAL9602](INFO): SBD MO Status=1, MOMSN=818, MT Status=0, MTMSN=0
2016-06-29T17:21:21.911Z,1467220881.911 [NAL9602](INFO): Sent 199 bytes from file Logs/20160629T165334/Express0005.lzma
2016-06-29T17:21:21.912Z,1467220881.912 [NAL9602](INFO): Packets left to send: 0
2016-06-29T17:21:25.633Z,1467220885.634 [NAL9602](DEBUG): Stored copy of sent data in Logs/20160629T165334/Express0005.lzma.parts/0000.sbd
2016-06-29T17:21:25.634Z,1467220885.634 [NAL9602](DEBUG): Completed sending Logs/20160629T165334/Express0005.lzma
2016-06-29T17:21:25.772Z,1467220885.773 [BPC1](ERROR): Failed to receive battery data
2016-06-29T17:21:25.773Z,1467220885.773 [BPC1] Communications Fault, FailCount= 1
2016-06-29T17:21:25.773Z,1467220885.773 [BPC1](ERROR): Communications Fault
2016-06-29T17:21:25.890Z,1467220885.890 [CBIT](ERROR): Communications Fault in component: BPC1
2016-06-29T17:21:29.013Z,1467220889.013 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.019800
2016-06-29T17:21:29.276Z,1467220889.276 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-29T17:21:29.276Z,1467220889.276 [BPC1] No Fault, FailCount= 1
2016-06-29T17:21:37.268Z,1467220897.267 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:21:37.354Z,1467220897.353 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20160629T165334/Express0009.lzma
2016-06-29T17:21:37.688Z,1467220897.688 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:21:38.100Z,1467220898.100 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:21:38.293Z,1467220898.293 [DataOverHttps](INFO): Moved sent file to Logs/20160629T165334/Express0009.lzma.bak
2016-06-29T17:21:38.293Z,1467220898.293 [DataOverHttps](INFO): SBD MOMSN=4324317
2016-06-29T17:21:40.424Z,1467220900.424 [Depth_Keller](INFO): A/D timeout, 2 tries over 134 ms

2016-06-29T17:21:40.424Z,1467220900.424 [Depth_Keller] Data Fault, FailCount= 1
2016-06-29T17:21:40.425Z,1467220900.425 [Depth_Keller](ERROR): Data Fault
2016-06-29T17:21:40.905Z,1467220900.905 [CBIT](ERROR): Data Fault in component: Depth_Keller
2016-06-29T17:21:40.905Z,1467220900.905 [CBIT](INFO): Clearing failed state for component Depth_Keller
2016-06-29T17:21:40.905Z,1467220900.905 [Depth_Keller] No Fault, FailCount= 1
2016-06-29T17:21:52.283Z,1467220912.283 [NAL9602](INFO): SBD MO Status=2, MOMSN=819, MT Status=2, MTMSN=0
2016-06-29T17:21:52.283Z,1467220912.283 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2016-06-29T17:21:59.746Z,1467220919.746 [NAL9602](INFO): Powering down
2016-06-29T17:22:00.257Z,1467220920.257 [DataOverHttps](INFO): Sending 1003 bytes from file Logs/20160629T170447/Express0001.lzma
2016-06-29T17:22:01.067Z,1467220921.067 [DataOverHttps](INFO): Moved sent file to Logs/20160629T170447/Express0001.lzma.bak
2016-06-29T17:22:01.068Z,1467220921.068 [DataOverHttps](INFO): SBD MOMSN=4324319
2016-06-29T17:22:09.881Z,1467220929.881 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:15.813Z,1467220935.813 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:15.940Z,1467220935.940 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20160629T170447/Express0005.lzma
2016-06-29T17:22:15.995Z,1467220935.995 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:16.429Z,1467220936.429 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:16.742Z,1467220936.742 [DataOverHttps](INFO): Moved sent file to Logs/20160629T170447/Express0005.lzma.bak
2016-06-29T17:22:16.742Z,1467220936.742 [DataOverHttps](INFO): SBD MOMSN=4324350
2016-06-29T17:22:16.810Z,1467220936.810 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:17.716Z,1467220937.716 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:17.861Z,1467220937.861 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:22.838Z,1467220942.838 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:23.247Z,1467220943.247 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:23.865Z,1467220943.865 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:24.047Z,1467220944.047 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:24.408Z,1467220944.408 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:24.913Z,1467220944.913 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:25.462Z,1467220945.462 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:25.904Z,1467220945.904 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:34.067Z,1467220954.066 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:34.186Z,1467220954.187 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:34.548Z,1467220954.548 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20160629T171016/Express0001.lzma
2016-06-29T17:22:34.614Z,1467220954.614 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:34.976Z,1467220954.976 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:35.338Z,1467220955.338 [DataOverHttps](INFO): Moved sent file to Logs/20160629T171016/Express0001.lzma.bak
2016-06-29T17:22:35.339Z,1467220955.339 [DataOverHttps](INFO): SBD MOMSN=4324352
2016-06-29T17:22:35.420Z,1467220955.420 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:35.999Z,1467220955.999 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:36.151Z,1467220956.151 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:41.772Z,1467220961.772 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:41.781Z,1467220961.781 [BPC1](ERROR): Failed to receive battery data
2016-06-29T17:22:41.781Z,1467220961.781 [BPC1] Communications Fault, FailCount= 1
2016-06-29T17:22:41.781Z,1467220961.781 [BPC1](ERROR): Communications Fault
2016-06-29T17:22:41.797Z,1467220961.797 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-06-29T17:22:41.797Z,1467220961.797 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2016-06-29T17:22:41.797Z,1467220961.797 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-06-29T17:22:41.871Z,1467220961.871 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-06-29T17:22:41.871Z,1467220961.871 [CBIT](ERROR): Communications Fault in component: BPC1
2016-06-29T17:22:41.933Z,1467220961.933 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:41.971Z,1467220961.971 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-06-29T17:22:41.971Z,1467220961.971 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2016-06-29T17:22:42.375Z,1467220962.375 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:42.440Z,1467220962.440 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-06-29T17:22:42.441Z,1467220962.441 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-06-29T17:22:42.442Z,1467220962.442 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-06-29T17:22:42.779Z,1467220962.779 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:42.984Z,1467220962.984 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-29T17:22:42.984Z,1467220962.984 [BPC1] No Fault, FailCount= 1
2016-06-29T17:22:43.129Z,1467220963.129 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:43.517Z,1467220963.517 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:47.106Z,1467220967.106 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:47.900Z,1467220967.900 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:49.885Z,1467220969.885 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:50.002Z,1467220970.002 [DataOverHttps](INFO): Sending 1059 bytes from file Logs/20160629T171542/Express0001.lzma
2016-06-29T17:22:50.054Z,1467220970.054 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:50.522Z,1467220970.522 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:50.844Z,1467220970.844 [DataOverHttps](INFO): Moved sent file to Logs/20160629T171542/Express0001.lzma.bak
2016-06-29T17:22:50.845Z,1467220970.845 [DataOverHttps](INFO): SBD MOMSN=4324354
2016-06-29T17:22:50.979Z,1467220970.980 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:52.000Z,1467220972.000 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:22:52.162Z,1467220972.162 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:00.357Z,1467220980.357 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:00.481Z,1467220980.481 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:00.946Z,1467220980.946 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:01.325Z,1467220981.325 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:01.722Z,1467220981.722 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:02.075Z,1467220982.075 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:02.531Z,1467220982.531 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:02.914Z,1467220982.914 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:12.323Z,1467220992.323 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:12.484Z,1467220992.484 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:12.864Z,1467220992.864 [DataOverHttps](INFO): Sending 259 bytes from file Logs/20160629T171542/Express0005.lzma
2016-06-29T17:23:13.005Z,1467220993.005 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:13.703Z,1467220993.703 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:13.957Z,1467220993.957 [DataOverHttps](INFO): Moved sent file to Logs/20160629T171542/Express0005.lzma.bak
2016-06-29T17:23:13.957Z,1467220993.957 [DataOverHttps](INFO): SBD MOMSN=4324383
2016-06-29T17:23:14.026Z,1467220994.026 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:16.652Z,1467220996.652 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:17.137Z,1467220997.137 [Default:CheckIn:Read_Iridium] Stopped
2016-06-29T17:23:17.137Z,1467220997.137 [Default:CheckIn:C.Wait] Running Loop=1
2016-06-29T17:23:17.137Z,1467220997.137 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2016-06-29T17:23:17.422Z,1467220997.422 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:27.382Z,1467221007.382 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:27.602Z,1467221007.602 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:27.972Z,1467221007.972 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:28.420Z,1467221008.420 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:28.791Z,1467221008.792 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:29.265Z,1467221009.265 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:29.589Z,1467221009.589 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:29.992Z,1467221009.992 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:30.427Z,1467221010.427 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:30.811Z,1467221010.811 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:31.213Z,1467221011.213 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:31.585Z,1467221011.585 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:31.984Z,1467221011.984 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:32.412Z,1467221012.412 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:32.829Z,1467221012.829 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:33.213Z,1467221013.213 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:33.588Z,1467221013.588 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:33.987Z,1467221013.987 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:34.420Z,1467221014.420 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:34.822Z,1467221014.822 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:35.240Z,1467221015.240 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:35.592Z,1467221015.592 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:35.991Z,1467221015.991 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:36.391Z,1467221016.391 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:36.812Z,1467221016.812 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:37.232Z,1467221017.232 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:37.614Z,1467221017.614 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:37.984Z,1467221017.984 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:38.405Z,1467221018.405 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:38.831Z,1467221018.831 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:39.214Z,1467221019.214 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:39.587Z,1467221019.587 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:39.987Z,1467221019.987 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:40.440Z,1467221020.440 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:40.818Z,1467221020.818 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:41.308Z,1467221021.308 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:41.713Z,1467221021.713 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:42.121Z,1467221022.121 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:42.562Z,1467221022.562 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:42.940Z,1467221022.940 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:43.318Z,1467221023.318 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:43.712Z,1467221023.712 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:44.111Z,1467221024.111 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:44.548Z,1467221024.548 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:44.986Z,1467221024.986 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:45.330Z,1467221025.330 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:45.735Z,1467221025.735 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:46.130Z,1467221026.130 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:46.557Z,1467221026.557 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:46.966Z,1467221026.966 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:47.337Z,1467221027.337 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:47.727Z,1467221027.727 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:48.129Z,1467221028.129 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:48.528Z,1467221028.528 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:48.996Z,1467221028.996 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:49.404Z,1467221029.404 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:49.830Z,1467221029.830 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:50.304Z,1467221030.304 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:50.666Z,1467221030.666 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:51.162Z,1467221031.162 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:51.488Z,1467221031.488 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:51.907Z,1467221031.907 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:52.308Z,1467221032.308 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:52.779Z,1467221032.779 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:53.278Z,1467221033.278 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:53.652Z,1467221033.652 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:54.043Z,1467221034.043 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:54.478Z,1467221034.478 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:54.909Z,1467221034.908 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:55.283Z,1467221035.283 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:55.654Z,1467221035.654 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:56.050Z,1467221036.050 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:56.501Z,1467221036.501 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:56.901Z,1467221036.901 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:57.303Z,1467221037.303 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:57.689Z,1467221037.689 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:58.105Z,1467221038.105 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:58.532Z,1467221038.532 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:58.911Z,1467221038.911 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:59.308Z,1467221039.307 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:23:59.695Z,1467221039.695 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:00.094Z,1467221040.094 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:00.503Z,1467221040.503 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:00.930Z,1467221040.930 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:01.422Z,1467221041.422 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:01.792Z,1467221041.792 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:02.227Z,1467221042.227 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:02.596Z,1467221042.596 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:03.118Z,1467221043.118 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:03.430Z,1467221043.430 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:03.831Z,1467221043.831 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:04.269Z,1467221044.269 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:04.697Z,1467221044.697 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:05.104Z,1467221045.104 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:05.426Z,1467221045.426 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:05.825Z,1467221045.825 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:06.255Z,1467221046.255 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:06.877Z,1467221046.877 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:07.282Z,1467221047.282 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:07.646Z,1467221047.646 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:08.044Z,1467221048.044 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:08.482Z,1467221048.482 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:08.898Z,1467221048.898 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:09.247Z,1467221049.247 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:09.648Z,1467221049.648 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:10.045Z,1467221050.045 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:10.474Z,1467221050.474 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:11.050Z,1467221051.050 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:11.361Z,1467221051.361 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:11.761Z,1467221051.761 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:12.162Z,1467221052.162 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:12.560Z,1467221052.560 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:13.021Z,1467221053.021 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:13.527Z,1467221053.527 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:13.854Z,1467221053.854 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:14.276Z,1467221054.276 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:14.831Z,1467221054.831 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:15.247Z,1467221055.247 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:15.618Z,1467221055.618 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:16.040Z,1467221056.040 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:16.465Z,1467221056.465 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:16.997Z,1467221056.997 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:17.403Z,1467221057.402 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:26.761Z,1467221066.761 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:27.231Z,1467221067.231 [BPC1](ERROR): Failed to receive battery data
2016-06-29T17:24:27.231Z,1467221067.231 [BPC1] Communications Fault, FailCount= 1
2016-06-29T17:24:27.231Z,1467221067.231 [BPC1](ERROR): Communications Fault
2016-06-29T17:24:27.341Z,1467221067.341 [CBIT](ERROR): Communications Fault in component: BPC1
2016-06-29T17:24:27.426Z,1467221067.426 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:27.814Z,1467221067.815 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:28.279Z,1467221068.279 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:28.882Z,1467221068.882 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-29T17:24:28.883Z,1467221068.883 [BPC1] No Fault, FailCount= 1
2016-06-29T17:24:29.207Z,1467221069.207 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:29.610Z,1467221069.610 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:30.004Z,1467221070.004 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:30.400Z,1467221070.400 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:30.932Z,1467221070.932 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:31.007Z,1467221071.007 [PNI_TCM](ERROR): CRC does not match. Expected:0x52175 got:0x14862
2016-06-29T17:24:31.265Z,1467221071.265 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:31.280Z,1467221071.280 [PNI_TCM](ERROR): CRC does not match. Expected:0x25543 got:0x14893
2016-06-29T17:24:31.665Z,1467221071.665 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:31.671Z,1467221071.671 [PNI_TCM](ERROR): CRC does not match. Expected:0x22294 got:0x14902
2016-06-29T17:24:32.061Z,1467221072.061 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:32.068Z,1467221072.068 [PNI_TCM](ERROR): CRC does not match. Expected:0x31378 got:0x14953
2016-06-29T17:24:32.482Z,1467221072.482 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:32.565Z,1467221072.565 [PNI_TCM](ERROR): CRC does not match. Expected:0x62429 got:0x14905
2016-06-29T17:24:33.135Z,1467221073.135 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:33.224Z,1467221073.224 [PNI_TCM](ERROR): CRC does not match. Expected:0x54891 got:0x14830
2016-06-29T17:24:33.224Z,1467221073.224 [PNI_TCM](ERROR): CRC does not match. Expected:0x57234 got:0x14884
2016-06-29T17:24:33.369Z,1467221073.369 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:33.763Z,1467221073.763 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:33.771Z,1467221073.771 [PNI_TCM](ERROR): CRC does not match. Expected:0x48245 got:0x14963
2016-06-29T17:24:34.209Z,1467221074.209 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:34.250Z,1467221074.250 [PNI_TCM](ERROR): CRC does not match. Expected:0x12541 got:0x14978
2016-06-29T17:24:34.632Z,1467221074.632 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:34.823Z,1467221074.823 [PNI_TCM](ERROR): CRC does not match. Expected:0x45187 got:0x14942
2016-06-29T17:24:34.849Z,1467221074.849 [PNI_TCM](ERROR): CRC does not match. Expected:0x18033 got:0x14932
2016-06-29T17:24:35.263Z,1467221075.263 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:35.270Z,1467221075.270 [PNI_TCM](ERROR): CRC does not match. Expected:0x36575 got:0x14919
2016-06-29T17:24:35.605Z,1467221075.605 [PNI_TCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:24:35.620Z,1467221075.620 [PNI_TCM](ERROR): CRC does not match. Expected:0x42652 got:0x14948
2016-06-29T17:24:35.621Z,1467221075.621 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-29T17:24:35.621Z,1467221075.621 [PNI_TCM] Data Fault, FailCount= 1
2016-06-29T17:24:35.621Z,1467221075.621 [PNI_TCM](ERROR): Data Fault
2016-06-29T17:24:35.636Z,1467221075.635 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.293800 seconds old.
2016-06-29T17:24:35.637Z,1467221075.637 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.294700 seconds old.
2016-06-29T17:24:35.684Z,1467221075.684 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-29T17:24:36.020Z,1467221076.020 [PNI_TCM](INFO): Powering down
2016-06-29T17:24:36.035Z,1467221076.035 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.693600 seconds old.
2016-06-29T17:24:36.045Z,1467221076.045 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.701800 seconds old.
2016-06-29T17:24:36.391Z,1467221076.391 [PNI_TCM](FAULT): LCB fault:  Software Overcurrent.
2016-06-29T17:24:36.391Z,1467221076.391 [PNI_TCM] Hardware Fault, FailCount= 1
2016-06-29T17:24:36.391Z,1467221076.391 [PNI_TCM](ERROR): Hardware Fault
2016-06-29T17:24:36.399Z,1467221076.399 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.057500 seconds old.
2016-06-29T17:24:36.408Z,1467221076.408 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.064900 seconds old.
2016-06-29T17:24:36.919Z,1467221076.919 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.575600 seconds old.
2016-06-29T17:24:36.948Z,1467221076.948 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.605200 seconds old.
2016-06-29T17:24:37.259Z,1467221077.259 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.916200 seconds old.
2016-06-29T17:24:37.277Z,1467221077.277 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.933300 seconds old.
2016-06-29T17:24:37.395Z,1467221077.395 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-29T17:24:37.408Z,1467221077.408 [PNI_TCM] No Fault, FailCount= 1
2016-06-29T17:24:37.645Z,1467221077.645 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.302300 seconds old.
2016-06-29T17:24:37.657Z,1467221077.657 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.313600 seconds old.
2016-06-29T17:24:38.004Z,1467221078.003 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.661800 seconds old.
2016-06-29T17:24:38.005Z,1467221078.005 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.662200 seconds old.
2016-06-29T17:24:38.504Z,1467221078.504 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.161000 seconds old.
2016-06-29T17:24:38.527Z,1467221078.527 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.183500 seconds old.
2016-06-29T17:24:38.881Z,1467221078.881 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.538700 seconds old.
2016-06-29T17:24:38.904Z,1467221078.904 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.560100 seconds old.
2016-06-29T17:24:39.264Z,1467221079.264 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.922000 seconds old.
2016-06-29T17:24:39.265Z,1467221079.265 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.922400 seconds old.
2016-06-29T17:24:39.623Z,1467221079.623 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.281700 seconds old.
2016-06-29T17:24:39.625Z,1467221079.625 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.282100 seconds old.
2016-06-29T17:24:40.030Z,1467221080.030 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.688400 seconds old.
2016-06-29T17:24:40.032Z,1467221080.032 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.689000 seconds old.
2016-06-29T17:24:40.489Z,1467221080.489 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.146400 seconds old.
2016-06-29T17:24:40.501Z,1467221080.501 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.158000 seconds old.
2016-06-29T17:25:42.977Z,1467221142.977 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-06-29T17:25:42.978Z,1467221142.978 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2016-06-29T17:25:42.978Z,1467221142.978 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-06-29T17:25:43.105Z,1467221143.105 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-06-29T17:25:43.252Z,1467221143.251 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-06-29T17:25:43.252Z,1467221143.252 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2016-06-29T17:25:43.600Z,1467221143.600 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-06-29T17:25:43.600Z,1467221143.600 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-06-29T17:25:43.600Z,1467221143.600 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-06-29T17:26:03.792Z,1467221163.792 [CBIT](DEBUG): EFC running - data check-sum false
2016-06-29T17:26:58.303Z,1467221218.303 [BPC1](ERROR): Failed to receive battery data
2016-06-29T17:26:58.306Z,1467221218.306 [BPC1] Communications Fault, FailCount= 1
2016-06-29T17:26:58.307Z,1467221218.307 [BPC1](ERROR): Communications Fault
2016-06-29T17:26:58.470Z,1467221218.470 [CBIT](ERROR): Communications Fault in component: BPC1
2016-06-29T17:26:59.480Z,1467221219.480 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-29T17:26:59.481Z,1467221219.480 [BPC1] No Fault, FailCount= 1
2016-06-29T17:27:25.810Z,1467221245.810 [PNI_TCM](ERROR): CRC does not match. Expected:0x52121 got:0x14867
2016-06-29T17:27:26.256Z,1467221246.256 [PNI_TCM](ERROR): CRC does not match. Expected:0x2521 got:0x14899
2016-06-29T17:27:26.257Z,1467221246.257 [PNI_TCM](ERROR): CRC does not match. Expected:0x7877 got:0x14939
2016-06-29T17:27:26.678Z,1467221246.678 [PNI_TCM](ERROR): CRC does not match. Expected:0x8742 got:0x14905
2016-06-29T17:27:27.427Z,1467221247.427 [PNI_TCM](ERROR): CRC does not match. Expected:0x54891 got:0x14895
2016-06-29T17:27:27.820Z,1467221247.820 [PNI_TCM](ERROR): CRC does not match. Expected:0x39551 got:0x14902
2016-06-29T17:27:28.463Z,1467221248.463 [PNI_TCM](ERROR): CRC does not match. Expected:0x31378 got:0x14943
2016-06-29T17:27:28.488Z,1467221248.488 [PNI_TCM](ERROR): CRC does not match. Expected:0x43221 got:0x14896
2016-06-29T17:27:28.909Z,1467221248.909 [PNI_TCM](ERROR): CRC does not match. Expected:0x15624 got:0x14898
2016-06-29T17:27:29.146Z,1467221249.146 [PNI_TCM](ERROR): CRC does not match. Expected:0x61537 got:0x14889
2016-06-29T17:27:29.533Z,1467221249.533 [PNI_TCM](ERROR): CRC does not match. Expected:0x56805 got:0x14924
2016-06-29T17:27:30.105Z,1467221250.105 [PNI_TCM](ERROR): CRC does not match. Expected:0x32918 got:0x14979
2016-06-29T17:27:30.807Z,1467221250.806 [PNI_TCM](ERROR): CRC does not match. Expected:0x24103 got:0x14893
2016-06-29T17:27:30.808Z,1467221250.808 [PNI_TCM](ERROR): CRC does not match. Expected:0x22294 got:0x14830
2016-06-29T17:27:30.809Z,1467221250.809 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-29T17:27:30.809Z,1467221250.809 [PNI_TCM] Data Fault, FailCount= 1
2016-06-29T17:27:30.809Z,1467221250.809 [PNI_TCM](ERROR): Data Fault
2016-06-29T17:27:30.909Z,1467221250.908 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.702400 seconds old.
2016-06-29T17:27:30.911Z,1467221250.911 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.685800 seconds old.
2016-06-29T17:27:30.964Z,1467221250.964 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-29T17:27:31.017Z,1467221251.017 [PNI_TCM](INFO): Powering down
2016-06-29T17:27:31.032Z,1467221251.032 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.825800 seconds old.
2016-06-29T17:27:31.033Z,1467221251.033 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.807800 seconds old.
2016-06-29T17:27:31.417Z,1467221251.417 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.210900 seconds old.
2016-06-29T17:27:31.418Z,1467221251.418 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.192500 seconds old.
2016-06-29T17:27:32.029Z,1467221252.029 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.781200 seconds old.
2016-06-29T17:27:32.054Z,1467221252.054 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.827800 seconds old.
2016-06-29T17:27:32.490Z,1467221252.490 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.282600 seconds old.
2016-06-29T17:27:32.505Z,1467221252.505 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.279000 seconds old.
2016-06-29T17:27:32.603Z,1467221252.603 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-29T17:27:32.651Z,1467221252.651 [PNI_TCM] No Fault, FailCount= 1
2016-06-29T17:27:32.927Z,1467221252.927 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.701400 seconds old.
2016-06-29T17:27:32.928Z,1467221252.928 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.703100 seconds old.
2016-06-29T17:27:33.116Z,1467221253.116 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.910000 seconds old.
2016-06-29T17:27:33.117Z,1467221253.117 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.891600 seconds old.
2016-06-29T17:27:33.539Z,1467221253.539 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.332900 seconds old.
2016-06-29T17:27:33.540Z,1467221253.540 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.314600 seconds old.
2016-06-29T17:27:34.064Z,1467221254.064 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.816900 seconds old.
2016-06-29T17:27:34.067Z,1467221254.067 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.841300 seconds old.
2016-06-29T17:27:34.561Z,1467221254.561 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.354900 seconds old.
2016-06-29T17:27:34.570Z,1467221254.570 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.344300 seconds old.
2016-06-29T17:27:34.932Z,1467221254.932 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.725900 seconds old.
2016-06-29T17:27:34.949Z,1467221254.949 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.723300 seconds old.
2016-06-29T17:27:35.208Z,1467221255.208 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.002000 seconds old.
2016-06-29T17:27:35.209Z,1467221255.209 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.983600 seconds old.
2016-06-29T17:27:35.616Z,1467221255.616 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.410200 seconds old.
2016-06-29T17:27:35.617Z,1467221255.617 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.391800 seconds old.
2016-06-29T17:28:00.640Z,1467221280.640 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:28:01.050Z,1467221281.050 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:28:01.460Z,1467221281.460 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:28:18.016Z,1467221298.016 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2016-06-29T17:28:18.018Z,1467221298.018 [Default:CheckIn:C.Wait] Stopped
2016-06-29T17:28:18.018Z,1467221298.018 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2016-06-29T17:28:18.019Z,1467221298.019 [Default:CheckIn:D] Running Loop=1
2016-06-29T17:28:18.436Z,1467221298.436 [Default:CheckIn:D] Stopped
2016-06-29T17:28:18.436Z,1467221298.436 [Default:CheckIn:E] Running Loop=1
2016-06-29T17:28:23.265Z,1467221303.265 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 8.989250 min 
2016-06-29T17:28:23.267Z,1467221303.267 [Default:CheckIn:E] Stopped
2016-06-29T17:28:23.267Z,1467221303.267 [Default:CheckIn](INFO): Completed Default:CheckIn
2016-06-29T17:28:23.267Z,1467221303.267 [Default:CheckIn] Stopped
2016-06-29T17:28:23.267Z,1467221303.267 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2016-06-29T17:28:23.267Z,1467221303.267 [Default:CheckIn](INFO): Running loop #2
2016-06-29T17:28:23.267Z,1467221303.267 [Default:CheckIn] Running Loop=2
2016-06-29T17:28:23.267Z,1467221303.267 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2016-06-29T17:28:23.268Z,1467221303.267 [Default:CheckIn:Read_GPS] Running Loop=1
2016-06-29T17:28:23.715Z,1467221303.715 [NAL9602](INFO): Powering up
2016-06-29T17:28:34.912Z,1467221314.912 [NAL9602](INFO): NAL9602 initialized
2016-06-29T17:28:43.649Z,1467221323.649 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-06-29T17:28:43.649Z,1467221323.649 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2016-06-29T17:28:43.649Z,1467221323.649 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-06-29T17:28:43.692Z,1467221323.692 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-06-29T17:28:44.212Z,1467221324.212 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-06-29T17:28:44.212Z,1467221324.212 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2016-06-29T17:28:44.469Z,1467221324.469 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-06-29T17:28:44.470Z,1467221324.470 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-06-29T17:28:44.471Z,1467221324.471 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-06-29T17:28:48.407Z,1467221328.407 [NAL9602](INFO): SBD MO Status=0, MOMSN=819, MT Status=0, MTMSN=0
2016-06-29T17:28:48.407Z,1467221328.407 [NAL9602](INFO): No messages in MT queue
2016-06-29T17:29:12.242Z,1467221352.242 [NAL9602](INFO): GPS fix at 20160629T172834: (36.802544, -121.787044)
2016-06-29T17:29:12.417Z,1467221352.417 [Default:CheckIn:Read_GPS] Stopped
2016-06-29T17:29:12.417Z,1467221352.417 [Default:CheckIn:Read_Iridium] Running Loop=1
2016-06-29T17:29:12.821Z,1467221352.821 [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-29T17:29:12.822Z,1467221352.822 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2016-06-29T17:29:12.822Z,1467221352.822 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-06-29T17:29:12.923Z,1467221352.923 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-06-29T17:29:13.643Z,1467221353.643 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-06-29T17:29:13.643Z,1467221353.643 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2016-06-29T17:29:13.974Z,1467221353.974 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-06-29T17:29:13.984Z,1467221353.984 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-06-29T17:29:13.984Z,1467221353.984 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-06-29T17:29:22.202Z,1467221362.202 [DataOverHttps](INFO): Sending 230 bytes from file Logs/20160629T171542/Courier0008.lzma
2016-06-29T17:29:23.012Z,1467221363.012 [DataOverHttps](INFO): Moved sent file to Logs/20160629T171542/Courier0008.lzma.bak
2016-06-29T17:29:23.012Z,1467221363.012 [DataOverHttps](INFO): SBD MOMSN=4324424
2016-06-29T17:29:30.304Z,1467221370.304 [NAL9602](INFO): Powering down
2016-06-29T17:29:39.548Z,1467221379.547 [DataOverHttps](INFO): Sending 380 bytes from file Logs/20160629T171542/Express0009.lzma
2016-06-29T17:29:40.425Z,1467221380.425 [DataOverHttps](INFO): Moved sent file to Logs/20160629T171542/Express0009.lzma.bak
2016-06-29T17:29:40.426Z,1467221380.426 [DataOverHttps](INFO): SBD MOMSN=4324427
2016-06-29T17:29:41.554Z,1467221381.554 [Default:CheckIn:Read_Iridium] Stopped
2016-06-29T17:29:41.554Z,1467221381.554 [Default:CheckIn:C.Wait] Running Loop=1
2016-06-29T17:29:41.554Z,1467221381.554 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2016-06-29T17:29:58.721Z,1467221398.721 [PNI_TCM](ERROR): CRC does not match. Expected:0x20531 got:0x14857
2016-06-29T17:29:59.391Z,1467221399.391 [PNI_TCM](ERROR): CRC does not match. Expected:0x51961 got:0x14862
2016-06-29T17:29:59.774Z,1467221399.774 [PNI_TCM](ERROR): CRC does not match. Expected:0x25543 got:0x14850
2016-06-29T17:30:00.266Z,1467221400.266 [PNI_TCM](ERROR): CRC does not match. Expected:0x60659 got:0x14841
2016-06-29T17:30:00.267Z,1467221400.267 [PNI_TCM](ERROR): CRC does not match. Expected:0x32034 got:0x14833
2016-06-29T17:30:00.678Z,1467221400.678 [PNI_TCM](ERROR): CRC does not match. Expected:0x30949 got:0x14841
2016-06-29T17:30:01.074Z,1467221401.074 [PNI_TCM](ERROR): CRC does not match. Expected:0x32034 got:0x14835
2016-06-29T17:30:01.406Z,1467221401.406 [PNI_TCM](ERROR): CRC does not match. Expected:0x46476 got:0x14861
2016-06-29T17:30:01.918Z,1467221401.918 [PNI_TCM](ERROR): CRC does not match. Expected:0x16394 got:0x14857
2016-06-29T17:30:02.346Z,1467221402.346 [PNI_TCM](ERROR): CRC does not match. Expected:0x51961 got:0x14859
2016-06-29T17:30:02.721Z,1467221402.721 [PNI_TCM](ERROR): CRC does not match. Expected:0x1936 got:0x14858
2016-06-29T17:30:03.067Z,1467221403.067 [PNI_TCM](ERROR): CRC does not match. Expected:0x59700 got:0x14862
2016-06-29T17:30:03.491Z,1467221403.491 [PNI_TCM](ERROR): CRC does not match. Expected:0x25543 got:0x14841
2016-06-29T17:30:03.492Z,1467221403.492 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-29T17:30:03.492Z,1467221403.492 [PNI_TCM] Data Fault, FailCount= 1
2016-06-29T17:30:03.492Z,1467221403.492 [PNI_TCM](ERROR): Data Fault
2016-06-29T17:30:03.503Z,1467221403.503 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.399300 seconds old.
2016-06-29T17:30:03.505Z,1467221403.505 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.399800 seconds old.
2016-06-29T17:30:03.559Z,1467221403.559 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-29T17:30:03.884Z,1467221403.884 [PNI_TCM](INFO): Powering down
2016-06-29T17:30:03.921Z,1467221403.921 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.816400 seconds old.
2016-06-29T17:30:03.925Z,1467221403.925 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.818900 seconds old.
2016-06-29T17:30:04.327Z,1467221404.327 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.221900 seconds old.
2016-06-29T17:30:04.355Z,1467221404.355 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.241300 seconds old.
2016-06-29T17:30:04.744Z,1467221404.744 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.639500 seconds old.
2016-06-29T17:30:04.745Z,1467221404.745 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.639900 seconds old.
2016-06-29T17:30:05.075Z,1467221405.075 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.971100 seconds old.
2016-06-29T17:30:05.077Z,1467221405.077 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.971500 seconds old.
2016-06-29T17:30:05.094Z,1467221405.094 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-29T17:30:05.094Z,1467221405.094 [PNI_TCM] No Fault, FailCount= 1
2016-06-29T17:30:05.479Z,1467221405.479 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.375100 seconds old.
2016-06-29T17:30:05.492Z,1467221405.492 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.386600 seconds old.
2016-06-29T17:30:05.997Z,1467221405.997 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.879000 seconds old.
2016-06-29T17:30:06.010Z,1467221406.010 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.904400 seconds old.
2016-06-29T17:30:06.396Z,1467221406.396 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.291200 seconds old.
2016-06-29T17:30:06.405Z,1467221406.405 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.299600 seconds old.
2016-06-29T17:30:06.756Z,1467221406.756 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.651500 seconds old.
2016-06-29T17:30:06.757Z,1467221406.757 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.652000 seconds old.
2016-06-29T17:30:07.085Z,1467221407.085 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.980700 seconds old.
2016-06-29T17:30:07.086Z,1467221407.086 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.981100 seconds old.
2016-06-29T17:30:07.531Z,1467221407.531 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.427200 seconds old.
2016-06-29T17:30:07.533Z,1467221407.533 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.427600 seconds old.
2016-06-29T17:30:07.949Z,1467221407.949 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.844300 seconds old.
2016-06-29T17:30:07.953Z,1467221407.953 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.847400 seconds old.
2016-06-29T17:30:08.308Z,1467221408.308 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.202900 seconds old.
2016-06-29T17:30:08.313Z,1467221408.313 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.207000 seconds old.
2016-06-29T17:31:04.621Z,1467221464.621 [BPC1](ERROR): Failed to parse bank B battery data
2016-06-29T17:31:04.621Z,1467221464.621 [BPC1] Data Fault, FailCount= 1
2016-06-29T17:31:04.621Z,1467221464.621 [BPC1](ERROR): Data Fault
2016-06-29T17:31:04.685Z,1467221464.685 [CBIT](ERROR): Data Fault in component: BPC1
2016-06-29T17:31:06.049Z,1467221466.049 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-29T17:31:06.049Z,1467221466.049 [BPC1] No Fault, FailCount= 1
2016-06-29T17:31:16.628Z,1467221476.628 [PNI_TCM](ERROR): CRC does not match. Expected:0x32523 got:0x6464
2016-06-29T17:31:17.421Z,1467221477.421 [PNI_TCM](ERROR): CRC does not match. Expected:0x49985 got:0x6464
2016-06-29T17:31:17.880Z,1467221477.880 [PNI_TCM](ERROR): CRC does not match. Expected:0x34454 got:0x6464
2016-06-29T17:31:17.881Z,1467221477.881 [PNI_TCM](ERROR): CRC does not match. Expected:0x52493 got:0x6464
2016-06-29T17:31:18.287Z,1467221478.287 [PNI_TCM](ERROR): CRC does not match. Expected:0x19759 got:0x6464
2016-06-29T17:31:19.015Z,1467221479.015 [PNI_TCM](ERROR): CRC does not match. Expected:0x23774 got:0x6464
2016-06-29T17:31:19.414Z,1467221479.414 [PNI_TCM](ERROR): CRC does not match. Expected:0x10589 got:0x6464
2016-06-29T17:31:19.867Z,1467221479.867 [PNI_TCM](ERROR): CRC does not match. Expected:0x12128 got:0x6464
2016-06-29T17:31:19.868Z,1467221479.868 [PNI_TCM](ERROR): CRC does not match. Expected:0x29962 got:0x6464
2016-06-29T17:31:20.300Z,1467221480.300 [PNI_TCM](ERROR): CRC does not match. Expected:0x45202 got:0x6464
2016-06-29T17:31:21.027Z,1467221481.027 [PNI_TCM](ERROR): CRC does not match. Expected:0x57618 got:0x6464
2016-06-29T17:31:21.027Z,1467221481.027 [PNI_TCM](ERROR): CRC does not match. Expected:0x31874 got:0x6464
2016-06-29T17:31:21.426Z,1467221481.426 [PNI_TCM](ERROR): CRC does not match. Expected:0x18910 got:0x6464
2016-06-29T17:31:21.426Z,1467221481.426 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-29T17:31:21.426Z,1467221481.426 [PNI_TCM] Data Fault, FailCount= 1
2016-06-29T17:31:21.426Z,1467221481.426 [PNI_TCM](ERROR): Data Fault
2016-06-29T17:31:21.432Z,1467221481.432 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.364300 seconds old.
2016-06-29T17:31:21.433Z,1467221481.434 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.364800 seconds old.
2016-06-29T17:31:21.480Z,1467221481.480 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-29T17:31:21.839Z,1467221481.839 [PNI_TCM](INFO): Powering down
2016-06-29T17:31:21.875Z,1467221481.875 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.807000 seconds old.
2016-06-29T17:31:21.881Z,1467221481.881 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.811900 seconds old.
2016-06-29T17:31:22.267Z,1467221482.267 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.198900 seconds old.
2016-06-29T17:31:22.271Z,1467221482.271 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.201400 seconds old.
2016-06-29T17:31:22.625Z,1467221482.625 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.557200 seconds old.
2016-06-29T17:31:22.626Z,1467221482.626 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.557600 seconds old.
2016-06-29T17:31:23.023Z,1467221483.023 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.955200 seconds old.
2016-06-29T17:31:23.024Z,1467221483.024 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.955800 seconds old.
2016-06-29T17:31:23.039Z,1467221483.039 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-29T17:31:23.039Z,1467221483.039 [PNI_TCM] No Fault, FailCount= 1
2016-06-29T17:31:23.424Z,1467221483.424 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.355700 seconds old.
2016-06-29T17:31:23.425Z,1467221483.425 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.356200 seconds old.
2016-06-29T17:31:23.823Z,1467221483.823 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.755500 seconds old.
2016-06-29T17:31:23.825Z,1467221483.825 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.756100 seconds old.
2016-06-29T17:31:24.385Z,1467221484.385 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.298900 seconds old.
2016-06-29T17:31:24.405Z,1467221484.405 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.336000 seconds old.
2016-06-29T17:31:24.819Z,1467221484.819 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.750400 seconds old.
2016-06-29T17:31:24.839Z,1467221484.839 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.769100 seconds old.
2016-06-29T17:31:25.131Z,1467221485.131 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.063100 seconds old.
2016-06-29T17:31:25.132Z,1467221485.132 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.063700 seconds old.
2016-06-29T17:31:25.551Z,1467221485.551 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.470300 seconds old.
2016-06-29T17:31:25.555Z,1467221485.555 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.485400 seconds old.
2016-06-29T17:31:25.927Z,1467221485.927 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.858600 seconds old.
2016-06-29T17:31:25.934Z,1467221485.934 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.864300 seconds old.
2016-06-29T17:31:26.404Z,1467221486.404 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.335800 seconds old.
2016-06-29T17:31:26.408Z,1467221486.408 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.339200 seconds old.
2016-06-29T17:32:14.234Z,1467221534.234 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-06-29T17:32:14.235Z,1467221534.235 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2016-06-29T17:32:14.235Z,1467221534.235 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-06-29T17:32:14.422Z,1467221534.422 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-06-29T17:32:14.627Z,1467221534.627 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-06-29T17:32:14.627Z,1467221534.627 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2016-06-29T17:32:14.920Z,1467221534.920 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-06-29T17:32:14.920Z,1467221534.920 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-06-29T17:32:14.920Z,1467221534.920 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-06-29T17:32:36.039Z,1467221556.039 [BPC1](ERROR): Failed to parse bank B battery data
2016-06-29T17:32:36.047Z,1467221556.047 [BPC1] Data Fault, FailCount= 1
2016-06-29T17:32:36.048Z,1467221556.048 [BPC1](ERROR): Data Fault
2016-06-29T17:32:36.255Z,1467221556.255 [CBIT](ERROR): Data Fault in component: BPC1
2016-06-29T17:32:37.188Z,1467221557.188 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-29T17:32:37.188Z,1467221557.188 [BPC1] No Fault, FailCount= 1
2016-06-29T17:34:09.620Z,1467221649.620 [BPC1](ERROR): Failed to receive battery data
2016-06-29T17:34:09.620Z,1467221649.620 [BPC1] Communications Fault, FailCount= 1
2016-06-29T17:34:09.620Z,1467221649.620 [BPC1](ERROR): Communications Fault
2016-06-29T17:34:09.949Z,1467221649.949 [CBIT](ERROR): Communications Fault in component: BPC1
2016-06-29T17:34:10.861Z,1467221650.861 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-29T17:34:10.861Z,1467221650.861 [BPC1] No Fault, FailCount= 1
2016-06-29T17:34:26.828Z,1467221666.828 [BPC1](ERROR): Failed to receive battery data
2016-06-29T17:34:26.828Z,1467221666.828 [BPC1] Communications Fault, FailCount= 2
2016-06-29T17:34:26.828Z,1467221666.828 [BPC1](ERROR): Communications Fault
2016-06-29T17:34:26.886Z,1467221666.885 [CBIT](ERROR): Communications Fault in component: BPC1
2016-06-29T17:34:28.272Z,1467221668.272 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-29T17:34:28.272Z,1467221668.272 [BPC1] No Fault, FailCount= 2
2016-06-29T17:34:37.705Z,1467221677.705 [PNI_TCM](ERROR): CRC does not match. Expected:0x58973 got:0x37605
2016-06-29T17:34:38.073Z,1467221678.073 [PNI_TCM](ERROR): CRC does not match. Expected:0x8851 got:0x37460
2016-06-29T17:34:38.451Z,1467221678.451 [PNI_TCM](ERROR): CRC does not match. Expected:0x36053 got:0x37608
2016-06-29T17:34:39.275Z,1467221679.275 [PNI_TCM](ERROR): CRC does not match. Expected:0x17155 got:0x37917
2016-06-29T17:34:39.289Z,1467221679.289 [PNI_TCM](ERROR): CRC does not match. Expected:0x60333 got:0x38055
2016-06-29T17:34:39.726Z,1467221679.727 [PNI_TCM](ERROR): CRC does not match. Expected:0x25569 got:0x38018
2016-06-29T17:34:39.780Z,1467221679.780 [BPC1](ERROR): Failed to parse bank B battery data
2016-06-29T17:34:39.780Z,1467221679.780 [BPC1] Data Fault, FailCount= 3
2016-06-29T17:34:39.780Z,1467221679.780 [BPC1](ERROR): Data Fault
2016-06-29T17:34:39.913Z,1467221679.913 [CBIT](ERROR): Data Fault in component: BPC1
2016-06-29T17:34:40.100Z,1467221680.100 [PNI_TCM](ERROR): CRC does not match. Expected:0x4266 got:0x37814
2016-06-29T17:34:40.833Z,1467221680.833 [PNI_TCM](ERROR): CRC does not match. Expected:0x39944 got:0x37668
2016-06-29T17:34:40.893Z,1467221680.893 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-29T17:34:40.893Z,1467221680.893 [BPC1] No Fault, FailCount= 3
2016-06-29T17:34:41.349Z,1467221681.349 [PNI_TCM](ERROR): CRC does not match. Expected:0x1695 got:0x38007
2016-06-29T17:34:41.351Z,1467221681.351 [PNI_TCM](ERROR): CRC does not match. Expected:0x6695 got:0x38077
2016-06-29T17:34:41.856Z,1467221681.856 [PNI_TCM](ERROR): CRC does not match. Expected:0x41153 got:0x38223
2016-06-29T17:34:42.240Z,1467221682.240 [PNI_TCM](ERROR): CRC does not match. Expected:0x48018 got:0x38222
2016-06-29T17:34:42.263Z,1467221682.263 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2016-06-29T17:34:42.264Z,1467221682.263 [Default:CheckIn:C.Wait] Stopped
2016-06-29T17:34:42.264Z,1467221682.264 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2016-06-29T17:34:42.264Z,1467221682.264 [Default:CheckIn:D] Running Loop=1
2016-06-29T17:34:42.554Z,1467221682.554 [PNI_TCM](ERROR): CRC does not match. Expected:0x21814 got:0x37613
2016-06-29T17:34:42.554Z,1467221682.554 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-29T17:34:42.554Z,1467221682.555 [PNI_TCM] Data Fault, FailCount= 1
2016-06-29T17:34:42.554Z,1467221682.555 [PNI_TCM](ERROR): Data Fault
2016-06-29T17:34:42.588Z,1467221682.588 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.336900 seconds old.
2016-06-29T17:34:42.589Z,1467221682.589 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.333200 seconds old.
2016-06-29T17:34:42.593Z,1467221682.593 [Default:CheckIn:D] Stopped
2016-06-29T17:34:42.593Z,1467221682.593 [Default:CheckIn:E] Running Loop=1
2016-06-29T17:34:42.606Z,1467221682.606 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-29T17:34:42.949Z,1467221682.949 [PNI_TCM](INFO): Powering down
2016-06-29T17:34:42.956Z,1467221682.957 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.705700 seconds old.
2016-06-29T17:34:42.958Z,1467221682.958 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.702200 seconds old.
2016-06-29T17:34:42.988Z,1467221682.988 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 15.392200 min 
2016-06-29T17:34:42.988Z,1467221682.989 [Default:CheckIn:E] Stopped
2016-06-29T17:34:42.989Z,1467221682.989 [Default:CheckIn](INFO): Completed Default:CheckIn
2016-06-29T17:34:42.989Z,1467221682.989 [Default:CheckIn] Stopped
2016-06-29T17:34:42.989Z,1467221682.989 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2016-06-29T17:34:42.989Z,1467221682.989 [Default:CheckIn](INFO): Running loop #3
2016-06-29T17:34:42.989Z,1467221682.989 [Default:CheckIn] Running Loop=3
2016-06-29T17:34:42.989Z,1467221682.989 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2016-06-29T17:34:42.989Z,1467221682.989 [Default:CheckIn:Read_GPS] Running Loop=1
2016-06-29T17:34:52.568Z,1467221692.568 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 10.317300 seconds old.
2016-06-29T17:34:52.570Z,1467221692.569 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 10.313700 seconds old.
2016-06-29T17:34:52.696Z,1467221692.696 [NAL9602](INFO): Powering up
2016-06-29T17:34:52.731Z,1467221692.731 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 10.480600 seconds old.
2016-06-29T17:34:52.768Z,1467221692.768 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 10.512000 seconds old.
2016-06-29T17:34:52.844Z,1467221692.844 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-29T17:34:52.844Z,1467221692.844 [PNI_TCM] No Fault, FailCount= 1
2016-06-29T17:34:53.051Z,1467221693.051 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 10.800600 seconds old.
2016-06-29T17:34:53.053Z,1467221693.053 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 10.797000 seconds old.
2016-06-29T17:34:53.516Z,1467221693.516 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 11.264100 seconds old.
2016-06-29T17:34:53.533Z,1467221693.533 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 11.276200 seconds old.
2016-06-29T17:34:54.034Z,1467221694.034 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 11.782900 seconds old.
2016-06-29T17:34:54.041Z,1467221694.041 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 11.784300 seconds old.
2016-06-29T17:34:54.328Z,1467221694.328 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 12.076800 seconds old.
2016-06-29T17:34:54.329Z,1467221694.329 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 12.073100 seconds old.
2016-06-29T17:34:54.732Z,1467221694.732 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 12.480900 seconds old.
2016-06-29T17:34:54.733Z,1467221694.733 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 12.477300 seconds old.
2016-06-29T17:34:55.182Z,1467221695.182 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 12.930500 seconds old.
2016-06-29T17:34:55.186Z,1467221695.186 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 12.929300 seconds old.
2016-06-29T17:34:55.613Z,1467221695.614 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 13.362000 seconds old.
2016-06-29T17:34:55.642Z,1467221695.642 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 13.385100 seconds old.
2016-06-29T17:34:55.940Z,1467221695.940 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 13.687800 seconds old.
2016-06-29T17:34:55.957Z,1467221695.957 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 13.700000 seconds old.
2016-06-29T17:35:03.830Z,1467221703.830 [NAL9602](INFO): NAL9602 initialized
2016-06-29T17:35:06.115Z,1467221706.115 [PNI_TCM](ERROR): CRC does not match. Expected:0x14027 got:0x16283
2016-06-29T17:35:06.117Z,1467221706.117 [PNI_TCM](ERROR): CRC does not match. Expected:0x16507 got:0x43783
2016-06-29T17:35:06.450Z,1467221706.450 [PNI_TCM](ERROR): CRC does not match. Expected:0x36705 got:0x51608
2016-06-29T17:35:06.813Z,1467221706.813 [PNI_TCM](ERROR): CRC does not match. Expected:0x38653 got:0x36553
2016-06-29T17:35:07.333Z,1467221707.333 [PNI_TCM](ERROR): CRC does not match. Expected:0x47744 got:0x35319
2016-06-29T17:35:08.184Z,1467221708.184 [PNI_TCM](ERROR): CRC does not match. Expected:0x65164 got:0x11485
2016-06-29T17:35:08.186Z,1467221708.186 [PNI_TCM](ERROR): CRC does not match. Expected:0x53171 got:0x6456
2016-06-29T17:35:08.366Z,1467221708.366 [PNI_TCM](ERROR): CRC does not match. Expected:0x62511 got:0x9614
2016-06-29T17:35:08.757Z,1467221708.757 [PNI_TCM](ERROR): CRC does not match. Expected:0x59021 got:0x7610
2016-06-29T17:35:09.738Z,1467221709.737 [PNI_TCM](ERROR): CRC does not match. Expected:0x42740 got:0x23745
2016-06-29T17:35:09.739Z,1467221709.739 [PNI_TCM](ERROR): CRC does not match. Expected:0x63256 got:0x28050
2016-06-29T17:35:10.216Z,1467221710.216 [PNI_TCM](ERROR): CRC does not match. Expected:0x2110 got:0x22943
2016-06-29T17:35:10.457Z,1467221710.457 [PNI_TCM](ERROR): CRC does not match. Expected:0x56242 got:0x46031
2016-06-29T17:35:10.457Z,1467221710.457 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-29T17:35:10.458Z,1467221710.457 [PNI_TCM] Data Fault, FailCount= 1
2016-06-29T17:35:10.458Z,1467221710.457 [PNI_TCM](ERROR): Data Fault
2016-06-29T17:35:10.480Z,1467221710.480 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.221900 seconds old.
2016-06-29T17:35:10.482Z,1467221710.482 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.222200 seconds old.
2016-06-29T17:35:10.572Z,1467221710.572 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-29T17:35:10.861Z,1467221710.861 [PNI_TCM](INFO): Powering down
2016-06-29T17:35:10.908Z,1467221710.908 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.649400 seconds old.
2016-06-29T17:35:10.909Z,1467221710.909 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.649700 seconds old.
2016-06-29T17:35:11.269Z,1467221711.269 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.010000 seconds old.
2016-06-29T17:35:11.270Z,1467221711.270 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.010800 seconds old.
2016-06-29T17:35:11.970Z,1467221711.970 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:35:12.020Z,1467221712.020 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.740400 seconds old.
2016-06-29T17:35:12.044Z,1467221712.044 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.784700 seconds old.
2016-06-29T17:35:12.381Z,1467221712.381 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:35:12.466Z,1467221712.466 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.207100 seconds old.
2016-06-29T17:35:12.584Z,1467221712.584 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.230800 seconds old.
2016-06-29T17:35:12.750Z,1467221712.750 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-29T17:35:12.750Z,1467221712.750 [PNI_TCM] No Fault, FailCount= 1
2016-06-29T17:35:12.792Z,1467221712.792 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2016-06-29T17:35:12.868Z,1467221712.868 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.609700 seconds old.
2016-06-29T17:35:12.869Z,1467221712.869 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.610000 seconds old.
2016-06-29T17:35:13.442Z,1467221713.442 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.183000 seconds old.
2016-06-29T17:35:13.453Z,1467221713.453 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.193300 seconds old.
2016-06-29T17:35:13.938Z,1467221713.938 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.660800 seconds old.
2016-06-29T17:35:13.968Z,1467221713.968 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.699200 seconds old.
2016-06-29T17:35:14.332Z,1467221714.332 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.020800 seconds old.
2016-06-29T17:35:14.333Z,1467221714.333 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.073600 seconds old.
2016-06-29T17:35:14.683Z,1467221714.682 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.424200 seconds old.
2016-06-29T17:35:14.696Z,1467221714.696 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.436400 seconds old.
2016-06-29T17:35:15.059Z,1467221715.059 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.800900 seconds old.
2016-06-29T17:35:15.060Z,1467221715.060 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-06-29T17:35:15.060Z,1467221715.060 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2016-06-29T17:35:15.061Z,1467221715.061 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-06-29T17:35:15.062Z,1467221715.062 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.802300 seconds old.
2016-06-29T17:35:15.183Z,1467221715.183 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-06-29T17:35:15.500Z,1467221715.500 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.231700 seconds old.
2016-06-29T17:35:15.678Z,1467221715.678 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-06-29T17:35:15.679Z,1467221715.679 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2016-06-29T17:35:16.038Z,1467221716.038 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-06-29T17:35:16.053Z,1467221716.053 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-06-29T17:35:16.054Z,1467221716.054 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-06-29T17:35:33.374Z,1467221733.374 [NAL9602](INFO): SBD MO Status=2, MOMSN=820, MT Status=2, MTMSN=0
2016-06-29T17:35:33.375Z,1467221733.375 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2016-06-29T17:36:03.983Z,1467221763.983 [CBIT](DEBUG): EFC running - data check-sum false
2016-06-29T17:36:05.254Z,1467221765.254 [NAL9602](INFO): SBD MO Status=2, MOMSN=820, MT Status=2, MTMSN=0
2016-06-29T17:36:05.255Z,1467221765.255 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2016-06-29T17:36:18.163Z,1467221778.163 [NAL9602](INFO): SBD MO Status=2, MOMSN=820, MT Status=2, MTMSN=0
2016-06-29T17:36:18.166Z,1467221778.166 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2016-06-29T17:36:24.325Z,1467221784.325 [BPC1](ERROR): Failed to receive battery data
2016-06-29T17:36:24.325Z,1467221784.325 [BPC1] Communications Fault, FailCount= 1
2016-06-29T17:36:24.325Z,1467221784.325 [BPC1](ERROR): Communications Fault
2016-06-29T17:36:24.464Z,1467221784.464 [CBIT](ERROR): Communications Fault in component: BPC1
2016-06-29T17:36:25.809Z,1467221785.809 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-29T17:36:25.810Z,1467221785.810 [BPC1] No Fault, FailCount= 1
2016-06-29T17:37:57.410Z,1467221877.410 [PNI_TCM](ERROR): CRC does not match. Expected:0x57031 got:0x40268
2016-06-29T17:37:57.800Z,1467221877.800 [PNI_TCM](ERROR): CRC does not match. Expected:0x4090 got:0x40270
2016-06-29T17:37:58.102Z,1467221878.102 [PNI_TCM](ERROR): CRC does not match. Expected:0x49811 got:0x40268
2016-06-29T17:37:58.890Z,1467221878.890 [PNI_TCM](ERROR): CRC does not match. Expected:0x4090 got:0x40263
2016-06-29T17:37:59.290Z,1467221879.290 [PNI_TCM](ERROR): CRC does not match. Expected:0x10736 got:0x40265
2016-06-29T17:37:59.788Z,1467221879.788 [PNI_TCM](ERROR): CRC does not match. Expected:0x27565 got:0x40255
2016-06-29T17:37:59.789Z,1467221879.789 [PNI_TCM](ERROR): CRC does not match. Expected:0x7837 got:0x40256
2016-06-29T17:38:00.153Z,1467221880.153 [PNI_TCM](ERROR): CRC does not match. Expected:0x32974 got:0x40266
2016-06-29T17:38:01.034Z,1467221881.034 [PNI_TCM](ERROR): CRC does not match. Expected:0x18528 got:0x40264
2016-06-29T17:38:01.056Z,1467221881.056 [PNI_TCM](ERROR): CRC does not match. Expected:0x34057 got:0x40268
2016-06-29T17:38:01.426Z,1467221881.426 [PNI_TCM](ERROR): CRC does not match. Expected:0x4090 got:0x40267
2016-06-29T17:38:01.874Z,1467221881.874 [PNI_TCM](ERROR): CRC does not match. Expected:0x42692 got:0x40270
2016-06-29T17:38:02.141Z,1467221882.141 [PNI_TCM](ERROR): CRC does not match. Expected:0x49811 got:0x40273
2016-06-29T17:38:02.141Z,1467221882.141 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-29T17:38:02.141Z,1467221882.141 [PNI_TCM] Data Fault, FailCount= 1
2016-06-29T17:38:02.142Z,1467221882.142 [PNI_TCM](ERROR): Data Fault
2016-06-29T17:38:02.179Z,1467221882.179 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.246100 seconds old.
2016-06-29T17:38:02.191Z,1467221882.191 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.255800 seconds old.
2016-06-29T17:38:02.220Z,1467221882.220 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-29T17:38:02.520Z,1467221882.520 [PNI_TCM](INFO): Powering down
2016-06-29T17:38:02.526Z,1467221882.526 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.592700 seconds old.
2016-06-29T17:38:02.528Z,1467221882.528 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.591700 seconds old.
2016-06-29T17:38:02.976Z,1467221882.977 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.042800 seconds old.
2016-06-29T17:38:02.980Z,1467221882.980 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.044400 seconds old.
2016-06-29T17:38:03.392Z,1467221883.392 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.454000 seconds old.
2016-06-29T17:38:03.397Z,1467221883.397 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.460600 seconds old.
2016-06-29T17:38:03.817Z,1467221883.817 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.883300 seconds old.
2016-06-29T17:38:03.826Z,1467221883.826 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.889600 seconds old.
2016-06-29T17:38:03.923Z,1467221883.923 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-29T17:38:03.923Z,1467221883.923 [PNI_TCM] No Fault, FailCount= 1
2016-06-29T17:38:04.123Z,1467221884.123 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.190100 seconds old.
2016-06-29T17:38:04.125Z,1467221884.125 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.189100 seconds old.
2016-06-29T17:38:04.506Z,1467221884.506 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.572900 seconds old.
2016-06-29T17:38:04.519Z,1467221884.519 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.583900 seconds old.
2016-06-29T17:38:04.996Z,1467221884.996 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.062700 seconds old.
2016-06-29T17:38:05.005Z,1467221885.005 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.069500 seconds old.
2016-06-29T17:38:05.388Z,1467221885.388 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.450000 seconds old.
2016-06-29T17:38:05.396Z,1467221885.396 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.455700 seconds old.
2016-06-29T17:38:05.775Z,1467221885.775 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.841500 seconds old.
2016-06-29T17:38:05.780Z,1467221885.780 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.844600 seconds old.
2016-06-29T17:38:06.129Z,1467221886.129 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.195900 seconds old.
2016-06-29T17:38:06.130Z,1467221886.130 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.194900 seconds old.
2016-06-29T17:38:06.531Z,1467221886.531 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.598400 seconds old.
2016-06-29T17:38:06.533Z,1467221886.533 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.597400 seconds old.
2016-06-29T17:38:07.034Z,1467221887.034 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.100600 seconds old.
2016-06-29T17:38:07.047Z,1467221887.047 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.106800 seconds old.
2016-06-29T17:38:16.398Z,1467221896.398 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-06-29T17:38:16.398Z,1467221896.398 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2016-06-29T17:38:16.398Z,1467221896.398 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-06-29T17:38:16.413Z,1467221896.413 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-06-29T17:38:17.056Z,1467221897.056 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-06-29T17:38:17.057Z,1467221897.057 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2016-06-29T17:38:17.351Z,1467221897.351 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-06-29T17:38:17.366Z,1467221897.366 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-06-29T17:38:17.367Z,1467221897.367 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-06-29T17:38:23.078Z,1467221903.078 [NAL9602](INFO): SBD MO Status=0, MOMSN=820, MT Status=0, MTMSN=0
2016-06-29T17:38:23.078Z,1467221903.078 [NAL9602](INFO): No messages in MT queue
2016-06-29T17:38:24.482Z,1467221904.482 [NAL9602](INFO): GPS fix at 20160629T173747: (36.802825, -121.788044)
2016-06-29T17:38:24.691Z,1467221904.691 [Default:CheckIn:Read_GPS] Stopped
2016-06-29T17:38:24.703Z,1467221904.703 [Default:CheckIn:Read_Iridium] Running Loop=1
2016-06-29T17:38:25.251Z,1467221905.251 [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-29T17:38:25.252Z,1467221905.251 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2016-06-29T17:38:25.252Z,1467221905.252 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-06-29T17:38:25.419Z,1467221905.419 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-06-29T17:38:28.522Z,1467221908.523 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-06-29T17:38:28.523Z,1467221908.523 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2016-06-29T17:38:28.665Z,1467221908.665 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-06-29T17:38:28.665Z,1467221908.665 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-06-29T17:38:28.666Z,1467221908.666 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-06-29T17:38:48.583Z,1467221928.583 [DataOverHttps](INFO): Sending 80 bytes from file Logs/20160629T171542/Courier0012.lzma
2016-06-29T17:38:48.597Z,1467221928.597 [NAL9602](INFO): Powering down
2016-06-29T17:38:49.708Z,1467221929.708 [DataOverHttps](INFO): Moved sent file to Logs/20160629T171542/Courier0012.lzma.bak
2016-06-29T17:38:49.708Z,1467221929.708 [DataOverHttps](INFO): SBD MOMSN=4324467
2016-06-29T17:39:08.498Z,1467221948.498 [BPC1](ERROR): Failed to receive battery data
2016-06-29T17:39:08.498Z,1467221948.498 [BPC1] Communications Fault, FailCount= 1
2016-06-29T17:39:08.498Z,1467221948.499 [BPC1](ERROR): Communications Fault
2016-06-29T17:39:08.530Z,1467221948.530 [CBIT](ERROR): Communications Fault in component: BPC1
2016-06-29T17:39:10.710Z,1467221950.710 [DataOverHttps](INFO): Sending 329 bytes from file Logs/20160629T171542/Express0013.lzma
2016-06-29T17:39:11.530Z,1467221951.530 [CBIT](INFO): Clearing failed state for component BPC1
2016-06-29T17:39:11.530Z,1467221951.530 [BPC1] No Fault, FailCount= 1
2016-06-29T17:39:11.633Z,1467221951.633 [DataOverHttps](INFO): Moved sent file to Logs/20160629T171542/Express0013.lzma.bak
2016-06-29T17:39:11.634Z,1467221951.634 [DataOverHttps](INFO): SBD MOMSN=4324470
2016-06-29T17:39:28.433Z,1467221968.433 [DataOverHttps](INFO): Sending 41 bytes from file Logs/20160629T171542/Express0014.lzma
2016-06-29T17:39:29.262Z,1467221969.263 [DataOverHttps](INFO): Moved sent file to Logs/20160629T171542/Express0014.lzma.bak
2016-06-29T17:39:29.280Z,1467221969.280 [DataOverHttps](INFO): SBD MOMSN=4324482
2016-06-29T17:39:30.436Z,1467221970.436 [Default:CheckIn:Read_Iridium] Stopped
2016-06-29T17:39:30.436Z,1467221970.436 [Default:CheckIn:C.Wait] Running Loop=1
2016-06-29T17:39:30.437Z,1467221970.437 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2016-06-29T17:40:00.383Z,1467222000.383 [PNI_TCM](ERROR): CRC does not match. Expected:0x31032 got:0x40260
2016-06-29T17:40:00.959Z,1467222000.959 [PNI_TCM](ERROR): CRC does not match. Expected:0x2621 got:0x40263
2016-06-29T17:40:00.961Z,1467222000.961 [PNI_TCM](ERROR): CRC does not match. Expected:0x10736 got:0x40264
2016-06-29T17:40:01.303Z,1467222001.303 [PNI_TCM](ERROR): CRC does not match. Expected:0x34057 got:0x40268
2016-06-29T17:40:01.994Z,1467222001.994 [PNI_TCM](ERROR): CRC does not match. Expected:0x4090 got:0x40268
2016-06-29T17:40:02.391Z,1467222002.391 [PNI_TCM](ERROR): CRC does not match. Expected:0x4090 got:0x40264
2016-06-29T17:40:02.878Z,1467222002.878 [PNI_TCM](ERROR): CRC does not match. Expected:0x34057 got:0x40258
2016-06-29T17:40:02.896Z,1467222002.896 [PNI_TCM](ERROR): CRC does not match. Expected:0x19879 got:0x40267
2016-06-29T17:40:03.315Z,1467222003.315 [PNI_TCM](ERROR): CRC does not match. Expected:0x42692 got:0x40267
2016-06-29T17:40:03.709Z,1467222003.709 [PNI_TCM](ERROR): CRC does not match. Expected:0x42692 got:0x40259
2016-06-29T17:40:04.385Z,1467222004.385 [PNI_TCM](ERROR): CRC does not match. Expected:0x41731 got:0x40267
2016-06-29T17:40:04.843Z,1467222004.843 [PNI_TCM](ERROR): CRC does not match. Expected:0x42692 got:0x40264
2016-06-29T17:40:04.844Z,1467222004.844 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-29T17:40:04.844Z,1467222004.844 [PNI_TCM] Data Fault, FailCount= 1
2016-06-29T17:40:04.844Z,1467222004.844 [PNI_TCM](ERROR): Data Fault
2016-06-29T17:40:04.920Z,1467222004.920 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.501600 seconds old.
2016-06-29T17:40:04.924Z,1467222004.924 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.497500 seconds old.
2016-06-29T17:40:05.014Z,1467222005.014 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-29T17:40:05.217Z,1467222005.217 [PNI_TCM](INFO): Powering down
2016-06-29T17:40:05.284Z,1467222005.284 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.856100 seconds old.
2016-06-29T17:40:05.291Z,1467222005.291 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.864000 seconds old.
2016-06-29T17:40:05.718Z,1467222005.718 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.298700 seconds old.
2016-06-29T17:40:05.733Z,1467222005.733 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.306800 seconds old.
2016-06-29T17:40:05.996Z,1467222005.996 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.577900 seconds old.
2016-06-29T17:40:05.998Z,1467222005.998 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.571500 seconds old.
2016-06-29T17:40:06.389Z,1467222006.389 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.971200 seconds old.
2016-06-29T17:40:06.391Z,1467222006.391 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.964800 seconds old.
2016-06-29T17:40:06.405Z,1467222006.405 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-29T17:40:06.405Z,1467222006.405 [PNI_TCM] No Fault, FailCount= 1
2016-06-29T17:40:06.825Z,1467222006.825 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.405600 seconds old.
2016-06-29T17:40:06.838Z,1467222006.838 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.410400 seconds old.
2016-06-29T17:40:07.234Z,1467222007.234 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.815700 seconds old.
2016-06-29T17:40:07.248Z,1467222007.248 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.820800 seconds old.
2016-06-29T17:40:07.637Z,1467222007.637 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.218200 seconds old.
2016-06-29T17:40:07.641Z,1467222007.641 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.214100 seconds old.
2016-06-29T17:40:07.997Z,1467222007.997 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.578400 seconds old.
2016-06-29T17:40:07.998Z,1467222007.999 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.572400 seconds old.
2016-06-29T17:40:08.400Z,1467222008.400 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.982100 seconds old.
2016-06-29T17:40:08.402Z,1467222008.402 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.975700 seconds old.
2016-06-29T17:40:08.968Z,1467222008.968 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.549300 seconds old.
2016-06-29T17:40:08.976Z,1467222008.976 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.549800 seconds old.
2016-06-29T17:40:09.404Z,1467222009.404 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.956000 seconds old.
2016-06-29T17:40:09.420Z,1467222009.420 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.980700 seconds old.
2016-06-29T17:40:09.803Z,1467222009.803 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.384800 seconds old.
2016-06-29T17:40:09.812Z,1467222009.812 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.385400 seconds old.
2016-06-29T17:40:25.486Z,1467222025.486 [PNI_TCM](ERROR): CRC does not match. Expected:0x34520 got:0x40257
2016-06-29T17:40:25.753Z,1467222025.753 [PNI_TCM](ERROR): CRC does not match. Expected:0x28266 got:0x40261
2016-06-29T17:40:26.142Z,1467222026.142 [PNI_TCM](ERROR): CRC does not match. Expected:0x58521 got:0x40257
2016-06-29T17:40:26.555Z,1467222026.555 [PNI_TCM](ERROR): CRC does not match. Expected:0x28266 got:0x40255
2016-06-29T17:40:27.038Z,1467222027.038 [PNI_TCM](ERROR): CRC does not match. Expected:0x7837 got:0x40259
2016-06-29T17:40:27.397Z,1467222027.397 [PNI_TCM](ERROR): CRC does not match. Expected:0x41731 got:0x40263
2016-06-29T17:40:27.746Z,1467222027.746 [PNI_TCM](ERROR): CRC does not match. Expected:0x10736 got:0x40266
2016-06-29T17:40:28.141Z,1467222028.141 [PNI_TCM](ERROR): CRC does not match. Expected:0x18528 got:0x40265
2016-06-29T17:40:29.024Z,1467222029.024 [PNI_TCM](ERROR): CRC does not match. Expected:0x27565 got:0x40259
2016-06-29T17:40:29.026Z,1467222029.026 [PNI_TCM](ERROR): CRC does not match. Expected:0x41731 got:0x40260
2016-06-29T17:40:29.492Z,1467222029.492 [PNI_TCM](ERROR): CRC does not match. Expected:0x2621 got:0x40268
2016-06-29T17:40:29.805Z,1467222029.805 [PNI_TCM](ERROR): CRC does not match. Expected:0x4090 got:0x40266
2016-06-29T17:40:30.189Z,1467222030.188 [PNI_TCM](ERROR): CRC does not match. Expected:0x18528 got:0x40267
2016-06-29T17:40:30.189Z,1467222030.189 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-29T17:40:30.189Z,1467222030.189 [PNI_TCM] Data Fault, FailCount= 1
2016-06-29T17:40:30.189Z,1467222030.189 [PNI_TCM](ERROR): Data Fault
2016-06-29T17:40:30.195Z,1467222030.195 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.341400 seconds old.
2016-06-29T17:40:30.213Z,1467222030.213 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.352800 seconds old.
2016-06-29T17:40:30.264Z,1467222030.263 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-29T17:40:30.608Z,1467222030.608 [PNI_TCM](INFO): Powering down
2016-06-29T17:40:30.689Z,1467222030.689 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.834700 seconds old.
2016-06-29T17:40:30.693Z,1467222030.693 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.832300 seconds old.
2016-06-29T17:40:31.210Z,1467222031.210 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.355700 seconds old.
2016-06-29T17:40:31.222Z,1467222031.222 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.362000 seconds old.
2016-06-29T17:40:41.965Z,1467222041.965 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 12.111100 seconds old.
2016-06-29T17:40:41.966Z,1467222041.966 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 12.106300 seconds old.
2016-06-29T17:40:42.136Z,1467222042.136 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 12.282500 seconds old.
2016-06-29T17:40:42.137Z,1467222042.137 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 12.277700 seconds old.
2016-06-29T17:40:42.188Z,1467222042.188 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-29T17:40:42.189Z,1467222042.188 [PNI_TCM] No Fault, FailCount= 1
2016-06-29T17:40:42.544Z,1467222042.544 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 12.690200 seconds old.
2016-06-29T17:40:42.545Z,1467222042.545 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 12.685400 seconds old.
2016-06-29T17:40:43.129Z,1467222043.129 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 13.274500 seconds old.
2016-06-29T17:40:43.153Z,1467222043.153 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 13.292300 seconds old.
2016-06-29T17:40:43.672Z,1467222043.672 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 13.818700 seconds old.
2016-06-29T17:40:43.674Z,1467222043.674 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 13.813900 seconds old.
2016-06-29T17:40:43.915Z,1467222043.915 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 14.061800 seconds old.
2016-06-29T17:40:43.920Z,1467222043.920 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 14.060600 seconds old.
2016-06-29T17:40:44.319Z,1467222044.319 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 14.465000 seconds old.
2016-06-29T17:40:44.320Z,1467222044.320 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 14.460200 seconds old.
2016-06-29T17:40:44.838Z,1467222044.838 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 14.984300 seconds old.
2016-06-29T17:40:44.859Z,1467222044.859 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 14.998100 seconds old.
2016-06-29T17:40:55.703Z,1467222055.703 [PNI_TCM](ERROR): CRC does not match. Expected:0x9180 got:0x40257
2016-06-29T17:40:56.091Z,1467222056.091 [PNI_TCM](ERROR): CRC does not match. Expected:0x28266 got:0x40261
2016-06-29T17:40:56.477Z,1467222056.477 [PNI_TCM](ERROR): CRC does not match. Expected:0x58521 got:0x40254
2016-06-29T17:40:57.125Z,1467222057.125 [PNI_TCM](ERROR): CRC does not match. Expected:0x61497 got:0x40258
2016-06-29T17:40:57.586Z,1467222057.586 [PNI_TCM](ERROR): CRC does not match. Expected:0x19879 got:0x40259
2016-06-29T17:40:57.846Z,1467222057.846 [PNI_TCM](ERROR): CRC does not match. Expected:0x41731 got:0x40260
2016-06-29T17:40:58.243Z,1467222058.243 [PNI_TCM](ERROR): CRC does not match. Expected:0x2621 got:0x40256
2016-06-29T17:40:58.651Z,1467222058.651 [PNI_TCM](ERROR): CRC does not match. Expected:0x32974 got:0x40259
2016-06-29T17:40:59.115Z,1467222059.115 [PNI_TCM](ERROR): CRC does not match. Expected:0x41731 got:0x40252
2016-06-29T17:40:59.519Z,1467222059.519 [PNI_TCM](ERROR): CRC does not match. Expected:0x15696 got:0x40247
2016-06-29T17:40:59.931Z,1467222059.931 [PNI_TCM](ERROR): CRC does not match. Expected:0x7002 got:0x40256
2016-06-29T17:41:00.248Z,1467222060.248 [PNI_TCM](ERROR): CRC does not match. Expected:0x32974 got:0x40256
2016-06-29T17:41:00.800Z,1467222060.800 [PNI_TCM](ERROR): CRC does not match. Expected:0x32974 got:0x40255
2016-06-29T17:41:00.801Z,1467222060.801 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-06-29T17:41:00.801Z,1467222060.801 [PNI_TCM] Data Fault, FailCount= 1
2016-06-29T17:41:00.802Z,1467222060.802 [PNI_TCM](ERROR): Data Fault
2016-06-29T17:41:00.862Z,1467222060.862 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.607000 seconds old.
2016-06-29T17:41:00.874Z,1467222060.874 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.618500 seconds old.
2016-06-29T17:41:01.002Z,1467222061.002 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-06-29T17:41:01.092Z,1467222061.092 [PNI_TCM](INFO): Powering down
2016-06-29T17:41:01.117Z,1467222061.117 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.862200 seconds old.
2016-06-29T17:41:01.132Z,1467222061.132 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.876800 seconds old.
2016-06-29T17:41:01.514Z,1467222061.514 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.259200 seconds old.
2016-06-29T17:41:01.542Z,1467222061.542 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.285800 seconds old.
2016-06-29T17:41:01.896Z,1467222061.896 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.624900 seconds old.
2016-06-29T17:41:01.897Z,1467222061.897 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.641700 seconds old.
2016-06-29T17:41:02.275Z,1467222062.275 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.020900 seconds old.
2016-06-29T17:41:02.277Z,1467222062.277 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.021500 seconds old.
2016-06-29T17:41:02.316Z,1467222062.316 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-06-29T17:41:02.316Z,1467222062.316 [PNI_TCM] No Fault, FailCount= 1
2016-06-29T17:41:02.769Z,1467222062.769 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.513700 seconds old.
2016-06-29T17:41:02.779Z,1467222062.779 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.522500 seconds old.
2016-06-29T17:41:03.121Z,1467222063.121 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.866100 seconds old.
2016-06-29T17:41:03.125Z,1467222063.125 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.869100 seconds old.
2016-06-29T17:41:03.624Z,1467222063.624 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.336200 seconds old.
2016-06-29T17:41:03.628Z,1467222063.628 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.371600 seconds old.
2016-06-29T17:41:03.880Z,1467222063.880 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.625800 seconds old.
2016-06-29T17:41:03.881Z,1467222063.881 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.626200 seconds old.
2016-06-29T17:41:04.283Z,1467222064.283 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.028900 seconds old.
2016-06-29T17:41:04.285Z,1467222064.284 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.029300 seconds old.
2016-06-29T17:41:04.804Z,1467222064.804 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.549800 seconds old.
2016-06-29T17:41:04.808Z,1467222064.808 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.552300 seconds old.
2016-06-29T17:41:05.206Z,1467222065.206 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.951100 seconds old.
2016-06-29T17:41:05.223Z,1467222065.223 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.966900 seconds old.
2016-06-29T17:41:05.667Z,1467222065.667 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.413200 seconds old.
2016-06-29T17:41:05.669Z,1467222065.669 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.413600 seconds old.
2016-06-29T17:41:29.031Z,1467222089.031 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-06-29T17:41:29.052Z,1467222089.052 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2016-06-29T17:41:29.052Z,1467222089.052 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-06-29T17:41:29.321Z,1467222089.321 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-06-29T17:41:29.728Z,1467222089.728 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-06-29T17:41:29.728Z,1467222089.728 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2