2015-02-13T21:03:48.847Z,1423861428.847 [Supervisor](DEBUG): Initializing supervisor.
2015-02-13T21:03:48.850Z,1423861428.850 [SyncHandler](DEBUG): Created PCaller Thread at 4034C4E0
2015-02-13T21:03:48.850Z,1423861428.850 [SyncHandler](INFO): Protected caller Thread ID is 968
2015-02-13T21:03:48.851Z,1423861428.851 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2015-02-13T21:03:48.852Z,1423861428.852 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4037C4E0
2015-02-13T21:03:48.852Z,1423861428.852 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 969
2015-02-13T21:03:48.855Z,1423861428.855 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2015-02-13T21:03:48.867Z,1423861428.867 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2015-02-13T21:03:48.868Z,1423861428.868 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 403AC4E0
2015-02-13T21:03:48.868Z,1423861428.868 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 970
2015-02-13T21:03:48.869Z,1423861428.869 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2015-02-13T21:03:48.870Z,1423861428.870 [logger ThreadHandler](DEBUG): Created PCaller Thread at 403DC4E0
2015-02-13T21:03:48.870Z,1423861428.870 [logger ThreadHandler](INFO): Protected caller Thread ID is 971
2015-02-13T21:03:48.872Z,1423861428.872 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2015-02-13T21:03:48.873Z,1423861428.873 [Supervisor](INFO): Looking for Config files in directory: Config/
2015-02-13T21:03:48.874Z,1423861428.874 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2015-02-13T21:03:49.207Z,1423861429.207 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2015-02-13T21:03:49.208Z,1423861429.208 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2015-02-13T21:03:49.371Z,1423861429.371 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2015-02-13T21:03:49.371Z,1423861429.371 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2015-02-13T21:03:49.487Z,1423861429.487 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2015-02-13T21:03:49.488Z,1423861429.488 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2015-02-13T21:03:49.623Z,1423861429.623 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2015-02-13T21:03:49.624Z,1423861429.624 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2015-02-13T21:03:49.715Z,1423861429.715 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2015-02-13T21:03:49.887Z,1423861429.887 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2015-02-13T21:03:49.888Z,1423861429.888 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2015-02-13T21:03:49.974Z,1423861429.974 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2015-02-13T21:03:49.975Z,1423861429.975 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2015-02-13T21:03:50.202Z,1423861430.202 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2015-02-13T21:03:50.203Z,1423861430.203 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2015-02-13T21:03:50.710Z,1423861430.710 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2015-02-13T21:03:50.711Z,1423861430.711 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2015-02-13T21:03:51.224Z,1423861431.224 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2015-02-13T21:03:51.225Z,1423861431.225 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2015-02-13T21:03:52.005Z,1423861432.005 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2015-02-13T21:03:52.005Z,1423861432.005 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2015-02-13T21:03:52.513Z,1423861432.513 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2015-02-13T21:03:52.514Z,1423861432.514 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2015-02-13T21:03:52.665Z,1423861432.665 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2015-02-13T21:03:52.666Z,1423861432.666 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2015-02-13T21:03:53.383Z,1423861433.383 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2015-02-13T21:03:53.384Z,1423861433.384 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2015-02-13T21:03:53.499Z,1423861433.499 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2015-02-13T21:03:53.501Z,1423861433.501 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2015-02-13T21:03:53.502Z,1423861433.502 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2015-02-13T21:03:53.748Z,1423861433.748 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2015-02-13T21:03:53.749Z,1423861433.749 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2015-02-13T21:03:53.872Z,1423861433.872 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Estimation.cfg
2015-02-13T21:03:54.019Z,1423861434.019 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2015-02-13T21:03:54.128Z,1423861434.128 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2015-02-13T21:03:54.236Z,1423861434.236 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2015-02-13T21:03:54.381Z,1423861434.381 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2015-02-13T21:03:54.554Z,1423861434.554 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2015-02-13T21:03:54.719Z,1423861434.719 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2015-02-13T21:03:54.829Z,1423861434.829 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2015-02-13T21:03:54.942Z,1423861434.942 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2015-02-13T21:03:55.062Z,1423861435.062 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2015-02-13T21:03:55.381Z,1423861435.381 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/
2015-02-13T21:03:55.381Z,1423861435.381 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2015-02-13T21:04:00.426Z,1423861440.426 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2015-02-13T21:04:00.502Z,1423861440.502 [VerticalControl](DEBUG): Construct VerticalControl.
2015-02-13T21:04:00.665Z,1423861440.665 [VerticalControl] Loaded
2015-02-13T21:04:00.665Z,1423861440.665 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2015-02-13T21:04:00.666Z,1423861440.666 [HorizontalControl](DEBUG): Construct HorizontalControl.
2015-02-13T21:04:00.786Z,1423861440.786 [HorizontalControl] Loaded
2015-02-13T21:04:00.787Z,1423861440.787 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2015-02-13T21:04:00.787Z,1423861440.787 [SpeedControl](DEBUG): Construct SpeedControl.
2015-02-13T21:04:00.793Z,1423861440.793 [SpeedControl] Loaded
2015-02-13T21:04:00.794Z,1423861440.794 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2015-02-13T21:04:00.794Z,1423861440.794 [LoopControl](DEBUG): Construct LoopControl.
2015-02-13T21:04:00.795Z,1423861440.795 [LoopControl] Loaded
2015-02-13T21:04:00.795Z,1423861440.795 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2015-02-13T21:04:00.799Z,1423861440.799 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2015-02-13T21:04:00.800Z,1423861440.800 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2015-02-13T21:04:00.952Z,1423861440.952 [SBIT](DEBUG): Construct Startup Built In Test.
2015-02-13T21:04:00.964Z,1423861440.964 [SBIT] Loaded
2015-02-13T21:04:00.964Z,1423861440.964 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2015-02-13T21:04:00.965Z,1423861440.965 [IBIT](DEBUG): Construct Initiated Built In Test.
2015-02-13T21:04:00.996Z,1423861440.996 [IBIT] Loaded
2015-02-13T21:04:00.997Z,1423861440.997 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2015-02-13T21:04:00.999Z,1423861440.999 [CBIT](DEBUG): Construct CBIT Built In Test.
2015-02-13T21:04:01.202Z,1423861441.202 [CBIT] Loaded
2015-02-13T21:04:01.202Z,1423861441.202 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2015-02-13T21:04:01.202Z,1423861441.202 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2015-02-13T21:04:01.206Z,1423861441.206 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2015-02-13T21:04:01.225Z,1423861441.225 [DepthRateCalculator] Loaded
2015-02-13T21:04:01.225Z,1423861441.225 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2015-02-13T21:04:01.231Z,1423861441.231 [PitchRateCalculator] Loaded
2015-02-13T21:04:01.231Z,1423861441.231 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2015-02-13T21:04:01.246Z,1423861441.246 [SpeedCalculator] Loaded
2015-02-13T21:04:01.247Z,1423861441.247 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2015-02-13T21:04:01.264Z,1423861441.264 [TempGradientCalculator] Loaded
2015-02-13T21:04:01.264Z,1423861441.264 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2015-02-13T21:04:01.269Z,1423861441.269 [YawRateCalculator] Loaded
2015-02-13T21:04:01.270Z,1423861441.270 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2015-02-13T21:04:01.270Z,1423861441.270 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2015-02-13T21:04:01.271Z,1423861441.271 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2015-02-13T21:04:02.878Z,1423861442.878 [HFRCMReconstructedInterpolator] Loaded
2015-02-13T21:04:02.878Z,1423861442.878 [ComponentRegistry](DEBUG): SyncComponent "HFRCMReconstructedInterpolator" handled in the control thread.
2015-02-13T21:04:02.879Z,1423861442.879 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2015-02-13T21:04:02.880Z,1423861442.880 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2015-02-13T21:04:03.145Z,1423861443.145 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2015-02-13T21:04:03.145Z,1423861443.145 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2015-02-13T21:04:03.233Z,1423861443.233 [DeadReckonUsingMultipleVelocitySources] Loaded
2015-02-13T21:04:03.233Z,1423861443.233 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2015-02-13T21:04:03.307Z,1423861443.307 [DeadReckonUsingSpeedCalculator] Loaded
2015-02-13T21:04:03.308Z,1423861443.308 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2015-02-13T21:04:03.356Z,1423861443.356 [DeadReckonWithRespectToWater] Loaded
2015-02-13T21:04:03.356Z,1423861443.356 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToWater" handled in the control thread.
2015-02-13T21:04:03.374Z,1423861443.374 [NavChart] Loaded
2015-02-13T21:04:03.374Z,1423861443.374 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2015-02-13T21:04:03.379Z,1423861443.379 [UniversalFixResidualReporter] Loaded
2015-02-13T21:04:03.379Z,1423861443.379 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2015-02-13T21:04:03.380Z,1423861443.380 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2015-02-13T21:04:03.380Z,1423861443.380 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2015-02-13T21:04:03.386Z,1423861443.386 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2015-02-13T21:04:03.386Z,1423861443.386 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2015-02-13T21:04:03.498Z,1423861443.498 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2015-02-13T21:04:03.498Z,1423861443.498 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2015-02-13T21:04:03.859Z,1423861443.859 [DataOverHttps] Loaded
2015-02-13T21:04:03.859Z,1423861443.859 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2015-02-13T21:04:03.941Z,1423861443.941 [Depth_Keller] Loaded
2015-02-13T21:04:03.941Z,1423861443.941 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2015-02-13T21:04:04.310Z,1423861444.310 [NAL9602] Loaded
2015-02-13T21:04:04.310Z,1423861444.310 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2015-02-13T21:04:04.355Z,1423861444.355 [Onboard] Loaded
2015-02-13T21:04:04.355Z,1423861444.355 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2015-02-13T21:04:04.362Z,1423861444.362 [Radio_Surface] Loaded
2015-02-13T21:04:04.363Z,1423861444.363 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2015-02-13T21:04:04.364Z,1423861444.364 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408074E0
2015-02-13T21:04:04.364Z,1423861444.364 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1061
2015-02-13T21:04:06.544Z,1423861446.544 [BPC1] Loaded
2015-02-13T21:04:06.544Z,1423861446.544 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2015-02-13T21:04:06.545Z,1423861446.545 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2015-02-13T21:04:06.546Z,1423861446.546 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2015-02-13T21:04:06.655Z,1423861446.655 [BuoyancyServo] Loaded
2015-02-13T21:04:06.655Z,1423861446.655 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2015-02-13T21:04:06.667Z,1423861446.667 [ElevatorServo] Loaded
2015-02-13T21:04:06.668Z,1423861446.668 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2015-02-13T21:04:06.682Z,1423861446.682 [MassServo] Loaded
2015-02-13T21:04:06.683Z,1423861446.683 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2015-02-13T21:04:06.703Z,1423861446.703 [RudderServo] Loaded
2015-02-13T21:04:06.704Z,1423861446.704 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2015-02-13T21:04:06.716Z,1423861446.716 [ThrusterServo] Loaded
2015-02-13T21:04:06.716Z,1423861446.716 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2015-02-13T21:04:06.716Z,1423861446.716 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2015-02-13T21:04:06.717Z,1423861446.717 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2015-02-13T21:04:06.995Z,1423861446.995 [ExternalSim] Loaded
2015-02-13T21:04:06.996Z,1423861446.996 [ComponentRegistry](DEBUG): SyncComponent "ExternalSim" handled in the control thread.
2015-02-13T21:04:06.996Z,1423861446.996 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2015-02-13T21:04:06.997Z,1423861446.997 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2015-02-13T21:04:07.025Z,1423861447.025 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2015-02-13T21:04:07.027Z,1423861447.027 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2015-02-13T21:04:07.028Z,1423861447.028 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2015-02-13T21:04:07.034Z,1423861447.034 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2015-02-13T21:04:07.035Z,1423861447.035 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 408B84E0
2015-02-13T21:04:07.036Z,1423861447.036 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1062
2015-02-13T21:04:07.041Z,1423861447.041 [Supervisor](INFO): Main Thread ID is 967
2015-02-13T21:04:07.041Z,1423861447.041 [Supervisor](DEBUG): Running supervisor.
2015-02-13T21:04:07.041Z,1423861447.041 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1063
2015-02-13T21:04:07.045Z,1423861447.045 [controlThread ThreadHandler](INFO): Handler Thread ID is 1064
2015-02-13T21:04:07.045Z,1423861447.045 [controlThread](DEBUG): Initializing ControlThread
2015-02-13T21:04:07.046Z,1423861447.046 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2015-02-13T21:04:07.048Z,1423861447.048 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2015-02-13T21:04:07.049Z,1423861447.049 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2015-02-13T21:04:07.049Z,1423861447.049 [LoopControl](DEBUG): Initialize LoopControlComponent.
2015-02-13T21:04:07.049Z,1423861447.049 [SBIT](INFO): Initialize SBIT Component.
2015-02-13T21:04:07.050Z,1423861447.050 [SBIT](IMPORTANT): Tethys CM Info: SVN revision:12012
2015-02-13T21:04:07.050Z,1423861447.050 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2015-02-13T21:04:07.051Z,1423861447.051 [SBIT](IMPORTANT): Kernel Version:#639 PREEMPT Wed Mar 12 12:53:33 PDT 2014
2015-02-13T21:04:07.051Z,1423861447.051 [IBIT](INFO): Initialize IBIT Component.
2015-02-13T21:04:07.052Z,1423861447.052 [CBIT](DEBUG): Initialize CBIT Component.
2015-02-13T21:04:07.053Z,1423861447.053 [logger ThreadHandler](INFO): Handler Thread ID is 1065
2015-02-13T21:04:07.078Z,1423861447.078 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2015-02-13T21:04:07.079Z,1423861447.079 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2015-02-13T21:04:07.079Z,1423861447.079 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2015-02-13T21:04:07.079Z,1423861447.079 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2015-02-13T21:04:07.080Z,1423861447.080 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2015-02-13T21:04:07.081Z,1423861447.081 [HFRCMReconstructedInterpolator](INFO): Initializing HFRCMReconstructedInterpolator component with velocityAccuracy_ = 0.300000 m/s.
2015-02-13T21:04:07.082Z,1423861447.082 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2015-02-13T21:04:07.083Z,1423861447.083 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2015-02-13T21:04:07.083Z,1423861447.083 [DeadReckonWithRespectToWater](DEBUG): Initializing DeadReckonWithRespectToWater component.
2015-02-13T21:04:07.084Z,1423861447.084 [NavChart](DEBUG): Initialize NavChart Navigation.
2015-02-13T21:04:07.084Z,1423861447.084 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2015-02-13T21:04:07.088Z,1423861447.088 [ExternalSim](INFO): ExternalSim initializing...
2015-02-13T21:04:07.100Z,1423861447.100 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1066
2015-02-13T21:04:07.110Z,1423861447.110 [Radio_Surface](INFO): Powering up
2015-02-13T21:04:07.123Z,1423861447.123 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1067
2015-02-13T21:04:07.130Z,1423861447.130 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources
2015-02-13T21:04:07.131Z,1423861447.131 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2015-02-13T21:04:07.132Z,1423861447.132 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2015-02-13T21:04:07.132Z,1423861447.132 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2015-02-13T21:04:07.132Z,1423861447.132 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2015-02-13T21:04:07.132Z,1423861447.132 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2015-02-13T21:04:07.133Z,1423861447.133 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2015-02-13T21:04:07.133Z,1423861447.133 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2015-02-13T21:04:07.133Z,1423861447.133 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2015-02-13T21:04:07.509Z,1423861447.509 [ExternalSim](DEBUG): beaconLat = 36.80340
2015-02-13T21:04:07.510Z,1423861447.510 [ExternalSim](DEBUG): beaconLon = -121.82230
2015-02-13T21:04:07.510Z,1423861447.510 [ExternalSim](DEBUG): beaconDepth = 25.00
2015-02-13T21:04:07.700Z,1423861447.700 [ExternalSim](DEBUG): Simulator initialized
2015-02-13T21:04:07.706Z,1423861447.706 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2015-02-13T21:04:07.718Z,1423861447.718 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2015-02-13T21:04:07.755Z,1423861447.755 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://aosn.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://aosn.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://aosn.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://aosn.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://aosn.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

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

    <Aggregate Id="StartupSatComms">

        <Sequence/>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:latitude_fix/>
        </ReadDatum>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:platform_communications/>
        </ReadDatum>

    </Aggregate>

