2014-02-25T00:52:17.117Z,1393289537.117 [Supervisor](DEBUG): Initializing supervisor.
2014-02-25T00:52:17.120Z,1393289537.120 [SyncHandler](DEBUG): Created PCaller Thread at 4033B4E0
2014-02-25T00:52:17.121Z,1393289537.121 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2014-02-25T00:52:17.122Z,1393289537.122 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4036B4E0
2014-02-25T00:52:17.125Z,1393289537.125 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2014-02-25T00:52:17.138Z,1393289537.138 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2014-02-25T00:52:17.139Z,1393289537.139 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 4039B4E0
2014-02-25T00:52:17.140Z,1393289537.140 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2014-02-25T00:52:17.141Z,1393289537.141 [logger ThreadHandler](DEBUG): Created PCaller Thread at 403CB4E0
2014-02-25T00:52:17.143Z,1393289537.143 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2014-02-25T00:52:17.144Z,1393289537.144 [Supervisor](INFO): Looking for Config files in directory: Config/
2014-02-25T00:52:17.145Z,1393289537.145 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2014-02-25T00:52:17.442Z,1393289537.442 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2014-02-25T00:52:17.443Z,1393289537.443 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2014-02-25T00:52:17.719Z,1393289537.719 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2014-02-25T00:52:17.719Z,1393289537.719 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2014-02-25T00:52:17.822Z,1393289537.822 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2014-02-25T00:52:17.823Z,1393289537.823 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2014-02-25T00:52:17.935Z,1393289537.935 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2014-02-25T00:52:17.935Z,1393289537.935 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2014-02-25T00:52:18.078Z,1393289538.078 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2014-02-25T00:52:18.079Z,1393289538.079 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2014-02-25T00:52:18.339Z,1393289538.339 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2014-02-25T00:52:18.340Z,1393289538.340 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2014-02-25T00:52:18.511Z,1393289538.511 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2014-02-25T00:52:18.511Z,1393289538.511 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2014-02-25T00:52:18.856Z,1393289538.856 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2014-02-25T00:52:18.857Z,1393289538.857 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2014-02-25T00:52:18.977Z,1393289538.977 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2014-02-25T00:52:18.978Z,1393289538.978 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2014-02-25T00:52:19.434Z,1393289539.434 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2014-02-25T00:52:19.435Z,1393289539.435 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2014-02-25T00:52:19.540Z,1393289539.540 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2014-02-25T00:52:19.541Z,1393289539.541 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2014-02-25T00:52:19.632Z,1393289539.632 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2014-02-25T00:52:19.738Z,1393289539.738 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2014-02-25T00:52:19.739Z,1393289539.739 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2014-02-25T00:52:19.844Z,1393289539.844 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2014-02-25T00:52:19.844Z,1393289539.844 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2014-02-25T00:52:19.939Z,1393289539.939 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2014-02-25T00:52:19.941Z,1393289539.941 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2014-02-25T00:52:19.942Z,1393289539.942 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2014-02-25T00:52:20.078Z,1393289540.078 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2014-02-25T00:52:20.229Z,1393289540.229 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg
2014-02-25T00:52:20.322Z,1393289540.322 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2014-02-25T00:52:20.418Z,1393289540.418 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2014-02-25T00:52:20.551Z,1393289540.551 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2014-02-25T00:52:20.656Z,1393289540.656 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2014-02-25T00:52:20.742Z,1393289540.742 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2014-02-25T00:52:20.838Z,1393289540.838 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2014-02-25T00:52:20.937Z,1393289540.937 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/LOGIN/
2014-02-25T00:52:20.937Z,1393289540.937 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2014-02-25T00:52:20.939Z,1393289540.939 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2014-02-25T00:52:21.506Z,1393289541.506 [Batt_Ocean_Server] Loaded
2014-02-25T00:52:21.506Z,1393289541.506 [ComponentRegistry](DEBUG): SyncComponent "Batt_Ocean_Server" handled in the control thread.
2014-02-25T00:52:21.583Z,1393289541.583 [DataOverHttps] Loaded
2014-02-25T00:52:21.584Z,1393289541.584 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2014-02-25T00:52:21.669Z,1393289541.669 [Depth_Keller] Loaded
2014-02-25T00:52:21.669Z,1393289541.669 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2014-02-25T00:52:21.674Z,1393289541.674 [DropWeight] Loaded
2014-02-25T00:52:21.675Z,1393289541.675 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2014-02-25T00:52:21.778Z,1393289541.778 [NAL9602] Loaded
2014-02-25T00:52:21.778Z,1393289541.778 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2014-02-25T00:52:21.833Z,1393289541.833 [Onboard] Loaded
2014-02-25T00:52:21.833Z,1393289541.833 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2014-02-25T00:52:21.841Z,1393289541.841 [Radio_Freewave] Loaded
2014-02-25T00:52:21.841Z,1393289541.841 [ComponentRegistry](DEBUG): SyncComponent "Radio_Freewave" handled in the control thread.
2014-02-25T00:52:21.842Z,1393289541.842 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2014-02-25T00:52:21.842Z,1393289541.842 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2014-02-25T00:52:22.015Z,1393289542.015 [InternalSim] Loaded
2014-02-25T00:52:22.015Z,1393289542.015 [ComponentRegistry](DEBUG): SyncComponent "InternalSim" handled in the control thread.
2014-02-25T00:52:22.016Z,1393289542.016 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2014-02-25T00:52:22.016Z,1393289542.016 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2014-02-25T00:52:22.324Z,1393289542.324 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2014-02-25T00:52:22.324Z,1393289542.324 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2014-02-25T00:52:22.331Z,1393289542.331 [AsyncPiEstimator](DEBUG): Construct AsyncPiEstimator.
2014-02-25T00:52:22.336Z,1393289542.336 [AsyncPiEstimator] Loaded
2014-02-25T00:52:22.336Z,1393289542.336 [ComponentRegistry](DEBUG): Component "AsyncPiEstimator" handled in its own thread.
2014-02-25T00:52:22.337Z,1393289542.337 [AsyncPiEstimator ThreadHandler](DEBUG): Created PCaller Thread at 406854E0
2014-02-25T00:52:22.338Z,1393289542.338 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2014-02-25T00:52:22.339Z,1393289542.339 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2014-02-25T00:52:22.388Z,1393289542.388 [DeadReckonUsingMultipleVelocitySources] Loaded
2014-02-25T00:52:22.388Z,1393289542.388 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2014-02-25T00:52:22.407Z,1393289542.407 [DeadReckonWithRespectToWater] Loaded
2014-02-25T00:52:22.407Z,1393289542.407 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToWater" handled in the control thread.
2014-02-25T00:52:22.447Z,1393289542.447 [DeadReckonWithRespectToSeafloor] Loaded
2014-02-25T00:52:22.447Z,1393289542.447 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2014-02-25T00:52:22.479Z,1393289542.479 [DeadReckonUsingDVLWaterTrack] Loaded
2014-02-25T00:52:22.480Z,1393289542.480 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingDVLWaterTrack" handled in the control thread.
2014-02-25T00:52:22.498Z,1393289542.498 [NavChart] Loaded
2014-02-25T00:52:22.498Z,1393289542.498 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2014-02-25T00:52:22.498Z,1393289542.498 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2014-02-25T00:52:22.499Z,1393289542.499 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2014-02-25T00:52:22.550Z,1393289542.550 [VerticalControl](DEBUG): Construct VerticalControl.
2014-02-25T00:52:22.701Z,1393289542.701 [VerticalControl] Loaded
2014-02-25T00:52:22.701Z,1393289542.701 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2014-02-25T00:52:22.703Z,1393289542.703 [HorizontalControl](DEBUG): Construct HorizontalControl.
2014-02-25T00:52:22.790Z,1393289542.790 [HorizontalControl] Loaded
2014-02-25T00:52:22.790Z,1393289542.790 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2014-02-25T00:52:22.791Z,1393289542.791 [SpeedControl](DEBUG): Construct SpeedControl.
2014-02-25T00:52:22.793Z,1393289542.793 [SpeedControl] Loaded
2014-02-25T00:52:22.793Z,1393289542.793 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2014-02-25T00:52:22.794Z,1393289542.794 [LoopControl](DEBUG): Construct LoopControl.
2014-02-25T00:52:22.794Z,1393289542.794 [LoopControl] Loaded
2014-02-25T00:52:22.795Z,1393289542.795 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2014-02-25T00:52:22.795Z,1393289542.795 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2014-02-25T00:52:22.796Z,1393289542.796 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2014-02-25T00:52:22.815Z,1393289542.815 [DepthRateCalculator] Loaded
2014-02-25T00:52:22.815Z,1393289542.815 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2014-02-25T00:52:22.821Z,1393289542.821 [PitchRateCalculator] Loaded
2014-02-25T00:52:22.821Z,1393289542.821 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2014-02-25T00:52:22.828Z,1393289542.828 [SpeedCalculator] Loaded
2014-02-25T00:52:22.828Z,1393289542.828 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2014-02-25T00:52:22.846Z,1393289542.846 [TempGradientCalculator] Loaded
2014-02-25T00:52:22.846Z,1393289542.846 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2014-02-25T00:52:22.852Z,1393289542.852 [YawRateCalculator] Loaded
2014-02-25T00:52:22.852Z,1393289542.852 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2014-02-25T00:52:22.853Z,1393289542.853 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2014-02-25T00:52:22.853Z,1393289542.853 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2014-02-25T00:52:22.964Z,1393289542.964 [CTD_NeilBrown] Loaded
2014-02-25T00:52:22.965Z,1393289542.965 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2014-02-25T00:52:22.966Z,1393289542.966 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 407244E0
2014-02-25T00:52:22.982Z,1393289542.982 [PAR_Licor] Loaded
2014-02-25T00:52:22.983Z,1393289542.983 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2014-02-25T00:52:23.020Z,1393289543.020 [WetLabsBB2FL] Loaded
2014-02-25T00:52:23.020Z,1393289543.020 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2014-02-25T00:52:23.021Z,1393289543.021 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 407544E0
2014-02-25T00:52:23.022Z,1393289543.022 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2014-02-25T00:52:23.023Z,1393289543.023 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2014-02-25T00:52:23.125Z,1393289543.125 [SBIT](DEBUG): Construct Startup Built In Test.
2014-02-25T00:52:23.138Z,1393289543.138 [SBIT] Loaded
2014-02-25T00:52:23.138Z,1393289543.138 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2014-02-25T00:52:23.139Z,1393289543.139 [IBIT](DEBUG): Construct Initiated Built In Test.
2014-02-25T00:52:23.152Z,1393289543.152 [IBIT] Loaded
2014-02-25T00:52:23.153Z,1393289543.153 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2014-02-25T00:52:23.155Z,1393289543.155 [CBIT](DEBUG): Construct CBIT Built In Test.
2014-02-25T00:52:23.229Z,1393289543.229 [CBIT] Loaded
2014-02-25T00:52:23.229Z,1393289543.229 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2014-02-25T00:52:23.230Z,1393289543.230 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2014-02-25T00:52:23.230Z,1393289543.230 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2014-02-25T00:52:25.869Z,1393289545.869 [HFRadarModelCalc] Loaded
2014-02-25T00:52:25.869Z,1393289545.869 [ComponentRegistry](DEBUG): SyncComponent "HFRadarModelCalc" handled in the control thread.
2014-02-25T00:52:28.037Z,1393289548.037 [HFRadarCompactModelForecaster] Loaded
2014-02-25T00:52:28.038Z,1393289548.038 [ComponentRegistry](DEBUG): SyncComponent "HFRadarCompactModelForecaster" handled in the control thread.
2014-02-25T00:52:28.628Z,1393289548.628 [HFRCMSpaceInterpolator] Loaded
2014-02-25T00:52:28.629Z,1393289548.629 [ComponentRegistry](DEBUG): SyncComponent "HFRCMSpaceInterpolator" handled in the control thread.
2014-02-25T00:52:28.643Z,1393289548.643 [HFRCMSurfaceCurrentAtVehicleLocation] Loaded
2014-02-25T00:52:28.643Z,1393289548.643 [ComponentRegistry](DEBUG): SyncComponent "HFRCMSurfaceCurrentAtVehicleLocation" handled in the control thread.
2014-02-25T00:52:28.644Z,1393289548.644 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2014-02-25T00:52:28.644Z,1393289548.644 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2014-02-25T00:52:28.750Z,1393289548.750 [BuoyancyServo] Loaded
2014-02-25T00:52:28.751Z,1393289548.751 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2014-02-25T00:52:28.764Z,1393289548.764 [ElevatorServo] Loaded
2014-02-25T00:52:28.764Z,1393289548.764 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2014-02-25T00:52:28.777Z,1393289548.777 [RudderServo] Loaded
2014-02-25T00:52:28.777Z,1393289548.777 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2014-02-25T00:52:28.790Z,1393289548.790 [ThrusterServo] Loaded
2014-02-25T00:52:28.790Z,1393289548.790 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2014-02-25T00:52:28.790Z,1393289548.790 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2014-02-25T00:52:28.791Z,1393289548.791 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2014-02-25T00:52:28.816Z,1393289548.816 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2014-02-25T00:52:28.818Z,1393289548.818 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2014-02-25T00:52:28.819Z,1393289548.819 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2014-02-25T00:52:28.826Z,1393289548.826 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2014-02-25T00:52:28.827Z,1393289548.827 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A0A4E0
2014-02-25T00:52:28.831Z,1393289548.831 [Supervisor](DEBUG): Running supervisor.
2014-02-25T00:52:28.832Z,1393289548.832 [CommandLine](INFO): Thread ID is 7783
2014-02-25T00:52:28.835Z,1393289548.835 [controlThread](INFO): Thread ID is 7782
2014-02-25T00:52:28.835Z,1393289548.835 [controlThread](DEBUG): Initializing ControlThread
2014-02-25T00:52:28.836Z,1393289548.836 [CycleStarter](INFO): Thread ID is 7781
2014-02-25T00:52:28.838Z,1393289548.838 [logger](INFO): Thread ID is 7784
2014-02-25T00:52:28.852Z,1393289548.852 [AsyncPiEstimator](INFO): Thread ID is 7874
2014-02-25T00:52:28.852Z,1393289548.852 [AsyncPiEstimator](DEBUG): Initialize AsyncPiEstimator.
2014-02-25T00:52:28.876Z,1393289548.876 [CTD_NeilBrown](INFO): Thread ID is 7879
2014-02-25T00:52:28.876Z,1393289548.876 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown.
2014-02-25T00:52:28.880Z,1393289548.880 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2014-02-25T00:52:28.896Z,1393289548.896 [WetLabsBB2FL](INFO): Thread ID is 7880
2014-02-25T00:52:28.897Z,1393289548.897 [WetLabsBB2FL](INFO): Powering down
2014-02-25T00:52:28.912Z,1393289548.912 [NavChartDb](INFO): Thread ID is 7901
2014-02-25T00:52:28.915Z,1393289548.915 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources
2014-02-25T00:52:28.916Z,1393289548.916 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2014-02-25T00:52:28.916Z,1393289548.916 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2014-02-25T00:52:28.916Z,1393289548.916 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2014-02-25T00:52:28.917Z,1393289548.917 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2014-02-25T00:52:28.917Z,1393289548.917 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2014-02-25T00:52:28.917Z,1393289548.917 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2014-02-25T00:52:28.917Z,1393289548.917 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2014-02-25T00:52:28.918Z,1393289548.918 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2014-02-25T00:52:30.729Z,1393289550.729 [Batt_Ocean_Server](INFO): Ocean Server Batteries initialized
2014-02-25T00:52:30.781Z,1393289550.781 [InternalSim](DEBUG):  InternalSim initializing...
2014-02-25T00:52:30.925Z,1393289550.925 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2014-02-25T00:52:30.925Z,1393289550.925 [DeadReckonWithRespectToWater](DEBUG): Initializing DeadReckonWithRespectToWater component.
2014-02-25T00:52:30.926Z,1393289550.926 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component.
2014-02-25T00:52:30.926Z,1393289550.926 [DeadReckonUsingDVLWaterTrack](DEBUG): Initializing DeadReckonUsingDVLWaterTrack component.
2014-02-25T00:52:30.927Z,1393289550.927 [NavChart](DEBUG): Initialize NavChart Navigation.
2014-02-25T00:52:30.927Z,1393289550.927 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2014-02-25T00:52:30.929Z,1393289550.929 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2014-02-25T00:52:30.930Z,1393289550.930 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2014-02-25T00:52:30.930Z,1393289550.930 [LoopControl](DEBUG): Initialize LoopControlComponent.
2014-02-25T00:52:30.935Z,1393289550.935 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2014-02-25T00:52:30.935Z,1393289550.935 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2014-02-25T00:52:30.935Z,1393289550.935 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2014-02-25T00:52:30.936Z,1393289550.936 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2014-02-25T00:52:30.936Z,1393289550.936 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2014-02-25T00:52:30.938Z,1393289550.938 [SBIT](INFO): Initialize SBIT Component.
2014-02-25T00:52:30.950Z,1393289550.950 [SBIT](IMPORTANT): Tethys CM Info: 
 $Rev:11010
