2015-02-17T17:58:35.740Z,1424195915.740 [Supervisor](DEBUG): Initializing supervisor. 2015-02-17T17:58:35.742Z,1424195915.742 [SyncHandler](DEBUG): Created PCaller Thread at 4034C4E0 2015-02-17T17:58:35.743Z,1424195915.743 [SyncHandler](INFO): Protected caller Thread ID is 768 2015-02-17T17:58:35.743Z,1424195915.743 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2015-02-17T17:58:35.744Z,1424195915.744 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4037C4E0 2015-02-17T17:58:35.745Z,1424195915.745 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 769 2015-02-17T17:58:35.747Z,1424195915.747 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2015-02-17T17:58:35.760Z,1424195915.760 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2015-02-17T17:58:35.761Z,1424195915.761 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 403AC4E0 2015-02-17T17:58:35.761Z,1424195915.761 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 770 2015-02-17T17:58:35.762Z,1424195915.762 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2015-02-17T17:58:35.763Z,1424195915.763 [logger ThreadHandler](DEBUG): Created PCaller Thread at 403DC4E0 2015-02-17T17:58:35.763Z,1424195915.763 [logger ThreadHandler](INFO): Protected caller Thread ID is 771 2015-02-17T17:58:35.765Z,1424195915.765 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2015-02-17T17:58:35.766Z,1424195915.766 [Supervisor](INFO): Looking for Config files in directory: Config/ 2015-02-17T17:58:35.771Z,1424195915.771 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2015-02-17T17:58:36.106Z,1424195916.106 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2015-02-17T17:58:36.107Z,1424195916.107 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2015-02-17T17:58:36.278Z,1424195916.278 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2015-02-17T17:58:36.279Z,1424195916.279 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2015-02-17T17:58:36.390Z,1424195916.390 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2015-02-17T17:58:36.391Z,1424195916.391 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2015-02-17T17:58:36.516Z,1424195916.516 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2015-02-17T17:58:36.516Z,1424195916.516 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2015-02-17T17:58:36.604Z,1424195916.604 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2015-02-17T17:58:36.766Z,1424195916.766 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2015-02-17T17:58:36.767Z,1424195916.767 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2015-02-17T17:58:36.855Z,1424195916.855 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2015-02-17T17:58:36.858Z,1424195916.858 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2015-02-17T17:58:37.073Z,1424195917.073 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2015-02-17T17:58:37.074Z,1424195917.074 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2015-02-17T17:58:37.439Z,1424195917.439 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2015-02-17T17:58:37.439Z,1424195917.439 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2015-02-17T17:58:37.754Z,1424195917.754 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2015-02-17T17:58:37.755Z,1424195917.755 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2015-02-17T17:58:38.272Z,1424195918.272 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2015-02-17T17:58:38.273Z,1424195918.273 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2015-02-17T17:58:38.514Z,1424195918.514 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2015-02-17T17:58:38.515Z,1424195918.515 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2015-02-17T17:58:38.621Z,1424195918.621 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2015-02-17T17:58:38.622Z,1424195918.622 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2015-02-17T17:58:39.048Z,1424195919.048 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2015-02-17T17:58:39.048Z,1424195919.048 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2015-02-17T17:58:39.162Z,1424195919.162 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2015-02-17T17:58:39.164Z,1424195919.164 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/ 2015-02-17T17:58:39.169Z,1424195919.169 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg 2015-02-17T17:58:39.422Z,1424195919.422 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2015-02-17T17:58:39.423Z,1424195919.423 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg 2015-02-17T17:58:50.425Z,1424195930.425 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Estimation.cfg 2015-02-17T17:58:51.358Z,1424195931.358 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg 2015-02-17T17:58:51.457Z,1424195931.457 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg 2015-02-17T17:58:51.570Z,1424195931.570 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg 2015-02-17T17:58:51.717Z,1424195931.717 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg 2015-02-17T17:58:51.893Z,1424195931.893 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg 2015-02-17T17:58:51.996Z,1424195931.996 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg 2015-02-17T17:58:52.088Z,1424195932.088 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg 2015-02-17T17:58:52.191Z,1424195932.191 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg 2015-02-17T17:58:52.290Z,1424195932.290 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg 2015-02-17T17:58:52.475Z,1424195932.475 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2015-02-17T17:58:52.482Z,1424195932.482 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2015-02-17T17:58:52.562Z,1424195932.562 [VerticalControl](DEBUG): Construct VerticalControl. 2015-02-17T17:58:52.690Z,1424195932.690 [VerticalControl] Loaded 2015-02-17T17:58:52.690Z,1424195932.690 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2015-02-17T17:58:52.691Z,1424195932.691 [HorizontalControl](DEBUG): Construct HorizontalControl. 2015-02-17T17:58:52.769Z,1424195932.769 [HorizontalControl] Loaded 2015-02-17T17:58:52.769Z,1424195932.769 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2015-02-17T17:58:52.770Z,1424195932.770 [SpeedControl](DEBUG): Construct SpeedControl. 2015-02-17T17:58:52.776Z,1424195932.776 [SpeedControl] Loaded 2015-02-17T17:58:52.777Z,1424195932.777 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2015-02-17T17:58:52.777Z,1424195932.777 [LoopControl](DEBUG): Construct LoopControl. 2015-02-17T17:58:52.778Z,1424195932.778 [LoopControl] Loaded 2015-02-17T17:58:52.778Z,1424195932.778 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2015-02-17T17:58:52.779Z,1424195932.779 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2015-02-17T17:58:52.780Z,1424195932.780 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2015-02-17T17:58:52.917Z,1424195932.917 [SBIT](DEBUG): Construct Startup Built In Test. 2015-02-17T17:58:52.929Z,1424195932.929 [SBIT] Loaded 2015-02-17T17:58:52.930Z,1424195932.930 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2015-02-17T17:58:52.930Z,1424195932.930 [IBIT](DEBUG): Construct Initiated Built In Test. 2015-02-17T17:58:52.961Z,1424195932.961 [IBIT] Loaded 2015-02-17T17:58:52.962Z,1424195932.962 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2015-02-17T17:58:52.964Z,1424195932.964 [CBIT](DEBUG): Construct CBIT Built In Test. 2015-02-17T17:58:53.106Z,1424195933.106 [CBIT] Loaded 2015-02-17T17:58:53.107Z,1424195933.107 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2015-02-17T17:58:53.107Z,1424195933.107 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2015-02-17T17:58:53.108Z,1424195933.108 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2015-02-17T17:58:53.139Z,1424195933.139 [DepthRateCalculator] Loaded 2015-02-17T17:58:53.140Z,1424195933.140 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2015-02-17T17:58:53.146Z,1424195933.146 [PitchRateCalculator] Loaded 2015-02-17T17:58:53.146Z,1424195933.146 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2015-02-17T17:58:53.158Z,1424195933.158 [SpeedCalculator] Loaded 2015-02-17T17:58:53.159Z,1424195933.159 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2015-02-17T17:58:53.176Z,1424195933.176 [TempGradientCalculator] Loaded 2015-02-17T17:58:53.177Z,1424195933.177 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2015-02-17T17:58:53.182Z,1424195933.182 [YawRateCalculator] Loaded 2015-02-17T17:58:53.183Z,1424195933.183 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2015-02-17T17:58:53.183Z,1424195933.183 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2015-02-17T17:58:53.184Z,1424195933.184 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2015-02-17T17:58:54.330Z,1424195934.330 [HFRCMReconstructedInterpolator] Loaded 2015-02-17T17:58:54.330Z,1424195934.330 [ComponentRegistry](DEBUG): SyncComponent "HFRCMReconstructedInterpolator" handled in the control thread. 2015-02-17T17:58:54.331Z,1424195934.331 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2015-02-17T17:58:54.331Z,1424195934.331 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2015-02-17T17:58:54.634Z,1424195934.634 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2015-02-17T17:58:54.635Z,1424195934.635 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2015-02-17T17:58:54.750Z,1424195934.750 [DeadReckonUsingMultipleVelocitySources] Loaded 2015-02-17T17:58:54.750Z,1424195934.750 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2015-02-17T17:58:54.800Z,1424195934.800 [DeadReckonUsingSpeedCalculator] Loaded 2015-02-17T17:58:54.800Z,1424195934.800 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2015-02-17T17:58:54.849Z,1424195934.849 [DeadReckonWithRespectToWater] Loaded 2015-02-17T17:58:54.850Z,1424195934.850 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToWater" handled in the control thread. 2015-02-17T17:58:54.868Z,1424195934.868 [NavChart] Loaded 2015-02-17T17:58:54.868Z,1424195934.868 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2015-02-17T17:58:54.873Z,1424195934.873 [UniversalFixResidualReporter] Loaded 2015-02-17T17:58:54.873Z,1424195934.873 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2015-02-17T17:58:54.873Z,1424195934.873 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2015-02-17T17:58:54.874Z,1424195934.874 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2015-02-17T17:58:54.883Z,1424195934.883 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2015-02-17T17:58:54.884Z,1424195934.884 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2015-02-17T17:58:55.016Z,1424195935.016 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2015-02-17T17:58:55.017Z,1424195935.017 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2015-02-17T17:58:55.695Z,1424195935.695 [DataOverHttps] Loaded 2015-02-17T17:58:55.695Z,1424195935.695 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread. 2015-02-17T17:58:55.779Z,1424195935.779 [Depth_Keller] Loaded 2015-02-17T17:58:55.780Z,1424195935.780 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2015-02-17T17:58:56.091Z,1424195936.091 [DVL_micro] Loaded 2015-02-17T17:58:56.091Z,1424195936.091 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread. 2015-02-17T17:58:56.193Z,1424195936.193 [NAL9602] Loaded 2015-02-17T17:58:56.194Z,1424195936.194 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2015-02-17T17:58:56.239Z,1424195936.239 [Onboard] Loaded 2015-02-17T17:58:56.240Z,1424195936.240 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2015-02-17T17:58:56.247Z,1424195936.247 [Radio_Surface] Loaded 2015-02-17T17:58:56.248Z,1424195936.248 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2015-02-17T17:58:56.249Z,1424195936.249 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408074E0 2015-02-17T17:58:56.249Z,1424195936.249 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 857 2015-02-17T17:58:58.300Z,1424195938.300 [BPC1] Loaded 2015-02-17T17:58:58.300Z,1424195938.300 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2015-02-17T17:58:58.301Z,1424195938.301 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2015-02-17T17:58:58.301Z,1424195938.301 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2015-02-17T17:59:03.421Z,1424195943.421 [BuoyancyServo] Loaded 2015-02-17T17:59:03.421Z,1424195943.421 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2015-02-17T17:59:03.434Z,1424195943.434 [ElevatorServo] Loaded 2015-02-17T17:59:03.435Z,1424195943.435 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2015-02-17T17:59:03.447Z,1424195943.447 [MassServo] Loaded 2015-02-17T17:59:03.448Z,1424195943.448 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2015-02-17T17:59:03.460Z,1424195943.460 [RudderServo] Loaded 2015-02-17T17:59:03.460Z,1424195943.460 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2015-02-17T17:59:03.473Z,1424195943.473 [ThrusterServo] Loaded 2015-02-17T17:59:03.473Z,1424195943.473 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2015-02-17T17:59:03.474Z,1424195943.474 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2015-02-17T17:59:03.474Z,1424195943.474 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2015-02-17T17:59:03.771Z,1424195943.771 [ExternalSim] Loaded 2015-02-17T17:59:03.771Z,1424195943.771 [ComponentRegistry](DEBUG): SyncComponent "ExternalSim" handled in the control thread. 2015-02-17T17:59:03.772Z,1424195943.772 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2015-02-17T17:59:03.773Z,1424195943.773 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2015-02-17T17:59:03.815Z,1424195943.815 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2015-02-17T17:59:03.817Z,1424195943.817 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2015-02-17T17:59:03.818Z,1424195943.818 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2015-02-17T17:59:03.824Z,1424195943.824 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2015-02-17T17:59:03.826Z,1424195943.826 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 408B84E0 2015-02-17T17:59:03.826Z,1424195943.826 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 858 2015-02-17T17:59:03.831Z,1424195943.831 [Supervisor](INFO): Main Thread ID is 766 2015-02-17T17:59:03.831Z,1424195943.831 [Supervisor](DEBUG): Running supervisor. 2015-02-17T17:59:03.831Z,1424195943.831 [CommandLine ThreadHandler](INFO): Handler Thread ID is 859 2015-02-17T17:59:03.834Z,1424195943.834 [controlThread ThreadHandler](INFO): Handler Thread ID is 860 2015-02-17T17:59:03.835Z,1424195943.835 [controlThread](DEBUG): Initializing ControlThread 2015-02-17T17:59:03.836Z,1424195943.836 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2015-02-17T17:59:03.837Z,1424195943.837 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2015-02-17T17:59:03.838Z,1424195943.838 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2015-02-17T17:59:03.839Z,1424195943.839 [LoopControl](DEBUG): Initialize LoopControlComponent. 2015-02-17T17:59:03.839Z,1424195943.839 [SBIT](INFO): Initialize SBIT Component. 2015-02-17T17:59:03.840Z,1424195943.840 [SBIT](IMPORTANT): Tethys CM Info: SVN revision:12012 2015-02-17T17:59:03.840Z,1424195943.840 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2015-02-17T17:59:03.840Z,1424195943.840 [SBIT](IMPORTANT): Kernel Version:#639 PREEMPT Wed Mar 12 12:53:33 PDT 2014 2015-02-17T17:59:03.841Z,1424195943.841 [IBIT](INFO): Initialize IBIT Component. 2015-02-17T17:59:03.841Z,1424195943.841 [CBIT](DEBUG): Initialize CBIT Component. 2015-02-17T17:59:03.842Z,1424195943.842 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL. 2015-02-17T17:59:03.842Z,1424195943.842 [CBIT](CRITICAL): LAST REBOOT DUE TO WATCHDOG TIMER RESET. 2015-02-17T17:59:03.843Z,1424195943.843 [logger ThreadHandler](INFO): Handler Thread ID is 861 2015-02-17T17:59:03.868Z,1424195943.868 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2015-02-17T17:59:03.868Z,1424195943.868 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2015-02-17T17:59:03.868Z,1424195943.868 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2015-02-17T17:59:03.869Z,1424195943.869 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2015-02-17T17:59:03.869Z,1424195943.869 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2015-02-17T17:59:03.870Z,1424195943.870 [HFRCMReconstructedInterpolator](INFO): Initializing HFRCMReconstructedInterpolator component with velocityAccuracy_ = 0.300000 m/s. 2015-02-17T17:59:03.872Z,1424195943.872 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2015-02-17T17:59:03.873Z,1424195943.873 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2015-02-17T17:59:03.873Z,1424195943.873 [DeadReckonWithRespectToWater](DEBUG): Initializing DeadReckonWithRespectToWater component. 2015-02-17T17:59:03.874Z,1424195943.874 [NavChart](DEBUG): Initialize NavChart Navigation. 2015-02-17T17:59:03.874Z,1424195943.874 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2015-02-17T17:59:03.878Z,1424195943.878 [ExternalSim](INFO): ExternalSim initializing... 2015-02-17T17:59:03.888Z,1424195943.888 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 862 2015-02-17T17:59:03.895Z,1424195943.895 [Radio_Surface](INFO): Powering up 2015-02-17T17:59:03.909Z,1424195943.909 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 863 2015-02-17T17:59:03.920Z,1424195943.920 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources 2015-02-17T17:59:03.921Z,1424195943.921 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2015-02-17T17:59:03.921Z,1424195943.921 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2015-02-17T17:59:03.921Z,1424195943.921 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2015-02-17T17:59:03.922Z,1424195943.922 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2015-02-17T17:59:03.922Z,1424195943.922 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2015-02-17T17:59:03.922Z,1424195943.922 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2015-02-17T17:59:03.922Z,1424195943.922 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2015-02-17T17:59:03.923Z,1424195943.923 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2015-02-17T17:59:04.163Z,1424195944.163 [ExternalSim](DEBUG): beaconLat = 36.80340 2015-02-17T17:59:04.163Z,1424195944.163 [ExternalSim](DEBUG): beaconLon = -121.82230 2015-02-17T17:59:04.163Z,1424195944.163 [ExternalSim](DEBUG): beaconDepth = 25.00 2015-02-17T17:59:04.403Z,1424195944.403 [ExternalSim](DEBUG): Simulator initialized 2015-02-17T17:59:04.529Z,1424195944.529 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2015-02-17T17:59:04.559Z,1424195944.559 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2015-02-17T17:59:04.584Z,1424195944.584 [MissionManager](DEBUG): 2015-02-17T17:59:04.584Z,1424195944.584 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2015-02-17T17:59:04.673Z,1424195944.673 [MissionManager](INFO): DefineArg Default.TimeMissionWasStarted = 0.000000 h 2015-02-17T17:59:04.693Z,1424195944.693 [MissionManager](INFO): DefineArg Default.ElapsedSinceMissionWasStarted = 0.000000 h 2015-02-17T17:59:04.704Z,1424195944.704 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2015-02-17T17:59:04.729Z,1424195944.729 [Default:CheckIn:A.SetSpeed](DEBUG): Construct. 2015-02-17T17:59:04.752Z,1424195944.752 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2015-02-17T17:59:04.780Z,1424195944.780 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed](DEBUG): Construct. 2015-02-17T17:59:04.802Z,1424195944.802 [MissionManager](DEBUG): 0 0 5.0 1.0 400 Burn 300 Dropped drop weight due to communications timeout 5.0 Default mission has been running for 5 2015-02-17T17:59:04.808Z,1424195944.808 [controlThread](DEBUG): Component order: CycleStarter,ExternalSim,DataOverHttps,Depth_Keller,DVL_micro,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-17T17:59:05.056Z,1424195945.056 [DVL_micro](INFO): Initializing 2015-02-17T17:59:05.078Z,1424195945.078 [NAL9602](INFO): Powering up NAL9602 2015-02-17T17:59:05.306Z,1424195945.306 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:05.319Z,1424195945.319 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 0 cycles since last successful read, accepting data for 5 cycles. 2015-02-17T17:59:05.460Z,1424195945.460 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2015-02-17T17:59:05.466Z,1424195945.466 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2015-02-17T17:59:05.473Z,1424195945.473 [ElevatorServo](DEBUG): Initializing EZServoServo. 2015-02-17T17:59:05.478Z,1424195945.478 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2015-02-17T17:59:05.484Z,1424195945.484 [MassServo](DEBUG): Initializing EZServoServo. 2015-02-17T17:59:05.490Z,1424195945.490 [MassServo](DEBUG): Initializing MassServo. 2015-02-17T17:59:05.496Z,1424195945.496 [RudderServo](DEBUG): Initializing EZServoServo. 2015-02-17T17:59:05.503Z,1424195945.503 [RudderServo](DEBUG): Initializing RudderServo. 2015-02-17T17:59:05.509Z,1424195945.509 [ThrusterServo](DEBUG): Initializing EZServoServo. 2015-02-17T17:59:05.514Z,1424195945.514 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2015-02-17T17:59:05.539Z,1424195945.539 [CommandLine](FAULT): Scheduling is paused 2015-02-17T17:59:05.789Z,1424195945.789 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:05.790Z,1424195945.790 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 1 cycles since last successful read, accepting data for 5 cycles. 2015-02-17T17:59:13.229Z,1424195953.229 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:13.230Z,1424195953.230 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 2 cycles since last successful read, accepting data for 5 cycles. 2015-02-17T17:59:13.648Z,1424195953.648 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:13.649Z,1424195953.649 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 3 cycles since last successful read, accepting data for 5 cycles. 2015-02-17T17:59:14.053Z,1424195954.053 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:14.054Z,1424195954.054 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 4 cycles since last successful read, accepting data for 5 cycles. 2015-02-17T17:59:14.420Z,1424195954.420 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003400 2015-02-17T17:59:14.592Z,1424195954.592 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:14.593Z,1424195954.593 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 5 cycles since last successful read, accepting data for 5 cycles. 2015-02-17T17:59:14.879Z,1424195954.879 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:15.256Z,1424195955.256 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:15.657Z,1424195955.657 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:16.073Z,1424195956.073 [NAL9602](INFO): NAL9602 initialized 2015-02-17T17:59:16.103Z,1424195956.103 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:16.544Z,1424195956.544 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:16.891Z,1424195956.891 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:17.359Z,1424195957.359 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:17.764Z,1424195957.764 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:18.110Z,1424195958.110 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:18.707Z,1424195958.707 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:18.882Z,1424195958.882 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:19.289Z,1424195959.289 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:19.350Z,1424195959.350 [SBIT](IMPORTANT): Beginning Startup BIT 2015-02-17T17:59:19.352Z,1424195959.352 [CBIT](IMPORTANT): Beginning GF scan 2015-02-17T17:59:19.672Z,1424195959.672 [NAL9602](INFO): Flushing. SigQuality: -1 2015-02-17T17:59:19.691Z,1424195959.691 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:20.251Z,1424195960.251 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:20.578Z,1424195960.578 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:20.945Z,1424195960.945 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:21.350Z,1424195961.350 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:21.766Z,1424195961.766 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:22.175Z,1424195962.175 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:22.580Z,1424195962.580 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:22.952Z,1424195962.952 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:23.456Z,1424195963.456 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:23.969Z,1424195963.969 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:24.267Z,1424195964.267 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:24.667Z,1424195964.667 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:25.128Z,1424195965.128 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:25.440Z,1424195965.440 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:26.021Z,1424195966.021 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:26.249Z,1424195966.249 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:26.729Z,1424195966.729 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:27.107Z,1424195967.107 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:27.507Z,1424195967.507 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:27.888Z,1424195967.888 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:28.282Z,1424195968.282 [NAL9602](INFO): Flushing. SigQuality: 1 2015-02-17T17:59:28.300Z,1424195968.300 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:28.705Z,1424195968.705 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:29.128Z,1424195969.128 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:29.572Z,1424195969.572 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:29.891Z,1424195969.891 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:30.358Z,1424195970.358 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:30.934Z,1424195970.934 [NAL9602](INFO): Flushing. SigQuality: 1 2015-02-17T17:59:30.982Z,1424195970.982 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:31.307Z,1424195971.307 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:31.602Z,1424195971.602 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:32.405Z,1424195972.405 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:32.559Z,1424195972.559 [SBIT](FAULT): Rudder: EXPECTED:15.000000 ACTUAL:14.634922 2015-02-17T17:59:33.619Z,1424195973.619 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:34.458Z,1424195974.458 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:35.203Z,1424195975.203 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:35.999Z,1424195975.999 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:36.947Z,1424195976.947 [NAL9602](INFO): Flushing. SigQuality: 5 2015-02-17T17:59:37.001Z,1424195977.001 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:37.331Z,1424195977.331 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:37.730Z,1424195977.730 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:38.192Z,1424195978.192 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:38.492Z,1424195978.492 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:38.986Z,1424195978.986 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:39.358Z,1424195979.358 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:39.710Z,1424195979.710 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:40.131Z,1424195980.131 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:40.669Z,1424195980.669 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:41.077Z,1424195981.077 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:41.385Z,1424195981.385 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:41.725Z,1424195981.725 [NAL9602](INFO): SBD MO Status=0, MOMSN=7161, MT Status=0, MTMSN=0 2015-02-17T17:59:41.726Z,1424195981.726 [NAL9602](INFO): No messages in MT queue 2015-02-17T17:59:41.786Z,1424195981.786 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:42.238Z,1424195982.238 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:42.578Z,1424195982.578 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:42.925Z,1424195982.925 [NAL9602](IMPORTANT): GPS fix at: 1424195982.92 2015-02-17T17:59:42.983Z,1424195982.983 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:43.431Z,1424195983.431 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:43.829Z,1424195983.829 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:44.175Z,1424195984.175 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:44.572Z,1424195984.572 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:45.024Z,1424195985.024 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:45.349Z,1424195985.349 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:45.817Z,1424195985.817 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:46.217Z,1424195986.217 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:46.362Z,1424195986.362 [CBIT](IMPORTANT): No ground fault detected 2015-02-17T17:59:46.672Z,1424195986.672 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:47.095Z,1424195987.095 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:47.385Z,1424195987.385 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:47.836Z,1424195987.836 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:48.257Z,1424195988.257 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:48.706Z,1424195988.706 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:49.057Z,1424195989.057 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:49.463Z,1424195989.463 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:49.811Z,1424195989.811 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:50.215Z,1424195990.215 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:50.631Z,1424195990.631 [NAL9602](INFO): Powering down 2015-02-17T17:59:50.664Z,1424195990.664 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:51.026Z,1424195991.026 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:51.429Z,1424195991.429 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:51.843Z,1424195991.843 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:52.340Z,1424195992.340 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:52.637Z,1424195992.637 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:53.001Z,1424195993.001 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:53.453Z,1424195993.453 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:53.881Z,1424195993.881 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:54.405Z,1424195994.405 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:54.745Z,1424195994.745 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:55.060Z,1424195995.060 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:55.472Z,1424195995.472 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:55.885Z,1424195995.885 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:56.209Z,1424195996.209 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:56.627Z,1424195996.627 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:57.030Z,1424195997.030 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:57.427Z,1424195997.427 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:57.831Z,1424195997.831 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:58.291Z,1424195998.291 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:58.640Z,1424195998.640 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:59.043Z,1424195999.043 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:59.455Z,1424195999.455 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T17:59:59.868Z,1424195999.868 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:00.284Z,1424196000.284 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:00.664Z,1424196000.664 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:01.087Z,1424196001.087 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:01.486Z,1424196001.486 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:01.802Z,1424196001.802 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:02.286Z,1424196002.286 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:02.888Z,1424196002.888 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:03.375Z,1424196003.375 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:03.738Z,1424196003.738 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:04.089Z,1424196004.089 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:04.548Z,1424196004.548 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:04.905Z,1424196004.905 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:05.297Z,1424196005.297 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:05.702Z,1424196005.702 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:11.790Z,1424196011.790 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:12.023Z,1424196012.023 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:12.423Z,1424196012.423 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:13.039Z,1424196013.039 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:13.400Z,1424196013.400 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:13.684Z,1424196013.684 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:13.708Z,1424196013.708 [SBIT](CRITICAL): SBIT FAILED 2015-02-17T18:00:14.146Z,1424196014.146 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:14.157Z,1424196014.157 [MissionManager](IMPORTANT): Started mission Startup 2015-02-17T18:00:14.157Z,1424196014.157 [Startup] Running Loop=1 2015-02-17T18:00:14.157Z,1424196014.157 [Startup](INFO): Aggregate::initialize Startup 2015-02-17T18:00:14.157Z,1424196014.157 [Startup:A.GoToSurface] Running Loop=1 2015-02-17T18:00:14.157Z,1424196014.157 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2015-02-17T18:00:14.158Z,1424196014.158 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2015-02-17T18:00:14.158Z,1424196014.158 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2015-02-17T18:00:14.159Z,1424196014.159 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 0.500000 m/s. 2015-02-17T18:00:14.168Z,1424196014.168 [Startup:StartupSatComms] Running Loop=1 2015-02-17T18:00:14.168Z,1424196014.168 [Startup:StartupSatComms](INFO): Aggregate::initialize Startup:StartupSatComms 2015-02-17T18:00:14.168Z,1424196014.168 [Startup:StartupSatComms:A] Running Loop=1 2015-02-17T18:00:14.507Z,1424196014.507 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:14.515Z,1424196014.515 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2015-02-17T18:00:14.923Z,1424196014.923 [NAL9602](INFO): Powering up 2015-02-17T18:00:14.970Z,1424196014.970 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:15.360Z,1424196015.360 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:15.666Z,1424196015.666 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:16.039Z,1424196016.039 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:16.582Z,1424196016.582 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:16.936Z,1424196016.936 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:17.339Z,1424196017.339 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:17.725Z,1424196017.725 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:18.164Z,1424196018.164 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:18.532Z,1424196018.532 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:18.828Z,1424196018.828 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:19.299Z,1424196019.299 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:19.642Z,1424196019.642 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:20.111Z,1424196020.111 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:20.450Z,1424196020.450 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:20.808Z,1424196020.808 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:21.259Z,1424196021.259 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:21.770Z,1424196021.770 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:22.165Z,1424196022.165 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:22.471Z,1424196022.471 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:22.873Z,1424196022.873 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:23.234Z,1424196023.234 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:23.741Z,1424196023.741 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:24.122Z,1424196024.122 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:24.458Z,1424196024.458 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:24.938Z,1424196024.938 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:25.302Z,1424196025.302 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:25.834Z,1424196025.834 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:26.168Z,1424196026.168 [NAL9602](INFO): NAL9602 initialized 2015-02-17T18:00:26.295Z,1424196026.295 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:26.579Z,1424196026.579 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:27.001Z,1424196027.001 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:27.365Z,1424196027.365 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:27.950Z,1424196027.950 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:28.436Z,1424196028.436 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:28.718Z,1424196028.718 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:29.198Z,1424196029.198 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:29.481Z,1424196029.481 [NAL9602](INFO): Flushing. SigQuality: -1 2015-02-17T18:00:29.535Z,1424196029.535 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:30.087Z,1424196030.087 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:30.442Z,1424196030.442 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:30.729Z,1424196030.729 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:31.171Z,1424196031.171 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:31.628Z,1424196031.628 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:32.248Z,1424196032.248 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:32.469Z,1424196032.469 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:32.942Z,1424196032.942 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:33.326Z,1424196033.326 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:33.675Z,1424196033.675 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:34.191Z,1424196034.191 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:34.500Z,1424196034.500 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:34.899Z,1424196034.899 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:35.307Z,1424196035.307 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:35.649Z,1424196035.649 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:36.101Z,1424196036.101 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:36.474Z,1424196036.474 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:37.101Z,1424196037.101 [NAL9602](INFO): Flushing. SigQuality: 4 2015-02-17T18:00:37.128Z,1424196037.128 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:37.446Z,1424196037.446 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:37.752Z,1424196037.752 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:38.139Z,1424196038.139 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:38.596Z,1424196038.596 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:38.970Z,1424196038.970 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:39.371Z,1424196039.371 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:39.709Z,1424196039.709 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:40.106Z,1424196040.106 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:40.928Z,1424196040.928 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:41.479Z,1424196041.479 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:41.873Z,1424196041.873 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:42.197Z,1424196042.197 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:42.596Z,1424196042.596 [NAL9602](INFO): SBD MO Status=0, MOMSN=7162, MT Status=0, MTMSN=0 2015-02-17T18:00:42.597Z,1424196042.597 [NAL9602](INFO): No messages in MT queue 2015-02-17T18:00:42.607Z,1424196042.607 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:43.182Z,1424196043.182 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:43.392Z,1424196043.392 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:43.796Z,1424196043.796 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:44.236Z,1424196044.236 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:44.643Z,1424196044.643 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:44.938Z,1424196044.938 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:45.367Z,1424196045.367 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:45.739Z,1424196045.739 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:46.132Z,1424196046.132 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:46.738Z,1424196046.738 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:47.094Z,1424196047.094 [NAL9602](IMPORTANT): GPS fix at: 1424196047.09 2015-02-17T18:00:47.105Z,1424196047.105 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:47.113Z,1424196047.113 [Startup:StartupSatComms:A] Stopped 2015-02-17T18:00:47.114Z,1424196047.114 [Startup:StartupSatComms:B] Running Loop=1 2015-02-17T18:00:47.440Z,1424196047.440 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:47.449Z,1424196047.449 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2015-02-17T18:00:58.478Z,1424196058.478 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:00:58.786Z,1424196058.786 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:02.823Z,1424196062.823 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:02.983Z,1424196062.983 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20150217T174555/Courier0008.lzma 2015-02-17T18:01:03.042Z,1424196063.042 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:03.465Z,1424196063.465 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:03.924Z,1424196063.924 [DataOverHttps](INFO): Moved sent file to Logs/20150217T174555/Courier0008.lzma.bak 2015-02-17T18:01:03.924Z,1424196063.924 [DataOverHttps](INFO): SBD MOMSN=3043370 2015-02-17T18:01:03.983Z,1424196063.983 [NAL9602](INFO): Powering down 2015-02-17T18:01:04.044Z,1424196064.044 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:05.066Z,1424196065.066 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:05.330Z,1424196065.330 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:09.706Z,1424196069.706 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:10.853Z,1424196070.853 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:11.709Z,1424196071.709 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:12.145Z,1424196072.145 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:12.623Z,1424196072.623 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:13.232Z,1424196073.232 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:17.218Z,1424196077.218 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:17.408Z,1424196077.408 [DataOverHttps](INFO): Sending 297 bytes from file Logs/20150217T175835/Courier0000.lzma 2015-02-17T18:01:17.440Z,1424196077.440 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:17.928Z,1424196077.928 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:18.225Z,1424196078.225 [DataOverHttps](INFO): Moved sent file to Logs/20150217T175835/Courier0000.lzma.bak 2015-02-17T18:01:18.225Z,1424196078.225 [DataOverHttps](INFO): SBD MOMSN=3043373 2015-02-17T18:01:18.295Z,1424196078.295 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:19.705Z,1424196079.705 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:20.167Z,1424196080.167 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:25.212Z,1424196085.212 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:25.618Z,1424196085.618 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:25.914Z,1424196085.914 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:26.243Z,1424196086.243 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:26.622Z,1424196086.622 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:27.177Z,1424196087.177 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:33.003Z,1424196093.003 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:34.171Z,1424196094.171 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:38.726Z,1424196098.726 [DataOverHttps](INFO): Sending 766 bytes from file Logs/20150217T174555/Express0001.lzma 2015-02-17T18:01:38.777Z,1424196098.777 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:39.815Z,1424196099.815 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:40.807Z,1424196100.807 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:41.490Z,1424196101.490 [DataOverHttps](INFO): Moved sent file to Logs/20150217T174555/Express0001.lzma.bak 2015-02-17T18:01:41.490Z,1424196101.490 [DataOverHttps](INFO): SBD MOMSN=3043379 2015-02-17T18:01:41.670Z,1424196101.670 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:50.340Z,1424196110.340 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:50.388Z,1424196110.388 [Startup:StartupSatComms:B](INFO): Timed out from 2015-02-17T18:00:47.1Z 2015-02-17T18:01:50.389Z,1424196110.389 [Startup:StartupSatComms:B] Stopped 2015-02-17T18:01:50.389Z,1424196110.389 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2015-02-17T18:01:50.389Z,1424196110.389 [Startup:StartupSatComms] Stopped 2015-02-17T18:01:50.389Z,1424196110.389 [Startup:StartupSatComms](INFO): Aggregate::uninitialize Startup:StartupSatComms 2015-02-17T18:01:50.390Z,1424196110.390 [Startup](INFO): Completed Startup 2015-02-17T18:01:50.390Z,1424196110.390 [Startup] Stopped 2015-02-17T18:01:50.390Z,1424196110.390 [Startup](INFO): Aggregate::uninitialize Startup 2015-02-17T18:01:50.390Z,1424196110.390 [Startup:A.GoToSurface] Stopped 2015-02-17T18:01:50.390Z,1424196110.390 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2015-02-17T18:01:50.641Z,1424196110.641 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:50.661Z,1424196110.661 [MissionManager](IMPORTANT): Started mission Default 2015-02-17T18:01:50.661Z,1424196110.661 [Default] Running Loop=1 2015-02-17T18:01:50.661Z,1424196110.661 [Default](INFO): Aggregate::initialize Default 2015-02-17T18:01:50.662Z,1424196110.662 [Default:B.GoToSurface] Running Loop=1 2015-02-17T18:01:50.662Z,1424196110.662 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2015-02-17T18:01:50.662Z,1424196110.662 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2015-02-17T18:01:50.662Z,1424196110.662 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2015-02-17T18:01:50.663Z,1424196110.663 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 0.500000 m/s. 2015-02-17T18:01:50.663Z,1424196110.663 [Default:StartClock] Running Loop=1 2015-02-17T18:01:50.663Z,1424196110.663 [Default:StartClock](INFO): Aggregate::initialize Default:StartClock 2015-02-17T18:01:50.663Z,1424196110.663 [Default:StartClock:A] Running Loop=1 2015-02-17T18:01:50.664Z,1424196110.664 [Default:CheckIn] Running Loop=1 2015-02-17T18:01:50.664Z,1424196110.664 [Default:CheckIn](INFO): Aggregate::initialize Default:CheckIn 2015-02-17T18:01:50.664Z,1424196110.664 [Default:CheckIn:A.SetSpeed] Running Loop=1 2015-02-17T18:01:50.664Z,1424196110.664 [Default:CheckIn:A.SetSpeed](DEBUG): Initialize. 2015-02-17T18:01:50.664Z,1424196110.664 [Default:CheckIn:Read_GPS] Running Loop=1 2015-02-17T18:01:50.665Z,1424196110.665 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2015-02-17T18:01:50.679Z,1424196110.679 [Default:CheckIn:A.SetSpeed] Running Loop=1 2015-02-17T18:01:50.708Z,1424196110.708 [Default:StartClock:A] Stopped 2015-02-17T18:01:50.708Z,1424196110.708 [Default:StartClock](INFO): Completed Default:StartClock 2015-02-17T18:01:50.708Z,1424196110.708 [Default:StartClock] Stopped 2015-02-17T18:01:50.708Z,1424196110.708 [Default:StartClock](INFO): Aggregate::uninitialize Default:StartClock 2015-02-17T18:01:54.719Z,1424196114.719 [NAL9602](INFO): Powering up 2015-02-17T18:01:54.778Z,1424196114.778 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:54.799Z,1424196114.799 [Default:WaitAtTheSurface] Running Loop=1 2015-02-17T18:01:54.799Z,1424196114.799 [Default:WaitAtTheSurface](INFO): Aggregate::initialize Default:WaitAtTheSurface 2015-02-17T18:01:54.799Z,1424196114.799 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed] Running Loop=1 2015-02-17T18:01:54.799Z,1424196114.799 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed](DEBUG): Initialize. 2015-02-17T18:01:55.189Z,1424196115.189 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:55.238Z,1424196115.238 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed] Running Loop=1 2015-02-17T18:01:55.460Z,1424196115.460 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:55.818Z,1424196115.818 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:56.610Z,1424196116.610 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:57.079Z,1424196117.079 [BPC1](ERROR): Failed to receive battery data 2015-02-17T18:01:57.080Z,1424196117.080 [BPC1] Communications Fault, FailCount= 1 2015-02-17T18:01:57.080Z,1424196117.080 [BPC1](ERROR): Communications Fault 2015-02-17T18:01:57.085Z,1424196117.085 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:57.135Z,1424196117.135 [CBIT](ERROR): Communications Fault in component: BPC1 2015-02-17T18:01:57.493Z,1424196117.493 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:58.051Z,1424196118.051 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:58.411Z,1424196118.411 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:58.465Z,1424196118.465 [CBIT](INFO): Clearing failed state for component BPC1 2015-02-17T18:01:58.466Z,1424196118.466 [BPC1] No Fault, FailCount= 1 2015-02-17T18:01:58.904Z,1424196118.904 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:59.081Z,1424196119.081 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:01:59.598Z,1424196119.598 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:00.216Z,1424196120.216 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:00.621Z,1424196120.621 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:01.092Z,1424196121.092 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:01.299Z,1424196121.299 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:01.955Z,1424196121.955 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:02.461Z,1424196122.461 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:02.830Z,1424196122.830 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:03.211Z,1424196123.211 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:03.602Z,1424196123.602 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:03.939Z,1424196123.939 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:04.738Z,1424196124.738 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:05.242Z,1424196125.242 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:05.734Z,1424196125.734 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:06.247Z,1424196126.247 [NAL9602](INFO): NAL9602 initialized 2015-02-17T18:02:06.266Z,1424196126.266 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:06.803Z,1424196126.803 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:07.072Z,1424196127.072 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:07.859Z,1424196127.859 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:08.286Z,1424196128.286 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:08.629Z,1424196128.629 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:09.163Z,1424196129.163 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:09.672Z,1424196129.672 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:09.892Z,1424196129.892 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:10.305Z,1424196130.305 [NAL9602](INFO): Flushing. SigQuality: -1 2015-02-17T18:02:10.361Z,1424196130.361 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:10.968Z,1424196130.968 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:11.608Z,1424196131.608 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:12.076Z,1424196132.076 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:12.511Z,1424196132.511 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:12.798Z,1424196132.798 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:13.137Z,1424196133.137 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:13.742Z,1424196133.742 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:14.450Z,1424196134.450 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:15.142Z,1424196135.142 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:15.795Z,1424196135.795 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:16.195Z,1424196136.195 [NAL9602](INFO): Flushing. SigQuality: 2 2015-02-17T18:02:16.210Z,1424196136.210 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:16.600Z,1424196136.600 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:16.840Z,1424196136.840 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:17.300Z,1424196137.300 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:17.833Z,1424196137.833 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:18.284Z,1424196138.284 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:18.545Z,1424196138.545 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:18.986Z,1424196138.986 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:19.369Z,1424196139.369 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:20.026Z,1424196140.026 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:20.529Z,1424196140.529 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:20.742Z,1424196140.742 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:21.195Z,1424196141.195 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:21.650Z,1424196141.650 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:23.309Z,1424196143.309 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:23.947Z,1424196143.947 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:24.515Z,1424196144.515 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:24.919Z,1424196144.919 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:25.296Z,1424196145.296 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:25.633Z,1424196145.633 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:26.030Z,1424196146.030 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:26.405Z,1424196146.405 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:26.941Z,1424196146.941 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:27.387Z,1424196147.387 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:27.761Z,1424196147.761 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:28.067Z,1424196148.067 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:28.577Z,1424196148.577 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:29.033Z,1424196149.033 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:29.356Z,1424196149.356 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:29.819Z,1424196149.819 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:30.268Z,1424196150.268 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:30.799Z,1424196150.799 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:31.589Z,1424196151.589 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:32.258Z,1424196152.258 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:32.701Z,1424196152.701 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:33.003Z,1424196153.003 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:33.465Z,1424196153.465 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:33.789Z,1424196153.789 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:34.471Z,1424196154.471 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:35.226Z,1424196155.226 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:35.801Z,1424196155.801 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:36.048Z,1424196156.048 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:36.402Z,1424196156.402 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:37.003Z,1424196157.003 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:37.393Z,1424196157.393 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:37.683Z,1424196157.683 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:38.127Z,1424196158.127 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:38.583Z,1424196158.583 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:39.106Z,1424196159.106 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:39.753Z,1424196159.753 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:40.065Z,1424196160.065 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:40.614Z,1424196160.614 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:41.583Z,1424196161.583 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:42.121Z,1424196162.121 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:42.342Z,1424196162.342 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:42.885Z,1424196162.885 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:43.434Z,1424196163.434 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:43.757Z,1424196163.757 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:44.140Z,1424196164.140 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:44.528Z,1424196164.528 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:45.132Z,1424196165.132 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:45.780Z,1424196165.780 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:46.807Z,1424196166.807 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:47.566Z,1424196167.566 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:48.585Z,1424196168.585 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:49.127Z,1424196169.127 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:49.674Z,1424196169.674 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:50.205Z,1424196170.205 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:51.041Z,1424196171.041 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:51.623Z,1424196171.623 [NAL9602](INFO): SBD MO Status=2, MOMSN=7163, MT Status=2, MTMSN=0 2015-02-17T18:02:51.623Z,1424196171.623 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-02-17T18:02:51.641Z,1424196171.641 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:55.458Z,1424196175.458 [BPC1](ERROR): Failed to receive battery data 2015-02-17T18:02:55.458Z,1424196175.458 [BPC1] Communications Fault, FailCount= 1 2015-02-17T18:02:55.458Z,1424196175.458 [BPC1](ERROR): Communications Fault 2015-02-17T18:02:55.468Z,1424196175.468 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:55.571Z,1424196175.571 [CBIT](ERROR): Communications Fault in component: BPC1 2015-02-17T18:02:56.173Z,1424196176.173 [DataOverHttps](INFO): Sending 448 bytes from file Logs/20150217T174555/Express0005.lzma 2015-02-17T18:02:56.242Z,1424196176.242 [NAL9602](INFO): Flushing. SigQuality: 1 2015-02-17T18:02:56.253Z,1424196176.253 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:56.729Z,1424196176.729 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:57.361Z,1424196177.361 [DataOverHttps](INFO): Moved sent file to Logs/20150217T174555/Express0005.lzma.bak 2015-02-17T18:02:57.361Z,1424196177.361 [DataOverHttps](INFO): SBD MOMSN=3043403 2015-02-17T18:02:57.394Z,1424196177.394 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:57.486Z,1424196177.486 [CBIT](INFO): Clearing failed state for component BPC1 2015-02-17T18:02:57.486Z,1424196177.486 [BPC1] No Fault, FailCount= 1 2015-02-17T18:02:58.328Z,1424196178.328 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:58.973Z,1424196178.973 [NAL9602](INFO): Flushing. SigQuality: 1 2015-02-17T18:02:59.027Z,1424196179.027 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:02:59.477Z,1424196179.477 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:00.004Z,1424196180.004 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:00.467Z,1424196180.467 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:00.905Z,1424196180.905 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:01.442Z,1424196181.442 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:02.050Z,1424196182.050 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:02.703Z,1424196182.703 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:03.507Z,1424196183.507 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:05.113Z,1424196185.113 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:05.981Z,1424196185.981 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:06.774Z,1424196186.774 [NAL9602](INFO): Flushing. SigQuality: 1 2015-02-17T18:03:06.847Z,1424196186.847 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:08.043Z,1424196188.043 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:09.115Z,1424196189.115 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:09.838Z,1424196189.838 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:10.731Z,1424196190.731 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:11.248Z,1424196191.248 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:12.198Z,1424196192.198 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:13.495Z,1424196193.495 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:14.180Z,1424196194.180 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:14.725Z,1424196194.725 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:15.194Z,1424196195.194 [NAL9602](INFO): Flushing. SigQuality: 1 2015-02-17T18:03:15.218Z,1424196195.218 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:15.824Z,1424196195.824 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:16.444Z,1424196196.444 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:16.901Z,1424196196.901 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:17.325Z,1424196197.325 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:17.633Z,1424196197.633 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:18.316Z,1424196198.316 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:18.620Z,1424196198.620 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:19.115Z,1424196199.115 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:19.400Z,1424196199.400 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:20.427Z,1424196200.427 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:20.944Z,1424196200.944 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:21.346Z,1424196201.346 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:21.766Z,1424196201.766 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:22.142Z,1424196202.142 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:22.548Z,1424196202.548 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:23.102Z,1424196203.102 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:23.467Z,1424196203.467 [NAL9602](INFO): Flushing. SigQuality: 0 2015-02-17T18:03:23.494Z,1424196203.494 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:23.822Z,1424196203.822 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:24.401Z,1424196204.401 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:24.658Z,1424196204.658 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:25.253Z,1424196205.253 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:25.798Z,1424196205.798 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:26.326Z,1424196206.326 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:26.835Z,1424196206.835 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:27.287Z,1424196207.287 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:27.569Z,1424196207.569 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:28.131Z,1424196208.131 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:28.692Z,1424196208.692 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:29.104Z,1424196209.104 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:29.456Z,1424196209.456 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:29.880Z,1424196209.880 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:30.138Z,1424196210.138 [NAL9602](INFO): Flushing. SigQuality: 1 2015-02-17T18:03:30.177Z,1424196210.177 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:30.705Z,1424196210.705 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:31.122Z,1424196211.122 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:31.357Z,1424196211.357 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:31.891Z,1424196211.891 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:32.145Z,1424196212.145 [NAL9602](INFO): Flushing. SigQuality: 2 2015-02-17T18:03:32.160Z,1424196212.160 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:32.805Z,1424196212.805 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:33.226Z,1424196213.226 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:33.631Z,1424196213.631 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:33.988Z,1424196213.988 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:34.344Z,1424196214.344 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:34.688Z,1424196214.688 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:35.094Z,1424196215.094 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:35.447Z,1424196215.447 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:35.957Z,1424196215.957 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:36.341Z,1424196216.341 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:36.757Z,1424196216.757 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:37.109Z,1424196217.109 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:37.815Z,1424196217.815 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:38.283Z,1424196218.283 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:38.553Z,1424196218.553 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:38.846Z,1424196218.846 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:39.404Z,1424196219.404 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:39.731Z,1424196219.731 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:40.393Z,1424196220.393 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:40.898Z,1424196220.898 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:41.200Z,1424196221.200 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:41.623Z,1424196221.623 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:41.986Z,1424196221.986 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:42.341Z,1424196222.341 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:42.865Z,1424196222.865 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:43.262Z,1424196223.262 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:43.671Z,1424196223.671 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:44.121Z,1424196224.121 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:44.560Z,1424196224.560 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:44.828Z,1424196224.828 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:45.284Z,1424196225.284 [NAL9602](INFO): SBD MO Status=0, MOMSN=7163, MT Status=0, MTMSN=0 2015-02-17T18:03:45.284Z,1424196225.284 [NAL9602](INFO): No messages in MT queue 2015-02-17T18:03:45.295Z,1424196225.295 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:45.651Z,1424196225.651 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:46.117Z,1424196226.117 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:46.413Z,1424196226.413 [NAL9602](IMPORTANT): GPS fix at: 1424196226.41 2015-02-17T18:03:46.449Z,1424196226.449 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:46.487Z,1424196226.487 [Default:CheckIn:Read_GPS] Stopped 2015-02-17T18:03:46.487Z,1424196226.487 [Default:CheckIn:Read_Iridium] Running Loop=1 2015-02-17T18:03:47.023Z,1424196227.023 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:47.041Z,1424196227.041 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2015-02-17T18:03:48.035Z,1424196228.035 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:48.453Z,1424196228.453 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:52.358Z,1424196232.358 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:52.934Z,1424196232.934 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:53.466Z,1424196233.466 [NAL9602](INFO): Powering down 2015-02-17T18:03:53.524Z,1424196233.524 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:53.985Z,1424196233.985 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:54.446Z,1424196234.446 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:55.038Z,1424196235.038 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:03:55.545Z,1424196235.545 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:04:00.354Z,1424196240.354 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:04:04.815Z,1424196244.815 [DataOverHttps](INFO): Sending 63 bytes from file Logs/20150217T175835/Courier0004.lzma 2015-02-17T18:04:04.848Z,1424196244.848 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:04:04.857Z,1424196244.857 [Default:UpdateAndReportMinutesSinceMissionStarted] Running Loop=1 2015-02-17T18:04:04.857Z,1424196244.857 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::initialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-02-17T18:04:04.857Z,1424196244.857 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Running Loop=1 2015-02-17T18:04:04.860Z,1424196244.860 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Stopped 2015-02-17T18:04:04.860Z,1424196244.860 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Running Loop=1 2015-02-17T18:04:05.421Z,1424196245.421 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:04:05.430Z,1424196245.430 [Default:UpdateAndReportMinutesSinceMissionStarted:B](IMPORTANT): Default mission has been running for 2.166542 min 2015-02-17T18:04:05.432Z,1424196245.432 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Stopped 2015-02-17T18:04:05.432Z,1424196245.432 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Completed Default:UpdateAndReportMinutesSinceMissionStarted 2015-02-17T18:04:05.432Z,1424196245.432 [Default:UpdateAndReportMinutesSinceMissionStarted] Stopped 2015-02-17T18:04:05.432Z,1424196245.432 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::uninitialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-02-17T18:04:06.131Z,1424196246.131 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:04:07.117Z,1424196247.117 [DataOverHttps](INFO): Moved sent file to Logs/20150217T175835/Courier0004.lzma.bak 2015-02-17T18:04:07.117Z,1424196247.117 [DataOverHttps](INFO): SBD MOMSN=3043413 2015-02-17T18:04:07.220Z,1424196247.220 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:04:12.937Z,1424196252.937 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:04:13.736Z,1424196253.736 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:04:18.173Z,1424196258.173 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:04:18.923Z,1424196258.923 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:04:19.731Z,1424196259.731 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:04:20.778Z,1424196260.778 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:04:22.037Z,1424196262.037 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:04:23.153Z,1424196263.153 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:04:28.037Z,1424196268.037 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:04:28.487Z,1424196268.487 [DataOverHttps](INFO): Sending 516 bytes from file Logs/20150217T174555/Express0009.lzma 2015-02-17T18:04:28.580Z,1424196268.580 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:04:29.144Z,1424196269.144 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:04:29.506Z,1424196269.506 [DataOverHttps](INFO): Moved sent file to Logs/20150217T174555/Express0009.lzma.bak 2015-02-17T18:04:29.507Z,1424196269.507 [DataOverHttps](INFO): SBD MOMSN=3043417 2015-02-17T18:04:29.651Z,1424196269.651 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:04:30.945Z,1424196270.945 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:04:31.489Z,1424196271.489 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:04:37.263Z,1424196277.263 [BPC1](ERROR): Failed to receive battery data 2015-02-17T18:04:37.263Z,1424196277.263 [BPC1] Communications Fault, FailCount= 1 2015-02-17T18:04:37.263Z,1424196277.263 [BPC1](ERROR): Communications Fault 2015-02-17T18:04:37.269Z,1424196277.269 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:04:37.288Z,1424196277.288 [CBIT](ERROR): Communications Fault in component: BPC1 2015-02-17T18:04:38.233Z,1424196278.233 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:04:38.868Z,1424196278.868 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:04:40.051Z,1424196280.051 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:04:40.093Z,1424196280.093 [CBIT](INFO): Clearing failed state for component BPC1 2015-02-17T18:04:40.094Z,1424196280.094 [BPC1] No Fault, FailCount= 1 2015-02-17T18:04:40.820Z,1424196280.820 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:04:41.361Z,1424196281.361 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:04:42.717Z,1424196282.717 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:04:46.875Z,1424196286.875 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:04:47.357Z,1424196287.357 [DataOverHttps](INFO): Sending 672 bytes from file Logs/20150217T175835/Express0001.lzma 2015-02-17T18:04:47.382Z,1424196287.382 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:04:48.195Z,1424196288.195 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:05:04.964Z,1424196304.964 [DataOverHttps](INFO): Moved sent file to Logs/20150217T175835/Express0001.lzma.bak 2015-02-17T18:05:04.964Z,1424196304.964 [DataOverHttps](INFO): SBD MOMSN=3043447 2015-02-17T18:05:05.082Z,1424196305.082 [BPC1](ERROR): Failed to receive battery data 2015-02-17T18:05:05.083Z,1424196305.083 [BPC1] Communications Fault, FailCount= 2 2015-02-17T18:05:05.083Z,1424196305.083 [BPC1](ERROR): Communications Fault 2015-02-17T18:05:05.091Z,1424196305.091 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:05:05.196Z,1424196305.196 [CBIT](ERROR): Communications Fault in component: BPC1 2015-02-17T18:05:06.705Z,1424196306.705 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:05:07.364Z,1424196307.364 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:05:12.073Z,1424196312.073 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:05:12.136Z,1424196312.136 [CBIT](INFO): Clearing failed state for component BPC1 2015-02-17T18:05:12.136Z,1424196312.136 [BPC1] No Fault, FailCount= 2 2015-02-17T18:05:12.797Z,1424196312.797 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:05:14.339Z,1424196314.339 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:05:15.407Z,1424196315.407 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:05:16.074Z,1424196316.074 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:05:16.321Z,1424196316.321 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:05:20.397Z,1424196320.397 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:05:21.103Z,1424196321.103 [DataOverHttps](INFO): Sending 139 bytes from file Logs/20150217T175835/Express0005.lzma 2015-02-17T18:05:21.211Z,1424196321.211 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:05:21.939Z,1424196321.939 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:05:22.555Z,1424196322.555 [DataOverHttps](INFO): Moved sent file to Logs/20150217T175835/Express0005.lzma.bak 2015-02-17T18:05:22.556Z,1424196322.556 [DataOverHttps](INFO): SBD MOMSN=3043461 2015-02-17T18:05:22.651Z,1424196322.651 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:05:24.229Z,1424196324.229 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:05:24.306Z,1424196324.306 [Default:CheckIn:Read_Iridium] Stopped 2015-02-17T18:05:24.306Z,1424196324.306 [Default:CheckIn](INFO): Completed Default:CheckIn 2015-02-17T18:05:24.306Z,1424196324.306 [Default:CheckIn] Stopped 2015-02-17T18:05:24.306Z,1424196324.306 [Default:CheckIn](INFO): Aggregate::uninitialize Default:CheckIn 2015-02-17T18:05:24.306Z,1424196324.306 [Default:CheckIn:A.SetSpeed] Stopped 2015-02-17T18:05:24.306Z,1424196324.306 [Default:CheckIn:A.SetSpeed](DEBUG): Uninitialize. 2015-02-17T18:05:25.147Z,1424196325.147 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:05:29.839Z,1424196329.839 [CommandLine](IMPORTANT): got command restart system 2015-02-17T18:05:33.768Z,1424196333.768 [BPC1](ERROR): Failed to receive battery data 2015-02-17T18:05:33.768Z,1424196333.768 [BPC1] Communications Fault, FailCount= 3 2015-02-17T18:05:33.768Z,1424196333.768 [BPC1](ERROR): Communications Fault 2015-02-17T18:05:33.779Z,1424196333.779 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:05:33.895Z,1424196333.895 [CBIT](ERROR): Communications Fault in component: BPC1 2015-02-17T18:05:35.045Z,1424196335.045 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:05:40.235Z,1424196340.235 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:05:45.255Z,1424196345.255 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:05:45.273Z,1424196345.273 [CBIT](INFO): Clearing failed state for component BPC1 2015-02-17T18:05:45.274Z,1424196345.274 [BPC1] No Fault, FailCount= 3 2015-02-17T18:05:50.044Z,1424196350.044 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:05:55.033Z,1424196355.033 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:06:00.380Z,1424196360.380 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2015-02-17T18:06:00.519Z,1424196360.519 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2015-02-17T18:06:00.527Z,1424196360.527 [CommandLine ThreadHandler](INFO): Thread cancelled. 2015-02-17T18:06:00.716Z,1424196360.716 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2015-02-17T18:06:00.716Z,1424196360.716 [CommandLine ThreadHandler](INFO): Thread cancelled. 2015-02-17T18:06:00.717Z,1424196360.717 [CommandLine](INFO): Join timeout helper Thread ID is 934 2015-02-17T18:06:00.719Z,1424196360.719 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2015-02-17T18:06:00.719Z,1424196360.719 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2015-02-17T18:06:00.720Z,1424196360.720 [NavChartDb](INFO): Join timeout helper Thread ID is 935 2015-02-17T18:06:00.912Z,1424196360.912 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2015-02-17T18:06:00.913Z,1424196360.913 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2015-02-17T18:06:00.928Z,1424196360.928 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2015-02-17T18:06:00.929Z,1424196360.929 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2015-02-17T18:06:00.929Z,1424196360.929 [Radio_Surface](INFO): Join timeout helper Thread ID is 936 2015-02-17T18:06:01.001Z,1424196361.001 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2015-02-17T18:06:01.001Z,1424196361.001 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2015-02-17T18:06:01.008Z,1424196361.008 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2015-02-17T18:06:01.008Z,1424196361.008 [logger ThreadHandler](INFO): Thread cancelled. 2015-02-17T18:06:01.009Z,1424196361.009 [logger](INFO): Join timeout helper Thread ID is 937 2015-02-17T18:06:01.020Z,1424196361.020 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2015-02-17T18:06:01.021Z,1424196361.021 [logger ThreadHandler](INFO): Thread cancelled. 2015-02-17T18:06:01.028Z,1424196361.028 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2015-02-17T18:06:01.028Z,1424196361.028 [CommandLine ThreadHandler](INFO): Thread cancelled. 2015-02-17T18:06:01.029Z,1424196361.029 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2015-02-17T18:06:01.029Z,1424196361.029 [controlThread ThreadHandler](INFO): Thread cancelled. 2015-02-17T18:06:01.029Z,1424196361.029 [controlThread](INFO): Join timeout helper Thread ID is 938 2015-02-17T18:06:04.334Z,1424196364.334 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2015-02-17T18:06:04.334Z,1424196364.334 [controlThread](DEBUG): Uninitializing ControlThread 2015-02-17T18:06:04.335Z,1424196364.335 [DVL_micro](INFO): uninitialize:Powering down 2015-02-17T18:06:04.336Z,1424196364.336 [NAL9602](INFO): Powering down 2015-02-17T18:06:04.338Z,1424196364.338 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2015-02-17T18:06:04.339Z,1424196364.339 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2015-02-17T18:06:04.339Z,1424196364.339 [Default] Stopped 2015-02-17T18:06:04.339Z,1424196364.339 [Default](INFO): Aggregate::uninitialize Default 2015-02-17T18:06:04.340Z,1424196364.340 [Default:B.GoToSurface] Stopped 2015-02-17T18:06:04.340Z,1424196364.340 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2015-02-17T18:06:04.340Z,1424196364.340 [Default:WaitAtTheSurface] Stopped 2015-02-17T18:06:04.340Z,1424196364.340 [Default:WaitAtTheSurface](INFO): Aggregate::uninitialize Default:WaitAtTheSurface 2015-02-17T18:06:04.340Z,1424196364.340 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed] Stopped 2015-02-17T18:06:04.340Z,1424196364.340 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed](DEBUG): Uninitialize. 2015-02-17T18:06:04.344Z,1424196364.344 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2015-02-17T18:06:04.344Z,1424196364.344 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2015-02-17T18:06:04.344Z,1424196364.344 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2015-02-17T18:06:04.345Z,1424196364.345 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2015-02-17T18:06:04.345Z,1424196364.345 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2015-02-17T18:06:04.345Z,1424196364.345 [BuoyancyServo](INFO): Powering down 2015-02-17T18:06:04.358Z,1424196364.358 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2015-02-17T18:06:04.358Z,1424196364.358 [ElevatorServo](INFO): Powering down 2015-02-17T18:06:04.359Z,1424196364.359 [MassServo](DEBUG): Uninitialize Mass Servo. 2015-02-17T18:06:04.359Z,1424196364.359 [MassServo](INFO): Powering down 2015-02-17T18:06:04.360Z,1424196364.360 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2015-02-17T18:06:04.360Z,1424196364.360 [RudderServo](INFO): Powering down 2015-02-17T18:06:04.361Z,1424196364.361 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2015-02-17T18:06:04.361Z,1424196364.361 [ThrusterServo](INFO): Powering down 2015-02-17T18:06:04.362Z,1424196364.362 [SBIT](DEBUG): Uninitialize SBIT Component. 2015-02-17T18:06:04.362Z,1424196364.362 [IBIT](DEBUG): Uninitialize IBIT Component. 2015-02-17T18:06:04.362Z,1424196364.362 [CBIT](DEBUG): Uninitialize CBIT Component. 2015-02-17T18:06:04.394Z,1424196364.394 [controlThread ThreadHandler](INFO): Thread cancelled. 2015-02-17T18:06:04.580Z,1424196364.580 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2015-02-17T18:06:04.643Z,1424196364.643 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2015-02-17T18:06:04.713Z,1424196364.713 [logger ThreadHandler](INFO): Thread cancelled.