2014-09-23T02:37:50.144Z,1411439870.144 [Supervisor](DEBUG): Initializing supervisor.
2014-09-23T02:37:50.148Z,1411439870.148 [SyncHandler](DEBUG): Created PCaller Thread at 4034C4E0
2014-09-23T02:37:50.148Z,1411439870.148 [SyncHandler](INFO): Protected caller Thread ID is 765
2014-09-23T02:37:50.149Z,1411439870.149 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2014-09-23T02:37:50.152Z,1411439870.152 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4037C4E0
2014-09-23T02:37:50.152Z,1411439870.152 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 766
2014-09-23T02:37:50.155Z,1411439870.155 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2014-09-23T02:37:50.167Z,1411439870.167 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2014-09-23T02:37:50.172Z,1411439870.172 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 403AC4E0
2014-09-23T02:37:50.172Z,1411439870.172 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 767
2014-09-23T02:37:50.173Z,1411439870.173 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2014-09-23T02:37:50.176Z,1411439870.176 [logger ThreadHandler](DEBUG): Created PCaller Thread at 403DC4E0
2014-09-23T02:37:50.176Z,1411439870.176 [logger ThreadHandler](INFO): Protected caller Thread ID is 768
2014-09-23T02:37:50.178Z,1411439870.178 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2014-09-23T02:37:50.179Z,1411439870.179 [Supervisor](INFO): Looking for Config files in directory: Config/
2014-09-23T02:37:50.183Z,1411439870.183 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2014-09-23T02:37:50.536Z,1411439870.536 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2014-09-23T02:37:50.536Z,1411439870.536 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2014-09-23T02:37:50.712Z,1411439870.712 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2014-09-23T02:37:50.715Z,1411439870.715 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2014-09-23T02:37:50.830Z,1411439870.830 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2014-09-23T02:37:50.832Z,1411439870.832 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2014-09-23T02:37:50.972Z,1411439870.972 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2014-09-23T02:37:50.973Z,1411439870.973 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2014-09-23T02:37:51.069Z,1411439871.069 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2014-09-23T02:37:51.230Z,1411439871.230 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2014-09-23T02:37:51.231Z,1411439871.231 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2014-09-23T02:37:51.329Z,1411439871.329 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2014-09-23T02:37:51.330Z,1411439871.330 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2014-09-23T02:37:51.551Z,1411439871.551 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2014-09-23T02:37:51.553Z,1411439871.553 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2014-09-23T02:37:51.930Z,1411439871.930 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2014-09-23T02:37:51.931Z,1411439871.931 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2014-09-23T02:37:52.262Z,1411439872.262 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2014-09-23T02:37:52.263Z,1411439872.263 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2014-09-23T02:37:52.814Z,1411439872.814 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2014-09-23T02:37:52.814Z,1411439872.814 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2014-09-23T02:37:53.046Z,1411439873.046 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2014-09-23T02:37:53.047Z,1411439873.047 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2014-09-23T02:38:02.268Z,1411439882.268 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2014-09-23T02:38:03.124Z,1411439883.124 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2014-09-23T02:38:03.542Z,1411439883.542 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2014-09-23T02:38:03.542Z,1411439883.542 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2014-09-23T02:38:03.656Z,1411439883.656 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2014-09-23T02:38:03.658Z,1411439883.658 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2014-09-23T02:38:03.662Z,1411439883.662 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2014-09-23T02:38:03.902Z,1411439883.902 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2014-09-23T02:38:03.903Z,1411439883.903 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2014-09-23T02:38:04.023Z,1411439884.023 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Estimation.cfg
2014-09-23T02:38:04.122Z,1411439884.122 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2014-09-23T02:38:04.220Z,1411439884.220 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2014-09-23T02:38:04.318Z,1411439884.318 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2014-09-23T02:38:04.461Z,1411439884.461 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2014-09-23T02:38:04.632Z,1411439884.632 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2014-09-23T02:38:04.735Z,1411439884.735 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2014-09-23T02:38:04.822Z,1411439884.822 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2014-09-23T02:38:04.916Z,1411439884.916 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2014-09-23T02:38:05.015Z,1411439885.015 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2014-09-23T02:38:05.190Z,1411439885.190 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2014-09-23T02:38:05.195Z,1411439885.195 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2014-09-23T02:38:05.268Z,1411439885.268 [VerticalControl](DEBUG): Construct VerticalControl.
2014-09-23T02:38:05.389Z,1411439885.389 [VerticalControl] Loaded
2014-09-23T02:38:05.389Z,1411439885.389 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2014-09-23T02:38:05.390Z,1411439885.390 [HorizontalControl](DEBUG): Construct HorizontalControl.
2014-09-23T02:38:05.461Z,1411439885.461 [HorizontalControl] Loaded
2014-09-23T02:38:05.461Z,1411439885.461 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2014-09-23T02:38:05.462Z,1411439885.462 [SpeedControl](DEBUG): Construct SpeedControl.
2014-09-23T02:38:05.468Z,1411439885.468 [SpeedControl] Loaded
2014-09-23T02:38:05.468Z,1411439885.468 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2014-09-23T02:38:05.469Z,1411439885.469 [LoopControl](DEBUG): Construct LoopControl.
2014-09-23T02:38:05.470Z,1411439885.470 [LoopControl] Loaded
2014-09-23T02:38:05.470Z,1411439885.470 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2014-09-23T02:38:05.470Z,1411439885.470 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2014-09-23T02:38:05.471Z,1411439885.471 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2014-09-23T02:38:05.592Z,1411439885.592 [SBIT](DEBUG): Construct Startup Built In Test.
2014-09-23T02:38:05.604Z,1411439885.604 [SBIT] Loaded
2014-09-23T02:38:05.604Z,1411439885.604 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2014-09-23T02:38:05.605Z,1411439885.605 [IBIT](DEBUG): Construct Initiated Built In Test.
2014-09-23T02:38:05.635Z,1411439885.635 [IBIT] Loaded
2014-09-23T02:38:05.635Z,1411439885.635 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2014-09-23T02:38:05.637Z,1411439885.637 [CBIT](DEBUG): Construct CBIT Built In Test.
2014-09-23T02:38:05.758Z,1411439885.758 [CBIT] Loaded
2014-09-23T02:38:05.758Z,1411439885.758 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2014-09-23T02:38:05.759Z,1411439885.759 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2014-09-23T02:38:05.759Z,1411439885.759 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2014-09-23T02:38:05.790Z,1411439885.790 [DepthRateCalculator] Loaded
2014-09-23T02:38:05.791Z,1411439885.791 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2014-09-23T02:38:05.796Z,1411439885.796 [PitchRateCalculator] Loaded
2014-09-23T02:38:05.796Z,1411439885.796 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2014-09-23T02:38:05.808Z,1411439885.808 [SpeedCalculator] Loaded
2014-09-23T02:38:05.808Z,1411439885.808 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2014-09-23T02:38:05.824Z,1411439885.824 [TempGradientCalculator] Loaded
2014-09-23T02:38:05.825Z,1411439885.825 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2014-09-23T02:38:05.830Z,1411439885.830 [YawRateCalculator] Loaded
2014-09-23T02:38:05.830Z,1411439885.830 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2014-09-23T02:38:05.831Z,1411439885.831 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2014-09-23T02:38:05.831Z,1411439885.831 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2014-09-23T02:38:07.229Z,1411439887.229 [HFRCMReconstructedInterpolator] Loaded
2014-09-23T02:38:07.229Z,1411439887.229 [ComponentRegistry](DEBUG): SyncComponent "HFRCMReconstructedInterpolator" handled in the control thread.
2014-09-23T02:38:07.230Z,1411439887.230 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2014-09-23T02:38:07.230Z,1411439887.230 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2014-09-23T02:38:07.507Z,1411439887.507 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2014-09-23T02:38:07.507Z,1411439887.507 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2014-09-23T02:38:07.602Z,1411439887.602 [DeadReckonUsingMultipleVelocitySources] Loaded
2014-09-23T02:38:07.603Z,1411439887.603 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2014-09-23T02:38:07.647Z,1411439887.647 [DeadReckonWithRespectToWater] Loaded
2014-09-23T02:38:07.648Z,1411439887.648 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToWater" handled in the control thread.
2014-09-23T02:38:07.694Z,1411439887.694 [DeadReckonWithRespectToSeafloor] Loaded
2014-09-23T02:38:07.694Z,1411439887.694 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2014-09-23T02:38:07.744Z,1411439887.744 [DeadReckonUsingDVLWaterTrack] Loaded
2014-09-23T02:38:07.744Z,1411439887.744 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingDVLWaterTrack" handled in the control thread.
2014-09-23T02:38:07.762Z,1411439887.762 [NavChart] Loaded
2014-09-23T02:38:07.762Z,1411439887.762 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2014-09-23T02:38:07.767Z,1411439887.767 [UniversalFixResidualReporter] Loaded
2014-09-23T02:38:07.767Z,1411439887.767 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2014-09-23T02:38:07.768Z,1411439887.768 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2014-09-23T02:38:07.768Z,1411439887.768 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2014-09-23T02:38:23.670Z,1411439903.670 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2014-09-23T02:38:23.671Z,1411439903.671 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2014-09-23T02:38:24.761Z,1411439904.761 [Aanderaa_O2] Loaded
2014-09-23T02:38:24.762Z,1411439904.762 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2014-09-23T02:38:24.798Z,1411439904.798 [CTD_NeilBrown] Loaded
2014-09-23T02:38:24.798Z,1411439904.798 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2014-09-23T02:38:24.799Z,1411439904.799 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 405D94E0
2014-09-23T02:38:24.800Z,1411439904.800 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 851
2014-09-23T02:38:24.817Z,1411439904.817 [rhodamine] Loaded
2014-09-23T02:38:24.818Z,1411439904.818 [ComponentRegistry](DEBUG): SyncComponent "rhodamine" handled in the control thread.
2014-09-23T02:38:24.853Z,1411439904.853 [WetLabsBB2FL] Loaded
2014-09-23T02:38:24.853Z,1411439904.853 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2014-09-23T02:38:24.854Z,1411439904.854 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406094E0
2014-09-23T02:38:24.855Z,1411439904.855 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 852
2014-09-23T02:38:24.855Z,1411439904.855 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2014-09-23T02:38:24.858Z,1411439904.858 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2014-09-23T02:38:25.554Z,1411439905.554 [AHRS_sp3003D] Loaded
2014-09-23T02:38:25.554Z,1411439905.554 [ComponentRegistry](DEBUG): SyncComponent "AHRS_sp3003D" handled in the control thread.
2014-09-23T02:38:25.590Z,1411439905.590 [AcousticModem_Benthos_ATM900] Loaded
2014-09-23T02:38:25.590Z,1411439905.590 [ComponentRegistry](DEBUG): SyncComponent "AcousticModem_Benthos_ATM900" handled in the control thread.
2014-09-23T02:38:25.749Z,1411439905.749 [DataOverHttps] Loaded
2014-09-23T02:38:25.749Z,1411439905.749 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2014-09-23T02:38:25.763Z,1411439905.763 [Depth_Keller] Loaded
2014-09-23T02:38:25.764Z,1411439905.764 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2014-09-23T02:38:25.769Z,1411439905.769 [DropWeight] Loaded
2014-09-23T02:38:25.769Z,1411439905.769 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2014-09-23T02:38:25.910Z,1411439905.910 [DVL_micro] Loaded
2014-09-23T02:38:25.910Z,1411439905.910 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread.
2014-09-23T02:38:26.015Z,1411439906.015 [NAL9602] Loaded
2014-09-23T02:38:26.015Z,1411439906.015 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2014-09-23T02:38:26.057Z,1411439906.057 [Onboard] Loaded
2014-09-23T02:38:26.057Z,1411439906.057 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2014-09-23T02:38:26.065Z,1411439906.065 [Radio_Surface] Loaded
2014-09-23T02:38:26.065Z,1411439906.065 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2014-09-23T02:38:26.066Z,1411439906.066 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408524E0
2014-09-23T02:38:26.066Z,1411439906.066 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 853
2014-09-23T02:38:27.925Z,1411439907.925 [BPC1] Loaded
2014-09-23T02:38:27.925Z,1411439907.925 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2014-09-23T02:38:27.926Z,1411439907.926 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2014-09-23T02:38:27.927Z,1411439907.927 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2014-09-23T02:38:28.058Z,1411439908.058 [BuoyancyServo] Loaded
2014-09-23T02:38:28.058Z,1411439908.058 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2014-09-23T02:38:28.070Z,1411439908.070 [ElevatorServo] Loaded
2014-09-23T02:38:28.071Z,1411439908.071 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2014-09-23T02:38:28.083Z,1411439908.083 [MassServo] Loaded
2014-09-23T02:38:28.083Z,1411439908.083 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2014-09-23T02:38:28.095Z,1411439908.095 [RudderServo] Loaded
2014-09-23T02:38:28.095Z,1411439908.095 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2014-09-23T02:38:28.107Z,1411439908.107 [ThrusterServo] Loaded
2014-09-23T02:38:28.107Z,1411439908.107 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2014-09-23T02:38:28.108Z,1411439908.108 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2014-09-23T02:38:28.109Z,1411439908.109 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2014-09-23T02:38:28.303Z,1411439908.303 [InternalSim] Loaded
2014-09-23T02:38:28.303Z,1411439908.303 [ComponentRegistry](DEBUG): SyncComponent "InternalSim" handled in the control thread.
2014-09-23T02:38:28.304Z,1411439908.304 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2014-09-23T02:38:28.304Z,1411439908.304 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2014-09-23T02:38:28.345Z,1411439908.345 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2014-09-23T02:38:28.347Z,1411439908.347 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2014-09-23T02:38:28.348Z,1411439908.348 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2014-09-23T02:38:28.355Z,1411439908.355 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2014-09-23T02:38:28.356Z,1411439908.356 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 409034E0
2014-09-23T02:38:28.356Z,1411439908.356 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 854
2014-09-23T02:38:28.361Z,1411439908.361 [Supervisor](INFO): Main Thread ID is 764
2014-09-23T02:38:28.361Z,1411439908.361 [Supervisor](DEBUG): Running supervisor.
2014-09-23T02:38:28.362Z,1411439908.362 [CommandLine ThreadHandler](INFO): Handler Thread ID is 855
2014-09-23T02:38:28.365Z,1411439908.365 [controlThread ThreadHandler](INFO): Handler Thread ID is 856
2014-09-23T02:38:28.365Z,1411439908.365 [controlThread](DEBUG): Initializing ControlThread
2014-09-23T02:38:28.366Z,1411439908.366 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2014-09-23T02:38:28.368Z,1411439908.368 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2014-09-23T02:38:28.369Z,1411439908.369 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2014-09-23T02:38:28.369Z,1411439908.369 [LoopControl](DEBUG): Initialize LoopControlComponent.
2014-09-23T02:38:28.369Z,1411439908.369 [SBIT](INFO): Initialize SBIT Component.
2014-09-23T02:38:28.370Z,1411439908.370 [SBIT](IMPORTANT): Tethys CM Info: SVN revision:11693
2014-09-23T02:38:28.370Z,1411439908.370 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2014-09-23T02:38:28.370Z,1411439908.370 [SBIT](IMPORTANT): Kernel Version:#639 PREEMPT Wed Mar 12 12:53:33 PDT 2014
2014-09-23T02:38:28.371Z,1411439908.371 [IBIT](INFO): Initialize IBIT Component.
2014-09-23T02:38:28.372Z,1411439908.372 [CBIT](DEBUG): Initialize CBIT Component.
2014-09-23T02:38:28.372Z,1411439908.372 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL.
2014-09-23T02:38:28.372Z,1411439908.372 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2014-09-23T02:38:28.373Z,1411439908.373 [logger ThreadHandler](INFO): Handler Thread ID is 857
2014-09-23T02:38:28.392Z,1411439908.392 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 858
2014-09-23T02:38:28.392Z,1411439908.392 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown.
2014-09-23T02:38:28.396Z,1411439908.396 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2014-09-23T02:38:28.396Z,1411439908.396 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2014-09-23T02:38:28.396Z,1411439908.396 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2014-09-23T02:38:28.396Z,1411439908.396 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2014-09-23T02:38:28.397Z,1411439908.397 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2014-09-23T02:38:28.398Z,1411439908.398 [HFRCMReconstructedInterpolator](INFO): Initializing HFRCMReconstructedInterpolator component with velocityAccuracy_ = 0.300000 m/s.
2014-09-23T02:38:28.400Z,1411439908.400 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2014-09-23T02:38:28.400Z,1411439908.400 [DeadReckonWithRespectToWater](DEBUG): Initializing DeadReckonWithRespectToWater component.
2014-09-23T02:38:28.401Z,1411439908.401 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component.
2014-09-23T02:38:28.401Z,1411439908.401 [DeadReckonUsingDVLWaterTrack](DEBUG): Initializing DeadReckonUsingDVLWaterTrack component.
2014-09-23T02:38:28.401Z,1411439908.401 [NavChart](DEBUG): Initialize NavChart Navigation.
2014-09-23T02:38:28.402Z,1411439908.402 [UniversalFixResidualReporter](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2014-09-23T02:38:28.408Z,1411439908.408 [InternalSim](DEBUG):  InternalSim initializing...
2014-09-23T02:38:28.416Z,1411439908.416 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2014-09-23T02:38:28.425Z,1411439908.425 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 860
2014-09-23T02:38:28.426Z,1411439908.426 [WetLabsBB2FL](INFO): Powering down
2014-09-23T02:38:28.465Z,1411439908.465 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 861
2014-09-23T02:38:28.471Z,1411439908.471 [Radio_Surface](INFO): Powering up
2014-09-23T02:38:28.484Z,1411439908.484 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 862
2014-09-23T02:38:28.494Z,1411439908.494 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources
2014-09-23T02:38:28.495Z,1411439908.495 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2014-09-23T02:38:28.496Z,1411439908.496 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2014-09-23T02:38:28.496Z,1411439908.496 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2014-09-23T02:38:28.496Z,1411439908.496 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2014-09-23T02:38:28.497Z,1411439908.497 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2014-09-23T02:38:28.497Z,1411439908.497 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2014-09-23T02:38:28.497Z,1411439908.497 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2014-09-23T02:38:28.497Z,1411439908.497 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2014-09-23T02:38:28.767Z,1411439908.767 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2014-09-23T02:38:28.823Z,1411439908.823 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2014-09-23T02:38:28.884Z,1411439908.884 [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-23T02:38:28.885Z,1411439908.885 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2014-09-23T02:38:28.968Z,1411439908.968 [MissionManager](INFO): DefineArg Default.TimeMissionWasStarted = 0.000000 h
2014-09-23T02:38:28.972Z,1411439908.972 [MissionManager](INFO): DefineArg Default.ElapsedSinceMissionWasStarted = 0.000000 h
2014-09-23T02:38:28.992Z,1411439908.992 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2014-09-23T02:38:29.017Z,1411439909.017 [Default:CheckIn:A.SetSpeed](DEBUG): Construct.
2014-09-23T02:38:29.023Z,1411439909.023 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2014-09-23T02:38:29.048Z,1411439909.048 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed](DEBUG): Construct.
2014-09-23T02:38:29.062Z,1411439909.062 [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-23T02:38:29.086Z,1411439909.086 [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-23T02:38:29.225Z,1411439909.225 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D.
2014-09-23T02:38:29.245Z,1411439909.245 [AcousticModem_Benthos_ATM900](INFO): Powering up
2014-09-23T02:38:29.245Z,1411439909.245 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2014-09-23T02:38:29.429Z,1411439909.429 [DVL_micro](INFO): Initializing
2014-09-23T02:38:29.746Z,1411439909.746 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:29.751Z,1411439909.751 [DeadReckonUsingMultipleVelocitySources](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T02:38:29.775Z,1411439909.775 [DeadReckonWithRespectToWater](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T02:38:29.790Z,1411439909.790 [DeadReckonWithRespectToSeafloor](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T02:38:29.806Z,1411439909.806 [DeadReckonUsingDVLWaterTrack](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T02:38:29.918Z,1411439909.918 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2014-09-23T02:38:29.926Z,1411439909.926 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2014-09-23T02:38:29.940Z,1411439909.940 [ElevatorServo](DEBUG): Initializing EZServoServo.
2014-09-23T02:38:29.946Z,1411439909.946 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2014-09-23T02:38:29.960Z,1411439909.960 [MassServo](DEBUG): Initializing EZServoServo.
2014-09-23T02:38:29.966Z,1411439909.966 [MassServo](DEBUG): Initializing MassServo.
2014-09-23T02:38:29.972Z,1411439909.972 [RudderServo](DEBUG): Initializing EZServoServo.
2014-09-23T02:38:29.978Z,1411439909.978 [RudderServo](DEBUG): Initializing RudderServo.
2014-09-23T02:38:30.006Z,1411439910.006 [ThrusterServo](DEBUG): Initializing EZServoServo.
2014-09-23T02:38:30.014Z,1411439910.014 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2014-09-23T02:38:30.293Z,1411439910.293 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:30.294Z,1411439910.294 [DeadReckonUsingMultipleVelocitySources](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T02:38:30.303Z,1411439910.303 [DeadReckonWithRespectToWater](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T02:38:30.304Z,1411439910.304 [DeadReckonWithRespectToSeafloor](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T02:38:30.304Z,1411439910.304 [DeadReckonUsingDVLWaterTrack](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T02:38:30.753Z,1411439910.753 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:30.753Z,1411439910.753 [DeadReckonUsingMultipleVelocitySources](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T02:38:30.754Z,1411439910.754 [DeadReckonWithRespectToWater](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T02:38:30.763Z,1411439910.763 [DeadReckonWithRespectToSeafloor](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T02:38:30.764Z,1411439910.764 [DeadReckonUsingDVLWaterTrack](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T02:38:31.399Z,1411439911.399 [NAL9602](INFO): Powering up NAL9602
2014-09-23T02:38:31.449Z,1411439911.449 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:31.991Z,1411439911.991 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:32.473Z,1411439912.473 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:32.750Z,1411439912.750 [Aanderaa_O2](INFO): Powering down
2014-09-23T02:38:33.439Z,1411439913.439 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:33.948Z,1411439913.948 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:34.555Z,1411439914.555 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:35.378Z,1411439915.378 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:36.062Z,1411439916.062 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:36.695Z,1411439916.695 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:37.174Z,1411439917.174 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:37.565Z,1411439917.565 [AcousticModem_Benthos_ATM900](DEBUG): 
2014-09-23T02:38:37.609Z,1411439917.609 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:38.093Z,1411439918.093 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:38.498Z,1411439918.498 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:38.891Z,1411439918.891 [AcousticModem_Benthos_ATM900](DEBUG): Teledyne Benthos ATM-900 Series
2014-09-23T02:38:38.891Z,1411439918.891 [AcousticModem_Benthos_ATM900](DEBUG): MF Frequency Band
2014-09-23T02:38:38.892Z,1411439918.892 [AcousticModem_Benthos_ATM900](DEBUG): Standard version 8.8.9
2014-09-23T02:38:39.058Z,1411439919.058 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:39.439Z,1411439919.439 [AcousticModem_Benthos_ATM900](DEBUG): Sep 23 2014 02:35:42 
2014-09-23T02:38:39.484Z,1411439919.484 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:40.005Z,1411439920.005 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:40.400Z,1411439920.400 [AcousticModem_Benthos_ATM900](INFO): entering command mode
2014-09-23T02:38:40.513Z,1411439920.513 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:40.905Z,1411439920.905 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T02:38:40.906Z,1411439920.906 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt 1: user:1>
2014-09-23T02:38:40.906Z,1411439920.906 [AcousticModem_Benthos_ATM900](INFO): command mode acknowledged
2014-09-23T02:38:40.938Z,1411439920.938 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:41.350Z,1411439921.350 [AcousticModem_Benthos_ATM900](INFO): setting local address to 3
2014-09-23T02:38:41.447Z,1411439921.447 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:41.854Z,1411439921.854 [AcousticModem_Benthos_ATM900](DEBUG): checking for local address setting acknowledgment
2014-09-23T02:38:41.855Z,1411439921.855 [AcousticModem_Benthos_ATM900](INFO): set local address to 3
2014-09-23T02:38:41.924Z,1411439921.924 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:42.360Z,1411439922.360 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:42.768Z,1411439922.768 [NAL9602](INFO): NAL9602 initialized
2014-09-23T02:38:42.793Z,1411439922.793 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:43.318Z,1411439923.318 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:43.811Z,1411439923.811 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:44.319Z,1411439924.319 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:44.373Z,1411439924.373 [SBIT](IMPORTANT): Beginning Startup BIT
2014-09-23T02:38:44.375Z,1411439924.375 [CBIT](IMPORTANT): Beginning GF scan
2014-09-23T02:38:44.832Z,1411439924.832 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:45.313Z,1411439925.313 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:45.794Z,1411439925.794 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:46.311Z,1411439926.311 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:47.276Z,1411439927.276 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:47.797Z,1411439927.797 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:48.370Z,1411439928.370 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:48.947Z,1411439928.947 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:49.423Z,1411439929.423 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:49.927Z,1411439929.927 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:50.448Z,1411439930.448 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:50.954Z,1411439930.954 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:51.481Z,1411439931.481 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:51.000Z,1411439932.000 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:52.500Z,1411439932.500 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:53.040Z,1411439933.040 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:53.683Z,1411439933.683 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:54.182Z,1411439934.182 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:54.663Z,1411439934.663 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:55.160Z,1411439935.160 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:55.646Z,1411439935.646 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:56.130Z,1411439936.130 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:56.595Z,1411439936.595 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:57.123Z,1411439937.123 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:57.632Z,1411439937.632 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:58.112Z,1411439938.112 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:58.623Z,1411439938.623 [BPC1](ERROR): A bank expecting battery number:1 and read number: uart read:X
$S,01,270F,02,00,04,60%21
$C1,01,FF,02,00,03,FF,04,00,05,00,06,00,07,00%72
$B11,0A,FFF6%43
$B12,0A,FFF5%43
$B13,0A,FFF4%43
$B14,0A,FFF6%46
$B15,0A,FFF7%46
$B16,0A,FFF8%4A
$B17,0A,FFF8%4B
$B18,0A,0000%3A
$S,01,270F,02,00,04,60%21
$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,3D84,0A,FFF7,0B,FFF9%4D
$B11,0C,0001,0D,0060,0E,0059,0F,1566,10,16E0,11,8EA8,12,B76A%3F
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0001,18,1838,19,3840%42
$B11,1A,0031,1B,4357,1C,00BE%33
$B12,02,000A,01,026C,03,0001,08,0B8D,09,3D85,0A,FFF6,0B,FFF8%3E
$B12,0C,0001,0D,005F,0E,005A,0F,15AD,10,1731,11,820E,12,A292%43
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0001,18,1838,19,3840%41
$B12,1A,0031,1B,4357,1C,00A3%45
$B13,02,000A,01,026C,03,0001,08,0B90,09,3D83,0A,FFF7,0B,FFF7%42
$B13,0C,0001,0D,0062,0E,0059,0F,155D,10,170A,11,8E6C,12,8E6C%4D
$B13,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0001,18,1838,19,3840%40
$B13,1A,0031,1B,4357,1C,0091%3E
$B14,02,000A,01,026C,03,0001,08,0B96,09,3D8D,0A,FFF8,0B,FFF9%35
$B14,0C,0001,0D,0060,0E,0059,0F,157D,10,16E8,11,A12A,12,B82F%4A
$B14,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0001,18,1838,19,3840%47
$B14,1A,0031,1B,4357,1C,00B7%44
$B15,02,000A,01,026C,03,0001,08,0B9A,09,3D88,0A,FFFA,0B,FFFB%3D
$B15,0C,0001,0D,0060,0E,005D,0F,1653,10,1782,11,DF3E,12,FFFF%4F
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0001,18,1838,19,3840%46
$B15,1A,0031,1B,4357,1C,008F%4E
$B16,02,000A,01,026C,03,0001,08,0B91,09,3D8A,0A,FFF9,0B,FFFB%4F
$B16,0C,0001,0D,0060,0E,005A,0F,1597,10,16B6,11,B90E,12,FFFF%47
$B16,13,FFFF,14,0000,15,41A0,16,00E0,17,0001,18,1838,19,3840%4B
$B16,1A,0031,1B,4357,1C,0088%33
$B17,02,000A,01,026C,03,0001,08,0B91,09,3D91,0A,FFFA,0B,FFFC%46
$B17,0C,0001,0D,0061,0E,005A,0F,15AE,10,16CA,11,D8CC,12,FFFF%49
$B17,13,FFFF,14,0000,15,41A0,16,00E0,17,0001,18,1838,19,3840%4A
$B17,1A,0031,1B,4357,1C,0098%33
$B18,02,000A,01,026C,03,0001,08,0B8D,09,3CF8,0A,0000,0B,0000%4E
$B18,0C,0001,0D,005D,0E,0057,0F,14E8,10,1698,11,FFFF,12,FFFF%41
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0001,18,1838,19,3840%4B
$B18,1A,0031,1B,4357,1C,00B3%4C

2014-09-23T02:38:58.623Z,1411439938.623 [BPC1](FAULT): Failed to parse bank A battery data
2014-09-23T02:38:58.623Z,1411439938.623 [BPC1] Data Fault, FailCount= 1
2014-09-23T02:38:58.623Z,1411439938.623 [BPC1](ERROR): Data Fault
2014-09-23T02:38:58.641Z,1411439938.641 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:58.738Z,1411439938.738 [CBIT](ERROR): Data Fault in component: BPC1
2014-09-23T02:38:59.089Z,1411439939.089 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:59.488Z,1411439939.488 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:38:59.950Z,1411439939.950 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:00.437Z,1411439940.437 [CBIT](INFO): Clearing failed state for component BPC1
2014-09-23T02:39:00.437Z,1411439940.437 [BPC1] No Fault, FailCount= 1
2014-09-23T02:39:00.897Z,1411439940.897 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:01.406Z,1411439941.406 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:01.856Z,1411439941.856 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:02.305Z,1411439942.305 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:02.758Z,1411439942.758 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:03.249Z,1411439943.249 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:03.793Z,1411439943.793 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:04.399Z,1411439944.399 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:04.988Z,1411439944.988 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:05.508Z,1411439945.508 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:06.025Z,1411439946.025 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:06.530Z,1411439946.530 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:07.043Z,1411439947.043 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:07.592Z,1411439947.592 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:08.124Z,1411439948.124 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:08.625Z,1411439948.625 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:09.134Z,1411439949.134 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:09.639Z,1411439949.639 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:10.183Z,1411439950.183 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:10.732Z,1411439950.732 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:11.275Z,1411439951.275 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:11.399Z,1411439951.399 [CBIT](IMPORTANT): No ground fault detected
2014-09-23T02:39:11.845Z,1411439951.845 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:12.455Z,1411439952.455 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:12.936Z,1411439952.936 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:13.451Z,1411439953.451 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:13.957Z,1411439953.957 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:14.463Z,1411439954.463 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:14.931Z,1411439954.931 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:15.448Z,1411439955.448 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:15.977Z,1411439955.977 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:16.461Z,1411439956.461 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:16.952Z,1411439956.952 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:17.459Z,1411439957.459 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:17.947Z,1411439957.947 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:18.416Z,1411439958.416 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:18.921Z,1411439958.921 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:19.398Z,1411439959.398 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:19.862Z,1411439959.862 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:20.347Z,1411439960.347 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:20.822Z,1411439960.822 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:21.312Z,1411439961.312 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:21.801Z,1411439961.801 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:22.293Z,1411439962.293 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:22.755Z,1411439962.755 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:23.212Z,1411439963.212 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:23.697Z,1411439963.697 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:24.242Z,1411439964.242 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:24.698Z,1411439964.698 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:25.163Z,1411439965.163 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:25.654Z,1411439965.654 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:26.092Z,1411439966.092 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:26.509Z,1411439966.509 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:27.057Z,1411439967.057 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:28.004Z,1411439968.004 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:28.605Z,1411439968.605 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:29.169Z,1411439969.169 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:29.649Z,1411439969.649 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:30.152Z,1411439970.152 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:30.703Z,1411439970.703 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:31.194Z,1411439971.194 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:31.610Z,1411439971.610 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:32.066Z,1411439972.066 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:32.480Z,1411439972.480 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:32.923Z,1411439972.923 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:33.355Z,1411439973.355 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:33.868Z,1411439973.868 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:34.275Z,1411439974.275 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:34.673Z,1411439974.673 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:35.064Z,1411439975.064 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:35.464Z,1411439975.464 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:35.879Z,1411439975.879 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:36.274Z,1411439976.274 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:36.681Z,1411439976.681 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:37.062Z,1411439977.062 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:37.484Z,1411439977.484 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:37.919Z,1411439977.919 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:38.323Z,1411439978.323 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:38.336Z,1411439978.336 [SBIT](IMPORTANT): SBIT PASSED
2014-09-23T02:39:38.719Z,1411439978.719 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:38.724Z,1411439978.724 [MissionManager](IMPORTANT): Started mission Startup
2014-09-23T02:39:38.724Z,1411439978.724 [Startup] Running Loop=1
2014-09-23T02:39:38.724Z,1411439978.724 [Startup](INFO): Aggregate::initialize Startup
2014-09-23T02:39:38.724Z,1411439978.724 [Startup:A.GoToSurface] Running Loop=1
2014-09-23T02:39:38.724Z,1411439978.724 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-09-23T02:39:38.725Z,1411439978.725 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2014-09-23T02:39:38.725Z,1411439978.725 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2014-09-23T02:39:38.726Z,1411439978.726 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 0.500000 m/s.
2014-09-23T02:39:38.732Z,1411439978.732 [Startup:StartupSatComms] Running Loop=1
2014-09-23T02:39:38.733Z,1411439978.733 [Startup:StartupSatComms](INFO): Aggregate::initialize Startup:StartupSatComms
2014-09-23T02:39:38.733Z,1411439978.733 [Startup:StartupSatComms:A] Running Loop=1
2014-09-23T02:39:39.126Z,1411439979.126 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:39.133Z,1411439979.133 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2014-09-23T02:39:39.520Z,1411439979.520 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:39.920Z,1411439979.920 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:40.321Z,1411439980.321 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:40.738Z,1411439980.738 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:41.151Z,1411439981.151 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:41.552Z,1411439981.552 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:41.957Z,1411439981.957 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:42.345Z,1411439982.345 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:42.737Z,1411439982.737 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:43.138Z,1411439983.138 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:43.538Z,1411439983.538 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:44.061Z,1411439984.061 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:44.452Z,1411439984.452 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:44.878Z,1411439984.878 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:45.235Z,1411439985.235 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:45.676Z,1411439985.676 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:46.073Z,1411439986.073 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:46.445Z,1411439986.445 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:46.875Z,1411439986.875 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:47.296Z,1411439987.296 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:47.697Z,1411439987.697 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:48.072Z,1411439988.072 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:48.472Z,1411439988.472 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:48.878Z,1411439988.878 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:49.277Z,1411439989.277 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:49.698Z,1411439989.698 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:50.115Z,1411439990.115 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:50.550Z,1411439990.550 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:50.951Z,1411439990.951 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:51.354Z,1411439991.354 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:51.750Z,1411439991.750 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:52.152Z,1411439992.152 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:52.555Z,1411439992.555 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:52.970Z,1411439992.970 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:53.378Z,1411439993.378 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:53.823Z,1411439993.823 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:54.215Z,1411439994.215 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:54.614Z,1411439994.614 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:55.012Z,1411439995.012 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:55.411Z,1411439995.411 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:55.830Z,1411439995.830 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:56.235Z,1411439996.235 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:56.652Z,1411439996.652 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:57.088Z,1411439997.088 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:57.473Z,1411439997.473 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:57.914Z,1411439997.914 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:58.317Z,1411439998.317 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:58.706Z,1411439998.706 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:59.117Z,1411439999.117 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:59.537Z,1411439999.537 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:39:59.933Z,1411439999.933 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:00.382Z,1411440000.382 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:00.779Z,1411440000.779 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:01.217Z,1411440001.217 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:01.592Z,1411440001.592 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:01.995Z,1411440001.995 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:02.401Z,1411440002.401 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:02.805Z,1411440002.805 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:03.179Z,1411440003.179 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:03.601Z,1411440003.601 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:04.023Z,1411440004.023 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:04.426Z,1411440004.426 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:04.845Z,1411440004.845 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:05.257Z,1411440005.257 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:05.673Z,1411440005.673 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:06.036Z,1411440006.036 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:06.436Z,1411440006.436 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:06.855Z,1411440006.855 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:07.260Z,1411440007.260 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:07.681Z,1411440007.681 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:08.088Z,1411440008.088 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:08.498Z,1411440008.498 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:08.888Z,1411440008.888 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:09.285Z,1411440009.285 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:09.686Z,1411440009.686 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:10.104Z,1411440010.104 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:10.505Z,1411440010.505 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:10.914Z,1411440010.914 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:11.306Z,1411440011.306 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:11.715Z,1411440011.715 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:12.097Z,1411440012.097 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:12.494Z,1411440012.494 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:12.937Z,1411440012.937 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:13.373Z,1411440013.373 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:13.758Z,1411440013.758 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:14.193Z,1411440014.193 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:14.592Z,1411440014.592 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:15.002Z,1411440015.002 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:15.411Z,1411440015.411 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:15.791Z,1411440015.791 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:16.200Z,1411440016.200 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:16.614Z,1411440016.614 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:17.044Z,1411440017.044 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:17.456Z,1411440017.456 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:17.859Z,1411440017.859 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:18.247Z,1411440018.247 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:18.646Z,1411440018.646 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:19.057Z,1411440019.057 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:19.446Z,1411440019.446 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:19.912Z,1411440019.912 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:20.349Z,1411440020.349 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:20.742Z,1411440020.742 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:21.119Z,1411440021.119 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:21.516Z,1411440021.516 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:21.916Z,1411440021.916 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:22.339Z,1411440022.339 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:22.741Z,1411440022.741 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:23.172Z,1411440023.172 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:23.598Z,1411440023.598 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:24.002Z,1411440024.002 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:24.393Z,1411440024.393 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:24.773Z,1411440024.773 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:25.171Z,1411440025.171 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:25.591Z,1411440025.591 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:25.997Z,1411440025.997 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:26.426Z,1411440026.426 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:26.858Z,1411440026.858 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:27.253Z,1411440027.253 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:27.678Z,1411440027.678 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:28.064Z,1411440028.064 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:28.503Z,1411440028.503 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:28.888Z,1411440028.888 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:29.323Z,1411440029.323 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:29.813Z,1411440029.813 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:30.183Z,1411440030.183 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:30.582Z,1411440030.582 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:30.980Z,1411440030.980 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:31.379Z,1411440031.379 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:31.810Z,1411440031.810 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:32.219Z,1411440032.219 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:32.610Z,1411440032.610 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:33.027Z,1411440033.027 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:33.419Z,1411440033.419 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:33.818Z,1411440033.818 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:34.221Z,1411440034.221 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:34.617Z,1411440034.617 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:35.026Z,1411440035.026 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:35.432Z,1411440035.432 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:35.841Z,1411440035.841 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:36.263Z,1411440036.263 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:36.653Z,1411440036.653 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:37.045Z,1411440037.045 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:37.445Z,1411440037.445 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:37.872Z,1411440037.872 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:38.289Z,1411440038.289 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:38.692Z,1411440038.692 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:39.079Z,1411440039.079 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:39.085Z,1411440039.085 [Startup:StartupSatComms:A](INFO): Timed out from 2014-09-23T02:39:38.7Z
2014-09-23T02:40:39.085Z,1411440039.085 [Startup:StartupSatComms:A] Stopped
2014-09-23T02:40:39.085Z,1411440039.085 [Startup:StartupSatComms:B] Running Loop=1
2014-09-23T02:40:39.505Z,1411440039.505 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:39.532Z,1411440039.532 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2014-09-23T02:40:40.039Z,1411440040.039 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:40.483Z,1411440040.483 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:40.876Z,1411440040.876 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:41.800Z,1411440041.800 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:43.629Z,1411440043.629 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:44.052Z,1411440044.052 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:44.531Z,1411440044.531 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:44.929Z,1411440044.929 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:45.345Z,1411440045.345 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:45.764Z,1411440045.764 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:46.143Z,1411440046.143 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:46.561Z,1411440046.561 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:47.459Z,1411440047.459 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:48.015Z,1411440048.015 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:48.392Z,1411440048.392 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:48.809Z,1411440048.809 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:49.208Z,1411440049.208 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:49.610Z,1411440049.610 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:49.000Z,1411440050.000 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:50.393Z,1411440050.393 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:50.793Z,1411440050.793 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:51.212Z,1411440051.212 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:51.639Z,1411440051.639 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:52.533Z,1411440052.533 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:53.014Z,1411440053.014 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:53.402Z,1411440053.402 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:53.817Z,1411440053.817 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:54.273Z,1411440054.273 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:54.722Z,1411440054.722 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:55.104Z,1411440055.104 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:55.501Z,1411440055.501 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:55.903Z,1411440055.903 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:56.349Z,1411440056.349 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:56.711Z,1411440056.711 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:57.144Z,1411440057.144 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:40:58.057Z,1411440058.057 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:41:06.103Z,1411440066.103 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:41:06.586Z,1411440066.586 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:41:06.990Z,1411440066.990 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:41:07.443Z,1411440067.443 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:41:07.822Z,1411440067.822 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:41:08.236Z,1411440068.236 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:41:08.629Z,1411440068.629 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:41:09.002Z,1411440069.002 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:41:09.425Z,1411440069.425 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:41:09.823Z,1411440069.823 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:41:10.719Z,1411440070.719 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:41:18.690Z,1411440078.690 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:41:19.275Z,1411440079.275 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:41:19.704Z,1411440079.704 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:41:20.105Z,1411440080.105 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:41:20.506Z,1411440080.506 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:41:20.917Z,1411440080.917 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:41:21.309Z,1411440081.309 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:41:21.746Z,1411440081.746 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:41:22.107Z,1411440082.107 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:41:22.602Z,1411440082.602 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:41:23.513Z,1411440083.513 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:41:24.058Z,1411440084.058 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:41:24.448Z,1411440084.448 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:41:24.861Z,1411440084.861 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:41:25.264Z,1411440085.264 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T02:41:25.726Z,1411440085.726 [HFRCMReconstructedInte