2014-05-21T22:19:41.575Z,1400710781.575 [Supervisor](DEBUG): Initializing supervisor. 2014-05-21T22:19:41.578Z,1400710781.578 [SyncHandler](DEBUG): Created PCaller Thread at 4034C4E0 2014-05-21T22:19:41.579Z,1400710781.579 [SyncHandler](INFO): Protected caller Thread ID is 779 2014-05-21T22:19:41.579Z,1400710781.579 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2014-05-21T22:19:41.582Z,1400710781.582 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4037C4E0 2014-05-21T22:19:41.583Z,1400710781.583 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 780 2014-05-21T22:19:41.586Z,1400710781.586 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2014-05-21T22:19:41.597Z,1400710781.597 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2014-05-21T22:19:41.598Z,1400710781.598 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 403AC4E0 2014-05-21T22:19:41.599Z,1400710781.599 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 781 2014-05-21T22:19:41.600Z,1400710781.600 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2014-05-21T22:19:41.602Z,1400710781.602 [logger ThreadHandler](DEBUG): Created PCaller Thread at 403DC4E0 2014-05-21T22:19:41.603Z,1400710781.603 [logger ThreadHandler](INFO): Protected caller Thread ID is 782 2014-05-21T22:19:41.605Z,1400710781.605 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2014-05-21T22:19:41.606Z,1400710781.606 [Supervisor](INFO): Looking for Config files in directory: Config/ 2014-05-21T22:19:41.610Z,1400710781.610 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2014-05-21T22:19:42.004Z,1400710782.004 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2014-05-21T22:19:42.004Z,1400710782.004 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2014-05-21T22:19:42.321Z,1400710782.321 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2014-05-21T22:19:42.321Z,1400710782.321 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2014-05-21T22:19:42.419Z,1400710782.419 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2014-05-21T22:19:42.421Z,1400710782.421 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2014-05-21T22:19:42.626Z,1400710782.626 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2014-05-21T22:19:42.627Z,1400710782.627 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2014-05-21T22:19:42.810Z,1400710782.810 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2014-05-21T22:19:42.812Z,1400710782.812 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2014-05-21T22:19:43.150Z,1400710783.150 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2014-05-21T22:19:43.151Z,1400710783.151 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2014-05-21T22:19:43.350Z,1400710783.350 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2014-05-21T22:19:43.352Z,1400710783.352 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2014-05-21T22:19:43.728Z,1400710783.728 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2014-05-21T22:19:43.730Z,1400710783.730 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2014-05-21T22:19:43.855Z,1400710783.855 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2014-05-21T22:19:43.856Z,1400710783.856 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2014-05-21T22:19:44.417Z,1400710784.417 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2014-05-21T22:19:44.417Z,1400710784.417 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2014-05-21T22:19:44.536Z,1400710784.536 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2014-05-21T22:19:44.537Z,1400710784.537 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2014-05-21T22:19:44.635Z,1400710784.635 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2014-05-21T22:19:44.831Z,1400710784.831 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2014-05-21T22:19:44.832Z,1400710784.832 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2014-05-21T22:19:44.949Z,1400710784.949 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2014-05-21T22:19:44.951Z,1400710784.951 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2014-05-21T22:19:45.109Z,1400710785.109 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2014-05-21T22:19:45.111Z,1400710785.111 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/ 2014-05-21T22:19:45.114Z,1400710785.114 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg 2014-05-21T22:19:45.233Z,1400710785.233 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg 2014-05-21T22:19:45.382Z,1400710785.382 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg 2014-05-21T22:19:45.490Z,1400710785.490 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg 2014-05-21T22:19:45.594Z,1400710785.594 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg 2014-05-21T22:19:45.763Z,1400710785.763 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg 2014-05-21T22:19:45.941Z,1400710785.941 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg 2014-05-21T22:19:46.095Z,1400710786.095 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg 2014-05-21T22:19:46.237Z,1400710786.237 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg 2014-05-21T22:19:46.351Z,1400710786.351 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg 2014-05-21T22:19:46.460Z,1400710786.460 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/workSite.cfg 2014-05-21T22:19:46.558Z,1400710786.558 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Estimation.cfg 2014-05-21T22:19:46.668Z,1400710786.668 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2014-05-21T22:19:46.671Z,1400710786.671 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2014-05-21T22:19:47.302Z,1400710787.302 [AHRS_sp3003D] Loaded 2014-05-21T22:19:47.303Z,1400710787.303 [ComponentRegistry](DEBUG): SyncComponent "AHRS_sp3003D" handled in the control thread. 2014-05-21T22:19:47.641Z,1400710787.641 [Batt_Ocean_Server] Loaded 2014-05-21T22:19:47.641Z,1400710787.641 [ComponentRegistry](DEBUG): SyncComponent "Batt_Ocean_Server" handled in the control thread. 2014-05-21T22:19:47.655Z,1400710787.655 [Depth_Keller] Loaded 2014-05-21T22:19:47.655Z,1400710787.655 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2014-05-21T22:19:47.660Z,1400710787.660 [DropWeight] Loaded 2014-05-21T22:19:47.661Z,1400710787.661 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2014-05-21T22:19:47.824Z,1400710787.824 [DVL_micro] Loaded 2014-05-21T22:19:47.825Z,1400710787.825 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread. 2014-05-21T22:19:47.947Z,1400710787.947 [NAL9602] Loaded 2014-05-21T22:19:47.947Z,1400710787.947 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2014-05-21T22:19:48.004Z,1400710788.004 [Onboard] Loaded 2014-05-21T22:19:48.005Z,1400710788.005 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2014-05-21T22:19:48.012Z,1400710788.012 [Radio_Freewave] Loaded 2014-05-21T22:19:48.012Z,1400710788.012 [ComponentRegistry](DEBUG): Component "Radio_Freewave" handled in its own thread. 2014-05-21T22:19:48.016Z,1400710788.016 [Radio_Freewave ThreadHandler](DEBUG): Created PCaller Thread at 4060F4E0 2014-05-21T22:19:48.017Z,1400710788.017 [Radio_Freewave ThreadHandler](INFO): Protected caller Thread ID is 866 2014-05-21T22:19:48.024Z,1400710788.024 [SCPI] Loaded 2014-05-21T22:19:48.024Z,1400710788.024 [ComponentRegistry](DEBUG): SyncComponent "SCPI" handled in the control thread. 2014-05-21T22:19:48.025Z,1400710788.025 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2014-05-21T22:19:48.025Z,1400710788.025 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2014-05-21T22:19:48.265Z,1400710788.265 [InternalSim] Loaded 2014-05-21T22:19:48.266Z,1400710788.266 [ComponentRegistry](DEBUG): SyncComponent "InternalSim" handled in the control thread. 2014-05-21T22:19:48.266Z,1400710788.266 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2014-05-21T22:19:48.267Z,1400710788.267 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2014-05-21T22:19:48.585Z,1400710788.585 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2014-05-21T22:19:48.585Z,1400710788.585 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2014-05-21T22:19:48.594Z,1400710788.594 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2014-05-21T22:19:48.595Z,1400710788.595 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2014-05-21T22:19:48.703Z,1400710788.703 [DeadReckonUsingMultipleVelocitySources] Loaded 2014-05-21T22:19:48.704Z,1400710788.704 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2014-05-21T22:19:48.754Z,1400710788.754 [DeadReckonWithRespectToWater] Loaded 2014-05-21T22:19:48.754Z,1400710788.754 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToWater" handled in the control thread. 2014-05-21T22:19:48.805Z,1400710788.805 [DeadReckonWithRespectToSeafloor] Loaded 2014-05-21T22:19:48.806Z,1400710788.806 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread. 2014-05-21T22:19:48.862Z,1400710788.862 [DeadReckonUsingDVLWaterTrack] Loaded 2014-05-21T22:19:48.862Z,1400710788.862 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingDVLWaterTrack" handled in the control thread. 2014-05-21T22:19:48.914Z,1400710788.914 [DeadReckonUsingCompactModelForecast] Loaded 2014-05-21T22:19:48.915Z,1400710788.915 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingCompactModelForecast" handled in the control thread. 2014-05-21T22:19:48.931Z,1400710788.931 [NavChart] Loaded 2014-05-21T22:19:48.931Z,1400710788.931 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2014-05-21T22:19:48.935Z,1400710788.935 [UniversalFixResidualReporter] Loaded 2014-05-21T22:19:48.936Z,1400710788.936 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2014-05-21T22:19:48.936Z,1400710788.936 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2014-05-21T22:19:48.937Z,1400710788.937 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2014-05-21T22:19:49.011Z,1400710789.011 [VerticalControl](DEBUG): Construct VerticalControl. 2014-05-21T22:19:49.135Z,1400710789.135 [VerticalControl] Loaded 2014-05-21T22:19:49.136Z,1400710789.136 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2014-05-21T22:19:49.136Z,1400710789.136 [HorizontalControl](DEBUG): Construct HorizontalControl. 2014-05-21T22:19:49.214Z,1400710789.214 [HorizontalControl] Loaded 2014-05-21T22:19:49.214Z,1400710789.214 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2014-05-21T22:19:49.215Z,1400710789.215 [SpeedControl](DEBUG): Construct SpeedControl. 2014-05-21T22:19:49.216Z,1400710789.216 [SpeedControl] Loaded 2014-05-21T22:19:49.217Z,1400710789.217 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2014-05-21T22:19:49.217Z,1400710789.217 [LoopControl](DEBUG): Construct LoopControl. 2014-05-21T22:19:49.218Z,1400710789.218 [LoopControl] Loaded 2014-05-21T22:19:49.218Z,1400710789.218 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2014-05-21T22:19:49.219Z,1400710789.219 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2014-05-21T22:19:49.219Z,1400710789.219 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2014-05-21T22:19:49.256Z,1400710789.256 [DepthRateCalculator] Loaded 2014-05-21T22:19:49.256Z,1400710789.256 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2014-05-21T22:19:49.262Z,1400710789.262 [PitchRateCalculator] Loaded 2014-05-21T22:19:49.262Z,1400710789.262 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2014-05-21T22:19:49.269Z,1400710789.269 [SpeedCalculator] Loaded 2014-05-21T22:19:49.270Z,1400710789.270 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2014-05-21T22:19:49.287Z,1400710789.287 [TempGradientCalculator] Loaded 2014-05-21T22:19:49.287Z,1400710789.287 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2014-05-21T22:19:49.292Z,1400710789.292 [YawRateCalculator] Loaded 2014-05-21T22:19:49.293Z,1400710789.293 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2014-05-21T22:19:49.293Z,1400710789.293 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2014-05-21T22:19:49.294Z,1400710789.294 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2014-05-21T22:19:49.435Z,1400710789.435 [CTD_NeilBrown] Loaded 2014-05-21T22:19:49.436Z,1400710789.436 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread. 2014-05-21T22:19:49.439Z,1400710789.439 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 4075E4E0 2014-05-21T22:19:49.439Z,1400710789.439 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 867 2014-05-21T22:19:49.453Z,1400710789.453 [ISUS] Loaded 2014-05-21T22:19:49.453Z,1400710789.453 [ComponentRegistry](DEBUG): SyncComponent "ISUS" handled in the control thread. 2014-05-21T22:19:49.468Z,1400710789.468 [PAR_Licor] Loaded 2014-05-21T22:19:49.468Z,1400710789.468 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2014-05-21T22:19:49.508Z,1400710789.508 [WetLabsBB2FL] Loaded 2014-05-21T22:19:49.508Z,1400710789.508 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2014-05-21T22:19:49.511Z,1400710789.511 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 4078E4E0 2014-05-21T22:19:49.511Z,1400710789.511 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 868 2014-05-21T22:19:49.512Z,1400710789.512 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2014-05-21T22:19:49.512Z,1400710789.512 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2014-05-21T22:19:49.646Z,1400710789.646 [SBIT](DEBUG): Construct Startup Built In Test. 2014-05-21T22:19:49.657Z,1400710789.657 [SBIT] Loaded 2014-05-21T22:19:49.658Z,1400710789.658 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2014-05-21T22:19:49.658Z,1400710789.658 [IBIT](DEBUG): Construct Initiated Built In Test. 2014-05-21T22:19:49.676Z,1400710789.676 [IBIT] Loaded 2014-05-21T22:19:49.676Z,1400710789.676 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2014-05-21T22:19:49.678Z,1400710789.678 [CBIT](DEBUG): Construct CBIT Built In Test. 2014-05-21T22:19:49.755Z,1400710789.755 [CBIT] Loaded 2014-05-21T22:19:49.756Z,1400710789.756 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2014-05-21T22:19:49.756Z,1400710789.756 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2014-05-21T22:19:49.757Z,1400710789.757 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2014-05-21T22:19:55.163Z,1400710795.163 [HFRadarModelCalc] Loaded 2014-05-21T22:19:55.163Z,1400710795.163 [ComponentRegistry](DEBUG): SyncComponent "HFRadarModelCalc" handled in the control thread. 2014-05-21T22:19:59.046Z,1400710799.046 [HFRadarCompactModelForecaster] Loaded 2014-05-21T22:19:59.046Z,1400710799.046 [ComponentRegistry](DEBUG): SyncComponent "HFRadarCompactModelForecaster" handled in the control thread. 2014-05-21T22:20:00.171Z,1400710800.171 [HFRCMSpaceInterpolator] Loaded 2014-05-21T22:20:00.171Z,1400710800.171 [ComponentRegistry](DEBUG): SyncComponent "HFRCMSpaceInterpolator" handled in the control thread. 2014-05-21T22:20:00.173Z,1400710800.173 [HFRCMTimeInterpolator] Loaded 2014-05-21T22:20:00.174Z,1400710800.174 [ComponentRegistry](DEBUG): SyncComponent "HFRCMTimeInterpolator" handled in the control thread. 2014-05-21T22:20:00.186Z,1400710800.186 [HFRCMSurfaceCurrentAtVehicleLocation] Loaded 2014-05-21T22:20:00.187Z,1400710800.187 [ComponentRegistry](DEBUG): SyncComponent "HFRCMSurfaceCurrentAtVehicleLocation" handled in the control thread. 2014-05-21T22:20:00.219Z,1400710800.219 [HFRCMVirtualSurfaceDrifter] Loaded 2014-05-21T22:20:00.219Z,1400710800.219 [ComponentRegistry](DEBUG): SyncComponent "HFRCMVirtualSurfaceDrifter" handled in the control thread. 2014-05-21T22:20:00.220Z,1400710800.220 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2014-05-21T22:20:00.220Z,1400710800.220 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2014-05-21T22:20:00.361Z,1400710800.361 [BuoyancyServo] Loaded 2014-05-21T22:20:00.362Z,1400710800.362 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2014-05-21T22:20:00.374Z,1400710800.374 [ElevatorServo] Loaded 2014-05-21T22:20:00.374Z,1400710800.374 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2014-05-21T22:20:00.386Z,1400710800.386 [MassServo] Loaded 2014-05-21T22:20:00.386Z,1400710800.386 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2014-05-21T22:20:00.402Z,1400710800.402 [RudderServo] Loaded 2014-05-21T22:20:00.403Z,1400710800.403 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2014-05-21T22:20:00.414Z,1400710800.414 [ThrusterServo] Loaded 2014-05-21T22:20:00.415Z,1400710800.415 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2014-05-21T22:20:00.415Z,1400710800.415 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2014-05-21T22:20:00.416Z,1400710800.416 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2014-05-21T22:20:00.460Z,1400710800.460 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2014-05-21T22:20:00.462Z,1400710800.462 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2014-05-21T22:20:00.463Z,1400710800.463 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2014-05-21T22:20:00.469Z,1400710800.469 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2014-05-21T22:20:00.472Z,1400710800.472 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A4E4E0 2014-05-21T22:20:00.472Z,1400710800.472 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 869 2014-05-21T22:20:00.477Z,1400710800.477 [Supervisor](INFO): Main Thread ID is 770 2014-05-21T22:20:00.477Z,1400710800.477 [Supervisor](DEBUG): Running supervisor. 2014-05-21T22:20:00.478Z,1400710800.478 [CommandLine ThreadHandler](INFO): Handler Thread ID is 870 2014-05-21T22:20:00.484Z,1400710800.484 [controlThread ThreadHandler](INFO): Handler Thread ID is 871 2014-05-21T22:20:00.485Z,1400710800.485 [controlThread](DEBUG): Initializing ControlThread 2014-05-21T22:20:00.488Z,1400710800.488 [logger ThreadHandler](INFO): Handler Thread ID is 872 2014-05-21T22:20:00.524Z,1400710800.524 [Radio_Freewave ThreadHandler](INFO): Handler Thread ID is 873 2014-05-21T22:20:00.536Z,1400710800.536 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 874 2014-05-21T22:20:00.537Z,1400710800.537 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown. 2014-05-21T22:20:00.540Z,1400710800.540 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4 2014-05-21T22:20:00.550Z,1400710800.550 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 876 2014-05-21T22:20:00.551Z,1400710800.551 [WetLabsBB2FL](INFO): Powering down 2014-05-21T22:20:00.581Z,1400710800.581 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 877 2014-05-21T22:20:00.603Z,1400710800.603 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources 2014-05-21T22:20:00.604Z,1400710800.604 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2014-05-21T22:20:00.605Z,1400710800.605 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2014-05-21T22:20:00.605Z,1400710800.605 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2014-05-21T22:20:00.605Z,1400710800.605 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2014-05-21T22:20:00.605Z,1400710800.605 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2014-05-21T22:20:00.605Z,1400710800.605 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2014-05-21T22:20:00.606Z,1400710800.606 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2014-05-21T22:20:00.606Z,1400710800.606 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2014-05-21T22:20:02.167Z,1400710802.167 [Batt_Ocean_Server](INFO): Ocean Server Batteries initialized 2014-05-21T22:20:02.197Z,1400710802.197 [InternalSim](DEBUG): InternalSim initializing... 2014-05-21T22:20:02.586Z,1400710802.586 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2014-05-21T22:20:02.586Z,1400710802.586 [DeadReckonWithRespectToWater](DEBUG): Initializing DeadReckonWithRespectToWater component. 2014-05-21T22:20:02.587Z,1400710802.587 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2014-05-21T22:20:02.587Z,1400710802.587 [DeadReckonUsingDVLWaterTrack](DEBUG): Initializing DeadReckonUsingDVLWaterTrack component. 2014-05-21T22:20:02.588Z,1400710802.588 [DeadReckonUsingCompactModelForecast](DEBUG): Initializing DeadReckonUsingCompactModelForecast component. 2014-05-21T22:20:02.588Z,1400710802.588 [NavChart](DEBUG): Initialize NavChart Navigation. 2014-05-21T22:20:02.588Z,1400710802.588 [UniversalFixResidualReporter](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2014-05-21T22:20:02.589Z,1400710802.589 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2014-05-21T22:20:02.591Z,1400710802.591 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2014-05-21T22:20:02.592Z,1400710802.592 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2014-05-21T22:20:02.592Z,1400710802.592 [LoopControl](DEBUG): Initialize LoopControlComponent. 2014-05-21T22:20:02.592Z,1400710802.592 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2014-05-21T22:20:02.593Z,1400710802.593 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2014-05-21T22:20:02.593Z,1400710802.593 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2014-05-21T22:20:02.594Z,1400710802.594 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2014-05-21T22:20:02.594Z,1400710802.594 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2014-05-21T22:20:02.607Z,1400710802.607 [SBIT](INFO): Initialize SBIT Component. 2014-05-21T22:20:02.608Z,1400710802.608 [SBIT](IMPORTANT): Tethys CM Info: $Rev:11320 2014-05-21T22:20:02.608Z,1400710802.608 [SBIT](IMPORTANT): Kernel Release:2.6.27.8 2014-05-21T22:20:02.608Z,1400710802.608 [SBIT](IMPORTANT): Kernel Version:#639 PREEMPT Wed Mar 12 12:53:33 PDT 2014 2014-05-21T22:20:02.609Z,1400710802.609 [IBIT](INFO): Initialize IBIT Component. 2014-05-21T22:20:02.610Z,1400710802.610 [CBIT](DEBUG): Initialize CBIT Component. 2014-05-21T22:20:02.610Z,1400710802.610 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2014-05-21T22:20:02.647Z,1400710802.647 [HFRadarCompactModelForecaster](DEBUG): Found new ECs! 2014-05-21T22:20:02.647Z,1400710802.647 [HFRadarCompactModelForecaster](ERROR): Most recent ECs are more than six hours old. 2014-05-21T22:20:03.206Z,1400710803.206 [Radio_Freewave](INFO): Powering up 2014-05-21T22:20:04.014Z,1400710804.014 [Radio_Freewave](IMPORTANT): Starting PPPD with command:/sbin/pppd nocrtscts /dev/ttyS1 noauth 115200 10.1.1.2:10.1.1.1 persist maxfail 0 2014-05-21T22:20:12.072Z,1400710812.072 [HFRadarCompactModelForecaster](IMPORTANT): Forecast time 201405211300: published 50 modes in rows, 61 hours in columns, 3050 elements. 2014-05-21T22:20:12.087Z,1400710812.087 [HFRCMSpaceInterpolator](DEBUG): Initializing HFRCMSpaceInterpolator component. 2014-05-21T22:20:12.089Z,1400710812.089 [HFRCMTimeInterpolator](DEBUG): Initializing HFRCMTimeInterpolator component. 2014-05-21T22:20:12.089Z,1400710812.089 [HFRCMSurfaceCurrentAtVehicleLocation](DEBUG): Initializing HFRCMSurfaceCurrentAtVehicleLocation component. 2014-05-21T22:20:12.102Z,1400710812.102 [HFRCMVirtualSurfaceDrifter](DEBUG): Initializing HFRCMVirtualSurfaceDrifter component. 2014-05-21T22:20:12.104Z,1400710812.104 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2014-05-21T22:20:12.133Z,1400710812.133 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2014-05-21T22:20:12.158Z,1400710812.158 [MissionManager](DEBUG): 2014-05-21T22:20:12.159Z,1400710812.159 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2014-05-21T22:20:12.241Z,1400710812.241 [MissionManager](INFO): DefineArg Default.NeedGPS = 1 bool 2014-05-21T22:20:12.243Z,1400710812.243 [Default:GPS:A.SetSpeed](DEBUG): Construct. 2014-05-21T22:20:12.263Z,1400710812.263 [Default:GPS:B.GoToSurface](DEBUG): Construct GoToSurface. 2014-05-21T22:20:12.279Z,1400710812.279 [Default:Iridium:A.SetSpeed](DEBUG): Construct. 2014-05-21T22:20:12.298Z,1400710812.298 [Default:Iridium:B.GoToSurface](DEBUG): Construct GoToSurface. 2014-05-21T22:20:12.305Z,1400710812.305 [Default:Iridium:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2014-05-21T22:20:12.355Z,1400710812.355 [Default:WaitAtTheSurface:RunAtLowSpeed.SetSpeed](DEBUG): Construct. 2014-05-21T22:20:12.358Z,1400710812.358 [Default:WaitAtTheSurface:B.GoToSurface](DEBUG): Construct GoToSurface. 2014-05-21T22:20:12.381Z,1400710812.381 [MissionManager](DEBUG): 400 400 Burn 300 Dropped drop weight due to communications timeout 5.0 1.0 5 2014-05-21T22:20:12.389Z,1400710812.389 [controlThread](DEBUG): Component order: CycleStarter,InternalSim,AHRS_sp3003D,Batt_Ocean_Server,Depth_Keller,DropWeight,DVL_micro,NAL9602,Onboard,SCPI,ISUS,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,HFRadarModelCalc,HFRadarCompactModelForecaster,HFRCMSpaceInterpolator,HFRCMTimeInterpolator,HFRCMSurfaceCurrentAtVehicleLocation,HFRCMVirtualSurfaceDrifter,DeadReckonUsingMultipleVelocitySources,DeadReckonWithRespectToWater,DeadReckonWithRespectToSeafloor,DeadReckonUsingDVLWaterTrack,DeadReckonUsingCompactModelForecast,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2014-05-21T22:20:12.598Z,1400710812.598 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D. 2014-05-21T22:20:13.339Z,1400710813.339 [DVL_micro](INFO): Initializing 2014-05-21T22:20:13.386Z,1400710813.386 [NAL9602](INFO): Powering up NAL9602 2014-05-21T22:20:13.747Z,1400710813.747 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:13.989Z,1400710813.989 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2014-05-21T22:20:13.997Z,1400710813.997 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2014-05-21T22:20:14.003Z,1400710814.003 [ElevatorServo](DEBUG): Initializing EZServoServo. 2014-05-21T22:20:14.009Z,1400710814.009 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2014-05-21T22:20:14.031Z,1400710814.031 [MassServo](DEBUG): Initializing EZServoServo. 2014-05-21T22:20:14.041Z,1400710814.041 [MassServo](DEBUG): Initializing MassServo. 2014-05-21T22:20:14.055Z,1400710814.055 [RudderServo](DEBUG): Initializing EZServoServo. 2014-05-21T22:20:14.061Z,1400710814.061 [RudderServo](DEBUG): Initializing RudderServo. 2014-05-21T22:20:14.075Z,1400710814.075 [ThrusterServo](DEBUG): Initializing EZServoServo. 2014-05-21T22:20:14.081Z,1400710814.081 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2014-05-21T22:20:14.512Z,1400710814.512 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:14.866Z,1400710814.866 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2014-05-21T22:20:14.866Z,1400710814.866 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2014-05-21T22:20:14.866Z,1400710814.866 [BuoyancyServo] Communications Fault, FailCount= 1 2014-05-21T22:20:14.866Z,1400710814.866 [BuoyancyServo](ERROR): Communications Fault 2014-05-21T22:20:15.105Z,1400710815.105 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2014-05-21T22:20:15.546Z,1400710815.546 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:15.608Z,1400710815.608 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2014-05-21T22:20:15.609Z,1400710815.609 [BuoyancyServo](INFO): Powering down 2014-05-21T22:20:16.129Z,1400710816.129 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:16.695Z,1400710816.695 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:17.321Z,1400710817.321 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:17.858Z,1400710817.858 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:18.009Z,1400710818.009 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2014-05-21T22:20:18.010Z,1400710818.010 [BuoyancyServo] No Fault, FailCount= 1 2014-05-21T22:20:18.422Z,1400710818.422 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:18.449Z,1400710818.449 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2014-05-21T22:20:18.569Z,1400710818.569 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2014-05-21T22:20:18.942Z,1400710818.942 [SBIT](IMPORTANT): Beginning Startup BIT 2014-05-21T22:20:18.944Z,1400710818.944 [CBIT](IMPORTANT): Beginning GF scan 2014-05-21T22:20:19.471Z,1400710819.471 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:20.360Z,1400710820.360 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:20.898Z,1400710820.898 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:21.442Z,1400710821.442 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:22.026Z,1400710822.026 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:23.048Z,1400710823.048 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:23.732Z,1400710823.732 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:24.570Z,1400710824.570 [NAL9602](INFO): NAL9602 initialized 2014-05-21T22:20:24.627Z,1400710824.627 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:25.221Z,1400710825.221 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:25.867Z,1400710825.867 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:26.344Z,1400710826.344 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:26.846Z,1400710826.846 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:27.298Z,1400710827.298 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:27.911Z,1400710827.911 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:28.442Z,1400710828.442 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:29.008Z,1400710829.008 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:29.457Z,1400710829.457 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:29.934Z,1400710829.934 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:30.355Z,1400710830.355 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:30.846Z,1400710830.846 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:31.438Z,1400710831.438 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:31.857Z,1400710831.857 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:32.300Z,1400710832.300 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:32.857Z,1400710832.857 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:33.355Z,1400710833.355 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:33.827Z,1400710833.827 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:34.315Z,1400710834.315 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:34.843Z,1400710834.843 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:35.843Z,1400710835.843 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:36.342Z,1400710836.342 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:36.816Z,1400710836.816 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:37.345Z,1400710837.345 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:38.165Z,1400710838.165 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:38.850Z,1400710838.850 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:39.406Z,1400710839.406 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:39.958Z,1400710839.958 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:40.557Z,1400710840.557 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:41.227Z,1400710841.227 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:41.816Z,1400710841.816 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:42.341Z,1400710842.341 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:42.838Z,1400710842.838 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:43.421Z,1400710843.421 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:43.962Z,1400710843.962 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:44.417Z,1400710844.417 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:44.928Z,1400710844.928 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:45.454Z,1400710845.454 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:46.012Z,1400710846.012 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:46.524Z,1400710846.524 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:46.668Z,1400710846.668 [CBIT](IMPORTANT): No ground fault detected 2014-05-21T22:20:47.064Z,1400710847.064 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:47.541Z,1400710847.541 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:48.060Z,1400710848.060 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:48.635Z,1400710848.635 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:49.102Z,1400710849.102 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:49.618Z,1400710849.618 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:50.073Z,1400710850.073 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:50.526Z,1400710850.526 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:50.985Z,1400710850.985 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:51.434Z,1400710851.434 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:51.929Z,1400710851.929 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:52.452Z,1400710852.452 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:52.896Z,1400710852.896 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:53.489Z,1400710853.489 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:53.911Z,1400710853.911 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:54.414Z,1400710854.414 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:54.911Z,1400710854.911 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:55.417Z,1400710855.417 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:55.862Z,1400710855.862 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:56.320Z,1400710856.320 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:56.754Z,1400710856.754 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:57.150Z,1400710857.150 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:57.551Z,1400710857.551 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:57.955Z,1400710857.955 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:58.481Z,1400710858.481 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:58.876Z,1400710858.876 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:59.310Z,1400710859.310 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:20:59.709Z,1400710859.709 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:00.110Z,1400710860.110 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:00.530Z,1400710860.530 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:00.951Z,1400710860.951 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:01.579Z,1400710861.579 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:02.428Z,1400710862.428 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:02.910Z,1400710862.910 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:03.398Z,1400710863.398 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:03.972Z,1400710863.972 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:04.548Z,1400710864.548 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:05.214Z,1400710865.214 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:05.654Z,1400710865.654 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:06.100Z,1400710866.100 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:06.566Z,1400710866.566 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:07.004Z,1400710867.004 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:07.429Z,1400710867.429 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:07.862Z,1400710867.862 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:08.379Z,1400710868.379 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:08.870Z,1400710868.870 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:09.311Z,1400710869.311 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:09.706Z,1400710869.706 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:10.108Z,1400710870.108 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:10.509Z,1400710870.509 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:10.929Z,1400710870.929 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:11.357Z,1400710871.357 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:11.847Z,1400710871.847 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:12.266Z,1400710872.266 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:12.633Z,1400710872.633 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:13.043Z,1400710873.043 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:13.082Z,1400710873.082 [SBIT](IMPORTANT): SBIT PASSED 2014-05-21T22:21:13.447Z,1400710873.447 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:13.477Z,1400710873.477 [MissionManager](IMPORTANT): Started mission Startup 2014-05-21T22:21:13.477Z,1400710873.477 [Startup] Running Loop=1 2014-05-21T22:21:13.478Z,1400710873.478 [Startup](INFO): Aggregate::initialize Startup 2014-05-21T22:21:13.478Z,1400710873.478 [Startup:A.GoToSurface] Running Loop=1 2014-05-21T22:21:13.478Z,1400710873.478 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2014-05-21T22:21:13.484Z,1400710873.484 [Startup:StartupSatComms] Running Loop=1 2014-05-21T22:21:13.484Z,1400710873.484 [Startup:StartupSatComms](INFO): Aggregate::initialize Startup:StartupSatComms 2014-05-21T22:21:13.484Z,1400710873.484 [Startup:StartupSatComms:A] Running Loop=1 2014-05-21T22:21:13.974Z,1400710873.974 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:13.982Z,1400710873.982 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2014-05-21T22:21:14.378Z,1400710874.378 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:14.802Z,1400710874.802 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:15.201Z,1400710875.201 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:15.602Z,1400710875.602 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:16.028Z,1400710876.028 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:16.480Z,1400710876.480 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:16.898Z,1400710876.898 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:17.323Z,1400710877.323 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:17.700Z,1400710877.700 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:18.111Z,1400710878.111 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:18.533Z,1400710878.533 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:19.036Z,1400710879.036 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:19.434Z,1400710879.434 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:19.836Z,1400710879.836 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:20.207Z,1400710880.207 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:20.614Z,1400710880.614 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:21.057Z,1400710881.057 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:21.536Z,1400710881.536 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:21.945Z,1400710881.945 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:22.345Z,1400710882.345 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:22.753Z,1400710882.753 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:23.158Z,1400710883.158 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:23.605Z,1400710883.605 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:24.059Z,1400710884.059 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:24.475Z,1400710884.475 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:24.880Z,1400710884.880 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:25.276Z,1400710885.276 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:25.678Z,1400710885.678 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:26.111Z,1400710886.111 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:26.526Z,1400710886.526 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:26.947Z,1400710886.947 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:27.351Z,1400710887.351 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:27.795Z,1400710887.795 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:28.168Z,1400710888.168 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:28.622Z,1400710888.622 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:29.019Z,1400710889.019 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:29.484Z,1400710889.484 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:29.887Z,1400710889.887 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:30.308Z,1400710890.308 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:30.732Z,1400710890.732 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:31.182Z,1400710891.182 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:31.591Z,1400710891.591 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:32.008Z,1400710892.008 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:32.385Z,1400710892.385 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:32.793Z,1400710892.793 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:33.222Z,1400710893.222 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:33.615Z,1400710893.615 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:34.040Z,1400710894.040 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:34.496Z,1400710894.496 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:34.914Z,1400710894.914 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:35.321Z,1400710895.321 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:35.774Z,1400710895.774 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:36.168Z,1400710896.168 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:36.592Z,1400710896.592 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:37.018Z,1400710897.018 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:37.477Z,1400710897.477 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:37.883Z,1400710897.883 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:38.325Z,1400710898.325 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:38.727Z,1400710898.727 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:39.180Z,1400710899.180 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:39.691Z,1400710899.691 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:40.125Z,1400710900.125 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:40.606Z,1400710900.606 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:40.997Z,1400710900.997 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:41.402Z,1400710901.402 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:41.824Z,1400710901.824 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:42.246Z,1400710902.246 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:42.673Z,1400710902.673 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:43.098Z,1400710903.098 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:43.484Z,1400710903.484 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:43.940Z,1400710903.940 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:44.344Z,1400710904.344 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:44.797Z,1400710904.797 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:45.247Z,1400710905.247 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:45.693Z,1400710905.693 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:46.093Z,1400710906.093 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:46.489Z,1400710906.489 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:46.957Z,1400710906.957 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:47.382Z,1400710907.382 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:47.788Z,1400710907.788 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:48.205Z,1400710908.205 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:48.601Z,1400710908.601 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:49.001Z,1400710909.001 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:49.398Z,1400710909.398 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:49.848Z,1400710909.848 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:50.302Z,1400710910.302 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:50.704Z,1400710910.704 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:51.105Z,1400710911.105 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:51.505Z,1400710911.505 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:51.920Z,1400710911.920 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:52.343Z,1400710912.343 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:52.765Z,1400710912.765 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:53.174Z,1400710913.174 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:53.610Z,1400710913.610 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:54.010Z,1400710914.010 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:54.410Z,1400710914.410 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:54.860Z,1400710914.860 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:55.302Z,1400710915.302 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:55.700Z,1400710915.700 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:56.097Z,1400710916.097 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:56.499Z,1400710916.499 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:56.924Z,1400710916.924 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:57.355Z,1400710917.355 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:57.805Z,1400710917.805 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:58.218Z,1400710918.218 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:58.627Z,1400710918.627 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:59.013Z,1400710919.013 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:59.414Z,1400710919.414 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:21:59.911Z,1400710919.911 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:00.359Z,1400710920.359 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:00.757Z,1400710920.757 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:01.157Z,1400710921.157 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:01.557Z,1400710921.557 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:01.957Z,1400710921.957 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:02.369Z,1400710922.369 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:02.813Z,1400710922.813 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:03.293Z,1400710923.293 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:03.683Z,1400710923.683 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:04.084Z,1400710924.084 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:04.478Z,1400710924.478 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:05.007Z,1400710925.007 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:05.383Z,1400710925.383 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:05.784Z,1400710925.784 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:06.222Z,1400710926.222 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:06.621Z,1400710926.621 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:07.026Z,1400710927.026 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:07.477Z,1400710927.477 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:07.910Z,1400710927.910 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:08.311Z,1400710928.311 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:08.708Z,1400710928.708 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:09.189Z,1400710929.189 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:09.619Z,1400710929.619 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:10.081Z,1400710930.081 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:10.483Z,1400710930.483 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:10.908Z,1400710930.908 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:11.338Z,1400710931.338 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:11.717Z,1400710931.717 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:11.788Z,1400710931.788 [CommandLine](IMPORTANT): got command quit 2014-05-21T22:22:12.209Z,1400710932.209 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:12.640Z,1400710932.640 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:12.796Z,1400710932.796 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2014-05-21T22:22:12.796Z,1400710932.796 [CommandLine ThreadHandler](INFO): Thread cancelled. 2014-05-21T22:22:12.957Z,1400710932.957 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2014-05-21T22:22:12.957Z,1400710932.957 [CommandLine ThreadHandler](INFO): Thread cancelled. 2014-05-21T22:22:12.958Z,1400710932.958 [CommandLine](INFO): Join timeout helper Thread ID is 918 2014-05-21T22:22:12.958Z,1400710932.958 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2014-05-21T22:22:12.958Z,1400710932.958 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2014-05-21T22:22:12.959Z,1400710932.959 [NavChartDb](INFO): Join timeout helper Thread ID is 919 2014-05-21T22:22:13.040Z,1400710933.040 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:13.118Z,1400710933.118 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2014-05-21T22:22:13.118Z,1400710933.118 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2014-05-21T22:22:13.121Z,1400710933.121 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2014-05-21T22:22:13.121Z,1400710933.121 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2014-05-21T22:22:13.122Z,1400710933.122 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 920 2014-05-21T22:22:13.402Z,1400710933.402 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2014-05-21T22:22:13.402Z,1400710933.402 [WetLabsBB2FL](INFO): Powering down 2014-05-21T22:22:13.403Z,1400710933.403 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2014-05-21T22:22:13.404Z,1400710933.404 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler 2014-05-21T22:22:13.404Z,1400710933.404 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2014-05-21T22:22:13.404Z,1400710933.404 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 921 2014-05-21T22:22:13.406Z,1400710933.406 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread. 2014-05-21T22:22:13.406Z,1400710933.406 [CTD_NeilBrown](INFO): Powering down 2014-05-21T22:22:13.407Z,1400710933.407 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2014-05-21T22:22:13.410Z,1400710933.410 [ComponentRegistry](INFO): Shutting down Radio_Freewave ThreadHandler 2014-05-21T22:22:13.410Z,1400710933.410 [Radio_Freewave ThreadHandler](INFO): Thread cancelled. 2014-05-21T22:22:13.410Z,1400710933.410 [Radio_Freewave](INFO): Join timeout helper Thread ID is 922 2014-05-21T22:22:13.467Z,1400710933.467 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:13.795Z,1400710933.795 [Radio_Freewave ThreadHandler](INFO): Uninitializing protected caller thread. 2014-05-21T22:22:13.906Z,1400710933.906 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:13.924Z,1400710933.924 [Startup:StartupSatComms:A](INFO): Timed out from 2014-05-21T22:21:13.5Z 2014-05-21T22:22:13.924Z,1400710933.924 [Startup:StartupSatComms:A] Stopped 2014-05-21T22:22:13.924Z,1400710933.924 [Startup:StartupSatComms:B] Running Loop=1 2014-05-21T22:22:13.967Z,1400710933.967 [Radio_Freewave](INFO): Powering down 2014-05-21T22:22:14.325Z,1400710934.325 [HFRCMSpaceInterpolator](INFO): requested location (36.806965, -121.824326) is outside grid, returning zeros 2014-05-21T22:22:14.334Z,1400710934.334 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2014-05-21T22:22:14.372Z,1400710934.372 [Radio_Freewave ThreadHandler](INFO): Thread cancelled. 2014-05-21T22:22:14.383Z,1400710934.383 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2014-05-21T22:22:14.384Z,1400710934.384 [logger ThreadHandler](INFO): Thread cancelled. 2014-05-21T22:22:14.384Z,1400710934.384 [logger](INFO): Join timeout helper Thread ID is 924 2014-05-21T22:22:14.395Z,1400710934.395 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2014-05-21T22:22:14.396Z,1400710934.396 [logger ThreadHandler](INFO): Thread cancelled. 2014-05-21T22:22:14.404Z,1400710934.404 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2014-05-21T22:22:14.405Z,1400710934.405 [CommandLine ThreadHandler](INFO): Thread cancelled. 2014-05-21T22:22:14.405Z,1400710934.405 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2014-05-21T22:22:14.405Z,1400710934.405 [controlThread ThreadHandler](INFO): Thread cancelled. 2014-05-21T22:22:14.405Z,1400710934.405 [controlThread](INFO): Join timeout helper Thread ID is 925 2014-05-21T22:22:14.594Z,1400710934.594 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2014-05-21T22:22:14.594Z,1400710934.594 [controlThread](DEBUG): Uninitializing ControlThread 2014-05-21T22:22:14.594Z,1400710934.594 [AHRS_sp3003D](INFO): Powering down 2014-05-21T22:22:14.752Z,1400710934.752 [DVL_micro](INFO): uninitialize:Powering down 2014-05-21T22:22:14.753Z,1400710934.753 [NAL9602](INFO): Powering down 2014-05-21T22:22:14.756Z,1400710934.756 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2014-05-21T22:22:14.759Z,1400710934.759 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2014-05-21T22:22:14.763Z,1400710934.763 [Startup] Stopped 2014-05-21T22:22:14.763Z,1400710934.763 [Startup](INFO): Aggregate::uninitialize Startup 2014-05-21T22:22:14.763Z,1400710934.763 [Startup:A.GoToSurface] Stopped 2014-05-21T22:22:14.763Z,1400710934.763 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2014-05-21T22:22:14.763Z,1400710934.763 [Startup:StartupSatComms] Stopped 2014-05-21T22:22:14.763Z,1400710934.763 [Startup:StartupSatComms](INFO): Aggregate::uninitialize Startup:StartupSatComms 2014-05-21T22:22:14.763Z,1400710934.763 [Startup:StartupSatComms:B] Stopped 2014-05-21T22:22:14.765Z,1400710934.765 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2014-05-21T22:22:14.765Z,1400710934.765 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2014-05-21T22:22:14.766Z,1400710934.766 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2014-05-21T22:22:14.766Z,1400710934.766 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2014-05-21T22:22:14.766Z,1400710934.766 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2014-05-21T22:22:14.766Z,1400710934.766 [BuoyancyServo](INFO): Powering down 2014-05-21T22:22:14.780Z,1400710934.780 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2014-05-21T22:22:14.780Z,1400710934.780 [ElevatorServo](INFO): Powering down 2014-05-21T22:22:14.781Z,1400710934.781 [MassServo](DEBUG): Uninitialize Mass Servo. 2014-05-21T22:22:14.781Z,1400710934.781 [MassServo](INFO): Powering down 2014-05-21T22:22:14.782Z,1400710934.782 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2014-05-21T22:22:14.782Z,1400710934.782 [RudderServo](INFO): Powering down 2014-05-21T22:22:14.783Z,1400710934.783 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2014-05-21T22:22:14.783Z,1400710934.783 [ThrusterServo](INFO): Powering down 2014-05-21T22:22:14.784Z,1400710934.784 [SBIT](DEBUG): Uninitialize SBIT Component. 2014-05-21T22:22:14.784Z,1400710934.784 [IBIT](DEBUG): Uninitialize IBIT Component. 2014-05-21T22:22:14.785Z,1400710934.785 [CBIT](DEBUG): Uninitialize CBIT Component. 2014-05-21T22:22:14.829Z,1400710934.829 [controlThread ThreadHandler](INFO): Thread cancelled. 2014-05-21T22:22:14.834Z,1400710934.834 [Radio_Freewave ThreadHandler](INFO): Thread cancelled. 2014-05-21T22:22:14.906Z,1400710934.906 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2014-05-21T22:22:14.909Z,1400710934.909 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2014-05-21T22:22:14.956Z,1400710934.956 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2014-05-21T22:22:14.991Z,1400710934.991 [logger ThreadHandler](INFO): Thread cancelled.