2013-09-17T01:00:26.110Z,1379379626.110 [Supervisor](DEBUG): Initializing supervisor. 2013-09-17T01:00:26.116Z,1379379626.116 [SyncHandler](DEBUG): Created PCaller Thread at 4033B4E0 2013-09-17T01:00:26.116Z,1379379626.116 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2013-09-17T01:00:26.120Z,1379379626.120 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4036B4E0 2013-09-17T01:00:26.123Z,1379379626.123 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2013-09-17T01:00:26.134Z,1379379626.134 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2013-09-17T01:00:26.136Z,1379379626.136 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 4039B4E0 2013-09-17T01:00:26.137Z,1379379626.137 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2013-09-17T01:00:26.140Z,1379379626.140 [logger ThreadHandler](DEBUG): Created PCaller Thread at 403CB4E0 2013-09-17T01:00:26.140Z,1379379626.140 [Supervisor](INFO): Looking for Config files in directory: Config/ 2013-09-17T01:00:26.144Z,1379379626.144 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2013-09-17T01:00:26.455Z,1379379626.455 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2013-09-17T01:00:26.456Z,1379379626.456 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2013-09-17T01:00:26.673Z,1379379626.673 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2013-09-17T01:00:26.674Z,1379379626.674 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2013-09-17T01:00:26.769Z,1379379626.769 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2013-09-17T01:00:26.771Z,1379379626.771 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2013-09-17T01:00:26.898Z,1379379626.898 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2013-09-17T01:00:26.898Z,1379379626.898 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2013-09-17T01:00:27.054Z,1379379627.054 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2013-09-17T01:00:27.056Z,1379379627.056 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2013-09-17T01:00:27.321Z,1379379627.321 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2013-09-17T01:00:27.322Z,1379379627.322 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2013-09-17T01:00:27.506Z,1379379627.506 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2013-09-17T01:00:27.509Z,1379379627.509 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2013-09-17T01:00:27.804Z,1379379627.804 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2013-09-17T01:00:27.806Z,1379379627.806 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2013-09-17T01:00:27.923Z,1379379627.923 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2013-09-17T01:00:27.924Z,1379379627.924 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2013-09-17T01:00:28.385Z,1379379628.385 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2013-09-17T01:00:28.385Z,1379379628.385 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2013-09-17T01:00:28.504Z,1379379628.504 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2013-09-17T01:00:28.505Z,1379379628.505 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2013-09-17T01:00:28.601Z,1379379628.601 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/ 2013-09-17T01:00:28.605Z,1379379628.605 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg 2013-09-17T01:00:28.714Z,1379379628.714 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg 2013-09-17T01:00:28.857Z,1379379628.857 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg 2013-09-17T01:00:28.965Z,1379379628.965 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg 2013-09-17T01:00:29.081Z,1379379629.081 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg 2013-09-17T01:00:29.189Z,1379379629.189 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg 2013-09-17T01:00:29.316Z,1379379629.316 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg 2013-09-17T01:00:29.422Z,1379379629.422 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg 2013-09-17T01:00:29.516Z,1379379629.516 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2013-09-17T01:00:29.521Z,1379379629.521 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2013-09-17T01:00:29.750Z,1379379629.750 [InternalSim] Loaded 2013-09-17T01:00:29.750Z,1379379629.750 [ComponentRegistry](DEBUG): SyncComponent "InternalSim" handled in the control thread. 2013-09-17T01:00:29.751Z,1379379629.751 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2013-09-17T01:00:29.752Z,1379379629.752 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2013-09-17T01:00:29.890Z,1379379629.890 [SBIT](DEBUG): Construct Startup Built In Test. 2013-09-17T01:00:29.920Z,1379379629.920 [SBIT] Loaded 2013-09-17T01:00:29.920Z,1379379629.920 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2013-09-17T01:00:29.921Z,1379379629.921 [IBIT](DEBUG): Construct Initiated Built In Test. 2013-09-17T01:00:29.961Z,1379379629.961 [IBIT] Loaded 2013-09-17T01:00:29.961Z,1379379629.961 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2013-09-17T01:00:29.963Z,1379379629.963 [CBIT](DEBUG): Construct CBIT Built In Test. 2013-09-17T01:00:30.105Z,1379379630.105 [CBIT] Loaded 2013-09-17T01:00:30.105Z,1379379630.105 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2013-09-17T01:00:30.106Z,1379379630.106 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2013-09-17T01:00:30.107Z,1379379630.107 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2013-09-17T01:00:30.320Z,1379379630.320 [BuoyancyServo] Loaded 2013-09-17T01:00:30.320Z,1379379630.320 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2013-09-17T01:00:30.332Z,1379379630.332 [ElevatorServo] Loaded 2013-09-17T01:00:30.333Z,1379379630.333 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2013-09-17T01:00:30.348Z,1379379630.348 [MassServo] Loaded 2013-09-17T01:00:30.348Z,1379379630.348 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2013-09-17T01:00:30.360Z,1379379630.360 [RudderServo] Loaded 2013-09-17T01:00:30.360Z,1379379630.360 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2013-09-17T01:00:30.372Z,1379379630.372 [ThrusterServo] Loaded 2013-09-17T01:00:30.372Z,1379379630.372 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2013-09-17T01:00:30.373Z,1379379630.373 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2013-09-17T01:00:30.373Z,1379379630.373 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2013-09-17T01:00:30.432Z,1379379630.432 [DepthRateCalculator] Loaded 2013-09-17T01:00:30.432Z,1379379630.432 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2013-09-17T01:00:33.854Z,1379379633.854 [HFRadarModelCalc] Loaded 2013-09-17T01:00:33.854Z,1379379633.854 [ComponentRegistry](DEBUG): SyncComponent "HFRadarModelCalc" handled in the control thread. 2013-09-17T01:00:33.871Z,1379379633.871 [NavChart] Loaded 2013-09-17T01:00:33.872Z,1379379633.872 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2013-09-17T01:00:33.877Z,1379379633.877 [PitchRateCalculator] Loaded 2013-09-17T01:00:33.878Z,1379379633.878 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2013-09-17T01:00:33.893Z,1379379633.893 [SpeedCalculator] Loaded 2013-09-17T01:00:33.893Z,1379379633.893 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2013-09-17T01:00:33.910Z,1379379633.910 [TempGradientCalculator] Loaded 2013-09-17T01:00:33.910Z,1379379633.910 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2013-09-17T01:00:33.916Z,1379379633.916 [YawRateCalculator] Loaded 2013-09-17T01:00:33.916Z,1379379633.916 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2013-09-17T01:00:33.969Z,1379379633.969 [Navigation] Loaded 2013-09-17T01:00:33.969Z,1379379633.969 [ComponentRegistry](DEBUG): SyncComponent "Navigation" handled in the control thread. 2013-09-17T01:00:33.970Z,1379379633.970 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2013-09-17T01:00:33.971Z,1379379633.971 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2013-09-17T01:00:34.289Z,1379379634.289 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2013-09-17T01:00:34.290Z,1379379634.290 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2013-09-17T01:00:34.335Z,1379379634.335 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2013-09-17T01:00:34.336Z,1379379634.336 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2013-09-17T01:00:34.410Z,1379379634.410 [VerticalControl](DEBUG): Construct VerticalControl. 2013-09-17T01:00:34.519Z,1379379634.519 [VerticalControl] Loaded 2013-09-17T01:00:34.519Z,1379379634.519 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2013-09-17T01:00:34.520Z,1379379634.520 [HorizontalControl](DEBUG): Construct HorizontalControl. 2013-09-17T01:00:34.584Z,1379379634.584 [HorizontalControl] Loaded 2013-09-17T01:00:34.584Z,1379379634.584 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2013-09-17T01:00:34.585Z,1379379634.585 [SpeedControl](DEBUG): Construct SpeedControl. 2013-09-17T01:00:34.587Z,1379379634.587 [SpeedControl] Loaded 2013-09-17T01:00:34.587Z,1379379634.587 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2013-09-17T01:00:34.588Z,1379379634.588 [LoopControl](DEBUG): Construct LoopControl. 2013-09-17T01:00:34.588Z,1379379634.588 [LoopControl] Loaded 2013-09-17T01:00:34.588Z,1379379634.588 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2013-09-17T01:00:34.593Z,1379379634.593 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2013-09-17T01:00:34.594Z,1379379634.594 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2013-09-17T01:00:34.606Z,1379379634.606 [AsyncPiEstimator](DEBUG): Construct AsyncPiEstimator. 2013-09-17T01:00:34.611Z,1379379634.611 [AsyncPiEstimator] Loaded 2013-09-17T01:00:34.612Z,1379379634.612 [ComponentRegistry](DEBUG): Component "AsyncPiEstimator" handled in its own thread. 2013-09-17T01:00:34.617Z,1379379634.617 [AsyncPiEstimator ThreadHandler](DEBUG): Created PCaller Thread at 406474E0 2013-09-17T01:00:34.617Z,1379379634.617 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2013-09-17T01:00:34.618Z,1379379634.618 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2013-09-17T01:00:34.888Z,1379379634.888 [AHRS_sp3003D] Loaded 2013-09-17T01:00:34.888Z,1379379634.888 [ComponentRegistry](DEBUG): SyncComponent "AHRS_sp3003D" handled in the control thread. 2013-09-17T01:00:34.902Z,1379379634.902 [Depth_Keller] Loaded 2013-09-17T01:00:34.903Z,1379379634.903 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2013-09-17T01:00:34.908Z,1379379634.908 [DropWeight] Loaded 2013-09-17T01:00:34.908Z,1379379634.908 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2013-09-17T01:00:35.119Z,1379379635.119 [DVL_micro] Loaded 2013-09-17T01:00:35.119Z,1379379635.119 [ComponentRegistry](DEBUG): Component "DVL_micro" handled in its own thread. 2013-09-17T01:00:35.122Z,1379379635.122 [DVL_micro ThreadHandler](DEBUG): Created PCaller Thread at 406CE4E0 2013-09-17T01:00:35.222Z,1379379635.222 [NAL9602] Loaded 2013-09-17T01:00:35.222Z,1379379635.222 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2013-09-17T01:00:35.271Z,1379379635.271 [Onboard] Loaded 2013-09-17T01:00:35.271Z,1379379635.271 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2013-09-17T01:00:35.278Z,1379379635.278 [Radio_Freewave] Loaded 2013-09-17T01:00:35.279Z,1379379635.279 [ComponentRegistry](DEBUG): SyncComponent "Radio_Freewave" handled in the control thread. 2013-09-17T01:00:35.442Z,1379379635.442 [DAT] Loaded 2013-09-17T01:00:35.442Z,1379379635.442 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread. 2013-09-17T01:00:35.449Z,1379379635.449 [SCPI] Loaded 2013-09-17T01:00:35.449Z,1379379635.449 [ComponentRegistry](DEBUG): SyncComponent "SCPI" handled in the control thread. 2013-09-17T01:00:35.450Z,1379379635.450 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2013-09-17T01:00:35.454Z,1379379635.454 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2013-09-17T01:00:35.590Z,1379379635.590 [CTD_NeilBrown] Loaded 2013-09-17T01:00:35.591Z,1379379635.591 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread. 2013-09-17T01:00:35.594Z,1379379635.594 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 4072B4E0 2013-09-17T01:00:35.610Z,1379379635.610 [PAR_Licor] Loaded 2013-09-17T01:00:35.610Z,1379379635.610 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2013-09-17T01:00:35.648Z,1379379635.648 [WetLabsBB2FL] Loaded 2013-09-17T01:00:35.648Z,1379379635.648 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2013-09-17T01:00:35.650Z,1379379635.650 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 4075B4E0 2013-09-17T01:00:35.651Z,1379379635.651 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2013-09-17T01:00:35.654Z,1379379635.654 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2013-09-17T01:00:35.655Z,1379379635.655 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2013-09-17T01:00:35.669Z,1379379635.669 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2013-09-17T01:00:35.670Z,1379379635.670 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 4078B4E0 2013-09-17T01:00:35.675Z,1379379635.675 [Supervisor](DEBUG): Running supervisor. 2013-09-17T01:00:35.676Z,1379379635.676 [CommandLine](INFO): Thread ID is 760 2013-09-17T01:00:35.679Z,1379379635.679 [controlThread](INFO): Thread ID is 759 2013-09-17T01:00:35.679Z,1379379635.679 [controlThread](DEBUG): Initializing ControlThread 2013-09-17T01:00:35.680Z,1379379635.680 [CycleStarter](INFO): Thread ID is 758 2013-09-17T01:00:35.680Z,1379379635.680 [InternalSim](DEBUG): InternalSim initializing... 2013-09-17T01:00:35.763Z,1379379635.763 [logger](INFO): Thread ID is 761 2013-09-17T01:00:35.811Z,1379379635.811 [AsyncPiEstimator](INFO): Thread ID is 822 2013-09-17T01:00:35.811Z,1379379635.811 [AsyncPiEstimator](DEBUG): Initialize AsyncPiEstimator. 2013-09-17T01:00:35.825Z,1379379635.825 [SBIT](INFO): Initialize SBIT Component. 2013-09-17T01:00:35.825Z,1379379635.825 [SBIT](IMPORTANT): Tethys CM Info: $Rev:10634 2013-09-17T01:00:35.826Z,1379379635.826 [SBIT](IMPORTANT): Kernel Release:2.6.27.8 2013-09-17T01:00:35.826Z,1379379635.826 [SBIT](IMPORTANT): Kernel Version:#634 PREEMPT Wed Feb 13 10:21:48 PST 2013 2013-09-17T01:00:35.826Z,1379379635.826 [IBIT](INFO): Initialize IBIT Component. 2013-09-17T01:00:35.828Z,1379379635.828 [DVL_micro](INFO): Thread ID is 823 2013-09-17T01:00:35.831Z,1379379635.831 [CBIT](DEBUG): Initialize CBIT Component. 2013-09-17T01:00:35.831Z,1379379635.831 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL. 2013-09-17T01:00:35.831Z,1379379635.831 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2013-09-17T01:00:35.843Z,1379379635.843 [CTD_NeilBrown](INFO): Thread ID is 824 2013-09-17T01:00:35.843Z,1379379635.843 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown. 2013-09-17T01:00:35.845Z,1379379635.845 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4 2013-09-17T01:00:35.856Z,1379379635.856 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2013-09-17T01:00:35.857Z,1379379635.857 [NavChart](DEBUG): Initialize NavChart Derivation. 2013-09-17T01:00:35.857Z,1379379635.857 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2013-09-17T01:00:35.857Z,1379379635.857 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2013-09-17T01:00:35.858Z,1379379635.858 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2013-09-17T01:00:35.858Z,1379379635.858 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2013-09-17T01:00:35.859Z,1379379635.859 [Navigation](DEBUG): Initializing Navigation. 2013-09-17T01:00:35.859Z,1379379635.859 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2013-09-17T01:00:35.861Z,1379379635.861 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2013-09-17T01:00:35.862Z,1379379635.862 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2013-09-17T01:00:35.862Z,1379379635.862 [LoopControl](DEBUG): Initialize LoopControlComponent. 2013-09-17T01:00:35.888Z,1379379635.888 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2013-09-17T01:00:35.888Z,1379379635.888 [DropWeight] Hardware Fault, FailCount= 1 2013-09-17T01:00:35.888Z,1379379635.888 [DropWeight](ERROR): Hardware Fault 2013-09-17T01:00:35.892Z,1379379635.892 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2013-09-17T01:00:35.912Z,1379379635.912 [WetLabsBB2FL](INFO): Thread ID is 825 2013-09-17T01:00:35.913Z,1379379635.913 [WetLabsBB2FL](INFO): Powering down 2013-09-17T01:00:35.931Z,1379379635.931 [DVL_micro](INFO): Initializing 2013-09-17T01:00:35.932Z,1379379635.932 [DVL_micro](INFO): start:Powering up 2013-09-17T01:00:35.932Z,1379379635.932 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:00:35.933Z,1379379635.933 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:00:35.938Z,1379379635.938 [NavChartDb](INFO): Thread ID is 826 2013-09-17T01:00:36.023Z,1379379636.023 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2013-09-17T01:00:36.036Z,1379379636.036 [MissionManager](DEBUG): 2013-09-17T01:00:36.037Z,1379379636.037 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2013-09-17T01:00:36.043Z,1379379636.043 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources 2013-09-17T01:00:36.047Z,1379379636.047 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2013-09-17T01:00:36.048Z,1379379636.048 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2013-09-17T01:00:36.048Z,1379379636.048 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2013-09-17T01:00:36.048Z,1379379636.048 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2013-09-17T01:00:36.048Z,1379379636.048 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2013-09-17T01:00:36.049Z,1379379636.049 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2013-09-17T01:00:36.049Z,1379379636.049 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2013-09-17T01:00:36.049Z,1379379636.049 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2013-09-17T01:00:36.139Z,1379379636.139 [MissionManager](INFO): DefineArg Default.NeedGPS = 1 bool 2013-09-17T01:00:36.142Z,1379379636.142 [Default:GPS:A.SetSpeed](DEBUG): Construct. 2013-09-17T01:00:36.152Z,1379379636.152 [Default:GPS:B.GoToSurface](DEBUG): Construct GoToSurface. 2013-09-17T01:00:36.188Z,1379379636.188 [Default:Iridium:A.SetSpeed](DEBUG): Construct. 2013-09-17T01:00:36.191Z,1379379636.191 [Default:Iridium:B.GoToSurface](DEBUG): Construct GoToSurface. 2013-09-17T01:00:36.213Z,1379379636.213 [Default:Iridium:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2013-09-17T01:00:36.235Z,1379379636.235 [Default:D.SetSpeed](DEBUG): Construct. 2013-09-17T01:00:36.238Z,1379379636.238 [Default:E.GoToSurface](DEBUG): Construct GoToSurface. 2013-09-17T01:00:36.252Z,1379379636.252 [Default:F.Wait](DEBUG): Construct Wait. 2013-09-17T01:00:36.280Z,1379379636.280 [MissionManager](DEBUG): 400 400 Burn 300 Dropped drop weight due to communications timeout 5.0 1.0 5 2013-09-17T01:00:36.284Z,1379379636.284 [controlThread](DEBUG): Component order: CycleStarter,InternalSim,AHRS_sp3003D,Depth_Keller,DropWeight,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-17T01:00:36.347Z,1379379636.347 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D. 2013-09-17T01:00:36.363Z,1379379636.363 [Depth_Keller](ERROR): Pressure reading out of range: 1831.078247 decibar 2013-09-17T01:00:36.440Z,1379379636.440 [Radio_Freewave](INFO): Powering up 2013-09-17T01:00:36.445Z,1379379636.445 [DAT](INFO): Powering up 2013-09-17T01:00:36.445Z,1379379636.445 [DAT](DEBUG): Initializing DAT. 2013-09-17T01:00:36.847Z,1379379636.847 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2013-09-17T01:00:36.852Z,1379379636.852 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2013-09-17T01:00:36.859Z,1379379636.859 [ElevatorServo](DEBUG): Initializing EZServoServo. 2013-09-17T01:00:36.885Z,1379379636.885 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2013-09-17T01:00:36.901Z,1379379636.901 [MassServo](DEBUG): Initializing EZServoServo. 2013-09-17T01:00:36.909Z,1379379636.909 [MassServo](DEBUG): Initializing MassServo. 2013-09-17T01:00:36.915Z,1379379636.915 [RudderServo](DEBUG): Initializing EZServoServo. 2013-09-17T01:00:36.921Z,1379379636.921 [RudderServo](DEBUG): Initializing RudderServo. 2013-09-17T01:00:36.926Z,1379379636.926 [ThrusterServo](DEBUG): Initializing EZServoServo. 2013-09-17T01:00:36.929Z,1379379636.929 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2013-09-17T01:00:36.985Z,1379379636.985 [CommandLine](FAULT): Scheduling is paused 2013-09-17T01:00:36.986Z,1379379636.986 [CBIT](FAULT): Main Battery Failure. Count: 1 2013-09-17T01:00:36.987Z,1379379636.987 [CBIT](ERROR): Hardware Fault in component: DropWeight 2013-09-17T01:00:36.987Z,1379379636.987 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2013-09-17T01:00:37.185Z,1379379637.185 [AHRS_sp3003D](ERROR): readHeadingMagBin UART error: serial timeout 2013-09-17T01:00:37.185Z,1379379637.185 [AHRS_sp3003D](ERROR): readHeadingMagBin got 0x00 2013-09-17T01:00:37.185Z,1379379637.185 [AHRS_sp3003D](ERROR): SP3003D failed to initialize 2013-09-17T01:00:37.185Z,1379379637.185 [AHRS_sp3003D] Hardware Fault, FailCount= 1 2013-09-17T01:00:37.185Z,1379379637.185 [AHRS_sp3003D](ERROR): Hardware Fault 2013-09-17T01:00:37.347Z,1379379637.347 [CBIT](ERROR): Hardware Fault in component: AHRS_sp3003D 2013-09-17T01:00:37.428Z,1379379637.428 [AHRS_sp3003D](INFO): Powering down 2013-09-17T01:00:37.966Z,1379379637.966 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:00:37.967Z,1379379637.967 [DVL_micro](INFO): Querying output modes 2013-09-17T01:00:37.967Z,1379379637.967 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:00:38.096Z,1379379638.096 [Radio_Freewave](INFO): Powering down 2013-09-17T01:00:38.823Z,1379379638.823 [CBIT](INFO): Clearing failed state for component AHRS_sp3003D 2013-09-17T01:00:38.824Z,1379379638.824 [AHRS_sp3003D] No Fault, FailCount= 1 2013-09-17T01:00:39.160Z,1379379639.160 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D. 2013-09-17T01:00:39.969Z,1379379639.969 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:00:39.969Z,1379379639.969 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:00:39.970Z,1379379639.970 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:00:40.294Z,1379379640.294 [AHRS_sp3003D](ERROR): readHeadingMagBin UART error: serial timeout 2013-09-17T01:00:40.294Z,1379379640.294 [AHRS_sp3003D](ERROR): SP3003D failed to initialize 2013-09-17T01:00:40.294Z,1379379640.294 [AHRS_sp3003D] Hardware Fault, FailCount= 2 2013-09-17T01:00:40.294Z,1379379640.294 [AHRS_sp3003D](ERROR): Hardware Fault 2013-09-17T01:00:40.299Z,1379379640.299 [NAL9602](INFO): Powering up NAL9602 2013-09-17T01:00:40.445Z,1379379640.445 [CBIT](ERROR): Hardware Fault in component: AHRS_sp3003D 2013-09-17T01:00:40.495Z,1379379640.495 [AHRS_sp3003D](INFO): Powering down 2013-09-17T01:00:41.851Z,1379379641.851 [CBIT](INFO): Clearing failed state for component AHRS_sp3003D 2013-09-17T01:00:41.851Z,1379379641.851 [AHRS_sp3003D] No Fault, FailCount= 2 2013-09-17T01:00:41.980Z,1379379641.980 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:00:41.986Z,1379379641.986 [DVL_micro](INFO): pause:Powering down 2013-09-17T01:00:42.188Z,1379379642.188 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D. 2013-09-17T01:00:43.334Z,1379379643.334 [AHRS_sp3003D](ERROR): readHeadingMagBin UART error: serial timeout 2013-09-17T01:00:43.334Z,1379379643.334 [AHRS_sp3003D](ERROR): SP3003D failed to initialize 2013-09-17T01:00:43.335Z,1379379643.335 [AHRS_sp3003D] Hardware Fault, FailCount= 3 2013-09-17T01:00:43.335Z,1379379643.335 [AHRS_sp3003D](ERROR): Hardware Fault 2013-09-17T01:00:43.466Z,1379379643.466 [CBIT](ERROR): Hardware Fault in component: AHRS_sp3003D 2013-09-17T01:00:43.523Z,1379379643.523 [AHRS_sp3003D](INFO): Powering down 2013-09-17T01:00:43.591Z,1379379643.591 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:00:43.592Z,1379379643.592 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:00:43.592Z,1379379643.592 [DVL_micro](INFO): resume:Powering up 2013-09-17T01:00:43.592Z,1379379643.592 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:00:44.892Z,1379379644.892 [CBIT](INFO): Clearing failed state for component AHRS_sp3003D 2013-09-17T01:00:44.892Z,1379379644.892 [AHRS_sp3003D] No Fault, FailCount= 3 2013-09-17T01:00:45.101Z,1379379645.101 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D. 2013-09-17T01:00:45.598Z,1379379645.598 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:00:45.598Z,1379379645.598 [DVL_micro](INFO): Querying output modes 2013-09-17T01:00:45.599Z,1379379645.599 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:00:46.239Z,1379379646.239 [AHRS_sp3003D](ERROR): readHeadingMagBin UART error: serial timeout 2013-09-17T01:00:46.239Z,1379379646.239 [AHRS_sp3003D](ERROR): SP3003D failed to initialize 2013-09-17T01:00:46.239Z,1379379646.239 [AHRS_sp3003D] Hardware Fault, FailCount= 4 2013-09-17T01:00:46.239Z,1379379646.239 [AHRS_sp3003D](ERROR): Hardware Fault 2013-09-17T01:00:46.386Z,1379379646.386 [CBIT](ERROR): Hardware Fault in component: AHRS_sp3003D 2013-09-17T01:00:46.407Z,1379379646.407 [AHRS_sp3003D](INFO): Powering down 2013-09-17T01:00:47.299Z,1379379647.299 [CBIT](CRITICAL): ABORT DEPTH REACHED. ACTIVATING BURNWIRE. 2013-09-17T01:00:47.313Z,1379379647.313 [CBIT](CRITICAL): STOP DEPTH REACHED. Terminating Mission. 2013-09-17T01:00:47.609Z,1379379647.609 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:00:47.609Z,1379379647.609 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:00:47.609Z,1379379647.609 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:00:47.724Z,1379379647.724 [CBIT](INFO): Clearing failed state for component AHRS_sp3003D 2013-09-17T01:00:47.724Z,1379379647.724 [AHRS_sp3003D] No Fault, FailCount= 4 2013-09-17T01:00:48.000Z,1379379648.000 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D. 2013-09-17T01:00:49.155Z,1379379649.155 [AHRS_sp3003D](ERROR): readHeadingMagBin UART error: serial timeout 2013-09-17T01:00:49.155Z,1379379649.155 [AHRS_sp3003D](ERROR): SP3003D failed to initialize 2013-09-17T01:00:49.156Z,1379379649.156 [AHRS_sp3003D] Hardware Fault, FailCount= 5 2013-09-17T01:00:49.156Z,1379379649.156 [AHRS_sp3003D](ERROR): Hardware Fault 2013-09-17T01:00:49.255Z,1379379649.255 [CBIT](ERROR): Hardware Fault in component: AHRS_sp3003D 2013-09-17T01:00:49.255Z,1379379649.255 [CBIT](CRITICAL): Hardware Fault in component: AHRS_sp3003D 2013-09-17T01:00:49.293Z,1379379649.293 [AHRS_sp3003D](INFO): Powering down 2013-09-17T01:00:49.620Z,1379379649.620 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:00:49.622Z,1379379649.622 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:00:49.622Z,1379379649.622 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:00:50.906Z,1379379650.906 [NAL9602](INFO): NAL9602 initialized 2013-09-17T01:00:51.393Z,1379379651.393 [SBIT](IMPORTANT): Beginning Startup BIT 2013-09-17T01:00:51.395Z,1379379651.395 [CBIT](IMPORTANT): Beginning GF scan 2013-09-17T01:00:51.632Z,1379379651.632 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:00:51.632Z,1379379651.632 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:00:53.635Z,1379379653.635 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:00:53.635Z,1379379653.635 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:00:53.635Z,1379379653.635 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:00:55.637Z,1379379655.637 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:00:55.637Z,1379379655.637 [DVL_micro](INFO): Querying output modes 2013-09-17T01:00:55.638Z,1379379655.638 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:00:56.499Z,1379379656.499 [DAT](INFO): Powering down 2013-09-17T01:00:57.644Z,1379379657.644 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:00:57.645Z,1379379657.645 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:00:57.645Z,1379379657.645 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:00:59.652Z,1379379659.652 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:01:01.655Z,1379379661.655 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:01:01.655Z,1379379661.655 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:01:03.658Z,1379379663.658 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:01:03.659Z,1379379663.659 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:01:05.665Z,1379379665.665 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:01:05.665Z,1379379665.665 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:01:05.665Z,1379379665.665 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:01:07.676Z,1379379667.676 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:01:07.676Z,1379379667.676 [DVL_micro](INFO): Querying output modes 2013-09-17T01:01:07.676Z,1379379667.676 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:01:09.683Z,1379379669.683 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:01:09.683Z,1379379669.683 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:01:09.684Z,1379379669.684 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:01:11.694Z,1379379671.694 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:01:13.702Z,1379379673.702 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:01:13.702Z,1379379673.702 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:01:15.705Z,1379379675.705 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:01:15.705Z,1379379675.705 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:01:17.712Z,1379379677.712 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:01:17.712Z,1379379677.712 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:01:17.712Z,1379379677.712 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:01:18.214Z,1379379678.214 [CBIT](IMPORTANT): No ground fault detected 2013-09-17T01:01:19.715Z,1379379679.715 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:01:19.715Z,1379379679.715 [DVL_micro](INFO): Querying output modes 2013-09-17T01:01:19.715Z,1379379679.715 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:01:21.723Z,1379379681.723 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:01:21.723Z,1379379681.723 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:01:21.723Z,1379379681.723 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:01:23.729Z,1379379683.729 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:01:25.745Z,1379379685.745 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:01:25.745Z,1379379685.745 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:01:27.748Z,1379379687.748 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:01:27.748Z,1379379687.748 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:01:29.758Z,1379379689.758 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:01:29.758Z,1379379689.758 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:01:29.759Z,1379379689.759 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:01:31.761Z,1379379691.761 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:01:31.762Z,1379379691.762 [DVL_micro](INFO): Querying output modes 2013-09-17T01:01:31.762Z,1379379691.762 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:01:33.768Z,1379379693.768 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:01:33.769Z,1379379693.769 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:01:33.769Z,1379379693.769 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:01:35.780Z,1379379695.780 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:01:37.791Z,1379379697.791 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:01:37.791Z,1379379697.791 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:01:39.794Z,1379379699.794 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:01:39.795Z,1379379699.795 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:01:41.805Z,1379379701.805 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:01:41.805Z,1379379701.805 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:01:41.805Z,1379379701.805 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:01:43.814Z,1379379703.814 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:01:43.815Z,1379379703.815 [DVL_micro](INFO): Querying output modes 2013-09-17T01:01:43.815Z,1379379703.815 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:01:45.198Z,1379379705.198 [SBIT](IMPORTANT): SBIT PASSED 2013-09-17T01:01:45.591Z,1379379705.591 [MissionManager](IMPORTANT): Started mission Startup 2013-09-17T01:01:45.591Z,1379379705.591 [Startup] Running Loop=1 2013-09-17T01:01:45.592Z,1379379705.592 [Startup](INFO): Aggregate::initialize Startup 2013-09-17T01:01:45.592Z,1379379705.592 [Startup:A.GoToSurface] Running Loop=1 2013-09-17T01:01:45.592Z,1379379705.592 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2013-09-17T01:01:45.824Z,1379379705.824 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:01:45.824Z,1379379705.824 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:01:45.824Z,1379379705.824 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:01:47.834Z,1379379707.834 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:01:49.842Z,1379379709.842 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:01:49.842Z,1379379709.842 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:01:51.845Z,1379379711.845 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:01:51.845Z,1379379711.845 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:01:53.856Z,1379379713.856 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:01:53.856Z,1379379713.856 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:01:53.856Z,1379379713.856 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:01:55.867Z,1379379715.867 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:01:55.867Z,1379379715.867 [DVL_micro](INFO): Querying output modes 2013-09-17T01:01:55.867Z,1379379715.867 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:01:57.874Z,1379379717.874 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:01:57.874Z,1379379717.874 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:01:57.874Z,1379379717.874 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:01:59.885Z,1379379719.885 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:02:01.898Z,1379379721.898 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:02:01.898Z,1379379721.898 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:02:03.904Z,1379379723.904 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:02:03.904Z,1379379723.904 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:02:05.910Z,1379379725.910 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:02:05.910Z,1379379725.910 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:02:05.911Z,1379379725.911 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:02:07.921Z,1379379727.921 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:02:07.921Z,1379379727.921 [DVL_micro](INFO): Querying output modes 2013-09-17T01:02:07.922Z,1379379727.922 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:02:09.929Z,1379379729.929 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:02:09.930Z,1379379729.930 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:02:09.930Z,1379379729.930 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:02:11.932Z,1379379731.932 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:02:13.943Z,1379379733.943 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:02:13.943Z,1379379733.943 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:02:15.946Z,1379379735.946 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:02:15.947Z,1379379735.947 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:02:17.953Z,1379379737.953 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:02:17.953Z,1379379737.953 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:02:17.953Z,1379379737.953 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:02:19.960Z,1379379739.960 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:02:19.960Z,1379379739.960 [DVL_micro](INFO): Querying output modes 2013-09-17T01:02:19.960Z,1379379739.960 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:02:21.963Z,1379379741.963 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:02:21.963Z,1379379741.963 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:02:21.963Z,1379379741.963 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:02:23.966Z,1379379743.966 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:02:25.974Z,1379379745.974 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:02:25.974Z,1379379745.974 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:02:27.977Z,1379379747.977 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:02:27.977Z,1379379747.977 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:02:29.988Z,1379379749.988 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:02:29.988Z,1379379749.988 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:02:29.988Z,1379379749.988 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:02:31.999Z,1379379751.999 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:02:31.000Z,1379379752.000 [DVL_micro](INFO): Querying output modes 2013-09-17T01:02:31.000Z,1379379752.000 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:02:34.002Z,1379379754.002 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:02:34.002Z,1379379754.002 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:02:34.002Z,1379379754.002 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:02:36.013Z,1379379756.013 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:02:38.021Z,1379379758.021 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:02:38.021Z,1379379758.021 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:02:40.024Z,1379379760.024 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:02:40.024Z,1379379760.024 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:02:42.030Z,1379379762.030 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:02:42.030Z,1379379762.030 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:02:42.031Z,1379379762.031 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:02:44.041Z,1379379764.041 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:02:44.041Z,1379379764.041 [DVL_micro](INFO): Querying output modes 2013-09-17T01:02:44.042Z,1379379764.042 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:02:46.049Z,1379379766.049 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:02:46.049Z,1379379766.049 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:02:46.049Z,1379379766.049 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:02:48.052Z,1379379768.052 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:02:50.055Z,1379379770.055 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:02:50.056Z,1379379770.056 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:02:52.058Z,1379379772.058 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:02:52.059Z,1379379772.059 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:02:54.061Z,1379379774.061 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:02:54.061Z,1379379774.061 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:02:54.061Z,1379379774.061 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:02:56.068Z,1379379776.068 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:02:56.068Z,1379379776.068 [DVL_micro](INFO): Querying output modes 2013-09-17T01:02:56.068Z,1379379776.068 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:02:58.079Z,1379379778.079 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:02:58.079Z,1379379778.079 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:02:58.079Z,1379379778.079 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:03:00.087Z,1379379780.087 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:03:02.098Z,1379379782.098 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:03:02.098Z,1379379782.098 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:03:04.101Z,1379379784.101 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:03:04.101Z,1379379784.101 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:03:06.108Z,1379379786.108 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:03:06.108Z,1379379786.108 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:03:06.108Z,1379379786.108 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:03:08.119Z,1379379788.119 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:03:08.119Z,1379379788.119 [DVL_micro](INFO): Querying output modes 2013-09-17T01:03:08.119Z,1379379788.119 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:03:10.131Z,1379379790.131 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:03:10.131Z,1379379790.131 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:03:10.131Z,1379379790.131 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:03:12.141Z,1379379792.141 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:03:14.145Z,1379379794.145 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:03:14.145Z,1379379794.145 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:03:16.148Z,1379379796.148 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:03:16.148Z,1379379796.148 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:03:18.154Z,1379379798.154 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:03:18.154Z,1379379798.154 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:03:18.155Z,1379379798.155 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:03:20.166Z,1379379800.166 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:03:20.166Z,1379379800.166 [DVL_micro](INFO): Querying output modes 2013-09-17T01:03:20.166Z,1379379800.166 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:03:22.169Z,1379379802.169 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:03:22.169Z,1379379802.169 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:03:22.169Z,1379379802.169 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:03:24.172Z,1379379804.172 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:03:26.175Z,1379379806.175 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:03:26.176Z,1379379806.176 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:03:28.178Z,1379379808.178 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:03:28.179Z,1379379808.179 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:03:30.189Z,1379379810.189 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:03:30.189Z,1379379810.189 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:03:30.189Z,1379379810.189 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:03:32.200Z,1379379812.200 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:03:32.200Z,1379379812.200 [DVL_micro](INFO): Querying output modes 2013-09-17T01:03:32.201Z,1379379812.201 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:03:34.207Z,1379379814.207 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:03:34.207Z,1379379814.207 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:03:34.208Z,1379379814.208 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:03:36.214Z,1379379816.214 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:03:38.227Z,1379379818.227 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:03:38.227Z,1379379818.227 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:03:40.233Z,1379379820.233 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:03:40.233Z,1379379820.233 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:03:42.236Z,1379379822.236 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:03:42.236Z,1379379822.236 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:03:42.236Z,1379379822.236 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:03:44.247Z,1379379824.247 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:03:44.247Z,1379379824.247 [DVL_micro](INFO): Querying output modes 2013-09-17T01:03:44.247Z,1379379824.247 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:03:46.250Z,1379379826.250 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:03:46.250Z,1379379826.250 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:03:46.250Z,1379379826.250 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:03:48.257Z,1379379828.257 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:03:50.269Z,1379379830.269 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:03:50.269Z,1379379830.269 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:03:52.272Z,1379379832.272 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:03:52.272Z,1379379832.272 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:03:54.278Z,1379379834.278 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:03:54.278Z,1379379834.278 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:03:54.279Z,1379379834.279 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:03:56.281Z,1379379836.281 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:03:56.281Z,1379379836.281 [DVL_micro](INFO): Querying output modes 2013-09-17T01:03:56.282Z,1379379836.282 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:03:58.289Z,1379379838.289 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:03:58.289Z,1379379838.289 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:03:58.289Z,1379379838.289 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:04:00.296Z,1379379840.296 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:04:02.299Z,1379379842.299 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:04:02.300Z,1379379842.300 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:04:04.302Z,1379379844.302 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:04:04.303Z,1379379844.303 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:04:06.313Z,1379379846.313 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:04:06.313Z,1379379846.313 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:04:06.313Z,1379379846.313 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:04:08.320Z,1379379848.320 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:04:08.321Z,1379379848.321 [DVL_micro](INFO): Querying output modes 2013-09-17T01:04:08.321Z,1379379848.321 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:04:10.331Z,1379379850.331 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:04:10.331Z,1379379850.331 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:04:10.332Z,1379379850.332 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:04:12.342Z,1379379852.342 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:04:14.354Z,1379379854.354 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:04:14.354Z,1379379854.354 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:04:16.357Z,1379379856.357 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:04:16.357Z,1379379856.357 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:04:18.360Z,1379379858.360 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:04:18.360Z,1379379858.360 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:04:18.360Z,1379379858.360 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:04:20.371Z,1379379860.371 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:04:20.371Z,1379379860.371 [DVL_micro](INFO): Querying output modes 2013-09-17T01:04:20.371Z,1379379860.371 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:04:20.499Z,1379379860.499 [MassServo](FAULT): Overload Error 2013-09-17T01:04:20.499Z,1379379860.499 [MassServo] Hardware Fault, FailCount= 1 2013-09-17T01:04:20.499Z,1379379860.499 [MassServo](ERROR): Hardware Fault 2013-09-17T01:04:20.534Z,1379379860.534 [CBIT](ERROR): Hardware Fault in component: MassServo 2013-09-17T01:04:20.846Z,1379379860.846 [MassServo](DEBUG): Uninitialize Mass Servo. 2013-09-17T01:04:20.846Z,1379379860.846 [MassServo](INFO): Powering down 2013-09-17T01:04:21.657Z,1379379861.657 [MassServo](DEBUG): Initializing EZServoServo. 2013-09-17T01:04:21.786Z,1379379861.786 [MassServo](DEBUG): Initializing MassServo. 2013-09-17T01:04:21.818Z,1379379861.818 [CBIT](INFO): Clearing failed state for component MassServo 2013-09-17T01:04:21.818Z,1379379861.818 [MassServo] No Fault, FailCount= 1 2013-09-17T01:04:22.378Z,1379379862.378 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:04:22.378Z,1379379862.378 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:04:22.378Z,1379379862.378 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:04:24.389Z,1379379864.389 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:04:26.397Z,1379379866.397 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:04:26.397Z,1379379866.397 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:04:28.400Z,1379379868.400 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:04:28.400Z,1379379868.400 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:04:30.410Z,1379379870.410 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:04:30.411Z,1379379870.411 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:04:30.411Z,1379379870.411 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:04:32.414Z,1379379872.414 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:04:32.414Z,1379379872.414 [DVL_micro](INFO): Querying output modes 2013-09-17T01:04:32.414Z,1379379872.414 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:04:34.425Z,1379379874.425 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:04:34.425Z,1379379874.425 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:04:34.425Z,1379379874.425 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:04:36.436Z,1379379876.436 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:04:38.448Z,1379379878.448 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:04:38.448Z,1379379878.448 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:04:40.454Z,1379379880.454 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:04:40.455Z,1379379880.455 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:04:42.462Z,1379379882.462 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:04:42.462Z,1379379882.462 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:04:42.462Z,1379379882.462 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:04:44.472Z,1379379884.472 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:04:44.473Z,1379379884.473 [DVL_micro](INFO): Querying output modes 2013-09-17T01:04:44.473Z,1379379884.473 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:04:46.484Z,1379379886.484 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:04:46.484Z,1379379886.484 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:04:46.484Z,1379379886.484 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:04:48.486Z,1379379888.486 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:04:50.498Z,1379379890.498 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:04:50.498Z,1379379890.498 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:04:52.501Z,1379379892.501 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:04:52.501Z,1379379892.501 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:04:54.508Z,1379379894.508 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:04:54.508Z,1379379894.508 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:04:54.508Z,1379379894.508 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:04:56.519Z,1379379896.519 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:04:56.519Z,1379379896.519 [DVL_micro](INFO): Querying output modes 2013-09-17T01:04:56.519Z,1379379896.519 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:04:58.526Z,1379379898.526 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:04:58.526Z,1379379898.526 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:04:58.526Z,1379379898.526 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:05:00.537Z,1379379900.537 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:05:02.549Z,1379379902.549 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:05:02.549Z,1379379902.549 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:05:04.552Z,1379379904.552 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:05:04.552Z,1379379904.552 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:05:06.558Z,1379379906.558 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:05:06.558Z,1379379906.558 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:05:06.559Z,1379379906.559 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:05:08.561Z,1379379908.561 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:05:08.562Z,1379379908.562 [DVL_micro](INFO): Querying output modes 2013-09-17T01:05:08.562Z,1379379908.562 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:05:10.573Z,1379379910.573 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:05:10.573Z,1379379910.573 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:05:10.573Z,1379379910.573 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:05:12.584Z,1379379912.584 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:05:14.596Z,1379379914.596 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:05:14.596Z,1379379914.596 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:05:16.598Z,1379379916.598 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:05:16.599Z,1379379916.599 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:05:18.609Z,1379379918.609 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:05:18.609Z,1379379918.609 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:05:18.609Z,1379379918.609 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:05:20.621Z,1379379920.621 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:05:20.621Z,1379379920.621 [DVL_micro](INFO): Querying output modes 2013-09-17T01:05:20.621Z,1379379920.621 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:05:22.631Z,1379379922.631 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:05:22.631Z,1379379922.631 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:05:22.632Z,1379379922.632 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:05:24.634Z,1379379924.634 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:05:26.646Z,1379379926.646 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:05:26.646Z,1379379926.646 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:05:27.691Z,1379379927.691 [MassServo](FAULT): Overload Error 2013-09-17T01:05:27.691Z,1379379927.691 [MassServo] Hardware Fault, FailCount= 2 2013-09-17T01:05:27.692Z,1379379927.692 [MassServo](ERROR): Hardware Fault 2013-09-17T01:05:27.778Z,1379379927.778 [CBIT](ERROR): Hardware Fault in component: MassServo 2013-09-17T01:05:28.055Z,1379379928.055 [MassServo](DEBUG): Uninitialize Mass Servo. 2013-09-17T01:05:28.055Z,1379379928.055 [MassServo](INFO): Powering down 2013-09-17T01:05:28.649Z,1379379928.649 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:05:28.649Z,1379379928.649 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:05:28.824Z,1379379928.824 [MassServo](DEBUG): Initializing EZServoServo. 2013-09-17T01:05:28.942Z,1379379928.942 [MassServo](DEBUG): Initializing MassServo. 2013-09-17T01:05:28.972Z,1379379928.972 [CBIT](INFO): Clearing failed state for component MassServo 2013-09-17T01:05:28.972Z,1379379928.972 [MassServo] No Fault, FailCount= 2 2013-09-17T01:05:29.879Z,1379379929.879 [CommandLine](IMPORTANT): got command failComponent 2013-09-17T01:05:29.879Z,1379379929.879 [CommandLine](IMPORTANT): Failed components: 2013-09-17T01:05:29.879Z,1379379929.879 [CommandLine](IMPORTANT): AHRS_sp3003D: Hardware Fault 2013-09-17T01:05:29.880Z,1379379929.880 [CommandLine](IMPORTANT): DropWeight: Hardware Fault 2013-09-17T01:05:30.656Z,1379379930.656 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:05:30.656Z,1379379930.656 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:05:30.656Z,1379379930.656 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:05:32.667Z,1379379932.667 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:05:32.667Z,1379379932.667 [DVL_micro](INFO): Querying output modes 2013-09-17T01:05:32.667Z,1379379932.667 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:05:34.670Z,1379379934.670 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:05:34.670Z,1379379934.670 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:05:34.670Z,1379379934.670 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:05:36.079Z,1379379936.079 [CBIT](INFO): Clearing failed count for component DropWeight 2013-09-17T01:05:36.079Z,1379379936.079 [DropWeight] No Fault, FailCount= 1 2013-09-17T01:05:36.402Z,1379379936.402 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2013-09-17T01:05:36.402Z,1379379936.402 [DropWeight] Hardware Fault, FailCount= 1 2013-09-17T01:05:36.402Z,1379379936.402 [DropWeight](ERROR): Hardware Fault 2013-09-17T01:05:36.528Z,1379379936.528 [CBIT](ERROR): Hardware Fault in component: DropWeight 2013-09-17T01:05:36.528Z,1379379936.528 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2013-09-17T01:05:36.681Z,1379379936.681 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:05:38.689Z,1379379938.689 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:05:38.689Z,1379379938.689 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:05:40.692Z,1379379940.692 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:05:40.692Z,1379379940.692 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:05:42.702Z,1379379942.702 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:05:42.702Z,1379379942.702 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:05:42.703Z,1379379942.703 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:05:44.714Z,1379379944.714 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:05:44.714Z,1379379944.714 [DVL_micro](INFO): Querying output modes 2013-09-17T01:05:44.714Z,1379379944.714 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:05:46.725Z,1379379946.725 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:05:46.725Z,1379379946.725 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:05:46.726Z,1379379946.726 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:05:48.736Z,1379379948.736 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:05:49.315Z,1379379949.315 [CBIT](INFO): Clearing failed count for component AHRS_sp3003D 2013-09-17T01:05:49.315Z,1379379949.315 [AHRS_sp3003D] No Fault, FailCount= 5 2013-09-17T01:05:49.597Z,1379379949.597 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D. 2013-09-17T01:05:50.735Z,1379379950.735 [AHRS_sp3003D](ERROR): readHeadingMagBin UART error: serial timeout 2013-09-17T01:05:50.735Z,1379379950.735 [AHRS_sp3003D](ERROR): SP3003D failed to initialize 2013-09-17T01:05:50.735Z,1379379950.735 [AHRS_sp3003D] Hardware Fault, FailCount= 1 2013-09-17T01:05:50.735Z,1379379950.735 [AHRS_sp3003D](ERROR): Hardware Fault 2013-09-17T01:05:50.747Z,1379379950.747 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:05:50.748Z,1379379950.748 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:05:50.826Z,1379379950.826 [CBIT](ERROR): Hardware Fault in component: AHRS_sp3003D 2013-09-17T01:05:50.867Z,1379379950.867 [AHRS_sp3003D](INFO): Powering down 2013-09-17T01:05:52.156Z,1379379952.156 [CBIT](INFO): Clearing failed state for component AHRS_sp3003D 2013-09-17T01:05:52.156Z,1379379952.156 [AHRS_sp3003D] No Fault, FailCount= 1 2013-09-17T01:05:52.453Z,1379379952.453 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D. 2013-09-17T01:05:52.750Z,1379379952.750 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:05:52.751Z,1379379952.751 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:05:53.591Z,1379379953.591 [AHRS_sp3003D](ERROR): readHeadingMagBin UART error: serial timeout 2013-09-17T01:05:53.591Z,1379379953.591 [AHRS_sp3003D](ERROR): SP3003D failed to initialize 2013-09-17T01:05:53.591Z,1379379953.591 [AHRS_sp3003D] Hardware Fault, FailCount= 2 2013-09-17T01:05:53.592Z,1379379953.592 [AHRS_sp3003D](ERROR): Hardware Fault 2013-09-17T01:05:53.686Z,1379379953.686 [CBIT](ERROR): Hardware Fault in component: AHRS_sp3003D 2013-09-17T01:05:53.700Z,1379379953.700 [AHRS_sp3003D](INFO): Powering down 2013-09-17T01:05:54.665Z,1379379954.665 [CommandLine](IMPORTANT): got command run ./Missions/Insert/Science.xml 2013-09-17T01:05:54.666Z,1379379954.666 [MissionManager](INFO): Loading Mission: ./Missions/Insert/Science.xml 2013-09-17T01:05:54.753Z,1379379954.753 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:05:54.753Z,1379379954.753 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:05:54.753Z,1379379954.753 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:05:54.765Z,1379379954.765 [MissionManager](INFO): DefineArg Science.SampleISUS = 0 bool 2013-09-17T01:05:54.769Z,1379379954.769 [MissionManager](INFO): DefineArg Science.SampleISUSmaxPitch = 60.000000 arcdeg 2013-09-17T01:05:54.772Z,1379379954.772 [MissionManager](INFO): DefineArg Science.SampleISUSminPitch = -60.000000 arcdeg 2013-09-17T01:05:54.775Z,1379379954.775 [MissionManager](INFO): DefineArg Science.SampleRSSI = 1 bool 2013-09-17T01:05:54.778Z,1379379954.778 [MissionManager](INFO): DefineArg Science.SampleADCP = 0 bool 2013-09-17T01:05:54.781Z,1379379954.781 [MissionManager](INFO): DefineArg Science.PeakDetectChlActive = 0 bool 2013-09-17T01:05:54.784Z,1379379954.784 [MissionManager](INFO): DefineArg Science.PeakDetectNO3Active = 0 bool 2013-09-17T01:05:54.786Z,1379379954.786 [MissionManager](INFO): DefineArg Science.PeakDetectRSSIActive = 0 bool 2013-09-17T01:05:54.790Z,1379379954.790 [MissionManager](INFO): DefineArg Science.UpwardDerivativeOfTemperatureActive = 0 bool 2013-09-17T01:05:54.793Z,1379379954.793 [MissionManager](INFO): DefineArg Science.ComputeWaterCurrent = 0 bool 2013-09-17T01:05:54.796Z,1379379954.796 [MissionManager](INFO): DefineArg Science.ComputeWaterCurrentMinDepth = 2.000000 m 2013-09-17T01:05:54.799Z,1379379954.799 [MissionManager](INFO): DefineArg Science.ComputeWaterCurrentMaxDepth = 5.000000 m 2013-09-17T01:05:54.803Z,1379379954.803 [MissionManager](INFO): DefineArg Science.EnabledAanderaaO2 = 0.000000 n/a 2013-09-17T01:05:54.807Z,1379379954.807 [MissionManager](INFO): DefineArg Science.EnabledNeilBrown = 1.000000 n/a 2013-09-17T01:05:54.811Z,1379379954.811 [MissionManager](INFO): DefineArg Science.EnabledTurbulence_NPS = 0.000000 n/a 2013-09-17T01:05:54.817Z,1379379954.817 [MissionManager](INFO): DefineArg Science.EnabledWetLabsBB2FL = 1.000000 n/a 2013-09-17T01:05:54.820Z,1379379954.820 [MissionManager](INFO): DefineArg Science.EnabledDVL = 1.000000 n/a 2013-09-17T01:05:54.824Z,1379379954.824 [MissionManager](INFO): DefineArg Science.EnabledISUS = 0.000000 n/a 2013-09-17T01:05:54.828Z,1379379954.828 [MissionManager](INFO): DefineOutput Science.PeakChl = 0.000000 ug/l 2013-09-17T01:05:54.855Z,1379379954.855 [MissionManager](INFO): DefineOutput Science.PeakChlDepth = 0.000000 m 2013-09-17T01:05:54.859Z,1379379954.859 [MissionManager](INFO): DefineOutput Science.PeakChlLatitude = nan arcdeg 2013-09-17T01:05:54.862Z,1379379954.862 [MissionManager](INFO): DefineOutput Science.PeakChlLongitude = nan arcdeg 2013-09-17T01:05:54.874Z,1379379954.874 [MissionManager](INFO): DefineOutput Science.PeakNO3 = 0.000000 umol/l 2013-09-17T01:05:54.881Z,1379379954.881 [MissionManager](INFO): DefineOutput Science.PeakNO3Depth = 0.000000 m 2013-09-17T01:05:54.885Z,1379379954.885 [MissionManager](INFO): DefineOutput Science.PeakNO3Latitude = nan arcdeg 2013-09-17T01:05:54.888Z,1379379954.888 [MissionManager](INFO): DefineOutput Science.PeakNO3Longitude = nan arcdeg 2013-09-17T01:05:54.910Z,1379379954.910 [MissionManager](INFO): DefineOutput Science.PeakRSSI = 0.000000 dB 2013-09-17T01:05:54.913Z,1379379954.913 [MissionManager](INFO): DefineOutput Science.PeakRSSIDepth = 0.000000 m 2013-09-17T01:05:54.916Z,1379379954.916 [MissionManager](INFO): DefineOutput Science.PeakRSSILatitude = nan arcdeg 2013-09-17T01:05:54.928Z,1379379954.928 [MissionManager](INFO): DefineOutput Science.PeakRSSILongitude = nan arcdeg 2013-09-17T01:05:55.001Z,1379379955.001 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2013-09-17T01:05:55.011Z,1379379955.011 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2013-09-17T01:05:55.028Z,1379379955.028 [Science:PeakDetectRSSI:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2013-09-17T01:05:55.044Z,1379379955.044 [CBIT](INFO): Clearing failed state for component AHRS_sp3003D 2013-09-17T01:05:55.044Z,1379379955.044 [AHRS_sp3003D] No Fault, FailCount= 2 2013-09-17T01:05:55.082Z,1379379955.082 [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-17T01:05:55.085Z,1379379955.085 [CommandLine](IMPORTANT): Running ./Missions/Insert/Science.xml 2013-09-17T01:05:55.302Z,1379379955.302 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D. 2013-09-17T01:05:56.231Z,1379379956.231 [AHRS_sp3003D](ERROR): readHeadingMagBin UART error: serial timeout 2013-09-17T01:05:56.232Z,1379379956.232 [AHRS_sp3003D](ERROR): readHeadingMagBin got 0xA409A0 2013-09-17T01:05:56.232Z,1379379956.232 [AHRS_sp3003D](ERROR): SP3003D failed to initialize 2013-09-17T01:05:56.232Z,1379379956.232 [AHRS_sp3003D] Hardware Fault, FailCount= 3 2013-09-17T01:05:56.232Z,1379379956.232 [AHRS_sp3003D](ERROR): Hardware Fault 2013-09-17T01:05:56.295Z,1379379956.295 [CBIT](ERROR): Hardware Fault in component: AHRS_sp3003D 2013-09-17T01:05:56.500Z,1379379956.500 [AHRS_sp3003D](INFO): Powering down 2013-09-17T01:05:56.756Z,1379379956.756 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:05:56.756Z,1379379956.756 [DVL_micro](INFO): Querying output modes 2013-09-17T01:05:56.756Z,1379379956.756 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:05:57.845Z,1379379957.845 [CBIT](INFO): Clearing failed state for component AHRS_sp3003D 2013-09-17T01:05:57.845Z,1379379957.845 [AHRS_sp3003D] No Fault, FailCount= 3 2013-09-17T01:05:58.102Z,1379379958.102 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D. 2013-09-17T01:05:58.767Z,1379379958.767 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:05:58.767Z,1379379958.767 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:05:58.768Z,1379379958.768 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:05:59.020Z,1379379959.020 [AHRS_sp3003D](ERROR): readHeadingMagBin UART error: serial timeout 2013-09-17T01:05:59.020Z,1379379959.020 [AHRS_sp3003D](ERROR): readHeadingMagBin got 0x0000 2013-09-17T01:05:59.020Z,1379379959.020 [AHRS_sp3003D](ERROR): SP3003D failed to initialize 2013-09-17T01:05:59.020Z,1379379959.020 [AHRS_sp3003D] Hardware Fault, FailCount= 4 2013-09-17T01:05:59.020Z,1379379959.020 [AHRS_sp3003D](ERROR): Hardware Fault 2013-09-17T01:05:59.167Z,1379379959.167 [CBIT](ERROR): Hardware Fault in component: AHRS_sp3003D 2013-09-17T01:05:59.300Z,1379379959.300 [AHRS_sp3003D](INFO): Powering down 2013-09-17T01:06:00.732Z,1379379960.732 [CBIT](INFO): Clearing failed state for component AHRS_sp3003D 2013-09-17T01:06:00.732Z,1379379960.732 [AHRS_sp3003D] No Fault, FailCount= 4 2013-09-17T01:06:00.778Z,1379379960.778 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:06:00.903Z,1379379960.903 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D. 2013-09-17T01:06:02.044Z,1379379962.044 [AHRS_sp3003D](ERROR): readHeadingMagBin UART error: serial timeout 2013-09-17T01:06:02.045Z,1379379962.045 [AHRS_sp3003D](ERROR): SP3003D failed to initialize 2013-09-17T01:06:02.045Z,1379379962.045 [AHRS_sp3003D] Hardware Fault, FailCount= 5 2013-09-17T01:06:02.045Z,1379379962.045 [AHRS_sp3003D](ERROR): Hardware Fault 2013-09-17T01:06:02.139Z,1379379962.139 [CBIT](ERROR): Hardware Fault in component: AHRS_sp3003D 2013-09-17T01:06:02.140Z,1379379962.140 [CBIT](CRITICAL): Hardware Fault in component: AHRS_sp3003D 2013-09-17T01:06:02.166Z,1379379962.166 [AHRS_sp3003D](INFO): Powering down 2013-09-17T01:06:02.786Z,1379379962.786 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:06:02.786Z,1379379962.786 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:06:04.789Z,1379379964.789 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:06:04.789Z,1379379964.789 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:06:05.887Z,1379379965.887 [CommandLine](IMPORTANT): got command show variable pressure 2013-09-17T01:06:05.891Z,1379379965.891 [CommandLine](INFO): platform_pressure (unknown) 2013-09-17T01:06:05.893Z,1379379965.893 [CommandLine](INFO): sea_water_pressure (decibar) 2013-09-17T01:06:05.897Z,1379379965.897 [CommandLine](INFO): OnboardPressure.ad (none) 2013-09-17T01:06:05.898Z,1379379965.898 [CommandLine](INFO): OnboardPressure.adVref (volt) 2013-09-17T01:06:05.898Z,1379379965.898 [CommandLine](INFO): OnboardPressure.adRes (bit) 2013-09-17T01:06:05.901Z,1379379965.901 [CommandLine](INFO): OnboardPressure.slope (pound_per_square_inch_per_volt) 2013-09-17T01:06:05.901Z,1379379965.901 [CommandLine](INFO): OnboardPressure.intercept (pound_per_square_inch) 2013-09-17T01:06:05.905Z,1379379965.905 [CommandLine](INFO): CBIT.pressureThreshold (pound_per_square_inch) 2013-09-17T01:06:05.923Z,1379379965.923 [CommandLine](INFO): Onboard.Pressure (pound_per_square_inch) 2013-09-17T01:06:05.945Z,1379379965.945 [CommandLine](INFO): Depth_Keller.sea_water_pressure (decibar) 2013-09-17T01:06:05.956Z,1379379965.956 [CommandLine](INFO): CTD_NeilBrown.sea_water_pressure (decibar) 2013-09-17T01:06:06.800Z,1379379966.800 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:06:06.800Z,1379379966.800 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:06:06.800Z,1379379966.800 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:06:08.807Z,1379379968.807 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:06:08.807Z,1379379968.807 [DVL_micro](INFO): Querying output modes 2013-09-17T01:06:08.807Z,1379379968.807 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:06:10.818Z,1379379970.818 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:06:10.818Z,1379379970.818 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:06:10.818Z,1379379970.818 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:06:12.832Z,1379379972.832 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:06:14.845Z,1379379974.845 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:06:14.845Z,1379379974.845 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:06:16.848Z,1379379976.848 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:06:16.848Z,1379379976.848 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:06:18.859Z,1379379978.859 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:06:18.859Z,1379379978.859 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:06:18.859Z,1379379978.859 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:06:20.862Z,1379379980.862 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:06:20.862Z,1379379980.862 [DVL_micro](INFO): Querying output modes 2013-09-17T01:06:20.862Z,1379379980.862 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:06:22.869Z,1379379982.869 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:06:22.869Z,1379379982.869 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:06:22.869Z,1379379982.869 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:06:24.876Z,1379379984.876 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:06:26.883Z,1379379986.883 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:06:26.884Z,1379379986.884 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:06:28.886Z,1379379988.886 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:06:28.887Z,1379379988.887 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:06:30.897Z,1379379990.897 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:06:30.897Z,1379379990.897 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:06:30.897Z,1379379990.897 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:06:32.904Z,1379379992.904 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:06:32.904Z,1379379992.904 [DVL_micro](INFO): Querying output modes 2013-09-17T01:06:32.905Z,1379379992.905 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:06:34.915Z,1379379994.915 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:06:34.915Z,1379379994.915 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:06:34.916Z,1379379994.916 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:06:36.926Z,1379379996.926 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:06:38.939Z,1379379998.939 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:06:38.939Z,1379379998.939 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:06:40.945Z,1379380000.945 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:06:40.946Z,1379380000.946 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:06:42.948Z,1379380002.948 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:06:42.948Z,1379380002.948 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:06:42.948Z,1379380002.948 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:06:44.951Z,1379380004.951 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:06:44.951Z,1379380004.951 [DVL_micro](INFO): Querying output modes 2013-09-17T01:06:44.952Z,1379380004.952 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:06:46.958Z,1379380006.958 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:06:46.958Z,1379380006.958 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:06:46.958Z,1379380006.958 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:06:48.969Z,1379380008.969 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:06:49.046Z,1379380009.046 [CommandLine](IMPORTANT): got command report periodic 1.000000 CTD_NeilBrown.sea_water_pressure 2013-09-17T01:06:49.250Z,1379380009.250 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:06:50.339Z,1379380010.339 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:06:50.973Z,1379380010.973 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:06:50.973Z,1379380010.973 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:06:51.525Z,1379380011.525 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:06:52.821Z,1379380012.821 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:06:52.976Z,1379380012.976 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:06:52.976Z,1379380012.976 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:06:53.928Z,1379380013.928 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:06:54.978Z,1379380014.978 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:06:54.979Z,1379380014.979 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:06:54.979Z,1379380014.979 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:06:54.994Z,1379380014.994 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:06:56.196Z,1379380016.196 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:06:56.986Z,1379380016.986 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:06:56.986Z,1379380016.986 [DVL_micro](INFO): Querying output modes 2013-09-17T01:06:56.986Z,1379380016.986 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:06:57.350Z,1379380017.350 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:06:58.551Z,1379380018.551 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:06:58.989Z,1379380018.989 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:06:58.989Z,1379380018.989 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:06:58.989Z,1379380018.989 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:06:59.917Z,1379380019.917 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:00.996Z,1379380020.996 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:07:01.244Z,1379380021.244 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:02.398Z,1379380022.398 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:03.007Z,1379380023.007 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:07:03.008Z,1379380023.008 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:07:03.595Z,1379380023.595 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:04.809Z,1379380024.809 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:05.010Z,1379380025.010 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:07:05.011Z,1379380025.011 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:07:06.175Z,1379380026.175 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:07.013Z,1379380027.013 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:07:07.013Z,1379380027.013 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:07:07.014Z,1379380027.014 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:07:07.501Z,1379380027.501 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:08.739Z,1379380028.739 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:09.020Z,1379380029.020 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:07:09.020Z,1379380029.020 [DVL_micro](INFO): Querying output modes 2013-09-17T01:07:09.021Z,1379380029.021 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:07:09.921Z,1379380029.921 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:11.039Z,1379380031.039 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:07:11.040Z,1379380031.040 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:07:11.040Z,1379380031.040 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:07:11.135Z,1379380031.135 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:12.285Z,1379380032.285 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:13.042Z,1379380033.042 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:07:13.067Z,1379380033.067 [MassServo](FAULT): Overload Error 2013-09-17T01:07:13.067Z,1379380033.067 [MassServo] Hardware Fault, FailCount= 1 2013-09-17T01:07:13.067Z,1379380033.067 [MassServo](ERROR): Hardware Fault 2013-09-17T01:07:13.137Z,1379380033.137 [CBIT](ERROR): Hardware Fault in component: MassServo 2013-09-17T01:07:13.425Z,1379380033.425 [MassServo](DEBUG): Uninitialize Mass Servo. 2013-09-17T01:07:13.425Z,1379380033.425 [MassServo](INFO): Powering down 2013-09-17T01:07:13.455Z,1379380033.455 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:14.228Z,1379380034.228 [MassServo](DEBUG): Initializing EZServoServo. 2013-09-17T01:07:14.341Z,1379380034.341 [MassServo](DEBUG): Initializing MassServo. 2013-09-17T01:07:14.371Z,1379380034.371 [CBIT](INFO): Clearing failed state for component MassServo 2013-09-17T01:07:14.371Z,1379380034.371 [MassServo] No Fault, FailCount= 1 2013-09-17T01:07:14.645Z,1379380034.645 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:15.055Z,1379380035.055 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:07:15.056Z,1379380035.056 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:07:15.850Z,1379380035.850 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:17.052Z,1379380037.052 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:17.061Z,1379380037.061 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:07:17.062Z,1379380037.062 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:07:18.274Z,1379380038.274 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:19.068Z,1379380039.068 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:07:19.068Z,1379380039.068 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:07:19.068Z,1379380039.068 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:07:19.480Z,1379380039.480 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:20.682Z,1379380040.682 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:21.075Z,1379380041.075 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:07:21.075Z,1379380041.075 [DVL_micro](INFO): Querying output modes 2013-09-17T01:07:21.075Z,1379380041.075 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:07:21.884Z,1379380041.884 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:23.081Z,1379380043.081 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:23.083Z,1379380043.083 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:07:23.083Z,1379380043.083 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:07:23.083Z,1379380043.083 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:07:24.279Z,1379380044.279 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:25.085Z,1379380045.085 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:07:25.517Z,1379380045.517 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:26.675Z,1379380046.675 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:27.097Z,1379380047.097 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:07:27.097Z,1379380047.097 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:07:27.877Z,1379380047.877 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:29.079Z,1379380049.079 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:29.100Z,1379380049.100 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:07:29.100Z,1379380049.100 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:07:30.273Z,1379380050.273 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:31.107Z,1379380051.107 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:07:31.107Z,1379380051.107 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:07:31.107Z,1379380051.107 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:07:31.514Z,1379380051.514 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:32.680Z,1379380052.680 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:33.114Z,1379380053.114 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:07:33.114Z,1379380053.114 [DVL_micro](INFO): Querying output modes 2013-09-17T01:07:33.114Z,1379380053.114 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:07:33.878Z,1379380053.878 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:35.116Z,1379380055.116 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:35.117Z,1379380055.117 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:07:35.117Z,1379380055.117 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:07:35.117Z,1379380055.117 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:07:36.274Z,1379380056.274 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:37.120Z,1379380057.120 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:07:37.484Z,1379380057.484 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:38.678Z,1379380058.678 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:39.132Z,1379380059.132 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:07:39.132Z,1379380059.132 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:07:39.876Z,1379380059.876 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:41.081Z,1379380061.081 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:41.134Z,1379380061.134 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:07:41.135Z,1379380061.135 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:07:42.275Z,1379380062.275 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:43.147Z,1379380063.147 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:07:43.148Z,1379380063.148 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:07:43.148Z,1379380063.148 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:07:43.481Z,1379380063.481 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:44.675Z,1379380064.675 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:45.156Z,1379380065.156 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:07:45.156Z,1379380065.156 [DVL_micro](INFO): Querying output modes 2013-09-17T01:07:45.157Z,1379380065.157 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:07:45.877Z,1379380065.877 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:47.079Z,1379380067.079 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:47.167Z,1379380067.167 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:07:47.168Z,1379380067.168 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:07:47.168Z,1379380067.168 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:07:48.353Z,1379380068.353 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:49.174Z,1379380069.174 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:07:49.498Z,1379380069.498 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:50.684Z,1379380070.684 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:51.186Z,1379380071.186 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:07:51.186Z,1379380071.186 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:07:51.890Z,1379380071.890 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:53.100Z,1379380073.100 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:53.189Z,1379380073.189 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:07:53.189Z,1379380073.189 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:07:54.290Z,1379380074.290 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:55.192Z,1379380075.192 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:07:55.192Z,1379380075.192 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:07:55.192Z,1379380075.192 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:07:55.500Z,1379380075.500 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:56.702Z,1379380076.702 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:57.195Z,1379380077.195 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:07:57.195Z,1379380077.195 [DVL_micro](INFO): Querying output modes 2013-09-17T01:07:57.195Z,1379380077.195 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:07:57.891Z,1379380077.891 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:59.125Z,1379380079.125 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:07:59.198Z,1379380079.198 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:07:59.198Z,1379380079.198 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:07:59.199Z,1379380079.199 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:08:00.291Z,1379380080.291 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:01.209Z,1379380081.209 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:08:01.497Z,1379380081.497 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:02.699Z,1379380082.699 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:03.217Z,1379380083.217 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:08:03.217Z,1379380083.217 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:08:03.893Z,1379380083.893 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:05.127Z,1379380085.127 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:05.220Z,1379380085.220 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:08:05.220Z,1379380085.220 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:08:06.284Z,1379380086.284 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:07.222Z,1379380087.222 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:08:07.223Z,1379380087.223 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:08:07.223Z,1379380087.223 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:08:07.498Z,1379380087.498 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:08.684Z,1379380088.684 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:09.234Z,1379380089.234 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:08:09.234Z,1379380089.234 [DVL_micro](INFO): Querying output modes 2013-09-17T01:08:09.234Z,1379380089.234 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:08:09.890Z,1379380089.890 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:11.100Z,1379380091.100 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:11.241Z,1379380091.241 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:08:11.241Z,1379380091.241 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:08:11.241Z,1379380091.241 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:08:12.290Z,1379380092.290 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:13.244Z,1379380093.244 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:08:13.500Z,1379380093.500 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:14.682Z,1379380094.682 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:15.251Z,1379380095.251 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:08:15.252Z,1379380095.252 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:08:15.891Z,1379380095.891 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:17.105Z,1379380097.105 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:17.254Z,1379380097.254 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:08:17.255Z,1379380097.255 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:08:18.291Z,1379380098.291 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:19.257Z,1379380099.257 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:08:19.257Z,1379380099.257 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:08:19.257Z,1379380099.257 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:08:19.497Z,1379380099.497 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:20.299Z,1379380100.299 [MassServo](FAULT): Overload Error 2013-09-17T01:08:20.299Z,1379380100.299 [MassServo] Hardware Fault, FailCount= 2 2013-09-17T01:08:20.299Z,1379380100.299 [MassServo](ERROR): Hardware Fault 2013-09-17T01:08:20.365Z,1379380100.365 [CBIT](ERROR): Hardware Fault in component: MassServo 2013-09-17T01:08:20.615Z,1379380100.615 [MassServo](DEBUG): Uninitialize Mass Servo. 2013-09-17T01:08:20.615Z,1379380100.615 [MassServo](INFO): Powering down 2013-09-17T01:08:20.643Z,1379380100.643 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:21.264Z,1379380101.264 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:08:21.264Z,1379380101.264 [DVL_micro](INFO): Querying output modes 2013-09-17T01:08:21.265Z,1379380101.265 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:08:21.416Z,1379380101.416 [MassServo](DEBUG): Initializing EZServoServo. 2013-09-17T01:08:21.532Z,1379380101.532 [MassServo](DEBUG): Initializing MassServo. 2013-09-17T01:08:21.564Z,1379380101.564 [CBIT](INFO): Clearing failed state for component MassServo 2013-09-17T01:08:21.564Z,1379380101.564 [MassServo] No Fault, FailCount= 2 2013-09-17T01:08:21.845Z,1379380101.845 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:23.087Z,1379380103.087 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:23.267Z,1379380103.267 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:08:23.267Z,1379380103.267 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:08:23.268Z,1379380103.268 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:08:24.245Z,1379380104.245 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:25.274Z,1379380105.274 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:08:25.485Z,1379380105.485 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:26.672Z,1379380106.672 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:27.282Z,1379380107.282 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:08:27.282Z,1379380107.282 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:08:27.878Z,1379380107.878 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:29.080Z,1379380109.080 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:29.285Z,1379380109.285 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:08:29.285Z,1379380109.285 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:08:30.282Z,1379380110.282 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:31.292Z,1379380111.292 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:08:31.292Z,1379380111.292 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:08:31.292Z,1379380111.292 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:08:31.488Z,1379380111.488 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:32.681Z,1379380112.681 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:33.299Z,1379380113.299 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:08:33.299Z,1379380113.299 [DVL_micro](INFO): Querying output modes 2013-09-17T01:08:33.299Z,1379380113.299 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:08:33.883Z,1379380113.883 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:35.081Z,1379380115.081 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:35.306Z,1379380115.306 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:08:35.306Z,1379380115.306 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:08:35.306Z,1379380115.306 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:08:36.275Z,1379380116.275 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:37.317Z,1379380117.317 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:08:37.481Z,1379380117.481 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:38.683Z,1379380118.683 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:39.330Z,1379380119.330 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:08:39.330Z,1379380119.330 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:08:39.877Z,1379380119.877 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:41.114Z,1379380121.114 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:41.336Z,1379380121.336 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:08:41.336Z,1379380121.336 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:08:42.272Z,1379380122.272 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:43.338Z,1379380123.338 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:08:43.339Z,1379380123.339 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:08:43.339Z,1379380123.339 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:08:43.485Z,1379380123.485 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:44.680Z,1379380124.680 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:45.342Z,1379380125.342 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:08:45.342Z,1379380125.342 [DVL_micro](INFO): Querying output modes 2013-09-17T01:08:45.342Z,1379380125.342 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:08:45.874Z,1379380125.874 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:47.116Z,1379380127.116 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:47.345Z,1379380127.345 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:08:47.345Z,1379380127.345 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:08:47.345Z,1379380127.345 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:08:48.282Z,1379380128.282 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:49.352Z,1379380129.352 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:08:49.479Z,1379380129.479 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:50.681Z,1379380130.681 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:51.363Z,1379380131.363 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:08:51.364Z,1379380131.364 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:08:51.875Z,1379380131.875 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:53.081Z,1379380133.081 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:53.366Z,1379380133.366 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:08:53.367Z,1379380133.367 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:08:54.279Z,1379380134.279 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:55.388Z,1379380135.388 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:08:55.389Z,1379380135.389 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:08:55.389Z,1379380135.389 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:08:55.557Z,1379380135.557 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:56.699Z,1379380136.699 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:57.400Z,1379380137.400 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:08:57.400Z,1379380137.400 [DVL_micro](INFO): Querying output modes 2013-09-17T01:08:57.401Z,1379380137.401 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:08:57.897Z,1379380137.897 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:59.123Z,1379380139.123 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:08:59.412Z,1379380139.412 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:08:59.412Z,1379380139.412 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:08:59.412Z,1379380139.412 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:09:00.284Z,1379380140.284 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:01.415Z,1379380141.415 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:09:01.498Z,1379380141.498 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:02.700Z,1379380142.700 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:03.429Z,1379380143.429 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:09:03.429Z,1379380143.429 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:09:03.894Z,1379380143.894 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:05.128Z,1379380145.128 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:05.449Z,1379380145.449 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:09:05.450Z,1379380145.450 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:09:06.286Z,1379380146.286 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:07.452Z,1379380147.452 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:09:07.452Z,1379380147.452 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:09:07.453Z,1379380147.453 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:09:07.500Z,1379380147.500 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:08.685Z,1379380148.685 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:09.467Z,1379380149.467 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:09:09.467Z,1379380149.467 [DVL_micro](INFO): Querying output modes 2013-09-17T01:09:09.468Z,1379380149.468 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:09:09.899Z,1379380149.899 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:11.101Z,1379380151.101 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:11.481Z,1379380151.481 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:09:11.481Z,1379380151.481 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:09:11.481Z,1379380151.481 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:09:12.291Z,1379380152.291 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:13.485Z,1379380153.485 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:09:13.501Z,1379380153.501 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:13.925Z,1379380153.925 [CBIT](CRITICAL): Environmental Failure. Press:14.451184 PSI. Humidity:43%. Temp:22 C. ABORTING MISSION 2013-09-17T01:09:14.691Z,1379380154.691 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:15.497Z,1379380155.497 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:09:15.497Z,1379380155.497 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:09:15.884Z,1379380155.884 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:17.122Z,1379380157.122 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:17.500Z,1379380157.500 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:09:17.500Z,1379380157.500 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:09:18.284Z,1379380158.284 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:19.498Z,1379380159.498 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:19.507Z,1379380159.507 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:09:19.507Z,1379380159.507 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:09:19.507Z,1379380159.507 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:09:20.680Z,1379380160.680 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:21.510Z,1379380161.510 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:09:21.510Z,1379380161.510 [DVL_micro](INFO): Querying output modes 2013-09-17T01:09:21.510Z,1379380161.510 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:09:21.898Z,1379380161.898 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:23.120Z,1379380163.120 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:23.513Z,1379380163.513 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:09:23.513Z,1379380163.513 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:09:23.513Z,1379380163.513 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:09:24.285Z,1379380164.285 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:25.499Z,1379380165.499 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:25.520Z,1379380165.520 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:09:26.685Z,1379380166.685 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:27.066Z,1379380167.066 [MassServo](FAULT): Overload Error 2013-09-17T01:09:27.067Z,1379380167.067 [MassServo] Hardware Fault, FailCount= 3 2013-09-17T01:09:27.067Z,1379380167.067 [MassServo](ERROR): Hardware Fault 2013-09-17T01:09:27.139Z,1379380167.139 [CBIT](ERROR): Hardware Fault in component: MassServo 2013-09-17T01:09:27.419Z,1379380167.419 [MassServo](DEBUG): Uninitialize Mass Servo. 2013-09-17T01:09:27.419Z,1379380167.419 [MassServo](INFO): Powering down 2013-09-17T01:09:27.532Z,1379380167.532 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:09:27.532Z,1379380167.532 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:09:27.855Z,1379380167.855 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:28.248Z,1379380168.248 [MassServo](DEBUG): Initializing EZServoServo. 2013-09-17T01:09:28.374Z,1379380168.374 [MassServo](DEBUG): Initializing MassServo. 2013-09-17T01:09:28.403Z,1379380168.403 [CBIT](INFO): Clearing failed state for component MassServo 2013-09-17T01:09:28.403Z,1379380168.403 [MassServo] No Fault, FailCount= 3 2013-09-17T01:09:29.097Z,1379380169.097 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:29.534Z,1379380169.534 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:09:29.535Z,1379380169.535 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:09:30.247Z,1379380170.247 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:31.481Z,1379380171.481 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:31.537Z,1379380171.537 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:09:31.537Z,1379380171.537 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:09:31.537Z,1379380171.537 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:09:32.678Z,1379380172.678 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:33.548Z,1379380173.548 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:09:33.548Z,1379380173.548 [DVL_micro](INFO): Querying output modes 2013-09-17T01:09:33.549Z,1379380173.549 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:09:33.872Z,1379380173.872 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:35.114Z,1379380175.114 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:35.555Z,1379380175.555 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:09:35.556Z,1379380175.556 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:09:35.556Z,1379380175.556 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:09:36.276Z,1379380176.276 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:37.478Z,1379380177.478 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:37.559Z,1379380177.559 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:09:38.676Z,1379380178.676 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:39.570Z,1379380179.570 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:09:39.570Z,1379380179.570 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:09:39.877Z,1379380179.877 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:41.115Z,1379380181.115 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:41.573Z,1379380181.573 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:09:41.574Z,1379380181.574 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:09:42.274Z,1379380182.274 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:43.515Z,1379380183.515 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:43.576Z,1379380183.576 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:09:43.576Z,1379380183.576 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:09:43.576Z,1379380183.576 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:09:44.673Z,1379380184.673 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:45.579Z,1379380185.579 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:09:45.579Z,1379380185.579 [DVL_micro](INFO): Querying output modes 2013-09-17T01:09:45.579Z,1379380185.579 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:09:45.879Z,1379380185.879 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:47.117Z,1379380187.117 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:47.582Z,1379380187.582 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:09:47.582Z,1379380187.582 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:09:47.582Z,1379380187.582 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:09:48.279Z,1379380188.279 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:49.516Z,1379380189.516 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:49.585Z,1379380189.585 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:09:50.671Z,1379380190.671 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:51.593Z,1379380191.593 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:09:51.593Z,1379380191.593 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:09:51.880Z,1379380191.880 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:53.078Z,1379380193.078 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:53.596Z,1379380193.596 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:09:53.596Z,1379380193.596 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:09:54.284Z,1379380194.284 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:55.510Z,1379380195.510 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:55.606Z,1379380195.606 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:09:55.607Z,1379380195.607 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:09:55.607Z,1379380195.607 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:09:56.683Z,1379380196.683 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:57.618Z,1379380197.618 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:09:57.618Z,1379380197.618 [DVL_micro](INFO): Querying output modes 2013-09-17T01:09:57.618Z,1379380197.618 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:09:57.877Z,1379380197.877 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:59.079Z,1379380199.079 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:09:59.630Z,1379380199.630 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:09:59.630Z,1379380199.630 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:09:59.630Z,1379380199.630 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:10:00.281Z,1379380200.281 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:01.511Z,1379380201.511 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:01.632Z,1379380201.632 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:10:02.757Z,1379380202.757 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:03.644Z,1379380203.644 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:10:03.644Z,1379380203.644 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:10:03.899Z,1379380203.899 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:05.101Z,1379380205.101 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:05.646Z,1379380205.646 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:10:05.647Z,1379380205.647 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:10:06.295Z,1379380206.295 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:07.528Z,1379380207.528 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:07.657Z,1379380207.657 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:10:07.657Z,1379380207.657 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:10:07.657Z,1379380207.657 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:10:08.698Z,1379380208.698 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:09.668Z,1379380209.668 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:10:09.668Z,1379380209.668 [DVL_micro](INFO): Querying output modes 2013-09-17T01:10:09.669Z,1379380209.669 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:10:09.892Z,1379380209.892 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:11.118Z,1379380211.118 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:11.680Z,1379380211.680 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:10:11.680Z,1379380211.680 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:10:11.680Z,1379380211.680 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:10:12.280Z,1379380212.280 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:13.518Z,1379380213.518 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:13.691Z,1379380213.691 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:10:14.700Z,1379380214.700 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:15.702Z,1379380215.702 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:10:15.702Z,1379380215.702 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:10:15.893Z,1379380215.893 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:17.123Z,1379380217.123 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:17.705Z,1379380217.705 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:10:17.706Z,1379380217.706 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:10:18.285Z,1379380218.285 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:19.523Z,1379380219.523 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:19.716Z,1379380219.716 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:10:19.716Z,1379380219.716 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:10:19.716Z,1379380219.716 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:10:20.685Z,1379380220.685 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:21.727Z,1379380221.727 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:10:21.727Z,1379380221.727 [DVL_micro](INFO): Querying output modes 2013-09-17T01:10:21.727Z,1379380221.727 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:10:21.891Z,1379380221.891 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:23.101Z,1379380223.101 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:23.731Z,1379380223.731 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:10:23.732Z,1379380223.732 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:10:23.732Z,1379380223.732 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:10:24.290Z,1379380224.290 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:25.528Z,1379380225.528 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:25.741Z,1379380225.741 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:10:26.690Z,1379380226.690 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:27.753Z,1379380227.753 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:10:27.753Z,1379380227.753 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:10:27.896Z,1379380227.896 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:29.094Z,1379380229.094 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:29.756Z,1379380229.756 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:10:29.756Z,1379380229.756 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:10:30.284Z,1379380230.284 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:31.518Z,1379380231.518 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:31.763Z,1379380231.763 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:10:31.763Z,1379380231.763 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:10:31.763Z,1379380231.763 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:10:32.691Z,1379380232.691 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:33.774Z,1379380233.774 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:10:33.774Z,1379380233.774 [DVL_micro](INFO): Querying output modes 2013-09-17T01:10:33.774Z,1379380233.774 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:10:33.881Z,1379380233.881 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:34.287Z,1379380234.287 [MassServo](FAULT): Overload Error 2013-09-17T01:10:34.287Z,1379380234.287 [MassServo] Hardware Fault, FailCount= 4 2013-09-17T01:10:34.287Z,1379380234.287 [MassServo](ERROR): Hardware Fault 2013-09-17T01:10:34.353Z,1379380234.353 [CBIT](ERROR): Hardware Fault in component: MassServo 2013-09-17T01:10:34.656Z,1379380234.656 [MassServo](DEBUG): Uninitialize Mass Servo. 2013-09-17T01:10:34.656Z,1379380234.656 [MassServo](INFO): Powering down 2013-09-17T01:10:35.087Z,1379380235.087 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:35.413Z,1379380235.413 [MassServo](DEBUG): Initializing EZServoServo. 2013-09-17T01:10:35.533Z,1379380235.533 [MassServo](DEBUG): Initializing MassServo. 2013-09-17T01:10:35.563Z,1379380235.563 [CBIT](INFO): Clearing failed state for component MassServo 2013-09-17T01:10:35.563Z,1379380235.563 [MassServo] No Fault, FailCount= 4 2013-09-17T01:10:35.785Z,1379380235.785 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:10:35.785Z,1379380235.785 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:10:35.785Z,1379380235.785 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:10:36.253Z,1379380236.253 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:36.645Z,1379380236.645 [CBIT](INFO): Clearing failed count for component DropWeight 2013-09-17T01:10:36.645Z,1379380236.645 [DropWeight] No Fault, FailCount= 1 2013-09-17T01:10:36.996Z,1379380236.996 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2013-09-17T01:10:36.996Z,1379380236.996 [DropWeight] Hardware Fault, FailCount= 1 2013-09-17T01:10:36.996Z,1379380236.996 [DropWeight](ERROR): Hardware Fault 2013-09-17T01:10:37.050Z,1379380237.050 [CBIT](ERROR): Hardware Fault in component: DropWeight 2013-09-17T01:10:37.050Z,1379380237.050 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2013-09-17T01:10:37.488Z,1379380237.488 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:37.791Z,1379380237.791 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:10:38.677Z,1379380238.677 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:39.800Z,1379380239.800 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:10:39.800Z,1379380239.800 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:10:39.875Z,1379380239.875 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:41.080Z,1379380241.080 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:41.803Z,1379380241.803 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:10:41.803Z,1379380241.803 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:10:42.270Z,1379380242.270 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:43.476Z,1379380243.476 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:43.816Z,1379380243.816 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:10:43.816Z,1379380243.816 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:10:43.816Z,1379380243.816 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:10:44.682Z,1379380244.682 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:45.844Z,1379380245.844 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:10:45.844Z,1379380245.844 [DVL_micro](INFO): Querying output modes 2013-09-17T01:10:45.845Z,1379380245.845 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:10:45.884Z,1379380245.884 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:47.078Z,1379380247.078 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:47.851Z,1379380247.852 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:10:47.852Z,1379380247.852 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:10:47.852Z,1379380247.852 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:10:48.275Z,1379380248.275 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:49.484Z,1379380249.484 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:49.859Z,1379380249.859 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:10:50.671Z,1379380250.671 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:51.449Z,1379380251.449 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadb4 2013-09-17T01:10:51.863Z,1379380251.863 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:10:51.863Z,1379380251.863 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:10:51.882Z,1379380251.882 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:52.196Z,1379380252.196 [NAL9602](FAULT): GPS failed to acquire within timeout. 2013-09-17T01:10:52.196Z,1379380252.196 [NAL9602] Data Fault, FailCount= 1 2013-09-17T01:10:52.196Z,1379380252.196 [NAL9602](ERROR): Data Fault 2013-09-17T01:10:52.285Z,1379380252.285 [CBIT](ERROR): Data Fault in component: NAL9602 2013-09-17T01:10:52.592Z,1379380252.592 [NAL9602](INFO): Powering down 2013-09-17T01:10:53.071Z,1379380253.071 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:53.475Z,1379380253.475 [CBIT](INFO): Clearing failed state for component NAL9602 2013-09-17T01:10:53.475Z,1379380253.475 [NAL9602] No Fault, FailCount= 1 2013-09-17T01:10:53.865Z,1379380253.865 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:10:53.866Z,1379380253.866 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:10:54.281Z,1379380254.281 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:55.412Z,1379380255.412 [VerticalControl](CRITICAL): Failure to ascend, stopping mission after 300.084259 seconds, depthRate=0.000188 m/s, pitch=29.646658 deg. 2013-09-17T01:10:55.475Z,1379380255.475 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:55.876Z,1379380255.876 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:10:55.876Z,1379380255.876 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:10:55.876Z,1379380255.876 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:10:56.676Z,1379380256.676 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:57.792Z,1379380257.792 [NAL9602](INFO): Powering up NAL9602 2013-09-17T01:10:57.874Z,1379380257.874 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:57.887Z,1379380257.887 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:10:57.887Z,1379380257.887 [DVL_micro](INFO): Querying output modes 2013-09-17T01:10:57.887Z,1379380257.887 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:10:59.076Z,1379380259.076 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:10:59.890Z,1379380259.890 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:10:59.890Z,1379380259.890 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:10:59.891Z,1379380259.891 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:11:00.270Z,1379380260.270 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:01.480Z,1379380261.480 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:01.897Z,1379380261.897 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:11:02.281Z,1379380262.281 [CBIT](INFO): Clearing failed count for component AHRS_sp3003D 2013-09-17T01:11:02.281Z,1379380262.281 [AHRS_sp3003D] No Fault, FailCount= 5 2013-09-17T01:11:02.590Z,1379380262.590 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D. 2013-09-17T01:11:02.682Z,1379380262.682 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:03.508Z,1379380263.508 [AHRS_sp3003D](ERROR): readHeadingMagBin UART error: serial timeout 2013-09-17T01:11:03.508Z,1379380263.508 [AHRS_sp3003D](ERROR): readHeadingMagBin got 0xA409A0 2013-09-17T01:11:03.508Z,1379380263.508 [AHRS_sp3003D](ERROR): SP3003D failed to initialize 2013-09-17T01:11:03.508Z,1379380263.508 [AHRS_sp3003D] Hardware Fault, FailCount= 1 2013-09-17T01:11:03.508Z,1379380263.508 [AHRS_sp3003D](ERROR): Hardware Fault 2013-09-17T01:11:03.603Z,1379380263.603 [CBIT](ERROR): Hardware Fault in component: AHRS_sp3003D 2013-09-17T01:11:03.788Z,1379380263.788 [AHRS_sp3003D](INFO): Powering down 2013-09-17T01:11:03.902Z,1379380263.902 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:11:03.902Z,1379380263.902 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:11:03.956Z,1379380263.956 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:05.077Z,1379380265.077 [CBIT](INFO): Clearing failed state for component AHRS_sp3003D 2013-09-17T01:11:05.077Z,1379380265.077 [AHRS_sp3003D] No Fault, FailCount= 1 2013-09-17T01:11:05.078Z,1379380265.078 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:05.391Z,1379380265.391 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D. 2013-09-17T01:11:05.904Z,1379380265.904 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:11:05.904Z,1379380265.904 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:11:06.308Z,1379380266.308 [AHRS_sp3003D](ERROR): readHeadingMagBin UART error: serial timeout 2013-09-17T01:11:06.308Z,1379380266.308 [AHRS_sp3003D](ERROR): readHeadingMagBin got 0x000100 2013-09-17T01:11:06.309Z,1379380266.309 [AHRS_sp3003D](ERROR): SP3003D failed to initialize 2013-09-17T01:11:06.309Z,1379380266.309 [AHRS_sp3003D] Hardware Fault, FailCount= 2 2013-09-17T01:11:06.309Z,1379380266.309 [AHRS_sp3003D](ERROR): Hardware Fault 2013-09-17T01:11:06.436Z,1379380266.436 [CBIT](ERROR): Hardware Fault in component: AHRS_sp3003D 2013-09-17T01:11:06.442Z,1379380266.442 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:06.589Z,1379380266.589 [AHRS_sp3003D](INFO): Powering down 2013-09-17T01:11:07.484Z,1379380267.484 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:07.873Z,1379380267.873 [CBIT](INFO): Clearing failed state for component AHRS_sp3003D 2013-09-17T01:11:07.873Z,1379380267.873 [AHRS_sp3003D] No Fault, FailCount= 2 2013-09-17T01:11:07.915Z,1379380267.915 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:11:07.915Z,1379380267.915 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:11:07.915Z,1379380267.915 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:11:08.191Z,1379380268.191 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D. 2013-09-17T01:11:08.635Z,1379380268.635 [NAL9602](INFO): NAL9602 initialized 2013-09-17T01:11:08.715Z,1379380268.715 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:09.333Z,1379380269.333 [AHRS_sp3003D](ERROR): readHeadingMagBin UART error: serial timeout 2013-09-17T01:11:09.333Z,1379380269.333 [AHRS_sp3003D](ERROR): SP3003D failed to initialize 2013-09-17T01:11:09.333Z,1379380269.333 [AHRS_sp3003D] Hardware Fault, FailCount= 3 2013-09-17T01:11:09.333Z,1379380269.333 [AHRS_sp3003D](ERROR): Hardware Fault 2013-09-17T01:11:09.536Z,1379380269.536 [CBIT](ERROR): Hardware Fault in component: AHRS_sp3003D 2013-09-17T01:11:09.549Z,1379380269.549 [AHRS_sp3003D](INFO): Powering down 2013-09-17T01:11:09.773Z,1379380269.773 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:09.918Z,1379380269.918 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:11:09.918Z,1379380269.918 [DVL_micro](INFO): Querying output modes 2013-09-17T01:11:09.918Z,1379380269.918 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:11:10.854Z,1379380270.854 [CBIT](INFO): Clearing failed state for component AHRS_sp3003D 2013-09-17T01:11:10.854Z,1379380270.854 [AHRS_sp3003D] No Fault, FailCount= 3 2013-09-17T01:11:10.855Z,1379380270.855 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:11.154Z,1379380271.154 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D. 2013-09-17T01:11:11.925Z,1379380271.925 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:11:11.925Z,1379380271.925 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:11:11.925Z,1379380271.925 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:11:12.285Z,1379380272.285 [AHRS_sp3003D](ERROR): readHeadingMagBin UART error: serial timeout 2013-09-17T01:11:12.285Z,1379380272.285 [AHRS_sp3003D](ERROR): SP3003D failed to initialize 2013-09-17T01:11:12.286Z,1379380272.286 [AHRS_sp3003D] Hardware Fault, FailCount= 4 2013-09-17T01:11:12.286Z,1379380272.286 [AHRS_sp3003D](ERROR): Hardware Fault 2013-09-17T01:11:12.380Z,1379380272.380 [CBIT](ERROR): Hardware Fault in component: AHRS_sp3003D 2013-09-17T01:11:12.381Z,1379380272.381 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:12.395Z,1379380272.395 [AHRS_sp3003D](INFO): Powering down 2013-09-17T01:11:13.722Z,1379380273.722 [CBIT](INFO): Clearing failed state for component AHRS_sp3003D 2013-09-17T01:11:13.722Z,1379380273.722 [AHRS_sp3003D] No Fault, FailCount= 4 2013-09-17T01:11:13.724Z,1379380273.724 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:13.936Z,1379380273.936 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:11:13.996Z,1379380273.996 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D. 2013-09-17T01:11:15.131Z,1379380275.131 [AHRS_sp3003D](ERROR): readHeadingMagBin UART error: serial timeout 2013-09-17T01:11:15.131Z,1379380275.131 [AHRS_sp3003D](ERROR): SP3003D failed to initialize 2013-09-17T01:11:15.131Z,1379380275.131 [AHRS_sp3003D] Hardware Fault, FailCount= 5 2013-09-17T01:11:15.131Z,1379380275.131 [AHRS_sp3003D](ERROR): Hardware Fault 2013-09-17T01:11:15.241Z,1379380275.241 [CBIT](ERROR): Hardware Fault in component: AHRS_sp3003D 2013-09-17T01:11:15.241Z,1379380275.241 [CBIT](CRITICAL): Hardware Fault in component: AHRS_sp3003D 2013-09-17T01:11:15.251Z,1379380275.251 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:15.267Z,1379380275.267 [AHRS_sp3003D](INFO): Powering down 2013-09-17T01:11:15.940Z,1379380275.940 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:11:15.940Z,1379380275.940 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:11:16.376Z,1379380276.376 [CommandLine](IMPORTANT): got command run ./Missions/Insert/Science.xml 2013-09-17T01:11:16.384Z,1379380276.384 [MissionManager](INFO): Loading Mission: ./Missions/Insert/Science.xml 2013-09-17T01:11:16.562Z,1379380276.562 [MissionManager](INFO): DefineArg Science.SampleISUS = 0 bool 2013-09-17T01:11:16.570Z,1379380276.570 [MissionManager](INFO): DefineArg Science.SampleISUSmaxPitch = 60.000000 arcdeg 2013-09-17T01:11:16.576Z,1379380276.576 [MissionManager](INFO): DefineArg Science.SampleISUSminPitch = -60.000000 arcdeg 2013-09-17T01:11:16.578Z,1379380276.578 [MissionManager](INFO): DefineArg Science.SampleRSSI = 1 bool 2013-09-17T01:11:16.583Z,1379380276.583 [MissionManager](INFO): DefineArg Science.SampleADCP = 0 bool 2013-09-17T01:11:16.585Z,1379380276.585 [MissionManager](INFO): DefineArg Science.PeakDetectChlActive = 0 bool 2013-09-17T01:11:16.587Z,1379380276.587 [MissionManager](INFO): DefineArg Science.PeakDetectNO3Active = 0 bool 2013-09-17T01:11:16.589Z,1379380276.589 [MissionManager](INFO): DefineArg Science.PeakDetectRSSIActive = 0 bool 2013-09-17T01:11:16.591Z,1379380276.591 [MissionManager](INFO): DefineArg Science.UpwardDerivativeOfTemperatureActive = 0 bool 2013-09-17T01:11:16.594Z,1379380276.594 [MissionManager](INFO): DefineArg Science.ComputeWaterCurrent = 0 bool 2013-09-17T01:11:16.597Z,1379380276.597 [MissionManager](INFO): DefineArg Science.ComputeWaterCurrentMinDepth = 2.000000 m 2013-09-17T01:11:16.599Z,1379380276.599 [MissionManager](INFO): DefineArg Science.ComputeWaterCurrentMaxDepth = 5.000000 m 2013-09-17T01:11:16.602Z,1379380276.602 [MissionManager](INFO): DefineArg Science.EnabledAanderaaO2 = 0.000000 n/a 2013-09-17T01:11:16.611Z,1379380276.611 [MissionManager](INFO): DefineArg Science.EnabledNeilBrown = 1.000000 n/a 2013-09-17T01:11:16.613Z,1379380276.613 [MissionManager](INFO): DefineArg Science.EnabledTurbulence_NPS = 0.000000 n/a 2013-09-17T01:11:16.616Z,1379380276.616 [MissionManager](INFO): DefineArg Science.EnabledWetLabsBB2FL = 1.000000 n/a 2013-09-17T01:11:16.619Z,1379380276.619 [MissionManager](INFO): DefineArg Science.EnabledDVL = 1.000000 n/a 2013-09-17T01:11:16.622Z,1379380276.622 [MissionManager](INFO): DefineArg Science.EnabledISUS = 0.000000 n/a 2013-09-17T01:11:16.625Z,1379380276.625 [MissionManager](INFO): DefineOutput Science.PeakChl = 0.000000 ug/l 2013-09-17T01:11:16.632Z,1379380276.632 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:16.644Z,1379380276.644 [MissionManager](INFO): DefineOutput Science.PeakChlDepth = 0.000000 m 2013-09-17T01:11:16.647Z,1379380276.647 [MissionManager](INFO): DefineOutput Science.PeakChlLatitude = nan arcdeg 2013-09-17T01:11:16.653Z,1379380276.653 [MissionManager](INFO): DefineOutput Science.PeakChlLongitude = nan arcdeg 2013-09-17T01:11:16.655Z,1379380276.655 [MissionManager](INFO): DefineOutput Science.PeakNO3 = 0.000000 umol/l 2013-09-17T01:11:16.662Z,1379380276.662 [MissionManager](INFO): DefineOutput Science.PeakNO3Depth = 0.000000 m 2013-09-17T01:11:16.669Z,1379380276.669 [MissionManager](INFO): DefineOutput Science.PeakNO3Latitude = nan arcdeg 2013-09-17T01:11:16.671Z,1379380276.671 [MissionManager](INFO): DefineOutput Science.PeakNO3Longitude = nan arcdeg 2013-09-17T01:11:16.674Z,1379380276.674 [MissionManager](INFO): DefineOutput Science.PeakRSSI = 0.000000 dB 2013-09-17T01:11:16.684Z,1379380276.684 [MissionManager](INFO): DefineOutput Science.PeakRSSIDepth = 0.000000 m 2013-09-17T01:11:16.686Z,1379380276.686 [MissionManager](INFO): DefineOutput Science.PeakRSSILatitude = nan arcdeg 2013-09-17T01:11:16.689Z,1379380276.689 [MissionManager](INFO): DefineOutput Science.PeakRSSILongitude = nan arcdeg 2013-09-17T01:11:16.706Z,1379380276.706 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2013-09-17T01:11:16.713Z,1379380276.713 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2013-09-17T01:11:16.721Z,1379380276.721 [Science:PeakDetectRSSI:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2013-09-17T01:11:16.754Z,1379380276.754 [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-17T01:11:16.768Z,1379380276.768 [CommandLine](IMPORTANT): Running ./Missions/Insert/Science.xml 2013-09-17T01:11:17.754Z,1379380277.754 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:17.942Z,1379380277.942 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:11:17.943Z,1379380277.943 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:11:19.027Z,1379380279.027 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:19.949Z,1379380279.949 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:11:19.949Z,1379380279.949 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:11:19.950Z,1379380279.950 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:11:20.245Z,1379380280.245 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:21.463Z,1379380281.463 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:21.960Z,1379380281.960 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:11:21.960Z,1379380281.960 [DVL_micro](INFO): Querying output modes 2013-09-17T01:11:21.961Z,1379380281.961 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:11:22.629Z,1379380282.629 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:23.807Z,1379380283.807 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:23.963Z,1379380283.963 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:11:23.964Z,1379380283.964 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:11:23.964Z,1379380283.964 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:11:25.077Z,1379380285.077 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:25.975Z,1379380285.975 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:11:26.719Z,1379380286.719 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:27.982Z,1379380287.982 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:11:27.982Z,1379380287.982 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:11:28.181Z,1379380288.181 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:29.239Z,1379380289.239 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:29.985Z,1379380289.985 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:11:29.986Z,1379380289.986 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:11:30.441Z,1379380290.441 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:31.779Z,1379380291.779 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:31.000Z,1379380292.000 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:11:32.000Z,1379380292.000 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:11:32.000Z,1379380292.000 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:11:32.849Z,1379380292.849 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:34.007Z,1379380294.007 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:11:34.007Z,1379380294.007 [DVL_micro](INFO): Querying output modes 2013-09-17T01:11:34.008Z,1379380294.008 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:11:34.039Z,1379380294.039 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:35.228Z,1379380295.228 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:36.010Z,1379380296.010 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:11:36.010Z,1379380296.010 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:11:36.011Z,1379380296.011 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:11:36.434Z,1379380296.434 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:38.013Z,1379380298.013 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:11:38.169Z,1379380298.169 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:39.502Z,1379380299.502 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:40.025Z,1379380300.025 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:11:40.025Z,1379380300.025 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:11:40.705Z,1379380300.705 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:41.955Z,1379380301.955 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:42.028Z,1379380302.028 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:11:42.028Z,1379380302.028 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:11:43.085Z,1379380303.085 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:44.031Z,1379380304.031 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:11:44.031Z,1379380304.031 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:11:44.031Z,1379380304.031 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:11:44.290Z,1379380304.290 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:45.621Z,1379380305.621 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:46.034Z,1379380306.034 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:11:46.034Z,1379380306.034 [DVL_micro](INFO): Querying output modes 2013-09-17T01:11:46.034Z,1379380306.034 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:11:46.766Z,1379380306.766 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:48.041Z,1379380308.041 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:11:48.041Z,1379380308.041 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:11:48.041Z,1379380308.041 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:11:48.449Z,1379380308.449 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:49.799Z,1379380309.799 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:50.048Z,1379380310.048 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:11:50.985Z,1379380310.985 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:52.064Z,1379380312.064 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:11:52.064Z,1379380312.064 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:11:52.255Z,1379380312.255 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:53.344Z,1379380313.344 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:54.067Z,1379380314.067 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:11:54.067Z,1379380314.067 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:11:54.131Z,1379380314.131 [CommandLine](IMPORTANT): got command report periodic 1.000000 sea_water_pressure 2013-09-17T01:11:54.706Z,1379380314.706 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:54.707Z,1379380314.707 [Reporter](INFO): sea_water_pressure 288.305700 db 2013-09-17T01:11:56.029Z,1379380316.029 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:56.029Z,1379380316.029 [Reporter](INFO): sea_water_pressure 288.306575 db 2013-09-17T01:11:56.069Z,1379380316.069 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:11:56.069Z,1379380316.069 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:11:56.070Z,1379380316.070 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:11:57.227Z,1379380317.227 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:57.227Z,1379380317.227 [Reporter](INFO): sea_water_pressure 288.313100 db 2013-09-17T01:11:58.076Z,1379380318.076 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:11:58.076Z,1379380318.076 [DVL_micro](INFO): Querying output modes 2013-09-17T01:11:58.077Z,1379380318.077 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:11:58.504Z,1379380318.504 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:58.505Z,1379380318.505 [Reporter](INFO): sea_water_pressure 288.317900 db 2013-09-17T01:11:59.578Z,1379380319.578 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:11:59.579Z,1379380319.579 [Reporter](INFO): sea_water_pressure 288.311375 db 2013-09-17T01:12:00.079Z,1379380320.079 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:12:00.080Z,1379380320.080 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:12:00.080Z,1379380320.080 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:12:00.948Z,1379380320.948 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:00.949Z,1379380320.949 [Reporter](INFO): sea_water_pressure 288.295650 db 2013-09-17T01:12:02.087Z,1379380322.087 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:12:02.306Z,1379380322.306 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:02.307Z,1379380322.307 [Reporter](INFO): sea_water_pressure 288.310050 db 2013-09-17T01:12:03.536Z,1379380323.536 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:03.537Z,1379380323.537 [Reporter](INFO): sea_water_pressure 288.300900 db 2013-09-17T01:12:04.098Z,1379380324.098 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:12:04.099Z,1379380324.099 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:12:04.714Z,1379380324.714 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:04.715Z,1379380324.715 [Reporter](INFO): sea_water_pressure 288.323575 db 2013-09-17T01:12:05.856Z,1379380325.856 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:05.857Z,1379380325.857 [Reporter](INFO): sea_water_pressure 288.301750 db 2013-09-17T01:12:06.101Z,1379380326.101 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:12:06.102Z,1379380326.102 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:12:07.074Z,1379380327.074 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:07.075Z,1379380327.075 [Reporter](INFO): sea_water_pressure 288.311375 db 2013-09-17T01:12:08.104Z,1379380328.104 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:12:08.104Z,1379380328.104 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:12:08.104Z,1379380328.104 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:12:08.264Z,1379380328.264 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:08.264Z,1379380328.264 [Reporter](INFO): sea_water_pressure 288.309625 db 2013-09-17T01:12:09.638Z,1379380329.638 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:09.639Z,1379380329.639 [Reporter](INFO): sea_water_pressure 288.309625 db 2013-09-17T01:12:10.115Z,1379380330.115 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:12:10.115Z,1379380330.115 [DVL_micro](INFO): Querying output modes 2013-09-17T01:12:10.115Z,1379380330.115 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:12:10.997Z,1379380330.997 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:10.998Z,1379380330.998 [Reporter](INFO): sea_water_pressure 288.316625 db 2013-09-17T01:12:12.114Z,1379380332.114 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:12.115Z,1379380332.115 [Reporter](INFO): sea_water_pressure 288.317050 db 2013-09-17T01:12:12.126Z,1379380332.126 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:12:12.127Z,1379380332.127 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:12:12.127Z,1379380332.127 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:12:13.384Z,1379380333.384 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:13.404Z,1379380333.404 [Reporter](INFO): sea_water_pressure 288.306575 db 2013-09-17T01:12:14.129Z,1379380334.129 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:12:14.402Z,1379380334.402 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:14.835Z,1379380334.835 [Reporter](INFO): sea_water_pressure 288.302650 db 2013-09-17T01:12:15.611Z,1379380335.611 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:15.917Z,1379380335.917 [CommandLine](IMPORTANT): got command show variable CTD 2013-09-17T01:12:15.923Z,1379380335.923 [CommandLine](INFO): CTD_NeilBrown.loadControl (none) 2013-09-17T01:12:15.923Z,1379380335.923 [CommandLine](INFO): CTD_NeilBrown.uart (none) 2013-09-17T01:12:15.924Z,1379380335.924 [CommandLine](INFO): CTD_NeilBrown.baud (bit_per_second) 2013-09-17T01:12:15.943Z,1379380335.943 [CommandLine](INFO): CTD_NeilBrown.loadAtStartup (bool) 2013-09-17T01:12:15.949Z,1379380335.949 [CommandLine](INFO): CTD_NeilBrown.simulateHardware (bool) 2013-09-17T01:12:15.950Z,1379380335.950 [CommandLine](INFO): CTD_NeilBrown.power (watt) 2013-09-17T01:12:15.950Z,1379380335.950 [CommandLine](INFO): CTD_NeilBrown.maxPressBound (decibar) 2013-09-17T01:12:15.950Z,1379380335.950 [CommandLine](INFO): CTD_NeilBrown.minPressBound (decibar) 2013-09-17T01:12:15.951Z,1379380335.951 [CommandLine](INFO): CTD_NeilBrown.offset (decibar) 2013-09-17T01:12:15.951Z,1379380335.951 [CommandLine](INFO): CTD_NeilBrown.maxSalinityBound (practical_salinity_unit) 2013-09-17T01:12:15.952Z,1379380335.952 [CommandLine](INFO): CTD_NeilBrown.minSalinityBound (practical_salinity_unit) 2013-09-17T01:12:15.980Z,1379380335.980 [CommandLine](INFO): CTD_NeilBrown.sea_water_density (kilogram_per_cubic_meter) 2013-09-17T01:12:15.981Z,1379380335.981 [CommandLine](INFO): CTD_NeilBrown.depth (meter) 2013-09-17T01:12:15.982Z,1379380335.982 [CommandLine](INFO): CTD_NeilBrown.sea_water_pressure (decibar) 2013-09-17T01:12:15.982Z,1379380335.982 [CommandLine](INFO): CTD_NeilBrown.sea_water_salinity (practical_salinity_unit) 2013-09-17T01:12:15.983Z,1379380335.983 [CommandLine](INFO): CTD_NeilBrown.sea_water_temperature (celsius) 2013-09-17T01:12:15.983Z,1379380335.983 [CommandLine](INFO): CTD_NeilBrown.sea_water_electrical_conductivity (millimho_per_centimeter) 2013-09-17T01:12:16.001Z,1379380336.001 [CommandLine](INFO): CTD_NeilBrown.durationOfLastRun (second) 2013-09-17T01:12:16.002Z,1379380336.002 [CommandLine](INFO): CTD_NeilBrown.component_voltage (volt) 2013-09-17T01:12:16.002Z,1379380336.002 [CommandLine](INFO): CTD_NeilBrown.component_avgVoltage (volt) 2013-09-17T01:12:16.003Z,1379380336.003 [CommandLine](INFO): CTD_NeilBrown.component_current (milliampere) 2013-09-17T01:12:16.003Z,1379380336.003 [CommandLine](INFO): CTD_NeilBrown.component_avgCurrent (milliampere) 2013-09-17T01:12:16.016Z,1379380336.016 [Reporter](INFO): sea_water_pressure 288.305275 db 2013-09-17T01:12:16.141Z,1379380336.141 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:12:16.141Z,1379380336.141 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:12:16.768Z,1379380336.768 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:17.166Z,1379380337.166 [Reporter](INFO): sea_water_pressure 288.293025 db 2013-09-17T01:12:17.979Z,1379380337.979 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:18.144Z,1379380338.144 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:12:18.144Z,1379380338.144 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:12:18.424Z,1379380338.424 [Reporter](INFO): sea_water_pressure 288.301325 db 2013-09-17T01:12:19.345Z,1379380339.345 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:19.492Z,1379380339.492 [Reporter](INFO): sea_water_pressure 288.314425 db 2013-09-17T01:12:20.159Z,1379380340.159 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:12:20.159Z,1379380340.159 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:12:20.159Z,1379380340.159 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:12:20.679Z,1379380340.679 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:20.680Z,1379380340.680 [Reporter](INFO): sea_water_pressure 288.303950 db 2013-09-17T01:12:21.905Z,1379380341.905 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:21.906Z,1379380341.906 [Reporter](INFO): sea_water_pressure 288.309175 db 2013-09-17T01:12:22.162Z,1379380342.162 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:12:22.162Z,1379380342.162 [DVL_micro](INFO): Querying output modes 2013-09-17T01:12:22.162Z,1379380342.162 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:12:23.119Z,1379380343.119 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:23.119Z,1379380343.119 [Reporter](INFO): sea_water_pressure 288.298275 db 2013-09-17T01:12:24.173Z,1379380344.173 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:12:24.173Z,1379380344.173 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:12:24.173Z,1379380344.173 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:12:24.369Z,1379380344.369 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:24.369Z,1379380344.369 [Reporter](INFO): sea_water_pressure 288.308750 db 2013-09-17T01:12:25.518Z,1379380345.518 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:25.519Z,1379380345.519 [Reporter](INFO): sea_water_pressure 288.301325 db 2013-09-17T01:12:26.180Z,1379380346.180 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:12:26.724Z,1379380346.724 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:26.725Z,1379380346.725 [Reporter](INFO): sea_water_pressure 288.295650 db 2013-09-17T01:12:27.128Z,1379380347.128 [CBIT](CRITICAL): Environmental Failure. Press:14.451184 PSI. Humidity:43%. Temp:22 C. ABORTING MISSION 2013-09-17T01:12:27.889Z,1379380347.889 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:27.890Z,1379380347.890 [Reporter](INFO): sea_water_pressure 288.299125 db 2013-09-17T01:12:28.196Z,1379380348.196 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:12:28.196Z,1379380348.196 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:12:29.120Z,1379380349.120 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:29.121Z,1379380349.121 [Reporter](INFO): sea_water_pressure 288.301750 db 2013-09-17T01:12:30.199Z,1379380350.199 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:12:30.199Z,1379380350.199 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:12:30.294Z,1379380350.294 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:30.295Z,1379380350.295 [Reporter](INFO): sea_water_pressure 288.302225 db 2013-09-17T01:12:31.496Z,1379380351.496 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:31.496Z,1379380351.496 [Reporter](INFO): sea_water_pressure 288.300450 db 2013-09-17T01:12:31.853Z,1379380351.853 [MassServo](FAULT): Overload Error 2013-09-17T01:12:31.853Z,1379380351.853 [MassServo] Hardware Fault, FailCount= 1 2013-09-17T01:12:31.853Z,1379380351.853 [MassServo](ERROR): Hardware Fault 2013-09-17T01:12:31.924Z,1379380351.924 [CBIT](ERROR): Hardware Fault in component: MassServo 2013-09-17T01:12:32.205Z,1379380352.205 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:12:32.205Z,1379380352.205 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:12:32.206Z,1379380352.206 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:12:32.219Z,1379380352.219 [MassServo](DEBUG): Uninitialize Mass Servo. 2013-09-17T01:12:32.219Z,1379380352.219 [MassServo](INFO): Powering down 2013-09-17T01:12:32.645Z,1379380352.645 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:32.646Z,1379380352.646 [Reporter](INFO): sea_water_pressure 288.307850 db 2013-09-17T01:12:33.011Z,1379380353.011 [MassServo](DEBUG): Initializing EZServoServo. 2013-09-17T01:12:33.136Z,1379380353.136 [MassServo](DEBUG): Initializing MassServo. 2013-09-17T01:12:33.165Z,1379380353.165 [CBIT](INFO): Clearing failed state for component MassServo 2013-09-17T01:12:33.165Z,1379380353.165 [MassServo] No Fault, FailCount= 1 2013-09-17T01:12:33.856Z,1379380353.856 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:33.857Z,1379380353.857 [Reporter](INFO): sea_water_pressure 288.307425 db 2013-09-17T01:12:34.217Z,1379380354.217 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:12:34.217Z,1379380354.217 [DVL_micro](INFO): Querying output modes 2013-09-17T01:12:34.217Z,1379380354.217 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:12:35.041Z,1379380355.041 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:35.042Z,1379380355.042 [Reporter](INFO): sea_water_pressure 288.310950 db 2013-09-17T01:12:36.228Z,1379380356.228 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:12:36.228Z,1379380356.228 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:12:36.228Z,1379380356.228 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:12:36.275Z,1379380356.275 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:36.276Z,1379380356.276 [Reporter](INFO): sea_water_pressure 288.296075 db 2013-09-17T01:12:37.473Z,1379380357.473 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:37.473Z,1379380357.473 [Reporter](INFO): sea_water_pressure 288.287350 db 2013-09-17T01:12:38.231Z,1379380358.231 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:12:38.675Z,1379380358.675 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:38.675Z,1379380358.675 [Reporter](INFO): sea_water_pressure 288.310050 db 2013-09-17T01:12:39.876Z,1379380359.876 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:39.877Z,1379380359.877 [Reporter](INFO): sea_water_pressure 288.285175 db 2013-09-17T01:12:40.243Z,1379380360.243 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:12:40.243Z,1379380360.243 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:12:41.058Z,1379380361.058 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:41.059Z,1379380361.059 [Reporter](INFO): sea_water_pressure 288.308750 db 2013-09-17T01:12:42.247Z,1379380362.247 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:12:42.247Z,1379380362.247 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:12:42.272Z,1379380362.272 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:42.273Z,1379380362.273 [Reporter](INFO): sea_water_pressure 288.289975 db 2013-09-17T01:12:43.470Z,1379380363.470 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:43.471Z,1379380363.471 [Reporter](INFO): sea_water_pressure 288.297400 db 2013-09-17T01:12:44.252Z,1379380364.252 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:12:44.252Z,1379380364.252 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:12:44.252Z,1379380364.252 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:12:44.676Z,1379380364.676 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:44.677Z,1379380364.677 [Reporter](INFO): sea_water_pressure 288.306125 db 2013-09-17T01:12:45.862Z,1379380365.862 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:45.862Z,1379380365.862 [Reporter](INFO): sea_water_pressure 288.296550 db 2013-09-17T01:12:46.255Z,1379380366.255 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:12:46.255Z,1379380366.255 [DVL_micro](INFO): Querying output modes 2013-09-17T01:12:46.256Z,1379380366.256 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:12:47.056Z,1379380367.056 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:47.057Z,1379380367.057 [Reporter](INFO): sea_water_pressure 288.294350 db 2013-09-17T01:12:48.258Z,1379380368.258 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:12:48.258Z,1379380368.258 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:12:48.259Z,1379380368.259 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:12:48.274Z,1379380368.274 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:48.274Z,1379380368.274 [Reporter](INFO): sea_water_pressure 288.302225 db 2013-09-17T01:12:49.471Z,1379380369.471 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:49.472Z,1379380369.472 [Reporter](INFO): sea_water_pressure 288.296075 db 2013-09-17T01:12:50.265Z,1379380370.265 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:12:50.677Z,1379380370.677 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:50.678Z,1379380370.678 [Reporter](INFO): sea_water_pressure 288.297400 db 2013-09-17T01:12:51.871Z,1379380371.871 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:51.872Z,1379380371.872 [Reporter](INFO): sea_water_pressure 288.296550 db 2013-09-17T01:12:52.278Z,1379380372.278 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:12:52.278Z,1379380372.278 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:12:53.069Z,1379380373.069 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:53.070Z,1379380373.070 [Reporter](INFO): sea_water_pressure 288.291300 db 2013-09-17T01:12:54.271Z,1379380374.271 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:54.272Z,1379380374.272 [Reporter](INFO): sea_water_pressure 288.296075 db 2013-09-17T01:12:54.292Z,1379380374.292 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:12:54.292Z,1379380374.292 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:12:54.569Z,1379380374.569 [CommandLine](IMPORTANT): got command report periodic 1.000000 CTD_NeilBrown.depth 2013-09-17T01:12:54.672Z,1379380374.672 [Reporter](INFO): CTD_NeilBrown.depth no_value 2013-09-17T01:12:55.477Z,1379380375.477 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:55.477Z,1379380375.477 [Reporter](INFO): sea_water_pressure 288.297400 db 2013-09-17T01:12:55.862Z,1379380375.862 [Reporter](INFO): CTD_NeilBrown.depth no_value 2013-09-17T01:12:56.303Z,1379380376.303 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:12:56.303Z,1379380376.303 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:12:56.303Z,1379380376.303 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:12:56.671Z,1379380376.671 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:56.672Z,1379380376.672 [Reporter](INFO): sea_water_pressure 288.293450 db 2013-09-17T01:12:57.071Z,1379380377.071 [Reporter](INFO): CTD_NeilBrown.depth no_value 2013-09-17T01:12:57.876Z,1379380377.876 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:57.877Z,1379380377.877 [Reporter](INFO): sea_water_pressure 288.289975 db 2013-09-17T01:12:58.261Z,1379380378.261 [Reporter](INFO): CTD_NeilBrown.depth no_value 2013-09-17T01:12:58.306Z,1379380378.306 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:12:58.306Z,1379380378.306 [DVL_micro](INFO): Querying output modes 2013-09-17T01:12:58.306Z,1379380378.306 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:12:59.054Z,1379380379.054 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:12:59.055Z,1379380379.055 [Reporter](INFO): sea_water_pressure 288.307425 db 2013-09-17T01:12:59.467Z,1379380379.467 [Reporter](INFO): CTD_NeilBrown.depth no_value 2013-09-17T01:13:00.276Z,1379380380.276 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:13:00.277Z,1379380380.277 [Reporter](INFO): sea_water_pressure 288.286925 db 2013-09-17T01:13:00.317Z,1379380380.317 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:13:00.317Z,1379380380.317 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:13:00.317Z,1379380380.317 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:13:00.673Z,1379380380.673 [Reporter](INFO): CTD_NeilBrown.depth no_value 2013-09-17T01:13:01.466Z,1379380381.466 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value 2013-09-17T01:13:01.467Z,1379380381.467 [Reporter](INFO): sea_water_pressure 288.301325 db 2013-09-17T01:13:01.867Z,1379380381.867 [Reporter](INFO): CTD_NeilBrown.depth no_value 2013-09-17T01:13:02.160Z,1379380382.160 [CommandLine](IMPORTANT): got command report clear 2013-09-17T01:13:02.328Z,1379380382.328 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:13:04.336Z,1379380384.336 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:13:04.336Z,1379380384.336 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:13:06.339Z,1379380386.339 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:13:06.339Z,1379380386.339 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:13:08.349Z,1379380388.349 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:13:08.349Z,1379380388.349 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:13:08.350Z,1379380388.350 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:13:10.352Z,1379380390.352 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:13:10.353Z,1379380390.353 [DVL_micro](INFO): Querying output modes 2013-09-17T01:13:10.353Z,1379380390.353 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:13:12.364Z,1379380392.364 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:13:12.364Z,1379380392.364 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:13:12.364Z,1379380392.364 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:13:14.371Z,1379380394.371 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:13:16.378Z,1379380396.378 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:13:16.378Z,1379380396.378 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:13:18.381Z,1379380398.381 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:13:18.382Z,1379380398.382 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:13:20.388Z,1379380400.388 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:13:20.388Z,1379380400.388 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:13:20.388Z,1379380400.388 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:13:21.899Z,1379380401.899 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadb4 2013-09-17T01:13:22.399Z,1379380402.399 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:13:22.399Z,1379380402.399 [DVL_micro](INFO): Querying output modes 2013-09-17T01:13:22.400Z,1379380402.400 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:13:24.406Z,1379380404.406 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:13:24.406Z,1379380404.406 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:13:24.407Z,1379380404.407 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:13:26.413Z,1379380406.413 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:13:28.425Z,1379380408.425 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:13:28.425Z,1379380408.425 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:13:30.428Z,1379380410.428 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:13:30.428Z,1379380410.428 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:13:32.439Z,1379380412.439 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:13:32.439Z,1379380412.439 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:13:32.439Z,1379380412.439 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:13:34.450Z,1379380414.450 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:13:34.450Z,1379380414.450 [DVL_micro](INFO): Querying output modes 2013-09-17T01:13:34.450Z,1379380414.450 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:13:36.457Z,1379380416.457 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:13:36.457Z,1379380416.457 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:13:36.457Z,1379380416.457 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:13:38.468Z,1379380418.468 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:13:38.649Z,1379380418.649 [MassServo](FAULT): Overload Error 2013-09-17T01:13:38.649Z,1379380418.649 [MassServo] Hardware Fault, FailCount= 2 2013-09-17T01:13:38.649Z,1379380418.649 [MassServo](ERROR): Hardware Fault 2013-09-17T01:13:38.723Z,1379380418.723 [CBIT](ERROR): Hardware Fault in component: MassServo 2013-09-17T01:13:39.018Z,1379380419.018 [MassServo](DEBUG): Uninitialize Mass Servo. 2013-09-17T01:13:39.018Z,1379380419.018 [MassServo](INFO): Powering down 2013-09-17T01:13:39.814Z,1379380419.814 [MassServo](DEBUG): Initializing EZServoServo. 2013-09-17T01:13:39.935Z,1379380419.935 [MassServo](DEBUG): Initializing MassServo. 2013-09-17T01:13:39.965Z,1379380419.965 [CBIT](INFO): Clearing failed state for component MassServo 2013-09-17T01:13:39.965Z,1379380419.965 [MassServo] No Fault, FailCount= 2 2013-09-17T01:13:40.482Z,1379380420.482 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:13:40.482Z,1379380420.482 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:13:42.487Z,1379380422.487 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:13:42.487Z,1379380422.487 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:13:44.488Z,1379380424.488 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:13:44.488Z,1379380424.488 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:13:44.488Z,1379380424.488 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:13:46.496Z,1379380426.496 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:13:46.497Z,1379380426.497 [DVL_micro](INFO): Querying output modes 2013-09-17T01:13:46.497Z,1379380426.497 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:13:48.508Z,1379380428.508 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:13:48.508Z,1379380428.508 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:13:48.508Z,1379380428.508 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:13:50.511Z,1379380430.511 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:13:52.519Z,1379380432.519 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:13:52.519Z,1379380432.519 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:13:54.521Z,1379380434.521 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:13:54.522Z,1379380434.522 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:13:56.524Z,1379380436.524 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:13:56.524Z,1379380436.524 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:13:56.524Z,1379380436.524 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:13:58.531Z,1379380438.531 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:13:58.531Z,1379380438.531 [DVL_micro](INFO): Querying output modes 2013-09-17T01:13:58.531Z,1379380438.531 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:14:00.542Z,1379380440.542 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:14:00.542Z,1379380440.542 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:14:00.543Z,1379380440.543 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:14:02.549Z,1379380442.549 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:14:04.557Z,1379380444.557 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:14:04.557Z,1379380444.557 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:14:06.560Z,1379380446.560 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:14:06.560Z,1379380446.560 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:14:08.571Z,1379380448.571 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:14:08.571Z,1379380448.571 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:14:08.571Z,1379380448.571 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:14:08.711Z,1379380448.711 [CommandLine](IMPORTANT): got command ibit 2013-09-17T01:14:09.069Z,1379380449.069 [IBIT](IMPORTANT): Beginning Initiated BIT 2013-09-17T01:14:09.070Z,1379380449.070 [IBIT](IMPORTANT): Beginning control surface checks. 2013-09-17T01:14:09.071Z,1379380449.071 [CBIT](IMPORTANT): Beginning GF scan 2013-09-17T01:14:10.582Z,1379380450.582 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:14:10.582Z,1379380450.582 [DVL_micro](INFO): Querying output modes 2013-09-17T01:14:10.582Z,1379380450.582 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:14:12.593Z,1379380452.593 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:14:12.593Z,1379380452.593 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:14:12.593Z,1379380452.593 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:14:14.597Z,1379380454.597 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:14:16.604Z,1379380456.604 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:14:16.604Z,1379380456.604 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:14:18.607Z,1379380458.607 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:14:18.607Z,1379380458.607 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:14:20.609Z,1379380460.609 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:14:20.610Z,1379380460.610 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:14:20.610Z,1379380460.610 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:14:22.616Z,1379380462.616 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:14:22.617Z,1379380462.617 [DVL_micro](INFO): Querying output modes 2013-09-17T01:14:22.617Z,1379380462.617 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:14:24.628Z,1379380464.628 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:14:24.628Z,1379380464.628 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:14:24.628Z,1379380464.628 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:14:26.640Z,1379380466.640 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:14:28.647Z,1379380468.647 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:14:28.647Z,1379380468.647 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:14:30.650Z,1379380470.650 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:14:30.651Z,1379380470.651 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0 2013-09-17T01:14:32.652Z,1379380472.652 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:14:32.652Z,1379380472.652 [DVL_micro](INFO): Enabling NQ1 output 2013-09-17T01:14:32.652Z,1379380472.652 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1 2013-09-17T01:14:34.663Z,1379380474.663 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:14:34.663Z,1379380474.663 [DVL_micro](INFO): Querying output modes 2013-09-17T01:14:34.664Z,1379380474.664 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-17T01:14:35.817Z,1379380475.817 [CBIT](IMPORTANT): No ground fault detected 2013-09-17T01:14:36.666Z,1379380476.666 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:14:36.667Z,1379380476.667 [DVL_micro](INFO): Output Modes: No Response 2013-09-17T01:14:36.667Z,1379380476.667 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-17T01:14:38.669Z,1379380478.669 [DVL_micro](DEBUG): cmdResponse: 2013-09-17T01:14:40.677Z,1379380480.677 [DVL_micro](INFO): NQ1 requested 2013-09-17T01:14:40.677Z,1379380480.677 [DVL_micro](INFO): Cycling power to configure device. 2013-09-17T01:14:42.680Z,1379380482.680 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-17T01:14:42.680Z,1379380482.680 [DVL_micro](DEBUG): com