</Mission>


2015-02-13T21:04:07.756Z,1423861447.756 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2015-02-13T21:04:07.836Z,1423861447.836 [MissionManager](INFO): DefineArg Default.TimeMissionWasStarted = 0.000000 h
2015-02-13T21:04:07.844Z,1423861447.844 [MissionManager](INFO): DefineArg Default.ElapsedSinceMissionWasStarted = 0.000000 h
2015-02-13T21:04:07.848Z,1423861447.848 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2015-02-13T21:04:07.867Z,1423861447.867 [Default:CheckIn:A.SetSpeed](DEBUG): Construct.
2015-02-13T21:04:07.897Z,1423861447.897 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2015-02-13T21:04:07.925Z,1423861447.925 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed](DEBUG): Construct.
2015-02-13T21:04:07.948Z,1423861447.948 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
xmlns:Control="Tethys/Control"
xmlns:Guidance="Tethys/Guidance" 
xmlns:Units="Tethys/Units"
xmlns:Universal="Tethys/Universal"
xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
xsi:schemaLocation="Tethys http://aosn.mbari.org/tethys/Xml/Tethys.xsd
Tethys/Control http://aosn.mbari.org/tethys/Xml/Control.xsd
Tethys/Guidance http://aosn.mbari.org/tethys/Xml/Guidance.xsd
Tethys/Units http://aosn.mbari.org/tethys/Xml/Units.xsd
Tethys/Universal http://aosn.mbari.org/tethys/Xml/Universal.xsd"
Id="Default">

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

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

    <Aggregate Id="StartClock">

        <Sequence/>

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

    </Aggregate>

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

    <Aggregate Id="CheckIn">

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

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

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

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

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

