2013-09-17T00:35:07.575Z,1379378107.575 [Supervisor](DEBUG): Initializing supervisor.
2013-09-17T00:35:07.580Z,1379378107.580 [SyncHandler](DEBUG): Created PCaller Thread at 4033B4E0
2013-09-17T00:35:07.581Z,1379378107.581 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2013-09-17T00:35:07.584Z,1379378107.584 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4036B4E0
2013-09-17T00:35:07.587Z,1379378107.587 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2013-09-17T00:35:07.597Z,1379378107.597 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2013-09-17T00:35:07.600Z,1379378107.600 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 4039B4E0
2013-09-17T00:35:07.601Z,1379378107.601 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2013-09-17T00:35:07.604Z,1379378107.604 [logger ThreadHandler](DEBUG): Created PCaller Thread at 403CB4E0
2013-09-17T00:35:07.605Z,1379378107.605 [Supervisor](INFO): Looking for Config files in directory: Config/
2013-09-17T00:35:07.609Z,1379378107.609 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2013-09-17T00:35:07.913Z,1379378107.913 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2013-09-17T00:35:07.914Z,1379378107.914 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2013-09-17T00:35:08.130Z,1379378108.130 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2013-09-17T00:35:08.130Z,1379378108.130 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2013-09-17T00:35:08.226Z,1379378108.226 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2013-09-17T00:35:08.228Z,1379378108.228 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2013-09-17T00:35:08.354Z,1379378108.354 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2013-09-17T00:35:08.355Z,1379378108.355 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2013-09-17T00:35:08.514Z,1379378108.514 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2013-09-17T00:35:08.516Z,1379378108.516 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2013-09-17T00:35:08.781Z,1379378108.781 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2013-09-17T00:35:08.782Z,1379378108.782 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2013-09-17T00:35:08.963Z,1379378108.963 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2013-09-17T00:35:08.965Z,1379378108.965 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2013-09-17T00:35:09.256Z,1379378109.256 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2013-09-17T00:35:09.258Z,1379378109.258 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2013-09-17T00:35:09.376Z,1379378109.376 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2013-09-17T00:35:09.376Z,1379378109.376 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2013-09-17T00:35:09.827Z,1379378109.827 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2013-09-17T00:35:09.828Z,1379378109.828 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2013-09-17T00:35:09.944Z,1379378109.944 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2013-09-17T00:35:09.945Z,1379378109.945 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2013-09-17T00:35:10.041Z,1379378110.041 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2013-09-17T00:35:10.045Z,1379378110.045 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2013-09-17T00:35:10.154Z,1379378110.154 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2013-09-17T00:35:10.293Z,1379378110.293 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2013-09-17T00:35:10.397Z,1379378110.397 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2013-09-17T00:35:10.513Z,1379378110.513 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2013-09-17T00:35:10.622Z,1379378110.622 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2013-09-17T00:35:10.751Z,1379378110.751 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2013-09-17T00:35:10.858Z,1379378110.858 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2013-09-17T00:35:10.953Z,1379378110.953 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2013-09-17T00:35:10.960Z,1379378110.960 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2013-09-17T00:35:11.168Z,1379378111.168 [InternalSim] Loaded
2013-09-17T00:35:11.168Z,1379378111.168 [ComponentRegistry](DEBUG): SyncComponent "InternalSim" handled in the control thread.
2013-09-17T00:35:11.169Z,1379378111.169 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2013-09-17T00:35:11.169Z,1379378111.169 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2013-09-17T00:35:11.286Z,1379378111.286 [SBIT](DEBUG): Construct Startup Built In Test.
2013-09-17T00:35:11.318Z,1379378111.318 [SBIT] Loaded
2013-09-17T00:35:11.318Z,1379378111.318 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2013-09-17T00:35:11.319Z,1379378111.319 [IBIT](DEBUG): Construct Initiated Built In Test.
2013-09-17T00:35:11.347Z,1379378111.347 [IBIT] Loaded
2013-09-17T00:35:11.348Z,1379378111.348 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2013-09-17T00:35:11.350Z,1379378111.350 [CBIT](DEBUG): Construct CBIT Built In Test.
2013-09-17T00:35:11.477Z,1379378111.477 [CBIT] Loaded
2013-09-17T00:35:11.478Z,1379378111.478 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2013-09-17T00:35:11.478Z,1379378111.478 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2013-09-17T00:35:11.479Z,1379378111.479 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2013-09-17T00:35:11.691Z,1379378111.691 [BuoyancyServo] Loaded
2013-09-17T00:35:11.692Z,1379378111.692 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2013-09-17T00:35:11.703Z,1379378111.703 [ElevatorServo] Loaded
2013-09-17T00:35:11.703Z,1379378111.703 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2013-09-17T00:35:11.718Z,1379378111.718 [MassServo] Loaded
2013-09-17T00:35:11.718Z,1379378111.718 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2013-09-17T00:35:11.729Z,1379378111.729 [RudderServo] Loaded
2013-09-17T00:35:11.730Z,1379378111.730 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2013-09-17T00:35:11.741Z,1379378111.741 [ThrusterServo] Loaded
2013-09-17T00:35:11.741Z,1379378111.741 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2013-09-17T00:35:11.741Z,1379378111.741 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2013-09-17T00:35:11.742Z,1379378111.742 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2013-09-17T00:35:13.502Z,1379378113.502 [DepthRateCalculator] Loaded
2013-09-17T00:35:13.502Z,1379378113.502 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2013-09-17T00:35:16.925Z,1379378116.925 [HFRadarModelCalc] Loaded
2013-09-17T00:35:16.925Z,1379378116.925 [ComponentRegistry](DEBUG): SyncComponent "HFRadarModelCalc" handled in the control thread.
2013-09-17T00:35:16.941Z,1379378116.941 [NavChart] Loaded
2013-09-17T00:35:16.941Z,1379378116.941 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2013-09-17T00:35:16.947Z,1379378116.947 [PitchRateCalculator] Loaded
2013-09-17T00:35:16.947Z,1379378116.947 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2013-09-17T00:35:16.957Z,1379378116.957 [SpeedCalculator] Loaded
2013-09-17T00:35:16.957Z,1379378116.957 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2013-09-17T00:35:16.973Z,1379378116.973 [TempGradientCalculator] Loaded
2013-09-17T00:35:16.973Z,1379378116.973 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2013-09-17T00:35:16.979Z,1379378116.979 [YawRateCalculator] Loaded
2013-09-17T00:35:16.979Z,1379378116.979 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2013-09-17T00:35:17.028Z,1379378117.028 [Navigation] Loaded
2013-09-17T00:35:17.029Z,1379378117.029 [ComponentRegistry](DEBUG): SyncComponent "Navigation" handled in the control thread.
2013-09-17T00:35:17.029Z,1379378117.029 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2013-09-17T00:35:17.030Z,1379378117.030 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2013-09-17T00:35:17.328Z,1379378117.328 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2013-09-17T00:35:17.328Z,1379378117.328 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2013-09-17T00:35:17.370Z,1379378117.370 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2013-09-17T00:35:17.371Z,1379378117.371 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2013-09-17T00:35:17.441Z,1379378117.441 [VerticalControl](DEBUG): Construct VerticalControl.
2013-09-17T00:35:17.539Z,1379378117.539 [VerticalControl] Loaded
2013-09-17T00:35:17.540Z,1379378117.540 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2013-09-17T00:35:17.541Z,1379378117.541 [HorizontalControl](DEBUG): Construct HorizontalControl.
2013-09-17T00:35:17.605Z,1379378117.605 [HorizontalControl] Loaded
2013-09-17T00:35:17.605Z,1379378117.605 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2013-09-17T00:35:17.606Z,1379378117.606 [SpeedControl](DEBUG): Construct SpeedControl.
2013-09-17T00:35:17.607Z,1379378117.607 [SpeedControl] Loaded
2013-09-17T00:35:17.608Z,1379378117.608 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2013-09-17T00:35:17.608Z,1379378117.608 [LoopControl](DEBUG): Construct LoopControl.
2013-09-17T00:35:17.609Z,1379378117.609 [LoopControl] Loaded
2013-09-17T00:35:17.609Z,1379378117.609 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2013-09-17T00:35:17.610Z,1379378117.610 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2013-09-17T00:35:17.610Z,1379378117.610 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2013-09-17T00:35:17.619Z,1379378117.619 [AsyncPiEstimator](DEBUG): Construct AsyncPiEstimator.
2013-09-17T00:35:17.624Z,1379378117.624 [AsyncPiEstimator] Loaded
2013-09-17T00:35:17.624Z,1379378117.624 [ComponentRegistry](DEBUG): Component "AsyncPiEstimator" handled in its own thread.
2013-09-17T00:35:17.628Z,1379378117.628 [AsyncPiEstimator ThreadHandler](DEBUG): Created PCaller Thread at 406474E0
2013-09-17T00:35:17.628Z,1379378117.628 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2013-09-17T00:35:17.629Z,1379378117.629 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2013-09-17T00:35:17.883Z,1379378117.883 [AHRS_sp3003D] Loaded
2013-09-17T00:35:17.884Z,1379378117.884 [ComponentRegistry](DEBUG): SyncComponent "AHRS_sp3003D" handled in the control thread.
2013-09-17T00:35:17.897Z,1379378117.897 [Depth_Keller] Loaded
2013-09-17T00:35:17.897Z,1379378117.897 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2013-09-17T00:35:18.095Z,1379378118.095 [DVL_micro] Loaded
2013-09-17T00:35:18.095Z,1379378118.095 [ComponentRegistry](DEBUG): Component "DVL_micro" handled in its own thread.
2013-09-17T00:35:18.100Z,1379378118.100 [DVL_micro ThreadHandler](DEBUG): Created PCaller Thread at 406CE4E0
2013-09-17T00:35:18.194Z,1379378118.194 [NAL9602] Loaded
2013-09-17T00:35:18.195Z,1379378118.195 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2013-09-17T00:35:18.240Z,1379378118.240 [Onboard] Loaded
2013-09-17T00:35:18.241Z,1379378118.241 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2013-09-17T00:35:18.247Z,1379378118.247 [Radio_Freewave] Loaded
2013-09-17T00:35:18.247Z,1379378118.247 [ComponentRegistry](DEBUG): SyncComponent "Radio_Freewave" handled in the control thread.
2013-09-17T00:35:18.400Z,1379378118.400 [DAT] Loaded
2013-09-17T00:35:18.400Z,1379378118.400 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2013-09-17T00:35:18.407Z,1379378118.407 [SCPI] Loaded
2013-09-17T00:35:18.407Z,1379378118.407 [ComponentRegistry](DEBUG): SyncComponent "SCPI" handled in the control thread.
2013-09-17T00:35:18.408Z,1379378118.408 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2013-09-17T00:35:18.408Z,1379378118.408 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2013-09-17T00:35:18.545Z,1379378118.545 [CTD_NeilBrown] Loaded
2013-09-17T00:35:18.546Z,1379378118.546 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2013-09-17T00:35:18.549Z,1379378118.549 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 4072B4E0
2013-09-17T00:35:18.564Z,1379378118.564 [PAR_Licor] Loaded
2013-09-17T00:35:18.564Z,1379378118.564 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2013-09-17T00:35:18.600Z,1379378118.600 [WetLabsBB2FL] Loaded
2013-09-17T00:35:18.600Z,1379378118.600 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2013-09-17T00:35:18.601Z,1379378118.601 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 4075B4E0
2013-09-17T00:35:18.602Z,1379378118.602 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2013-09-17T00:35:18.604Z,1379378118.604 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2013-09-17T00:35:18.605Z,1379378118.605 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2013-09-17T00:35:18.621Z,1379378118.621 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2013-09-17T00:35:18.623Z,1379378118.623 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 4078B4E0
2013-09-17T00:35:18.627Z,1379378118.627 [Supervisor](DEBUG): Running supervisor.
2013-09-17T00:35:18.629Z,1379378118.629 [CommandLine](INFO): Thread ID is 760
2013-09-17T00:35:18.634Z,1379378118.634 [controlThread](INFO): Thread ID is 759
2013-09-17T00:35:18.634Z,1379378118.634 [controlThread](DEBUG): Initializing ControlThread
2013-09-17T00:35:18.634Z,1379378118.634 [CycleStarter](INFO): Thread ID is 758
2013-09-17T00:35:18.635Z,1379378118.635 [InternalSim](DEBUG): InternalSim initializing...
2013-09-17T00:35:18.717Z,1379378118.717 [logger](INFO): Thread ID is 761
2013-09-17T00:35:18.783Z,1379378118.783 [AsyncPiEstimator](INFO): Thread ID is 822
2013-09-17T00:35:18.783Z,1379378118.783 [AsyncPiEstimator](DEBUG): Initialize AsyncPiEstimator.
2013-09-17T00:35:18.791Z,1379378118.791 [DVL_micro](INFO): Thread ID is 823
2013-09-17T00:35:18.810Z,1379378118.810 [DVL_micro](INFO): Initializing
2013-09-17T00:35:18.810Z,1379378118.810 [DVL_micro](INFO): start:Powering up
2013-09-17T00:35:18.811Z,1379378118.811 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:35:18.812Z,1379378118.812 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:35:18.816Z,1379378118.816 [SBIT](INFO): Initialize SBIT Component.
2013-09-17T00:35:18.817Z,1379378118.817 [SBIT](IMPORTANT): Tethys CM Info:
$Rev:10634
2013-09-17T00:35:18.817Z,1379378118.817 [SBIT](IMPORTANT): Kernel Release:2.6.27.8
2013-09-17T00:35:18.821Z,1379378118.821 [SBIT](IMPORTANT): Kernel Version:#634 PREEMPT Wed Feb 13 10:21:48 PST 2013
2013-09-17T00:35:18.822Z,1379378118.822 [IBIT](INFO): Initialize IBIT Component.
2013-09-17T00:35:18.823Z,1379378118.823 [CBIT](DEBUG): Initialize CBIT Component.
2013-09-17T00:35:18.823Z,1379378118.823 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2013-09-17T00:35:18.843Z,1379378118.843 [CTD_NeilBrown](INFO): Thread ID is 824
2013-09-17T00:35:18.843Z,1379378118.843 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown.
2013-09-17T00:35:18.851Z,1379378118.851 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2013-09-17T00:35:18.851Z,1379378118.851 [NavChart](DEBUG): Initialize NavChart Derivation.
2013-09-17T00:35:18.852Z,1379378118.852 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2013-09-17T00:35:18.852Z,1379378118.852 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2013-09-17T00:35:18.852Z,1379378118.852 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2013-09-17T00:35:18.853Z,1379378118.853 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2013-09-17T00:35:18.854Z,1379378118.854 [Navigation](DEBUG): Initializing Navigation.
2013-09-17T00:35:18.854Z,1379378118.854 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2013-09-17T00:35:18.856Z,1379378118.856 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2013-09-17T00:35:18.856Z,1379378118.856 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2013-09-17T00:35:18.857Z,1379378118.857 [LoopControl](DEBUG): Initialize LoopControlComponent.
2013-09-17T00:35:18.862Z,1379378118.862 [WetLabsBB2FL](INFO): Thread ID is 825
2013-09-17T00:35:18.863Z,1379378118.863 [WetLabsBB2FL](INFO): Powering down
2013-09-17T00:35:18.864Z,1379378118.864 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2013-09-17T00:35:18.886Z,1379378118.886 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2013-09-17T00:35:18.887Z,1379378118.887 [NavChartDb](INFO): Thread ID is 826
2013-09-17T00:35:18.959Z,1379378118.959 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2013-09-17T00:35:18.972Z,1379378118.972 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources
2013-09-17T00:35:18.972Z,1379378118.972 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2013-09-17T00:35:18.973Z,1379378118.973 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2013-09-17T00:35:18.973Z,1379378118.973 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2013-09-17T00:35:18.973Z,1379378118.973 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2013-09-17T00:35:18.974Z,1379378118.974 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2013-09-17T00:35:18.974Z,1379378118.974 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2013-09-17T00:35:18.974Z,1379378118.974 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2013-09-17T00:35:18.974Z,1379378118.974 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2013-09-17T00:35:18.981Z,1379378118.981 [MissionManager](DEBUG):
2013-09-17T00:35:18.995Z,1379378118.995 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2013-09-17T00:35:19.112Z,1379378119.112 [MissionManager](INFO): DefineArg Default.NeedGPS = 1 bool
2013-09-17T00:35:19.114Z,1379378119.114 [Default:GPS:A.SetSpeed](DEBUG): Construct.
2013-09-17T00:35:19.117Z,1379378119.117 [Default:GPS:B.GoToSurface](DEBUG): Construct GoToSurface.
2013-09-17T00:35:19.141Z,1379378119.141 [Default:Iridium:A.SetSpeed](DEBUG): Construct.
2013-09-17T00:35:19.168Z,1379378119.168 [Default:Iridium:B.GoToSurface](DEBUG): Construct GoToSurface.
2013-09-17T00:35:19.188Z,1379378119.188 [Default:Iridium:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2013-09-17T00:35:19.196Z,1379378119.196 [Default:D.SetSpeed](DEBUG): Construct.
2013-09-17T00:35:19.211Z,1379378119.211 [Default:E.GoToSurface](DEBUG): Construct GoToSurface.
2013-09-17T00:35:19.216Z,1379378119.216 [Default:F.Wait](DEBUG): Construct Wait.
2013-09-17T00:35:19.248Z,1379378119.248 [MissionManager](DEBUG):
400
400
Burn 300
Dropped drop weight due to communications timeout
5.0
1.0
5
2013-09-17T00:35:19.252Z,1379378119.252 [controlThread](DEBUG): Component order: CycleStarter,InternalSim,AHRS_sp3003D,Depth_Keller,NAL9602,Onboard,Radio_Freewave,DAT,SCPI,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,HFRadarModelCalc,NavChart,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,Navigation,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,
2013-09-17T00:35:19.296Z,1379378119.296 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D.
2013-09-17T00:35:19.511Z,1379378119.511 [Radio_Freewave](INFO): Powering up
2013-09-17T00:35:19.516Z,1379378119.516 [DAT](INFO): Powering up
2013-09-17T00:35:19.516Z,1379378119.516 [DAT](DEBUG): Initializing DAT.
2013-09-17T00:35:19.906Z,1379378119.906 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2013-09-17T00:35:19.912Z,1379378119.912 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2013-09-17T00:35:19.918Z,1379378119.918 [ElevatorServo](DEBUG): Initializing EZServoServo.
2013-09-17T00:35:19.943Z,1379378119.943 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2013-09-17T00:35:19.949Z,1379378119.949 [MassServo](DEBUG): Initializing EZServoServo.
2013-09-17T00:35:19.959Z,1379378119.959 [MassServo](DEBUG): Initializing MassServo.
2013-09-17T00:35:19.965Z,1379378119.965 [RudderServo](DEBUG): Initializing EZServoServo.
2013-09-17T00:35:19.971Z,1379378119.971 [RudderServo](DEBUG): Initializing RudderServo.
2013-09-17T00:35:19.977Z,1379378119.977 [ThrusterServo](DEBUG): Initializing EZServoServo.
2013-09-17T00:35:19.980Z,1379378119.980 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2013-09-17T00:35:20.008Z,1379378120.008 [CBIT](FAULT): Main Battery Failure. Count: 1
2013-09-17T00:35:20.454Z,1379378120.454 [AHRS_sp3003D](ERROR): readHeadingMagBin UART error: serial timeout
2013-09-17T00:35:20.455Z,1379378120.455 [AHRS_sp3003D](ERROR): SP3003D failed to initialize
2013-09-17T00:35:20.455Z,1379378120.455 [AHRS_sp3003D] Hardware Fault, FailCount= 1
2013-09-17T00:35:20.455Z,1379378120.455 [AHRS_sp3003D](ERROR): Hardware Fault
2013-09-17T00:35:21.009Z,1379378121.009 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:35:21.010Z,1379378121.010 [DVL_micro](INFO): Querying output modes
2013-09-17T00:35:21.010Z,1379378121.010 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:35:21.093Z,1379378121.093 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2013-09-17T00:35:21.093Z,1379378121.093 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2013-09-17T00:35:21.093Z,1379378121.093 [BuoyancyServo] Communications Fault, FailCount= 1
2013-09-17T00:35:21.093Z,1379378121.093 [BuoyancyServo](ERROR): Communications Fault
2013-09-17T00:35:21.304Z,1379378121.304 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2013-09-17T00:35:21.304Z,1379378121.304 [CBIT](ERROR): Hardware Fault in component: AHRS_sp3003D
2013-09-17T00:35:21.374Z,1379378121.374 [AHRS_sp3003D](INFO): Powering down
2013-09-17T00:35:21.576Z,1379378121.576 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2013-09-17T00:35:21.577Z,1379378121.577 [BuoyancyServo](INFO): Powering down
2013-09-17T00:35:22.710Z,1379378122.710 [CBIT](INFO): Clearing failed state for component AHRS_sp3003D
2013-09-17T00:35:22.710Z,1379378122.710 [AHRS_sp3003D] No Fault, FailCount= 1
2013-09-17T00:35:22.919Z,1379378122.919 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D.
2013-09-17T00:35:23.016Z,1379378123.016 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:35:23.016Z,1379378123.016 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:35:23.016Z,1379378123.016 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:35:23.330Z,1379378123.330 [NAL9602](INFO): Powering up NAL9602
2013-09-17T00:35:24.070Z,1379378124.070 [AHRS_sp3003D](ERROR): readHeadingMagBin UART error: serial timeout
2013-09-17T00:35:24.070Z,1379378124.070 [AHRS_sp3003D](ERROR): SP3003D failed to initialize
2013-09-17T00:35:24.070Z,1379378124.070 [AHRS_sp3003D] Hardware Fault, FailCount= 2
2013-09-17T00:35:24.070Z,1379378124.070 [AHRS_sp3003D](ERROR): Hardware Fault
2013-09-17T00:35:24.380Z,1379378124.380 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2013-09-17T00:35:24.381Z,1379378124.381 [BuoyancyServo] No Fault, FailCount= 1
2013-09-17T00:35:24.381Z,1379378124.381 [CBIT](ERROR): Hardware Fault in component: AHRS_sp3003D
2013-09-17T00:35:24.397Z,1379378124.397 [AHRS_sp3003D](INFO): Powering down
2013-09-17T00:35:24.541Z,1379378124.541 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2013-09-17T00:35:24.660Z,1379378124.660 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2013-09-17T00:35:25.035Z,1379378125.035 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:35:25.047Z,1379378125.047 [DVL_micro](INFO): pause:Powering down
2013-09-17T00:35:25.049Z,1379378125.049 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:35:25.050Z,1379378125.050 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:35:25.050Z,1379378125.050 [DVL_micro](INFO): resume:Powering up
2013-09-17T00:35:25.050Z,1379378125.050 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:35:25.803Z,1379378125.803 [CBIT](INFO): Clearing failed state for component AHRS_sp3003D
2013-09-17T00:35:25.803Z,1379378125.803 [AHRS_sp3003D] No Fault, FailCount= 2
2013-09-17T00:35:26.112Z,1379378126.112 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D.
2013-09-17T00:35:27.059Z,1379378127.059 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:35:27.059Z,1379378127.059 [DVL_micro](INFO): Querying output modes
2013-09-17T00:35:27.059Z,1379378127.059 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:35:27.263Z,1379378127.263 [AHRS_sp3003D](ERROR): readHeadingMagBin UART error: serial timeout
2013-09-17T00:35:27.263Z,1379378127.263 [AHRS_sp3003D](ERROR): SP3003D failed to initialize
2013-09-17T00:35:27.263Z,1379378127.263 [AHRS_sp3003D] Hardware Fault, FailCount= 3
2013-09-17T00:35:27.263Z,1379378127.263 [AHRS_sp3003D](ERROR): Hardware Fault
2013-09-17T00:35:27.359Z,1379378127.359 [CBIT](ERROR): Hardware Fault in component: AHRS_sp3003D
2013-09-17T00:35:27.373Z,1379378127.373 [AHRS_sp3003D](INFO): Powering down
2013-09-17T00:35:28.752Z,1379378128.752 [CBIT](INFO): Clearing failed state for component AHRS_sp3003D
2013-09-17T00:35:28.752Z,1379378128.752 [AHRS_sp3003D] No Fault, FailCount= 3
2013-09-17T00:35:28.972Z,1379378128.972 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D.
2013-09-17T00:35:29.061Z,1379378129.061 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:35:29.061Z,1379378129.061 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:35:29.062Z,1379378129.062 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:35:30.127Z,1379378130.127 [AHRS_sp3003D](ERROR): readHeadingMagBin UART error: serial timeout
2013-09-17T00:35:30.127Z,1379378130.127 [AHRS_sp3003D](ERROR): SP3003D failed to initialize
2013-09-17T00:35:30.127Z,1379378130.127 [AHRS_sp3003D] Hardware Fault, FailCount= 4
2013-09-17T00:35:30.127Z,1379378130.127 [AHRS_sp3003D](ERROR): Hardware Fault
2013-09-17T00:35:30.274Z,1379378130.274 [CBIT](ERROR): Hardware Fault in component: AHRS_sp3003D
2013-09-17T00:35:30.287Z,1379378130.287 [AHRS_sp3003D](INFO): Powering down
2013-09-17T00:35:31.064Z,1379378131.064 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:35:31.066Z,1379378131.066 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:35:31.066Z,1379378131.066 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:35:31.600Z,1379378131.600 [CBIT](INFO): Clearing failed state for component AHRS_sp3003D
2013-09-17T00:35:31.601Z,1379378131.601 [AHRS_sp3003D] No Fault, FailCount= 4
2013-09-17T00:35:31.889Z,1379378131.889 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D.
2013-09-17T00:35:33.019Z,1379378133.019 [AHRS_sp3003D](ERROR): readHeadingMagBin UART error: serial timeout
2013-09-17T00:35:33.020Z,1379378133.020 [AHRS_sp3003D](ERROR): SP3003D failed to initialize
2013-09-17T00:35:33.020Z,1379378133.020 [AHRS_sp3003D] Hardware Fault, FailCount= 5
2013-09-17T00:35:33.020Z,1379378133.020 [AHRS_sp3003D](ERROR): Hardware Fault
2013-09-17T00:35:33.072Z,1379378133.072 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:35:33.072Z,1379378133.072 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:35:33.171Z,1379378133.171 [CBIT](ERROR): Hardware Fault in component: AHRS_sp3003D
2013-09-17T00:35:33.172Z,1379378133.172 [CBIT](CRITICAL): Hardware Fault in component: AHRS_sp3003D
2013-09-17T00:35:33.192Z,1379378133.192 [AHRS_sp3003D](INFO): Powering down
2013-09-17T00:35:33.410Z,1379378133.410 [CommandLine](FAULT): Scheduling is paused
2013-09-17T00:35:34.074Z,1379378134.074 [NAL9602](INFO): NAL9602 initialized
2013-09-17T00:35:34.522Z,1379378134.522 [SBIT](IMPORTANT): Beginning Startup BIT
2013-09-17T00:35:34.524Z,1379378134.524 [CBIT](IMPORTANT): Beginning GF scan
2013-09-17T00:35:35.075Z,1379378135.075 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:35:35.075Z,1379378135.075 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:35:35.075Z,1379378135.075 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:35:37.086Z,1379378137.086 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:35:37.086Z,1379378137.086 [DVL_micro](INFO): Querying output modes
2013-09-17T00:35:37.086Z,1379378137.086 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:35:39.090Z,1379378139.090 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:35:39.090Z,1379378139.090 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:35:39.090Z,1379378139.090 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:35:39.605Z,1379378139.605 [DAT](INFO): Powering down
2013-09-17T00:35:41.092Z,1379378141.092 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:35:43.096Z,1379378143.096 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:35:43.096Z,1379378143.096 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:35:45.099Z,1379378145.099 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:35:45.099Z,1379378145.099 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:35:47.101Z,1379378147.101 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:35:47.101Z,1379378147.101 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:35:47.102Z,1379378147.102 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:35:49.104Z,1379378149.104 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:35:49.105Z,1379378149.105 [DVL_micro](INFO): Querying output modes
2013-09-17T00:35:49.105Z,1379378149.105 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:35:51.108Z,1379378151.108 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:35:51.108Z,1379378151.108 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:35:51.108Z,1379378151.108 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:35:53.120Z,1379378153.120 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:35:55.127Z,1379378155.127 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:35:55.127Z,1379378155.127 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:35:57.133Z,1379378157.133 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:35:57.134Z,1379378157.134 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:35:59.136Z,1379378159.136 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:35:59.136Z,1379378159.136 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:35:59.136Z,1379378159.136 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:36:01.143Z,1379378161.143 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:36:01.143Z,1379378161.143 [DVL_micro](INFO): Querying output modes
2013-09-17T00:36:01.143Z,1379378161.143 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:36:01.325Z,1379378161.325 [CBIT](IMPORTANT): No ground fault detected
2013-09-17T00:36:03.146Z,1379378163.146 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:36:03.146Z,1379378163.146 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:36:03.147Z,1379378163.147 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:36:05.157Z,1379378165.157 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:36:07.169Z,1379378167.169 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:36:07.169Z,1379378167.169 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:36:09.172Z,1379378169.172 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:36:09.172Z,1379378169.172 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:36:11.175Z,1379378171.175 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:36:11.175Z,1379378171.175 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:36:11.175Z,1379378171.175 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:36:13.182Z,1379378173.182 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:36:13.182Z,1379378173.182 [DVL_micro](INFO): Querying output modes
2013-09-17T00:36:13.182Z,1379378173.182 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:36:15.197Z,1379378175.197 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:36:15.197Z,1379378175.197 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:36:15.197Z,1379378175.197 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:36:17.204Z,1379378177.204 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:36:19.088Z,1379378179.088 [CommandLine](IMPORTANT): got command report periodic 1.000000 platform_buoyancy_position
2013-09-17T00:36:19.217Z,1379378179.217 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:36:19.217Z,1379378179.217 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:36:19.313Z,1379378179.313 [Reporter](INFO): platform_buoyancy_position 202.380033 cc
2013-09-17T00:36:20.450Z,1379378180.450 [Reporter](INFO): platform_buoyancy_position 206.543336 cc
2013-09-17T00:36:21.223Z,1379378181.223 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:36:21.223Z,1379378181.223 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:36:21.648Z,1379378181.648 [Reporter](INFO): platform_buoyancy_position 210.975224 cc
2013-09-17T00:36:22.874Z,1379378182.874 [Reporter](INFO): platform_buoyancy_position 215.138512 cc
2013-09-17T00:36:23.234Z,1379378183.234 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:36:23.234Z,1379378183.234 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:36:23.234Z,1379378183.234 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:36:24.044Z,1379378184.044 [Reporter](INFO): platform_buoyancy_position 219.301815 cc
2013-09-17T00:36:25.237Z,1379378185.237 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:36:25.237Z,1379378185.237 [DVL_micro](INFO): Querying output modes
2013-09-17T00:36:25.238Z,1379378185.238 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:36:25.266Z,1379378185.266 [Reporter](INFO): platform_buoyancy_position 221.719238 cc
2013-09-17T00:36:26.404Z,1379378186.404 [Reporter](INFO): platform_buoyancy_position 226.151125 cc
2013-09-17T00:36:27.248Z,1379378187.248 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:36:27.248Z,1379378187.248 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:36:27.248Z,1379378187.248 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:36:27.606Z,1379378187.606 [Reporter](INFO): platform_buoyancy_position 230.180114 cc
2013-09-17T00:36:28.412Z,1379378188.412 [SBIT](IMPORTANT): SBIT PASSED
2013-09-17T00:36:28.782Z,1379378188.782 [MissionManager](IMPORTANT): Started mission Startup
2013-09-17T00:36:28.783Z,1379378188.783 [Startup] Running Loop=1
2013-09-17T00:36:28.783Z,1379378188.783 [Startup](INFO): Aggregate::initialize Startup
2013-09-17T00:36:28.783Z,1379378188.783 [Startup:A.GoToSurface] Running Loop=1
2013-09-17T00:36:28.783Z,1379378188.783 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-09-17T00:36:28.791Z,1379378188.791 [Startup:StartupSatComms] Running Loop=1
2013-09-17T00:36:28.791Z,1379378188.791 [Startup:StartupSatComms](INFO): Aggregate::initialize Startup:StartupSatComms
2013-09-17T00:36:28.792Z,1379378188.792 [Startup:StartupSatComms:A] Running Loop=1
2013-09-17T00:36:28.839Z,1379378188.839 [Reporter](INFO): platform_buoyancy_position 234.612031 cc
2013-09-17T00:36:29.179Z,1379378189.179 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2013-09-17T00:36:29.259Z,1379378189.259 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:36:30.005Z,1379378190.005 [Reporter](INFO): platform_buoyancy_position 238.909633 cc
2013-09-17T00:36:31.244Z,1379378191.244 [Reporter](INFO): platform_buoyancy_position 241.998539 cc
2013-09-17T00:36:31.270Z,1379378191.270 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:36:31.271Z,1379378191.271 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:36:32.405Z,1379378192.405 [Reporter](INFO): platform_buoyancy_position 245.490315 cc
2013-09-17T00:36:33.273Z,1379378193.273 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:36:33.274Z,1379378193.274 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:36:33.603Z,1379378193.603 [Reporter](INFO): platform_buoyancy_position 249.653618 cc
2013-09-17T00:36:34.840Z,1379378194.840 [Reporter](INFO): platform_buoyancy_position 253.816921 cc
2013-09-17T00:36:35.276Z,1379378195.276 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:36:35.276Z,1379378195.276 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:36:35.276Z,1379378195.276 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:36:35.999Z,1379378195.999 [Reporter](INFO): platform_buoyancy_position 258.114538 cc
2013-09-17T00:36:37.216Z,1379378197.216 [Reporter](INFO): platform_buoyancy_position 262.412126 cc
2013-09-17T00:36:37.279Z,1379378197.279 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:36:37.279Z,1379378197.279 [DVL_micro](INFO): Querying output modes
2013-09-17T00:36:37.279Z,1379378197.279 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:36:38.402Z,1379378198.402 [Reporter](INFO): platform_buoyancy_position 264.963834 cc
2013-09-17T00:36:39.290Z,1379378199.290 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:36:39.290Z,1379378199.290 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:36:39.291Z,1379378199.291 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:36:39.604Z,1379378199.604 [Reporter](INFO): platform_buoyancy_position 269.261451 cc
2013-09-17T00:36:40.838Z,1379378200.838 [Reporter](INFO): platform_buoyancy_position 273.424754 cc
2013-09-17T00:36:41.293Z,1379378201.293 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:36:42.004Z,1379378202.004 [Reporter](INFO): platform_buoyancy_position 277.453742 cc
2013-09-17T00:36:43.217Z,1379378203.217 [Reporter](INFO): platform_buoyancy_position 281.885616 cc
2013-09-17T00:36:43.297Z,1379378203.297 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:36:43.297Z,1379378203.297 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:36:44.400Z,1379378204.400 [Reporter](INFO): platform_buoyancy_position 286.048918 cc
2013-09-17T00:36:45.300Z,1379378205.300 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:36:45.300Z,1379378205.300 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:36:45.605Z,1379378205.605 [Reporter](INFO): platform_buoyancy_position 289.137824 cc
2013-09-17T00:36:46.843Z,1379378206.843 [Reporter](INFO): platform_buoyancy_position 292.629644 cc
2013-09-17T00:36:47.311Z,1379378207.311 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:36:47.311Z,1379378207.311 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:36:47.311Z,1379378207.311 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:36:48.005Z,1379378208.005 [Reporter](INFO): platform_buoyancy_position 296.792947 cc
2013-09-17T00:36:49.243Z,1379378209.243 [Reporter](INFO): platform_buoyancy_position 301.224820 cc
2013-09-17T00:36:49.319Z,1379378209.319 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:36:49.319Z,1379378209.319 [DVL_micro](INFO): Querying output modes
2013-09-17T00:36:49.320Z,1379378209.320 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:36:50.401Z,1379378210.401 [Reporter](INFO): platform_buoyancy_position 305.388123 cc
2013-09-17T00:36:51.322Z,1379378211.322 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:36:51.323Z,1379378211.323 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:36:51.323Z,1379378211.323 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:36:51.603Z,1379378211.603 [Reporter](INFO): platform_buoyancy_position 309.685740 cc
2013-09-17T00:36:52.840Z,1379378212.840 [Reporter](INFO): platform_buoyancy_position 312.237418 cc
2013-09-17T00:36:53.324Z,1379378213.324 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:36:53.998Z,1379378213.998 [Reporter](INFO): platform_buoyancy_position 316.266436 cc
2013-09-17T00:36:55.216Z,1379378215.216 [Reporter](INFO): platform_buoyancy_position 320.429739 cc
2013-09-17T00:36:55.328Z,1379378215.328 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:36:55.328Z,1379378215.328 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:36:56.402Z,1379378216.402 [Reporter](INFO): platform_buoyancy_position 324.861641 cc
2013-09-17T00:36:57.331Z,1379378217.331 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:36:57.331Z,1379378217.331 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:36:57.604Z,1379378217.604 [Reporter](INFO): platform_buoyancy_position 329.024944 cc
2013-09-17T00:36:58.841Z,1379378218.841 [Reporter](INFO): platform_buoyancy_position 333.322532 cc
2013-09-17T00:36:59.337Z,1379378219.337 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:36:59.337Z,1379378219.337 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:36:59.338Z,1379378219.338 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:36:59.000Z,1379378220.000 [Reporter](INFO): platform_buoyancy_position 336.008554 cc
2013-09-17T00:37:01.218Z,1379378221.218 [Reporter](INFO): platform_buoyancy_position 339.903228 cc
2013-09-17T00:37:01.344Z,1379378221.344 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:37:01.344Z,1379378221.344 [DVL_micro](INFO): Querying output modes
2013-09-17T00:37:01.345Z,1379378221.345 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:37:02.400Z,1379378222.400 [Reporter](INFO): platform_buoyancy_position 344.200846 cc
2013-09-17T00:37:03.355Z,1379378223.355 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:37:03.356Z,1379378223.356 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:37:03.356Z,1379378223.356 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:37:03.605Z,1379378223.605 [Reporter](INFO): platform_buoyancy_position 348.498434 cc
2013-09-17T00:37:04.835Z,1379378224.835 [Reporter](INFO): platform_buoyancy_position 352.661737 cc
2013-09-17T00:37:05.359Z,1379378225.359 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:37:06.005Z,1379378226.005 [Reporter](INFO): platform_buoyancy_position 356.825039 cc
2013-09-17T00:37:07.235Z,1379378227.235 [Reporter](INFO): platform_buoyancy_position 359.108119 cc
2013-09-17T00:37:07.362Z,1379378227.362 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:37:07.362Z,1379378227.362 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:37:08.405Z,1379378228.405 [Reporter](INFO): platform_buoyancy_position 363.405736 cc
2013-09-17T00:37:09.365Z,1379378229.365 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:37:09.366Z,1379378229.366 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:37:09.607Z,1379378229.607 [Reporter](INFO): platform_buoyancy_position 367.837638 cc
2013-09-17T00:37:10.487Z,1379378230.487 [CommandLine](IMPORTANT): got command run ./Missions/Insert/Science.xml
2013-09-17T00:37:10.487Z,1379378230.487 [MissionManager](INFO): Loading Mission: ./Missions/Insert/Science.xml
2013-09-17T00:37:10.591Z,1379378230.591 [MissionManager](INFO): DefineArg Science.SampleISUS = 0 bool
2013-09-17T00:37:10.594Z,1379378230.594 [MissionManager](INFO): DefineArg Science.SampleISUSmaxPitch = 60.000000 arcdeg
2013-09-17T00:37:10.598Z,1379378230.598 [MissionManager](INFO): DefineArg Science.SampleISUSminPitch = -60.000000 arcdeg
2013-09-17T00:37:10.601Z,1379378230.601 [MissionManager](INFO): DefineArg Science.SampleRSSI = 1 bool
2013-09-17T00:37:10.604Z,1379378230.604 [MissionManager](INFO): DefineArg Science.SampleADCP = 0 bool
2013-09-17T00:37:10.607Z,1379378230.607 [MissionManager](INFO): DefineArg Science.PeakDetectChlActive = 0 bool
2013-09-17T00:37:10.610Z,1379378230.610 [MissionManager](INFO): DefineArg Science.PeakDetectNO3Active = 0 bool
2013-09-17T00:37:10.613Z,1379378230.613 [MissionManager](INFO): DefineArg Science.PeakDetectRSSIActive = 0 bool
2013-09-17T00:37:10.616Z,1379378230.616 [MissionManager](INFO): DefineArg Science.UpwardDerivativeOfTemperatureActive = 0 bool
2013-09-17T00:37:10.635Z,1379378230.635 [MissionManager](INFO): DefineArg Science.ComputeWaterCurrent = 0 bool
2013-09-17T00:37:10.638Z,1379378230.638 [MissionManager](INFO): DefineArg Science.ComputeWaterCurrentMinDepth = 2.000000 m
2013-09-17T00:37:10.642Z,1379378230.642 [MissionManager](INFO): DefineArg Science.ComputeWaterCurrentMaxDepth = 5.000000 m
2013-09-17T00:37:10.649Z,1379378230.649 [MissionManager](INFO): DefineArg Science.EnabledAanderaaO2 = 0.000000 n/a
2013-09-17T00:37:10.654Z,1379378230.654 [MissionManager](INFO): DefineArg Science.EnabledNeilBrown = 1.000000 n/a
2013-09-17T00:37:10.666Z,1379378230.666 [MissionManager](INFO): DefineArg Science.EnabledTurbulence_NPS = 0.000000 n/a
2013-09-17T00:37:10.673Z,1379378230.673 [MissionManager](INFO): DefineArg Science.EnabledWetLabsBB2FL = 1.000000 n/a
2013-09-17T00:37:10.677Z,1379378230.677 [MissionManager](INFO): DefineArg Science.EnabledDVL = 1.000000 n/a
2013-09-17T00:37:10.681Z,1379378230.681 [MissionManager](INFO): DefineArg Science.EnabledISUS = 0.000000 n/a
2013-09-17T00:37:10.685Z,1379378230.685 [MissionManager](INFO): DefineOutput Science.PeakChl = 0.000000 ug/l
2013-09-17T00:37:10.688Z,1379378230.688 [MissionManager](INFO): DefineOutput Science.PeakChlDepth = 0.000000 m
2013-09-17T00:37:10.692Z,1379378230.692 [MissionManager](INFO): DefineOutput Science.PeakChlLatitude = nan arcdeg
2013-09-17T00:37:10.695Z,1379378230.695 [MissionManager](INFO): DefineOutput Science.PeakChlLongitude = nan arcdeg
2013-09-17T00:37:10.698Z,1379378230.698 [MissionManager](INFO): DefineOutput Science.PeakNO3 = 0.000000 umol/l
2013-09-17T00:37:10.702Z,1379378230.702 [MissionManager](INFO): DefineOutput Science.PeakNO3Depth = 0.000000 m
2013-09-17T00:37:10.705Z,1379378230.705 [MissionManager](INFO): DefineOutput Science.PeakNO3Latitude = nan arcdeg
2013-09-17T00:37:10.709Z,1379378230.709 [MissionManager](INFO): DefineOutput Science.PeakNO3Longitude = nan arcdeg
2013-09-17T00:37:10.712Z,1379378230.712 [MissionManager](INFO): DefineOutput Science.PeakRSSI = 0.000000 dB
2013-09-17T00:37:10.716Z,1379378230.716 [MissionManager](INFO): DefineOutput Science.PeakRSSIDepth = 0.000000 m
2013-09-17T00:37:10.762Z,1379378230.762 [MissionManager](INFO): DefineOutput Science.PeakRSSILatitude = nan arcdeg
2013-09-17T00:37:10.766Z,1379378230.766 [MissionManager](INFO): DefineOutput Science.PeakRSSILongitude = nan arcdeg
2013-09-17T00:37:10.813Z,1379378230.813 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2013-09-17T00:37:10.847Z,1379378230.847 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2013-09-17T00:37:10.867Z,1379378230.867 [Science:PeakDetectRSSI:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2013-09-17T00:37:10.891Z,1379378230.891 [MissionManager](DEBUG):
Set either this or PeakDetectNO3Active to True in order to sample
Nitrate. EnabledISUS must also be true.
Maximum pitch to sample ISUS. (EnabledISUS must also be true.)
60.0
Minimum pitch to sample ISUS. (EnabledISUS must also be true.)
-60.0
Set to True in order to sample RSSI data from the DVL. EnabledDVL must
also be true.
Set to True in order to sample ADCP data from the DVL. EnabledDVL must
also be true.
Turns on peak detection of Cholorphyll.
Turns on peak detection of Nitrate (and turns on ISUS).
Turns on peak detection of RSSI (and turns on RSSI mode of DVL).
Turns on seawater temperature derivative.
Compute and report water current (from LinkQuest full column average)
Minimum depth to compute and report water current (from LinkQuest full
column average)
2.0
Maximum depth to compute and report water current (from LinkQuest full
column average)
5.0
Automatically set to True if the Aanderaa O2 sensor is installed. Set to
false to disable reading Aandera O2.
Automatically set to true if the Neil Brown CTD is enabled. Set to false
to disable reading from the Neil Brown.
Automatically set to true if the NPS Turbulence sensor is enabled. Set
to false to disable reading from the NPS Turbulence sensor.
Automatically set to true if the the WetLabs BB2FL is enabled. Set to
false to disable the WetLabs BB2FL.
Automatically set to True if DVL is enabled. Set to false to disable the
DVL.
Automatically set to True if ISUS is enabled. Set to false to disable
ISUS.
0
0
NaN
NaN
0
0
NaN
NaN
0
0
NaN
NaN
2013-09-17T00:37:10.894Z,1379378230.894 [CommandLine](IMPORTANT): Running ./Missions/Insert/Science.xml
2013-09-17T00:37:10.909Z,1379378230.909 [Reporter](INFO): platform_buoyancy_position 372.000941 cc
2013-09-17T00:37:11.376Z,1379378231.376 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:37:11.376Z,1379378231.376 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:37:11.376Z,1379378231.376 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:37:12.006Z,1379378232.006 [Reporter](INFO): platform_buoyancy_position 374.284020 cc
2013-09-17T00:37:13.245Z,1379378233.245 [Reporter](INFO): platform_buoyancy_position 378.447323 cc
2013-09-17T00:37:13.387Z,1379378233.387 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:37:13.387Z,1379378233.387 [DVL_micro](INFO): Querying output modes
2013-09-17T00:37:13.387Z,1379378233.387 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:37:14.402Z,1379378234.402 [Reporter](INFO): platform_buoyancy_position 382.744940 cc
2013-09-17T00:37:15.398Z,1379378235.398 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:37:15.398Z,1379378235.398 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:37:15.399Z,1379378235.399 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:37:15.604Z,1379378235.604 [Reporter](INFO): platform_buoyancy_position 387.042528 cc
2013-09-17T00:37:16.841Z,1379378236.841 [Reporter](INFO): platform_buoyancy_position 391.340145 cc
2013-09-17T00:37:17.409Z,1379378237.409 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:37:17.000Z,1379378238.000 [Reporter](INFO): platform_buoyancy_position 393.623224 cc
2013-09-17T00:37:19.238Z,1379378239.238 [Reporter](INFO): platform_buoyancy_position 397.786527 cc
2013-09-17T00:37:19.417Z,1379378239.417 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:37:19.417Z,1379378239.417 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:37:20.399Z,1379378240.399 [Reporter](INFO): platform_buoyancy_position 402.084144 cc
2013-09-17T00:37:21.420Z,1379378241.420 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:37:21.420Z,1379378241.420 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:37:21.609Z,1379378241.609 [Reporter](INFO): platform_buoyancy_position 406.381732 cc
2013-09-17T00:37:22.835Z,1379378242.835 [Reporter](INFO): platform_buoyancy_position 410.679349 cc
2013-09-17T00:37:23.431Z,1379378243.431 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:37:23.431Z,1379378243.431 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:37:23.431Z,1379378243.431 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:37:23.876Z,1379378243.876 [CommandLine](IMPORTANT): got command show variable ctd
2013-09-17T00:37:23.883Z,1379378243.883 [CommandLine](INFO): CTD_NeilBrown.loadControl (none)
2013-09-17T00:37:23.883Z,1379378243.883 [CommandLine](INFO): CTD_NeilBrown.uart (none)
2013-09-17T00:37:23.883Z,1379378243.883 [CommandLine](INFO): CTD_NeilBrown.baud (bit_per_second)
2013-09-17T00:37:23.891Z,1379378243.891 [CommandLine](INFO): CTD_NeilBrown.loadAtStartup (bool)
2013-09-17T00:37:23.891Z,1379378243.891 [CommandLine](INFO): CTD_NeilBrown.simulateHardware (bool)
2013-09-17T00:37:23.892Z,1379378243.892 [CommandLine](INFO): CTD_NeilBrown.power (watt)
2013-09-17T00:37:23.892Z,1379378243.892 [CommandLine](INFO): CTD_NeilBrown.maxPressBound (decibar)
2013-09-17T00:37:23.892Z,1379378243.892 [CommandLine](INFO): CTD_NeilBrown.minPressBound (decibar)
2013-09-17T00:37:23.893Z,1379378243.893 [CommandLine](INFO): CTD_NeilBrown.offset (decibar)
2013-09-17T00:37:23.893Z,1379378243.893 [CommandLine](INFO): CTD_NeilBrown.maxSalinityBound (practical_salinity_unit)
2013-09-17T00:37:23.893Z,1379378243.893 [CommandLine](INFO): CTD_NeilBrown.minSalinityBound (practical_salinity_unit)
2013-09-17T00:37:23.916Z,1379378243.916 [CommandLine](INFO): CTD_NeilBrown.sea_water_density (kilogram_per_cubic_meter)
2013-09-17T00:37:23.917Z,1379378243.917 [CommandLine](INFO): CTD_NeilBrown.depth (meter)
2013-09-17T00:37:23.917Z,1379378243.917 [CommandLine](INFO): CTD_NeilBrown.sea_water_pressure (decibar)
2013-09-17T00:37:23.917Z,1379378243.917 [CommandLine](INFO): CTD_NeilBrown.sea_water_salinity (practical_salinity_unit)
2013-09-17T00:37:23.918Z,1379378243.918 [CommandLine](INFO): CTD_NeilBrown.sea_water_temperature (celsius)
2013-09-17T00:37:23.918Z,1379378243.918 [CommandLine](INFO): CTD_NeilBrown.sea_water_electrical_conductivity (millimho_per_centimeter)
2013-09-17T00:37:23.956Z,1379378243.956 [CommandLine](INFO): CTD_NeilBrown.durationOfLastRun (second)
2013-09-17T00:37:23.956Z,1379378243.956 [CommandLine](INFO): CTD_NeilBrown.component_voltage (volt)
2013-09-17T00:37:23.957Z,1379378243.957 [CommandLine](INFO): CTD_NeilBrown.component_avgVoltage (volt)
2013-09-17T00:37:23.957Z,1379378243.957 [CommandLine](INFO): CTD_NeilBrown.component_current (milliampere)
2013-09-17T00:37:23.957Z,1379378243.957 [CommandLine](INFO): CTD_NeilBrown.component_avgCurrent (milliampere)
2013-09-17T00:37:24.030Z,1379378244.030 [Reporter](INFO): platform_buoyancy_position 413.365342 cc
2013-09-17T00:37:25.215Z,1379378245.215 [Reporter](INFO): platform_buoyancy_position 417.394331 cc
2013-09-17T00:37:25.442Z,1379378245.442 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:37:25.442Z,1379378245.442 [DVL_micro](INFO): Querying output modes
2013-09-17T00:37:25.442Z,1379378245.442 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:37:26.405Z,1379378246.405 [Reporter](INFO): platform_buoyancy_position 421.557634 cc
2013-09-17T00:37:27.453Z,1379378247.453 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:37:27.453Z,1379378247.453 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:37:27.453Z,1379378247.453 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:37:27.599Z,1379378247.599 [Reporter](INFO): platform_buoyancy_position 425.720908 cc
2013-09-17T00:37:28.840Z,1379378248.840 [Reporter](INFO): platform_buoyancy_position 430.152868 cc
2013-09-17T00:37:29.180Z,1379378249.180 [Startup:StartupSatComms:A](INFO): Timed out from 2013-09-17T00:36:28.8Z
2013-09-17T00:37:29.180Z,1379378249.180 [Startup:StartupSatComms:A:A_Timeout] Running Loop=1
2013-09-17T00:37:29.181Z,1379378249.181 [Startup:StartupSatComms:A:A_Timeout](INFO): Aggregate::initialize Startup:StartupSatComms:A:A_Timeout
2013-09-17T00:37:29.181Z,1379378249.181 [Startup:StartupSatComms:A:A_Timeout](INFO): Completed Startup:StartupSatComms:A:A_Timeout
2013-09-17T00:37:29.181Z,1379378249.181 [Startup:StartupSatComms:A] Stopped
2013-09-17T00:37:29.181Z,1379378249.181 [Startup:StartupSatComms:B] Running Loop=1
2013-09-17T00:37:29.456Z,1379378249.456 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:37:29.569Z,1379378249.569 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2013-09-17T00:37:30.006Z,1379378250.006 [Reporter](INFO): platform_buoyancy_position 434.316142 cc
2013-09-17T00:37:31.176Z,1379378251.176 [Reporter](INFO): platform_buoyancy_position 436.464936 cc
2013-09-17T00:37:31.468Z,1379378251.468 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:37:31.468Z,1379378251.468 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:37:32.177Z,1379378252.177 [Reporter](INFO): platform_buoyancy_position 440.762553 cc
2013-09-17T00:37:33.471Z,1379378253.471 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:37:33.471Z,1379378253.471 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:37:33.488Z,1379378253.488 [Reporter](INFO): platform_buoyancy_position 445.194426 cc
2013-09-17T00:37:34.646Z,1379378254.646 [Reporter](INFO): platform_buoyancy_position 449.357758 cc
2013-09-17T00:37:35.473Z,1379378255.473 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:37:35.473Z,1379378255.473 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:37:35.474Z,1379378255.474 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:37:36.372Z,1379378256.372 [Reporter](INFO): platform_buoyancy_position 453.655375 cc
2013-09-17T00:37:37.484Z,1379378257.484 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:37:37.484Z,1379378257.484 [DVL_micro](INFO): Querying output modes
2013-09-17T00:37:37.485Z,1379378257.485 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:37:37.690Z,1379378257.690 [Reporter](INFO): platform_buoyancy_position 458.221533 cc
2013-09-17T00:37:38.848Z,1379378258.848 [Reporter](INFO): platform_buoyancy_position 462.250522 cc
2013-09-17T00:37:39.495Z,1379378259.495 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:37:39.496Z,1379378259.496 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:37:39.496Z,1379378259.496 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:37:40.074Z,1379378260.074 [Reporter](INFO): platform_buoyancy_position 466.682453 cc
2013-09-17T00:37:41.079Z,1379378261.079 [Reporter](INFO): platform_buoyancy_position 470.442843 cc
2013-09-17T00:37:41.507Z,1379378261.507 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:37:42.273Z,1379378262.273 [Reporter](INFO): platform_buoyancy_position 473.128865 cc
2013-09-17T00:37:43.439Z,1379378263.439 [Reporter](INFO): platform_buoyancy_position 477.292138 cc
2013-09-17T00:37:43.519Z,1379378263.519 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:37:43.520Z,1379378263.520 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:37:45.174Z,1379378265.174 [Reporter](INFO): platform_buoyancy_position 483.738550 cc
2013-09-17T00:37:45.525Z,1379378265.525 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:37:45.526Z,1379378265.526 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:37:46.476Z,1379378266.476 [Reporter](INFO): platform_buoyancy_position 488.036167 cc
2013-09-17T00:37:47.532Z,1379378267.532 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:37:47.532Z,1379378267.532 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:37:47.532Z,1379378267.532 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:37:47.646Z,1379378267.646 [Reporter](INFO): platform_buoyancy_position 490.990758 cc
2013-09-17T00:37:48.799Z,1379378268.799 [CommandLine](IMPORTANT): got command report periodic 1.000000 platform_pressure
2013-09-17T00:37:48.979Z,1379378268.979 [Reporter](INFO): platform_buoyancy_position 496.631372 cc
2013-09-17T00:37:49.539Z,1379378269.539 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:37:49.539Z,1379378269.539 [DVL_micro](INFO): Querying output modes
2013-09-17T00:37:49.539Z,1379378269.539 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:37:50.278Z,1379378270.278 [Reporter](INFO): platform_buoyancy_position 500.928902 cc
2013-09-17T00:37:51.472Z,1379378271.472 [Reporter](INFO): platform_buoyancy_position 503.346324 cc
2013-09-17T00:37:51.546Z,1379378271.546 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:37:51.546Z,1379378271.546 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:37:51.546Z,1379378271.546 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:37:52.650Z,1379378272.650 [Reporter](INFO): platform_buoyancy_position 507.509685 cc
2013-09-17T00:37:53.557Z,1379378273.557 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:37:53.711Z,1379378273.711 [Reporter](INFO): platform_buoyancy_position 511.672930 cc
2013-09-17T00:37:54.869Z,1379378274.869 [Reporter](INFO): platform_buoyancy_position 516.104803 cc
2013-09-17T00:37:55.569Z,1379378275.569 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:37:55.569Z,1379378275.569 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:37:56.055Z,1379378276.055 [Reporter](INFO): platform_buoyancy_position 518.387940 cc
2013-09-17T00:37:57.572Z,1379378277.572 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:37:57.572Z,1379378277.572 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:37:57.773Z,1379378277.773 [Reporter](INFO): platform_buoyancy_position 524.700037 cc
2013-09-17T00:37:59.075Z,1379378279.075 [Reporter](INFO): platform_buoyancy_position 528.863340 cc
2013-09-17T00:37:59.575Z,1379378279.575 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:37:59.575Z,1379378279.575 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:37:59.575Z,1379378279.575 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:38:00.245Z,1379378280.245 [Reporter](INFO): platform_buoyancy_position 533.160928 cc
2013-09-17T00:38:01.443Z,1379378281.443 [Reporter](INFO): platform_buoyancy_position 537.458516 cc
2013-09-17T00:38:01.570Z,1379378281.570 [CommandLine](IMPORTANT): got command report clear
2013-09-17T00:38:01.582Z,1379378281.582 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:38:01.582Z,1379378281.582 [DVL_micro](INFO): Querying output modes
2013-09-17T00:38:01.582Z,1379378281.582 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:38:03.584Z,1379378283.584 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:38:03.584Z,1379378283.584 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:38:03.584Z,1379378283.584 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:38:04.948Z,1379378284.948 [CommandLine](IMPORTANT): got command report periodic 1.000000 platform_pressure
2013-09-17T00:38:05.588Z,1379378285.588 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:38:07.592Z,1379378287.592 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:38:07.592Z,1379378287.592 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:38:09.595Z,1379378289.595 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:38:09.595Z,1379378289.595 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:38:11.597Z,1379378291.597 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:38:11.597Z,1379378291.597 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:38:11.598Z,1379378291.598 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:38:13.610Z,1379378293.610 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:38:13.610Z,1379378293.610 [DVL_micro](INFO): Querying output modes
2013-09-17T00:38:13.611Z,1379378293.611 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:38:15.611Z,1379378295.611 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:38:15.612Z,1379378295.612 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:38:15.612Z,1379378295.612 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:38:17.623Z,1379378297.623 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:38:19.630Z,1379378299.630 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:38:19.631Z,1379378299.631 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:38:21.633Z,1379378301.633 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:38:21.634Z,1379378301.634 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:38:23.640Z,1379378303.640 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:38:23.640Z,1379378303.640 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:38:23.640Z,1379378303.640 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:38:25.523Z,1379378305.523 [CommandLine](IMPORTANT): got command report clear
2013-09-17T00:38:25.647Z,1379378305.647 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:38:25.647Z,1379378305.647 [DVL_micro](INFO): Querying output modes
2013-09-17T00:38:25.647Z,1379378305.647 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:38:27.658Z,1379378307.658 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:38:27.658Z,1379378307.658 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:38:27.658Z,1379378307.658 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:38:29.490Z,1379378309.490 [Startup:StartupSatComms:B](INFO): Timed out from 2013-09-17T00:37:29.2Z
2013-09-17T00:38:29.490Z,1379378309.490 [Startup:StartupSatComms:B:A_Timeout] Running Loop=1
2013-09-17T00:38:29.490Z,1379378309.490 [Startup:StartupSatComms:B:A_Timeout](INFO): Aggregate::initialize Startup:StartupSatComms:B:A_Timeout
2013-09-17T00:38:29.490Z,1379378309.490 [Startup:StartupSatComms:B:A_Timeout](INFO): Completed Startup:StartupSatComms:B:A_Timeout
2013-09-17T00:38:29.490Z,1379378309.490 [Startup:StartupSatComms:B] Stopped
2013-09-17T00:38:29.490Z,1379378309.490 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2013-09-17T00:38:29.490Z,1379378309.490 [Startup:StartupSatComms] Stopped
2013-09-17T00:38:29.491Z,1379378309.491 [Startup:StartupSatComms](INFO): Aggregate::uninitialize Startup:StartupSatComms
2013-09-17T00:38:29.491Z,1379378309.491 [Startup](INFO): Completed Startup
2013-09-17T00:38:29.492Z,1379378309.492 [Startup] Stopped
2013-09-17T00:38:29.492Z,1379378309.492 [Startup](INFO): Aggregate::uninitialize Startup
2013-09-17T00:38:29.492Z,1379378309.492 [Startup:A.GoToSurface] Stopped
2013-09-17T00:38:29.492Z,1379378309.492 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-09-17T00:38:29.596Z,1379378309.596 [MissionManager](IMPORTANT): Started mission Science
2013-09-17T00:38:29.596Z,1379378309.596 [Science] Running Loop=1
2013-09-17T00:38:29.597Z,1379378309.597 [Science](INFO): Aggregate::initialize Science
2013-09-17T00:38:29.597Z,1379378309.597 [Science:A] Running Loop=1
2013-09-17T00:38:29.597Z,1379378309.597 [Science:B] Running Loop=1
2013-09-17T00:38:29.597Z,1379378309.597 [Science:C] Running Loop=1
2013-09-17T00:38:29.597Z,1379378309.597 [Science:D] Running Loop=1
2013-09-17T00:38:29.597Z,1379378309.597 [Science:E] Running Loop=1
2013-09-17T00:38:29.597Z,1379378309.597 [Science:F] Running Loop=1
2013-09-17T00:38:29.597Z,1379378309.597 [Science:G] Running Loop=1
2013-09-17T00:38:29.597Z,1379378309.597 [Science:H] Running Loop=1
2013-09-17T00:38:29.598Z,1379378309.598 [Science:I] Running Loop=1
2013-09-17T00:38:29.598Z,1379378309.598 [Science:I] Running Loop=1
2013-09-17T00:38:29.599Z,1379378309.599 [Science:I](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2013-09-17T00:38:29.601Z,1379378309.601 [Science:H] Running Loop=1
2013-09-17T00:38:29.602Z,1379378309.602 [Science:H](DEBUG): Initialize ReadDataComponent to sense DVL_micro.Beam1RSSI
2013-09-17T00:38:29.603Z,1379378309.603 [Science:D] Running Loop=1
2013-09-17T00:38:29.604Z,1379378309.604 [Science:D](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature
2013-09-17T00:38:29.604Z,1379378309.604 [Science:D](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity
2013-09-17T00:38:29.662Z,1379378309.662 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:38:29.769Z,1379378309.769 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2013-09-17T00:38:29.915Z,1379378309.915 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=4
2013-09-17T00:38:29.915Z,1379378309.915 [WetLabsBB2FL](INFO): Powering up
2013-09-17T00:38:31.481Z,1379378311.481 [CommandLine](IMPORTANT): got command show variable pressure
2013-09-17T00:38:31.485Z,1379378311.485 [CommandLine](INFO): platform_pressure (unknown)
2013-09-17T00:38:31.487Z,1379378311.487 [CommandLine](INFO): sea_water_pressure (decibar)
2013-09-17T00:38:31.491Z,1379378311.491 [CommandLine](INFO): OnboardPressure.ad (none)
2013-09-17T00:38:31.496Z,1379378311.496 [CommandLine](INFO): OnboardPressure.adVref (volt)
2013-09-17T00:38:31.497Z,1379378311.497 [CommandLine](INFO): OnboardPressure.adRes (bit)
2013-09-17T00:38:31.500Z,1379378311.500 [CommandLine](INFO): OnboardPressure.slope (pound_per_square_inch_per_volt)
2013-09-17T00:38:31.500Z,1379378311.500 [CommandLine](INFO): OnboardPressure.intercept (pound_per_square_inch)
2013-09-17T00:38:31.501Z,1379378311.501 [CommandLine](INFO): CBIT.pressureThreshold (pound_per_square_inch)
2013-09-17T00:38:31.516Z,1379378311.516 [CommandLine](INFO): Onboard.Pressure (pound_per_square_inch)
2013-09-17T00:38:31.542Z,1379378311.542 [CommandLine](INFO): Depth_Keller.sea_water_pressure (decibar)
2013-09-17T00:38:31.571Z,1379378311.571 [CommandLine](INFO): CTD_NeilBrown.sea_water_pressure (decibar)
2013-09-17T00:38:31.669Z,1379378311.669 [DVL_micro](INFO): RSSI requested
2013-09-17T00:38:31.669Z,1379378311.669 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:38:31.669Z,1379378311.669 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:38:33.672Z,1379378313.672 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:38:33.672Z,1379378313.672 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:38:35.194Z,1379378315.194 [WetLabsBB2FL] Communications Fault, FailCount= 1
2013-09-17T00:38:35.194Z,1379378315.194 [WetLabsBB2FL](ERROR): Communications Fault
2013-09-17T00:38:35.214Z,1379378315.214 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2013-09-17T00:38:35.286Z,1379378315.286 [WetLabsBB2FL](INFO): Powering down
2013-09-17T00:38:35.683Z,1379378315.683 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:38:35.683Z,1379378315.683 [DVL_micro](INFO): Enabling RSSI output
2013-09-17T00:38:35.683Z,1379378315.683 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 16 7
2013-09-17T00:38:36.009Z,1379378316.009 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2013-09-17T00:38:36.009Z,1379378316.009 [WetLabsBB2FL] No Fault, FailCount= 1
2013-09-17T00:38:36.097Z,1379378316.097 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=4
2013-09-17T00:38:36.097Z,1379378316.097 [WetLabsBB2FL](INFO): Powering up
2013-09-17T00:38:37.686Z,1379378317.686 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:38:37.686Z,1379378317.686 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:38:37.686Z,1379378317.686 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:38:39.689Z,1379378319.689 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:38:39.689Z,1379378319.689 [DVL_micro](INFO): Querying output modes
2013-09-17T00:38:39.689Z,1379378319.689 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:38:41.400Z,1379378321.400 [WetLabsBB2FL] Communications Fault, FailCount= 2
2013-09-17T00:38:41.400Z,1379378321.400 [WetLabsBB2FL](ERROR): Communications Fault
2013-09-17T00:38:41.492Z,1379378321.492 [WetLabsBB2FL](INFO): Powering down
2013-09-17T00:38:41.639Z,1379378321.639 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2013-09-17T00:38:41.700Z,1379378321.700 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:38:41.700Z,1379378321.700 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:38:41.700Z,1379378321.700 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:38:42.014Z,1379378322.014 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2013-09-17T00:38:42.014Z,1379378322.014 [WetLabsBB2FL] No Fault, FailCount= 2
2013-09-17T00:38:42.302Z,1379378322.302 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=4
2013-09-17T00:38:42.302Z,1379378322.302 [WetLabsBB2FL](INFO): Powering up
2013-09-17T00:38:43.712Z,1379378323.712 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:38:45.523Z,1379378325.523 [CommandLine](IMPORTANT): got command report periodic 1.000000 sea_water_pressure
2013-09-17T00:38:45.637Z,1379378325.637 [Reporter](INFO): sea_water_pressure -0.068486 db
2013-09-17T00:38:45.745Z,1379378325.745 [DVL_micro](INFO): RSSI requested
2013-09-17T00:38:45.745Z,1379378325.745 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:38:45.745Z,1379378325.745 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:38:46.836Z,1379378326.836 [Reporter](INFO): sea_water_pressure -0.076780 db
2013-09-17T00:38:47.605Z,1379378327.605 [WetLabsBB2FL] Communications Fault, FailCount= 3
2013-09-17T00:38:47.605Z,1379378327.605 [WetLabsBB2FL](ERROR): Communications Fault
2013-09-17T00:38:47.612Z,1379378327.612 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2013-09-17T00:38:47.702Z,1379378327.702 [WetLabsBB2FL](INFO): Powering down
2013-09-17T00:38:47.750Z,1379378327.750 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:38:47.750Z,1379378327.750 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:38:48.037Z,1379378328.037 [Reporter](INFO): sea_water_pressure -0.074161 db
2013-09-17T00:38:48.440Z,1379378328.440 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2013-09-17T00:38:48.440Z,1379378328.440 [WetLabsBB2FL] No Fault, FailCount= 3
2013-09-17T00:38:48.512Z,1379378328.512 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=4
2013-09-17T00:38:48.512Z,1379378328.512 [WetLabsBB2FL](INFO): Powering up
2013-09-17T00:38:49.241Z,1379378329.241 [Reporter](INFO): sea_water_pressure -0.063685 db
2013-09-17T00:38:49.752Z,1379378329.752 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:38:49.753Z,1379378329.753 [DVL_micro](INFO): Enabling RSSI output
2013-09-17T00:38:49.753Z,1379378329.753 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 16 7
2013-09-17T00:38:50.416Z,1379378330.416 [Reporter](INFO): sea_water_pressure -0.090311 db
2013-09-17T00:38:51.644Z,1379378331.644 [Reporter](INFO): sea_water_pressure -0.085946 db
2013-09-17T00:38:51.760Z,1379378331.760 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:38:51.760Z,1379378331.760 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:38:51.760Z,1379378331.760 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:38:52.832Z,1379378332.832 [Reporter](INFO): sea_water_pressure -0.079835 db
2013-09-17T00:38:53.763Z,1379378333.763 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:38:53.763Z,1379378333.763 [DVL_micro](INFO): Querying output modes
2013-09-17T00:38:53.763Z,1379378333.763 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:38:53.775Z,1379378333.775 [WetLabsBB2FL] Communications Fault, FailCount= 4
2013-09-17T00:38:53.775Z,1379378333.775 [WetLabsBB2FL](ERROR): Communications Fault
2013-09-17T00:38:53.873Z,1379378333.873 [WetLabsBB2FL](INFO): Powering down
2013-09-17T00:38:54.012Z,1379378334.012 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2013-09-17T00:38:54.013Z,1379378334.013 [Reporter](INFO): sea_water_pressure -0.082454 db
2013-09-17T00:38:54.435Z,1379378334.435 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2013-09-17T00:38:54.435Z,1379378334.435 [WetLabsBB2FL] No Fault, FailCount= 4
2013-09-17T00:38:54.682Z,1379378334.682 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=4
2013-09-17T00:38:54.682Z,1379378334.682 [WetLabsBB2FL](INFO): Powering up
2013-09-17T00:38:55.243Z,1379378335.243 [Reporter](INFO): sea_water_pressure -0.058883 db
2013-09-17T00:38:55.770Z,1379378335.770 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:38:55.770Z,1379378335.770 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:38:55.770Z,1379378335.770 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:38:56.416Z,1379378336.416 [Reporter](INFO): sea_water_pressure -0.060629 db
2013-09-17T00:38:57.638Z,1379378337.638 [Reporter](INFO): sea_water_pressure -0.077216 db
2013-09-17T00:38:57.777Z,1379378337.777 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:38:58.834Z,1379378338.834 [Reporter](INFO): sea_water_pressure -0.071978 db
2013-09-17T00:38:59.789Z,1379378339.789 [DVL_micro](INFO): RSSI requested
2013-09-17T00:38:59.789Z,1379378339.789 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:38:59.789Z,1379378339.789 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:38:59.980Z,1379378339.980 [WetLabsBB2FL] Communications Fault, FailCount= 5
2013-09-17T00:38:59.981Z,1379378339.981 [WetLabsBB2FL](ERROR): Communications Fault
2013-09-17T00:39:00.013Z,1379378340.013 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2013-09-17T00:39:00.013Z,1379378340.013 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL
2013-09-17T00:39:00.015Z,1379378340.015 [Reporter](INFO): sea_water_pressure -0.065867 db
2013-09-17T00:39:00.073Z,1379378340.073 [WetLabsBB2FL](INFO): Powering down
2013-09-17T00:39:01.288Z,1379378341.288 [Reporter](INFO): sea_water_pressure -0.058447 db
2013-09-17T00:39:01.791Z,1379378341.791 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:39:01.792Z,1379378341.792 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:39:02.447Z,1379378342.447 [Reporter](INFO): sea_water_pressure -0.078089 db
2013-09-17T00:39:03.703Z,1379378343.703 [Reporter](INFO): sea_water_pressure -0.089002 db
2013-09-17T00:39:03.794Z,1379378343.794 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:39:03.794Z,1379378343.794 [DVL_micro](INFO): Enabling RSSI output
2013-09-17T00:39:03.795Z,1379378343.795 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 16 7
2013-09-17T00:39:04.847Z,1379378344.847 [Reporter](INFO): sea_water_pressure -0.082018 db
2013-09-17T00:39:05.797Z,1379378345.797 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:39:05.798Z,1379378345.798 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:39:05.798Z,1379378345.798 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:39:06.051Z,1379378346.051 [Reporter](INFO): sea_water_pressure -0.080272 db
2013-09-17T00:39:07.243Z,1379378347.243 [Reporter](INFO): sea_water_pressure -0.050153 db
2013-09-17T00:39:07.800Z,1379378347.800 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:39:07.801Z,1379378347.801 [DVL_micro](INFO): Querying output modes
2013-09-17T00:39:07.801Z,1379378347.801 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:39:08.459Z,1379378348.459 [Reporter](INFO): sea_water_pressure -0.082454 db
2013-09-17T00:39:09.673Z,1379378349.673 [Reporter](INFO): sea_water_pressure -0.081145 db
2013-09-17T00:39:09.804Z,1379378349.804 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:39:09.804Z,1379378349.804 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:39:09.804Z,1379378349.804 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:39:10.839Z,1379378350.839 [Reporter](INFO): sea_water_pressure -0.068923 db
2013-09-17T00:39:11.813Z,1379378351.813 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:39:12.049Z,1379378352.049 [Reporter](INFO): sea_water_pressure -0.075034 db
2013-09-17T00:39:13.278Z,1379378353.278 [Reporter](INFO): sea_water_pressure -0.059756 db
2013-09-17T00:39:13.876Z,1379378353.876 [DVL_micro](INFO): RSSI requested
2013-09-17T00:39:13.876Z,1379378353.876 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:39:13.876Z,1379378353.876 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:39:14.476Z,1379378354.476 [Reporter](INFO): sea_water_pressure -0.078089 db
2013-09-17T00:39:15.674Z,1379378355.674 [Reporter](INFO): sea_water_pressure -0.085946 db
2013-09-17T00:39:15.881Z,1379378355.881 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:39:15.882Z,1379378355.882 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:39:16.844Z,1379378356.844 [Reporter](INFO): sea_water_pressure -0.078962 db
2013-09-17T00:39:17.884Z,1379378357.884 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:39:17.884Z,1379378357.884 [DVL_micro](INFO): Enabling RSSI output
2013-09-17T00:39:17.884Z,1379378357.884 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 16 7
2013-09-17T00:39:18.038Z,1379378358.038 [Reporter](INFO): sea_water_pressure -0.071542 db
2013-09-17T00:39:19.283Z,1379378359.283 [Reporter](INFO): sea_water_pressure -0.070232 db
2013-09-17T00:39:19.895Z,1379378359.895 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:39:19.896Z,1379378359.896 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:39:19.896Z,1379378359.896 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:39:20.465Z,1379378360.465 [Reporter](INFO): sea_water_pressure -0.085946 db
2013-09-17T00:39:21.671Z,1379378361.671 [Reporter](INFO): sea_water_pressure -0.079835 db
2013-09-17T00:39:21.898Z,1379378361.898 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:39:21.899Z,1379378361.899 [DVL_micro](INFO): Querying output modes
2013-09-17T00:39:21.899Z,1379378361.899 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:39:22.849Z,1379378362.849 [Reporter](INFO): sea_water_pressure -0.082454 db
2013-09-17T00:39:23.909Z,1379378363.909 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:39:23.910Z,1379378363.910 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:39:23.910Z,1379378363.910 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:39:24.066Z,1379378364.066 [Reporter](INFO): sea_water_pressure -0.078089 db
2013-09-17T00:39:25.246Z,1379378365.246 [Reporter](INFO): sea_water_pressure -0.066740 db
2013-09-17T00:39:25.920Z,1379378365.920 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:39:26.450Z,1379378366.450 [Reporter](INFO): sea_water_pressure -0.074597 db
2013-09-17T00:39:27.645Z,1379378367.645 [Reporter](INFO): sea_water_pressure -0.072851 db
2013-09-17T00:39:27.924Z,1379378367.924 [DVL_micro](INFO): RSSI requested
2013-09-17T00:39:27.924Z,1379378367.924 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:39:27.924Z,1379378367.924 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:39:28.899Z,1379378368.899 [Reporter](INFO): sea_water_pressure -0.090311 db
2013-09-17T00:39:29.927Z,1379378369.927 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:39:29.927Z,1379378369.927 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:39:30.042Z,1379378370.042 [Reporter](INFO): sea_water_pressure -0.077216 db
2013-09-17T00:39:31.254Z,1379378371.254 [Reporter](INFO): sea_water_pressure -0.078089 db
2013-09-17T00:39:31.934Z,1379378371.934 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:39:31.934Z,1379378371.934 [DVL_micro](INFO): Enabling RSSI output
2013-09-17T00:39:31.934Z,1379378371.934 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 16 7
2013-09-17T00:39:32.464Z,1379378372.464 [Reporter](INFO): sea_water_pressure -0.083327 db
2013-09-17T00:39:33.651Z,1379378373.651 [Reporter](INFO): sea_water_pressure -0.073724 db
2013-09-17T00:39:33.957Z,1379378373.957 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:39:33.957Z,1379378373.957 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:39:33.957Z,1379378373.957 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:39:34.860Z,1379378374.860 [Reporter](INFO): sea_water_pressure -0.079399 db
2013-09-17T00:39:35.968Z,1379378375.968 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:39:35.969Z,1379378375.969 [DVL_micro](INFO): Querying output modes
2013-09-17T00:39:35.969Z,1379378375.969 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:39:36.051Z,1379378376.051 [Reporter](INFO): sea_water_pressure -0.068923 db
2013-09-17T00:39:37.284Z,1379378377.284 [Reporter](INFO): sea_water_pressure -0.074597 db
2013-09-17T00:39:37.975Z,1379378377.975 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:39:37.975Z,1379378377.975 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:39:37.976Z,1379378377.976 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:39:38.447Z,1379378378.447 [Reporter](INFO): sea_water_pressure -0.078962 db
2013-09-17T00:39:38.909Z,1379378378.909 [CommandLine](IMPORTANT): got command report periodic 1.000000 CTD_NeilBrown.sea_water_pressure
2013-09-17T00:39:39.255Z,1379378379.255 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.130000 db
2013-09-17T00:39:39.680Z,1379378379.680 [Reporter](INFO): sea_water_pressure -0.070669 db
2013-09-17T00:39:39.982Z,1379378379.982 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:39:40.445Z,1379378380.445 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.120000 db
2013-09-17T00:39:40.853Z,1379378380.853 [Reporter](INFO): sea_water_pressure -0.078962 db
2013-09-17T00:39:41.643Z,1379378381.643 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.130000 db
2013-09-17T00:39:42.056Z,1379378382.056 [DVL_micro](INFO): RSSI requested
2013-09-17T00:39:42.056Z,1379378382.056 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:39:42.056Z,1379378382.056 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:39:42.096Z,1379378382.096 [Reporter](INFO): sea_water_pressure -0.080272 db
2013-09-17T00:39:42.889Z,1379378382.889 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.130000 db
2013-09-17T00:39:43.248Z,1379378383.248 [Reporter](INFO): sea_water_pressure -0.056264 db
2013-09-17T00:39:44.057Z,1379378384.057 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.120000 db
2013-09-17T00:39:44.061Z,1379378384.061 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:39:44.062Z,1379378384.062 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:39:44.452Z,1379378384.452 [Reporter](INFO): sea_water_pressure -0.067177 db
2013-09-17T00:39:45.248Z,1379378385.248 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.120000 db
2013-09-17T00:39:45.653Z,1379378385.653 [Reporter](INFO): sea_water_pressure -0.092930 db
2013-09-17T00:39:46.064Z,1379378386.064 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:39:46.064Z,1379378386.064 [DVL_micro](INFO): Enabling RSSI output
2013-09-17T00:39:46.064Z,1379378386.064 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 16 7
2013-09-17T00:39:46.450Z,1379378386.450 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.140000 db
2013-09-17T00:39:46.847Z,1379378386.847 [Reporter](INFO): sea_water_pressure -0.068050 db
2013-09-17T00:39:47.652Z,1379378387.652 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.130000 db
2013-09-17T00:39:48.056Z,1379378388.056 [Reporter](INFO): sea_water_pressure -0.076780 db
2013-09-17T00:39:48.071Z,1379378388.071 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:39:48.071Z,1379378388.071 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:39:48.071Z,1379378388.071 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:39:48.882Z,1379378388.882 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.130000 db
2013-09-17T00:39:49.264Z,1379378389.264 [Reporter](INFO): sea_water_pressure -0.077216 db
2013-09-17T00:39:50.053Z,1379378390.053 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.130000 db
2013-09-17T00:39:50.082Z,1379378390.082 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:39:50.082Z,1379378390.082 [DVL_micro](INFO): Querying output modes
2013-09-17T00:39:50.082Z,1379378390.082 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:39:50.459Z,1379378390.459 [Reporter](INFO): sea_water_pressure -0.082891 db
2013-09-17T00:39:51.290Z,1379378391.290 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.130000 db
2013-09-17T00:39:51.674Z,1379378391.674 [Reporter](INFO): sea_water_pressure -0.079835 db
2013-09-17T00:39:52.093Z,1379378392.093 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:39:52.093Z,1379378392.093 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:39:52.093Z,1379378392.093 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:39:52.411Z,1379378392.411 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.120000 db
2013-09-17T00:39:52.856Z,1379378392.856 [Reporter](INFO): sea_water_pressure -0.062812 db
2013-09-17T00:39:53.646Z,1379378393.646 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.130000 db
2013-09-17T00:39:54.066Z,1379378394.066 [Reporter](INFO): sea_water_pressure -0.075470 db
2013-09-17T00:39:54.104Z,1379378394.104 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:39:54.891Z,1379378394.891 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.130000 db
2013-09-17T00:39:55.264Z,1379378395.264 [Reporter](INFO): sea_water_pressure -0.075470 db
2013-09-17T00:39:56.041Z,1379378396.041 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.130000 db
2013-09-17T00:39:56.112Z,1379378396.112 [DVL_micro](INFO): RSSI requested
2013-09-17T00:39:56.113Z,1379378396.113 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:39:56.113Z,1379378396.113 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:39:56.442Z,1379378396.442 [Reporter](INFO): sea_water_pressure -0.073724 db
2013-09-17T00:39:57.267Z,1379378397.267 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.120000 db
2013-09-17T00:39:57.679Z,1379378397.679 [Reporter](INFO): sea_water_pressure -0.064121 db
2013-09-17T00:39:58.135Z,1379378398.135 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:39:58.135Z,1379378398.135 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:39:58.457Z,1379378398.457 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.130000 db
2013-09-17T00:39:58.845Z,1379378398.845 [Reporter](INFO): sea_water_pressure -0.078526 db
2013-09-17T00:39:59.671Z,1379378399.671 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.120000 db
2013-09-17T00:40:00.059Z,1379378400.059 [Reporter](INFO): sea_water_pressure -0.065867 db
2013-09-17T00:40:00.146Z,1379378400.146 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:40:00.146Z,1379378400.146 [DVL_micro](INFO): Enabling RSSI output
2013-09-17T00:40:00.146Z,1379378400.146 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 16 7
2013-09-17T00:40:00.869Z,1379378400.869 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.130000 db
2013-09-17T00:40:01.246Z,1379378401.246 [Reporter](INFO): sea_water_pressure -0.083764 db
2013-09-17T00:40:02.102Z,1379378402.102 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.120000 db
2013-09-17T00:40:02.157Z,1379378402.157 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:40:02.157Z,1379378402.157 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:40:02.157Z,1379378402.157 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:40:02.539Z,1379378402.539 [Reporter](INFO): sea_water_pressure -0.061939 db
2013-09-17T00:40:03.308Z,1379378403.308 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.130000 db
2013-09-17T00:40:03.940Z,1379378403.940 [Reporter](INFO): sea_water_pressure -0.075907 db
2013-09-17T00:40:04.164Z,1379378404.164 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:40:04.164Z,1379378404.164 [DVL_micro](INFO): Querying output modes
2013-09-17T00:40:04.164Z,1379378404.164 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:40:04.458Z,1379378404.458 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.130000 db
2013-09-17T00:40:05.259Z,1379378405.259 [Reporter](INFO): sea_water_pressure -0.079399 db
2013-09-17T00:40:05.662Z,1379378405.662 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.130000 db
2013-09-17T00:40:06.171Z,1379378406.171 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:40:06.171Z,1379378406.171 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:40:06.171Z,1379378406.171 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:40:06.469Z,1379378406.469 [Reporter](INFO): sea_water_pressure -0.055391 db
2013-09-17T00:40:06.851Z,1379378406.851 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.130000 db
2013-09-17T00:40:07.612Z,1379378407.612 [Reporter](INFO): sea_water_pressure -0.072415 db
2013-09-17T00:40:08.016Z,1379378408.016 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.140000 db
2013-09-17T00:40:08.182Z,1379378408.182 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:40:08.809Z,1379378408.809 [Reporter](INFO): sea_water_pressure -0.063685 db
2013-09-17T00:40:09.218Z,1379378409.218 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.130000 db
2013-09-17T00:40:10.047Z,1379378410.047 [Reporter](INFO): sea_water_pressure -0.073724 db
2013-09-17T00:40:10.228Z,1379378410.228 [DVL_micro](INFO): RSSI requested
2013-09-17T00:40:10.228Z,1379378410.228 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:40:10.228Z,1379378410.228 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:40:10.452Z,1379378410.452 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.130000 db
2013-09-17T00:40:11.216Z,1379378411.216 [Reporter](INFO): sea_water_pressure -0.064558 db
2013-09-17T00:40:11.608Z,1379378411.608 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.130000 db
2013-09-17T00:40:12.233Z,1379378412.233 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:40:12.233Z,1379378412.233 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:40:12.447Z,1379378412.447 [Reporter](INFO): sea_water_pressure -0.063248 db
2013-09-17T00:40:12.857Z,1379378412.857 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.120000 db
2013-09-17T00:40:13.657Z,1379378413.657 [Reporter](INFO): sea_water_pressure -0.082454 db
2013-09-17T00:40:14.011Z,1379378414.011 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.130000 db
2013-09-17T00:40:14.244Z,1379378414.244 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:40:14.244Z,1379378414.244 [DVL_micro](INFO): Enabling RSSI output
2013-09-17T00:40:14.244Z,1379378414.244 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 16 7
2013-09-17T00:40:14.818Z,1379378414.818 [Reporter](INFO): sea_water_pressure -0.077653 db
2013-09-17T00:40:15.216Z,1379378415.216 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.130000 db
2013-09-17T00:40:16.053Z,1379378416.053 [Reporter](INFO): sea_water_pressure -0.080708 db
2013-09-17T00:40:16.251Z,1379378416.251 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:40:16.251Z,1379378416.251 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:40:16.251Z,1379378416.251 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:40:16.456Z,1379378416.456 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.130000 db
2013-09-17T00:40:17.237Z,1379378417.237 [Reporter](INFO): sea_water_pressure -0.070232 db
2013-09-17T00:40:17.617Z,1379378417.617 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.120000 db
2013-09-17T00:40:18.258Z,1379378418.258 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:40:18.258Z,1379378418.258 [DVL_micro](INFO): Querying output modes
2013-09-17T00:40:18.258Z,1379378418.258 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:40:18.449Z,1379378418.449 [Reporter](INFO): sea_water_pressure -0.081581 db
2013-09-17T00:40:18.863Z,1379378418.863 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.130000 db
2013-09-17T00:40:19.618Z,1379378419.618 [Reporter](INFO): sea_water_pressure -0.088565 db
2013-09-17T00:40:20.005Z,1379378420.005 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.130000 db
2013-09-17T00:40:20.269Z,1379378420.269 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:40:20.269Z,1379378420.269 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:40:20.269Z,1379378420.269 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:40:20.859Z,1379378420.859 [Reporter](INFO): sea_water_pressure -0.067613 db
2013-09-17T00:40:21.251Z,1379378421.251 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.130000 db
2013-09-17T00:40:22.043Z,1379378422.043 [Reporter](INFO): sea_water_pressure -0.078526 db
2013-09-17T00:40:22.272Z,1379378422.272 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:40:22.451Z,1379378422.451 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.130000 db
2013-09-17T00:40:23.213Z,1379378423.213 [Reporter](INFO): sea_water_pressure -0.065431 db
2013-09-17T00:40:23.603Z,1379378423.603 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 56.130000 db
2013-09-17T00:40:24.284Z,1379378424.284 [DVL_micro](INFO): RSSI requested
2013-09-17T00:40:24.284Z,1379378424.284 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:40:24.284Z,1379378424.284 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:40:24.456Z,1379378424.456 [Reporter](INFO): sea_water_pressure 0.389839 db
2013-09-17T00:40:24.783Z,1379378424.783 [Radio_Freewave](INFO): Powering down
2013-09-17T00:40:24.860Z,1379378424.860 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 57.430000 db
2013-09-17T00:40:25.187Z,1379378425.187 [Radio_Freewave](FAULT): LCB fault: Software Overcurrent.
2013-09-17T00:40:25.187Z,1379378425.187 [Radio_Freewave] Hardware Fault, FailCount= 1
2013-09-17T00:40:25.187Z,1379378425.187 [Radio_Freewave](ERROR): Hardware Fault
2013-09-17T00:40:25.253Z,1379378425.253 [CBIT](ERROR): Hardware Fault in component: Radio_Freewave
2013-09-17T00:40:25.610Z,1379378425.610 [CBIT](INFO): Clearing failed state for component Radio_Freewave
2013-09-17T00:40:25.610Z,1379378425.610 [Radio_Freewave] No Fault, FailCount= 1
2013-09-17T00:40:25.614Z,1379378425.614 [Reporter](INFO): sea_water_pressure 1.511207 db
2013-09-17T00:40:25.964Z,1379378425.964 [Radio_Freewave](INFO): Powering up
2013-09-17T00:40:26.011Z,1379378426.011 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 57.630000 db
2013-09-17T00:40:26.286Z,1379378426.286 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:40:26.287Z,1379378426.287 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:40:26.818Z,1379378426.818 [Reporter](INFO): sea_water_pressure 1.624697 db
2013-09-17T00:40:27.245Z,1379378427.245 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 57.720000 db
2013-09-17T00:40:27.583Z,1379378427.583 [Radio_Freewave](INFO): Powering down
2013-09-17T00:40:28.053Z,1379378428.053 [Reporter](INFO): sea_water_pressure 1.959056 db
2013-09-17T00:40:28.289Z,1379378428.289 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:40:28.289Z,1379378428.289 [DVL_micro](INFO): Enabling RSSI output
2013-09-17T00:40:28.290Z,1379378428.290 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 16 7
2013-09-17T00:40:28.464Z,1379378428.464 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 60.680000 db
2013-09-17T00:40:29.210Z,1379378429.210 [Reporter](INFO): sea_water_pressure 9.994149 db
2013-09-17T00:40:29.589Z,1379378429.589 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 76.530000 db
2013-09-17T00:40:30.296Z,1379378430.296 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:40:30.296Z,1379378430.296 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:40:30.297Z,1379378430.297 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:40:30.467Z,1379378430.467 [Reporter](INFO): sea_water_pressure 39.789203 db
2013-09-17T00:40:30.818Z,1379378430.818 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 109.289988 db
2013-09-17T00:40:31.605Z,1379378431.605 [Reporter](INFO): sea_water_pressure 85.701150 db
2013-09-17T00:40:32.013Z,1379378432.013 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 156.819987 db
2013-09-17T00:40:32.307Z,1379378432.307 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:40:32.308Z,1379378432.308 [DVL_micro](INFO): Querying output modes
2013-09-17T00:40:32.308Z,1379378432.308 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:40:32.788Z,1379378432.788 [Reporter](INFO): sea_water_pressure 135.915662 db
2013-09-17T00:40:33.246Z,1379378433.246 [CBIT](INFO): Clearing failed count for component AHRS_sp3003D
2013-09-17T00:40:33.246Z,1379378433.246 [AHRS_sp3003D] No Fault, FailCount= 5
2013-09-17T00:40:33.248Z,1379378433.248 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 206.569987 db
2013-09-17T00:40:33.557Z,1379378433.557 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D.
2013-09-17T00:40:34.059Z,1379378434.059 [Reporter](INFO): sea_water_pressure 179.461775 db
2013-09-17T00:40:34.322Z,1379378434.322 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:40:34.322Z,1379378434.322 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:40:34.322Z,1379378434.322 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:40:34.695Z,1379378434.695 [AHRS_sp3003D](ERROR): readHeadingMagBin UART error: serial timeout
2013-09-17T00:40:34.695Z,1379378434.695 [AHRS_sp3003D](ERROR): SP3003D failed to initialize
2013-09-17T00:40:34.696Z,1379378434.696 [AHRS_sp3003D] Hardware Fault, FailCount= 1
2013-09-17T00:40:34.696Z,1379378434.696 [AHRS_sp3003D](ERROR): Hardware Fault
2013-09-17T00:40:34.793Z,1379378434.793 [CBIT](ERROR): Hardware Fault in component: AHRS_sp3003D
2013-09-17T00:40:34.794Z,1379378434.794 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 240.060000 db
2013-09-17T00:40:34.835Z,1379378434.835 [AHRS_sp3003D](INFO): Powering down
2013-09-17T00:40:35.277Z,1379378435.277 [Reporter](INFO): sea_water_pressure 200.419025 db
2013-09-17T00:40:36.079Z,1379378436.079 [CBIT](INFO): Clearing failed state for component AHRS_sp3003D
2013-09-17T00:40:36.079Z,1379378436.079 [AHRS_sp3003D] No Fault, FailCount= 1
2013-09-17T00:40:36.080Z,1379378436.080 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 244.150000 db
2013-09-17T00:40:36.334Z,1379378436.334 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:40:36.409Z,1379378436.409 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D.
2013-09-17T00:40:36.487Z,1379378436.487 [Reporter](INFO): sea_water_pressure 204.426525 db
2013-09-17T00:40:37.548Z,1379378437.548 [AHRS_sp3003D](ERROR): readHeadingMagBin UART error: serial timeout
2013-09-17T00:40:37.548Z,1379378437.548 [AHRS_sp3003D](ERROR): SP3003D failed to initialize
2013-09-17T00:40:37.548Z,1379378437.548 [AHRS_sp3003D] Hardware Fault, FailCount= 2
2013-09-17T00:40:37.548Z,1379378437.548 [AHRS_sp3003D](ERROR): Hardware Fault
2013-09-17T00:40:37.642Z,1379378437.642 [CBIT](ERROR): Hardware Fault in component: AHRS_sp3003D
2013-09-17T00:40:37.643Z,1379378437.643 [Reporter](INFO): sea_water_pressure 207.259862 db
2013-09-17T00:40:37.652Z,1379378437.652 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 248.890000 db
2013-09-17T00:40:37.677Z,1379378437.677 [AHRS_sp3003D](INFO): Powering down
2013-09-17T00:40:38.349Z,1379378438.349 [DVL_micro](INFO): RSSI requested
2013-09-17T00:40:38.349Z,1379378438.349 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:40:38.350Z,1379378438.350 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:40:38.949Z,1379378438.949 [CBIT](INFO): Clearing failed state for component AHRS_sp3003D
2013-09-17T00:40:38.954Z,1379378438.954 [AHRS_sp3003D] No Fault, FailCount= 2
2013-09-17T00:40:38.955Z,1379378438.955 [Reporter](INFO): sea_water_pressure 212.306650 db
2013-09-17T00:40:38.956Z,1379378438.956 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 252.520000 db
2013-09-17T00:40:39.267Z,1379378439.267 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D.
2013-09-17T00:40:40.352Z,1379378440.352 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:40:40.353Z,1379378440.353 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:40:40.408Z,1379378440.408 [AHRS_sp3003D](ERROR): readHeadingMagBin UART error: serial timeout
2013-09-17T00:40:40.408Z,1379378440.408 [AHRS_sp3003D](ERROR): SP3003D failed to initialize
2013-09-17T00:40:40.408Z,1379378440.408 [AHRS_sp3003D] Hardware Fault, FailCount= 3
2013-09-17T00:40:40.408Z,1379378440.408 [AHRS_sp3003D](ERROR): Hardware Fault
2013-09-17T00:40:40.490Z,1379378440.490 [CBIT](ERROR): Hardware Fault in component: AHRS_sp3003D
2013-09-17T00:40:40.491Z,1379378440.491 [Reporter](INFO): sea_water_pressure 215.392725 db
2013-09-17T00:40:40.492Z,1379378440.492 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 255.770000 db
2013-09-17T00:40:40.514Z,1379378440.514 [AHRS_sp3003D](INFO): Powering down
2013-09-17T00:40:41.777Z,1379378441.777 [CBIT](CRITICAL): Environmental Failure. Press:14.451184 PSI. Humidity:41%. Temp:21 C. ABORTING MISSION
2013-09-17T00:40:41.777Z,1379378441.777 [CBIT](INFO): Clearing failed state for component AHRS_sp3003D
2013-09-17T00:40:41.777Z,1379378441.777 [AHRS_sp3003D] No Fault, FailCount= 3
2013-09-17T00:40:41.783Z,1379378441.783 [Reporter](INFO): sea_water_pressure 218.770350 db
2013-09-17T00:40:41.784Z,1379378441.784 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure 258.280000 db
2013-09-17T00:40:42.110Z,1379378442.110 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D.
2013-09-17T00:40:42.167Z,1379378442.167 [Science] Stopped
2013-09-17T00:40:42.167Z,1379378442.167 [Science](INFO): Aggregate::uninitialize Science
2013-09-17T00:40:42.167Z,1379378442.167 [Science:A] Stopped
2013-09-17T00:40:42.167Z,1379378442.167 [Science:B] Stopped
2013-09-17T00:40:42.167Z,1379378442.167 [Science:C] Stopped
2013-09-17T00:40:42.167Z,1379378442.167 [Science:D] Stopped
2013-09-17T00:40:42.167Z,1379378442.167 [Science:E] Stopped
2013-09-17T00:40:42.168Z,1379378442.168 [Science:F] Stopped
2013-09-17T00:40:42.168Z,1379378442.168 [Science:G] Stopped
2013-09-17T00:40:42.168Z,1379378442.168 [Science:H] Stopped
2013-09-17T00:40:42.168Z,1379378442.168 [Science:I] Stopped
2013-09-17T00:40:42.195Z,1379378442.195 [CBIT](CRITICAL): STOP DEPTH REACHED. Terminating Mission.
2013-09-17T00:40:42.363Z,1379378442.363 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:40:42.363Z,1379378442.363 [DVL_micro](INFO): Enabling RSSI output
2013-09-17T00:40:42.363Z,1379378442.363 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 16 7
2013-09-17T00:40:42.568Z,1379378442.568 [MissionManager](IMPORTANT): Started mission Default
2013-09-17T00:40:42.568Z,1379378442.568 [Default] Running Loop=1
2013-09-17T00:40:42.568Z,1379378442.568 [Default](INFO): Aggregate::initialize Default
2013-09-17T00:40:42.568Z,1379378442.568 [Default:D.SetSpeed] Running Loop=1
2013-09-17T00:40:42.568Z,1379378442.568 [Default:D.SetSpeed](DEBUG): Initialize.
2013-09-17T00:40:42.568Z,1379378442.568 [Default:E.GoToSurface] Running Loop=1
2013-09-17T00:40:42.568Z,1379378442.568 [Default:E.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-09-17T00:40:42.569Z,1379378442.569 [Default:Iridium] Running Loop=1
2013-09-17T00:40:42.569Z,1379378442.569 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2013-09-17T00:40:42.569Z,1379378442.569 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-09-17T00:40:42.569Z,1379378442.569 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2013-09-17T00:40:42.569Z,1379378442.569 [Default:Iridium:B.GoToSurface] Running Loop=1
2013-09-17T00:40:42.569Z,1379378442.569 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-09-17T00:40:42.570Z,1379378442.570 [Default:E.GoToSurface] Running Loop=1
2013-09-17T00:40:42.583Z,1379378442.583 [Default:D.SetSpeed] Running Loop=1
2013-09-17T00:40:42.592Z,1379378442.592 [Default:CallIridium] Running Loop=1
2013-09-17T00:40:42.592Z,1379378442.592 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2013-09-17T00:40:42.592Z,1379378442.592 [Default:CallIridium:A] Running Loop=1
2013-09-17T00:40:42.594Z,1379378442.594 [Default:CallIridium:A] Stopped
2013-09-17T00:40:42.594Z,1379378442.594 [Default:CallIridium:B] Running Loop=1
2013-09-17T00:40:42.595Z,1379378442.595 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2013-09-17T00:40:42.608Z,1379378442.608 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-09-17T00:40:42.617Z,1379378442.617 [Default:GPS] Running Loop=1
2013-09-17T00:40:42.617Z,1379378442.617 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2013-09-17T00:40:42.617Z,1379378442.617 [Default:GPS:A.SetSpeed] Running Loop=1
2013-09-17T00:40:42.617Z,1379378442.617 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2013-09-17T00:40:42.617Z,1379378442.617 [Default:GPS:B.GoToSurface] Running Loop=1
2013-09-17T00:40:42.617Z,1379378442.617 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-09-17T00:40:42.655Z,1379378442.655 [Default:GPS:A.SetSpeed] Running Loop=1
2013-09-17T00:40:42.698Z,1379378442.698 [CBIT](CRITICAL): ABORT DEPTH REACHED. ACTIVATING BURNWIRE.
2013-09-17T00:40:43.244Z,1379378443.244 [AHRS_sp3003D](ERROR): readHeadingMagBin UART error: serial timeout
2013-09-17T00:40:43.244Z,1379378443.244 [AHRS_sp3003D](ERROR): SP3003D failed to initialize
2013-09-17T00:40:43.245Z,1379378443.245 [AHRS_sp3003D] Hardware Fault, FailCount= 4
2013-09-17T00:40:43.245Z,1379378443.245 [AHRS_sp3003D](ERROR): Hardware Fault
2013-09-17T00:40:43.317Z,1379378443.317 [CBIT](ERROR): Hardware Fault in component: AHRS_sp3003D
2013-09-17T00:40:43.319Z,1379378443.319 [Reporter](INFO): sea_water_pressure 220.905725 db
2013-09-17T00:40:43.319Z,1379378443.319 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:40:43.385Z,1379378443.385 [AHRS_sp3003D](INFO): Powering down
2013-09-17T00:40:44.370Z,1379378444.370 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:40:44.370Z,1379378444.370 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:40:44.371Z,1379378444.371 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:40:44.673Z,1379378444.673 [CBIT](INFO): Clearing failed state for component AHRS_sp3003D
2013-09-17T00:40:44.673Z,1379378444.673 [AHRS_sp3003D] No Fault, FailCount= 4
2013-09-17T00:40:44.675Z,1379378444.675 [Reporter](INFO): sea_water_pressure 224.016200 db
2013-09-17T00:40:44.675Z,1379378444.675 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:40:44.934Z,1379378444.934 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D.
2013-09-17T00:40:46.065Z,1379378446.065 [AHRS_sp3003D](ERROR): readHeadingMagBin UART error: serial timeout
2013-09-17T00:40:46.065Z,1379378446.065 [AHRS_sp3003D](ERROR): SP3003D failed to initialize
2013-09-17T00:40:46.065Z,1379378446.065 [AHRS_sp3003D] Hardware Fault, FailCount= 5
2013-09-17T00:40:46.065Z,1379378446.065 [AHRS_sp3003D](ERROR): Hardware Fault
2013-09-17T00:40:46.264Z,1379378446.264 [CBIT](ERROR): Hardware Fault in component: AHRS_sp3003D
2013-09-17T00:40:46.264Z,1379378446.264 [CBIT](CRITICAL): Hardware Fault in component: AHRS_sp3003D
2013-09-17T00:40:46.265Z,1379378446.265 [Reporter](INFO): sea_water_pressure 226.552275 db
2013-09-17T00:40:46.266Z,1379378446.266 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:40:46.286Z,1379378446.286 [AHRS_sp3003D](INFO): Powering down
2013-09-17T00:40:46.373Z,1379378446.373 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:40:46.373Z,1379378446.373 [DVL_micro](INFO): Querying output modes
2013-09-17T00:40:46.374Z,1379378446.374 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:40:47.727Z,1379378447.727 [Reporter](INFO): sea_water_pressure 229.116725 db
2013-09-17T00:40:47.727Z,1379378447.727 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:40:48.376Z,1379378448.376 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:40:48.377Z,1379378448.377 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:40:48.377Z,1379378448.377 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:40:49.113Z,1379378449.113 [Reporter](INFO): sea_water_pressure 232.245975 db
2013-09-17T00:40:49.114Z,1379378449.114 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:40:50.267Z,1379378450.267 [Reporter](INFO): sea_water_pressure 233.892025 db
2013-09-17T00:40:50.268Z,1379378450.268 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:40:50.387Z,1379378450.387 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:40:51.501Z,1379378451.501 [Reporter](INFO): sea_water_pressure 235.275300 db
2013-09-17T00:40:51.501Z,1379378451.501 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:40:52.399Z,1379378452.399 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:40:52.399Z,1379378452.399 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:40:52.671Z,1379378452.671 [Reporter](INFO): sea_water_pressure 236.465625 db
2013-09-17T00:40:52.671Z,1379378452.671 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:40:53.387Z,1379378453.387 [VerticalControl](CRITICAL): Excessive depth excursion=16.773636 m, failToGoUpDepth_=218.480606 m, depthRate=0.867816 m/s, pitch=5.338151 deg.
2013-09-17T00:40:53.865Z,1379378453.865 [Reporter](INFO): sea_water_pressure 237.481375 db
2013-09-17T00:40:53.865Z,1379378453.865 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:40:54.402Z,1379378454.402 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:40:54.402Z,1379378454.402 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:40:55.095Z,1379378455.095 [Reporter](INFO): sea_water_pressure 238.344750 db
2013-09-17T00:40:55.095Z,1379378455.095 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:40:56.381Z,1379378456.381 [Reporter](INFO): sea_water_pressure 239.065425 db
2013-09-17T00:40:56.381Z,1379378456.381 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:40:56.409Z,1379378456.409 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:40:56.409Z,1379378456.409 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:40:56.409Z,1379378456.409 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:40:57.471Z,1379378457.471 [Reporter](INFO): sea_water_pressure 239.679150 db
2013-09-17T00:40:57.471Z,1379378457.471 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:40:58.412Z,1379378458.412 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:40:58.412Z,1379378458.412 [DVL_micro](INFO): Querying output modes
2013-09-17T00:40:58.412Z,1379378458.412 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:40:58.660Z,1379378458.660 [Reporter](INFO): sea_water_pressure 240.228250 db
2013-09-17T00:40:58.661Z,1379378458.661 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:40:59.866Z,1379378459.866 [Reporter](INFO): sea_water_pressure 240.711475 db
2013-09-17T00:40:59.867Z,1379378459.867 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:00.423Z,1379378460.423 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:41:00.423Z,1379378460.423 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:41:00.424Z,1379378460.424 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:41:01.204Z,1379378461.204 [Reporter](INFO): sea_water_pressure 241.138800 db
2013-09-17T00:41:01.204Z,1379378461.204 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:02.258Z,1379378462.258 [Reporter](INFO): sea_water_pressure 241.517675 db
2013-09-17T00:41:02.258Z,1379378462.258 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:02.434Z,1379378462.434 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:41:03.454Z,1379378463.454 [Reporter](INFO): sea_water_pressure 241.866025 db
2013-09-17T00:41:03.455Z,1379378463.455 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:04.442Z,1379378464.442 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:41:04.443Z,1379378464.443 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:41:04.598Z,1379378464.598 [VerticalControl](CRITICAL): Dropping drop weight at excessive depth excursion=21.789536, failToGoUpDepth_=218.480606, depthRate=0.205673 m/s, pitch=15.256486 deg.
2013-09-17T00:41:04.690Z,1379378464.690 [Reporter](INFO): sea_water_pressure 242.197750 db
2013-09-17T00:41:04.690Z,1379378464.690 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:05.831Z,1379378465.831 [Reporter](INFO): sea_water_pressure 242.484975 db
2013-09-17T00:41:05.832Z,1379378465.832 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:06.445Z,1379378466.445 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:41:06.446Z,1379378466.446 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:41:07.614Z,1379378467.614 [Reporter](INFO): sea_water_pressure 242.793125 db
2013-09-17T00:41:07.614Z,1379378467.614 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:08.455Z,1379378468.455 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:41:08.456Z,1379378468.456 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:41:08.456Z,1379378468.456 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:41:08.972Z,1379378468.972 [Reporter](INFO): sea_water_pressure 243.203875 db
2013-09-17T00:41:08.973Z,1379378468.973 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:10.174Z,1379378470.174 [Reporter](INFO): sea_water_pressure 243.460550 db
2013-09-17T00:41:10.174Z,1379378470.174 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:10.459Z,1379378470.459 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:41:10.459Z,1379378470.459 [DVL_micro](INFO): Querying output modes
2013-09-17T00:41:10.459Z,1379378470.459 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:41:11.440Z,1379378471.440 [Reporter](INFO): sea_water_pressure 243.694950 db
2013-09-17T00:41:11.440Z,1379378471.440 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:12.466Z,1379378472.466 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:41:12.466Z,1379378472.466 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:41:12.466Z,1379378472.466 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:41:12.530Z,1379378472.530 [Reporter](INFO): sea_water_pressure 243.913200 db
2013-09-17T00:41:12.530Z,1379378472.530 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:13.892Z,1379378473.892 [Reporter](INFO): sea_water_pressure 244.071200 db
2013-09-17T00:41:13.892Z,1379378473.892 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:14.477Z,1379378474.477 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:41:15.258Z,1379378475.258 [Reporter](INFO): sea_water_pressure 244.411250 db
2013-09-17T00:41:15.258Z,1379378475.258 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:16.436Z,1379378476.436 [Reporter](INFO): sea_water_pressure 244.624250 db
2013-09-17T00:41:16.436Z,1379378476.436 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:16.481Z,1379378476.481 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:41:16.481Z,1379378476.481 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:41:17.724Z,1379378477.724 [Reporter](INFO): sea_water_pressure 244.845125 db
2013-09-17T00:41:17.724Z,1379378477.724 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:18.483Z,1379378478.483 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:41:18.484Z,1379378478.484 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:41:18.816Z,1379378478.816 [Reporter](INFO): sea_water_pressure 245.043300 db
2013-09-17T00:41:18.816Z,1379378478.816 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:20.494Z,1379378480.494 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:41:20.494Z,1379378480.494 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:41:20.495Z,1379378480.495 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:41:20.582Z,1379378480.582 [Reporter](INFO): sea_water_pressure 245.724225 db
2013-09-17T00:41:20.582Z,1379378480.582 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:21.940Z,1379378481.940 [Reporter](INFO): sea_water_pressure 295.778125 db
2013-09-17T00:41:21.941Z,1379378481.941 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:22.497Z,1379378482.497 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:41:22.497Z,1379378482.497 [DVL_micro](INFO): Querying output modes
2013-09-17T00:41:22.498Z,1379378482.498 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:41:23.142Z,1379378483.142 [Reporter](INFO): sea_water_pressure 295.604850 db
2013-09-17T00:41:23.143Z,1379378483.143 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:24.416Z,1379378484.416 [Reporter](INFO): sea_water_pressure 295.452525 db
2013-09-17T00:41:24.416Z,1379378484.416 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:24.500Z,1379378484.500 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:41:24.501Z,1379378484.501 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:41:24.501Z,1379378484.501 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:41:25.498Z,1379378485.498 [Reporter](INFO): sea_water_pressure 295.284875 db
2013-09-17T00:41:25.498Z,1379378485.498 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:26.507Z,1379378486.507 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:41:26.696Z,1379378486.696 [Reporter](INFO): sea_water_pressure 295.148700 db
2013-09-17T00:41:26.696Z,1379378486.696 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:27.942Z,1379378487.942 [Reporter](INFO): sea_water_pressure 295.011200 db
2013-09-17T00:41:27.942Z,1379378487.942 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:28.522Z,1379378488.522 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:41:28.522Z,1379378488.522 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:41:29.047Z,1379378489.047 [Reporter](INFO): sea_water_pressure 294.913875 db
2013-09-17T00:41:29.047Z,1379378489.047 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:30.244Z,1379378490.244 [CBIT](INFO): Clearing failed count for component WetLabsBB2FL
2013-09-17T00:41:30.244Z,1379378490.244 [WetLabsBB2FL] No Fault, FailCount= 5
2013-09-17T00:41:30.245Z,1379378490.245 [Reporter](INFO): sea_water_pressure 294.754125 db
2013-09-17T00:41:30.246Z,1379378490.246 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:30.254Z,1379378490.254 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=4
2013-09-17T00:41:30.254Z,1379378490.254 [WetLabsBB2FL](INFO): Powering up
2013-09-17T00:41:30.526Z,1379378490.526 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:41:30.526Z,1379378490.526 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:41:31.387Z,1379378491.387 [Reporter](INFO): sea_water_pressure 294.624475 db
2013-09-17T00:41:31.387Z,1379378491.387 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:32.529Z,1379378492.529 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:41:32.529Z,1379378492.529 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:41:32.529Z,1379378492.529 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:41:32.745Z,1379378492.745 [Reporter](INFO): sea_water_pressure 294.522775 db
2013-09-17T00:41:32.746Z,1379378492.746 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:34.129Z,1379378494.129 [Reporter](INFO): sea_water_pressure 294.360375 db
2013-09-17T00:41:34.129Z,1379378494.129 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:34.540Z,1379378494.540 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:41:34.540Z,1379378494.540 [DVL_micro](INFO): Querying output modes
2013-09-17T00:41:34.540Z,1379378494.540 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:41:35.285Z,1379378495.285 [Reporter](INFO): sea_water_pressure 294.265650 db
2013-09-17T00:41:35.285Z,1379378495.285 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:35.529Z,1379378495.529 [WetLabsBB2FL] Communications Fault, FailCount= 1
2013-09-17T00:41:35.529Z,1379378495.529 [WetLabsBB2FL](ERROR): Communications Fault
2013-09-17T00:41:35.626Z,1379378495.626 [WetLabsBB2FL](INFO): Powering down
2013-09-17T00:41:35.752Z,1379378495.752 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2013-09-17T00:41:36.038Z,1379378496.038 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2013-09-17T00:41:36.039Z,1379378496.039 [WetLabsBB2FL] No Fault, FailCount= 1
2013-09-17T00:41:36.436Z,1379378496.436 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=4
2013-09-17T00:41:36.436Z,1379378496.436 [WetLabsBB2FL](INFO): Powering up
2013-09-17T00:41:36.475Z,1379378496.475 [Reporter](INFO): sea_water_pressure 294.143900 db
2013-09-17T00:41:36.475Z,1379378496.475 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:36.551Z,1379378496.551 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:41:36.551Z,1379378496.551 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:41:36.552Z,1379378496.552 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:41:37.648Z,1379378497.648 [Reporter](INFO): sea_water_pressure 294.033025 db
2013-09-17T00:41:37.650Z,1379378497.650 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:38.562Z,1379378498.562 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:41:39.015Z,1379378499.015 [Reporter](INFO): sea_water_pressure 293.979775 db
2013-09-17T00:41:39.015Z,1379378499.015 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:40.349Z,1379378500.349 [Reporter](INFO): sea_water_pressure 293.856225 db
2013-09-17T00:41:40.349Z,1379378500.349 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:40.574Z,1379378500.574 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:41:40.574Z,1379378500.574 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:41:41.535Z,1379378501.535 [Reporter](INFO): sea_water_pressure 293.746675 db
2013-09-17T00:41:41.535Z,1379378501.535 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:41.723Z,1379378501.723 [WetLabsBB2FL] Communications Fault, FailCount= 2
2013-09-17T00:41:41.723Z,1379378501.723 [WetLabsBB2FL](ERROR): Communications Fault
2013-09-17T00:41:41.824Z,1379378501.824 [WetLabsBB2FL](INFO): Powering down
2013-09-17T00:41:41.986Z,1379378501.986 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2013-09-17T00:41:42.391Z,1379378502.391 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2013-09-17T00:41:42.391Z,1379378502.391 [WetLabsBB2FL] No Fault, FailCount= 2
2013-09-17T00:41:42.577Z,1379378502.577 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:41:42.577Z,1379378502.577 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:41:42.641Z,1379378502.641 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=4
2013-09-17T00:41:42.641Z,1379378502.641 [WetLabsBB2FL](INFO): Powering up
2013-09-17T00:41:42.797Z,1379378502.797 [Reporter](INFO): sea_water_pressure 293.657625 db
2013-09-17T00:41:42.797Z,1379378502.797 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:43.930Z,1379378503.930 [Reporter](INFO): sea_water_pressure 293.563325 db
2013-09-17T00:41:43.939Z,1379378503.939 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:44.583Z,1379378504.583 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:41:44.584Z,1379378504.584 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:41:44.584Z,1379378504.584 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:41:45.165Z,1379378505.165 [Reporter](INFO): sea_water_pressure 293.481250 db
2013-09-17T00:41:45.165Z,1379378505.165 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:46.398Z,1379378506.398 [Reporter](INFO): sea_water_pressure 293.399650 db
2013-09-17T00:41:46.399Z,1379378506.399 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:46.587Z,1379378506.587 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:41:46.587Z,1379378506.587 [DVL_micro](INFO): Querying output modes
2013-09-17T00:41:46.587Z,1379378506.587 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:41:47.576Z,1379378507.576 [Reporter](INFO): sea_water_pressure 293.326325 db
2013-09-17T00:41:47.576Z,1379378507.576 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:47.913Z,1379378507.913 [WetLabsBB2FL] Communications Fault, FailCount= 3
2013-09-17T00:41:47.913Z,1379378507.913 [WetLabsBB2FL](ERROR): Communications Fault
2013-09-17T00:41:47.980Z,1379378507.980 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2013-09-17T00:41:48.009Z,1379378508.009 [WetLabsBB2FL](INFO): Powering down
2013-09-17T00:41:48.590Z,1379378508.590 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:41:48.590Z,1379378508.590 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:41:48.590Z,1379378508.590 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:41:48.797Z,1379378508.797 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2013-09-17T00:41:48.797Z,1379378508.797 [WetLabsBB2FL] No Fault, FailCount= 3
2013-09-17T00:41:48.798Z,1379378508.798 [Reporter](INFO): sea_water_pressure 293.250375 db
2013-09-17T00:41:48.799Z,1379378508.799 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:48.827Z,1379378508.827 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=4
2013-09-17T00:41:48.827Z,1379378508.827 [WetLabsBB2FL](INFO): Powering up
2013-09-17T00:41:49.968Z,1379378509.968 [Reporter](INFO): sea_water_pressure 293.166575 db
2013-09-17T00:41:49.968Z,1379378509.968 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:50.597Z,1379378510.597 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:41:51.129Z,1379378511.129 [Reporter](INFO): sea_water_pressure 293.090600 db
2013-09-17T00:41:51.138Z,1379378511.138 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:51.959Z,1379378511.959 [MassServo](FAULT): Overload Error
2013-09-17T00:41:51.959Z,1379378511.959 [MassServo] Hardware Fault, FailCount= 1
2013-09-17T00:41:51.960Z,1379378511.960 [MassServo](ERROR): Hardware Fault
2013-09-17T00:41:51.990Z,1379378511.990 [CBIT](ERROR): Hardware Fault in component: MassServo
2013-09-17T00:41:52.286Z,1379378512.286 [MassServo](DEBUG): Uninitialize Mass Servo.
2013-09-17T00:41:52.286Z,1379378512.286 [MassServo](INFO): Powering down
2013-09-17T00:41:52.332Z,1379378512.332 [Reporter](INFO): sea_water_pressure 293.007225 db
2013-09-17T00:41:52.332Z,1379378512.332 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:52.609Z,1379378512.609 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:41:52.609Z,1379378512.609 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:41:53.063Z,1379378513.063 [MassServo](DEBUG): Initializing EZServoServo.
2013-09-17T00:41:53.178Z,1379378513.178 [MassServo](DEBUG): Initializing MassServo.
2013-09-17T00:41:53.207Z,1379378513.207 [CBIT](INFO): Clearing failed state for component MassServo
2013-09-17T00:41:53.208Z,1379378513.208 [MassServo] No Fault, FailCount= 1
2013-09-17T00:41:53.493Z,1379378513.493 [Reporter](INFO): sea_water_pressure 292.918175 db
2013-09-17T00:41:53.493Z,1379378513.493 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:54.106Z,1379378514.106 [WetLabsBB2FL] Communications Fault, FailCount= 4
2013-09-17T00:41:54.106Z,1379378514.106 [WetLabsBB2FL](ERROR): Communications Fault
2013-09-17T00:41:54.203Z,1379378514.203 [WetLabsBB2FL](INFO): Powering down
2013-09-17T00:41:54.309Z,1379378514.309 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2013-09-17T00:41:54.611Z,1379378514.611 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:41:54.612Z,1379378514.612 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:41:54.737Z,1379378514.737 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2013-09-17T00:41:54.737Z,1379378514.737 [WetLabsBB2FL] No Fault, FailCount= 4
2013-09-17T00:41:54.739Z,1379378514.739 [Reporter](INFO): sea_water_pressure 292.873225 db
2013-09-17T00:41:54.739Z,1379378514.739 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:55.013Z,1379378515.013 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=4
2013-09-17T00:41:55.013Z,1379378515.013 [WetLabsBB2FL](INFO): Powering up
2013-09-17T00:41:55.897Z,1379378515.897 [Reporter](INFO): sea_water_pressure 292.820850 db
2013-09-17T00:41:55.897Z,1379378515.897 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:56.630Z,1379378516.630 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:41:56.630Z,1379378516.630 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:41:56.631Z,1379378516.631 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:41:57.130Z,1379378517.130 [Reporter](INFO): sea_water_pressure 292.758000 db
2013-09-17T00:41:57.143Z,1379378517.143 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:58.337Z,1379378518.337 [Reporter](INFO): sea_water_pressure 292.696875 db
2013-09-17T00:41:58.337Z,1379378518.337 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:41:58.634Z,1379378518.634 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:41:58.634Z,1379378518.634 [DVL_micro](INFO): Querying output modes
2013-09-17T00:41:58.634Z,1379378518.634 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:41:59.535Z,1379378519.535 [Reporter](INFO): sea_water_pressure 292.637075 db
2013-09-17T00:41:59.535Z,1379378519.535 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:00.305Z,1379378520.305 [WetLabsBB2FL] Communications Fault, FailCount= 5
2013-09-17T00:42:00.305Z,1379378520.305 [WetLabsBB2FL](ERROR): Communications Fault
2013-09-17T00:42:00.335Z,1379378520.335 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2013-09-17T00:42:00.335Z,1379378520.335 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL
2013-09-17T00:42:00.396Z,1379378520.396 [WetLabsBB2FL](INFO): Powering down
2013-09-17T00:42:00.638Z,1379378520.638 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:42:00.638Z,1379378520.638 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:42:00.638Z,1379378520.638 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:42:00.745Z,1379378520.745 [Reporter](INFO): sea_water_pressure 292.567225 db
2013-09-17T00:42:00.745Z,1379378520.745 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:01.974Z,1379378521.974 [Reporter](INFO): sea_water_pressure 292.521850 db
2013-09-17T00:42:01.975Z,1379378521.975 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:02.648Z,1379378522.648 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:42:03.160Z,1379378523.160 [Reporter](INFO): sea_water_pressure 292.452450 db
2013-09-17T00:42:03.161Z,1379378523.161 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:04.371Z,1379378524.371 [Reporter](INFO): sea_water_pressure 292.388275 db
2013-09-17T00:42:04.371Z,1379378524.371 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:04.659Z,1379378524.659 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:42:04.659Z,1379378524.659 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:42:05.560Z,1379378525.560 [Reporter](INFO): sea_water_pressure 292.351625 db
2013-09-17T00:42:05.560Z,1379378525.560 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:06.662Z,1379378526.662 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:42:06.663Z,1379378526.663 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:42:06.766Z,1379378526.766 [Reporter](INFO): sea_water_pressure 292.297050 db
2013-09-17T00:42:06.766Z,1379378526.766 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:07.960Z,1379378527.960 [Reporter](INFO): sea_water_pressure 292.239875 db
2013-09-17T00:42:07.960Z,1379378527.960 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:08.669Z,1379378528.669 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:42:08.669Z,1379378528.669 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:42:08.669Z,1379378528.669 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:42:09.142Z,1379378529.142 [Reporter](INFO): sea_water_pressure 292.188800 db
2013-09-17T00:42:09.142Z,1379378529.142 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:10.364Z,1379378530.364 [Reporter](INFO): sea_water_pressure 292.144725 db
2013-09-17T00:42:10.364Z,1379378530.364 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:10.680Z,1379378530.680 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:42:10.680Z,1379378530.680 [DVL_micro](INFO): Querying output modes
2013-09-17T00:42:10.680Z,1379378530.680 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:42:11.566Z,1379378531.566 [Reporter](INFO): sea_water_pressure 292.087950 db
2013-09-17T00:42:11.566Z,1379378531.566 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:12.683Z,1379378532.683 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:42:12.683Z,1379378532.683 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:42:12.684Z,1379378532.684 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:42:12.759Z,1379378532.759 [Reporter](INFO): sea_water_pressure 292.036900 db
2013-09-17T00:42:12.760Z,1379378532.760 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:13.970Z,1379378533.970 [Reporter](INFO): sea_water_pressure 291.989325 db
2013-09-17T00:42:13.970Z,1379378533.970 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:14.694Z,1379378534.694 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:42:15.143Z,1379378535.143 [Reporter](INFO): sea_water_pressure 291.957875 db
2013-09-17T00:42:15.143Z,1379378535.143 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:16.345Z,1379378536.345 [Reporter](INFO): sea_water_pressure 291.909000 db
2013-09-17T00:42:16.345Z,1379378536.345 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:16.706Z,1379378536.706 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:42:16.706Z,1379378536.706 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:42:17.558Z,1379378537.558 [Reporter](INFO): sea_water_pressure 291.858375 db
2013-09-17T00:42:17.559Z,1379378537.559 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:18.709Z,1379378538.709 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:42:18.709Z,1379378538.709 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:42:18.764Z,1379378538.764 [Reporter](INFO): sea_water_pressure 291.821725 db
2013-09-17T00:42:18.765Z,1379378538.765 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:19.971Z,1379378539.971 [Reporter](INFO): sea_water_pressure 291.778475 db
2013-09-17T00:42:19.971Z,1379378539.971 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:20.717Z,1379378540.717 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:42:20.717Z,1379378540.717 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:42:20.718Z,1379378540.718 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:42:21.160Z,1379378541.160 [Reporter](INFO): sea_water_pressure 291.738350 db
2013-09-17T00:42:21.161Z,1379378541.161 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:22.374Z,1379378542.374 [Reporter](INFO): sea_water_pressure 291.692925 db
2013-09-17T00:42:22.374Z,1379378542.374 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:22.751Z,1379378542.751 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:42:22.751Z,1379378542.751 [DVL_micro](INFO): Querying output modes
2013-09-17T00:42:22.751Z,1379378542.751 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:42:23.560Z,1379378543.560 [Reporter](INFO): sea_water_pressure 291.642300 db
2013-09-17T00:42:23.560Z,1379378543.560 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:24.762Z,1379378544.762 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:42:24.762Z,1379378544.762 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:42:24.762Z,1379378544.762 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:42:24.767Z,1379378544.767 [Reporter](INFO): sea_water_pressure 291.609975 db
2013-09-17T00:42:24.767Z,1379378544.767 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:25.939Z,1379378545.939 [Reporter](INFO): sea_water_pressure 291.575075 db
2013-09-17T00:42:25.944Z,1379378545.944 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:26.769Z,1379378546.769 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:42:27.258Z,1379378547.258 [Reporter](INFO): sea_water_pressure 291.531850 db
2013-09-17T00:42:27.258Z,1379378547.258 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:28.371Z,1379378548.371 [Reporter](INFO): sea_water_pressure 291.506100 db
2013-09-17T00:42:28.372Z,1379378548.372 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:28.777Z,1379378548.777 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:42:28.777Z,1379378548.777 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:42:29.565Z,1379378549.565 [Reporter](INFO): sea_water_pressure 291.456775 db
2013-09-17T00:42:29.566Z,1379378549.566 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:30.771Z,1379378550.771 [Reporter](INFO): sea_water_pressure 291.435400 db
2013-09-17T00:42:30.771Z,1379378550.771 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:30.780Z,1379378550.780 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:42:30.780Z,1379378550.780 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:42:31.961Z,1379378551.961 [Reporter](INFO): sea_water_pressure 291.393075 db
2013-09-17T00:42:31.961Z,1379378551.961 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:32.790Z,1379378552.790 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:42:32.790Z,1379378552.790 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:42:32.791Z,1379378552.791 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:42:33.167Z,1379378553.167 [Reporter](INFO): sea_water_pressure 291.352900 db
2013-09-17T00:42:33.167Z,1379378553.167 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:34.389Z,1379378554.389 [Reporter](INFO): sea_water_pressure 291.324950 db
2013-09-17T00:42:34.389Z,1379378554.389 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:34.798Z,1379378554.798 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:42:34.798Z,1379378554.798 [DVL_micro](INFO): Querying output modes
2013-09-17T00:42:34.798Z,1379378554.798 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:42:35.567Z,1379378555.567 [Reporter](INFO): sea_water_pressure 291.291775 db
2013-09-17T00:42:35.567Z,1379378555.567 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:36.772Z,1379378556.772 [Reporter](INFO): sea_water_pressure 291.270850 db
2013-09-17T00:42:36.773Z,1379378556.773 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:36.801Z,1379378556.801 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:42:36.801Z,1379378556.801 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:42:36.801Z,1379378556.801 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:42:37.966Z,1379378557.966 [Reporter](INFO): sea_water_pressure 291.230675 db
2013-09-17T00:42:37.967Z,1379378557.967 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:38.812Z,1379378558.812 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:42:39.168Z,1379378559.168 [Reporter](INFO): sea_water_pressure 291.199675 db
2013-09-17T00:42:39.168Z,1379378559.168 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:40.370Z,1379378560.370 [Reporter](INFO): sea_water_pressure 291.180475 db
2013-09-17T00:42:40.370Z,1379378560.370 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:40.827Z,1379378560.827 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:42:40.828Z,1379378560.828 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:42:41.576Z,1379378561.576 [Reporter](INFO): sea_water_pressure 291.142050 db
2013-09-17T00:42:41.576Z,1379378561.576 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:42.770Z,1379378562.770 [Reporter](INFO): sea_water_pressure 291.115875 db
2013-09-17T00:42:42.770Z,1379378562.770 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:42.830Z,1379378562.830 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:42:42.831Z,1379378562.831 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:42:43.960Z,1379378563.960 [Reporter](INFO): sea_water_pressure 291.081400 db
2013-09-17T00:42:43.960Z,1379378563.960 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:44.841Z,1379378564.841 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:42:44.841Z,1379378564.841 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:42:44.841Z,1379378564.841 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:42:45.174Z,1379378565.174 [Reporter](INFO): sea_water_pressure 291.060450 db
2013-09-17T00:42:45.174Z,1379378565.174 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:46.395Z,1379378566.395 [Reporter](INFO): sea_water_pressure 291.026825 db
2013-09-17T00:42:46.396Z,1379378566.396 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:46.852Z,1379378566.852 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:42:46.852Z,1379378566.852 [DVL_micro](INFO): Querying output modes
2013-09-17T00:42:46.852Z,1379378566.852 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:42:47.561Z,1379378567.561 [Reporter](INFO): sea_water_pressure 290.998900 db
2013-09-17T00:42:47.561Z,1379378567.561 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:48.771Z,1379378568.771 [Reporter](INFO): sea_water_pressure 290.966575 db
2013-09-17T00:42:48.771Z,1379378568.771 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:48.863Z,1379378568.863 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:42:48.863Z,1379378568.863 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:42:48.864Z,1379378568.864 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:42:49.949Z,1379378569.949 [Reporter](INFO): sea_water_pressure 290.956125 db
2013-09-17T00:42:49.949Z,1379378569.949 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:50.874Z,1379378570.874 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:42:51.175Z,1379378571.175 [Reporter](INFO): sea_water_pressure 290.924675 db
2013-09-17T00:42:51.175Z,1379378571.175 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:52.360Z,1379378572.360 [Reporter](INFO): sea_water_pressure 290.902875 db
2013-09-17T00:42:52.361Z,1379378572.361 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:52.886Z,1379378572.886 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:42:52.886Z,1379378572.886 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:42:53.570Z,1379378573.570 [Reporter](INFO): sea_water_pressure 290.873625 db
2013-09-17T00:42:53.571Z,1379378573.571 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:54.760Z,1379378574.760 [Reporter](INFO): sea_water_pressure 290.833475 db
2013-09-17T00:42:54.761Z,1379378574.761 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:54.889Z,1379378574.889 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:42:54.889Z,1379378574.889 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:42:55.974Z,1379378575.974 [Reporter](INFO): sea_water_pressure 290.815125 db
2013-09-17T00:42:55.975Z,1379378575.975 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:56.900Z,1379378576.900 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:42:56.900Z,1379378576.900 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:42:56.900Z,1379378576.900 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:42:57.164Z,1379378577.164 [Reporter](INFO): sea_water_pressure 290.796350 db
2013-09-17T00:42:57.165Z,1379378577.165 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:58.374Z,1379378578.374 [Reporter](INFO): sea_water_pressure 290.776725 db
2013-09-17T00:42:58.374Z,1379378578.374 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:58.727Z,1379378578.727 [MassServo](FAULT): Overload Error
2013-09-17T00:42:58.727Z,1379378578.727 [MassServo] Hardware Fault, FailCount= 2
2013-09-17T00:42:58.727Z,1379378578.727 [MassServo](ERROR): Hardware Fault
2013-09-17T00:42:58.797Z,1379378578.797 [CBIT](ERROR): Hardware Fault in component: MassServo
2013-09-17T00:42:58.911Z,1379378578.911 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:42:58.911Z,1379378578.911 [DVL_micro](INFO): Querying output modes
2013-09-17T00:42:58.911Z,1379378578.911 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:42:59.077Z,1379378579.077 [MassServo](DEBUG): Uninitialize Mass Servo.
2013-09-17T00:42:59.077Z,1379378579.077 [MassServo](INFO): Powering down
2013-09-17T00:42:59.540Z,1379378579.540 [Reporter](INFO): sea_water_pressure 290.753150 db
2013-09-17T00:42:59.540Z,1379378579.540 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:42:59.891Z,1379378579.891 [MassServo](DEBUG): Initializing EZServoServo.
2013-09-17T00:43:00.009Z,1379378580.009 [MassServo](DEBUG): Initializing MassServo.
2013-09-17T00:43:00.039Z,1379378580.039 [CBIT](INFO): Clearing failed state for component MassServo
2013-09-17T00:43:00.039Z,1379378580.039 [MassServo] No Fault, FailCount= 2
2013-09-17T00:43:00.782Z,1379378580.782 [Reporter](INFO): sea_water_pressure 290.720400 db
2013-09-17T00:43:00.782Z,1379378580.782 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:00.922Z,1379378580.922 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:43:00.922Z,1379378580.922 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:43:00.922Z,1379378580.922 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:43:01.935Z,1379378581.935 [Reporter](INFO): sea_water_pressure 290.709925 db
2013-09-17T00:43:01.936Z,1379378581.936 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:02.925Z,1379378582.925 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:43:03.166Z,1379378583.166 [Reporter](INFO): sea_water_pressure 290.671975 db
2013-09-17T00:43:03.166Z,1379378583.166 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:04.343Z,1379378584.343 [Reporter](INFO): sea_water_pressure 290.666725 db
2013-09-17T00:43:04.344Z,1379378584.344 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:04.937Z,1379378584.937 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:43:04.937Z,1379378584.937 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:43:05.565Z,1379378585.565 [Reporter](INFO): sea_water_pressure 290.638325 db
2013-09-17T00:43:05.565Z,1379378585.565 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:06.743Z,1379378586.743 [Reporter](INFO): sea_water_pressure 290.617825 db
2013-09-17T00:43:06.743Z,1379378586.743 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:06.940Z,1379378586.940 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:43:06.940Z,1379378586.940 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:43:07.973Z,1379378587.973 [Reporter](INFO): sea_water_pressure 290.598200 db
2013-09-17T00:43:07.973Z,1379378587.973 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:08.946Z,1379378588.946 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:43:08.946Z,1379378588.946 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:43:08.947Z,1379378588.947 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:43:09.179Z,1379378589.179 [Reporter](INFO): sea_water_pressure 290.565450 db
2013-09-17T00:43:09.179Z,1379378589.179 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:10.344Z,1379378590.344 [Reporter](INFO): sea_water_pressure 290.558475 db
2013-09-17T00:43:10.345Z,1379378590.345 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:10.953Z,1379378590.953 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:43:10.953Z,1379378590.953 [DVL_micro](INFO): Querying output modes
2013-09-17T00:43:10.954Z,1379378590.954 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:43:11.570Z,1379378591.570 [Reporter](INFO): sea_water_pressure 290.512625 db
2013-09-17T00:43:11.571Z,1379378591.571 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:12.744Z,1379378592.744 [Reporter](INFO): sea_water_pressure 290.504800 db
2013-09-17T00:43:12.745Z,1379378592.745 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:12.960Z,1379378592.960 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:43:12.961Z,1379378592.961 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:43:12.961Z,1379378592.961 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:43:13.958Z,1379378593.958 [Reporter](INFO): sea_water_pressure 290.481650 db
2013-09-17T00:43:13.958Z,1379378593.958 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:14.972Z,1379378594.972 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:43:15.172Z,1379378595.172 [Reporter](INFO): sea_water_pressure 290.465950 db
2013-09-17T00:43:15.172Z,1379378595.172 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:16.366Z,1379378596.366 [Reporter](INFO): sea_water_pressure 290.443675 db
2013-09-17T00:43:16.366Z,1379378596.366 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:16.983Z,1379378596.983 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:43:16.983Z,1379378596.983 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:43:17.564Z,1379378597.564 [Reporter](INFO): sea_water_pressure 290.430575 db
2013-09-17T00:43:17.564Z,1379378597.564 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:18.757Z,1379378598.757 [Reporter](INFO): sea_water_pressure 290.403950 db
2013-09-17T00:43:18.758Z,1379378598.758 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:18.986Z,1379378598.986 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:43:18.987Z,1379378598.987 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:43:19.959Z,1379378599.959 [Reporter](INFO): sea_water_pressure 290.391725 db
2013-09-17T00:43:19.960Z,1379378599.960 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:20.997Z,1379378600.997 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:43:20.997Z,1379378600.997 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:43:20.997Z,1379378600.997 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:43:21.169Z,1379378601.169 [Reporter](INFO): sea_water_pressure 290.365550 db
2013-09-17T00:43:21.170Z,1379378601.170 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:22.359Z,1379378602.359 [Reporter](INFO): sea_water_pressure 290.352450 db
2013-09-17T00:43:22.360Z,1379378602.360 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:23.008Z,1379378603.008 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:43:23.008Z,1379378603.008 [DVL_micro](INFO): Querying output modes
2013-09-17T00:43:23.008Z,1379378603.008 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:43:23.561Z,1379378603.561 [Reporter](INFO): sea_water_pressure 290.331050 db
2013-09-17T00:43:23.561Z,1379378603.561 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:24.775Z,1379378604.775 [Reporter](INFO): sea_water_pressure 290.323200 db
2013-09-17T00:43:24.775Z,1379378604.775 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:25.019Z,1379378605.019 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:43:25.019Z,1379378605.019 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:43:25.020Z,1379378605.020 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:43:25.949Z,1379378605.949 [Reporter](INFO): sea_water_pressure 290.297450 db
2013-09-17T00:43:25.949Z,1379378605.949 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:27.031Z,1379378607.031 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:43:27.170Z,1379378607.170 [Reporter](INFO): sea_water_pressure 290.273000 db
2013-09-17T00:43:27.171Z,1379378607.171 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:28.360Z,1379378608.360 [Reporter](INFO): sea_water_pressure 290.262500 db
2013-09-17T00:43:28.361Z,1379378608.361 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:29.042Z,1379378609.042 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:43:29.042Z,1379378609.042 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:43:29.562Z,1379378609.562 [Reporter](INFO): sea_water_pressure 290.243750 db
2013-09-17T00:43:29.562Z,1379378609.562 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:30.748Z,1379378610.748 [Reporter](INFO): sea_water_pressure 290.231525 db
2013-09-17T00:43:30.748Z,1379378610.748 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:31.045Z,1379378611.045 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:43:31.045Z,1379378611.045 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:43:31.966Z,1379378611.966 [Reporter](INFO): sea_water_pressure 290.212775 db
2013-09-17T00:43:31.966Z,1379378611.966 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:33.056Z,1379378613.056 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:43:33.056Z,1379378613.056 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:43:33.056Z,1379378613.056 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:43:33.180Z,1379378613.180 [Reporter](INFO): sea_water_pressure 290.189175 db
2013-09-17T00:43:33.180Z,1379378613.180 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:34.437Z,1379378614.437 [Reporter](INFO): sea_water_pressure 290.183500 db
2013-09-17T00:43:34.438Z,1379378614.438 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:35.059Z,1379378615.059 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:43:35.059Z,1379378615.059 [DVL_micro](INFO): Querying output modes
2013-09-17T00:43:35.059Z,1379378615.059 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:43:35.572Z,1379378615.572 [Reporter](INFO): sea_water_pressure 290.168250 db
2013-09-17T00:43:35.572Z,1379378615.572 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:36.773Z,1379378616.773 [Reporter](INFO): sea_water_pressure 290.144650 db
2013-09-17T00:43:36.774Z,1379378616.774 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:37.062Z,1379378617.062 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:43:37.062Z,1379378617.062 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:43:37.062Z,1379378617.062 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:43:37.959Z,1379378617.959 [Reporter](INFO): sea_water_pressure 290.129400 db
2013-09-17T00:43:37.960Z,1379378617.960 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:39.073Z,1379378619.073 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:43:39.173Z,1379378619.173 [Reporter](INFO): sea_water_pressure 290.113250 db
2013-09-17T00:43:39.174Z,1379378619.174 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:40.367Z,1379378620.367 [Reporter](INFO): sea_water_pressure 290.113675 db
2013-09-17T00:43:40.367Z,1379378620.367 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:41.081Z,1379378621.081 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:43:41.081Z,1379378621.081 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:43:41.573Z,1379378621.573 [Reporter](INFO): sea_water_pressure 290.087500 db
2013-09-17T00:43:41.574Z,1379378621.574 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:42.767Z,1379378622.767 [Reporter](INFO): sea_water_pressure 290.075725 db
2013-09-17T00:43:42.767Z,1379378622.767 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:43.084Z,1379378623.084 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:43:43.084Z,1379378623.084 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:43:43.969Z,1379378623.969 [Reporter](INFO): sea_water_pressure 290.047325 db
2013-09-17T00:43:43.969Z,1379378623.969 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:45.090Z,1379378625.090 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:43:45.091Z,1379378625.091 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:43:45.091Z,1379378625.091 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:43:45.198Z,1379378625.198 [Reporter](INFO): sea_water_pressure 290.046025 db
2013-09-17T00:43:45.199Z,1379378625.199 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:46.396Z,1379378626.396 [Reporter](INFO): sea_water_pressure 290.029000 db
2013-09-17T00:43:46.397Z,1379378626.397 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:47.094Z,1379378627.094 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:43:47.094Z,1379378627.094 [DVL_micro](INFO): Querying output modes
2013-09-17T00:43:47.094Z,1379378627.094 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:43:47.574Z,1379378627.574 [Reporter](INFO): sea_water_pressure 290.020275 db
2013-09-17T00:43:47.574Z,1379378627.574 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:48.748Z,1379378628.748 [Reporter](INFO): sea_water_pressure 289.994925 db
2013-09-17T00:43:48.748Z,1379378628.748 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:49.105Z,1379378629.105 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:43:49.105Z,1379378629.105 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:43:49.105Z,1379378629.105 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:43:49.978Z,1379378629.978 [Reporter](INFO): sea_water_pressure 289.986200 db
2013-09-17T00:43:49.978Z,1379378629.978 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:51.116Z,1379378631.116 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:43:51.180Z,1379378631.180 [Reporter](INFO): sea_water_pressure 289.980525 db
2013-09-17T00:43:51.180Z,1379378631.180 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:52.365Z,1379378632.365 [Reporter](INFO): sea_water_pressure 289.960900 db
2013-09-17T00:43:52.366Z,1379378632.366 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:53.139Z,1379378633.139 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:43:53.139Z,1379378633.139 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:43:53.591Z,1379378633.591 [Reporter](INFO): sea_water_pressure 289.957400 db
2013-09-17T00:43:53.592Z,1379378633.592 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:54.769Z,1379378634.769 [Reporter](INFO): sea_water_pressure 289.926850 db
2013-09-17T00:43:54.770Z,1379378634.770 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:55.142Z,1379378635.142 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:43:55.143Z,1379378635.143 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:43:55.959Z,1379378635.959 [Reporter](INFO): sea_water_pressure 289.932950 db
2013-09-17T00:43:55.960Z,1379378635.960 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:57.149Z,1379378637.149 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:43:57.149Z,1379378637.149 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:43:57.149Z,1379378637.149 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:43:57.181Z,1379378637.181 [Reporter](INFO): sea_water_pressure 289.912875 db
2013-09-17T00:43:57.182Z,1379378637.182 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:58.370Z,1379378638.370 [Reporter](INFO): sea_water_pressure 289.907650 db
2013-09-17T00:43:58.371Z,1379378638.371 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:43:59.156Z,1379378639.156 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:43:59.156Z,1379378639.156 [DVL_micro](INFO): Querying output modes
2013-09-17T00:43:59.157Z,1379378639.157 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:43:59.573Z,1379378639.573 [Reporter](INFO): sea_water_pressure 289.898050 db
2013-09-17T00:43:59.573Z,1379378639.573 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:00.767Z,1379378640.767 [Reporter](INFO): sea_water_pressure 289.877525 db
2013-09-17T00:44:00.767Z,1379378640.767 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:01.163Z,1379378641.163 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:44:01.163Z,1379378641.163 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:44:01.164Z,1379378641.164 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:44:01.960Z,1379378641.960 [Reporter](INFO): sea_water_pressure 289.863125 db
2013-09-17T00:44:01.961Z,1379378641.961 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:03.167Z,1379378643.167 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:44:03.174Z,1379378643.174 [Reporter](INFO): sea_water_pressure 289.854825 db
2013-09-17T00:44:03.175Z,1379378643.175 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:04.360Z,1379378644.360 [Reporter](INFO): sea_water_pressure 289.842175 db
2013-09-17T00:44:04.361Z,1379378644.361 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:05.174Z,1379378645.174 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:44:05.174Z,1379378645.174 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:44:05.570Z,1379378645.570 [Reporter](INFO): sea_water_pressure 289.836475 db
2013-09-17T00:44:05.570Z,1379378645.570 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:06.367Z,1379378646.367 [MassServo](FAULT): Overload Error
2013-09-17T00:44:06.368Z,1379378646.368 [MassServo] Hardware Fault, FailCount= 3
2013-09-17T00:44:06.368Z,1379378646.368 [MassServo](ERROR): Hardware Fault
2013-09-17T00:44:06.430Z,1379378646.430 [CBIT](ERROR): Hardware Fault in component: MassServo
2013-09-17T00:44:06.686Z,1379378646.686 [MassServo](DEBUG): Uninitialize Mass Servo.
2013-09-17T00:44:06.686Z,1379378646.686 [MassServo](INFO): Powering down
2013-09-17T00:44:06.736Z,1379378646.736 [Reporter](INFO): sea_water_pressure 289.815975 db
2013-09-17T00:44:06.736Z,1379378646.736 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:07.177Z,1379378647.177 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:44:07.177Z,1379378647.177 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:44:07.503Z,1379378647.503 [MassServo](DEBUG): Initializing EZServoServo.
2013-09-17T00:44:07.621Z,1379378647.621 [MassServo](DEBUG): Initializing MassServo.
2013-09-17T00:44:07.652Z,1379378647.652 [CBIT](INFO): Clearing failed state for component MassServo
2013-09-17T00:44:07.652Z,1379378647.652 [MassServo] No Fault, FailCount= 3
2013-09-17T00:44:07.946Z,1379378647.946 [Reporter](INFO): sea_water_pressure 289.794150 db
2013-09-17T00:44:07.946Z,1379378647.946 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:09.149Z,1379378649.149 [Reporter](INFO): sea_water_pressure 289.794150 db
2013-09-17T00:44:09.150Z,1379378649.150 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:09.188Z,1379378649.188 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:44:09.188Z,1379378649.188 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:44:09.188Z,1379378649.188 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:44:10.342Z,1379378650.342 [Reporter](INFO): sea_water_pressure 289.792850 db
2013-09-17T00:44:10.342Z,1379378650.342 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:11.191Z,1379378651.191 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:44:11.191Z,1379378651.191 [DVL_micro](INFO): Querying output modes
2013-09-17T00:44:11.191Z,1379378651.191 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:44:11.568Z,1379378651.568 [Reporter](INFO): sea_water_pressure 289.770600 db
2013-09-17T00:44:11.568Z,1379378651.568 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:12.765Z,1379378652.765 [Reporter](INFO): sea_water_pressure 289.771025 db
2013-09-17T00:44:12.766Z,1379378652.766 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:13.202Z,1379378653.202 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:44:13.202Z,1379378653.202 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:44:13.202Z,1379378653.202 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:44:13.963Z,1379378653.963 [Reporter](INFO): sea_water_pressure 289.755725 db
2013-09-17T00:44:13.963Z,1379378653.963 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:15.161Z,1379378655.161 [Reporter](INFO): sea_water_pressure 289.739175 db
2013-09-17T00:44:15.161Z,1379378655.161 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:15.205Z,1379378655.205 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:44:16.338Z,1379378656.338 [Reporter](INFO): sea_water_pressure 289.735225 db
2013-09-17T00:44:16.339Z,1379378656.339 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:17.217Z,1379378657.217 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:44:17.217Z,1379378657.217 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:44:17.561Z,1379378657.561 [Reporter](INFO): sea_water_pressure 289.721250 db
2013-09-17T00:44:17.561Z,1379378657.561 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:18.766Z,1379378658.766 [Reporter](INFO): sea_water_pressure 289.711200 db
2013-09-17T00:44:18.767Z,1379378658.767 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:19.220Z,1379378659.220 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:44:19.220Z,1379378659.220 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:44:19.944Z,1379378659.944 [Reporter](INFO): sea_water_pressure 289.696800 db
2013-09-17T00:44:19.945Z,1379378659.945 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:21.175Z,1379378661.175 [Reporter](INFO): sea_water_pressure 289.685925 db
2013-09-17T00:44:21.175Z,1379378661.175 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:21.223Z,1379378661.223 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:44:21.223Z,1379378661.223 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:44:21.223Z,1379378661.223 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:44:22.348Z,1379378662.348 [Reporter](INFO): sea_water_pressure 289.676300 db
2013-09-17T00:44:22.348Z,1379378662.348 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:23.233Z,1379378663.233 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:44:23.234Z,1379378663.234 [DVL_micro](INFO): Querying output modes
2013-09-17T00:44:23.234Z,1379378663.234 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:44:23.562Z,1379378663.562 [Reporter](INFO): sea_water_pressure 289.657525 db
2013-09-17T00:44:23.563Z,1379378663.563 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:24.760Z,1379378664.760 [Reporter](INFO): sea_water_pressure 289.664100 db
2013-09-17T00:44:24.760Z,1379378664.760 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:25.241Z,1379378665.241 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:44:25.241Z,1379378665.241 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:44:25.241Z,1379378665.241 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:44:25.970Z,1379378665.970 [Reporter](INFO): sea_water_pressure 289.656650 db
2013-09-17T00:44:25.970Z,1379378665.970 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:27.183Z,1379378667.183 [Reporter](INFO): sea_water_pressure 289.647075 db
2013-09-17T00:44:27.184Z,1379378667.184 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:27.252Z,1379378667.252 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:44:28.366Z,1379378668.366 [Reporter](INFO): sea_water_pressure 289.618675 db
2013-09-17T00:44:28.366Z,1379378668.366 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:29.259Z,1379378669.259 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:44:29.260Z,1379378669.260 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:44:29.563Z,1379378669.563 [Reporter](INFO): sea_water_pressure 289.609950 db
2013-09-17T00:44:29.563Z,1379378669.563 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:30.339Z,1379378670.339 [CBIT](INFO): Clearing failed count for component WetLabsBB2FL
2013-09-17T00:44:30.339Z,1379378670.339 [WetLabsBB2FL] No Fault, FailCount= 5
2013-09-17T00:44:30.357Z,1379378670.357 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=4
2013-09-17T00:44:30.357Z,1379378670.357 [WetLabsBB2FL](INFO): Powering up
2013-09-17T00:44:30.733Z,1379378670.733 [Reporter](INFO): sea_water_pressure 289.607800 db
2013-09-17T00:44:30.734Z,1379378670.734 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:31.262Z,1379378671.262 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:44:31.263Z,1379378671.263 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:44:31.919Z,1379378671.919 [Reporter](INFO): sea_water_pressure 289.598175 db
2013-09-17T00:44:31.931Z,1379378671.931 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:33.137Z,1379378673.137 [Reporter](INFO): sea_water_pressure 289.595125 db
2013-09-17T00:44:33.137Z,1379378673.137 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:33.265Z,1379378673.265 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:44:33.265Z,1379378673.265 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:44:33.265Z,1379378673.265 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:44:34.318Z,1379378674.318 [Reporter](INFO): sea_water_pressure 289.590300 db
2013-09-17T00:44:34.335Z,1379378674.335 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:35.268Z,1379378675.268 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:44:35.268Z,1379378675.268 [DVL_micro](INFO): Querying output modes
2013-09-17T00:44:35.268Z,1379378675.268 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:44:35.536Z,1379378675.536 [Reporter](INFO): sea_water_pressure 289.582450 db
2013-09-17T00:44:35.541Z,1379378675.541 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:35.633Z,1379378675.633 [WetLabsBB2FL] Communications Fault, FailCount= 1
2013-09-17T00:44:35.633Z,1379378675.633 [WetLabsBB2FL](ERROR): Communications Fault
2013-09-17T00:44:35.733Z,1379378675.733 [WetLabsBB2FL](INFO): Powering down
2013-09-17T00:44:35.936Z,1379378675.936 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2013-09-17T00:44:36.349Z,1379378676.349 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2013-09-17T00:44:36.349Z,1379378676.349 [WetLabsBB2FL] No Fault, FailCount= 1
2013-09-17T00:44:36.543Z,1379378676.543 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=4
2013-09-17T00:44:36.543Z,1379378676.543 [WetLabsBB2FL](INFO): Powering up
2013-09-17T00:44:36.734Z,1379378676.734 [Reporter](INFO): sea_water_pressure 289.559325 db
2013-09-17T00:44:36.738Z,1379378676.738 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:37.279Z,1379378677.279 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:44:37.279Z,1379378677.279 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:44:37.280Z,1379378677.280 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:44:37.935Z,1379378677.935 [Reporter](INFO): sea_water_pressure 289.554525 db
2013-09-17T00:44:37.936Z,1379378677.936 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:39.137Z,1379378679.137 [Reporter](INFO): sea_water_pressure 289.566325 db
2013-09-17T00:44:39.137Z,1379378679.137 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:39.286Z,1379378679.286 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:44:40.320Z,1379378680.320 [Reporter](INFO): sea_water_pressure 289.531375 db
2013-09-17T00:44:40.328Z,1379378680.328 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:41.298Z,1379378681.298 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:44:41.298Z,1379378681.298 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:44:41.626Z,1379378681.626 [Reporter](INFO): sea_water_pressure 289.541400 db
2013-09-17T00:44:41.626Z,1379378681.626 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:41.806Z,1379378681.806 [WetLabsBB2FL] Communications Fault, FailCount= 2
2013-09-17T00:44:41.806Z,1379378681.806 [WetLabsBB2FL](ERROR): Communications Fault
2013-09-17T00:44:41.899Z,1379378681.899 [WetLabsBB2FL](INFO): Powering down
2013-09-17T00:44:41.961Z,1379378681.961 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2013-09-17T00:44:42.342Z,1379378682.342 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2013-09-17T00:44:42.342Z,1379378682.342 [WetLabsBB2FL] No Fault, FailCount= 2
2013-09-17T00:44:42.709Z,1379378682.709 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=4
2013-09-17T00:44:42.709Z,1379378682.709 [WetLabsBB2FL](INFO): Powering up
2013-09-17T00:44:42.735Z,1379378682.735 [Reporter](INFO): sea_water_pressure 289.531375 db
2013-09-17T00:44:42.736Z,1379378682.736 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:43.301Z,1379378683.301 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:44:43.301Z,1379378683.301 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:44:43.933Z,1379378683.933 [Reporter](INFO): sea_water_pressure 289.522225 db
2013-09-17T00:44:43.941Z,1379378683.941 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:45.147Z,1379378685.147 [Reporter](INFO): sea_water_pressure 289.500400 db
2013-09-17T00:44:45.148Z,1379378685.148 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:45.312Z,1379378685.312 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:44:45.312Z,1379378685.312 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:44:45.313Z,1379378685.313 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:44:46.336Z,1379378686.336 [Reporter](INFO): sea_water_pressure 289.502575 db
2013-09-17T00:44:46.337Z,1379378686.337 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:47.323Z,1379378687.323 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:44:47.323Z,1379378687.323 [DVL_micro](INFO): Querying output modes
2013-09-17T00:44:47.323Z,1379378687.323 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:44:47.563Z,1379378687.563 [Reporter](INFO): sea_water_pressure 289.491250 db
2013-09-17T00:44:47.563Z,1379378687.563 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:47.984Z,1379378687.984 [WetLabsBB2FL] Communications Fault, FailCount= 3
2013-09-17T00:44:47.984Z,1379378687.984 [WetLabsBB2FL](ERROR): Communications Fault
2013-09-17T00:44:48.080Z,1379378688.080 [WetLabsBB2FL](INFO): Powering down
2013-09-17T00:44:48.343Z,1379378688.343 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2013-09-17T00:44:48.732Z,1379378688.732 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2013-09-17T00:44:48.732Z,1379378688.732 [WetLabsBB2FL] No Fault, FailCount= 3
2013-09-17T00:44:48.733Z,1379378688.733 [Reporter](INFO): sea_water_pressure 289.490350 db
2013-09-17T00:44:48.734Z,1379378688.734 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:48.891Z,1379378688.891 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=4
2013-09-17T00:44:48.891Z,1379378688.891 [WetLabsBB2FL](INFO): Powering up
2013-09-17T00:44:49.326Z,1379378689.326 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:44:49.326Z,1379378689.326 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:44:49.326Z,1379378689.326 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:44:49.934Z,1379378689.934 [Reporter](INFO): sea_water_pressure 289.477700 db
2013-09-17T00:44:49.935Z,1379378689.935 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:51.165Z,1379378691.165 [Reporter](INFO): sea_water_pressure 289.476375 db
2013-09-17T00:44:51.165Z,1379378691.165 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:51.337Z,1379378691.337 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:44:52.334Z,1379378692.334 [Reporter](INFO): sea_water_pressure 289.472900 db
2013-09-17T00:44:52.342Z,1379378692.342 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:53.341Z,1379378693.341 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:44:53.341Z,1379378693.341 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:44:53.564Z,1379378693.564 [Reporter](INFO): sea_water_pressure 289.443200 db
2013-09-17T00:44:53.565Z,1379378693.565 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:54.169Z,1379378694.169 [WetLabsBB2FL] Communications Fault, FailCount= 4
2013-09-17T00:44:54.169Z,1379378694.169 [WetLabsBB2FL](ERROR): Communications Fault
2013-09-17T00:44:54.270Z,1379378694.270 [WetLabsBB2FL](INFO): Powering down
2013-09-17T00:44:54.364Z,1379378694.364 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2013-09-17T00:44:54.729Z,1379378694.729 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2013-09-17T00:44:54.729Z,1379378694.729 [WetLabsBB2FL] No Fault, FailCount= 4
2013-09-17T00:44:54.731Z,1379378694.731 [Reporter](INFO): sea_water_pressure 289.446725 db
2013-09-17T00:44:54.731Z,1379378694.731 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:55.083Z,1379378695.083 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=4
2013-09-17T00:44:55.083Z,1379378695.083 [WetLabsBB2FL](INFO): Powering up
2013-09-17T00:44:55.344Z,1379378695.344 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:44:55.344Z,1379378695.344 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:44:55.936Z,1379378695.936 [Reporter](INFO): sea_water_pressure 289.448875 db
2013-09-17T00:44:55.944Z,1379378695.944 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:57.146Z,1379378697.146 [Reporter](INFO): sea_water_pressure 289.438000 db
2013-09-17T00:44:57.146Z,1379378697.146 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:57.346Z,1379378697.346 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:44:57.346Z,1379378697.346 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:44:57.347Z,1379378697.347 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:44:58.336Z,1379378698.336 [Reporter](INFO): sea_water_pressure 289.438425 db
2013-09-17T00:44:58.336Z,1379378698.336 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:44:59.353Z,1379378699.353 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:44:59.354Z,1379378699.354 [DVL_micro](INFO): Querying output modes
2013-09-17T00:44:59.354Z,1379378699.354 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:44:59.566Z,1379378699.566 [Reporter](INFO): sea_water_pressure 289.414825 db
2013-09-17T00:44:59.566Z,1379378699.566 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:45:00.367Z,1379378700.367 [WetLabsBB2FL] Communications Fault, FailCount= 5
2013-09-17T00:45:00.367Z,1379378700.367 [WetLabsBB2FL](ERROR): Communications Fault
2013-09-17T00:45:00.374Z,1379378700.374 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2013-09-17T00:45:00.374Z,1379378700.374 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL
2013-09-17T00:45:00.463Z,1379378700.463 [WetLabsBB2FL](INFO): Powering down
2013-09-17T00:45:00.735Z,1379378700.735 [Reporter](INFO): sea_water_pressure 289.422275 db
2013-09-17T00:45:00.744Z,1379378700.744 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:45:01.365Z,1379378701.365 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:45:01.365Z,1379378701.365 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:45:01.365Z,1379378701.365 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:45:01.973Z,1379378701.973 [Reporter](INFO): sea_water_pressure 289.409175 db
2013-09-17T00:45:01.974Z,1379378701.974 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:45:03.175Z,1379378703.175 [Reporter](INFO): sea_water_pressure 289.408300 db
2013-09-17T00:45:03.176Z,1379378703.176 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:45:03.372Z,1379378703.372 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:45:04.373Z,1379378704.373 [Reporter](INFO): sea_water_pressure 289.395625 db
2013-09-17T00:45:04.374Z,1379378704.374 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:45:05.384Z,1379378705.384 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:45:05.384Z,1379378705.384 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:45:05.591Z,1379378705.591 [Reporter](INFO): sea_water_pressure 289.393900 db
2013-09-17T00:45:05.591Z,1379378705.591 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:45:06.761Z,1379378706.761 [Reporter](INFO): sea_water_pressure 289.390400 db
2013-09-17T00:45:06.761Z,1379378706.761 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:45:07.386Z,1379378707.386 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-17T00:45:07.387Z,1379378707.387 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0
2013-09-17T00:45:07.959Z,1379378707.959 [Reporter](INFO): sea_water_pressure 289.381225 db
2013-09-17T00:45:07.959Z,1379378707.959 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:45:09.169Z,1379378709.169 [Reporter](INFO): sea_water_pressure 289.367250 db
2013-09-17T00:45:09.169Z,1379378709.169 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:45:09.389Z,1379378709.389 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:45:09.389Z,1379378709.389 [DVL_micro](INFO): Enabling NQ1 output
2013-09-17T00:45:09.390Z,1379378709.390 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1
2013-09-17T00:45:10.363Z,1379378710.363 [Reporter](INFO): sea_water_pressure 289.364200 db
2013-09-17T00:45:10.363Z,1379378710.363 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:45:11.396Z,1379378711.396 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:45:11.396Z,1379378711.396 [DVL_micro](INFO): Querying output modes
2013-09-17T00:45:11.396Z,1379378711.396 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2013-09-17T00:45:11.572Z,1379378711.572 [Reporter](INFO): sea_water_pressure 289.375125 db
2013-09-17T00:45:11.573Z,1379378711.573 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:45:12.770Z,1379378712.770 [Reporter](INFO): sea_water_pressure 289.347175 db
2013-09-17T00:45:12.771Z,1379378712.771 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:45:13.407Z,1379378713.407 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:45:13.408Z,1379378713.408 [DVL_micro](INFO): Output Modes: No Response
2013-09-17T00:45:13.408Z,1379378713.408 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2013-09-17T00:45:13.572Z,1379378713.572 [MassServo](FAULT): Overload Error
2013-09-17T00:45:13.572Z,1379378713.572 [MassServo] Hardware Fault, FailCount= 4
2013-09-17T00:45:13.572Z,1379378713.572 [MassServo](ERROR): Hardware Fault
2013-09-17T00:45:13.638Z,1379378713.638 [CBIT](ERROR): Hardware Fault in component: MassServo
2013-09-17T00:45:13.982Z,1379378713.982 [MassServo](DEBUG): Uninitialize Mass Servo.
2013-09-17T00:45:13.982Z,1379378713.982 [MassServo](INFO): Powering down
2013-09-17T00:45:14.009Z,1379378714.009 [Reporter](INFO): sea_water_pressure 289.326225 db
2013-09-17T00:45:14.009Z,1379378714.009 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:45:14.764Z,1379378714.764 [MassServo](DEBUG): Initializing EZServoServo.
2013-09-17T00:45:14.883Z,1379378714.883 [MassServo](DEBUG): Initializing MassServo.
2013-09-17T00:45:14.912Z,1379378714.912 [CBIT](INFO): Clearing failed state for component MassServo
2013-09-17T00:45:14.912Z,1379378714.912 [MassServo] No Fault, FailCount= 4
2013-09-17T00:45:15.198Z,1379378715.198 [Reporter](INFO): sea_water_pressure 289.335400 db
2013-09-17T00:45:15.198Z,1379378715.198 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:45:15.420Z,1379378715.420 [DVL_micro](DEBUG): cmdResponse:
2013-09-17T00:45:16.339Z,1379378716.339 [Reporter](INFO): sea_water_pressure 289.324025 db
2013-09-17T00:45:16.339Z,1379378716.339 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-09-17T00:45:17.422Z,1379378717.422 [DVL_micro](INFO): NQ1 requested
2013-09-17T00:45:17.422Z,1379378717.422 [DVL_micro](INFO): Cycling power to configure device.
2013-09-17T00:45:17.602Z,1379378717.602 [Reporter](INFO): sea_water_pressure 289.328850 db
2013-09-17T00:45:17.602Z,13793