2014-02-25T00:52:30.951Z,1393289550.951 [SBIT](IMPORTANT): Kernel Release:2.6.27.8
2014-02-25T00:52:30.951Z,1393289550.951 [SBIT](IMPORTANT): Kernel Version:#639 PREEMPT Wed Dec 4 13:20:24 PST 2013
2014-02-25T00:52:30.952Z,1393289550.952 [IBIT](INFO): Initialize IBIT Component.
2014-02-25T00:52:30.953Z,1393289550.953 [CBIT](DEBUG): Initialize CBIT Component.
2014-02-25T00:52:30.953Z,1393289550.953 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2014-02-25T00:52:30.979Z,1393289550.979 [HFRCMSpaceInterpolator](DEBUG): Initializing HFRCMSpaceInterpolator component.
2014-02-25T00:52:30.981Z,1393289550.981 [HFRCMSurfaceCurrentAtVehicleLocation](DEBUG): Initializing HFRCMSurfaceCurrentAtVehicleLocation component.
2014-02-25T00:52:30.987Z,1393289550.987 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2014-02-25T00:52:30.997Z,1393289550.997 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2014-02-25T00:52:31.047Z,1393289551.047 [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-02-25T00:52:31.048Z,1393289551.048 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2014-02-25T00:52:31.132Z,1393289551.132 [MissionManager](INFO): DefineArg Default.NeedGPS = 1 bool
2014-02-25T00:52:31.134Z,1393289551.134 [Default:GPS:A.SetSpeed](DEBUG): Construct.
2014-02-25T00:52:31.138Z,1393289551.138 [Default:GPS:B.GoToSurface](DEBUG): Construct GoToSurface.
2014-02-25T00:52:31.223Z,1393289551.223 [Default:Iridium:A.SetSpeed](DEBUG): Construct.
2014-02-25T00:52:31.226Z,1393289551.226 [Default:Iridium:B.GoToSurface](DEBUG): Construct GoToSurface.
2014-02-25T00:52:31.233Z,1393289551.233 [Default:Iridium:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2014-02-25T00:52:31.283Z,1393289551.283 [Default:WaitAtTheSurface:RunAtLowSpeed.SetSpeed](DEBUG): Construct.
2014-02-25T00:52:31.297Z,1393289551.297 [Default:WaitAtTheSurface:B.GoToSurface](DEBUG): Construct GoToSurface.
2014-02-25T00:52:31.306Z,1393289551.306 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
xmlns:Control="Tethys/Control"
xmlns:Guidance="Tethys/Guidance" 
xmlns:Units="Tethys/Units"
xmlns:Universal="Tethys/Universal"
xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
xsi:schemaLocation="Tethys http://aosn.mbari.org/tethys/Xml/Tethys.xsd
Tethys/Control http://aosn.mbari.org/tethys/Xml/Control.xsd
Tethys/Guidance http://aosn.mbari.org/tethys/Xml/Guidance.xsd
Tethys/Units http://aosn.mbari.org/tethys/Xml/Units.xsd
Tethys/Universal http://aosn.mbari.org/tethys/Xml/Universal.xsd"
Id="Default">

    <DefineArg Name="NeedGPS"><True/></DefineArg>

    <Aggregate Id="GPS">

        <When>
            <Arg Name="NeedGPS"/>
        </When>

<!-- Run at high speed -->

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

<!-- Get to the surface -->

        <Guidance:GoToSurface>
            <Sequence/>
        </Guidance:GoToSurface>

<!-- Get GPS fix -->

        <ReadDatum Id="Read_GPS">
            <Universal:latitude_fix/>
        </ReadDatum>

        <Assign><Sequence/><Arg Name="NeedGPS"/><False/></Assign>

    </Aggregate>

    <Aggregate Id="Iridium">

        <Sequence/>

<!-- Run at high speed -->

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

<!-- Get to the surface -->

        <Guidance:GoToSurface>
            <Sequence/>
        </Guidance:GoToSurface>

<!-- 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="CallIridium">

        <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>

        <Assign><Sequence/><Arg Name="NeedGPS"/><True/></Assign>

        <Call RefId="Iridium"/>

    </Aggregate>

    <Aggregate Id="WaitAtTheSurface">

        <Sequence/>

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

        <Guidance:GoToSurface>
            <Parallel/>
        </Guidance:GoToSurface>

    </Aggregate>

</Mission>


2014-02-25T00:52:31.324Z,1393289551.324 [controlThread](DEBUG): Component order: CycleStarter,InternalSim,Batt_Ocean_Server,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,Radio_Freewave,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,HFRadarModelCalc,HFRadarCompactModelForecaster,HFRCMSpaceInterpolator,HFRCMSurfaceCurrentAtVehicleLocation,DeadReckonUsingMultipleVelocitySources,DeadReckonWithRespectToWater,DeadReckonWithRespectToSeafloor,DeadReckonUsingDVLWaterTrack,NavChart,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2014-02-25T00:52:31.396Z,1393289551.396 [DataOverHttps](DEBUG): tcpConnect
2014-02-25T00:52:31.526Z,1393289551.526 [NAL9602](INFO): Powering up NAL9602
2014-02-25T00:52:31.580Z,1393289551.580 [Radio_Freewave](INFO): Powering up
2014-02-25T00:52:31.801Z,1393289551.801 [HFRCMSurfaceCurrentAtVehicleLocation](DEBUG): expecting 4 rows, 1835016 columns
2014-02-25T00:52:31.802Z,1393289551.802 [HFRCMSurfaceCurrentAtVehicleLocation](IMPORTANT): Error reading BlobValue for expansion coefficients.
2014-02-25T00:52:31.818Z,1393289551.818 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:31.824Z,1393289551.824 [DeadReckonWithRespectToWater](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:31.830Z,1393289551.830 [DeadReckonWithRespectToSeafloor](DEBUG): Data for platform velocity with respect to ground is invalid.
2014-02-25T00:52:31.831Z,1393289551.831 [DeadReckonWithRespectToSeafloor](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:31.873Z,1393289551.873 [DeadReckonUsingDVLWaterTrack](DEBUG): DVL water track data is invalid.
2014-02-25T00:52:31.873Z,1393289551.873 [DeadReckonUsingDVLWaterTrack](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:31.977Z,1393289551.977 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2014-02-25T00:52:31.978Z,1393289551.978 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2014-02-25T00:52:31.992Z,1393289551.992 [ElevatorServo](DEBUG): Initializing EZServoServo.
2014-02-25T00:52:31.993Z,1393289551.993 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2014-02-25T00:52:31.999Z,1393289551.999 [RudderServo](DEBUG): Initializing EZServoServo.
2014-02-25T00:52:32.004Z,1393289552.004 [RudderServo](DEBUG): Initializing RudderServo.
2014-02-25T00:52:32.014Z,1393289552.014 [ThrusterServo](DEBUG): Initializing EZServoServo.
2014-02-25T00:52:32.014Z,1393289552.014 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2014-02-25T00:52:32.211Z,1393289552.211 [DataOverHttps](DEBUG): tcpConnecting
2014-02-25T00:52:32.211Z,1393289552.211 [DataOverHttps](DEBUG): sslConnect
2014-02-25T00:52:32.215Z,1393289552.215 [DataOverHttps](DEBUG): sslConnecting
2014-02-25T00:52:32.380Z,1393289552.380 [HFRCMSurfaceCurrentAtVehicleLocation](DEBUG): no valid forecast
2014-02-25T00:52:32.381Z,1393289552.381 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:32.382Z,1393289552.382 [DeadReckonWithRespectToWater](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:32.383Z,1393289552.383 [DeadReckonWithRespectToSeafloor](DEBUG): Data for platform velocity with respect to ground is invalid.
2014-02-25T00:52:32.384Z,1393289552.384 [DeadReckonWithRespectToSeafloor](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:32.385Z,1393289552.385 [DeadReckonUsingDVLWaterTrack](DEBUG): DVL water track data is invalid.
2014-02-25T00:52:32.385Z,1393289552.385 [DeadReckonUsingDVLWaterTrack](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:32.552Z,1393289552.552 [DataOverHttps](DEBUG): sslConnecting
2014-02-25T00:52:34.071Z,1393289554.071 [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-02-25T00:52:34.192Z,1393289554.192 [HFRCMSurfaceCurrentAtVehicleLocation](DEBUG): no valid forecast
2014-02-25T00:52:34.193Z,1393289554.193 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:34.195Z,1393289554.195 [DeadReckonWithRespectToWater](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:34.209Z,1393289554.209 [DeadReckonWithRespectToSeafloor](DEBUG): Data for platform velocity with respect to ground is invalid.
2014-02-25T00:52:34.209Z,1393289554.209 [DeadReckonWithRespectToSeafloor](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:34.210Z,1393289554.210 [DeadReckonUsingDVLWaterTrack](DEBUG): DVL water track data is invalid.
2014-02-25T00:52:34.211Z,1393289554.211 [DeadReckonUsingDVLWaterTrack](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:35.006Z,1393289555.006 [DataOverHttps](DEBUG): sslConnecting
2014-02-25T00:52:35.008Z,1393289555.008 [DataOverHttps](DEBUG): dataWrite
2014-02-25T00:52:35.009Z,1393289555.009 [DataOverHttps](DEBUG): dataWriting
2014-02-25T00:52:35.010Z,1393289555.010 [DataOverHttps](DEBUG): Wrote 206 bytes
2014-02-25T00:52:35.092Z,1393289555.092 [HFRCMSurfaceCurrentAtVehicleLocation](DEBUG): no valid forecast
2014-02-25T00:52:35.094Z,1393289555.094 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:35.095Z,1393289555.095 [DeadReckonWithRespectToWater](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:35.096Z,1393289555.096 [DeadReckonWithRespectToSeafloor](DEBUG): Data for platform velocity with respect to ground is invalid.
2014-02-25T00:52:35.096Z,1393289555.096 [DeadReckonWithRespectToSeafloor](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:35.105Z,1393289555.105 [DeadReckonUsingDVLWaterTrack](DEBUG): DVL water track data is invalid.
2014-02-25T00:52:35.105Z,1393289555.105 [DeadReckonUsingDVLWaterTrack](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:35.506Z,1393289555.506 [DataOverHttps](DEBUG): dataRead
2014-02-25T00:52:35.661Z,1393289555.661 [HFRCMSurfaceCurrentAtVehicleLocation](DEBUG): no valid forecast
2014-02-25T00:52:35.662Z,1393289555.662 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:35.664Z,1393289555.664 [DeadReckonWithRespectToWater](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:35.665Z,1393289555.665 [DeadReckonWithRespectToSeafloor](DEBUG): Data for platform velocity with respect to ground is invalid.
2014-02-25T00:52:35.665Z,1393289555.665 [DeadReckonWithRespectToSeafloor](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:35.666Z,1393289555.666 [DeadReckonUsingDVLWaterTrack](DEBUG): DVL water track data is invalid.
2014-02-25T00:52:35.666Z,1393289555.666 [DeadReckonUsingDVLWaterTrack](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:35.760Z,1393289555.760 [DataOverHttps](DEBUG): dataRead
2014-02-25T00:52:35.761Z,1393289555.761 [DataOverHttps](DEBUG): received: vehicle=daphne&busy=true
2014-02-25T00:52:35.761Z,1393289555.761 [DataOverHttps](DEBUG): disconnect
2014-02-25T00:52:35.765Z,1393289555.765 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003906
2014-02-25T00:52:35.865Z,1393289555.865 [HFRCMSurfaceCurrentAtVehicleLocation](DEBUG): no valid forecast
2014-02-25T00:52:35.882Z,1393289555.882 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:35.884Z,1393289555.884 [DeadReckonWithRespectToWater](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:35.884Z,1393289555.884 [DeadReckonWithRespectToSeafloor](DEBUG): Data for platform velocity with respect to ground is invalid.
2014-02-25T00:52:35.885Z,1393289555.885 [DeadReckonWithRespectToSeafloor](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:35.886Z,1393289555.886 [DeadReckonUsingDVLWaterTrack](DEBUG): DVL water track data is invalid.
2014-02-25T00:52:35.894Z,1393289555.894 [DeadReckonUsingDVLWaterTrack](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:36.701Z,1393289556.701 [HFRCMSurfaceCurrentAtVehicleLocation](DEBUG): no valid forecast
2014-02-25T00:52:36.702Z,1393289556.702 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:36.703Z,1393289556.703 [DeadReckonWithRespectToWater](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:36.704Z,1393289556.704 [DeadReckonWithRespectToSeafloor](DEBUG): Data for platform velocity with respect to ground is invalid.
2014-02-25T00:52:36.704Z,1393289556.704 [DeadReckonWithRespectToSeafloor](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:36.705Z,1393289556.705 [DeadReckonUsingDVLWaterTrack](DEBUG): DVL water track data is invalid.
2014-02-25T00:52:36.705Z,1393289556.705 [DeadReckonUsingDVLWaterTrack](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:36.843Z,1393289556.843 [HFRCMSurfaceCurrentAtVehicleLocation](DEBUG): no valid forecast
2014-02-25T00:52:36.848Z,1393289556.848 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:36.849Z,1393289556.849 [DeadReckonWithRespectToWater](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:36.850Z,1393289556.850 [DeadReckonWithRespectToSeafloor](DEBUG): Data for platform velocity with respect to ground is invalid.
2014-02-25T00:52:36.851Z,1393289556.851 [DeadReckonWithRespectToSeafloor](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:36.858Z,1393289556.858 [DeadReckonUsingDVLWaterTrack](DEBUG): DVL water track data is invalid.
2014-02-25T00:52:36.859Z,1393289556.859 [DeadReckonUsingDVLWaterTrack](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:37.191Z,1393289557.191 [HFRCMSurfaceCurrentAtVehicleLocation](DEBUG): no valid forecast
2014-02-25T00:52:37.200Z,1393289557.200 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:37.201Z,1393289557.201 [DeadReckonWithRespectToWater](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:37.202Z,1393289557.202 [DeadReckonWithRespectToSeafloor](DEBUG): Data for platform velocity with respect to ground is invalid.
2014-02-25T00:52:37.203Z,1393289557.203 [DeadReckonWithRespectToSeafloor](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:37.203Z,1393289557.203 [DeadReckonUsingDVLWaterTrack](DEBUG): DVL water track data is invalid.
2014-02-25T00:52:37.204Z,1393289557.204 [DeadReckonUsingDVLWaterTrack](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:37.592Z,1393289557.592 [HFRCMSurfaceCurrentAtVehicleLocation](DEBUG): no valid forecast
2014-02-25T00:52:37.601Z,1393289557.601 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:37.602Z,1393289557.602 [DeadReckonWithRespectToWater](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:37.603Z,1393289557.603 [DeadReckonWithRespectToSeafloor](DEBUG): Data for platform velocity with respect to ground is invalid.
2014-02-25T00:52:37.604Z,1393289557.604 [DeadReckonWithRespectToSeafloor](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:37.604Z,1393289557.604 [DeadReckonUsingDVLWaterTrack](DEBUG): DVL water track data is invalid.
2014-02-25T00:52:37.605Z,1393289557.605 [DeadReckonUsingDVLWaterTrack](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:37.985Z,1393289557.985 [HFRCMSurfaceCurrentAtVehicleLocation](DEBUG): no valid forecast
2014-02-25T00:52:37.986Z,1393289557.986 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:37.987Z,1393289557.987 [DeadReckonWithRespectToWater](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:37.988Z,1393289557.988 [DeadReckonWithRespectToSeafloor](DEBUG): Data for platform velocity with respect to ground is invalid.
2014-02-25T00:52:37.988Z,1393289557.988 [DeadReckonWithRespectToSeafloor](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:37.997Z,1393289557.997 [DeadReckonUsingDVLWaterTrack](DEBUG): DVL water track data is invalid.
2014-02-25T00:52:37.998Z,1393289557.998 [DeadReckonUsingDVLWaterTrack](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:38.525Z,1393289558.525 [HFRCMSurfaceCurrentAtVehicleLocation](DEBUG): no valid forecast
2014-02-25T00:52:38.526Z,1393289558.526 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:38.539Z,1393289558.539 [DeadReckonWithRespectToWater](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:38.540Z,1393289558.540 [DeadReckonWithRespectToSeafloor](DEBUG): Data for platform velocity with respect to ground is invalid.
2014-02-25T00:52:38.540Z,1393289558.540 [DeadReckonWithRespectToSeafloor](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:38.541Z,1393289558.541 [DeadReckonUsingDVLWaterTrack](DEBUG): DVL water track data is invalid.
2014-02-25T00:52:38.541Z,1393289558.541 [DeadReckonUsingDVLWaterTrack](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:38.786Z,1393289558.786 [HFRCMSurfaceCurrentAtVehicleLocation](DEBUG): no valid forecast
2014-02-25T00:52:38.796Z,1393289558.796 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:38.797Z,1393289558.797 [DeadReckonWithRespectToWater](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:38.798Z,1393289558.798 [DeadReckonWithRespectToSeafloor](DEBUG): Data for platform velocity with respect to ground is invalid.
2014-02-25T00:52:38.798Z,1393289558.798 [DeadReckonWithRespectToSeafloor](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:38.799Z,1393289558.799 [DeadReckonUsingDVLWaterTrack](DEBUG): DVL water track data is invalid.
2014-02-25T00:52:38.799Z,1393289558.799 [DeadReckonUsingDVLWaterTrack](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:39.199Z,1393289559.199 [HFRCMSurfaceCurrentAtVehicleLocation](DEBUG): no valid forecast
2014-02-25T00:52:39.209Z,1393289559.209 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:39.210Z,1393289559.210 [DeadReckonWithRespectToWater](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:39.211Z,1393289559.211 [DeadReckonWithRespectToSeafloor](DEBUG): Data for platform velocity with respect to ground is invalid.
2014-02-25T00:52:39.211Z,1393289559.211 [DeadReckonWithRespectToSeafloor](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:39.221Z,1393289559.221 [DeadReckonUsingDVLWaterTrack](DEBUG): DVL water track data is invalid.
2014-02-25T00:52:39.221Z,1393289559.221 [DeadReckonUsingDVLWaterTrack](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:40.008Z,1393289560.008 [HFRCMSurfaceCurrentAtVehicleLocation](DEBUG): no valid forecast
2014-02-25T00:52:40.009Z,1393289560.009 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:40.010Z,1393289560.010 [DeadReckonWithRespectToWater](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:40.011Z,1393289560.011 [DeadReckonWithRespectToSeafloor](DEBUG): Data for platform velocity with respect to ground is invalid.
2014-02-25T00:52:40.012Z,1393289560.012 [DeadReckonWithRespectToSeafloor](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:40.013Z,1393289560.013 [DeadReckonUsingDVLWaterTrack](DEBUG): DVL water track data is invalid.
2014-02-25T00:52:40.013Z,1393289560.013 [DeadReckonUsingDVLWaterTrack](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:40.817Z,1393289560.817 [HFRCMSurfaceCurrentAtVehicleLocation](DEBUG): no valid forecast
2014-02-25T00:52:40.823Z,1393289560.823 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:40.825Z,1393289560.825 [DeadReckonWithRespectToWater](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:40.831Z,1393289560.831 [DeadReckonWithRespectToSeafloor](DEBUG): Data for platform velocity with respect to ground is invalid.
2014-02-25T00:52:40.831Z,1393289560.831 [DeadReckonWithRespectToSeafloor](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:40.832Z,1393289560.832 [DeadReckonUsingDVLWaterTrack](DEBUG): DVL water track data is invalid.
2014-02-25T00:52:40.833Z,1393289560.833 [DeadReckonUsingDVLWaterTrack](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:40.961Z,1393289560.961 [HFRCMSurfaceCurrentAtVehicleLocation](DEBUG): no valid forecast
2014-02-25T00:52:40.982Z,1393289560.982 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:40.984Z,1393289560.984 [DeadReckonWithRespectToWater](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:40.984Z,1393289560.984 [DeadReckonWithRespectToSeafloor](DEBUG): Data for platform velocity with respect to ground is invalid.
2014-02-25T00:52:40.985Z,1393289560.985 [DeadReckonWithRespectToSeafloor](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:40.986Z,1393289560.986 [DeadReckonUsingDVLWaterTrack](DEBUG): DVL water track data is invalid.
2014-02-25T00:52:40.994Z,1393289560.994 [DeadReckonUsingDVLWaterTrack](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:41.333Z,1393289561.333 [HFRCMSurfaceCurrentAtVehicleLocation](DEBUG): no valid forecast
2014-02-25T00:52:41.335Z,1393289561.335 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:41.336Z,1393289561.336 [DeadReckonWithRespectToWater](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:41.337Z,1393289561.337 [DeadReckonWithRespectToSeafloor](DEBUG): Data for platform velocity with respect to ground is invalid.
2014-02-25T00:52:41.337Z,1393289561.337 [DeadReckonWithRespectToSeafloor](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:41.338Z,1393289561.338 [DeadReckonUsingDVLWaterTrack](DEBUG): DVL water track data is invalid.
2014-02-25T00:52:41.338Z,1393289561.338 [DeadReckonUsingDVLWaterTrack](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:41.738Z,1393289561.738 [HFRCMSurfaceCurrentAtVehicleLocation](DEBUG): no valid forecast
2014-02-25T00:52:41.744Z,1393289561.744 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:41.745Z,1393289561.745 [DeadReckonWithRespectToWater](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:41.746Z,1393289561.746 [DeadReckonWithRespectToSeafloor](DEBUG): Data for platform velocity with respect to ground is invalid.
2014-02-25T00:52:41.746Z,1393289561.746 [DeadReckonWithRespectToSeafloor](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:41.751Z,1393289561.751 [DeadReckonUsingDVLWaterTrack](DEBUG): DVL water track data is invalid.
2014-02-25T00:52:41.752Z,1393289561.752 [DeadReckonUsingDVLWaterTrack](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:41.788Z,1393289561.788 [CommandLine](IMPORTANT): got command quit
2014-02-25T00:52:42.821Z,1393289562.821 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2014-02-25T00:52:42.821Z,1393289562.821 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2014-02-25T00:52:43.683Z,1393289563.683 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2014-02-25T00:52:43.939Z,1393289563.939 [WetLabsBB2FL](INFO): Powering down
2014-02-25T00:52:43.955Z,1393289563.955 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2014-02-25T00:52:44.043Z,1393289564.043 [CTD_NeilBrown](INFO): Powering down
2014-02-25T00:52:44.045Z,1393289564.045 [ComponentRegistry](INFO): Shutting down AsyncPiEstimator ThreadHandler
2014-02-25T00:52:44.119Z,1393289564.119 [NAL9602](ERROR): NAL9602 initialize uart error: serial timeout
2014-02-25T00:52:44.119Z,1393289564.119 [NAL9602] Communications Fault, FailCount= 1
2014-02-25T00:52:44.119Z,1393289564.119 [NAL9602](ERROR): Communications Fault
2014-02-25T00:52:44.133Z,1393289564.133 [HFRCMSurfaceCurrentAtVehicleLocation](DEBUG): no valid forecast
2014-02-25T00:52:44.134Z,1393289564.134 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:44.135Z,1393289564.135 [DeadReckonWithRespectToWater](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:44.136Z,1393289564.136 [DeadReckonWithRespectToSeafloor](DEBUG): Data for platform velocity with respect to ground is invalid.
2014-02-25T00:52:44.136Z,1393289564.136 [DeadReckonWithRespectToSeafloor](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:44.137Z,1393289564.137 [DeadReckonUsingDVLWaterTrack](DEBUG): DVL water track data is invalid.
2014-02-25T00:52:44.137Z,1393289564.137 [DeadReckonUsingDVLWaterTrack](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:44.147Z,1393289564.147 [CBIT](ERROR): Communications Fault in component: NAL9602
2014-02-25T00:52:44.187Z,1393289564.187 [AsyncPiEstimator](DEBUG): Uninitialize AsyncPiEstimator.
2014-02-25T00:52:44.203Z,1393289564.203 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2014-02-25T00:52:44.219Z,1393289564.219 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2014-02-25T00:52:44.232Z,1393289564.232 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2014-02-25T00:52:44.439Z,1393289564.439 [NAL9602](INFO): Powering down
2014-02-25T00:52:44.475Z,1393289564.475 [HFRCMSurfaceCurrentAtVehicleLocation](DEBUG): no valid forecast
2014-02-25T00:52:44.477Z,1393289564.477 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:44.478Z,1393289564.478 [DeadReckonWithRespectToWater](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:44.478Z,1393289564.478 [DeadReckonWithRespectToSeafloor](DEBUG): Data for platform velocity with respect to ground is invalid.
2014-02-25T00:52:44.479Z,1393289564.479 [DeadReckonWithRespectToSeafloor](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:44.480Z,1393289564.480 [DeadReckonUsingDVLWaterTrack](DEBUG): DVL water track data is invalid.
2014-02-25T00:52:44.480Z,1393289564.480 [DeadReckonUsingDVLWaterTrack](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-02-25T00:52:44.492Z,1393289564.492 [controlThread](DEBUG): Uninitializing ControlThread
2014-02-25T00:52:44.493Z,1393289564.493 [DataOverHttps](DEBUG): disconnect
2014-02-25T00:52:44.494Z,1393289564.494 [NAL9602](INFO): Powering down
2014-02-25T00:52:44.496Z,1393289564.496 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2014-02-25T00:52:44.498Z,1393289564.498 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2014-02-25T00:52:44.503Z,1393289564.503 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2014-02-25T00:52:44.504Z,1393289564.504 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2014-02-25T00:52:44.504Z,1393289564.504 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2014-02-25T00:52:44.505Z,1393289564.505 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2014-02-25T00:52:44.505Z,1393289564.505 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2014-02-25T00:52:44.505Z,1393289564.505 [BuoyancyServo](INFO): Powering down
2014-02-25T00:52:44.520Z,1393289564.520 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2014-02-25T00:52:44.520Z,1393289564.520 [ElevatorServo](INFO): Powering down
2014-02-25T00:52:44.542Z,1393289564.542 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2014-02-25T00:52:44.542Z,1393289564.542 [RudderServo](INFO): Powering down
2014-02-25T00:52:44.543Z,1393289564.543 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2014-02-25T00:52:44.543Z,1393289564.543 [ThrusterServo](INFO): Powering down
2014-02-25T00:52:44.544Z,1393289564.544 [SBIT](DEBUG): Uninitialize SBIT Component.
2014-02-25T00:52:44.545Z,1393289564.545 [IBIT](DEBUG): Uninitialize IBIT Component.
2014-02-25T00:52:44.545Z,1393289564.545 [CBIT](DEBUG): Uninitialize CBIT Component.