<!-- Do data comms -->

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

    </Aggregate>

    <Aggregate Id="UpdateAndReportMinutesSinceMissionStarted">

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

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

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

    </Aggregate>

    <Aggregate Id="WaitAtTheSurface">

        <Sequence/>

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

    </Aggregate>

</Mission>


2015-02-13T21:04:07.960Z,1423861447.960 [controlThread](DEBUG): Component order: CycleStarter,ExternalSim,DataOverHttps,Depth_Keller,NAL9602,Onboard,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,HFRCMReconstructedInterpolator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToWater,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2015-02-13T21:04:08.541Z,1423861448.541 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:08.568Z,1423861448.568 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 0 cycles since last successful read, accepting data for 5 cycles.
2015-02-13T21:04:08.804Z,1423861448.804 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2015-02-13T21:04:08.809Z,1423861448.809 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2015-02-13T21:04:08.827Z,1423861448.827 [ElevatorServo](DEBUG): Initializing EZServoServo.
2015-02-13T21:04:08.833Z,1423861448.833 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2015-02-13T21:04:08.851Z,1423861448.851 [MassServo](DEBUG): Initializing EZServoServo.
2015-02-13T21:04:08.857Z,1423861448.857 [MassServo](DEBUG): Initializing MassServo.
2015-02-13T21:04:08.863Z,1423861448.863 [RudderServo](DEBUG): Initializing EZServoServo.
2015-02-13T21:04:08.873Z,1423861448.873 [RudderServo](DEBUG): Initializing RudderServo.
2015-02-13T21:04:08.883Z,1423861448.883 [ThrusterServo](DEBUG): Initializing EZServoServo.
2015-02-13T21:04:08.889Z,1423861448.889 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2015-02-13T21:04:09.493Z,1423861449.493 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:09.510Z,1423861449.510 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 1 cycles since last successful read, accepting data for 5 cycles.
2015-02-13T21:04:19.141Z,1423861459.141 [NAL9602](INFO): Powering up NAL9602
2015-02-13T21:04:19.166Z,1423861459.166 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:19.172Z,1423861459.172 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 2 cycles since last successful read, accepting data for 5 cycles.
2015-02-13T21:04:19.563Z,1423861459.563 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:19.570Z,1423861459.570 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 3 cycles since last successful read, accepting data for 5 cycles.
2015-02-13T21:04:20.253Z,1423861460.253 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:20.260Z,1423861460.260 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 4 cycles since last successful read, accepting data for 5 cycles.
2015-02-13T21:04:20.530Z,1423861460.530 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003506
2015-02-13T21:04:20.588Z,1423861460.588 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:20.594Z,1423861460.594 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 5 cycles since last successful read, accepting data for 5 cycles.
2015-02-13T21:04:21.094Z,1423861461.094 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:21.989Z,1423861461.989 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:22.492Z,1423861462.492 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:22.588Z,1423861462.588 [SBIT](IMPORTANT): Beginning Startup BIT
2015-02-13T21:04:22.591Z,1423861462.591 [CBIT](IMPORTANT): Beginning GF scan
2015-02-13T21:04:22.849Z,1423861462.849 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:23.298Z,1423861463.298 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:23.835Z,1423861463.835 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:24.477Z,1423861464.477 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:24.829Z,1423861464.829 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:25.566Z,1423861465.566 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:25.961Z,1423861465.961 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:26.299Z,1423861466.299 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:26.918Z,1423861466.918 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:27.424Z,1423861467.424 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:28.066Z,1423861468.066 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:28.510Z,1423861468.510 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:28.874Z,1423861468.874 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:29.331Z,1423861469.331 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:29.788Z,1423861469.788 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:30.383Z,1423861470.383 [NAL9602](INFO): NAL9602 initialized
2015-02-13T21:04:30.408Z,1423861470.408 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:30.862Z,1423861470.862 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:31.318Z,1423861471.318 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:31.803Z,1423861471.803 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:32.216Z,1423861472.216 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:32.821Z,1423861472.821 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:33.344Z,1423861473.344 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:34.076Z,1423861474.076 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:34.579Z,1423861474.579 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:34.940Z,1423861474.940 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:35.522Z,1423861475.522 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:35.937Z,1423861475.937 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:36.472Z,1423861476.472 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:36.811Z,1423861476.811 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:37.304Z,1423861477.304 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:37.656Z,1423861477.656 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:38.070Z,1423861478.070 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:38.823Z,1423861478.823 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:39.187Z,1423861479.187 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:39.591Z,1423861479.591 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:39.984Z,1423861479.984 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:40.659Z,1423861480.659 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:41.047Z,1423861481.047 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:41.434Z,1423861481.434 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:41.823Z,1423861481.823 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:42.239Z,1423861482.239 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:42.664Z,1423861482.664 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:43.077Z,1423861483.077 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:43.529Z,1423861483.529 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:43.861Z,1423861483.861 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:44.321Z,1423861484.321 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:44.731Z,1423861484.731 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:45.075Z,1423861485.075 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:45.707Z,1423861485.707 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:46.117Z,1423861486.117 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:46.458Z,1423861486.458 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:46.871Z,1423861486.871 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:47.291Z,1423861487.291 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:47.672Z,1423861487.672 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:48.076Z,1423861488.076 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:48.481Z,1423861488.481 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:48.874Z,1423861488.874 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:49.280Z,1423861489.280 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:49.437Z,1423861489.437 [CBIT](IMPORTANT): No ground fault detected
2015-02-13T21:04:49.675Z,1423861489.675 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:50.076Z,1423861490.076 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:50.689Z,1423861490.689 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:51.178Z,1423861491.178 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:51.542Z,1423861491.542 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:52.031Z,1423861492.031 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:52.380Z,1423861492.380 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:52.777Z,1423861492.777 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:53.199Z,1423861493.199 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:53.593Z,1423861493.593 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:53.974Z,1423861493.974 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:54.350Z,1423861494.350 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:54.784Z,1423861494.784 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:55.148Z,1423861495.148 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:55.602Z,1423861495.602 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:56.169Z,1423861496.169 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:56.517Z,1423861496.517 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:57.059Z,1423861497.059 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:57.571Z,1423861497.571 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:57.946Z,1423861497.946 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:58.327Z,1423861498.327 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:58.745Z,1423861498.745 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:59.291Z,1423861499.291 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:04:59.731Z,1423861499.731 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:00.112Z,1423861500.112 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:00.488Z,1423861500.488 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:01.080Z,1423861501.080 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:01.477Z,1423861501.477 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:01.928Z,1423861501.928 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:02.287Z,1423861502.287 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:02.703Z,1423861502.703 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:03.123Z,1423861503.123 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:03.512Z,1423861503.512 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:03.897Z,1423861503.897 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:04.295Z,1423861504.295 [BPC1](ERROR): B 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,FFF8%4D
$B12,0A,0000%30
$B13,0A,0000%31
$B14,0A,FFFB%32
$B15,0A,0000%37
$B16,0A,0000%34
$B17,0A,0000%35
$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,0B7E,09,3FF9,0A,FFF8,0B,FFF9%4C
$B11,0C,0001,0D,0063,0E,005A,0F,15A9,10,1640,11,A274,12,B9A9%38
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0002,18,1838,19,3840%41
$B11,1A,0031,1B,4357,1C,009D%49
$B12,02,000A,01,026C,03,0001,08,0B86,09,3EBF,0A,0000,0B,0000%4A
$B12,0C,0001,0D,0057,0E,0055,0F,1488,10,17B5,11,FFFF,12,FFFF%30
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0002,18,1838,19,3840%42
$B12,1A,0031,1B,4357,1C,0093%3D
$B13,02,000A,01,026C,03,0001,08,0B8A,09,3E93,0A,0000,0B,0000%32
$B13,0C,0001,0D,0060,0E,0051,0F,1387,10,16F7,11,FFFF,12,FFFF%3E
$B13,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0002,18,1838,19,3840%43
$B13,1A,0031,1B,4333,1C,0068%3A
$B14,02,000A,01,026C,03,0001,08,0B86,09,3FF0,0A,FFFB,0B,FFFB%3D
$B14,0C,0001,0D,005F,0E,0059,0F,1555,10,169D,11,FFFC,12,FFFC%41
$B14,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0002,18,1838,19,3840%44
$B14,1A,0031,1B,4357,1C,008D%4D
$B15,02,000A,01,026C,03,0001,08,0B88,09,4017,0A,0000,0B,0000%33
$B15,0C,0001,0D,0063,0E,005C,0F,1624,10,169B,11,FFFF,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,008A%49
$B16,02,000A,01,026C,03,0001,08,0B82,09,39D3,0A,0000,0B,0000%45
$B16,0C,0001,0D,0064,0E,005E,0F,1691,10,16AB,11,FFFF,12,FFFF%3B
$B16,13,FFFF,14,0000,15,41A0,16,00E0,17,0001,18,1838,19,3840%4B
$B16,1A,0031,1B,4357,1C,00B9%48
$B17,02,000A,01,026C,03,0001,08,0B86,09,398B,0A,0000,0B,0000%4D
$B17,0C,0001,0D,0064,0E,005D,0F,1669,10,1701,11,FFFF,12,FFFF%3F
$B17,13,FFFF,14,0000,15,41A0,16,00E0,17,0001,18,1838,19,3840%4A
$B17,1A,0031,1B,4357,1C,00A5%46
$B18,02,000A,01,026C,03,0001,08,0B8B,09,3F06,0A,0000,0B,0001%34
$B18,0C,0001,0D,005A,0E,0052,0F,13C9,10,169F,11,FFFF,12,FFFF%3F
$B18,13,AA28,14,0BB8,15,41A0,16,00C0,17,0002,18,1838,19,3840%42
$B18,1A,0031,1B,4357,1C,00AE%39

