2014-09-23T04:08:51.292Z,1411445331.292 [Supervisor](DEBUG): Initializing supervisor.
2014-09-23T04:08:51.294Z,1411445331.294 [SyncHandler](DEBUG): Created PCaller Thread at 4034C4E0
2014-09-23T04:08:51.295Z,1411445331.295 [SyncHandler](INFO): Protected caller Thread ID is 767
2014-09-23T04:08:51.295Z,1411445331.295 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2014-09-23T04:08:51.296Z,1411445331.296 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4037C4E0
2014-09-23T04:08:51.297Z,1411445331.297 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 768
2014-09-23T04:08:51.299Z,1411445331.299 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2014-09-23T04:08:51.312Z,1411445331.312 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2014-09-23T04:08:51.313Z,1411445331.313 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 403AC4E0
2014-09-23T04:08:51.313Z,1411445331.313 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 769
2014-09-23T04:08:51.314Z,1411445331.314 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2014-09-23T04:08:51.315Z,1411445331.315 [logger ThreadHandler](DEBUG): Created PCaller Thread at 403DC4E0
2014-09-23T04:08:51.315Z,1411445331.315 [logger ThreadHandler](INFO): Protected caller Thread ID is 770
2014-09-23T04:08:51.317Z,1411445331.317 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2014-09-23T04:08:51.318Z,1411445331.318 [Supervisor](INFO): Looking for Config files in directory: Config/
2014-09-23T04:08:51.321Z,1411445331.321 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2014-09-23T04:08:51.664Z,1411445331.664 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2014-09-23T04:08:51.665Z,1411445331.665 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2014-09-23T04:08:51.826Z,1411445331.826 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2014-09-23T04:08:51.829Z,1411445331.829 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2014-09-23T04:08:51.940Z,1411445331.940 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2014-09-23T04:08:51.942Z,1411445331.942 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2014-09-23T04:08:52.069Z,1411445332.069 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2014-09-23T04:08:52.070Z,1411445332.070 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2014-09-23T04:08:52.157Z,1411445332.157 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2014-09-23T04:08:52.305Z,1411445332.305 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2014-09-23T04:08:52.305Z,1411445332.305 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2014-09-23T04:08:52.393Z,1411445332.393 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2014-09-23T04:08:52.394Z,1411445332.394 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2014-09-23T04:08:52.597Z,1411445332.597 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2014-09-23T04:08:52.600Z,1411445332.600 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2014-09-23T04:08:52.942Z,1411445332.942 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2014-09-23T04:08:52.943Z,1411445332.943 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2014-09-23T04:08:53.253Z,1411445333.253 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2014-09-23T04:08:53.254Z,1411445333.254 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2014-09-23T04:08:53.761Z,1411445333.761 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2014-09-23T04:08:53.761Z,1411445333.761 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2014-09-23T04:08:53.972Z,1411445333.972 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2014-09-23T04:08:53.973Z,1411445333.973 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2014-09-23T04:08:54.079Z,1411445334.079 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2014-09-23T04:08:54.081Z,1411445334.081 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2014-09-23T04:08:54.502Z,1411445334.502 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2014-09-23T04:08:54.503Z,1411445334.503 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2014-09-23T04:08:54.618Z,1411445334.618 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2014-09-23T04:08:54.620Z,1411445334.620 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2014-09-23T04:08:54.624Z,1411445334.624 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2014-09-23T04:08:54.868Z,1411445334.868 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2014-09-23T04:08:54.868Z,1411445334.868 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2014-09-23T04:09:09.071Z,1411445349.071 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Estimation.cfg
2014-09-23T04:09:09.468Z,1411445349.468 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2014-09-23T04:09:10.384Z,1411445350.384 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2014-09-23T04:09:10.484Z,1411445350.484 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2014-09-23T04:09:10.628Z,1411445350.628 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2014-09-23T04:09:10.802Z,1411445350.802 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2014-09-23T04:09:10.906Z,1411445350.906 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2014-09-23T04:09:10.994Z,1411445350.994 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2014-09-23T04:09:11.089Z,1411445351.089 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2014-09-23T04:09:11.190Z,1411445351.190 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2014-09-23T04:09:11.368Z,1411445351.368 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2014-09-23T04:09:11.373Z,1411445351.373 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2014-09-23T04:09:11.448Z,1411445351.448 [VerticalControl](DEBUG): Construct VerticalControl.
2014-09-23T04:09:11.572Z,1411445351.572 [VerticalControl] Loaded
2014-09-23T04:09:11.572Z,1411445351.572 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2014-09-23T04:09:11.573Z,1411445351.573 [HorizontalControl](DEBUG): Construct HorizontalControl.
2014-09-23T04:09:11.646Z,1411445351.646 [HorizontalControl] Loaded
2014-09-23T04:09:11.647Z,1411445351.647 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2014-09-23T04:09:11.647Z,1411445351.647 [SpeedControl](DEBUG): Construct SpeedControl.
2014-09-23T04:09:11.653Z,1411445351.653 [SpeedControl] Loaded
2014-09-23T04:09:11.654Z,1411445351.654 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2014-09-23T04:09:11.654Z,1411445351.654 [LoopControl](DEBUG): Construct LoopControl.
2014-09-23T04:09:11.655Z,1411445351.655 [LoopControl] Loaded
2014-09-23T04:09:11.655Z,1411445351.655 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2014-09-23T04:09:11.656Z,1411445351.656 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2014-09-23T04:09:11.657Z,1411445351.657 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2014-09-23T04:09:11.782Z,1411445351.782 [SBIT](DEBUG): Construct Startup Built In Test.
2014-09-23T04:09:11.794Z,1411445351.794 [SBIT] Loaded
2014-09-23T04:09:11.794Z,1411445351.794 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2014-09-23T04:09:11.795Z,1411445351.795 [IBIT](DEBUG): Construct Initiated Built In Test.
2014-09-23T04:09:11.825Z,1411445351.825 [IBIT] Loaded
2014-09-23T04:09:11.825Z,1411445351.825 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2014-09-23T04:09:11.827Z,1411445351.827 [CBIT](DEBUG): Construct CBIT Built In Test.
2014-09-23T04:09:11.951Z,1411445351.951 [CBIT] Loaded
2014-09-23T04:09:11.951Z,1411445351.951 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2014-09-23T04:09:11.952Z,1411445351.952 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2014-09-23T04:09:11.952Z,1411445351.952 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2014-09-23T04:09:11.984Z,1411445351.984 [DepthRateCalculator] Loaded
2014-09-23T04:09:11.984Z,1411445351.984 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2014-09-23T04:09:11.990Z,1411445351.990 [PitchRateCalculator] Loaded
2014-09-23T04:09:11.990Z,1411445351.990 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2014-09-23T04:09:12.002Z,1411445352.002 [SpeedCalculator] Loaded
2014-09-23T04:09:12.002Z,1411445352.002 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2014-09-23T04:09:12.019Z,1411445352.019 [TempGradientCalculator] Loaded
2014-09-23T04:09:12.019Z,1411445352.019 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2014-09-23T04:09:12.025Z,1411445352.025 [YawRateCalculator] Loaded
2014-09-23T04:09:12.025Z,1411445352.025 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2014-09-23T04:09:12.026Z,1411445352.026 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2014-09-23T04:09:12.026Z,1411445352.026 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2014-09-23T04:09:13.386Z,1411445353.386 [HFRCMReconstructedInterpolator] Loaded
2014-09-23T04:09:13.387Z,1411445353.387 [ComponentRegistry](DEBUG): SyncComponent "HFRCMReconstructedInterpolator" handled in the control thread.
2014-09-23T04:09:13.387Z,1411445353.387 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2014-09-23T04:09:13.388Z,1411445353.388 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2014-09-23T04:09:13.675Z,1411445353.675 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2014-09-23T04:09:13.676Z,1411445353.676 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2014-09-23T04:09:13.771Z,1411445353.771 [DeadReckonUsingMultipleVelocitySources] Loaded
2014-09-23T04:09:13.771Z,1411445353.771 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2014-09-23T04:09:13.817Z,1411445353.817 [DeadReckonWithRespectToWater] Loaded
2014-09-23T04:09:13.817Z,1411445353.817 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToWater" handled in the control thread.
2014-09-23T04:09:13.864Z,1411445353.864 [DeadReckonWithRespectToSeafloor] Loaded
2014-09-23T04:09:13.864Z,1411445353.864 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2014-09-23T04:09:13.915Z,1411445353.915 [DeadReckonUsingDVLWaterTrack] Loaded
2014-09-23T04:09:13.915Z,1411445353.915 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingDVLWaterTrack" handled in the control thread.
2014-09-23T04:09:13.934Z,1411445353.934 [NavChart] Loaded
2014-09-23T04:09:13.934Z,1411445353.934 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2014-09-23T04:09:13.938Z,1411445353.938 [UniversalFixResidualReporter] Loaded
2014-09-23T04:09:13.939Z,1411445353.939 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2014-09-23T04:09:13.939Z,1411445353.939 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2014-09-23T04:09:13.940Z,1411445353.940 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2014-09-23T04:09:13.949Z,1411445353.949 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2014-09-23T04:09:13.950Z,1411445353.950 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2014-09-23T04:09:14.153Z,1411445354.153 [Aanderaa_O2] Loaded
2014-09-23T04:09:14.153Z,1411445354.153 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2014-09-23T04:09:14.190Z,1411445354.190 [CTD_NeilBrown] Loaded
2014-09-23T04:09:14.190Z,1411445354.190 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2014-09-23T04:09:14.192Z,1411445354.192 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 405D94E0
2014-09-23T04:09:14.192Z,1411445354.192 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 855
2014-09-23T04:09:14.210Z,1411445354.210 [rhodamine] Loaded
2014-09-23T04:09:14.210Z,1411445354.210 [ComponentRegistry](DEBUG): SyncComponent "rhodamine" handled in the control thread.
2014-09-23T04:09:14.246Z,1411445354.246 [WetLabsBB2FL] Loaded
2014-09-23T04:09:14.247Z,1411445354.247 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2014-09-23T04:09:14.248Z,1411445354.248 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406094E0
2014-09-23T04:09:14.248Z,1411445354.248 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 856
2014-09-23T04:09:14.249Z,1411445354.249 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2014-09-23T04:09:14.251Z,1411445354.251 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2014-09-23T04:09:14.955Z,1411445354.955 [AHRS_sp3003D] Loaded
2014-09-23T04:09:14.955Z,1411445354.955 [ComponentRegistry](DEBUG): SyncComponent "AHRS_sp3003D" handled in the control thread.
2014-09-23T04:09:15.002Z,1411445355.002 [AcousticModem_Benthos_ATM900] Loaded
2014-09-23T04:09:15.002Z,1411445355.002 [ComponentRegistry](DEBUG): SyncComponent "AcousticModem_Benthos_ATM900" handled in the control thread.
2014-09-23T04:09:15.163Z,1411445355.163 [DataOverHttps] Loaded
2014-09-23T04:09:15.163Z,1411445355.163 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2014-09-23T04:09:15.177Z,1411445355.177 [Depth_Keller] Loaded
2014-09-23T04:09:15.177Z,1411445355.177 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2014-09-23T04:09:15.183Z,1411445355.183 [DropWeight] Loaded
2014-09-23T04:09:15.183Z,1411445355.183 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2014-09-23T04:09:15.327Z,1411445355.327 [DVL_micro] Loaded
2014-09-23T04:09:15.327Z,1411445355.327 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread.
2014-09-23T04:09:15.425Z,1411445355.425 [NAL9602] Loaded
2014-09-23T04:09:15.425Z,1411445355.425 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2014-09-23T04:09:15.468Z,1411445355.468 [Onboard] Loaded
2014-09-23T04:09:15.469Z,1411445355.469 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2014-09-23T04:09:15.476Z,1411445355.476 [Radio_Surface] Loaded
2014-09-23T04:09:15.476Z,1411445355.476 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2014-09-23T04:09:15.477Z,1411445355.477 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408534E0
2014-09-23T04:09:15.478Z,1411445355.478 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 857
2014-09-23T04:09:17.401Z,1411445357.401 [BPC1] Loaded
2014-09-23T04:09:17.402Z,1411445357.402 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2014-09-23T04:09:17.402Z,1411445357.402 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2014-09-23T04:09:17.403Z,1411445357.403 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2014-09-23T04:09:29.432Z,1411445369.432 [BuoyancyServo] Loaded
2014-09-23T04:09:29.432Z,1411445369.432 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2014-09-23T04:09:29.445Z,1411445369.445 [ElevatorServo] Loaded
2014-09-23T04:09:29.445Z,1411445369.445 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2014-09-23T04:09:29.457Z,1411445369.457 [MassServo] Loaded
2014-09-23T04:09:29.458Z,1411445369.458 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2014-09-23T04:09:29.470Z,1411445369.470 [RudderServo] Loaded
2014-09-23T04:09:29.470Z,1411445369.470 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2014-09-23T04:09:29.482Z,1411445369.482 [ThrusterServo] Loaded
2014-09-23T04:09:29.482Z,1411445369.482 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2014-09-23T04:09:29.483Z,1411445369.483 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2014-09-23T04:09:29.484Z,1411445369.484 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2014-09-23T04:09:29.681Z,1411445369.681 [InternalSim] Loaded
2014-09-23T04:09:29.682Z,1411445369.682 [ComponentRegistry](DEBUG): SyncComponent "InternalSim" handled in the control thread.
2014-09-23T04:09:29.682Z,1411445369.682 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2014-09-23T04:09:29.683Z,1411445369.683 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2014-09-23T04:09:29.725Z,1411445369.725 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2014-09-23T04:09:29.727Z,1411445369.727 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2014-09-23T04:09:29.728Z,1411445369.728 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2014-09-23T04:09:29.735Z,1411445369.735 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2014-09-23T04:09:29.736Z,1411445369.736 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 409044E0
2014-09-23T04:09:29.736Z,1411445369.736 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 858
2014-09-23T04:09:29.741Z,1411445369.741 [Supervisor](INFO): Main Thread ID is 766
2014-09-23T04:09:29.741Z,1411445369.741 [Supervisor](DEBUG): Running supervisor.
2014-09-23T04:09:29.742Z,1411445369.742 [CommandLine ThreadHandler](INFO): Handler Thread ID is 859
2014-09-23T04:09:29.758Z,1411445369.758 [controlThread ThreadHandler](INFO): Handler Thread ID is 860
2014-09-23T04:09:29.758Z,1411445369.758 [controlThread](DEBUG): Initializing ControlThread
2014-09-23T04:09:29.759Z,1411445369.759 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2014-09-23T04:09:29.761Z,1411445369.761 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2014-09-23T04:09:29.762Z,1411445369.762 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2014-09-23T04:09:29.762Z,1411445369.762 [LoopControl](DEBUG): Initialize LoopControlComponent.
2014-09-23T04:09:29.763Z,1411445369.763 [SBIT](INFO): Initialize SBIT Component.
2014-09-23T04:09:29.763Z,1411445369.763 [SBIT](IMPORTANT): Tethys CM Info: SVN revision:11693
2014-09-23T04:09:29.763Z,1411445369.763 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2014-09-23T04:09:29.764Z,1411445369.764 [SBIT](IMPORTANT): Kernel Version:#639 PREEMPT Wed Mar 12 12:53:33 PDT 2014
2014-09-23T04:09:29.764Z,1411445369.764 [IBIT](INFO): Initialize IBIT Component.
2014-09-23T04:09:29.765Z,1411445369.765 [CBIT](DEBUG): Initialize CBIT Component.
2014-09-23T04:09:29.765Z,1411445369.765 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2014-09-23T04:09:29.766Z,1411445369.766 [logger ThreadHandler](INFO): Handler Thread ID is 861
2014-09-23T04:09:29.785Z,1411445369.785 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 862
2014-09-23T04:09:29.786Z,1411445369.786 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown.
2014-09-23T04:09:29.789Z,1411445369.789 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2014-09-23T04:09:29.790Z,1411445369.790 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2014-09-23T04:09:29.790Z,1411445369.790 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2014-09-23T04:09:29.790Z,1411445369.790 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2014-09-23T04:09:29.791Z,1411445369.791 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2014-09-23T04:09:29.792Z,1411445369.792 [HFRCMReconstructedInterpolator](INFO): Initializing HFRCMReconstructedInterpolator component with velocityAccuracy_ = 0.300000 m/s.
2014-09-23T04:09:29.794Z,1411445369.794 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2014-09-23T04:09:29.794Z,1411445369.794 [DeadReckonWithRespectToWater](DEBUG): Initializing DeadReckonWithRespectToWater component.
2014-09-23T04:09:29.794Z,1411445369.794 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component.
2014-09-23T04:09:29.795Z,1411445369.795 [DeadReckonUsingDVLWaterTrack](DEBUG): Initializing DeadReckonUsingDVLWaterTrack component.
2014-09-23T04:09:29.795Z,1411445369.795 [NavChart](DEBUG): Initialize NavChart Navigation.
2014-09-23T04:09:29.795Z,1411445369.795 [UniversalFixResidualReporter](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2014-09-23T04:09:29.801Z,1411445369.801 [InternalSim](DEBUG):  InternalSim initializing...
2014-09-23T04:09:29.810Z,1411445369.810 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2014-09-23T04:09:29.811Z,1411445369.811 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 864
2014-09-23T04:09:29.812Z,1411445369.812 [WetLabsBB2FL](INFO): Powering down
2014-09-23T04:09:29.846Z,1411445369.846 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 865
2014-09-23T04:09:29.857Z,1411445369.857 [Radio_Surface](INFO): Powering up
2014-09-23T04:09:29.870Z,1411445369.870 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 866
2014-09-23T04:09:29.990Z,1411445369.990 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2014-09-23T04:09:31.603Z,1411445371.603 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2014-09-23T04:09:31.610Z,1411445371.610 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources
2014-09-23T04:09:31.611Z,1411445371.611 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2014-09-23T04:09:31.611Z,1411445371.611 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2014-09-23T04:09:31.611Z,1411445371.611 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2014-09-23T04:09:31.611Z,1411445371.611 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2014-09-23T04:09:31.611Z,1411445371.611 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2014-09-23T04:09:31.612Z,1411445371.612 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2014-09-23T04:09:31.612Z,1411445371.612 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2014-09-23T04:09:31.612Z,1411445371.612 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2014-09-23T04:09:31.656Z,1411445371.656 [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>


2014-09-23T04:09:31.657Z,1411445371.657 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2014-09-23T04:09:31.745Z,1411445371.745 [MissionManager](INFO): DefineArg Default.TimeMissionWasStarted = 0.000000 h
2014-09-23T04:09:31.748Z,1411445371.748 [MissionManager](INFO): DefineArg Default.ElapsedSinceMissionWasStarted = 0.000000 h
2014-09-23T04:09:31.769Z,1411445371.769 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2014-09-23T04:09:31.798Z,1411445371.798 [Default:CheckIn:A.SetSpeed](DEBUG): Construct.
2014-09-23T04:09:31.820Z,1411445371.820 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2014-09-23T04:09:31.842Z,1411445371.842 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed](DEBUG): Construct.
2014-09-23T04:09:31.864Z,1411445371.864 [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>


2014-09-23T04:09:31.870Z,1411445371.870 [controlThread](DEBUG): Component order: CycleStarter,InternalSim,Aanderaa_O2,rhodamine,AHRS_sp3003D,AcousticModem_Benthos_ATM900,DataOverHttps,Depth_Keller,DropWeight,DVL_micro,NAL9602,Onboard,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,HFRCMReconstructedInterpolator,DeadReckonUsingMultipleVelocitySources,DeadReckonWithRespectToWater,DeadReckonWithRespectToSeafloor,DeadReckonUsingDVLWaterTrack,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2014-09-23T04:09:32.016Z,1411445372.016 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D.
2014-09-23T04:09:32.047Z,1411445372.047 [AcousticModem_Benthos_ATM900](INFO): Powering up
2014-09-23T04:09:32.047Z,1411445372.047 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2014-09-23T04:09:32.228Z,1411445372.228 [DVL_micro](INFO): Initializing
2014-09-23T04:09:32.259Z,1411445372.259 [NAL9602](INFO): Powering up NAL9602
2014-09-23T04:09:32.634Z,1411445372.634 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:32.647Z,1411445372.647 [DeadReckonUsingMultipleVelocitySources](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T04:09:32.666Z,1411445372.666 [DeadReckonWithRespectToWater](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T04:09:32.686Z,1411445372.686 [DeadReckonWithRespectToSeafloor](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T04:09:32.693Z,1411445372.693 [DeadReckonUsingDVLWaterTrack](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T04:09:32.836Z,1411445372.836 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2014-09-23T04:09:32.842Z,1411445372.842 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2014-09-23T04:09:32.856Z,1411445372.856 [ElevatorServo](DEBUG): Initializing EZServoServo.
2014-09-23T04:09:32.862Z,1411445372.862 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2014-09-23T04:09:32.880Z,1411445372.880 [MassServo](DEBUG): Initializing EZServoServo.
2014-09-23T04:09:32.886Z,1411445372.886 [MassServo](DEBUG): Initializing MassServo.
2014-09-23T04:09:32.904Z,1411445372.904 [RudderServo](DEBUG): Initializing EZServoServo.
2014-09-23T04:09:32.910Z,1411445372.910 [RudderServo](DEBUG): Initializing RudderServo.
2014-09-23T04:09:32.924Z,1411445372.924 [ThrusterServo](DEBUG): Initializing EZServoServo.
2014-09-23T04:09:32.930Z,1411445372.930 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2014-09-23T04:09:33.222Z,1411445373.222 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:33.223Z,1411445373.223 [DeadReckonUsingMultipleVelocitySources](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T04:09:33.224Z,1411445373.224 [DeadReckonWithRespectToWater](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T04:09:33.225Z,1411445373.225 [DeadReckonWithRespectToSeafloor](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T04:09:33.226Z,1411445373.226 [DeadReckonUsingDVLWaterTrack](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T04:09:33.594Z,1411445373.594 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:33.594Z,1411445373.594 [DeadReckonUsingMultipleVelocitySources](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T04:09:33.601Z,1411445373.601 [DeadReckonWithRespectToWater](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T04:09:33.602Z,1411445373.602 [DeadReckonWithRespectToSeafloor](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T04:09:33.615Z,1411445373.615 [DeadReckonUsingDVLWaterTrack](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T04:09:34.332Z,1411445374.332 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:34.777Z,1411445374.777 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:35.236Z,1411445375.236 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:35.530Z,1411445375.530 [Aanderaa_O2](INFO): Powering down
2014-09-23T04:09:36.189Z,1411445376.189 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:36.920Z,1411445376.920 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:37.575Z,1411445377.575 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:38.402Z,1411445378.402 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:39.150Z,1411445379.150 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:39.866Z,1411445379.866 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:40.356Z,1411445380.356 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:40.757Z,1411445380.757 [AcousticModem_Benthos_ATM900](DEBUG): 
2014-09-23T04:09:40.960Z,1411445380.960 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:41.363Z,1411445381.363 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:41.747Z,1411445381.747 [AcousticModem_Benthos_ATM900](DEBUG): Teledyne Benthos ATM-900 Series
2014-09-23T04:09:41.748Z,1411445381.748 [AcousticModem_Benthos_ATM900](DEBUG): MF Frequency Band
2014-09-23T04:09:41.748Z,1411445381.748 [AcousticModem_Benthos_ATM900](DEBUG): Standard version 8.8.9
2014-09-23T04:09:41.787Z,1411445381.787 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:42.195Z,1411445382.195 [AcousticModem_Benthos_ATM900](DEBUG): Sep 23 2014 04:06:44 
2014-09-23T04:09:42.295Z,1411445382.295 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:42.771Z,1411445382.771 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:43.197Z,1411445383.197 [AcousticModem_Benthos_ATM900](INFO): entering command mode
2014-09-23T04:09:43.298Z,1411445383.298 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:43.709Z,1411445383.709 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T04:09:43.710Z,1411445383.710 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt 1: user:1>
2014-09-23T04:09:43.710Z,1411445383.710 [AcousticModem_Benthos_ATM900](INFO): command mode acknowledged
2014-09-23T04:09:43.718Z,1411445383.718 [NAL9602](INFO): NAL9602 initialized
2014-09-23T04:09:43.750Z,1411445383.750 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:44.150Z,1411445384.150 [AcousticModem_Benthos_ATM900](INFO): setting local address to 3
2014-09-23T04:09:44.283Z,1411445384.283 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:44.678Z,1411445384.678 [AcousticModem_Benthos_ATM900](DEBUG): checking for local address setting acknowledgment
2014-09-23T04:09:44.679Z,1411445384.679 [AcousticModem_Benthos_ATM900](INFO): set local address to 3
2014-09-23T04:09:44.731Z,1411445384.731 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:45.124Z,1411445385.124 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt 2: user:2>
2014-09-23T04:09:45.209Z,1411445385.209 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:45.706Z,1411445385.706 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:45.734Z,1411445385.734 [SBIT](IMPORTANT): Beginning Startup BIT
2014-09-23T04:09:45.743Z,1411445385.743 [CBIT](IMPORTANT): Beginning GF scan
2014-09-23T04:09:46.194Z,1411445386.194 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:46.706Z,1411445386.706 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:47.204Z,1411445387.204 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:47.669Z,1411445387.669 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:48.236Z,1411445388.236 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:49.114Z,1411445389.114 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:49.631Z,1411445389.631 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:50.259Z,1411445390.259 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:50.733Z,1411445390.733 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:51.273Z,1411445391.273 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:51.782Z,1411445391.782 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:52.275Z,1411445392.275 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:52.823Z,1411445392.823 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:53.344Z,1411445393.344 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:53.919Z,1411445393.919 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:54.418Z,1411445394.418 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:54.935Z,1411445394.935 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:55.520Z,1411445395.520 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:55.985Z,1411445395.985 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:56.538Z,1411445396.538 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:57.023Z,1411445397.023 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:57.483Z,1411445397.483 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:57.995Z,1411445397.995 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:58.501Z,1411445398.501 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:59.026Z,1411445399.026 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:09:59.503Z,1411445399.503 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:00.075Z,1411445400.075 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:00.584Z,1411445400.584 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:01.045Z,1411445401.045 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:01.935Z,1411445401.935 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:02.532Z,1411445402.532 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:03.024Z,1411445403.024 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:03.593Z,1411445403.593 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:04.102Z,1411445404.102 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:04.599Z,1411445404.599 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:05.088Z,1411445405.088 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:05.608Z,1411445405.608 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:06.218Z,1411445406.218 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:06.770Z,1411445406.770 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:07.326Z,1411445407.326 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:07.847Z,1411445407.847 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:08.387Z,1411445408.387 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:08.904Z,1411445408.904 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:09.390Z,1411445409.390 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:09.951Z,1411445409.951 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:10.467Z,1411445410.467 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:10.968Z,1411445410.968 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:11.573Z,1411445411.573 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:12.086Z,1411445412.086 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:12.650Z,1411445412.650 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:12.793Z,1411445412.793 [CBIT](IMPORTANT): No ground fault detected
2014-09-23T04:10:13.268Z,1411445413.268 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:13.951Z,1411445413.951 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:14.414Z,1411445414.414 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:14.919Z,1411445414.919 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:15.453Z,1411445415.453 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:15.952Z,1411445415.952 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:16.465Z,1411445416.465 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:16.946Z,1411445416.946 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:17.462Z,1411445417.462 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:17.911Z,1411445417.911 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:18.349Z,1411445418.349 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:18.795Z,1411445418.795 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:19.396Z,1411445419.396 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:19.910Z,1411445419.910 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:20.375Z,1411445420.375 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:20.859Z,1411445420.859 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:21.324Z,1411445421.324 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:21.812Z,1411445421.812 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:22.270Z,1411445422.270 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:22.766Z,1411445422.766 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:23.323Z,1411445423.323 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:23.803Z,1411445423.803 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:24.261Z,1411445424.261 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:24.752Z,1411445424.752 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:25.234Z,1411445425.234 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:25.714Z,1411445425.714 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:26.172Z,1411445426.172 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:26.710Z,1411445426.710 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:27.153Z,1411445427.153 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:27.606Z,1411445427.606 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:28.079Z,1411445428.079 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:28.601Z,1411445428.601 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:29.458Z,1411445429.458 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:29.958Z,1411445429.958 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:30.583Z,1411445430.583 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:31.039Z,1411445431.039 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:31.560Z,1411445431.560 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:32.128Z,1411445432.128 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:32.535Z,1411445432.535 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:32.939Z,1411445432.939 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:33.400Z,1411445433.400 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:33.840Z,1411445433.840 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:34.279Z,1411445434.279 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:34.699Z,1411445434.699 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:35.132Z,1411445435.132 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:35.630Z,1411445435.630 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:36.037Z,1411445436.037 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:36.488Z,1411445436.488 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:36.903Z,1411445436.903 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:37.309Z,1411445437.309 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:37.696Z,1411445437.696 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:38.096Z,1411445438.096 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:38.499Z,1411445438.499 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:38.897Z,1411445438.897 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:39.320Z,1411445439.320 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:39.765Z,1411445439.765 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:39.789Z,1411445439.789 [SBIT](IMPORTANT): SBIT PASSED
2014-09-23T04:10:40.178Z,1411445440.178 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:40.199Z,1411445440.199 [MissionManager](IMPORTANT): Started mission Startup
2014-09-23T04:10:40.199Z,1411445440.199 [Startup] Running Loop=1
2014-09-23T04:10:40.199Z,1411445440.199 [Startup](INFO): Aggregate::initialize Startup
2014-09-23T04:10:40.199Z,1411445440.199 [Startup:A.GoToSurface] Running Loop=1
2014-09-23T04:10:40.199Z,1411445440.199 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-09-23T04:10:40.200Z,1411445440.200 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2014-09-23T04:10:40.200Z,1411445440.200 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2014-09-23T04:10:40.201Z,1411445440.201 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 0.500000 m/s.
2014-09-23T04:10:40.207Z,1411445440.207 [Startup:StartupSatComms] Running Loop=1
2014-09-23T04:10:40.207Z,1411445440.207 [Startup:StartupSatComms](INFO): Aggregate::initialize Startup:StartupSatComms
2014-09-23T04:10:40.208Z,1411445440.208 [Startup:StartupSatComms:A] Running Loop=1
2014-09-23T04:10:40.601Z,1411445440.601 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:40.606Z,1411445440.606 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2014-09-23T04:10:40.996Z,1411445440.996 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:41.369Z,1411445441.369 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:41.796Z,1411445441.796 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:42.213Z,1411445442.213 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:42.650Z,1411445442.650 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:43.059Z,1411445443.059 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:43.451Z,1411445443.451 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:43.850Z,1411445443.850 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:44.250Z,1411445444.250 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:44.707Z,1411445444.707 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:45.113Z,1411445445.113 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:45.541Z,1411445445.541 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:45.912Z,1411445445.912 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:46.380Z,1411445446.380 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:46.804Z,1411445446.804 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:47.197Z,1411445447.197 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:47.617Z,1411445447.617 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:48.022Z,1411445448.022 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:48.446Z,1411445448.446 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:48.820Z,1411445448.820 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:49.213Z,1411445449.213 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:49.661Z,1411445449.661 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:50.056Z,1411445450.056 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:50.474Z,1411445450.474 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:50.878Z,1411445450.878 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:51.283Z,1411445451.283 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:51.670Z,1411445451.670 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:52.062Z,1411445452.062 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:52.464Z,1411445452.464 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:52.881Z,1411445452.881 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:53.306Z,1411445453.306 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:53.706Z,1411445453.706 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:54.091Z,1411445454.091 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:54.470Z,1411445454.470 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:54.870Z,1411445454.870 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:55.271Z,1411445455.271 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:55.671Z,1411445455.671 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:56.085Z,1411445456.085 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:56.511Z,1411445456.511 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:56.912Z,1411445456.912 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:57.288Z,1411445457.288 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:57.687Z,1411445457.687 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:58.084Z,1411445458.084 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:58.478Z,1411445458.478 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:58.912Z,1411445458.912 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:59.380Z,1411445459.380 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:10:59.785Z,1411445459.785 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:00.197Z,1411445460.197 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:00.621Z,1411445460.621 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:00.989Z,1411445460.989 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:01.426Z,1411445461.426 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:01.797Z,1411445461.797 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:02.226Z,1411445462.226 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:02.649Z,1411445462.649 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:03.061Z,1411445463.061 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:03.482Z,1411445463.482 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:03.840Z,1411445463.840 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:04.245Z,1411445464.245 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:04.648Z,1411445464.648 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:05.054Z,1411445465.054 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:05.465Z,1411445465.465 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:05.898Z,1411445465.898 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:06.306Z,1411445466.306 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:06.696Z,1411445466.696 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:07.093Z,1411445467.093 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:07.496Z,1411445467.496 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:07.890Z,1411445467.890 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:08.309Z,1411445468.309 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:08.714Z,1411445468.714 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:09.174Z,1411445469.174 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:09.547Z,1411445469.547 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:09.942Z,1411445469.942 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:10.342Z,1411445470.342 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:10.745Z,1411445470.745 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:11.143Z,1411445471.143 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:11.559Z,1411445471.559 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:11.981Z,1411445471.981 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:12.416Z,1411445472.416 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:12.796Z,1411445472.796 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:13.195Z,1411445473.195 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:13.601Z,1411445473.601 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:14.055Z,1411445474.055 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:14.463Z,1411445474.463 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:14.889Z,1411445474.889 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:15.276Z,1411445475.276 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:15.753Z,1411445475.753 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:16.163Z,1411445476.163 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:16.558Z,1411445476.558 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:16.955Z,1411445476.955 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:17.362Z,1411445477.362 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:17.776Z,1411445477.776 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:18.185Z,1411445478.185 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:18.567Z,1411445478.567 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:18.980Z,1411445478.980 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:19.387Z,1411445479.387 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:19.775Z,1411445479.775 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:20.178Z,1411445480.178 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:20.596Z,1411445480.596 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:20.992Z,1411445480.992 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:21.390Z,1411445481.390 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:21.772Z,1411445481.772 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:22.194Z,1411445482.194 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:22.610Z,1411445482.610 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:23.001Z,1411445483.001 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:23.428Z,1411445483.428 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:23.814Z,1411445483.814 [NAL9602](IMPORTANT): GPS fix at: 1411445312.00
2014-09-23T04:11:23.847Z,1411445483.847 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:23.860Z,1411445483.860 [Startup:StartupSatComms:A] Stopped
2014-09-23T04:11:23.861Z,1411445483.861 [Startup:StartupSatComms:B] Running Loop=1
2014-09-23T04:11:24.294Z,1411445484.294 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:24.304Z,1411445484.304 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2014-09-23T04:11:24.944Z,1411445484.944 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:25.404Z,1411445485.404 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:25.814Z,1411445485.814 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:26.265Z,1411445486.265 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:27.175Z,1411445487.175 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:28.509Z,1411445488.509 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:29.032Z,1411445489.032 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:29.499Z,1411445489.499 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:29.967Z,1411445489.967 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:30.412Z,1411445490.412 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:31.343Z,1411445491.343 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:31.878Z,1411445491.878 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:32.333Z,1411445492.333 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:32.742Z,1411445492.742 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:33.173Z,1411445493.173 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:34.085Z,1411445494.085 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:34.626Z,1411445494.626 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:35.048Z,1411445495.048 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:35.468Z,1411445495.468 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:35.892Z,1411445495.892 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:36.326Z,1411445496.326 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:36.777Z,1411445496.777 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:37.309Z,1411445497.309 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:38.259Z,1411445498.259 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:38.857Z,1411445498.857 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:39.373Z,1411445499.373 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:39.805Z,1411445499.805 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:40.228Z,1411445500.227 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:41.156Z,1411445501.156 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:41.673Z,1411445501.673 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:42.165Z,1411445502.165 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:42.613Z,1411445502.613 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:43.106Z,1411445503.106 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:43.568Z,1411445503.568 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:43.990Z,1411445503.990 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:44.415Z,1411445504.415 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:44.857Z,1411445504.857 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:45.863Z,1411445505.863 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:46.421Z,1411445506.421 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:46.828Z,1411445506.828 [AcousticModem_Benthos_ATM900](DEBUG): sending wake-up to local modem
2014-09-23T04:11:46.881Z,1411445506.881 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:47.257Z,1411445507.257 [AcousticModem_Benthos_ATM900](DEBUG): confirming wake-up of local modem
2014-09-23T04:11:47.279Z,1411445507.279 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:47.687Z,1411445507.687 [AcousticModem_Benthos_ATM900](INFO): serial response: Rx Time:04:08:50.0253

2014-09-23T04:11:47.687Z,1411445507.687 [AcousticModem_Benthos_ATM900](INFO): got acoustic wakeup
2014-09-23T04:11:47.688Z,1411445507.688 [AcousticModem_Benthos_ATM900](INFO): serial response: range request

2014-09-23T04:11:47.688Z,1411445507.688 [AcousticModem_Benthos_ATM900](INFO): got acoustic wakeup
2014-09-23T04:11:47.760Z,1411445507.760 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:48.662Z,1411445508.662 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:49.245Z,1411445509.245 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:49.649Z,1411445509.649 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:50.044Z,1411445510.044 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:50.471Z,1411445510.471 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:50.885Z,1411445510.885 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:51.324Z,1411445511.324 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:51.725Z,1411445511.725 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:52.127Z,1411445512.127 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:53.074Z,1411445513.074 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:53.592Z,1411445513.592 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:53.989Z,1411445513.989 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:54.394Z,1411445514.394 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:54.833Z,1411445514.833 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:55.738Z,1411445515.738 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:56.304Z,1411445516.304 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:56.708Z,1411445516.708 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:57.148Z,1411445517.148 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:57.675Z,1411445517.675 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:58.145Z,1411445518.145 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:58.645Z,1411445518.645 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:11:59.066Z,1411445519.066 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:00.038Z,1411445520.038 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:00.628Z,1411445520.628 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:01.029Z,1411445521.029 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:01.461Z,1411445521.461 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:01.911Z,1411445521.911 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:02.822Z,1411445522.822 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:03.394Z,1411445523.394 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:03.771Z,1411445523.771 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:04.177Z,1411445524.177 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:04.595Z,1411445524.595 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:04.999Z,1411445524.999 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:05.400Z,1411445525.400 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:05.797Z,1411445525.797 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:06.204Z,1411445526.204 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:07.145Z,1411445527.145 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:07.656Z,1411445527.656 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:08.055Z,1411445528.055 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:08.460Z,1411445528.460 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:08.885Z,1411445528.885 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:09.806Z,1411445529.806 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:10.518Z,1411445530.518 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:10.923Z,1411445530.923 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:11.323Z,1411445531.323 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:11.744Z,1411445531.744 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:12.145Z,1411445532.145 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:12.564Z,1411445532.564 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:12.969Z,1411445532.969 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:13.428Z,1411445533.428 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:14.435Z,1411445534.435 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:14.981Z,1411445534.981 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:15.375Z,1411445535.375 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:15.835Z,1411445535.835 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:16.259Z,1411445536.259 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:17.198Z,1411445537.198 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:17.818Z,1411445537.818 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:18.210Z,1411445538.210 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:18.600Z,1411445538.600 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:19.031Z,1411445539.031 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:19.434Z,1411445539.434 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:19.834Z,1411445539.834 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:20.237Z,1411445540.237 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:20.639Z,1411445540.639 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:21.574Z,1411445541.574 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:22.081Z,1411445542.081 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:22.484Z,1411445542.484 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:22.888Z,1411445542.888 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:23.300Z,1411445543.300 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:24.220Z,1411445544.220 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:24.229Z,1411445544.229 [Startup:StartupSatComms:B](INFO): Timed out from 2014-09-23T04:11:23.9Z
2014-09-23T04:12:24.229Z,1411445544.229 [Startup:StartupSatComms:B] Stopped
2014-09-23T04:12:24.229Z,1411445544.229 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2014-09-23T04:12:24.229Z,1411445544.229 [Startup:StartupSatComms] Stopped
2014-09-23T04:12:24.230Z,1411445544.230 [Startup:StartupSatComms](INFO): Aggregate::uninitialize Startup:StartupSatComms
2014-09-23T04:12:24.231Z,1411445544.231 [Startup](INFO): Completed Startup
2014-09-23T04:12:24.231Z,1411445544.231 [Startup] Stopped
2014-09-23T04:12:24.231Z,1411445544.231 [Startup](INFO): Aggregate::uninitialize Startup
2014-09-23T04:12:24.231Z,1411445544.231 [Startup:A.GoToSurface] Stopped
2014-09-23T04:12:24.231Z,1411445544.231 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-09-23T04:12:24.804Z,1411445544.804 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:24.813Z,1411445544.813 [MissionManager](IMPORTANT): Started mission Default
2014-09-23T04:12:24.813Z,1411445544.813 [Default] Running Loop=1
2014-09-23T04:12:24.813Z,1411445544.813 [Default](INFO): Aggregate::initialize Default
2014-09-23T04:12:24.813Z,1411445544.813 [Default:B.GoToSurface] Running Loop=1
2014-09-23T04:12:24.814Z,1411445544.814 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-09-23T04:12:24.814Z,1411445544.814 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2014-09-23T04:12:24.814Z,1411445544.814 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2014-09-23T04:12:24.815Z,1411445544.815 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 0.500000 m/s.
2014-09-23T04:12:24.815Z,1411445544.815 [Default:StartClock] Running Loop=1
2014-09-23T04:12:24.815Z,1411445544.815 [Default:StartClock](INFO): Aggregate::initialize Default:StartClock
2014-09-23T04:12:24.815Z,1411445544.815 [Default:StartClock:A] Running Loop=1
2014-09-23T04:12:24.815Z,1411445544.815 [Default:CheckIn] Running Loop=1
2014-09-23T04:12:24.816Z,1411445544.816 [Default:CheckIn](INFO): Aggregate::initialize Default:CheckIn
2014-09-23T04:12:24.816Z,1411445544.816 [Default:CheckIn:A.SetSpeed] Running Loop=1
2014-09-23T04:12:24.816Z,1411445544.816 [Default:CheckIn:A.SetSpeed](DEBUG): Initialize.
2014-09-23T04:12:24.816Z,1411445544.816 [Default:CheckIn:Read_GPS] Running Loop=1
2014-09-23T04:12:24.817Z,1411445544.817 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2014-09-23T04:12:24.819Z,1411445544.819 [Default:CheckIn:A.SetSpeed] Running Loop=1
2014-09-23T04:12:24.847Z,1411445544.847 [Default:StartClock:A] Stopped
2014-09-23T04:12:24.848Z,1411445544.848 [Default:StartClock](INFO): Completed Default:StartClock
2014-09-23T04:12:24.848Z,1411445544.848 [Default:StartClock] Stopped
2014-09-23T04:12:24.848Z,1411445544.848 [Default:StartClock](INFO): Aggregate::uninitialize Default:StartClock
2014-09-23T04:12:25.282Z,1411445545.282 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:25.308Z,1411445545.308 [Default:WaitAtTheSurface] Running Loop=1
2014-09-23T04:12:25.308Z,1411445545.308 [Default:WaitAtTheSurface](INFO): Aggregate::initialize Default:WaitAtTheSurface
2014-09-23T04:12:25.308Z,1411445545.308 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed] Running Loop=1
2014-09-23T04:12:25.308Z,1411445545.308 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed](DEBUG): Initialize.
2014-09-23T04:12:25.718Z,1411445545.718 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:25.727Z,1411445545.727 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed] Running Loop=1
2014-09-23T04:12:26.125Z,1411445546.125 [NAL9602](IMPORTANT): GPS fix at: 1411445374.00
2014-09-23T04:12:26.136Z,1411445546.136 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:26.146Z,1411445546.146 [Default:CheckIn:Read_GPS] Stopped
2014-09-23T04:12:26.147Z,1411445546.147 [Default:CheckIn:Read_Iridium] Running Loop=1
2014-09-23T04:12:26.587Z,1411445546.587 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:26.599Z,1411445546.599 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2014-09-23T04:12:27.206Z,1411445547.206 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:27.645Z,1411445547.645 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:28.169Z,1411445548.169 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:29.129Z,1411445549.129 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:29.729Z,1411445549.729 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:30.157Z,1411445550.157 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:30.576Z,1411445550.576 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:31.043Z,1411445551.043 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:31.494Z,1411445551.494 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:31.948Z,1411445551.948 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:32.442Z,1411445552.442 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:33.381Z,1411445553.381 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:33.898Z,1411445553.898 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:34.303Z,1411445554.303 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:34.744Z,1411445554.744 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:35.168Z,1411445555.168 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:36.090Z,1411445556.090 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:36.615Z,1411445556.615 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:37.008Z,1411445557.008 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:37.413Z,1411445557.413 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:37.815Z,1411445557.815 [DVL_micro](FAULT): DVL failed to acquire valid data within timeout.
2014-09-23T04:12:37.815Z,1411445557.815 [DVL_micro] Data Fault, FailCount= 1
2014-09-23T04:12:37.815Z,1411445557.815 [DVL_micro](ERROR): Data Fault
2014-09-23T04:12:37.869Z,1411445557.869 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:37.911Z,1411445557.911 [CBIT](ERROR): Data Fault in component: DVL_micro
2014-09-23T04:12:38.355Z,1411445558.355 [DVL_micro](INFO): uninitialize:Powering down
2014-09-23T04:12:38.392Z,1411445558.392 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:38.790Z,1411445558.790 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:39.197Z,1411445559.197 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:39.215Z,1411445559.215 [CBIT](INFO): Clearing failed state for component DVL_micro
2014-09-23T04:12:39.215Z,1411445559.215 [DVL_micro] No Fault, FailCount= 1
2014-09-23T04:12:39.601Z,1411445559.601 [DVL_micro](INFO): Initializing
2014-09-23T04:12:39.613Z,1411445559.613 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:40.566Z,1411445560.566 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:41.086Z,1411445561.086 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:41.471Z,1411445561.471 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:41.879Z,1411445561.879 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:42.311Z,1411445562.311 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:43.221Z,1411445563.221 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:43.802Z,1411445563.802 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:44.209Z,1411445564.209 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:44.659Z,1411445564.659 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:45.070Z,1411445565.070 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:45.466Z,1411445565.466 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:45.870Z,1411445565.870 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:46.325Z,1411445566.325 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:46.768Z,1411445566.768 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:47.691Z,1411445567.691 [BPC1](FAULT): Failed to receive battery data
2014-09-23T04:12:47.691Z,1411445567.691 [BPC1] Communications Fault, FailCount= 1
2014-09-23T04:12:47.691Z,1411445567.691 [BPC1](ERROR): Communications Fault
2014-09-23T04:12:47.697Z,1411445567.697 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:47.747Z,1411445567.747 [CBIT](ERROR): Communications Fault in component: BPC1
2014-09-23T04:12:48.261Z,1411445568.261 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:48.646Z,1411445568.646 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:49.047Z,1411445569.047 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:49.082Z,1411445569.082 [CBIT](INFO): Clearing failed state for component BPC1
2014-09-23T04:12:49.082Z,1411445569.082 [BPC1] No Fault, FailCount= 1
2014-09-23T04:12:49.603Z,1411445569.603 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:50.517Z,1411445570.517 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:51.035Z,1411445571.035 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:51.411Z,1411445571.411 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:51.823Z,1411445571.823 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:52.242Z,1411445572.242 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:52.676Z,1411445572.676 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:53.149Z,1411445573.149 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:53.554Z,1411445573.554 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:53.963Z,1411445573.963 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:54.881Z,1411445574.881 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:55.403Z,1411445575.403 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:55.823Z,1411445575.823 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:56.255Z,1411445576.255 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:56.662Z,1411445576.662 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:57.572Z,1411445577.572 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:58.252Z,1411445578.252 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:58.659Z,1411445578.659 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:59.084Z,1411445579.084 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:59.530Z,1411445579.530 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:12:59.957Z,1411445579.957 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:00.357Z,1411445580.357 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:00.760Z,1411445580.760 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:01.160Z,1411445581.160 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:02.066Z,1411445582.066 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:02.659Z,1411445582.659 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:03.061Z,1411445583.061 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:03.460Z,1411445583.460 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:03.938Z,1411445583.938 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:04.851Z,1411445584.851 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:05.371Z,1411445585.371 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:05.833Z,1411445585.833 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:06.236Z,1411445586.236 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:06.695Z,1411445586.695 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:07.123Z,1411445587.123 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:07.523Z,1411445587.523 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:07.929Z,1411445587.929 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:08.329Z,1411445588.329 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:09.241Z,1411445589.241 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:09.801Z,1411445589.801 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:10.192Z,1411445590.192 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:10.601Z,1411445590.601 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:11.027Z,1411445591.027 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:11.938Z,1411445591.938 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:12.458Z,1411445592.458 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:12.900Z,1411445592.900 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:13.315Z,1411445593.315 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:13.735Z,1411445593.735 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:14.139Z,1411445594.139 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:14.542Z,1411445594.542 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:14.947Z,1411445594.947 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:15.371Z,1411445595.371 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:16.335Z,1411445596.335 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:16.949Z,1411445596.949 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:17.401Z,1411445597.401 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:17.800Z,1411445597.800 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:18.244Z,1411445598.244 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:19.196Z,1411445599.196 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:19.736Z,1411445599.736 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:20.232Z,1411445600.232 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:20.618Z,1411445600.618 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:21.073Z,1411445601.073 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:21.498Z,1411445601.498 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:21.897Z,1411445601.897 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:22.299Z,1411445602.299 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:22.704Z,1411445602.704 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:23.620Z,1411445603.620 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:24.236Z,1411445604.236 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:24.656Z,1411445604.656 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:25.057Z,1411445605.057 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:25.461Z,1411445605.461 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:26.372Z,1411445606.372 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:26.899Z,1411445606.899 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:27.308Z,1411445607.308 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:27.721Z,1411445607.721 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:28.143Z,1411445608.143 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:28.541Z,1411445608.541 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:28.964Z,1411445608.964 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:29.374Z,1411445609.374 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:29.775Z,1411445609.775 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:30.691Z,1411445610.691 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:31.256Z,1411445611.256 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:31.721Z,1411445611.721 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:32.170Z,1411445612.170 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:32.589Z,1411445612.589 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:33.527Z,1411445613.527 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:34.040Z,1411445614.040 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:34.519Z,1411445614.519 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:34.928Z,1411445614.928 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:35.391Z,1411445615.391 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:35.827Z,1411445615.827 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:36.229Z,1411445616.229 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:36.639Z,1411445616.639 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:37.577Z,1411445617.577 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:38.145Z,1411445618.145 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:38.543Z,1411445618.543 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:38.957Z,1411445618.957 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:39.375Z,1411445619.375 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:40.298Z,1411445620.298 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:40.815Z,1411445620.815 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:41.269Z,1411445621.269 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:41.651Z,1411445621.651 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:42.084Z,1411445622.084 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:42.485Z,1411445622.485 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:42.887Z,1411445622.887 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:43.290Z,1411445623.290 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:43.699Z,1411445623.699 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:44.626Z,1411445624.626 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:45.198Z,1411445625.198 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:45.601Z,1411445625.601 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:46.011Z,1411445626.011 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:46.465Z,1411445626.465 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:47.373Z,1411445627.373 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:47.907Z,1411445627.907 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:48.350Z,1411445628.350 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:48.774Z,1411445628.774 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:49.229Z,1411445629.229 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:49.631Z,1411445629.631 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:50.065Z,1411445630.065 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:50.506Z,1411445630.506 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:50.912Z,1411445630.912 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:51.881Z,1411445631.881 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:52.409Z,1411445632.409 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:52.809Z,1411445632.809 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:53.216Z,1411445633.216 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:53.639Z,1411445633.639 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:54.560Z,1411445634.560 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:55.124Z,1411445635.124 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:55.527Z,1411445635.527 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:55.926Z,1411445635.926 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:56.349Z,1411445636.349 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:56.767Z,1411445636.767 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:57.170Z,1411445637.170 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:57.570Z,1411445637.570 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:57.978Z,1411445637.978 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:58.951Z,1411445638.951 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:59.476Z,1411445639.476 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:13:59.881Z,1411445639.881 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:00.282Z,1411445640.282 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:00.705Z,1411445640.705 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:01.659Z,1411445641.659 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:02.251Z,1411445642.251 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:02.692Z,1411445642.692 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:03.090Z,1411445643.090 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:03.534Z,1411445643.534 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:03.936Z,1411445643.936 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:04.372Z,1411445644.372 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:04.810Z,1411445644.810 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:05.758Z,1411445645.758 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:06.265Z,1411445646.265 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:06.644Z,1411445646.644 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:07.061Z,1411445647.061 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:07.488Z,1411445647.488 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:08.414Z,1411445648.414 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:08.993Z,1411445648.993 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:09.398Z,1411445649.398 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:09.801Z,1411445649.801 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:10.240Z,1411445650.240 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:10.641Z,1411445650.641 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:11.042Z,1411445651.042 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:11.443Z,1411445651.443 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:11.845Z,1411445651.845 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:12.786Z,1411445652.786 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:13.298Z,1411445653.298 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:13.700Z,1411445653.700 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:14.100Z,1411445654.100 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:14.527Z,1411445654.527 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:15.465Z,1411445655.465 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:16.051Z,1411445656.051 [BPC1](ERROR): B bank expecting battery number:1 and read number: uart read:X
$S,01,270F,02,00,04,61%20
$C1,01,FF,02,00,03,FF,04,00,05,00,06,00,07,00%72
$B11,0A,FFFB%37
$B12,0A,FFFB%34
$B13,0A,FFFA%36
$B14,0A,FFFC%33
$B15,0A,0000%37
$B16,0A,0000%34
$B17,0A,0000%35
$B18,0A,0000%3A
$S,01,270F,02,00,04,61%20
$C1,01,FF,02,00,03,FF,04,00,05,00,06,00,07,00%72
$B11,02,000A,01,026C,03,0001,08,0B94,09,3D87,0A,FFFA,0B,FFFB%43
$B11,0C,0001,0D,0062,0E,005C,0F,1630,10,1782,11,DDE0,12,FFFF%4A
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0001,18,1838,19,3840%42
$B11,1A,0031,1B,4357,1C,00A7%42
$B12,02,000A,01,026C,03,0001,08,0B94,09,3D81,0A,FFFC,0B,FFFC%45
$B12,0C,0001,0D,0060,0E,005A,0F,15C1,10,1706,11,FFFF,12,FFFF%42
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0001,18,1838,19,3840%41
$B12,1A,0031,1B,4357,1C,009E%4B
$B13,02,000A,01,026C,03,0001,08,0B95,09,3D8E,0A,FFFB,0B,FFFA%32
$B13,0C,0001,0D,0063,0E,005C,0F,1628,10,17A9,11,FFFF,12,DD90%4E
$B13,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0001,18,1838,19,3840%40
$B13,1A,0031,1B,4357,1C,0089%37
$B14,02,000A,01,026C,03,0001,08,0B99,09,3D8D,0A,FFFC,0B,FFFB%3A
$B14,0C,0001,0D,0061,0E,005A,0F,159A,10,16F8,11,FFFF,12,FFFF%36
$B14,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0001,18,1838,19,3840%47
$B14,1A,0031,1B,4357,1C,00A6%46
$B15,02,000A,01,026C,03,0001,08,0B99,09,3D85,0A,FFFD,0B,FFFF%49
$B15,0C,0001,0D,0061,0E,005B,0F,15FE,10,171F,11,FFFF,12,FFFF%47
$B15,13,FFFF,14,0000,15,41A0,16,00E0,17,0001,18,1838,19,3840%48
$B15,1A,0031,1B,4357,1C,00A9%48
$B16,02,000A,01,026C,03,0001,08,0B8D,09,3D84,0A,0000,0B,FFFF%35
$B16,0C,0001,0D,005F,0E,0058,0F,1536,10,1690,11,FFFF,12,FFFF%33
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0001,18,1838,19,3840%45
$B16,1A,0031,1B,4357,1C,00A8%4A
$B17,02,000A,01,026C,03,0001,08,0B8C,09,3D7E,0A,FFFC,0B,FFFE%4B
$B17,0C,0001,0D,005F,0E,0059,0F,156B,10,16DB,11,FFFF,12,FFFF%4D
$B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0001,18,1838,19,3840%44
$B17,1A,0031,1B,4357,1C,0096%3D
$B18,02,000A,01,026C,03,0001,08,0B90,09,3CF0,0A,0000,0B,0000%33
$B18,0C,0001,0D,0064,0E,0062,0F,17BC,10,17C1,11,FFFF,12,FFFF%39
$B18,13,FFFF,14,0000,15,41A0,16,00E0,17,0001,18,1838,19,3840%45
$B18,1A,0031,1B,4357,1C,009B%46

2014-09-23T04:14:16.051Z,1411445656.051 [BPC1](FAULT): Failed to parse bank B battery data
2014-09-23T04:14:16.051Z,1411445656.051 [BPC1] Data Fault, FailCount= 1
2014-09-23T04:14:16.051Z,1411445656.051 [BPC1](ERROR): Data Fault
2014-09-23T04:14:16.062Z,1411445656.062 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:16.144Z,1411445656.144 [CBIT](ERROR): Data Fault in component: BPC1
2014-09-23T04:14:16.515Z,1411445656.515 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:16.916Z,1411445656.916 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:17.343Z,1411445657.343 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:17.382Z,1411445657.382 [CBIT](INFO): Clearing failed state for component BPC1
2014-09-23T04:14:17.382Z,1411445657.382 [BPC1] No Fault, FailCount= 1
2014-09-23T04:14:17.821Z,1411445657.821 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:18.259Z,1411445658.259 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:18.663Z,1411445658.663 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:19.609Z,1411445659.609 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:20.136Z,1411445660.136 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:20.562Z,1411445660.562 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:21.012Z,1411445661.012 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:21.421Z,1411445661.421 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:22.328Z,1411445662.328 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:22.899Z,1411445662.899 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:23.294Z,1411445663.294 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:23.730Z,1411445663.730 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:24.169Z,1411445664.169 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:24.570Z,1411445664.570 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:24.973Z,1411445664.973 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:25.380Z,1411445665.380 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:25.786Z,1411445665.786 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:26.750Z,1411445666.750 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:27.269Z,1411445667.269 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:27.673Z,1411445667.673 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:28.053Z,1411445668.053 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:28.491Z,1411445668.491 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:29.451Z,1411445669.451 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:30.084Z,1411445670.084 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:30.490Z,1411445670.490 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:30.929Z,1411445670.929 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:31.336Z,1411445671.336 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:31.772Z,1411445671.772 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:31.781Z,1411445671.781 [Default:UpdateAndReportMinutesSinceMissionStarted] Running Loop=1
2014-09-23T04:14:31.781Z,1411445671.781 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::initialize Default:UpdateAndReportMinutesSinceMissionStarted
2014-09-23T04:14:31.781Z,1411445671.781 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Running Loop=1
2014-09-23T04:14:31.784Z,1411445671.784 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Stopped
2014-09-23T04:14:31.784Z,1411445671.784 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Running Loop=1
2014-09-23T04:14:32.221Z,1411445672.221 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:32.230Z,1411445672.230 [Default:UpdateAndReportMinutesSinceMissionStarted:B](IMPORTANT): Default mission has been running for 2.118546 min 
2014-09-23T04:14:32.232Z,1411445672.232 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Stopped
2014-09-23T04:14:32.232Z,1411445672.232 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Completed Default:UpdateAndReportMinutesSinceMissionStarted
2014-09-23T04:14:32.232Z,1411445672.232 [Default:UpdateAndReportMinutesSinceMissionStarted] Stopped
2014-09-23T04:14:32.233Z,1411445672.233 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::uninitialize Default:UpdateAndReportMinutesSinceMissionStarted
2014-09-23T04:14:32.631Z,1411445672.631 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:33.579Z,1411445673.579 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:34.092Z,1411445674.092 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:34.489Z,1411445674.489 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:34.900Z,1411445674.900 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:35.314Z,1411445675.314 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:36.245Z,1411445676.245 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:36.829Z,1411445676.829 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:37.254Z,1411445677.254 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:37.659Z,1411445677.659 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:38.085Z,1411445678.085 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:38.499Z,1411445678.499 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:38.903Z,1411445678.903 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:39.311Z,1411445679.311 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:39.719Z,1411445679.719 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:40.696Z,1411445680.696 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:41.203Z,1411445681.203 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:41.606Z,1411445681.606 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:42.003Z,1411445682.003 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:42.426Z,1411445682.426 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:43.366Z,1411445683.366 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:44.031Z,1411445684.031 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:44.442Z,1411445684.442 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:44.881Z,1411445684.881 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:45.293Z,1411445685.293 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:45.714Z,1411445685.714 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:46.115Z,1411445686.115 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:46.473Z,1411445686.473 [AcousticModem_Benthos_ATM900](INFO): serial response: Tx time:04:08:51.6282

2014-09-23T04:14:46.473Z,1411445686.473 [AcousticModem_Benthos_ATM900](INFO): got acoustic wakeup
2014-09-23T04:14:46.538Z,1411445686.538 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:47.451Z,1411445687.451 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:48.009Z,1411445688.009 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:48.379Z,1411445688.379 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:48.781Z,1411445688.781 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:49.216Z,1411445689.216 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:50.123Z,1411445690.123 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:50.718Z,1411445690.718 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:51.148Z,1411445691.148 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:51.580Z,1411445691.580 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:51.992Z,1411445691.992 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:52.400Z,1411445692.400 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:52.817Z,1411445692.817 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:53.248Z,1411445693.248 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:54.184Z,1411445694.184 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:54.736Z,1411445694.736 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:55.149Z,1411445695.149 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:55.552Z,1411445695.552 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:55.992Z,1411445695.992 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:56.401Z,1411445696.401 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:56.823Z,1411445696.823 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:57.290Z,1411445697.290 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:57.785Z,1411445697.785 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:58.229Z,1411445698.229 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:58.637Z,1411445698.637 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:59.089Z,1411445699.089 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:59.493Z,1411445699.493 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:14:59.932Z,1411445699.932 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:00.332Z,1411445700.332 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:00.808Z,1411445700.808 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:01.207Z,1411445701.207 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:01.613Z,1411445701.613 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:02.013Z,1411445702.013 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:02.433Z,1411445702.433 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:02.839Z,1411445702.839 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:03.244Z,1411445703.244 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:04.160Z,1411445704.160 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:04.745Z,1411445704.745 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:05.153Z,1411445705.153 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:05.563Z,1411445705.563 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:05.985Z,1411445705.985 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:06.384Z,1411445706.384 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:06.783Z,1411445706.783 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:07.184Z,1411445707.184 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:07.588Z,1411445707.588 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:08.527Z,1411445708.527 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:09.166Z,1411445709.166 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:09.578Z,1411445709.578 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:09.986Z,1411445709.986 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:10.422Z,1411445710.422 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:10.824Z,1411445710.824 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:11.225Z,1411445711.225 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:11.701Z,1411445711.701 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:12.658Z,1411445712.658 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:13.297Z,1411445713.297 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:13.730Z,1411445713.730 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:14.196Z,1411445714.196 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:14.607Z,1411445714.607 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:15.599Z,1411445715.599 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:16.155Z,1411445716.155 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:16.536Z,1411445716.536 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:16.945Z,1411445716.945 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:17.389Z,1411445717.389 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:17.787Z,1411445717.787 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:18.195Z,1411445718.195 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:18.639Z,1411445718.639 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:19.050Z,1411445719.050 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:19.965Z,1411445719.965 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:20.473Z,1411445720.473 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:20.880Z,1411445720.880 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:21.416Z,1411445721.416 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:21.932Z,1411445721.932 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:22.830Z,1411445722.830 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:23.358Z,1411445723.358 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:23.768Z,1411445723.768 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:24.205Z,1411445724.205 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:24.616Z,1411445724.616 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:25.091Z,1411445725.091 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:25.524Z,1411445725.524 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:25.927Z,1411445725.927 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:26.336Z,1411445726.336 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:27.252Z,1411445727.252 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:27.780Z,1411445727.780 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:28.234Z,1411445728.234 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:28.657Z,1411445728.657 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:29.104Z,1411445729.104 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:30.008Z,1411445730.008 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:30.558Z,1411445730.558 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:30.951Z,1411445730.951 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:31.439Z,1411445731.439 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:31.859Z,1411445731.859 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:32.333Z,1411445732.333 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:32.835Z,1411445732.835 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:33.332Z,1411445733.332 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:34.327Z,1411445734.327 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:35.171Z,1411445735.171 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:35.593Z,1411445735.593 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:36.004Z,1411445736.004 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:36.445Z,1411445736.445 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:37.344Z,1411445737.344 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:38.041Z,1411445738.041 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:38.528Z,1411445738.528 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:38.941Z,1411445738.941 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:39.367Z,1411445739.367 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:39.908Z,1411445739.908 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:40.339Z,1411445740.339 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:40.755Z,1411445740.755 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:41.691Z,1411445741.691 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:42.247Z,1411445742.247 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:42.649Z,1411445742.649 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:43.049Z,1411445743.049 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:43.503Z,1411445743.503 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:44.464Z,1411445744.464 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:44.918Z,1411445744.918 [DVL_micro](FAULT): DVL failed to acquire valid data within timeout.
2014-09-23T04:15:44.918Z,1411445744.918 [DVL_micro] Data Fault, FailCount= 1
2014-09-23T04:15:44.918Z,1411445744.918 [DVL_micro](ERROR): Data Fault
2014-09-23T04:15:45.195Z,1411445745.195 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:45.222Z,1411445745.222 [CBIT](ERROR): Data Fault in component: DVL_micro
2014-09-23T04:15:45.714Z,1411445745.714 [DVL_micro](INFO): uninitialize:Powering down
2014-09-23T04:15:45.770Z,1411445745.770 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:46.310Z,1411445746.310 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:46.420Z,1411445746.420 [CommandLine](IMPORTANT): got command restart system
2014-09-23T04:15:46.821Z,1411445746.821 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:46.839Z,1411445746.839 [CBIT](INFO): Clearing failed state for component DVL_micro
2014-09-23T04:15:46.839Z,1411445746.839 [DVL_micro] No Fault, FailCount= 1
2014-09-23T04:15:47.228Z,1411445747.228 [DVL_micro](INFO): Initializing
2014-09-23T04:15:47.285Z,1411445747.285 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:47.681Z,1411445747.681 [BPC1](DEBUG): Received data from all battery sticks
2014-09-23T04:15:47.688Z,1411445747.688 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:48.610Z,1411445748.610 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:49.658Z,1411445749.658 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:50.064Z,1411445750.064 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:50.483Z,1411445750.483 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:50.966Z,1411445750.966 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:15:51.886Z,1411445751.886 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:16:03.151Z,1411445763.151 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:16:03.615Z,1411445763.615 [DVL_micro](ERROR): No DVL communication! Re-initializing
2014-09-23T04:16:03.615Z,1411445763.615 [DVL_micro] Communications Fault, FailCount= 2
2014-09-23T04:16:03.615Z,1411445763.615 [DVL_micro](ERROR): Communications Fault
2014-09-23T04:16:03.664Z,1411445763.664 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:16:03.703Z,1411445763.703 [CBIT](ERROR): Communications Fault in component: DVL_micro
2014-09-23T04:16:04.064Z,1411445764.064 [DVL_micro](INFO): uninitialize:Powering down
2014-09-23T04:16:04.101Z,1411445764.101 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:16:04.518Z,1411445764.518 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:16:05.453Z,1411445765.453 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:16:05.470Z,1411445765.470 [CBIT](INFO): Clearing failed state for component DVL_micro
2014-09-23T04:16:05.470Z,1411445765.470 [DVL_micro] No Fault, FailCount= 2
2014-09-23T04:16:05.849Z,1411445765.849 [DVL_micro](INFO): Initializing
2014-09-23T04:16:16.933Z,1411445776.933 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:16:17.455Z,1411445777.455 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:16:17.896Z,1411445777.896 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:16:18.314Z,1411445778.314 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:16:18.719Z,1411445778.719 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2014-09-23T04:16:18.728Z,1411445778.728 [CommandLine ThreadHandler](INFO): Thread cancelled.
2014-09-23T04:16:18.877Z,1411445778.877 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2014-09-23T04:16:18.878Z,1411445778.878 [CommandLine ThreadHandler](INFO): Thread cancelled.
2014-09-23T04:16:18.878Z,1411445778.878 [CommandLine](INFO): Join timeout helper Thread ID is 920
2014-09-23T04:16:18.882Z,1411445778.882 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2014-09-23T04:16:18.882Z,1411445778.882 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2014-09-23T04:16:18.882Z,1411445778.882 [NavChartDb](INFO): Join timeout helper Thread ID is 921
2014-09-23T04:16:18.884Z,1411445778.884 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2014-09-23T04:16:18.885Z,1411445778.885 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2014-09-23T04:16:18.886Z,1411445778.886 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2014-09-23T04:16:18.886Z,1411445778.886 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2014-09-23T04:16:18.887Z,1411445778.887 [Radio_Surface](INFO): Join timeout helper Thread ID is 922
2014-09-23T04:16:18.934Z,1411445778.934 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2014-09-23T04:16:18.934Z,1411445778.934 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2014-09-23T04:16:18.945Z,1411445778.945 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2014-09-23T04:16:18.946Z,1411445778.946 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2014-09-23T04:16:18.946Z,1411445778.946 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 923
2014-09-23T04:16:19.142Z,1411445779.142 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2014-09-23T04:16:19.142Z,1411445779.142 [WetLabsBB2FL](INFO): Powering down
2014-09-23T04:16:19.143Z,1411445779.143 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2014-09-23T04:16:19.150Z,1411445779.150 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2014-09-23T04:16:19.150Z,1411445779.150 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2014-09-23T04:16:19.150Z,1411445779.150 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 924
2014-09-23T04:16:19.261Z,1411445779.261 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:16:19.503Z,1411445779.503 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2014-09-23T04:16:19.503Z,1411445779.503 [CTD_NeilBrown](INFO): Powering down
2014-09-23T04:16:19.504Z,1411445779.504 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2014-09-23T04:16:19.517Z,1411445779.517 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2014-09-23T04:16:19.517Z,1411445779.517 [logger ThreadHandler](INFO): Thread cancelled.
2014-09-23T04:16:19.518Z,1411445779.518 [logger](INFO): Join timeout helper Thread ID is 925
2014-09-23T04:16:19.518Z,1411445779.518 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2014-09-23T04:16:19.519Z,1411445779.519 [logger ThreadHandler](INFO): Thread cancelled.
2014-09-23T04:16:19.520Z,1411445779.520 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2014-09-23T04:16:19.520Z,1411445779.520 [CommandLine ThreadHandler](INFO): Thread cancelled.
2014-09-23T04:16:19.520Z,1411445779.520 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2014-09-23T04:16:19.520Z,1411445779.520 [controlThread ThreadHandler](INFO): Thread cancelled.
2014-09-23T04:16:19.521Z,1411445779.521 [controlThread](INFO): Join timeout helper Thread ID is 926
2014-09-23T04:16:19.761Z,1411445779.761 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T04:16:19.780Z,1411445779.780 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2014-09-23T04:16:19.780Z,1411445779.780 [controlThread](DEBUG): Uninitializing ControlThread
2014-09-23T04:16:19.780Z,1411445779.780 [Aanderaa_O2](INFO): Powering down
2014-09-23T04:16:19.781Z,1411445779.781 [AHRS_sp3003D](INFO): Powering down
2014-09-23T04:16:19.867Z,1411445779.867 [AcousticModem_Benthos_ATM900](INFO): Powering down
2014-09-23T04:16:20.059Z,1411445780.059 [DVL_micro](INFO): uninitialize:Powering down
2014-09-23T04:16:20.060Z,1411445780.060 [NAL9602](INFO): Powering down
2014-09-23T04:16:20.062Z,1411445780.062 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2014-09-23T04:16:20.064Z,1411445780.064 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2014-09-23T04:16:20.065Z,1411445780.065 [Default] Stopped
2014-09-23T04:16:20.065Z,1411445780.065 [Default](INFO): Aggregate::uninitialize Default
2014-09-23T04:16:20.065Z,1411445780.065 [Default:B.GoToSurface] Stopped
2014-09-23T04:16:20.065Z,1411445780.065 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-09-23T04:16:20.065Z,1411445780.065 [Default:CheckIn] Stopped
2014-09-23T04:16:20.065Z,1411445780.065 [Default:CheckIn](INFO): Aggregate::uninitialize Default:CheckIn
2014-09-23T04:16:20.065Z,1411445780.065 [Default:CheckIn:A.SetSpeed] Stopped
2014-09-23T04:16:20.065Z,1411445780.065 [Default:CheckIn:A.SetSpeed](DEBUG): Uninitialize.
2014-09-23T04:16:20.066Z,1411445780.066 [Default:CheckIn:Read_Iridium] Stopped
2014-09-23T04:16:20.066Z,1411445780.066 [Default:WaitAtTheSurface] Stopped
2014-09-23T04:16:20.066Z,1411445780.066 [Default:WaitAtTheSurface](INFO): Aggregate::uninitialize Default:WaitAtTheSurface
2014-09-23T04:16:20.066Z,1411445780.066 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed] Stopped
2014-09-23T04:16:20.066Z,1411445780.066 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed](DEBUG): Uninitialize.
2014-09-23T04:16:20.069Z,1411445780.069 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2014-09-23T04:16:20.070Z,1411445780.070 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2014-09-23T04:16:20.070Z,1411445780.070 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2014-09-23T04:16:20.070Z,1411445780.070 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2014-09-23T04:16:20.071Z,1411445780.071 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2014-09-23T04:16:20.071Z,1411445780.071 [BuoyancyServo](INFO): Powering down
2014-09-23T04:16:20.083Z,1411445780.083 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2014-09-23T04:16:20.084Z,1411445780.084 [ElevatorServo](INFO): Powering down
2014-09-23T04:16:20.085Z,1411445780.085 [MassServo](DEBUG): Uninitialize Mass Servo.
2014-09-23T04:16:20.085Z,1411445780.085 [MassServo](INFO): Powering down
2014-09-23T04:16:20.085Z,1411445780.085 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2014-09-23T04:16:20.086Z,1411445780.086 [RudderServo](INFO): Powering down
2014-09-23T04:16:20.086Z,1411445780.086 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2014-09-23T04:16:20.087Z,1411445780.087 [ThrusterServo](INFO): Powering down
2014-09-23T04:16:20.087Z,1411445780.087 [SBIT](DEBUG): Uninitialize SBIT Component.
2014-09-23T04:16:20.088Z,1411445780.088 [IBIT](DEBUG): Uninitialize IBIT Component.
2014-09-23T04:16:20.088Z,1411445780.088 [CBIT](DEBUG): Uninitialize CBIT Component.
2014-09-23T04:16:20.120Z,1411445780.120 [controlThread ThreadHandler](INFO): Thread cancelled.
2014-09-23T04:16:20.186Z,1411445780.186 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2014-09-23T04:16:20.189Z,1411445780.189 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2014-09-23T04:16:20.250Z,1411445780.250 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2014-09-23T04:16:20.307Z,1411445780.307 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2014-09-23T04:16:20.370Z,1411445780.370 [logger ThreadHandler](INFO): Thread cancelled.