2014-08-14T18:39:14.516Z,1408041554.516 [Supervisor](DEBUG): Initializing supervisor.
2014-08-14T18:39:14.518Z,1408041554.518 [SyncHandler](DEBUG): Created PCaller Thread at 4034C4E0
2014-08-14T18:39:14.519Z,1408041554.519 [SyncHandler](INFO): Protected caller Thread ID is 2406
2014-08-14T18:39:14.519Z,1408041554.519 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2014-08-14T18:39:14.520Z,1408041554.520 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4037C4E0
2014-08-14T18:39:14.521Z,1408041554.521 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 2407
2014-08-14T18:39:14.524Z,1408041554.524 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2014-08-14T18:39:14.535Z,1408041554.535 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2014-08-14T18:39:14.536Z,1408041554.536 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 403AC4E0
2014-08-14T18:39:14.536Z,1408041554.536 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 2408
2014-08-14T18:39:14.537Z,1408041554.537 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2014-08-14T18:39:14.538Z,1408041554.538 [logger ThreadHandler](DEBUG): Created PCaller Thread at 403DC4E0
2014-08-14T18:39:14.538Z,1408041554.538 [logger ThreadHandler](INFO): Protected caller Thread ID is 2409
2014-08-14T18:39:14.541Z,1408041554.541 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2014-08-14T18:39:14.541Z,1408041554.541 [Supervisor](INFO): Looking for Config files in directory: Config/
2014-08-14T18:39:14.542Z,1408041554.542 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2014-08-14T18:39:14.858Z,1408041554.858 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2014-08-14T18:39:14.859Z,1408041554.859 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2014-08-14T18:39:15.010Z,1408041555.010 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2014-08-14T18:39:15.011Z,1408041555.011 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2014-08-14T18:39:15.117Z,1408041555.117 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2014-08-14T18:39:15.118Z,1408041555.118 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2014-08-14T18:39:15.238Z,1408041555.238 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2014-08-14T18:39:15.239Z,1408041555.239 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2014-08-14T18:39:15.323Z,1408041555.323 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2014-08-14T18:39:15.494Z,1408041555.494 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2014-08-14T18:39:15.494Z,1408041555.494 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2014-08-14T18:39:15.579Z,1408041555.579 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2014-08-14T18:39:15.579Z,1408041555.579 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2014-08-14T18:39:15.755Z,1408041555.755 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2014-08-14T18:39:15.755Z,1408041555.755 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2014-08-14T18:39:16.038Z,1408041556.038 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2014-08-14T18:39:16.039Z,1408041556.039 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2014-08-14T18:39:16.340Z,1408041556.340 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2014-08-14T18:39:16.340Z,1408041556.340 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2014-08-14T18:39:16.826Z,1408041556.826 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2014-08-14T18:39:16.827Z,1408041556.827 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2014-08-14T18:39:17.010Z,1408041557.010 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2014-08-14T18:39:17.010Z,1408041557.010 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2014-08-14T18:39:17.112Z,1408041557.112 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2014-08-14T18:39:17.112Z,1408041557.112 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2014-08-14T18:39:17.501Z,1408041557.501 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2014-08-14T18:39:17.502Z,1408041557.502 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2014-08-14T18:39:17.610Z,1408041557.610 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2014-08-14T18:39:17.612Z,1408041557.612 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2014-08-14T18:39:17.613Z,1408041557.613 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2014-08-14T18:39:17.715Z,1408041557.715 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2014-08-14T18:39:17.830Z,1408041557.830 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2014-08-14T18:39:17.929Z,1408041557.929 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Estimation.cfg
2014-08-14T18:39:18.037Z,1408041558.037 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg
2014-08-14T18:39:18.132Z,1408041558.132 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2014-08-14T18:39:18.256Z,1408041558.256 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2014-08-14T18:39:18.398Z,1408041558.398 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2014-08-14T18:39:18.498Z,1408041558.498 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2014-08-14T18:39:18.582Z,1408041558.582 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/workSite.cfg
2014-08-14T18:39:18.663Z,1408041558.663 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg
2014-08-14T18:39:18.758Z,1408041558.758 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2014-08-14T18:39:18.866Z,1408041558.866 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2014-08-14T18:39:18.871Z,1408041558.871 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2014-08-14T18:39:18.920Z,1408041558.920 [VerticalControl](DEBUG): Construct VerticalControl.
2014-08-14T18:39:19.035Z,1408041559.035 [VerticalControl] Loaded
2014-08-14T18:39:19.035Z,1408041559.035 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2014-08-14T18:39:19.036Z,1408041559.036 [HorizontalControl](DEBUG): Construct HorizontalControl.
2014-08-14T18:39:19.105Z,1408041559.105 [HorizontalControl] Loaded
2014-08-14T18:39:19.105Z,1408041559.105 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2014-08-14T18:39:19.106Z,1408041559.106 [SpeedControl](DEBUG): Construct SpeedControl.
2014-08-14T18:39:19.111Z,1408041559.111 [SpeedControl] Loaded
2014-08-14T18:39:19.112Z,1408041559.112 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2014-08-14T18:39:19.112Z,1408041559.112 [LoopControl](DEBUG): Construct LoopControl.
2014-08-14T18:39:19.113Z,1408041559.113 [LoopControl] Loaded
2014-08-14T18:39:19.113Z,1408041559.113 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2014-08-14T18:39:19.113Z,1408041559.113 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2014-08-14T18:39:19.114Z,1408041559.114 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2014-08-14T18:39:19.209Z,1408041559.209 [SBIT](DEBUG): Construct Startup Built In Test.
2014-08-14T18:39:19.220Z,1408041559.220 [SBIT] Loaded
2014-08-14T18:39:19.220Z,1408041559.220 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2014-08-14T18:39:19.221Z,1408041559.221 [IBIT](DEBUG): Construct Initiated Built In Test.
2014-08-14T18:39:19.249Z,1408041559.249 [IBIT] Loaded
2014-08-14T18:39:19.249Z,1408041559.249 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2014-08-14T18:39:19.251Z,1408041559.251 [CBIT](DEBUG): Construct CBIT Built In Test.
2014-08-14T18:39:19.364Z,1408041559.364 [CBIT] Loaded
2014-08-14T18:39:19.365Z,1408041559.365 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2014-08-14T18:39:19.365Z,1408041559.365 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2014-08-14T18:39:19.366Z,1408041559.366 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2014-08-14T18:39:19.386Z,1408041559.386 [DepthRateCalculator] Loaded
2014-08-14T18:39:19.386Z,1408041559.386 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2014-08-14T18:39:19.391Z,1408041559.391 [PitchRateCalculator] Loaded
2014-08-14T18:39:19.392Z,1408041559.392 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2014-08-14T18:39:19.403Z,1408041559.403 [SpeedCalculator] Loaded
2014-08-14T18:39:19.403Z,1408041559.403 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2014-08-14T18:39:19.422Z,1408041559.422 [TempGradientCalculator] Loaded
2014-08-14T18:39:19.422Z,1408041559.422 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2014-08-14T18:39:19.433Z,1408041559.433 [YawRateCalculator] Loaded
2014-08-14T18:39:19.433Z,1408041559.433 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2014-08-14T18:39:19.435Z,1408041559.435 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2014-08-14T18:39:19.435Z,1408041559.435 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2014-08-14T18:39:23.405Z,1408041563.405 [HFRadarCompactModelForecaster] Loaded
2014-08-14T18:39:23.405Z,1408041563.405 [ComponentRegistry](DEBUG): SyncComponent "HFRadarCompactModelForecaster" handled in the control thread.
2014-08-14T18:39:24.784Z,1408041564.784 [HFRCMSpaceInterpolator] Loaded
2014-08-14T18:39:24.785Z,1408041564.785 [ComponentRegistry](DEBUG): SyncComponent "HFRCMSpaceInterpolator" handled in the control thread.
2014-08-14T18:39:24.787Z,1408041564.787 [HFRCMTimeInterpolator] Loaded
2014-08-14T18:39:24.787Z,1408041564.787 [ComponentRegistry](DEBUG): SyncComponent "HFRCMTimeInterpolator" handled in the control thread.
2014-08-14T18:39:25.821Z,1408041565.821 [HFRCMReconstructedInterpolator] Loaded
2014-08-14T18:39:25.821Z,1408041565.821 [ComponentRegistry](DEBUG): SyncComponent "HFRCMReconstructedInterpolator" handled in the control thread.
2014-08-14T18:39:25.833Z,1408041565.833 [HFRCMSurfaceCurrentAtVehicleLocation] Loaded
2014-08-14T18:39:25.833Z,1408041565.833 [ComponentRegistry](DEBUG): SyncComponent "HFRCMSurfaceCurrentAtVehicleLocation" handled in the control thread.
2014-08-14T18:39:25.833Z,1408041565.833 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2014-08-14T18:39:25.834Z,1408041565.834 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2014-08-14T18:39:26.055Z,1408041566.055 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2014-08-14T18:39:26.056Z,1408041566.056 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2014-08-14T18:39:26.134Z,1408041566.134 [DeadReckonUsingMultipleVelocitySources] Loaded
2014-08-14T18:39:26.134Z,1408041566.134 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2014-08-14T18:39:26.179Z,1408041566.179 [DeadReckonWithRespectToWater] Loaded
2014-08-14T18:39:26.179Z,1408041566.179 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToWater" handled in the control thread.
2014-08-14T18:39:26.224Z,1408041566.224 [DeadReckonWithRespectToSeafloor] Loaded
2014-08-14T18:39:26.224Z,1408041566.224 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2014-08-14T18:39:26.281Z,1408041566.281 [DeadReckonUsingDVLWaterTrack] Loaded
2014-08-14T18:39:26.282Z,1408041566.282 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingDVLWaterTrack" handled in the control thread.
2014-08-14T18:39:26.327Z,1408041566.327 [DeadReckonUsingCompactModelForecast] Loaded
2014-08-14T18:39:26.328Z,1408041566.328 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingCompactModelForecast" handled in the control thread.
2014-08-14T18:39:26.344Z,1408041566.344 [NavChart] Loaded
2014-08-14T18:39:26.344Z,1408041566.344 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2014-08-14T18:39:26.348Z,1408041566.348 [UniversalFixResidualReporter] Loaded
2014-08-14T18:39:26.349Z,1408041566.349 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2014-08-14T18:39:26.349Z,1408041566.349 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2014-08-14T18:39:26.350Z,1408041566.350 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2014-08-14T18:39:26.355Z,1408041566.355 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2014-08-14T18:39:26.356Z,1408041566.356 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2014-08-14T18:39:26.528Z,1408041566.528 [CTD_NeilBrown] Loaded
2014-08-14T18:39:26.528Z,1408041566.528 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2014-08-14T18:39:26.529Z,1408041566.529 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 406C34E0
2014-08-14T18:39:26.530Z,1408041566.530 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 2491
2014-08-14T18:39:26.544Z,1408041566.544 [PAR_Licor] Loaded
2014-08-14T18:39:26.544Z,1408041566.544 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2014-08-14T18:39:26.579Z,1408041566.579 [WetLabsBB2FL] Loaded
2014-08-14T18:39:26.579Z,1408041566.579 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2014-08-14T18:39:26.580Z,1408041566.580 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406F34E0
2014-08-14T18:39:26.580Z,1408041566.580 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 2492
2014-08-14T18:39:26.581Z,1408041566.581 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2014-08-14T18:39:26.581Z,1408041566.581 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2014-08-14T18:39:26.853Z,1408041566.853 [AHRS_sp3003D] Loaded
2014-08-14T18:39:26.854Z,1408041566.854 [ComponentRegistry](DEBUG): SyncComponent "AHRS_sp3003D" handled in the control thread.
2014-08-14T18:39:27.106Z,1408041567.106 [Batt_Ocean_Server] Loaded
2014-08-14T18:39:27.106Z,1408041567.106 [ComponentRegistry](DEBUG): SyncComponent "Batt_Ocean_Server" handled in the control thread.
2014-08-14T18:39:27.176Z,1408041567.176 [DataOverHttps] Loaded
2014-08-14T18:39:27.177Z,1408041567.177 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2014-08-14T18:39:27.190Z,1408041567.190 [Depth_Keller] Loaded
2014-08-14T18:39:27.190Z,1408041567.190 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2014-08-14T18:39:27.195Z,1408041567.195 [DropWeight] Loaded
2014-08-14T18:39:27.195Z,1408041567.195 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2014-08-14T18:39:27.327Z,1408041567.327 [DVL_micro] Loaded
2014-08-14T18:39:27.327Z,1408041567.327 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread.
2014-08-14T18:39:27.422Z,1408041567.422 [NAL9602] Loaded
2014-08-14T18:39:27.422Z,1408041567.422 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2014-08-14T18:39:27.463Z,1408041567.463 [Onboard] Loaded
2014-08-14T18:39:27.463Z,1408041567.463 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2014-08-14T18:39:27.470Z,1408041567.470 [Radio_Freewave] Loaded
2014-08-14T18:39:27.471Z,1408041567.471 [ComponentRegistry](DEBUG): Component "Radio_Freewave" handled in its own thread.
2014-08-14T18:39:27.472Z,1408041567.472 [Radio_Freewave ThreadHandler](DEBUG): Created PCaller Thread at 4092C4E0
2014-08-14T18:39:27.472Z,1408041567.472 [Radio_Freewave ThreadHandler](INFO): Protected caller Thread ID is 2493
2014-08-14T18:39:27.601Z,1408041567.601 [DAT] Loaded
2014-08-14T18:39:27.601Z,1408041567.601 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2014-08-14T18:39:27.607Z,1408041567.607 [SCPI] Loaded
2014-08-14T18:39:27.608Z,1408041567.608 [ComponentRegistry](DEBUG): SyncComponent "SCPI" handled in the control thread.
2014-08-14T18:39:27.609Z,1408041567.609 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2014-08-14T18:39:27.609Z,1408041567.609 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2014-08-14T18:39:27.704Z,1408041567.704 [BuoyancyServo] Loaded
2014-08-14T18:39:27.704Z,1408041567.704 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2014-08-14T18:39:27.716Z,1408041567.716 [ElevatorServo] Loaded
2014-08-14T18:39:27.716Z,1408041567.716 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2014-08-14T18:39:27.730Z,1408041567.730 [MassServo] Loaded
2014-08-14T18:39:27.731Z,1408041567.731 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2014-08-14T18:39:27.742Z,1408041567.742 [RudderServo] Loaded
2014-08-14T18:39:27.742Z,1408041567.742 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2014-08-14T18:39:27.753Z,1408041567.753 [ThrusterServo] Loaded
2014-08-14T18:39:27.754Z,1408041567.754 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2014-08-14T18:39:27.754Z,1408041567.754 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2014-08-14T18:39:27.755Z,1408041567.755 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2014-08-14T18:39:27.909Z,1408041567.909 [InternalSim] Loaded
2014-08-14T18:39:27.910Z,1408041567.910 [ComponentRegistry](DEBUG): SyncComponent "InternalSim" handled in the control thread.
2014-08-14T18:39:27.910Z,1408041567.910 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2014-08-14T18:39:27.911Z,1408041567.911 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2014-08-14T18:39:27.934Z,1408041567.934 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2014-08-14T18:39:27.936Z,1408041567.936 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2014-08-14T18:39:27.937Z,1408041567.937 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2014-08-14T18:39:27.943Z,1408041567.943 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2014-08-14T18:39:27.944Z,1408041567.944 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 409DD4E0
2014-08-14T18:39:27.945Z,1408041567.945 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 2494
2014-08-14T18:39:27.950Z,1408041567.950 [Supervisor](INFO): Main Thread ID is 2405
2014-08-14T18:39:27.950Z,1408041567.950 [Supervisor](DEBUG): Running supervisor.
2014-08-14T18:39:27.950Z,1408041567.950 [CommandLine ThreadHandler](INFO): Handler Thread ID is 2495
2014-08-14T18:39:27.953Z,1408041567.953 [controlThread ThreadHandler](INFO): Handler Thread ID is 2496
2014-08-14T18:39:27.954Z,1408041567.954 [controlThread](DEBUG): Initializing ControlThread
2014-08-14T18:39:27.955Z,1408041567.955 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2014-08-14T18:39:27.956Z,1408041567.956 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2014-08-14T18:39:27.957Z,1408041567.957 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2014-08-14T18:39:27.958Z,1408041567.958 [LoopControl](DEBUG): Initialize LoopControlComponent.
2014-08-14T18:39:27.958Z,1408041567.958 [SBIT](INFO): Initialize SBIT Component.
2014-08-14T18:39:27.958Z,1408041567.958 [SBIT](IMPORTANT): Tethys CM Info: SVN revision: 11510
2014-08-14T18:39:27.959Z,1408041567.959 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2014-08-14T18:39:27.959Z,1408041567.959 [SBIT](IMPORTANT): Kernel Version:#639 PREEMPT Wed Mar 12 12:53:33 PDT 2014
2014-08-14T18:39:27.960Z,1408041567.960 [IBIT](INFO): Initialize IBIT Component.
2014-08-14T18:39:27.960Z,1408041567.960 [CBIT](DEBUG): Initialize CBIT Component.
2014-08-14T18:39:27.961Z,1408041567.961 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2014-08-14T18:39:27.962Z,1408041567.962 [logger ThreadHandler](INFO): Handler Thread ID is 2497
2014-08-14T18:39:27.981Z,1408041567.981 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 2498
2014-08-14T18:39:27.981Z,1408041567.981 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown.
2014-08-14T18:39:27.984Z,1408041567.984 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2014-08-14T18:39:27.985Z,1408041567.985 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2014-08-14T18:39:27.985Z,1408041567.985 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2014-08-14T18:39:27.985Z,1408041567.985 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2014-08-14T18:39:27.986Z,1408041567.986 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2014-08-14T18:39:27.993Z,1408041567.993 [HFRadarCompactModelForecaster](DEBUG): Found new ECs!
2014-08-14T18:39:27.993Z,1408041567.993 [HFRadarCompactModelForecaster](ERROR): Most recent ECs are more than six hours old.
2014-08-14T18:39:28.005Z,1408041568.005 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2014-08-14T18:39:28.014Z,1408041568.014 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 2500
2014-08-14T18:39:28.015Z,1408041568.015 [WetLabsBB2FL](INFO): Powering down
2014-08-14T18:39:28.049Z,1408041568.049 [Radio_Freewave ThreadHandler](INFO): Handler Thread ID is 2501
2014-08-14T18:39:28.065Z,1408041568.065 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 2502
2014-08-14T18:39:28.067Z,1408041568.067 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources
2014-08-14T18:39:28.068Z,1408041568.068 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2014-08-14T18:39:28.069Z,1408041568.069 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2014-08-14T18:39:28.069Z,1408041568.069 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2014-08-14T18:39:28.069Z,1408041568.069 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2014-08-14T18:39:28.069Z,1408041568.069 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2014-08-14T18:39:28.070Z,1408041568.070 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2014-08-14T18:39:28.070Z,1408041568.070 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2014-08-14T18:39:28.070Z,1408041568.070 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2014-08-14T18:39:36.939Z,1408041576.939 [HFRadarCompactModelForecaster](IMPORTANT): forecast time 201408061400 published
2014-08-14T18:39:36.942Z,1408041576.942 [HFRCMSpaceInterpolator](DEBUG): Initializing HFRCMSpaceInterpolator component with verbosity level 0.
2014-08-14T18:39:36.943Z,1408041576.943 [HFRCMTimeInterpolator](DEBUG): Initializing HFRCMTimeInterpolator component.
2014-08-14T18:39:36.944Z,1408041576.944 [HFRCMReconstructedInterpolator](INFO): Initializing HFRCMReconstructedInterpolator component with velocityAccuracy_ = 0.300000 m/s.
2014-08-14T18:39:36.946Z,1408041576.946 [HFRCMSurfaceCurrentAtVehicleLocation](DEBUG): Initializing HFRCMSurfaceCurrentAtVehicleLocation component.
2014-08-14T18:39:36.958Z,1408041576.958 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2014-08-14T18:39:36.959Z,1408041576.959 [DeadReckonWithRespectToWater](DEBUG): Initializing DeadReckonWithRespectToWater component.
2014-08-14T18:39:36.959Z,1408041576.959 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component.
2014-08-14T18:39:36.959Z,1408041576.959 [DeadReckonUsingDVLWaterTrack](DEBUG): Initializing DeadReckonUsingDVLWaterTrack component.
2014-08-14T18:39:36.960Z,1408041576.960 [DeadReckonUsingCompactModelForecast](DEBUG): Initializing DeadReckonUsingCompactModelForecast component.
2014-08-14T18:39:36.960Z,1408041576.960 [NavChart](DEBUG): Initialize NavChart Navigation.
2014-08-14T18:39:36.961Z,1408041576.961 [UniversalFixResidualReporter](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2014-08-14T18:39:38.946Z,1408041578.946 [Batt_Ocean_Server](INFO): Ocean Server Batteries initialized
2014-08-14T18:39:38.978Z,1408041578.978 [InternalSim](DEBUG):  InternalSim initializing...
2014-08-14T18:39:39.070Z,1408041579.070 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2014-08-14T18:39:39.089Z,1408041579.089 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2014-08-14T18:39:39.134Z,1408041579.134 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://aosn.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://aosn.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://aosn.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://aosn.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://aosn.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

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

    <Aggregate Id="StartupSatComms">

        <Sequence/>

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

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

    </Aggregate>

</Mission>


2014-08-14T18:39:39.135Z,1408041579.135 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2014-08-14T18:39:39.185Z,1408041579.185 [Default:A.GoToSurface](DEBUG): Construct GoToSurface.
2014-08-14T18:39:39.210Z,1408041579.210 [Default:CheckIn:A.SetSpeed](DEBUG): Construct.
2014-08-14T18:39:39.240Z,1408041579.240 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2014-08-14T18:39:39.243Z,1408041579.243 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed](DEBUG): Construct.
2014-08-14T18:39:39.265Z,1408041579.265 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
xmlns:Control="Tethys/Control"
xmlns:Guidance="Tethys/Guidance" 
xmlns:Units="Tethys/Units"
xmlns:Universal="Tethys/Universal"
xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
xsi:schemaLocation="Tethys http://aosn.mbari.org/tethys/Xml/Tethys.xsd
Tethys/Control http://aosn.mbari.org/tethys/Xml/Control.xsd
Tethys/Guidance http://aosn.mbari.org/tethys/Xml/Guidance.xsd
Tethys/Units http://aosn.mbari.org/tethys/Xml/Units.xsd
Tethys/Universal http://aosn.mbari.org/tethys/Xml/Universal.xsd"
Id="Default">

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

    <Aggregate Id="CheckIn">

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

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

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

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

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