2015-02-13T21:05:04.295Z,1423861504.295 [BPC1](ERROR): Failed to parse bank B battery data
2015-02-13T21:05:04.295Z,1423861504.295 [BPC1] Data Fault, FailCount= 1
2015-02-13T21:05:04.295Z,1423861504.295 [BPC1](ERROR): Data Fault
2015-02-13T21:05:04.302Z,1423861504.302 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:04.515Z,1423861504.515 [CBIT](ERROR): Data Fault in component: BPC1
2015-02-13T21:05:04.908Z,1423861504.908 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:05.635Z,1423861505.635 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:06.267Z,1423861506.267 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:06.450Z,1423861506.450 [CBIT](INFO): Clearing failed state for component BPC1
2015-02-13T21:05:06.450Z,1423861506.450 [BPC1] No Fault, FailCount= 1
2015-02-13T21:05:06.794Z,1423861506.794 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:07.291Z,1423861507.291 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:07.635Z,1423861507.635 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:08.043Z,1423861508.043 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:08.452Z,1423861508.452 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:08.865Z,1423861508.865 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:15.050Z,1423861515.050 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:15.508Z,1423861515.508 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:15.880Z,1423861515.880 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:16.482Z,1423861516.482 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:16.544Z,1423861516.544 [SBIT](IMPORTANT): SBIT PASSED
2015-02-13T21:05:16.793Z,1423861516.793 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:16.832Z,1423861516.832 [MissionManager](IMPORTANT): Started mission Startup
2015-02-13T21:05:16.832Z,1423861516.832 [Startup] Running Loop=1
2015-02-13T21:05:16.833Z,1423861516.833 [Startup](INFO): Aggregate::initialize Startup
2015-02-13T21:05:16.833Z,1423861516.833 [Startup:A.GoToSurface] Running Loop=1
2015-02-13T21:05:16.833Z,1423861516.833 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2015-02-13T21:05:16.833Z,1423861516.833 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2015-02-13T21:05:16.834Z,1423861516.834 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2015-02-13T21:05:16.834Z,1423861516.834 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 0.500000 m/s.
2015-02-13T21:05:16.854Z,1423861516.854 [Startup:StartupSatComms] Running Loop=1
2015-02-13T21:05:16.854Z,1423861516.854 [Startup:StartupSatComms](INFO): Aggregate::initialize Startup:StartupSatComms
2015-02-13T21:05:16.854Z,1423861516.854 [Startup:StartupSatComms:A] Running Loop=1
2015-02-13T21:05:17.165Z,1423861517.165 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:17.234Z,1423861517.234 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2015-02-13T21:05:17.554Z,1423861517.554 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:17.955Z,1423861517.955 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:18.403Z,1423861518.403 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:19.153Z,1423861519.153 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:19.462Z,1423861519.462 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:19.957Z,1423861519.957 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:20.339Z,1423861520.339 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:20.686Z,1423861520.686 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:21.184Z,1423861521.184 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:21.633Z,1423861521.633 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:21.981Z,1423861521.981 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:22.370Z,1423861522.370 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:22.771Z,1423861522.771 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:23.183Z,1423861523.183 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:23.595Z,1423861523.595 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:23.989Z,1423861523.989 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:24.373Z,1423861524.373 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:24.844Z,1423861524.844 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:25.230Z,1423861525.230 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:25.575Z,1423861525.575 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:25.975Z,1423861525.975 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:26.472Z,1423861526.472 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:26.781Z,1423861526.781 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:27.236Z,1423861527.236 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:27.598Z,1423861527.598 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:27.963Z,1423861527.963 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:28.403Z,1423861528.403 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:28.768Z,1423861528.768 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:29.164Z,1423861529.164 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:29.613Z,1423861529.613 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:29.971Z,1423861529.971 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:30.370Z,1423861530.370 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:30.779Z,1423861530.779 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:31.184Z,1423861531.184 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:31.773Z,1423861531.773 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:32.118Z,1423861532.118 [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,FFF8%4D
$B12,0A,0000%30
$B13,0A,0000%31
$B14,0A,FFFB%32
$B15,0A,0000%37
$B16,0A,0000%34
$B17,0A,0000%35
$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,0B7E,09,3FFA,0A,FFF8,0B,FFF8%35
$B11,0C,0001,0D,0063,0E,005A,0F,15A9,10,1640,11,A274,12,A274%4B
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0002,18,1838,19,3840%41
$B11,1A,0031,1B,4357,1C,009D%49
$B12,02,000A,01,026C,03,0001,08,0B86,09,3EBE,0A,0000,0B,0000%49
$B12,0C,0001,0D,0057,0E,0055,0F,1488,10,17B5,11,FFFF,12,FFFF%30
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0002,18,1838,19,3840%42
$B12,1A,0031,1B,4357,1C,0093%3D
$B13,02,000A,01,026C,03,0001,08,0B8A,09,3E93,0A,0000,0B,0000%32
$B13,0C,0001,0D,0060,0E,0051,0F,1387,10,16F7,11,FFFF,12,FFFF%3E
$B13,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0002,18,1838,19,3840%43
$B13,1A,0031,1B,4333,1C,0068%3A
$B14,02,000A,01,026C,03,0001,08,0B86,09,3FF0,0A,FFFB,0B,FFFB%3D
$B14,0C,0001,0D,005F,0E,0059,0F,1555,10,169D,11,FFFC,12,FFFC%41
$B14,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0002,18,1838,19,3840%44
$B14,1A,0031,1B,4357,1C,008D%4D
$B15,02,000A,01,026C,03,0001,08,0B88,09,4016,0A,0000,0B,0000%32
$B15,0C,0001,0D,0063,0E,005C,0F,1624,10,169B,11,FFFF,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,008A%49
$B16,02,000A,01,026C,03,0001,08,0B82,09,39D3,0A,0000,0B,0000%45
$B16,0C,0001,0D,0064,0E,005E,0F,1691,10,16AB,11,FFFF,12,FFFF%3B
$B16,13,FFFF,14,0000,15,41A0,16,00E0,17,0001,18,1838,19,3840%4B
$B16,1A,0031,1B,4357,1C,00B9%48
$B17,02,000A,01,026C,03,0001,08,0B86,09,398B,0A,0000,0B,0000%4D
$B17,0C,0001,0D,0064,0E,005D,0F,1669,10,1701,11,FFFF,12,FFFF%3F
$B17,13,FFFF,14,0000,15,41A0,16,00E0,17,0001,18,1838,19,3840%4A
$B17,1A,0031,1B,4357,1C,00A5%46
$B18,02,000A,01,026C,03,0001,08,0B8B,09,3F06,0A,0000,0B,0000%35
$B18,0C,0001,0D,005A,0E,0052,0F,13C9,10,169F,11,FFFF,12,FFFF%3F
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0002,18,1838,19,3840%48
$B18,1A,0031,1B,4357,1C,00AE%39

2015-02-13T21:05:32.118Z,1423861532.118 [BPC1](ERROR): Failed to parse bank A battery data
2015-02-13T21:05:32.118Z,1423861532.118 [BPC1] Data Fault, FailCount= 1
2015-02-13T21:05:32.118Z,1423861532.118 [BPC1](ERROR): Data Fault
2015-02-13T21:05:32.126Z,1423861532.126 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:32.198Z,1423861532.198 [CBIT](ERROR): Data Fault in component: BPC1
2015-02-13T21:05:32.462Z,1423861532.462 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:32.862Z,1423861532.862 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:33.297Z,1423861533.297 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:33.327Z,1423861533.327 [CBIT](INFO): Clearing failed state for component BPC1
2015-02-13T21:05:33.327Z,1423861533.327 [BPC1] No Fault, FailCount= 1
2015-02-13T21:05:33.688Z,1423861533.688 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:34.080Z,1423861534.080 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:34.460Z,1423861534.460 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:34.861Z,1423861534.861 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:35.262Z,1423861535.262 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:35.662Z,1423861535.662 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:36.063Z,1423861536.063 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:36.464Z,1423861536.464 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:36.968Z,1423861536.968 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:37.289Z,1423861537.289 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:37.661Z,1423861537.661 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:38.055Z,1423861538.055 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:38.463Z,1423861538.463 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:38.863Z,1423861538.863 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:39.257Z,1423861539.257 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:39.661Z,1423861539.661 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:40.061Z,1423861540.061 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:40.450Z,1423861540.450 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:40.864Z,1423861540.864 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:41.264Z,1423861541.264 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:41.844Z,1423861541.844 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:42.129Z,1423861542.129 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:42.489Z,1423861542.489 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:42.887Z,1423861542.887 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:43.288Z,1423861543.288 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:43.688Z,1423861543.688 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:44.089Z,1423861544.089 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:44.488Z,1423861544.488 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:44.917Z,1423861544.917 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:45.287Z,1423861545.287 [BPC1](ERROR): B 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,FFF8%4D
$B12,0A,0000%30
$B13,0A,0000%31
$B14,0A,FFFB%32
$B15,0A,0000%37
$B16,0A,0000%34
$B17,0A,0000%35
$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,0B7F,09,3FFA,0A,FFF8,0B,FFF8%36
$B11,0C,0001,0D,0063,0E,005A,0F,15A9,10,1640,11,A274,12,A274%4B
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0002,18,1838,19,3840%41
$B11,1A,0031,1B,4357,1C,009D%49
$B12,02,000A,01,026C,03,0001,08,0B86,09,3EBF,0A,0000,0B,0000%4A
$B12,0C,0001,0D,0057,0E,0055,0F,1488,10,17B5,11,FFFF,12,FFFF%30
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0002,18,1838,19,3840%42
$B12,1A,0031,1B,4357,1C,0093%3D
$B13,02,000A,01,026C,03,0001,08,0B8A,09,3E93,0A,0000,0B,0000%32
$B13,0C,0001,0D,0060,0E,0051,0F,1387,10,16F7,11,FFFF,12,FFFF%3E
$B13,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0002,18,1838,19,3840%43
$B13,1A,0031,1B,4333,1C,0068%3A
$B14,02,000A,01,026C,03,0001,08,0B86,09,3FF0,0A,FFFB,0B,FFFB%3D
$B14,0C,0001,0D,005F,0E,0059,0F,1555,10,169D,11,FFFC,12,FFFC%41
$B14,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0002,18,1838,19,3840%44
$B14,1A,0031,1B,4357,1C,008D%4D
$B15,02,000A,01,026C,03,0001,08,0B88,09,4017,0A,0000,0B,0000%33
$B15,0C,0001,0D,0063,0E,005C,0F,1624,10,169B,11,FFFF,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,008A%49
$B16,02,000A,01,026C,03,0001,08,0B82,09,39D3,0A,0000,0B,0000%45
$B16,0C,0001,0D,0064,0E,005E,0F,1691,10,16AB,11,FFFF,12,FFFF%3B
$B16,13,FFFF,14,0000,15,41A0,16,00E0,17,0001,18,1838,19,3840%4B
$B16,1A,0031,1B,4357,1C,00B9%48
$B17,02,000A,01,026C,03,0001,08,0B86,09,398B,0A,0000,0B,0000%4D
$B17,0C,0001,0D,0064,0E,005D,0F,1669,10,1701,11,FFFF,12,FFFF%3F
$B17,13,FFFF,14,0000,15,41A0,16,00E0,17,0001,18,1838,19,3840%4A
$B17,1A,0031,1B,4357,1C,00A5%46
$B18,02,000A,01,026C,03,0001,08,0B8B,09,3F06,0A,0000,0B,0000%35
$B18,0C,0001,0D,005A,0E,0052,0F,13C9,10,169F,11,FFFF,12,FFFF%3F
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0002,18,1838,19,3840%48
$B18,1A,0031,1B,4357,1C,00AE%39

2015-02-13T21:05:45.287Z,1423861545.287 [BPC1](ERROR): Failed to parse bank B battery data
2015-02-13T21:05:45.287Z,1423861545.287 [BPC1] Data Fault, FailCount= 2
2015-02-13T21:05:45.287Z,1423861545.287 [BPC1](ERROR): Data Fault
2015-02-13T21:05:45.292Z,1423861545.292 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:45.322Z,1423861545.322 [CBIT](ERROR): Data Fault in component: BPC1
2015-02-13T21:05:45.691Z,1423861545.691 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:46.258Z,1423861546.258 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:46.579Z,1423861546.579 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:46.617Z,1423861546.617 [CBIT](INFO): Clearing failed state for component BPC1
2015-02-13T21:05:46.617Z,1423861546.617 [BPC1] No Fault, FailCount= 2
2015-02-13T21:05:47.205Z,1423861547.205 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:47.505Z,1423861547.505 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:48.026Z,1423861548.026 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:48.541Z,1423861548.541 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:48.883Z,1423861548.883 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:49.216Z,1423861549.216 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:49.658Z,1423861549.658 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:50.017Z,1423861550.017 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:50.428Z,1423861550.428 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:50.822Z,1423861550.822 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:51.216Z,1423861551.216 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:51.711Z,1423861551.711 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:52.266Z,1423861552.266 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:52.565Z,1423861552.565 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:52.921Z,1423861552.921 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:53.322Z,1423861553.322 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:53.717Z,1423861553.717 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:54.123Z,1423861554.123 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:54.623Z,1423861554.623 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:54.981Z,1423861554.981 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:55.450Z,1423861555.450 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:55.754Z,1423861555.754 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:56.154Z,1423861556.154 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:56.568Z,1423861556.568 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:57.200Z,1423861557.200 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:57.472Z,1423861557.472 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:57.905Z,1423861557.905 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:58.262Z,1423861558.262 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:58.646Z,1423861558.646 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:59.095Z,1423861559.095 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:59.512Z,1423861559.512 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:05:59.888Z,1423861559.888 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:00.265Z,1423861560.265 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:00.678Z,1423861560.678 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:01.047Z,1423861561.047 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:01.487Z,1423861561.487 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:01.903Z,1423861561.903 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:02.512Z,1423861562.512 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:02.861Z,1423861562.861 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:03.198Z,1423861563.198 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:03.566Z,1423861563.566 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:03.998Z,1423861563.998 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:04.366Z,1423861564.366 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:04.782Z,1423861564.782 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:05.168Z,1423861565.168 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:05.584Z,1423861565.584 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:05.981Z,1423861565.981 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:06.378Z,1423861566.378 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:06.779Z,1423861566.779 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:07.175Z,1423861567.175 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:07.672Z,1423861567.672 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:07.973Z,1423861567.973 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:08.348Z,1423861568.348 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:08.798Z,1423861568.798 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:09.183Z,1423861569.183 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:12.455Z,1423861572.455 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:12.797Z,1423861572.797 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:13.112Z,1423861573.112 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:13.543Z,1423861573.543 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:13.946Z,1423861573.946 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:14.334Z,1423861574.334 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:14.736Z,1423861574.736 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:15.168Z,1423861575.168 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:15.516Z,1423861575.516 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:15.950Z,1423861575.950 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:16.313Z,1423861576.313 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:16.811Z,1423861576.811 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:17.223Z,1423861577.223 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:17.265Z,1423861577.265 [Startup:StartupSatComms:A](INFO): Timed out from 2015-02-13T21:05:16.9Z
2015-02-13T21:06:17.265Z,1423861577.265 [Startup:StartupSatComms:A] Stopped
2015-02-13T21:06:17.265Z,1423861577.265 [Startup:StartupSatComms:B] Running Loop=1
2015-02-13T21:06:17.668Z,1423861577.668 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:17.706Z,1423861577.706 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2015-02-13T21:06:18.417Z,1423861578.417 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:18.763Z,1423861578.763 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:21.917Z,1423861581.917 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:22.158Z,1423861582.158 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20150213T204400/Courier0008.lzma
2015-02-13T21:06:22.179Z,1423861582.179 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:22.578Z,1423861582.578 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:23.192Z,1423861583.192 [DataOverHttps](INFO): Moved sent file to Logs/20150213T204400/Courier0008.lzma.bak
2015-02-13T21:06:23.192Z,1423861583.192 [DataOverHttps](INFO): SBD MOMSN=3001277
2015-02-13T21:06:23.229Z,1423861583.229 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:23.985Z,1423861583.985 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:24.370Z,1423861584.370 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:27.790Z,1423861587.790 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:28.154Z,1423861588.154 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:28.456Z,1423861588.456 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:28.861Z,1423861588.861 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:29.322Z,1423861589.322 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:29.674Z,1423861589.674 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:33.052Z,1423861593.052 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:33.311Z,1423861593.311 [DataOverHttps](INFO): Sending 234 bytes from file Logs/20150213T210117/Courier0000.lzma
2015-02-13T21:06:33.328Z,1423861593.328 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:33.758Z,1423861593.758 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:34.108Z,1423861594.108 [DataOverHttps](INFO): Moved sent file to Logs/20150213T210117/Courier0000.lzma.bak
2015-02-13T21:06:34.108Z,1423861594.108 [DataOverHttps](INFO): SBD MOMSN=3001279
2015-02-13T21:06:34.186Z,1423861594.186 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:35.143Z,1423861595.143 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:35.447Z,1423861595.447 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:38.651Z,1423861598.651 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:38.913Z,1423861598.913 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:39.350Z,1423861599.350 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:39.709Z,1423861599.709 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:40.118Z,1423861600.118 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:40.511Z,1423861600.511 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:43.767Z,1423861603.767 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:44.017Z,1423861604.017 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20150213T204400/Express0009.lzma
2015-02-13T21:06:44.031Z,1423861604.031 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:44.470Z,1423861604.470 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:44.814Z,1423861604.814 [DataOverHttps](INFO): Moved sent file to Logs/20150213T204400/Express0009.lzma.bak
2015-02-13T21:06:44.814Z,1423861604.814 [DataOverHttps](INFO): SBD MOMSN=3001285
2015-02-13T21:06:44.834Z,1423861604.834 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:45.815Z,1423861605.815 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:46.148Z,1423861606.148 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:49.435Z,1423861609.435 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:49.730Z,1423861609.730 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:50.138Z,1423861610.138 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:50.548Z,1423861610.548 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:50.932Z,1423861610.932 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:51.381Z,1423861611.381 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:55.679Z,1423861615.679 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:55.952Z,1423861615.952 [DataOverHttps](INFO): Sending 439 bytes from file Logs/20150213T210117/Express0001.lzma
2015-02-13T21:06:56.008Z,1423861616.008 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:56.420Z,1423861616.420 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:56.802Z,1423861616.802 [DataOverHttps](INFO): Moved sent file to Logs/20150213T210117/Express0001.lzma.bak
2015-02-13T21:06:56.803Z,1423861616.803 [DataOverHttps](INFO): SBD MOMSN=3001287
2015-02-13T21:06:56.817Z,1423861616.817 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:57.831Z,1423861617.831 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:06:58.098Z,1423861618.098 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:07:01.445Z,1423861621.445 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:07:01.732Z,1423861621.732 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:07:02.137Z,1423861622.137 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:07:02.604Z,1423861622.604 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:07:02.944Z,1423861622.944 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:07:03.339Z,1423861623.339 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:07:06.787Z,1423861626.787 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:07:07.043Z,1423861627.043 [DataOverHttps](INFO): Sending 447 bytes from file Logs/20150213T210348/Express0001.lzma
2015-02-13T21:07:07.101Z,1423861627.101 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:07:07.106Z,1423861627.106 [DeadReckonUsingMultipleVelocitySources](FAULT): The allowance for input measurements to start up has expired, but I still cannot determine the rotation from vehicle frame to navigation frame.
2015-02-13T21:07:07.107Z,1423861627.107 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2015-02-13T21:07:07.107Z,1423861627.107 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2015-02-13T21:07:07.111Z,1423861627.111 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2015-02-13T21:07:07.120Z,1423861627.120 [DeadReckonUsingSpeedCalculator](FAULT): The allowance for input measurements to start up has expired, but I still cannot determine the rotation from vehicle frame to navigation frame.
2015-02-13T21:07:07.121Z,1423861627.121 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2015-02-13T21:07:07.121Z,1423861627.121 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2015-02-13T21:07:07.124Z,1423861627.124 [DeadReckonUsingSpeedCalculator](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2015-02-13T21:07:07.131Z,1423861627.131 [DeadReckonWithRespectToWater](FAULT): The allowance for input measurements to start up has expired, but I still cannot determine the rotation from vehicle frame to navigation frame.
2015-02-13T21:07:07.131Z,1423861627.131 [DeadReckonWithRespectToWater] Software Fault, FailCount= 1
2015-02-13T21:07:07.131Z,1423861627.131 [DeadReckonWithRespectToWater](ERROR): Software Fault
2015-02-13T21:07:07.134Z,1423861627.134 [DeadReckonWithRespectToWater](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2015-02-13T21:07:07.159Z,1423861627.159 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2015-02-13T21:07:07.159Z,1423861627.159 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2015-02-13T21:07:07.159Z,1423861627.159 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToWater
2015-02-13T21:07:07.521Z,1423861627.521 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:07:07.532Z,1423861627.532 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2015-02-13T21:07:07.532Z,1423861627.532 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2015-02-13T21:07:07.532Z,1423861627.532 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2015-02-13T21:07:07.532Z,1423861627.532 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2015-02-13T21:07:07.533Z,1423861627.533 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToWater
2015-02-13T21:07:07.533Z,1423861627.533 [DeadReckonWithRespectToWater] No Fault, FailCount= 1
2015-02-13T21:07:08.837Z,1423861628.837 [DataOverHttps](INFO): Moved sent file to Logs/20150213T210348/Express0001.lzma.bak
2015-02-13T21:07:08.837Z,1423861628.837 [DataOverHttps](INFO): SBD MOMSN=3001297
2015-02-13T21:07:08.945Z,1423861628.945 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:07:08.946Z,1423861628.946 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2015-02-13T21:07:08.946Z,1423861628.946 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2015-02-13T21:07:08.946Z,1423861628.946 [DeadReckonWithRespectToWater](DEBUG): Initializing DeadReckonWithRespectToWater component.
2015-02-13T21:07:09.728Z,1423861629.728 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:07:09.759Z,1423861629.759 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 0 cycles since last successful read, accepting data for 5 cycles.
2015-02-13T21:07:09.776Z,1423861629.776 [Startup:StartupSatComms:B] Stopped
2015-02-13T21:07:09.776Z,1423861629.776 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2015-02-13T21:07:09.776Z,1423861629.776 [Startup:StartupSatComms] Stopped
2015-02-13T21:07:09.776Z,1423861629.776 [Startup:StartupSatComms](INFO): Aggregate::uninitialize Startup:StartupSatComms
2015-02-13T21:07:09.777Z,1423861629.777 [Startup](INFO): Completed Startup
2015-02-13T21:07:09.777Z,1423861629.777 [Startup] Stopped
2015-02-13T21:07:09.777Z,1423861629.777 [Startup](INFO): Aggregate::uninitialize Startup
2015-02-13T21:07:09.777Z,1423861629.777 [Startup:A.GoToSurface] Stopped
2015-02-13T21:07:09.777Z,1423861629.777 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2015-02-13T21:07:10.040Z,1423861630.040 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:07:10.047Z,1423861630.047 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 1 cycles since last successful read, accepting data for 5 cycles.
2015-02-13T21:07:10.069Z,1423861630.069 [MissionManager](IMPORTANT): Started mission Default
2015-02-13T21:07:10.070Z,1423861630.070 [Default] Running Loop=1
2015-02-13T21:07:10.070Z,1423861630.070 [Default](INFO): Aggregate::initialize Default
2015-02-13T21:07:10.070Z,1423861630.070 [Default:B.GoToSurface] Running Loop=1
2015-02-13T21:07:10.070Z,1423861630.070 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2015-02-13T21:07:10.070Z,1423861630.070 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2015-02-13T21:07:10.071Z,1423861630.071 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2015-02-13T21:07:10.071Z,1423861630.071 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 0.500000 m/s.
2015-02-13T21:07:10.071Z,1423861630.071 [Default:StartClock] Running Loop=1
2015-02-13T21:07:10.071Z,1423861630.071 [Default:StartClock](INFO): Aggregate::initialize Default:StartClock
2015-02-13T21:07:10.071Z,1423861630.071 [Default:StartClock:A] Running Loop=1
2015-02-13T21:07:10.098Z,1423861630.098 [Default:StartClock:A] Stopped
2015-02-13T21:07:10.098Z,1423861630.098 [Default:StartClock](INFO): Completed Default:StartClock
2015-02-13T21:07:10.099Z,1423861630.099 [Default:StartClock] Stopped
2015-02-13T21:07:10.099Z,1423861630.099 [Default:StartClock](INFO): Aggregate::uninitialize Default:StartClock
2015-02-13T21:07:13.363Z,1423861633.363 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:07:13.384Z,1423861633.384 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 2 cycles since last successful read, accepting data for 5 cycles.
2015-02-13T21:07:13.406Z,1423861633.406 [Default:WaitAtTheSurface] Running Loop=1
2015-02-13T21:07:13.406Z,1423861633.406 [Default:WaitAtTheSurface](INFO): Aggregate::initialize Default:WaitAtTheSurface
2015-02-13T21:07:13.406Z,1423861633.406 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed] Running Loop=1
2015-02-13T21:07:13.406Z,1423861633.406 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed](DEBUG): Initialize.
2015-02-13T21:07:13.643Z,1423861633.643 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:07:13.649Z,1423861633.649 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 3 cycles since last successful read, accepting data for 5 cycles.
2015-02-13T21:07:13.662Z,1423861633.662 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed] Running Loop=1
2015-02-13T21:07:18.704Z,1423861638.704 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:07:18.710Z,1423861638.710 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 4 cycles since last successful read, accepting data for 5 cycles.
2015-02-13T21:07:23.697Z,1423861643.697 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:07:23.704Z,1423861643.704 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 5 cycles since last successful read, accepting data for 5 cycles.
2015-02-13T21:07:28.665Z,1423861648.665 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:07:33.663Z,1423861653.663 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:07:38.703Z,1423861658.703 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:07:43.669Z,1423861663.669 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:07:48.736Z,1423861668.736 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:07:53.681Z,1423861673.681 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:07:58.689Z,1423861678.689 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:08:03.693Z,1423861683.693 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:08:08.672Z,1423861688.672 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:08:13.656Z,1423861693.656 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:08:18.734Z,1423861698.734 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:08:26.448Z,1423861706.448 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:08:28.676Z,1423861708.676 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:08:33.655Z,1423861713.655 [NAL9602](INFO): SBD MO Status=2, MOMSN=5719, MT Status=2, MTMSN=0
2015-02-13T21:08:33.655Z,1423861713.655 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2015-02-13T21:08:33.664Z,1423861713.664 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:08:38.660Z,1423861718.660 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:08:43.741Z,1423861723.741 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:08:48.640Z,1423861728.640 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:08:53.707Z,1423861733.707 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:08:58.831Z,1423861738.831 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:09:03.674Z,1423861743.674 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:09:08.671Z,1423861748.671 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:09:08.706Z,1423861748.706 [Default:UpdateAndReportMinutesSinceMissionStarted] Running Loop=1
2015-02-13T21:09:08.706Z,1423861748.706 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::initialize Default:UpdateAndReportMinutesSinceMissionStarted
2015-02-13T21:09:08.706Z,1423861748.706 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Running Loop=1
2015-02-13T21:09:08.708Z,1423861748.708 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Stopped
2015-02-13T21:09:08.709Z,1423861748.709 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Running Loop=1
2015-02-13T21:09:13.718Z,1423861753.718 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:09:13.754Z,1423861753.754 [Default:UpdateAndReportMinutesSinceMissionStarted:B](IMPORTANT): Default mission has been running for 1.977306 min 
2015-02-13T21:09:13.757Z,1423861753.757 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Stopped
2015-02-13T21:09:13.758Z,1423861753.758 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Completed Default:UpdateAndReportMinutesSinceMissionStarted
2015-02-13T21:09:13.758Z,1423861753.758 [Default:UpdateAndReportMinutesSinceMissionStarted] Stopped
2015-02-13T21:09:13.758Z,1423861753.758 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::uninitialize Default:UpdateAndReportMinutesSinceMissionStarted
2015-02-13T21:09:18.708Z,1423861758.708 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:09:26.931Z,1423861766.931 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:09:28.848Z,1423861768.848 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:09:33.701Z,1423861773.701 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:09:38.665Z,1423861778.665 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2015-02-13T21:09:38.702Z,1423861778.702 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:09:43.761Z,1423861783.761 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:09:48.760Z,1423861788.760 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:09:53.663Z,1423861793.663 [NAL9602](IMPORTANT): GPS fix at: 1423861793.66
2015-02-13T21:09:53.729Z,1423861793.729 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:09:58.667Z,1423861798.667 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:09:58.677Z,1423861798.677 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: allowance for input measurements to start up has not expired, but velocity or orientation is invalid, and horizontal path length since last fix is nonzero.
2015-02-13T21:09:58.695Z,1423861798.695 [DeadReckonUsingSpeedCalculator](DEBUG): Will not write estimated position: allowance for input measurements to start up has not expired, but velocity or orientation is invalid, and horizontal path length since last fix is nonzero.
2015-02-13T21:09:58.701Z,1423861798.701 [DeadReckonWithRespectToWater](DEBUG): Will not write estimated position: allowance for input measurements to start up has not expired, but velocity or orientation is invalid, and horizontal path length since last fix is nonzero.
2015-02-13T21:10:03.680Z,1423861803.680 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:10:03.689Z,1423861803.689 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: allowance for input measurements to start up has not expired, but velocity or orientation is invalid, and horizontal path length since last fix is nonzero.
2015-02-13T21:10:03.698Z,1423861803.698 [DeadReckonUsingSpeedCalculator](DEBUG): Will not write estimated position: allowance for input measurements to start up has not expired, but velocity or orientation is invalid, and horizontal path length since last fix is nonzero.
2015-02-13T21:10:03.707Z,1423861803.707 [DeadReckonWithRespectToWater](DEBUG): Will not write estimated position: allowance for input measurements to start up has not expired, but velocity or orientation is invalid, and horizontal path length since last fix is nonzero.
2015-02-13T21:10:08.677Z,1423861808.677 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:10:08.686Z,1423861808.686 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: allowance for input measurements to start up has not expired, but velocity or orientation is invalid, and horizontal path length since last fix is nonzero.
2015-02-13T21:10:08.695Z,1423861808.695 [DeadReckonUsingSpeedCalculator](DEBUG): Will not write estimated position: allowance for input measurements to start up has not expired, but velocity or orientation is invalid, and horizontal path length since last fix is nonzero.
2015-02-13T21:10:08.698Z,1423861808.698 [DeadReckonWithRespectToWater](DEBUG): Will not write estimated position: allowance for input measurements to start up has not expired, but velocity or orientation is invalid, and horizontal path length since last fix is nonzero.
2015-02-13T21:10:13.619Z,1423861813.619 [BPC1](DEBUG): Received data from all battery sticks
2015-02-13T21:10:13.626Z,1423861813.626 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:10:13.632Z,1423861813.632 [DeadReckonUsingMultipleVelocitySources](FAULT): The allowance for input measurements to start up has expired, but I still cannot determine the rotation from vehicle frame to navigation frame.
2015-02-13T21:10:13.632Z,1423861813.632 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2015-02-13T21:10:13.632Z,1423861813.632 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2015-02-13T21:10:13.636Z,1423861813.636 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: allowance for input measurements to start up has expired, velocity or orientation is invalid, and horizontal path length since last fix is nonzero.
2015-02-13T21:10:13.641Z,1423861813.641 [DeadReckonUsingSpeedCalculator](FAULT): The allowance for input measurements to start up has expired, but I still cannot determine the rotation from vehicle frame to navigation frame.
2015-02-13T21:10:13.642Z,1423861813.642 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2015-02-13T21:10:13.642Z,1423861813.642 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2015-02-13T21:10:13.645Z,1423861813.645 [DeadReckonUsingSpeedCalculator](FAULT): Will not write estimated position: allowance for input measurements to start up has expired, velocity or orientation is invalid, and horizontal path length since last fix is nonzero.
2015-02-13T21:10:13.651Z,1423861813.651 [DeadReckonWithRespectToWater](FAULT): The allowance for input measurements to start up has expired, but I still cannot determine the rotation from vehicle frame to navigation frame.
2015-02-13T21:10:13.651Z,1423861813.651 [DeadReckonWithRespectToWater] Software Fault, FailCount= 1
2015-02-13T21:10:13.651Z,1423861813.651 [DeadReckonWithRespectToWater](ERROR): Software Fault
2015-02-13T21:10:13.654Z,1423861813.654 [DeadReckonWithRespectToWater](FAULT): Will not write estimated position: allowance for input measurements to start up has expired, velocity or orientation is invalid, and horizontal path length since last fix is nonzero.
2015-02-13T21:10:13.666Z,1423861813.666 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2015-02-13T21:10:13.667Z,1423861813.667 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2015-02-13T21:10:13.667Z,1423861813.667 [CBIT](ERROR): Software Fault in c