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