2015-02-11T18:33:06.432Z,1423679586.432 [Supervisor](DEBUG): Initializing supervisor.
2015-02-11T18:33:06.438Z,1423679586.438 [SyncHandler](DEBUG): Created PCaller Thread at 4034C4E0
2015-02-11T18:33:06.438Z,1423679586.438 [SyncHandler](INFO): Protected caller Thread ID is 2025
2015-02-11T18:33:06.439Z,1423679586.439 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2015-02-11T18:33:06.440Z,1423679586.440 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4037C4E0
2015-02-11T18:33:06.441Z,1423679586.441 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 2026
2015-02-11T18:33:06.443Z,1423679586.443 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2015-02-11T18:33:06.455Z,1423679586.455 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2015-02-11T18:33:06.456Z,1423679586.456 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 403AC4E0
2015-02-11T18:33:06.456Z,1423679586.456 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 2027
2015-02-11T18:33:06.457Z,1423679586.457 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2015-02-11T18:33:06.458Z,1423679586.458 [logger ThreadHandler](DEBUG): Created PCaller Thread at 403DC4E0
2015-02-11T18:33:06.459Z,1423679586.459 [logger ThreadHandler](INFO): Protected caller Thread ID is 2028
2015-02-11T18:33:06.461Z,1423679586.461 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2015-02-11T18:33:06.461Z,1423679586.461 [Supervisor](INFO): Looking for Config files in directory: Config/
2015-02-11T18:33:06.463Z,1423679586.463 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2015-02-11T18:33:06.926Z,1423679586.926 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2015-02-11T18:33:06.926Z,1423679586.926 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2015-02-11T18:33:07.155Z,1423679587.155 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2015-02-11T18:33:07.155Z,1423679587.155 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2015-02-11T18:33:07.277Z,1423679587.277 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2015-02-11T18:33:07.278Z,1423679587.278 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2015-02-11T18:33:07.479Z,1423679587.479 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2015-02-11T18:33:07.480Z,1423679587.480 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2015-02-11T18:33:07.565Z,1423679587.565 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2015-02-11T18:33:07.758Z,1423679587.758 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2015-02-11T18:33:07.758Z,1423679587.758 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2015-02-11T18:33:07.871Z,1423679587.871 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2015-02-11T18:33:07.872Z,1423679587.872 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2015-02-11T18:33:08.082Z,1423679588.082 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2015-02-11T18:33:08.082Z,1423679588.082 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2015-02-11T18:33:08.448Z,1423679588.448 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2015-02-11T18:33:08.448Z,1423679588.448 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2015-02-11T18:33:08.793Z,1423679588.793 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2015-02-11T18:33:08.794Z,1423679588.794 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2015-02-11T18:33:09.366Z,1423679589.366 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2015-02-11T18:33:09.367Z,1423679589.367 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2015-02-11T18:33:09.648Z,1423679589.648 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2015-02-11T18:33:09.649Z,1423679589.649 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2015-02-11T18:33:09.766Z,1423679589.766 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2015-02-11T18:33:09.766Z,1423679589.766 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2015-02-11T18:33:10.234Z,1423679590.234 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2015-02-11T18:33:10.235Z,1423679590.235 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2015-02-11T18:33:10.350Z,1423679590.350 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2015-02-11T18:33:10.352Z,1423679590.352 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2015-02-11T18:33:10.353Z,1423679590.353 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2015-02-11T18:33:10.614Z,1423679590.614 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2015-02-11T18:33:10.615Z,1423679590.615 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2015-02-11T18:33:10.732Z,1423679590.732 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Estimation.cfg
2015-02-11T18:33:10.831Z,1423679590.831 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2015-02-11T18:33:10.928Z,1423679590.928 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2015-02-11T18:33:11.048Z,1423679591.048 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2015-02-11T18:33:11.197Z,1423679591.197 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2015-02-11T18:33:11.370Z,1423679591.370 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2015-02-11T18:33:11.483Z,1423679591.483 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2015-02-11T18:33:11.586Z,1423679591.586 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2015-02-11T18:33:11.694Z,1423679591.694 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2015-02-11T18:33:11.791Z,1423679591.791 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2015-02-11T18:33:11.990Z,1423679591.990 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2015-02-11T18:33:12.005Z,1423679592.005 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2015-02-11T18:33:12.060Z,1423679592.060 [VerticalControl](DEBUG): Construct VerticalControl.
2015-02-11T18:33:12.187Z,1423679592.187 [VerticalControl] Loaded
2015-02-11T18:33:12.188Z,1423679592.188 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2015-02-11T18:33:12.188Z,1423679592.188 [HorizontalControl](DEBUG): Construct HorizontalControl.
2015-02-11T18:33:12.271Z,1423679592.271 [HorizontalControl] Loaded
2015-02-11T18:33:12.271Z,1423679592.271 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2015-02-11T18:33:12.272Z,1423679592.272 [SpeedControl](DEBUG): Construct SpeedControl.
2015-02-11T18:33:12.278Z,1423679592.278 [SpeedControl] Loaded
2015-02-11T18:33:12.278Z,1423679592.278 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2015-02-11T18:33:12.279Z,1423679592.279 [LoopControl](DEBUG): Construct LoopControl.
2015-02-11T18:33:12.279Z,1423679592.279 [LoopControl] Loaded
2015-02-11T18:33:12.279Z,1423679592.279 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2015-02-11T18:33:12.280Z,1423679592.280 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2015-02-11T18:33:12.280Z,1423679592.280 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2015-02-11T18:33:12.388Z,1423679592.388 [SBIT](DEBUG): Construct Startup Built In Test.
2015-02-11T18:33:12.399Z,1423679592.399 [SBIT] Loaded
2015-02-11T18:33:12.399Z,1423679592.399 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2015-02-11T18:33:12.400Z,1423679592.400 [IBIT](DEBUG): Construct Initiated Built In Test.
2015-02-11T18:33:12.431Z,1423679592.431 [IBIT] Loaded
2015-02-11T18:33:12.431Z,1423679592.431 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2015-02-11T18:33:12.433Z,1423679592.433 [CBIT](DEBUG): Construct CBIT Built In Test.
2015-02-11T18:33:12.581Z,1423679592.581 [CBIT] Loaded
2015-02-11T18:33:12.581Z,1423679592.581 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2015-02-11T18:33:12.582Z,1423679592.582 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2015-02-11T18:33:12.582Z,1423679592.582 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2015-02-11T18:33:12.601Z,1423679592.601 [DepthRateCalculator] Loaded
2015-02-11T18:33:12.602Z,1423679592.602 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2015-02-11T18:33:12.607Z,1423679592.607 [PitchRateCalculator] Loaded
2015-02-11T18:33:12.608Z,1423679592.608 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2015-02-11T18:33:12.619Z,1423679592.619 [SpeedCalculator] Loaded
2015-02-11T18:33:12.619Z,1423679592.619 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2015-02-11T18:33:12.636Z,1423679592.636 [TempGradientCalculator] Loaded
2015-02-11T18:33:12.636Z,1423679592.636 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2015-02-11T18:33:12.642Z,1423679592.642 [YawRateCalculator] Loaded
2015-02-11T18:33:12.642Z,1423679592.642 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2015-02-11T18:33:12.642Z,1423679592.642 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2015-02-11T18:33:12.643Z,1423679592.643 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2015-02-11T18:33:13.813Z,1423679593.813 [HFRCMReconstructedInterpolator] Loaded
2015-02-11T18:33:13.814Z,1423679593.814 [ComponentRegistry](DEBUG): SyncComponent "HFRCMReconstructedInterpolator" handled in the control thread.
2015-02-11T18:33:13.814Z,1423679593.814 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2015-02-11T18:33:13.815Z,1423679593.815 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2015-02-11T18:33:14.067Z,1423679594.067 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2015-02-11T18:33:14.067Z,1423679594.067 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2015-02-11T18:33:14.156Z,1423679594.156 [DeadReckonUsingMultipleVelocitySources] Loaded
2015-02-11T18:33:14.156Z,1423679594.156 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2015-02-11T18:33:14.207Z,1423679594.207 [DeadReckonUsingSpeedCalculator] Loaded
2015-02-11T18:33:14.207Z,1423679594.207 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2015-02-11T18:33:14.227Z,1423679594.227 [NavChart] Loaded
2015-02-11T18:33:14.227Z,1423679594.227 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2015-02-11T18:33:14.232Z,1423679594.232 [UniversalFixResidualReporter] Loaded
2015-02-11T18:33:14.232Z,1423679594.232 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2015-02-11T18:33:14.232Z,1423679594.232 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2015-02-11T18:33:14.233Z,1423679594.233 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2015-02-11T18:33:14.239Z,1423679594.239 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2015-02-11T18:33:14.240Z,1423679594.240 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2015-02-11T18:33:14.371Z,1423679594.371 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2015-02-11T18:33:14.371Z,1423679594.371 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2015-02-11T18:33:15.061Z,1423679595.061 [DataOverHttps] Loaded
2015-02-11T18:33:15.061Z,1423679595.061 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2015-02-11T18:33:15.144Z,1423679595.144 [Depth_Keller] Loaded
2015-02-11T18:33:15.145Z,1423679595.145 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2015-02-11T18:33:15.243Z,1423679595.243 [NAL9602] Loaded
2015-02-11T18:33:15.243Z,1423679595.243 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2015-02-11T18:33:15.286Z,1423679595.286 [Onboard] Loaded
2015-02-11T18:33:15.286Z,1423679595.286 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2015-02-11T18:33:15.294Z,1423679595.294 [Radio_Surface] Loaded
2015-02-11T18:33:15.294Z,1423679595.294 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2015-02-11T18:33:15.295Z,1423679595.295 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408074E0
2015-02-11T18:33:15.296Z,1423679595.296 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 2110
2015-02-11T18:33:15.348Z,1423679595.348 [PNI_TCM] Loaded
2015-02-11T18:33:15.348Z,1423679595.348 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread.
2015-02-11T18:33:17.837Z,1423679597.837 [BPC1] Loaded
2015-02-11T18:33:17.838Z,1423679597.838 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2015-02-11T18:33:17.838Z,1423679597.838 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2015-02-11T18:33:17.839Z,1423679597.839 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2015-02-11T18:33:17.957Z,1423679597.957 [BuoyancyServo] Loaded
2015-02-11T18:33:17.958Z,1423679597.958 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2015-02-11T18:33:17.975Z,1423679597.975 [ElevatorServo] Loaded
2015-02-11T18:33:17.975Z,1423679597.975 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2015-02-11T18:33:17.987Z,1423679597.987 [MassServo] Loaded
2015-02-11T18:33:17.988Z,1423679597.988 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2015-02-11T18:33:18.003Z,1423679598.003 [RudderServo] Loaded
2015-02-11T18:33:18.003Z,1423679598.003 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2015-02-11T18:33:18.018Z,1423679598.018 [ThrusterServo] Loaded
2015-02-11T18:33:18.019Z,1423679598.019 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2015-02-11T18:33:18.019Z,1423679598.019 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2015-02-11T18:33:18.020Z,1423679598.020 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2015-02-11T18:33:18.319Z,1423679598.319 [ExternalSim] Loaded
2015-02-11T18:33:18.320Z,1423679598.320 [ComponentRegistry](DEBUG): SyncComponent "ExternalSim" handled in the control thread.
2015-02-11T18:33:18.320Z,1423679598.320 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2015-02-11T18:33:18.321Z,1423679598.321 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2015-02-11T18:33:18.345Z,1423679598.345 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2015-02-11T18:33:18.347Z,1423679598.347 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2015-02-11T18:33:18.348Z,1423679598.348 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2015-02-11T18:33:18.354Z,1423679598.354 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2015-02-11T18:33:18.355Z,1423679598.355 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 408B84E0
2015-02-11T18:33:18.356Z,1423679598.356 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 2112
2015-02-11T18:33:18.361Z,1423679598.361 [Supervisor](INFO): Main Thread ID is 2024
2015-02-11T18:33:18.361Z,1423679598.361 [Supervisor](DEBUG): Running supervisor.
2015-02-11T18:33:18.361Z,1423679598.361 [CommandLine ThreadHandler](INFO): Handler Thread ID is 2113
2015-02-11T18:33:18.366Z,1423679598.366 [controlThread ThreadHandler](INFO): Handler Thread ID is 2114
2015-02-11T18:33:18.366Z,1423679598.366 [controlThread](DEBUG): Initializing ControlThread
2015-02-11T18:33:18.367Z,1423679598.367 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2015-02-11T18:33:18.369Z,1423679598.369 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2015-02-11T18:33:18.369Z,1423679598.369 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2015-02-11T18:33:18.370Z,1423679598.370 [LoopControl](DEBUG): Initialize LoopControlComponent.
2015-02-11T18:33:18.370Z,1423679598.370 [SBIT](INFO): Initialize SBIT Component.
2015-02-11T18:33:18.371Z,1423679598.371 [SBIT](IMPORTANT): Tethys CM Info: SVN revision:11976
2015-02-11T18:33:18.371Z,1423679598.371 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2015-02-11T18:33:18.371Z,1423679598.371 [SBIT](IMPORTANT): Kernel Version:#639 PREEMPT Wed Mar 12 12:53:33 PDT 2014
2015-02-11T18:33:18.372Z,1423679598.372 [IBIT](INFO): Initialize IBIT Component.
2015-02-11T18:33:18.373Z,1423679598.373 [CBIT](DEBUG): Initialize CBIT Component.
2015-02-11T18:33:18.373Z,1423679598.373 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2015-02-11T18:33:18.374Z,1423679598.374 [logger ThreadHandler](INFO): Handler Thread ID is 2115
2015-02-11T18:33:18.394Z,1423679598.394 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 2116
2015-02-11T18:33:18.400Z,1423679598.400 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2015-02-11T18:33:18.412Z,1423679598.412 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2015-02-11T18:33:18.412Z,1423679598.412 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2015-02-11T18:33:18.412Z,1423679598.412 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2015-02-11T18:33:18.413Z,1423679598.413 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2015-02-11T18:33:18.414Z,1423679598.414 [HFRCMReconstructedInterpolator](INFO): Initializing HFRCMReconstructedInterpolator component with velocityAccuracy_ = 0.300000 m/s.
2015-02-11T18:33:18.415Z,1423679598.415 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2015-02-11T18:33:18.416Z,1423679598.416 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2015-02-11T18:33:18.416Z,1423679598.416 [NavChart](DEBUG): Initialize NavChart Navigation.
2015-02-11T18:33:18.417Z,1423679598.417 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2015-02-11T18:33:18.428Z,1423679598.428 [ExternalSim](INFO): ExternalSim initializing...
2015-02-11T18:33:18.442Z,1423679598.442 [Radio_Surface](INFO): Powering up
2015-02-11T18:33:18.453Z,1423679598.453 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 2117
2015-02-11T18:33:18.456Z,1423679598.456 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources
2015-02-11T18:33:18.456Z,1423679598.456 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2015-02-11T18:33:18.457Z,1423679598.457 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2015-02-11T18:33:18.457Z,1423679598.457 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2015-02-11T18:33:18.457Z,1423679598.457 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2015-02-11T18:33:18.458Z,1423679598.458 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2015-02-11T18:33:18.458Z,1423679598.458 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2015-02-11T18:33:18.458Z,1423679598.458 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2015-02-11T18:33:18.458Z,1423679598.458 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2015-02-11T18:33:20.497Z,1423679600.497 [ExternalSim](DEBUG): beaconLat = 36.80340
2015-02-11T18:33:20.497Z,1423679600.497 [ExternalSim](DEBUG): beaconLon = -121.82230
2015-02-11T18:33:20.497Z,1423679600.497 [ExternalSim](DEBUG): beaconDepth = 25.00
2015-02-11T18:33:21.084Z,1423679601.084 [ExternalSim](DEBUG): Simulator initialized
2015-02-11T18:33:21.090Z,1423679601.090 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2015-02-11T18:33:21.099Z,1423679601.099 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2015-02-11T18:33:21.135Z,1423679601.135 [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://aosn.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://aosn.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://aosn.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://aosn.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://aosn.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>


2015-02-11T18:33:21.136Z,1423679601.136 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2015-02-11T18:33:21.235Z,1423679601.235 [MissionManager](INFO): DefineArg Default.TimeMissionWasStarted = 0.000000 h
2015-02-11T18:33:21.252Z,1423679601.252 [MissionManager](INFO): DefineArg Default.ElapsedSinceMissionWasStarted = 0.000000 h
2015-02-11T18:33:21.256Z,1423679601.256 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2015-02-11T18:33:21.302Z,1423679601.302 [Default:CheckIn:A.SetSpeed](DEBUG): Construct.
2015-02-11T18:33:21.321Z,1423679601.321 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2015-02-11T18:33:21.353Z,1423679601.353 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed](DEBUG): Construct.
2015-02-11T18:33:21.376Z,1423679601.376 [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://aosn.mbari.org/tethys/Xml/Tethys.xsd
Tethys/Control http://aosn.mbari.org/tethys/Xml/Control.xsd
Tethys/Guidance http://aosn.mbari.org/tethys/Xml/Guidance.xsd
Tethys/Units http://aosn.mbari.org/tethys/Xml/Units.xsd
Tethys/Universal http://aosn.mbari.org/tethys/Xml/Universal.xsd"
Id="Default">

    <DefineArg Name="TimeMissionWasStarted"><Units:hour/><Value>0</Value></DefineArg>

    <DefineArg Name="ElapsedSinceMissionWasStarted"><Units:hour/><Value>0</Value></DefineArg>

    <Aggregate Id="StartClock">

        <Sequence/>

        <Assign><Arg Name="TimeMissionWasStarted"/><Universal:time/></Assign>

    </Aggregate>

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

    <Aggregate Id="CheckIn">

        <When>
            <Elapsed><Universal:platform_communications/></Elapsed>
            <Gt><Units:minute/><Value>5.0</Value></Gt>
            <And><Universal:platform_conversation/><Eq><True/></Eq></And>
            <Or><Elapsed><Universal:platform_communications/></Elapsed><Gt><Units:hour/><Value>1.0</Value></Gt></Or>
        </When>

<!-- TODO: Do we really want this When operating on platform_communications? or on something else like time_fix? -->

<!-- Run application at high speed -->

        <Guidance:SetSpeed>
            <Parallel/>
            <Setting><Guidance:SetSpeed.period/><Units:millisecond/><Value>400</Value></Setting>
        </Guidance:SetSpeed>

        <ReadDatum Id="Read_GPS">
            <Timeout Duration="P5M"/>
<!-- NOTE: Original Default.xml didn't have a timeout on the GPS read, so theoretically could have hung indefinitely there... -->
            <Universal:latitude_fix/>
        </ReadDatum>

<!-- Do data comms -->

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

    </Aggregate>

    <Aggregate Id="UpdateAndReportMinutesSinceMissionStarted">

        <When>
            <Elapsed><Arg Name="ElapsedSinceMissionWasStarted"/></Elapsed>
            <Gt><Units:minute/><Value>5.0</Value></Gt>
        </When>

        <Assign><Arg Name="ElapsedSinceMissionWasStarted"/><Universal:time/><Sub><Arg Name="TimeMissionWasStarted"/></Sub></Assign>

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

    </Aggregate>

    <Aggregate Id="WaitAtTheSurface">

        <Sequence/>

        <Guidance:SetSpeed Id="RunApplicationAtLowSpeed">
            <Parallel/>
            <Setting><Guidance:SetSpeed.period/><Units:second/><Value>5</Value></Setting>
        </Guidance:SetSpeed>

    </Aggregate>

</Mission>


2015-02-11T18:33:21.381Z,1423679601.381 [controlThread](DEBUG): Component order: CycleStarter,ExternalSim,DataOverHttps,Depth_Keller,NAL9602,Onboard,PNI_TCM,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,HFRCMReconstructedInterpolator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2015-02-11T18:33:22.448Z,1423679602.448 [NAL9602](INFO): Powering up NAL9602
2015-02-11T18:33:22.821Z,1423679602.821 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:33:22.844Z,1423679602.844 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 0 cycles since last successful read, accepting data for 5 cycles.
2015-02-11T18:33:22.971Z,1423679602.971 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2015-02-11T18:33:22.981Z,1423679602.981 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2015-02-11T18:33:23.004Z,1423679603.004 [ElevatorServo](DEBUG): Initializing EZServoServo.
2015-02-11T18:33:23.009Z,1423679603.009 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2015-02-11T18:33:23.023Z,1423679603.023 [MassServo](DEBUG): Initializing EZServoServo.
2015-02-11T18:33:23.029Z,1423679603.029 [MassServo](DEBUG): Initializing MassServo.
2015-02-11T18:33:23.043Z,1423679603.043 [RudderServo](DEBUG): Initializing EZServoServo.
2015-02-11T18:33:23.049Z,1423679603.049 [RudderServo](DEBUG): Initializing RudderServo.
2015-02-11T18:33:23.071Z,1423679603.071 [ThrusterServo](DEBUG): Initializing EZServoServo.
2015-02-11T18:33:23.077Z,1423679603.077 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2015-02-11T18:33:24.302Z,1423679604.302 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:33:24.319Z,1423679604.319 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 1 cycles since last successful read, accepting data for 5 cycles.
2015-02-11T18:33:36.005Z,1423679616.005 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:33:36.006Z,1423679616.006 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 2 cycles since last successful read, accepting data for 5 cycles.
2015-02-11T18:33:38.047Z,1423679618.047 [BPC1](ERROR): Failed to parse message.
2015-02-11T18:33:38.047Z,1423679618.047 [BPC1](ERROR): Failed to parse bank A battery data
2015-02-11T18:33:38.047Z,1423679618.047 [BPC1] Data Fault, FailCount= 1
2015-02-11T18:33:38.047Z,1423679618.047 [BPC1](ERROR): Data Fault
2015-02-11T18:33:38.064Z,1423679618.064 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:33:38.065Z,1423679618.065 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 3 cycles since last successful read, accepting data for 5 cycles.
2015-02-11T18:33:38.225Z,1423679618.225 [SBIT](IMPORTANT): Beginning Startup BIT
2015-02-11T18:33:38.227Z,1423679618.227 [CBIT](ERROR): Data Fault in component: BPC1
2015-02-11T18:33:38.228Z,1423679618.228 [CBIT](IMPORTANT): Beginning GF scan
2015-02-11T18:33:39.719Z,1423679619.719 [NAL9602](INFO): NAL9602 initialized
2015-02-11T18:33:39.813Z,1423679619.813 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:33:39.814Z,1423679619.814 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 4 cycles since last successful read, accepting data for 5 cycles.
2015-02-11T18:33:41.600Z,1423679621.600 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003906
2015-02-11T18:33:41.649Z,1423679621.649 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:33:41.659Z,1423679621.659 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 5 cycles since last successful read, accepting data for 5 cycles.
2015-02-11T18:33:43.984Z,1423679623.984 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:33:44.758Z,1423679624.758 [CBIT](INFO): Clearing failed state for component BPC1
2015-02-11T18:33:44.758Z,1423679624.758 [BPC1] No Fault, FailCount= 1
2015-02-11T18:33:45.768Z,1423679625.768 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:33:47.074Z,1423679627.074 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:33:47.764Z,1423679627.764 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:33:48.760Z,1423679628.760 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:33:50.649Z,1423679630.649 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:33:51.086Z,1423679631.086 [CommandLine](IMPORTANT): got command report mod NAL9602.sigQuality
2015-02-11T18:33:52.748Z,1423679632.748 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:33:52.880Z,1423679632.880 [Reporter](INFO): NAL9602.sigQuality no_value
2015-02-11T18:33:53.370Z,1423679633.370 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:33:54.414Z,1423679634.414 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:33:55.144Z,1423679635.144 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:33:56.173Z,1423679636.173 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:33:57.160Z,1423679637.160 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:33:59.051Z,1423679639.051 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:33:59.751Z,1423679639.751 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:34:01.873Z,1423679641.873 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:34:04.262Z,1423679644.262 [BPC1](ERROR): Failed to receive battery data
2015-02-11T18:34:04.262Z,1423679644.262 [BPC1] Communications Fault, FailCount= 2
2015-02-11T18:34:04.262Z,1423679644.262 [BPC1](ERROR): Communications Fault
2015-02-11T18:34:04.280Z,1423679644.280 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:34:04.466Z,1423679644.466 [CBIT](ERROR): Communications Fault in component: BPC1
2015-02-11T18:34:05.306Z,1423679645.306 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:34:06.757Z,1423679646.757 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:34:09.264Z,1423679649.264 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:34:09.405Z,1423679649.405 [CBIT](INFO): Clearing failed state for component BPC1
2015-02-11T18:34:09.405Z,1423679649.405 [BPC1] No Fault, FailCount= 2
2015-02-11T18:34:11.584Z,1423679651.584 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:34:11.781Z,1423679651.781 [CBIT](IMPORTANT): No ground fault detected
2015-02-11T18:34:13.514Z,1423679653.514 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:34:15.607Z,1423679655.607 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:34:18.264Z,1423679658.264 [NAL9602](ERROR): parseGSV uart error: serial timeout
2015-02-11T18:34:18.345Z,1423679658.345 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:34:20.471Z,1423679660.471 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:34:21.628Z,1423679661.628 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:34:22.350Z,1423679662.350 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:34:23.869Z,1423679663.869 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:34:25.975Z,1423679665.975 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:34:34.324Z,1423679674.324 [BPC1](ERROR): Failed to receive battery data
2015-02-11T18:34:34.324Z,1423679674.324 [BPC1] Communications Fault, FailCount= 3
2015-02-11T18:34:34.324Z,1423679674.324 [BPC1](ERROR): Communications Fault
2015-02-11T18:34:34.375Z,1423679674.375 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:34:34.971Z,1423679674.971 [SBIT](FAULT): Mass: EXPECTED:0.000000 ACTUAL:-0.002589
2015-02-11T18:34:34.972Z,1423679674.972 [SBIT](FAULT): Rudder: EXPECTED:0.000000 ACTUAL:-14.973630
2015-02-11T18:34:34.972Z,1423679674.972 [SBIT](FAULT): Control surface position failure.
2015-02-11T18:34:34.974Z,1423679674.974 [CBIT](ERROR): Communications Fault in component: BPC1
2015-02-11T18:34:36.222Z,1423679676.222 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:34:36.316Z,1423679676.316 [SBIT](CRITICAL): SBIT FAILED
2015-02-11T18:34:36.318Z,1423679676.318 [CommandLine](FAULT): Scheduling is paused
2015-02-11T18:34:37.903Z,1423679677.903 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:34:37.907Z,1423679677.907 [MissionManager](IMPORTANT): Started mission Startup
2015-02-11T18:34:37.907Z,1423679677.907 [Startup] Running Loop=1
2015-02-11T18:34:37.907Z,1423679677.907 [Startup](INFO): Aggregate::initialize Startup
2015-02-11T18:34:37.907Z,1423679677.907 [Startup:A.GoToSurface] Running Loop=1
2015-02-11T18:34:37.907Z,1423679677.907 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2015-02-11T18:34:37.908Z,1423679677.908 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2015-02-11T18:34:37.908Z,1423679677.908 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2015-02-11T18:34:37.908Z,1423679677.908 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 0.500000 m/s.
2015-02-11T18:34:37.914Z,1423679677.914 [Startup:StartupSatComms] Running Loop=1
2015-02-11T18:34:37.914Z,1423679677.914 [Startup:StartupSatComms](INFO): Aggregate::initialize Startup:StartupSatComms
2015-02-11T18:34:37.915Z,1423679677.915 [Startup:StartupSatComms:A] Running Loop=1
2015-02-11T18:34:39.063Z,1423679679.063 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:34:39.072Z,1423679679.072 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2015-02-11T18:34:39.274Z,1423679679.274 [CBIT](INFO): Clearing failed state for component BPC1
2015-02-11T18:34:39.274Z,1423679679.274 [BPC1] No Fault, FailCount= 3
2015-02-11T18:34:40.238Z,1423679680.238 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:34:41.226Z,1423679681.226 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:34:42.138Z,1423679682.138 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:34:42.933Z,1423679682.933 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:34:44.639Z,1423679684.639 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:34:46.707Z,1423679686.707 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:34:47.831Z,1423679687.831 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:34:49.430Z,1423679689.430 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:34:54.251Z,1423679694.251 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2015-02-11T18:34:54.767Z,1423679694.767 [NAL9602](FAULT): received: 
2015-02-11T18:34:54.767Z,1423679694.767 [NAL9602] Data Fault, FailCount= 1
2015-02-11T18:34:54.768Z,1423679694.768 [NAL9602](ERROR): Data Fault
2015-02-11T18:34:54.859Z,1423679694.859 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:34:54.871Z,1423679694.871 [CBIT](ERROR): Data Fault in component: NAL9602
2015-02-11T18:34:56.407Z,1423679696.407 [NAL9602](INFO): Powering down
2015-02-11T18:34:56.422Z,1423679696.422 [BPC1](ERROR): Failed to receive battery data
2015-02-11T18:34:56.422Z,1423679696.422 [BPC1] Communications Fault, FailCount= 4
2015-02-11T18:34:56.422Z,1423679696.422 [BPC1](ERROR): Communications Fault
2015-02-11T18:34:56.428Z,1423679696.428 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:34:56.477Z,1423679696.477 [CBIT](ERROR): Communications Fault in component: BPC1
2015-02-11T18:34:57.487Z,1423679697.487 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:34:58.473Z,1423679698.473 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:34:58.486Z,1423679698.486 [CBIT](INFO): Clearing failed state for component NAL9602
2015-02-11T18:34:58.486Z,1423679698.486 [NAL9602] No Fault, FailCount= 1
2015-02-11T18:34:59.682Z,1423679699.682 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:34:59.752Z,1423679699.752 [CBIT](INFO): Clearing failed state for component BPC1
2015-02-11T18:34:59.752Z,1423679699.752 [BPC1] No Fault, FailCount= 4
2015-02-11T18:35:00.256Z,1423679700.256 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:35:01.407Z,1423679701.407 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:35:03.054Z,1423679703.054 [NAL9602](INFO): Powering up NAL9602
2015-02-11T18:35:03.104Z,1423679703.104 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:35:04.469Z,1423679704.469 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:35:05.379Z,1423679705.379 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:35:06.678Z,1423679706.678 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:35:07.539Z,1423679707.539 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:35:08.377Z,1423679708.377 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:35:09.726Z,1423679709.726 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:35:10.418Z,1423679710.418 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:35:12.968Z,1423679712.968 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:35:15.884Z,1423679715.884 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:35:17.190Z,1423679717.190 [BPC1](ERROR): Failed to receive battery data
2015-02-11T18:35:17.190Z,1423679717.190 [BPC1] Communications Fault, FailCount= 5
2015-02-11T18:35:17.191Z,1423679717.191 [BPC1](ERROR): Communications Fault
2015-02-11T18:35:17.196Z,1423679717.196 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:35:17.242Z,1423679717.242 [CBIT](ERROR): Communications Fault in component: BPC1
2015-02-11T18:35:19.605Z,1423679719.605 [NAL9602](INFO): NAL9602 initialized
2015-02-11T18:35:19.623Z,1423679719.623 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:35:21.447Z,1423679721.447 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:35:23.645Z,1423679723.645 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:35:23.658Z,1423679723.658 [CBIT](INFO): Clearing failed state for component BPC1
2015-02-11T18:35:23.658Z,1423679723.658 [BPC1] No Fault, FailCount= 5
2015-02-11T18:35:25.174Z,1423679725.174 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:35:26.240Z,1423679726.240 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:35:30.181Z,1423679730.181 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:35:32.986Z,1423679732.986 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:35:35.901Z,1423679735.901 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:35:42.954Z,1423679742.954 [BPC1](ERROR): Failed to receive battery data
2015-02-11T18:35:42.955Z,1423679742.955 [BPC1] Communications Fault, FailCount= 6
2015-02-11T18:35:42.955Z,1423679742.955 [BPC1](ERROR): Communications Fault
2015-02-11T18:35:42.998Z,1423679742.998 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:35:43.002Z,1423679743.002 [Startup:StartupSatComms:A](INFO): Timed out from 2015-02-11T18:34:37.9Z
2015-02-11T18:35:43.002Z,1423679743.002 [Startup:StartupSatComms:A] Stopped
2015-02-11T18:35:43.002Z,1423679743.002 [Startup:StartupSatComms:B] Running Loop=1
2015-02-11T18:35:43.026Z,1423679743.026 [CBIT](ERROR): Communications Fault in component: BPC1
2015-02-11T18:35:43.696Z,1423679743.696 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:35:43.700Z,1423679743.700 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2015-02-11T18:35:45.693Z,1423679745.693 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:35:47.294Z,1423679747.294 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:35:47.319Z,1423679747.319 [CBIT](INFO): Clearing failed state for component BPC1
2015-02-11T18:35:47.320Z,1423679747.320 [BPC1] No Fault, FailCount= 6
2015-02-11T18:35:48.717Z,1423679748.717 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:35:51.355Z,1423679751.355 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:35:52.970Z,1423679752.970 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:35:56.351Z,1423679756.351 [CommandLine](IMPORTANT): got command report mod platform_battery_charge
2015-02-11T18:35:57.937Z,1423679757.937 [NAL9602](ERROR): parseGSV uart error: serial timeout
2015-02-11T18:35:57.981Z,1423679757.981 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:35:58.035Z,1423679758.035 [Reporter](INFO): platform_battery_charge no_value
2015-02-11T18:35:58.478Z,1423679758.478 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:35:59.313Z,1423679759.313 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:00.701Z,1423679760.701 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:02.355Z,1423679762.355 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:03.828Z,1423679763.828 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:05.257Z,1423679765.257 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:11.462Z,1423679771.462 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:12.561Z,1423679772.561 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:13.767Z,1423679773.767 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:14.089Z,1423679774.089 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:14.881Z,1423679774.881 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:15.890Z,1423679775.890 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:19.947Z,1423679779.947 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:19.948Z,1423679779.948 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2015-02-11T18:36:19.949Z,1423679779.949 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2015-02-11T18:36:19.949Z,1423679779.949 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2015-02-11T18:36:19.951Z,1423679779.951 [DeadReckonUsingSpeedCalculator](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2015-02-11T18:36:19.951Z,1423679779.951 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2015-02-11T18:36:19.951Z,1423679779.951 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2015-02-11T18:36:19.988Z,1423679779.988 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2015-02-11T18:36:19.988Z,1423679779.988 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2015-02-11T18:36:21.412Z,1423679781.412 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:21.440Z,1423679781.440 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2015-02-11T18:36:21.440Z,1423679781.440 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2015-02-11T18:36:21.441Z,1423679781.441 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2015-02-11T18:36:21.441Z,1423679781.441 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2015-02-11T18:36:22.375Z,1423679782.375 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:22.376Z,1423679782.376 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2015-02-11T18:36:22.376Z,1423679782.376 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2015-02-11T18:36:23.172Z,1423679783.172 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:23.174Z,1423679783.174 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 0 cycles since last successful read, accepting data for 5 cycles.
2015-02-11T18:36:23.790Z,1423679783.790 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:23.791Z,1423679783.791 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 1 cycles since last successful read, accepting data for 5 cycles.
2015-02-11T18:36:24.340Z,1423679784.340 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:24.341Z,1423679784.341 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 2 cycles since last successful read, accepting data for 5 cycles.
2015-02-11T18:36:29.322Z,1423679789.322 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2015-02-11T18:36:29.839Z,1423679789.839 [NAL9602](FAULT): received: 
2015-02-11T18:36:29.839Z,1423679789.839 [NAL9602] Data Fault, FailCount= 2
2015-02-11T18:36:29.839Z,1423679789.839 [NAL9602](ERROR): Data Fault
2015-02-11T18:36:29.893Z,1423679789.893 [BPC1](ERROR): Failed to receive battery data
2015-02-11T18:36:29.893Z,1423679789.893 [BPC1] Communications Fault, FailCount= 1
2015-02-11T18:36:29.893Z,1423679789.893 [BPC1](ERROR): Communications Fault
2015-02-11T18:36:29.899Z,1423679789.899 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:29.900Z,1423679789.900 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 3 cycles since last successful read, accepting data for 5 cycles.
2015-02-11T18:36:29.965Z,1423679789.965 [CBIT](ERROR): Data Fault in component: NAL9602
2015-02-11T18:36:29.965Z,1423679789.965 [CBIT](ERROR): Communications Fault in component: BPC1
2015-02-11T18:36:32.043Z,1423679792.043 [NAL9602](INFO): Powering down
2015-02-11T18:36:32.063Z,1423679792.063 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:32.064Z,1423679792.064 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 4 cycles since last successful read, accepting data for 5 cycles.
2015-02-11T18:36:34.721Z,1423679794.721 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:34.721Z,1423679794.721 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 5 cycles since last successful read, accepting data for 5 cycles.
2015-02-11T18:36:36.878Z,1423679796.878 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:36.890Z,1423679796.890 [CBIT](INFO): Clearing failed state for component NAL9602
2015-02-11T18:36:36.890Z,1423679796.890 [NAL9602] No Fault, FailCount= 2
2015-02-11T18:36:36.891Z,1423679796.891 [CBIT](INFO): Clearing failed state for component BPC1
2015-02-11T18:36:36.891Z,1423679796.891 [BPC1] No Fault, FailCount= 1
2015-02-11T18:36:38.042Z,1423679798.042 [NAL9602](INFO): Powering up NAL9602
2015-02-11T18:36:38.181Z,1423679798.181 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:39.377Z,1423679799.377 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:40.310Z,1423679800.310 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:41.703Z,1423679801.703 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:43.049Z,1423679803.049 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:43.053Z,1423679803.053 [Startup:StartupSatComms:B](INFO): Timed out from 2015-02-11T18:35:43.0Z
2015-02-11T18:36:43.053Z,1423679803.053 [Startup:StartupSatComms:B] Stopped
2015-02-11T18:36:43.053Z,1423679803.053 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2015-02-11T18:36:43.053Z,1423679803.053 [Startup:StartupSatComms] Stopped
2015-02-11T18:36:43.053Z,1423679803.053 [Startup:StartupSatComms](INFO): Aggregate::uninitialize Startup:StartupSatComms
2015-02-11T18:36:43.054Z,1423679803.054 [Startup](INFO): Completed Startup
2015-02-11T18:36:43.054Z,1423679803.054 [Startup] Stopped
2015-02-11T18:36:43.055Z,1423679803.055 [Startup](INFO): Aggregate::uninitialize Startup
2015-02-11T18:36:43.055Z,1423679803.055 [Startup:A.GoToSurface] Stopped
2015-02-11T18:36:43.055Z,1423679803.055 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2015-02-11T18:36:45.221Z,1423679805.221 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:45.238Z,1423679805.238 [MissionManager](IMPORTANT): Started mission Default
2015-02-11T18:36:45.238Z,1423679805.238 [Default] Running Loop=1
2015-02-11T18:36:45.238Z,1423679805.238 [Default](INFO): Aggregate::initialize Default
2015-02-11T18:36:45.238Z,1423679805.238 [Default:B.GoToSurface] Running Loop=1
2015-02-11T18:36:45.239Z,1423679805.239 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2015-02-11T18:36:45.239Z,1423679805.239 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2015-02-11T18:36:45.239Z,1423679805.239 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2015-02-11T18:36:45.240Z,1423679805.240 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 0.500000 m/s.
2015-02-11T18:36:45.240Z,1423679805.240 [Default:StartClock] Running Loop=1
2015-02-11T18:36:45.240Z,1423679805.240 [Default:StartClock](INFO): Aggregate::initialize Default:StartClock
2015-02-11T18:36:45.240Z,1423679805.240 [Default:StartClock:A] Running Loop=1
2015-02-11T18:36:45.240Z,1423679805.240 [Default:CheckIn] Running Loop=1
2015-02-11T18:36:45.241Z,1423679805.241 [Default:CheckIn](INFO): Aggregate::initialize Default:CheckIn
2015-02-11T18:36:45.241Z,1423679805.241 [Default:CheckIn:A.SetSpeed] Running Loop=1
2015-02-11T18:36:45.241Z,1423679805.241 [Default:CheckIn:A.SetSpeed](DEBUG): Initialize.
2015-02-11T18:36:45.241Z,1423679805.241 [Default:CheckIn:Read_GPS] Running Loop=1
2015-02-11T18:36:45.242Z,1423679805.242 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2015-02-11T18:36:45.244Z,1423679805.244 [Default:CheckIn:A.SetSpeed] Running Loop=1
2015-02-11T18:36:45.270Z,1423679805.270 [Default:StartClock:A] Stopped
2015-02-11T18:36:45.270Z,1423679805.270 [Default:StartClock](INFO): Completed Default:StartClock
2015-02-11T18:36:45.270Z,1423679805.270 [Default:StartClock] Stopped
2015-02-11T18:36:45.270Z,1423679805.270 [Default:StartClock](INFO): Aggregate::uninitialize Default:StartClock
2015-02-11T18:36:47.178Z,1423679807.178 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:47.183Z,1423679807.183 [Default:WaitAtTheSurface] Running Loop=1
2015-02-11T18:36:47.183Z,1423679807.183 [Default:WaitAtTheSurface](INFO): Aggregate::initialize Default:WaitAtTheSurface
2015-02-11T18:36:47.183Z,1423679807.183 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed] Running Loop=1
2015-02-11T18:36:47.183Z,1423679807.183 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed](DEBUG): Initialize.
2015-02-11T18:36:52.167Z,1423679812.167 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:52.170Z,1423679812.170 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed] Running Loop=1
2015-02-11T18:36:53.137Z,1423679813.137 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:53.967Z,1423679813.967 [NAL9602](INFO): NAL9602 initialized
2015-02-11T18:36:54.189Z,1423679814.189 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:55.324Z,1423679815.324 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:55.887Z,1423679815.887 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:56.452Z,1423679816.452 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:57.279Z,1423679817.279 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:58.048Z,1423679818.048 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:58.704Z,1423679818.704 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:36:59.302Z,1423679819.302 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:00.066Z,1423679820.066 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:01.109Z,1423679821.109 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:02.242Z,1423679822.242 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:03.130Z,1423679823.130 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:03.689Z,1423679823.689 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:04.160Z,1423679824.160 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:05.072Z,1423679825.072 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:05.887Z,1423679825.887 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:06.252Z,1423679826.252 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:07.263Z,1423679827.263 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:07.735Z,1423679827.735 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:08.170Z,1423679828.170 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:08.592Z,1423679828.592 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:09.092Z,1423679829.092 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:09.740Z,1423679829.740 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:11.023Z,1423679831.023 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:12.629Z,1423679832.629 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:13.699Z,1423679833.699 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:14.994Z,1423679834.994 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:17.477Z,1423679837.477 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:19.004Z,1423679839.004 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:20.484Z,1423679840.484 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:21.207Z,1423679841.207 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:22.583Z,1423679842.583 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:23.016Z,1423679843.016 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:24.170Z,1423679844.170 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:24.874Z,1423679844.874 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:25.215Z,1423679845.215 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:25.827Z,1423679845.827 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:26.407Z,1423679846.407 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:27.515Z,1423679847.515 [NAL9602](ERROR): parseGSV uart error: serial timeout
2015-02-11T18:37:27.633Z,1423679847.633 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:28.864Z,1423679848.864 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:30.385Z,1423679850.385 [BPC1](ERROR): Failed to receive battery data
2015-02-11T18:37:30.385Z,1423679850.385 [BPC1] Communications Fault, FailCount= 1
2015-02-11T18:37:30.385Z,1423679850.385 [BPC1](ERROR): Communications Fault
2015-02-11T18:37:30.446Z,1423679850.446 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:30.476Z,1423679850.476 [CBIT](ERROR): Communications Fault in component: BPC1
2015-02-11T18:37:31.441Z,1423679851.441 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:31.944Z,1423679851.944 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:32.339Z,1423679852.339 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:32.369Z,1423679852.369 [CBIT](INFO): Clearing failed state for component BPC1
2015-02-11T18:37:32.369Z,1423679852.369 [BPC1] No Fault, FailCount= 1
2015-02-11T18:37:33.583Z,1423679853.583 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:34.327Z,1423679854.327 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:34.956Z,1423679854.956 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:35.258Z,1423679855.258 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:35.806Z,1423679855.806 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:36.223Z,1423679856.223 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:36.671Z,1423679856.671 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:36.981Z,1423679856.981 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:37.612Z,1423679857.612 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:37.973Z,1423679857.973 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:38.622Z,1423679858.622 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:38.935Z,1423679858.935 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:39.338Z,1423679859.338 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:39.931Z,1423679859.931 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:41.223Z,1423679861.223 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:41.686Z,1423679861.686 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:43.498Z,1423679863.498 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:44.526Z,1423679864.526 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:45.494Z,1423679865.494 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:46.493Z,1423679866.493 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:50.810Z,1423679870.810 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:52.859Z,1423679872.859 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:53.412Z,1423679873.412 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:54.082Z,1423679874.082 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:55.197Z,1423679875.197 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:56.236Z,1423679876.236 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:56.778Z,1423679876.778 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:57.280Z,1423679877.280 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:57.811Z,1423679877.811 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:58.329Z,1423679878.329 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:59.176Z,1423679879.176 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2015-02-11T18:37:59.699Z,1423679879.699 [NAL9602](FAULT): received: 
2015-02-11T18:37:59.699Z,1423679879.699 [NAL9602] Data Fault, FailCount= 3
2015-02-11T18:37:59.700Z,1423679879.700 [NAL9602](ERROR): Data Fault
2015-02-11T18:37:59.719Z,1423679879.719 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:37:59.732Z,1423679879.732 [CBIT](ERROR): Data Fault in component: NAL9602
2015-02-11T18:38:01.610Z,1423679881.610 [NAL9602](INFO): Powering down
2015-02-11T18:38:01.634Z,1423679881.634 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:03.325Z,1423679883.325 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:04.170Z,1423679884.170 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:04.244Z,1423679884.244 [CBIT](INFO): Clearing failed state for component NAL9602
2015-02-11T18:38:04.244Z,1423679884.244 [NAL9602] No Fault, FailCount= 3
2015-02-11T18:38:05.205Z,1423679885.205 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:06.369Z,1423679886.369 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:07.432Z,1423679887.432 [NAL9602](INFO): Powering up NAL9602
2015-02-11T18:38:07.469Z,1423679887.469 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:08.228Z,1423679888.228 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:09.086Z,1423679889.086 [BPC1](ERROR): Failed to receive battery data
2015-02-11T18:38:09.086Z,1423679889.086 [BPC1] Communications Fault, FailCount= 1
2015-02-11T18:38:09.086Z,1423679889.086 [BPC1](ERROR): Communications Fault
2015-02-11T18:38:09.092Z,1423679889.092 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:09.149Z,1423679889.149 [CBIT](ERROR): Communications Fault in component: BPC1
2015-02-11T18:38:10.540Z,1423679890.540 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:11.398Z,1423679891.398 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:12.148Z,1423679892.148 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:12.194Z,1423679892.194 [CBIT](INFO): Clearing failed state for component BPC1
2015-02-11T18:38:12.194Z,1423679892.194 [BPC1] No Fault, FailCount= 1
2015-02-11T18:38:13.028Z,1423679893.028 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:13.931Z,1423679893.931 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:14.664Z,1423679894.664 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:15.382Z,1423679895.382 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:16.322Z,1423679896.322 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:17.037Z,1423679897.037 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:17.686Z,1423679897.686 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:19.831Z,1423679899.831 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:21.330Z,1423679901.330 [NAL9602](INFO): NAL9602 initialized
2015-02-11T18:38:21.382Z,1423679901.382 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:21.386Z,1423679901.386 [Default:UpdateAndReportMinutesSinceMissionStarted] Running Loop=1
2015-02-11T18:38:21.386Z,1423679901.386 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::initialize Default:UpdateAndReportMinutesSinceMissionStarted
2015-02-11T18:38:21.386Z,1423679901.386 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Running Loop=1
2015-02-11T18:38:21.388Z,1423679901.388 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Stopped
2015-02-11T18:38:21.388Z,1423679901.388 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Running Loop=1
2015-02-11T18:38:22.155Z,1423679902.155 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:22.159Z,1423679902.159 [Default:UpdateAndReportMinutesSinceMissionStarted:B](IMPORTANT): Default mission has been running for 1.613333 min 
2015-02-11T18:38:22.161Z,1423679902.161 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Stopped
2015-02-11T18:38:22.162Z,1423679902.162 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Completed Default:UpdateAndReportMinutesSinceMissionStarted
2015-02-11T18:38:22.162Z,1423679902.162 [Default:UpdateAndReportMinutesSinceMissionStarted] Stopped
2015-02-11T18:38:22.162Z,1423679902.162 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::uninitialize Default:UpdateAndReportMinutesSinceMissionStarted
2015-02-11T18:38:22.789Z,1423679902.789 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:23.938Z,1423679903.938 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:24.862Z,1423679904.862 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:25.317Z,1423679905.317 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:25.908Z,1423679905.908 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:26.157Z,1423679906.157 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:27.117Z,1423679907.117 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:27.553Z,1423679907.553 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:27.868Z,1423679907.868 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:28.271Z,1423679908.271 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:28.830Z,1423679908.830 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:29.848Z,1423679909.848 [BPC1](ERROR): Failed to receive battery data
2015-02-11T18:38:29.849Z,1423679909.849 [BPC1] Communications Fault, FailCount= 2
2015-02-11T18:38:29.849Z,1423679909.849 [BPC1](ERROR): Communications Fault
2015-02-11T18:38:29.902Z,1423679909.902 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:29.947Z,1423679909.947 [CBIT](ERROR): Communications Fault in component: BPC1
2015-02-11T18:38:30.649Z,1423679910.649 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:31.083Z,1423679911.083 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:31.292Z,1423679911.292 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:31.323Z,1423679911.323 [CBIT](INFO): Clearing failed state for component BPC1
2015-02-11T18:38:31.323Z,1423679911.323 [BPC1] No Fault, FailCount= 2
2015-02-11T18:38:31.744Z,1423679911.744 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:32.415Z,1423679912.415 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:32.745Z,1423679912.745 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:33.726Z,1423679913.726 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:34.217Z,1423679914.217 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:34.469Z,1423679914.469 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:34.870Z,1423679914.870 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:35.180Z,1423679915.180 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:35.917Z,1423679915.917 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:36.332Z,1423679916.332 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:36.831Z,1423679916.831 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:37.045Z,1423679917.045 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:37.614Z,1423679917.614 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:37.991Z,1423679917.991 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:38.308Z,1423679918.308 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:38.619Z,1423679918.619 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:39.682Z,1423679919.682 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:40.281Z,1423679920.281 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:41.034Z,1423679921.034 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:41.735Z,1423679921.735 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:42.228Z,1423679922.228 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:43.176Z,1423679923.176 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:43.821Z,1423679923.821 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:44.488Z,1423679924.488 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:45.055Z,1423679925.055 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:45.927Z,1423679925.927 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:46.515Z,1423679926.515 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:51.241Z,1423679931.241 [BPC1](ERROR): Failed to receive battery data
2015-02-11T18:38:51.241Z,1423679931.241 [BPC1] Communications Fault, FailCount= 3
2015-02-11T18:38:51.241Z,1423679931.241 [BPC1](ERROR): Communications Fault
2015-02-11T18:38:51.248Z,1423679931.248 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:51.317Z,1423679931.317 [CBIT](ERROR): Communications Fault in component: BPC1
2015-02-11T18:38:51.847Z,1423679931.847 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:52.308Z,1423679932.308 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:53.074Z,1423679933.074 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:53.115Z,1423679933.115 [CBIT](INFO): Clearing failed state for component BPC1
2015-02-11T18:38:53.116Z,1423679933.116 [BPC1] No Fault, FailCount= 3
2015-02-11T18:38:54.101Z,1423679934.101 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:55.600Z,1423679935.600 [NAL9602](ERROR): parseGSV uart error: serial timeout
2015-02-11T18:38:55.679Z,1423679935.679 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:56.763Z,1423679936.763 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:57.451Z,1423679937.451 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:38:59.431Z,1423679939.431 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:00.727Z,1423679940.727 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:01.689Z,1423679941.689 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:03.578Z,1423679943.578 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:05.428Z,1423679945.428 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:06.236Z,1423679946.236 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:07.424Z,1423679947.424 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:08.462Z,1423679948.462 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:10.456Z,1423679950.456 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:11.054Z,1423679951.054 [BPC1](ERROR): Failed to receive battery data
2015-02-11T18:39:11.054Z,1423679951.054 [BPC1] Communications Fault, FailCount= 4
2015-02-11T18:39:11.054Z,1423679951.054 [BPC1](ERROR): Communications Fault
2015-02-11T18:39:11.060Z,1423679951.060 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:11.111Z,1423679951.111 [CBIT](ERROR): Communications Fault in component: BPC1
2015-02-11T18:39:12.015Z,1423679952.015 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:12.998Z,1423679952.998 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:13.617Z,1423679953.617 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:13.750Z,1423679953.750 [CBIT](INFO): Clearing failed state for component BPC1
2015-02-11T18:39:13.750Z,1423679953.750 [BPC1] No Fault, FailCount= 4
2015-02-11T18:39:14.808Z,1423679954.808 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:15.662Z,1423679955.662 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:17.044Z,1423679957.044 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:18.343Z,1423679958.343 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:19.507Z,1423679959.507 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:20.764Z,1423679960.764 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2015-02-11T18:39:20.858Z,1423679960.858 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:21.875Z,1423679961.875 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:23.186Z,1423679963.186 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:23.188Z,1423679963.188 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2015-02-11T18:39:23.188Z,1423679963.188 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2015-02-11T18:39:23.188Z,1423679963.188 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2015-02-11T18:39:23.198Z,1423679963.198 [DeadReckonUsingSpeedCalculator](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2015-02-11T18:39:23.198Z,1423679963.198 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2015-02-11T18:39:23.198Z,1423679963.198 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2015-02-11T18:39:23.221Z,1423679963.221 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2015-02-11T18:39:23.224Z,1423679963.224 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2015-02-11T18:39:24.421Z,1423679964.421 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:24.433Z,1423679964.433 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2015-02-11T18:39:24.433Z,1423679964.433 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2015-02-11T18:39:24.433Z,1423679964.433 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2015-02-11T18:39:24.433Z,1423679964.433 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2015-02-11T18:39:25.732Z,1423679965.732 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:25.733Z,1423679965.733 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2015-02-11T18:39:25.734Z,1423679965.734 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2015-02-11T18:39:26.660Z,1423679966.660 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:26.661Z,1423679966.661 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 0 cycles since last successful read, accepting data for 5 cycles.
2015-02-11T18:39:27.940Z,1423679967.940 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:27.941Z,1423679967.941 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 1 cycles since last successful read, accepting data for 5 cycles.
2015-02-11T18:39:28.879Z,1423679968.879 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:28.880Z,1423679968.880 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 2 cycles since last successful read, accepting data for 5 cycles.
2015-02-11T18:39:30.591Z,1423679970.591 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:30.592Z,1423679970.592 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 3 cycles since last successful read, accepting data for 5 cycles.
2015-02-11T18:39:31.725Z,1423679971.725 [BPC1](ERROR): Failed to receive battery data
2015-02-11T18:39:31.725Z,1423679971.725 [BPC1] Communications Fault, FailCount= 5
2015-02-11T18:39:31.725Z,1423679971.725 [BPC1](ERROR): Communications Fault
2015-02-11T18:39:31.731Z,1423679971.731 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:31.732Z,1423679971.732 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 4 cycles since last successful read, accepting data for 5 cycles.
2015-02-11T18:39:31.781Z,1423679971.781 [CBIT](ERROR): Communications Fault in component: BPC1
2015-02-11T18:39:32.538Z,1423679972.538 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:32.560Z,1423679972.560 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 5 cycles since last successful read, accepting data for 5 cycles.
2015-02-11T18:39:33.445Z,1423679973.445 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:34.032Z,1423679974.032 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:34.092Z,1423679974.092 [CBIT](INFO): Clearing failed state for component BPC1
2015-02-11T18:39:34.092Z,1423679974.092 [BPC1] No Fault, FailCount= 5
2015-02-11T18:39:34.511Z,1423679974.511 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:35.613Z,1423679975.613 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:36.628Z,1423679976.628 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:37.320Z,1423679977.320 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:38.183Z,1423679978.183 [CommandLine](IMPORTANT): got command failComponent
2015-02-11T18:39:38.184Z,1423679978.184 [CommandLine](IMPORTANT): Failed components:
2015-02-11T18:39:38.184Z,1423679978.184 [CommandLine](IMPORTANT): No failed Components.
2015-02-11T18:39:38.261Z,1423679978.261 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:39.420Z,1423679979.420 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:40.650Z,1423679980.650 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:41.683Z,1423679981.683 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:42.596Z,1423679982.596 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:43.424Z,1423679983.424 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:44.360Z,1423679984.360 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:46.072Z,1423679986.072 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:47.261Z,1423679987.261 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:53.123Z,1423679993.123 [BPC1](ERROR): Failed to receive battery data
2015-02-11T18:39:53.123Z,1423679993.123 [BPC1] Communications Fault, FailCount= 6
2015-02-11T18:39:53.123Z,1423679993.123 [BPC1](ERROR): Communications Fault
2015-02-11T18:39:53.129Z,1423679993.129 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:53.142Z,1423679993.142 [CBIT](ERROR): Communications Fault in component: BPC1
2015-02-11T18:39:54.854Z,1423679994.854 [NAL9602](ERROR): getFix uart error: serial timeout
2015-02-11T18:39:54.895Z,1423679994.895 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:55.727Z,1423679995.727 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:56.717Z,1423679996.717 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:56.730Z,1423679996.730 [CBIT](INFO): Clearing failed state for component BPC1
2015-02-11T18:39:56.730Z,1423679996.730 [BPC1] No Fault, FailCount= 6
2015-02-11T18:39:58.196Z,1423679998.196 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:39:59.990Z,1423679999.990 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:01.433Z,1423680001.433 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:02.698Z,1423680002.698 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:03.801Z,1423680003.801 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:05.524Z,1423680005.524 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:07.683Z,1423680007.683 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:09.225Z,1423680009.225 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:10.086Z,1423680010.086 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:10.619Z,1423680010.619 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:11.616Z,1423680011.616 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:12.610Z,1423680012.610 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:13.362Z,1423680013.362 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:13.919Z,1423680013.919 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:16.116Z,1423680016.116 [BPC1](ERROR): Failed to receive battery data
2015-02-11T18:40:16.116Z,1423680016.116 [BPC1] Communications Fault, FailCount= 7
2015-02-11T18:40:16.116Z,1423680016.116 [BPC1](ERROR): Communications Fault
2015-02-11T18:40:16.143Z,1423680016.143 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:16.202Z,1423680016.202 [CBIT](ERROR): Communications Fault in component: BPC1
2015-02-11T18:40:17.757Z,1423680017.757 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:20.098Z,1423680020.098 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:21.774Z,1423680021.774 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:21.787Z,1423680021.787 [CBIT](INFO): Clearing failed state for component BPC1
2015-02-11T18:40:21.787Z,1423680021.787 [BPC1] No Fault, FailCount= 7
2015-02-11T18:40:22.441Z,1423680022.441 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:23.295Z,1423680023.295 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:24.264Z,1423680024.264 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:25.202Z,1423680025.202 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:26.177Z,1423680026.177 [NAL9602](ERROR): parseGSV uart error: serial timeout
2015-02-11T18:40:26.207Z,1423680026.207 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:27.203Z,1423680027.203 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:27.895Z,1423680027.895 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:28.355Z,1423680028.355 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:29.045Z,1423680029.045 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:30.227Z,1423680030.227 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:32.309Z,1423680032.309 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:34.025Z,1423680034.025 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:35.374Z,1423680035.374 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:36.281Z,1423680036.281 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:37.679Z,1423680037.679 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:39.533Z,1423680039.533 [BPC1](ERROR): Failed to receive battery data
2015-02-11T18:40:39.534Z,1423680039.534 [BPC1] Communications Fault, FailCount= 8
2015-02-11T18:40:39.534Z,1423680039.534 [BPC1](ERROR): Communications Fault
2015-02-11T18:40:39.540Z,1423680039.540 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:39.574Z,1423680039.574 [CBIT](ERROR): Communications Fault in component: BPC1
2015-02-11T18:40:41.535Z,1423680041.535 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:43.925Z,1423680043.925 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:45.249Z,1423680045.249 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:45.283Z,1423680045.283 [CBIT](INFO): Clearing failed state for component BPC1
2015-02-11T18:40:45.283Z,1423680045.283 [BPC1] No Fault, FailCount= 8
2015-02-11T18:40:46.579Z,1423680046.579 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:48.592Z,1423680048.592 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:50.358Z,1423680050.358 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:56.419Z,1423680056.419 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:57.196Z,1423680057.196 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:58.437Z,1423680058.437 [NAL9602](ERROR): getFix uart error: serial timeout
2015-02-11T18:40:58.521Z,1423680058.521 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:59.537Z,1423680059.537 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:40:59.944Z,1423680059.944 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:00.586Z,1423680060.586 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:01.298Z,1423680061.298 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:01.785Z,1423680061.785 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:02.182Z,1423680062.182 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:02.828Z,1423680062.828 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:03.658Z,1423680063.658 [BPC1](ERROR): Failed to receive battery data
2015-02-11T18:41:03.658Z,1423680063.658 [BPC1] Communications Fault, FailCount= 9
2015-02-11T18:41:03.658Z,1423680063.658 [BPC1](ERROR): Communications Fault
2015-02-11T18:41:03.694Z,1423680063.694 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:03.744Z,1423680063.744 [CBIT](ERROR): Communications Fault in component: BPC1
2015-02-11T18:41:04.493Z,1423680064.493 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:05.155Z,1423680065.155 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:05.672Z,1423680065.672 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:05.685Z,1423680065.685 [CBIT](INFO): Clearing failed state for component BPC1
2015-02-11T18:41:05.685Z,1423680065.685 [BPC1] No Fault, FailCount= 9
2015-02-11T18:41:06.655Z,1423680066.655 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:08.010Z,1423680068.010 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:09.290Z,1423680069.290 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:09.883Z,1423680069.883 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:10.480Z,1423680070.480 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:11.072Z,1423680071.072 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:11.980Z,1423680071.980 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:13.774Z,1423680073.774 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:15.936Z,1423680075.936 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:16.727Z,1423680076.727 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:17.510Z,1423680077.510 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:18.411Z,1423680078.411 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:19.417Z,1423680079.417 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:20.639Z,1423680080.639 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:21.576Z,1423680081.576 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:22.370Z,1423680082.370 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:23.674Z,1423680083.674 [BPC1](ERROR): Failed to receive battery data
2015-02-11T18:41:23.674Z,1423680083.674 [BPC1] Communications Fault, FailCount= 10
2015-02-11T18:41:23.674Z,1423680083.674 [BPC1](ERROR): Communications Fault
2015-02-11T18:41:23.680Z,1423680083.680 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:23.722Z,1423680083.722 [CBIT](ERROR): Communications Fault in component: BPC1
2015-02-11T18:41:23.722Z,1423680083.722 [CBIT](CRITICAL): Communications Fault in component: BPC1
2015-02-11T18:41:25.516Z,1423680085.516 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:26.125Z,1423680086.125 [CommandLine](IMPORTANT): got command failComponent
2015-02-11T18:41:26.126Z,1423680086.126 [CommandLine](IMPORTANT): Failed components:
2015-02-11T18:41:26.126Z,1423680086.126 [CommandLine](IMPORTANT): BPC1: Communications Fault
2015-02-11T18:41:26.914Z,1423680086.914 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:28.678Z,1423680088.678 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:31.522Z,1423680091.522 [NAL9602](ERROR): parseGSV uart error: serial timeout
2015-02-11T18:41:31.607Z,1423680091.607 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:33.508Z,1423680093.508 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:35.803Z,1423680095.803 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:38.480Z,1423680098.480 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:39.572Z,1423680099.572 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:39.855Z,1423680099.855 [CommandLine](IMPORTANT): got command failComponent hardware NAL9602
2015-02-11T18:41:39.856Z,1423680099.856 [NAL9602] Hardware Fault, FailCount= 4
2015-02-11T18:41:39.856Z,1423680099.856 [NAL9602](ERROR): Hardware Fault
2015-02-11T18:41:39.856Z,1423680099.856 [CommandLine](IMPORTANT): NAL9602 failureMode is Hardware Fault
2015-02-11T18:41:40.260Z,1423680100.260 [NAL9602](INFO): Powering down
2015-02-11T18:41:40.390Z,1423680100.390 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:40.403Z,1423680100.403 [CBIT](ERROR): Hardware Fault in component: NAL9602
2015-02-11T18:41:41.883Z,1423680101.883 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:43.729Z,1423680103.729 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:43.774Z,1423680103.774 [CBIT](INFO): Clearing failed state for component NAL9602
2015-02-11T18:41:43.774Z,1423680103.774 [NAL9602] No Fault, FailCount= 4
2015-02-11T18:41:45.034Z,1423680105.034 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:46.579Z,1423680106.579 [CommandLine](IMPORTANT): got command failComponent
2015-02-11T18:41:46.579Z,1423680106.579 [CommandLine](IMPORTANT): Failed components:
2015-02-11T18:41:46.580Z,1423680106.580 [CommandLine](IMPORTANT): BPC1: Communications Fault
2015-02-11T18:41:46.631Z,1423680106.631 [NAL9602](INFO): Powering up NAL9602
2015-02-11T18:41:46.686Z,1423680106.686 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:46.691Z,1423680106.691 [Default:CheckIn:Read_GPS](INFO): Timed out from 2015-02-11T18:36:45.2Z
2015-02-11T18:41:46.691Z,1423680106.691 [Default:CheckIn:Read_GPS] Stopped
2015-02-11T18:41:46.691Z,1423680106.691 [Default:CheckIn:Read_Iridium] Running Loop=1
2015-02-11T18:41:47.843Z,1423680107.843 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:47.848Z,1423680107.848 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2015-02-11T18:41:52.634Z,1423680112.634 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:54.745Z,1423680114.745 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:56.151Z,1423680116.151 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:58.343Z,1423680118.343 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:41:59.796Z,1423680119.796 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:42:01.409Z,1423680121.409 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:42:06.794Z,1423680126.794 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:42:08.884Z,1423680128.884 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:42:10.615Z,1423680130.615 [NAL9602](ERROR): NAL9602 initialization error.
2015-02-11T18:42:10.615Z,1423680130.615 [NAL9602] Communications Fault, FailCount= 5
2015-02-11T18:42:10.615Z,1423680130.615 [NAL9602](ERROR): Communications Fault
2015-02-11T18:42:10.704Z,1423680130.704 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:42:10.725Z,1423680130.725 [CBIT](ERROR): Communications Fault in component: NAL9602
2015-02-11T18:42:10.725Z,1423680130.725 [CBIT](CRITICAL): Communications Fault in component: NAL9602
2015-02-11T18:42:11.941Z,1423680131.941 [NAL9602](INFO): Powering down
2015-02-11T18:42:12.003Z,1423680132.003 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:42:13.640Z,1423680133.640 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:42:16.050Z,1423680136.050 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:42:16.975Z,1423680136.975 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:42:21.828Z,1423680141.828 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:42:24.061Z,1423680144.061 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:42:24.172Z,1423680144.172 [CommandLine](IMPORTANT): got command failComponent
2015-02-11T18:42:24.173Z,1423680144.173 [CommandLine](IMPORTANT): Failed components:
2015-02-11T18:42:24.173Z,1423680144.173 [CommandLine](IMPORTANT): NAL9602: Communications Fault
2015-02-11T18:42:24.173Z,1423680144.173 [CommandLine](IMPORTANT): BPC1: Communications Fault
2015-02-11T18:42:26.727Z,1423680146.727 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:42:26.729Z,1423680146.729 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2015-02-11T18:42:26.729Z,1423680146.729 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2015-02-11T18:42:26.729Z,1423680146.729 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2015-02-11T18:42:26.731Z,1423680146.731 [DeadReckonUsingSpeedCalculator](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2015-02-11T18:42:26.731Z,1423680146.731 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2015-02-11T18:42:26.731Z,1423680146.731 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2015-02-11T18:42:26.773Z,1423680146.773 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2015-02-11T18:42:26.773Z,1423680146.773 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2015-02-11T18:42:27.932Z,1423680147.932 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:42:27.948Z,1423680147.948 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2015-02-11T18:42:27.948Z,1423680147.948 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2015-02-11T18:42:27.949Z,1423680147.949 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2015-02-11T18:42:27.949Z,1423680147.949 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2015-02-11T18:42:30.313Z,1423680150.313 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:42:30.314Z,1423680150.314 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2015-02-11T18:42:30.314Z,1423680150.314 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2015-02-11T18:42:31.890Z,1423680151.890 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:42:31.896Z,1423680151.896 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 0 cycles since last successful read, accepting data for 5 cycles.
2015-02-11T18:42:36.542Z,1423680156.542 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:42:36.543Z,1423680156.543 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 1 cycles since last successful read, accepting data for 5 cycles.
2015-02-11T18:42:36.885Z,1423680156.885 [CommandLine](IMPORTANT): got command failComponent none NAL9602
2015-02-11T18:42:36.885Z,1423680156.885 [NAL9602] No Fault, FailCount= 5
2015-02-11T18:42:36.885Z,1423680156.885 [CommandLine](IMPORTANT): NAL9602 failureMode is No Fault
2015-02-11T18:42:37.673Z,1423680157.673 [NAL9602](INFO): Powering up NAL9602
2015-02-11T18:42:37.721Z,1423680157.721 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:42:37.722Z,1423680157.722 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 2 cycles since last successful read, accepting data for 5 cycles.
2015-02-11T18:42:39.116Z,1423680159.116 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:42:39.117Z,1423680159.117 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 3 cycles since last successful read, accepting data for 5 cycles.
2015-02-11T18:42:41.926Z,1423680161.926 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:42:41.927Z,1423680161.927 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 4 cycles since last successful read, accepting data for 5 cycles.
2015-02-11T18:42:43.880Z,1423680163.880 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:42:43.881Z,1423680163.881 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 5 cycles since last successful read, accepting data for 5 cycles.
2015-02-11T18:42:44.322Z,1423680164.322 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:42:46.284Z,1423680166.284 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:42:51.385Z,1423680171.385 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:42:53.617Z,1423680173.617 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:42:55.593Z,1423680175.593 [NAL9602](INFO): NAL9602 initialized
2015-02-11T18:42:55.647Z,1423680175.647 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:42:56.887Z,1423680176.887 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:42:58.527Z,1423680178.527 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:42:59.622Z,1423680179.622 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:01.896Z,1423680181.896 [CommandLine](IMPORTANT): got command report
2015-02-11T18:43:01.896Z,1423680181.896 [Reporter](INFO): NAL9602.sigQuality reporting changes
2015-02-11T18:43:01.896Z,1423680181.896 [Reporter](INFO): platform_battery_charge reporting changes
2015-02-11T18:43:05.023Z,1423680185.023 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:05.823Z,1423680185.823 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:06.592Z,1423680186.592 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:07.347Z,1423680187.347 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:08.535Z,1423680188.535 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:09.059Z,1423680189.059 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:13.417Z,1423680193.417 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:14.478Z,1423680194.478 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:15.404Z,1423680195.404 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:17.363Z,1423680197.363 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:20.007Z,1423680200.007 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:21.721Z,1423680201.721 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:21.741Z,1423680201.741 [Default:UpdateAndReportMinutesSinceMissionStarted] Running Loop=1
2015-02-11T18:43:21.741Z,1423680201.741 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::initialize Default:UpdateAndReportMinutesSinceMissionStarted
2015-02-11T18:43:21.741Z,1423680201.741 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Running Loop=1
2015-02-11T18:43:21.741Z,1423680201.741 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Stopped
2015-02-11T18:43:21.741Z,1423680201.741 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Running Loop=1
2015-02-11T18:43:27.410Z,1423680207.410 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:27.418Z,1423680207.418 [Default:UpdateAndReportMinutesSinceMissionStarted:B](IMPORTANT): Default mission has been running for 6.616468 min 
2015-02-11T18:43:27.418Z,1423680207.418 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Stopped
2015-02-11T18:43:27.419Z,1423680207.419 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Completed Default:UpdateAndReportMinutesSinceMissionStarted
2015-02-11T18:43:27.419Z,1423680207.419 [Default:UpdateAndReportMinutesSinceMissionStarted] Stopped
2015-02-11T18:43:27.419Z,1423680207.419 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::uninitialize Default:UpdateAndReportMinutesSinceMissionStarted
2015-02-11T18:43:28.116Z,1423680208.116 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:29.731Z,1423680209.731 [NAL9602](ERROR): parseGSV uart error: serial timeout
2015-02-11T18:43:29.829Z,1423680209.829 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:32.749Z,1423680212.749 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:35.375Z,1423680215.375 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:37.525Z,1423680217.525 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:42.791Z,1423680222.791 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:43.544Z,1423680223.544 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:43.796Z,1423680223.796 [NAL9602](FAULT): GPS failed to acquire within timeout.
2015-02-11T18:43:43.796Z,1423680223.796 [NAL9602] Data Fault, FailCount= 6
2015-02-11T18:43:43.796Z,1423680223.796 [NAL9602](ERROR): Data Fault
2015-02-11T18:43:43.863Z,1423680223.863 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:43.918Z,1423680223.918 [CBIT](ERROR): Data Fault in component: NAL9602
2015-02-11T18:43:43.918Z,1423680223.918 [CBIT](CRITICAL): Data Fault in component: NAL9602
2015-02-11T18:43:44.167Z,1423680224.167 [NAL9602](INFO): Powering down
2015-02-11T18:43:44.186Z,1423680224.186 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:44.577Z,1423680224.577 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:44.990Z,1423680224.990 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:48.742Z,1423680228.742 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:49.102Z,1423680229.102 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:49.577Z,1423680229.577 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:49.904Z,1423680229.904 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:50.388Z,1423680230.388 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:50.762Z,1423680230.762 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:56.525Z,1423680236.525 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:56.975Z,1423680236.975 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:57.276Z,1423680237.276 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:57.693Z,1423680237.693 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:58.082Z,1423680238.082 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:58.842Z,1423680238.842 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:43:59.198Z,1423680239.198 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:44:02.733Z,1423680242.733 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:44:03.101Z,1423680243.101 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:44:03.459Z,1423680243.459 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:44:03.806Z,1423680243.806 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:44:04.208Z,1423680244.208 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:44:04.650Z,1423680244.650 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:44:08.038Z,1423680248.038 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:44:08.267Z,1423680248.267 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:44:08.618Z,1423680248.618 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:44:09.057Z,1423680249.057 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:44:09.412Z,1423680249.412 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:44:10.070Z,1423680250.070 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:44:13.354Z,1423680253.354 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:44:13.524Z,1423680253.524 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:44:13.924Z,1423680253.924 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:44:14.390Z,1423680254.390 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:44:14.793Z,1423680254.793 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:44:15.145Z,1423680255.145 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:44:16.293Z,1423680256.293 [CommandLine](IMPORTANT): got command restart application
2015-02-11T18:44:17.298Z,1423680257.298 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2015-02-11T18:44:17.298Z,1423680257.298 [CommandLine ThreadHandler](INFO): Thread cancelled.
2015-02-11T18:44:17.310Z,1423680257.310 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2015-02-11T18:44:17.311Z,1423680257.311 [CommandLine ThreadHandler](INFO): Thread cancelled.
2015-02-11T18:44:17.311Z,1423680257.311 [CommandLine](INFO): Join timeout helper Thread ID is 2206
2015-02-11T18:44:17.322Z,1423680257.322 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2015-02-11T18:44:17.323Z,1423680257.323 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2015-02-11T18:44:17.323Z,1423680257.323 [NavChartDb](INFO): Join timeout helper Thread ID is 2207
2015-02-11T18:44:17.559Z,1423680257.559 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2015-02-11T18:44:17.559Z,1423680257.559 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2015-02-11T18:44:17.563Z,1423680257.563 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2015-02-11T18:44:17.563Z,1423680257.563 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2015-02-11T18:44:17.563Z,1423680257.563 [Radio_Surface](INFO): Join timeout helper Thread ID is 2208
2015-02-11T18:44:17.920Z,1423680257.920 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2015-02-11T18:44:17.920Z,1423680257.920 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2015-02-11T18:44:17.936Z,1423680257.936 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2015-02-11T18:44:17.936Z,1423680257.936 [logger ThreadHandler](INFO): Thread cancelled.
2015-02-11T18:44:17.936Z,1423680257.936 [logger](INFO): Join timeout helper Thread ID is 2209
2015-02-11T18:44:17.952Z,1423680257.952 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2015-02-11T18:44:17.952Z,1423680257.952 [logger ThreadHandler](INFO): Thread cancelled.
2015-02-11T18:44:17.967Z,1423680257.967 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2015-02-11T18:44:17.968Z,1423680257.968 [CommandLine ThreadHandler](INFO): Thread cancelled.
2015-02-11T18:44:17.968Z,1423680257.968 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2015-02-11T18:44:17.968Z,1423680257.968 [controlThread ThreadHandler](INFO): Thread cancelled.
2015-02-11T18:44:17.968Z,1423680257.968 [controlThread](INFO): Join timeout helper Thread ID is 2210
2015-02-11T18:44:18.786Z,1423680258.786 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-11T18:44:18.800Z,1423680258.800 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2015-02-11T18:44:18.801Z,1423680258.801 [controlThread](DEBUG): Uninitializing ControlThread
2015-02-11T18:44:18.804Z,1423680258.804 [NAL9602](INFO): Powering down
2015-02-11T18:44:18.806Z,1423680258.806 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2015-02-11T18:44:18.810Z,1423680258.810 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2015-02-11T18:44:18.811Z,1423680258.811 [Default] Stopped
2015-02-11T18:44:18.811Z,1423680258.811 [Default](INFO): Aggregate::uninitialize Default
2015-02-11T18:44:18.811Z,1423680258.811 [Default:B.GoToSurface] Stopped
2015-02-11T18:44:18.811Z,1423680258.811 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2015-02-11T18:44:18.811Z,1423680258.811 [Default:CheckIn] Stopped
2015-02-11T18:44:18.811Z,1423680258.811 [Default:CheckIn](INFO): Aggregate::uninitialize Default:CheckIn
2015-02-11T18:44:18.811Z,1423680258.811 [Default:CheckIn:A.SetSpeed] Stopped
2015-02-11T18:44:18.811Z,1423680258.811 [Default:CheckIn:A.SetSpeed](DEBUG): Uninitialize.
2015-02-11T18:44:18.812Z,1423680258.812 [Default:CheckIn:Read_Iridium] Stopped
2015-02-11T18:44:18.812Z,1423680258.812 [Default:WaitAtTheSurface] Stopped
2015-02-11T18:44:18.812Z,1423680258.812 [Default:WaitAtTheSurface](INFO): Aggregate::uninitialize Default:WaitAtTheSurface
2015-02-11T18:44:18.812Z,1423680258.812 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed] Stopped
2015-02-11T18:44:18.812Z,1423680258.812 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed](DEBUG): Uninitialize.
2015-02-11T18:44:18.815Z,1423680258.815 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2015-02-11T18:44:18.816Z,1423680258.816 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2015-02-11T18:44:18.816Z,1423680258.816 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2015-02-11T18:44:18.816Z,1423680258.816 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2015-02-11T18:44:18.817Z,1423680258.817 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2015-02-11T18:44:18.817Z,1423680258.817 [BuoyancyServo](INFO): Powering down
2015-02-11T18:44:18.829Z,1423680258.829 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2015-02-11T18:44:18.829Z,1423680258.829 [ElevatorServo](INFO): Powering down
2015-02-11T18:44:18.830Z,1423680258.830 [MassServo](DEBUG): Uninitialize Mass Servo.
2015-02-11T18:44:18.830Z,1423680258.830 [MassServo](INFO): Powering down
2015-02-11T18:44:18.831Z,1423680258.831 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2015-02-11T18:44:18.831Z,1423680258.831 [RudderServo](INFO): Powering down
2015-02-11T18:44:18.832Z,1423680258.832 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2015-02-11T18:44:18.832Z,1423680258.832 [ThrusterServo](INFO): Powering down
2015-02-11T18:44:18.833Z,1423680258.833 [SBIT](DEBUG): Uninitialize SBIT Component.
2015-02-11T18:44:18.833Z,1423680258.833 [IBIT](DEBUG): Uninitialize IBIT Component.
2015-02-11T18:44:18.834Z,1423680258.834 [CBIT](DEBUG): Uninitialize CBIT Component.
2015-02-11T18:44:18.866Z,1423680258.866 [controlThread ThreadHandler](INFO): Thread cancelled.
2015-02-11T18:44:18.992Z,1423680258.992 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2015-02-11T18:44:19.038Z,1423680259.038 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2015-02-11T18:44:19.090Z,1423680259.090 [logger ThreadHandler](INFO): Thread cancelled.