<!-- Do data comms -->

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

    </Aggregate>

    <Aggregate Id="WaitAtTheSurface">

        <Sequence/>

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

    </Aggregate>

</Mission>


2014-08-14T18:39:39.271Z,1408041579.271 [controlThread](DEBUG): Component order: CycleStarter,InternalSim,PAR_Licor,AHRS_sp3003D,Batt_Ocean_Server,DataOverHttps,Depth_Keller,DropWeight,DVL_micro,NAL9602,Onboard,DAT,SCPI,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,HFRadarCompactModelForecaster,HFRCMSpaceInterpolator,HFRCMTimeInterpolator,HFRCMReconstructedInterpolator,HFRCMSurfaceCurrentAtVehicleLocation,DeadReckonUsingMultipleVelocitySources,DeadReckonWithRespectToWater,DeadReckonWithRespectToSeafloor,DeadReckonUsingDVLWaterTrack,DeadReckonUsingCompactModelForecast,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2014-08-14T18:39:39.527Z,1408041579.527 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D.
2014-08-14T18:39:39.554Z,1408041579.554 [Radio_Freewave](INFO): Powering up
2014-08-14T18:39:39.718Z,1408041579.718 [DVL_micro](INFO): Initializing
2014-08-14T18:39:39.761Z,1408041579.761 [NAL9602](INFO): Powering up NAL9602
2014-08-14T18:39:39.823Z,1408041579.823 [DAT](INFO): Powering up
2014-08-14T18:39:39.823Z,1408041579.823 [DAT](DEBUG): Initializing DAT.
2014-08-14T18:39:40.360Z,1408041580.360 [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-08-14T18:39:46.991Z,1408041586.991 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:39:46.990Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:39:47.228Z,1408041587.228 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2014-08-14T18:39:47.234Z,1408041587.234 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2014-08-14T18:39:47.253Z,1408041587.253 [ElevatorServo](DEBUG): Initializing EZServoServo.
2014-08-14T18:39:47.264Z,1408041587.264 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2014-08-14T18:39:47.274Z,1408041587.274 [MassServo](DEBUG): Initializing EZServoServo.
2014-08-14T18:39:47.282Z,1408041587.282 [MassServo](DEBUG): Initializing MassServo.
2014-08-14T18:39:47.288Z,1408041587.288 [RudderServo](DEBUG): Initializing EZServoServo.
2014-08-14T18:39:47.294Z,1408041587.295 [RudderServo](DEBUG): Initializing RudderServo.
2014-08-14T18:39:47.300Z,1408041587.300 [ThrusterServo](DEBUG): Initializing EZServoServo.
2014-08-14T18:39:47.328Z,1408041587.328 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2014-08-14T18:39:48.030Z,1408041588.030 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:39:48.029Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:39:48.341Z,1408041588.341 [SBIT](IMPORTANT): Beginning Startup BIT
2014-08-14T18:39:48.344Z,1408041588.344 [CBIT](IMPORTANT): Beginning GF scan
2014-08-14T18:39:49.776Z,1408041589.776 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:39:49.775Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:39:50.385Z,1408041590.385 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:39:50.383Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:39:50.960Z,1408041590.960 [NAL9602](INFO): NAL9602 initialized
2014-08-14T18:39:50.995Z,1408041590.995 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:39:50.993Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:39:51.395Z,1408041591.395 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003406
2014-08-14T18:39:51.451Z,1408041591.451 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:39:51.450Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:39:52.336Z,1408041592.336 [DVL_micro](FAULT): LCB fault:  Software Overcurrent.
2014-08-14T18:39:52.336Z,1408041592.336 [DVL_micro] Hardware Fault, FailCount= 1
2014-08-14T18:39:52.337Z,1408041592.337 [DVL_micro](ERROR): Hardware Fault
2014-08-14T18:39:52.349Z,1408041592.349 [DVL_micro](INFO): uninitialize:Powering down
2014-08-14T18:39:52.545Z,1408041592.545 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:39:52.543Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:39:53.110Z,1408041593.110 [CBIT](ERROR): Hardware Fault in component: DVL_micro
2014-08-14T18:39:53.504Z,1408041593.504 [DVL_micro](INFO): uninitialize:Powering down
2014-08-14T18:39:53.572Z,1408041593.572 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:39:53.566Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:39:54.319Z,1408041594.319 [DVL_micro](FAULT): LCB fault:  Software Overcurrent.
2014-08-14T18:39:54.408Z,1408041594.408 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:39:54.406Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:39:55.025Z,1408041595.025 [DVL_micro](INFO): Initializing
2014-08-14T18:39:55.071Z,1408041595.071 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:39:55.065Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:39:55.175Z,1408041595.175 [CBIT](INFO): Clearing failed state for component DVL_micro
2014-08-14T18:39:55.175Z,1408041595.175 [DVL_micro] No Fault, FailCount= 1
2014-08-14T18:39:55.657Z,1408041595.657 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:39:55.642Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:39:56.091Z,1408041596.091 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:39:56.089Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:39:56.583Z,1408041596.583 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:39:56.581Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:39:57.068Z,1408041597.068 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:39:57.066Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:39:57.569Z,1408041597.569 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:39:57.567Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:39:58.066Z,1408041598.066 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:39:58.064Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:39:58.716Z,1408041598.716 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:39:58.715Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:39:59.319Z,1408041599.319 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:39:59.318Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:39:59.816Z,1408041599.816 [DVL_micro](FAULT): LCB fault:  Software Overcurrent.
2014-08-14T18:39:59.816Z,1408041599.816 [DVL_micro] Hardware Fault, FailCount= 2
2014-08-14T18:39:59.816Z,1408041599.816 [DVL_micro](ERROR): Hardware Fault
2014-08-14T18:39:59.817Z,1408041599.817 [DVL_micro](INFO): uninitialize:Powering down
2014-08-14T18:39:59.936Z,1408041599.936 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:39:59.935Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:39:59.991Z,1408041599.991 [CBIT](ERROR): Hardware Fault in component: DVL_micro
2014-08-14T18:40:00.409Z,1408041600.409 [DVL_micro](INFO): uninitialize:Powering down
2014-08-14T18:40:00.445Z,1408041600.445 [DAT](INFO): Powering down
2014-08-14T18:40:00.540Z,1408041600.540 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:00.534Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:00.961Z,1408041600.961 [DVL_micro](FAULT): LCB fault:  Software Overcurrent.
2014-08-14T18:40:01.024Z,1408041601.024 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:01.023Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:01.416Z,1408041601.416 [DVL_micro](INFO): Initializing
2014-08-14T18:40:01.446Z,1408041601.446 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:01.445Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:01.511Z,1408041601.511 [CBIT](INFO): Clearing failed state for component DVL_micro
2014-08-14T18:40:01.511Z,1408041601.511 [DVL_micro] No Fault, FailCount= 2
2014-08-14T18:40:02.056Z,1408041602.056 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:02.055Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:02.501Z,1408041602.501 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:02.499Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:02.949Z,1408041602.949 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:02.948Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:03.450Z,1408041603.450 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:03.449Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:03.951Z,1408041603.951 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:03.950Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:05.049Z,1408041605.049 [NAL9602](IMPORTANT): GPS fix at: 1408041602.00
2014-08-14T18:40:05.105Z,1408041605.105 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:05.103Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:05.677Z,1408041605.677 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:05.675Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:05.684Z,1408041605.684 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:05.682Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:05.685Z,1408041605.685 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:06.209Z,1408041606.209 [DVL_micro](FAULT): LCB fault:  Software Overcurrent.
2014-08-14T18:40:06.209Z,1408041606.209 [DVL_micro] Hardware Fault, FailCount= 3
2014-08-14T18:40:06.210Z,1408041606.210 [DVL_micro](ERROR): Hardware Fault
2014-08-14T18:40:06.210Z,1408041606.210 [DVL_micro](INFO): uninitialize:Powering down
2014-08-14T18:40:06.274Z,1408041606.274 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:06.273Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:06.277Z,1408041606.277 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:06.276Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:06.278Z,1408041606.278 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:06.424Z,1408041606.424 [CBIT](ERROR): Hardware Fault in component: DVL_micro
2014-08-14T18:40:06.794Z,1408041606.794 [DVL_micro](INFO): uninitialize:Powering down
2014-08-14T18:40:06.846Z,1408041606.846 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:06.845Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:06.865Z,1408041606.865 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:06.847Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:06.866Z,1408041606.866 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:07.339Z,1408041607.339 [DVL_micro](FAULT): LCB fault:  Software Overcurrent.
2014-08-14T18:40:07.395Z,1408041607.395 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:07.394Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:07.418Z,1408041607.418 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:07.396Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:07.418Z,1408041607.418 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:07.930Z,1408041607.930 [DVL_micro](INFO): Initializing
2014-08-14T18:40:07.988Z,1408041607.988 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:07.987Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:07.995Z,1408041607.995 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:07.989Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:07.995Z,1408041607.995 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:08.134Z,1408041608.134 [CBIT](INFO): Clearing failed state for component DVL_micro
2014-08-14T18:40:08.134Z,1408041608.134 [DVL_micro] No Fault, FailCount= 3
2014-08-14T18:40:08.587Z,1408041608.587 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:08.585Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:08.593Z,1408041608.593 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:08.592Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:08.594Z,1408041608.594 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:09.135Z,1408041609.135 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:09.133Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:09.141Z,1408041609.141 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:09.136Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:09.142Z,1408041609.142 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:09.746Z,1408041609.746 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:09.739Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:09.748Z,1408041609.748 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:09.747Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:09.753Z,1408041609.753 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:10.539Z,1408041610.539 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:10.538Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:10.551Z,1408041610.551 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:10.550Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:10.552Z,1408041610.552 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:11.169Z,1408041611.169 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:11.168Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:11.172Z,1408041611.172 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:11.170Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:11.172Z,1408041611.172 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:11.706Z,1408041611.706 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:11.705Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:11.713Z,1408041611.713 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:11.707Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:11.714Z,1408041611.714 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:12.203Z,1408041612.203 [DVL_micro](FAULT): LCB fault:  Software Overcurrent.
2014-08-14T18:40:12.203Z,1408041612.203 [DVL_micro] Hardware Fault, FailCount= 4
2014-08-14T18:40:12.203Z,1408041612.203 [DVL_micro](ERROR): Hardware Fault
2014-08-14T18:40:12.204Z,1408041612.204 [DVL_micro](INFO): uninitialize:Powering down
2014-08-14T18:40:12.283Z,1408041612.283 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:12.282Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:12.293Z,1408041612.293 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:12.284Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:12.294Z,1408041612.294 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:12.381Z,1408041612.381 [CBIT](ERROR): Hardware Fault in component: DVL_micro
2014-08-14T18:40:12.753Z,1408041612.753 [DVL_micro](INFO): uninitialize:Powering down
2014-08-14T18:40:12.754Z,1408041612.754 [NAL9602](INFO): Powering down
2014-08-14T18:40:12.782Z,1408041612.782 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:12.776Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:12.784Z,1408041612.784 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:12.783Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:12.785Z,1408041612.785 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:13.264Z,1408041613.264 [DVL_micro](FAULT): LCB fault:  Software Overcurrent.
2014-08-14T18:40:13.353Z,1408041613.353 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:13.351Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:13.363Z,1408041613.363 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:13.354Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:13.364Z,1408041613.364 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:13.822Z,1408041613.822 [DVL_micro](INFO): Initializing
2014-08-14T18:40:13.842Z,1408041613.842 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:13.841Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:13.848Z,1408041613.848 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:13.847Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:13.849Z,1408041613.849 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:13.956Z,1408041613.956 [CBIT](INFO): Clearing failed state for component DVL_micro
2014-08-14T18:40:13.956Z,1408041613.956 [DVL_micro] No Fault, FailCount= 4
2014-08-14T18:40:14.362Z,1408041614.362 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:14.361Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:14.365Z,1408041614.365 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:14.363Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:14.366Z,1408041614.366 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:14.961Z,1408041614.961 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:14.960Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:14.978Z,1408041614.978 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:14.977Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:14.979Z,1408041614.979 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:15.639Z,1408041615.639 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:15.617Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:15.641Z,1408041615.641 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:15.640Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:15.642Z,1408041615.642 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:15.731Z,1408041615.731 [CBIT](IMPORTANT): No ground fault detected
2014-08-14T18:40:16.149Z,1408041616.149 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:16.148Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:16.152Z,1408041616.152 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:16.150Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:16.152Z,1408041616.152 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:16.734Z,1408041616.734 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:16.733Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:16.736Z,1408041616.736 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:16.735Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:16.737Z,1408041616.737 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:17.235Z,1408041617.235 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:17.234Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:17.238Z,1408041617.238 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:17.236Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:17.238Z,1408041617.238 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:17.701Z,1408041617.701 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:17.699Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:17.707Z,1408041617.707 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:17.706Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:17.708Z,1408041617.708 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:18.212Z,1408041618.212 [DVL_micro](FAULT): LCB fault:  Software Overcurrent.
2014-08-14T18:40:18.212Z,1408041618.212 [DVL_micro] Hardware Fault, FailCount= 5
2014-08-14T18:40:18.212Z,1408041618.212 [DVL_micro](ERROR): Hardware Fault
2014-08-14T18:40:18.213Z,1408041618.213 [DVL_micro](INFO): uninitialize:Powering down
2014-08-14T18:40:18.292Z,1408041618.292 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:18.291Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:18.294Z,1408041618.294 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:18.293Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:18.295Z,1408041618.295 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:18.364Z,1408041618.364 [CBIT](ERROR): Hardware Fault in component: DVL_micro
2014-08-14T18:40:18.364Z,1408041618.364 [CBIT](CRITICAL): Hardware Fault in component: DVL_micro
2014-08-14T18:40:18.757Z,1408041618.757 [DVL_micro](INFO): uninitialize:Powering down
2014-08-14T18:40:18.803Z,1408041618.803 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:18.801Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:18.809Z,1408041618.809 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:18.808Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:18.810Z,1408041618.810 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:18.868Z,1408041618.868 [CommandLine](FAULT): Scheduling is paused
2014-08-14T18:40:19.245Z,1408041619.245 [DVL_micro](FAULT): LCB fault:  Software Overcurrent.
2014-08-14T18:40:19.315Z,1408041619.315 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:19.314Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:19.332Z,1408041619.332 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:19.316Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:19.332Z,1408041619.332 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:19.760Z,1408041619.760 [DVL_micro](INFO): Initializing
2014-08-14T18:40:19.822Z,1408041619.822 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:19.821Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:19.825Z,1408041619.825 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:19.823Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:19.825Z,1408041619.825 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:20.459Z,1408041620.459 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:20.457Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:20.461Z,1408041620.461 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:20.460Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:20.474Z,1408041620.474 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:20.952Z,1408041620.952 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:20.951Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:20.955Z,1408041620.955 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:20.953Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:20.955Z,1408041620.955 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:21.429Z,1408041621.429 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:21.428Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:21.432Z,1408041621.432 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:21.430Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:21.432Z,1408041621.432 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:21.922Z,1408041621.922 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:21.920Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:21.924Z,1408041621.924 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:21.922Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:21.925Z,1408041621.925 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:22.411Z,1408041622.411 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:22.410Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:22.418Z,1408041622.418 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:22.412Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:22.418Z,1408041622.418 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:22.910Z,1408041622.910 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:22.909Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:22.923Z,1408041622.923 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:22.921Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:22.923Z,1408041622.923 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:23.392Z,1408041623.392 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:23.390Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:23.405Z,1408041623.405 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:23.393Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:23.406Z,1408041623.406 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:23.877Z,1408041623.877 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:23.876Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:23.884Z,1408041623.884 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:23.878Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:23.885Z,1408041623.885 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:24.295Z,1408041624.295 [CommandLine](IMPORTANT): got command quit
2014-08-14T18:40:24.442Z,1408041624.442 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:24.440Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:24.444Z,1408041624.444 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:24.442Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:24.444Z,1408041624.444 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:24.931Z,1408041624.931 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:24.929Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:24.937Z,1408041624.937 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:24.932Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:24.938Z,1408041624.938 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:25.300Z,1408041625.300 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2014-08-14T18:40:25.300Z,1408041625.300 [CommandLine ThreadHandler](INFO): Thread cancelled.
2014-08-14T18:40:25.461Z,1408041625.461 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2014-08-14T18:40:25.461Z,1408041625.461 [CommandLine ThreadHandler](INFO): Thread cancelled.
2014-08-14T18:40:25.462Z,1408041625.462 [CommandLine](INFO): Join timeout helper Thread ID is 2539
2014-08-14T18:40:25.465Z,1408041625.465 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2014-08-14T18:40:25.465Z,1408041625.465 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2014-08-14T18:40:25.466Z,1408041625.466 [NavChartDb](INFO): Join timeout helper Thread ID is 2540
2014-08-14T18:40:25.548Z,1408041625.548 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:25.546Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:25.550Z,1408041625.550 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:25.549Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:25.551Z,1408041625.551 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:25.694Z,1408041625.694 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2014-08-14T18:40:25.694Z,1408041625.694 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2014-08-14T18:40:25.710Z,1408041625.710 [ComponentRegistry](INFO): Shutting down Radio_Freewave ThreadHandler
2014-08-14T18:40:25.710Z,1408041625.710 [Radio_Freewave ThreadHandler](INFO): Thread cancelled.
2014-08-14T18:40:25.710Z,1408041625.710 [Radio_Freewave](INFO): Join timeout helper Thread ID is 2541
2014-08-14T18:40:25.946Z,1408041625.946 [Radio_Freewave ThreadHandler](INFO): Uninitializing protected caller thread.
2014-08-14T18:40:26.039Z,1408041626.039 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:26.037Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:26.041Z,1408041626.041 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:26.040Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:26.042Z,1408041626.042 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:26.145Z,1408041626.145 [Radio_Freewave](INFO): Powering down
2014-08-14T18:40:26.521Z,1408041626.521 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:26.520Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:26.524Z,1408041626.524 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:26.522Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:26.524Z,1408041626.524 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:26.547Z,1408041626.547 [Radio_Freewave ThreadHandler](INFO): Thread cancelled.
2014-08-14T18:40:26.563Z,1408041626.563 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2014-08-14T18:40:26.563Z,1408041626.563 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2014-08-14T18:40:26.563Z,1408041626.563 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 2543
2014-08-14T18:40:26.747Z,1408041626.747 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2014-08-14T18:40:26.748Z,1408041626.748 [WetLabsBB2FL](INFO): Powering down
2014-08-14T18:40:26.748Z,1408041626.748 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2014-08-14T18:40:26.751Z,1408041626.751 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2014-08-14T18:40:26.751Z,1408041626.751 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2014-08-14T18:40:26.752Z,1408041626.752 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 2544
2014-08-14T18:40:26.868Z,1408041626.868 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2014-08-14T18:40:26.868Z,1408041626.868 [CTD_NeilBrown](INFO): Powering down
2014-08-14T18:40:26.869Z,1408041626.869 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2014-08-14T18:40:26.873Z,1408041626.873 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2014-08-14T18:40:26.873Z,1408041626.873 [logger ThreadHandler](INFO): Thread cancelled.
2014-08-14T18:40:26.873Z,1408041626.873 [logger](INFO): Join timeout helper Thread ID is 2545
2014-08-14T18:40:26.904Z,1408041626.904 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2014-08-14T18:40:26.904Z,1408041626.904 [logger ThreadHandler](INFO): Thread cancelled.
2014-08-14T18:40:26.912Z,1408041626.912 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2014-08-14T18:40:26.913Z,1408041626.913 [CommandLine ThreadHandler](INFO): Thread cancelled.
2014-08-14T18:40:26.913Z,1408041626.913 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2014-08-14T18:40:26.913Z,1408041626.913 [controlThread ThreadHandler](INFO): Thread cancelled.
2014-08-14T18:40:26.913Z,1408041626.913 [controlThread](INFO): Join timeout helper Thread ID is 2546
2014-08-14T18:40:26.941Z,1408041626.941 [HFRCMReconstructedInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:26.940Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:26.944Z,1408041626.944 [HFRCMTimeInterpolator](DEBUG): Query for interpolated value 2014-08-14T18:40:26.942Z outside the range of the data. [2014-08-04T14:00:00.000Z, 2014-08-07T02:00:00.000Z]
2014-08-14T18:40:26.945Z,1408041626.945 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802017, -121.787186) is outside the bounding box
2014-08-14T18:40:26.966Z,1408041626.966 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2014-08-14T18:40:26.966Z,1408041626.966 [controlThread](DEBUG): Uninitializing ControlThread
2014-08-14T18:40:26.967Z,1408041626.967 [AHRS_sp3003D](INFO): Powering down
2014-08-14T18:40:26.968Z,1408041626.968 [DVL_micro](INFO): uninitialize:Powering down
2014-08-14T18:40:26.969Z,1408041626.969 [NAL9602](INFO): Powering down
2014-08-14T18:40:26.970Z,1408041626.970 [DAT](INFO): Powering down
2014-08-14T18:40:26.972Z,1408041626.972 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2014-08-14T18:40:26.974Z,1408041626.974 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2014-08-14T18:40:26.978Z,1408041626.978 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2014-08-14T18:40:26.979Z,1408041626.979 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2014-08-14T18:40:26.979Z,1408041626.979 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2014-08-14T18:40:26.979Z,1408041626.979 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2014-08-14T18:40:26.980Z,1408041626.980 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2014-08-14T18:40:26.980Z,1408041626.980 [BuoyancyServo](INFO): Powering down
2014-08-14T18:40:26.992Z,1408041626.992 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2014-08-14T18:40:26.992Z,1408041626.992 [ElevatorServo](INFO): Powering down
2014-08-14T18:40:26.993Z,1408041626.993 [MassServo](DEBUG): Uninitialize Mass Servo.
2014-08-14T18:40:26.993Z,1408041626.993 [MassServo](INFO): Powering down
2014-08-14T18:40:26.994Z,1408041626.994 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2014-08-14T18:40:26.994Z,1408041626.994 [RudderServo](INFO): Powering down
2014-08-14T18:40:26.994Z,1408041626.994 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2014-08-14T18:40:26.995Z,1408041626.995 [ThrusterServo](INFO): Powering down
2014-08-14T18:40:26.995Z,1408041626.995 [SBIT](DEBUG): Uninitialize SBIT Component.
2014-08-14T18:40:26.996Z,1408041626.996 [IBIT](DEBUG): Uninitialize IBIT Component.
2014-08-14T18:40:26.996Z,1408041626.996 [CBIT](DEBUG): Uninitialize CBIT Component.
2014-08-14T18:40:27.042Z,1408041627.042 [controlThread ThreadHandler](INFO): Thread cancelled.
2014-08-14T18:40:27.113Z,1408041627.113 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2014-08-14T18:40:27.116Z,1408041627.116 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2014-08-14T18:40:27.125Z,1408041627.125 [Radio_Freewave ThreadHandler](INFO): Thread cancelled.
2014-08-14T18:40:27.182Z,1408041627.182 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2014-08-14T18:40:27.219Z,1408041627.219 [logger ThreadHandler](INFO): Thread cancelled.