2013-09-14T18:09:47.947Z,1379182187.947 [Supervisor](DEBUG): Initializing supervisor.
2013-09-14T18:09:47.949Z,1379182187.949 [SyncHandler](DEBUG): Created PCaller Thread at 4033B4E0
2013-09-14T18:09:47.950Z,1379182187.950 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2013-09-14T18:09:47.951Z,1379182187.951 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4036B4E0
2013-09-14T18:09:47.955Z,1379182187.955 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2013-09-14T18:09:47.966Z,1379182187.966 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2013-09-14T18:09:47.967Z,1379182187.967 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 4039B4E0
2013-09-14T18:09:47.967Z,1379182187.967 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2013-09-14T18:09:47.968Z,1379182187.968 [logger ThreadHandler](DEBUG): Created PCaller Thread at 403CB4E0
2013-09-14T18:09:47.969Z,1379182187.969 [Supervisor](INFO): Looking for Config files in directory: Config/
2013-09-14T18:09:47.970Z,1379182187.970 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2013-09-14T18:09:48.304Z,1379182188.304 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2013-09-14T18:09:48.305Z,1379182188.305 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2013-09-14T18:09:48.489Z,1379182188.489 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2013-09-14T18:09:48.490Z,1379182188.490 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2013-09-14T18:09:48.569Z,1379182188.569 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2013-09-14T18:09:48.570Z,1379182188.570 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2013-09-14T18:09:48.675Z,1379182188.675 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2013-09-14T18:09:48.676Z,1379182188.676 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2013-09-14T18:09:48.811Z,1379182188.811 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2013-09-14T18:09:48.812Z,1379182188.812 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2013-09-14T18:09:49.114Z,1379182189.114 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2013-09-14T18:09:49.115Z,1379182189.115 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2013-09-14T18:09:49.272Z,1379182189.272 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2013-09-14T18:09:49.273Z,1379182189.273 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2013-09-14T18:09:49.526Z,1379182189.526 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2013-09-14T18:09:49.526Z,1379182189.526 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2013-09-14T18:09:49.624Z,1379182189.624 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2013-09-14T18:09:49.625Z,1379182189.625 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2013-09-14T18:09:50.025Z,1379182190.025 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2013-09-14T18:09:50.026Z,1379182190.026 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2013-09-14T18:09:50.130Z,1379182190.130 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2013-09-14T18:09:50.131Z,1379182190.131 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2013-09-14T18:09:50.213Z,1379182190.213 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2013-09-14T18:09:50.214Z,1379182190.214 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2013-09-14T18:09:50.307Z,1379182190.307 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2013-09-14T18:09:50.427Z,1379182190.427 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2013-09-14T18:09:50.515Z,1379182190.515 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2013-09-14T18:09:50.615Z,1379182190.615 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2013-09-14T18:09:50.705Z,1379182190.705 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2013-09-14T18:09:50.814Z,1379182190.814 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2013-09-14T18:09:50.905Z,1379182190.905 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2013-09-14T18:09:50.985Z,1379182190.985 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/root/
2013-09-14T18:09:50.986Z,1379182190.986 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2013-09-14T18:09:50.987Z,1379182190.987 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2013-09-14T18:09:51.145Z,1379182191.145 [InternalSim] Loaded
2013-09-14T18:09:51.146Z,1379182191.146 [ComponentRegistry](DEBUG): SyncComponent "InternalSim" handled in the control thread.
2013-09-14T18:09:51.146Z,1379182191.146 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2013-09-14T18:09:51.147Z,1379182191.147 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2013-09-14T18:09:51.230Z,1379182191.230 [SBIT](DEBUG): Construct Startup Built In Test.
2013-09-14T18:09:51.258Z,1379182191.258 [SBIT] Loaded
2013-09-14T18:09:51.258Z,1379182191.258 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2013-09-14T18:09:51.259Z,1379182191.259 [IBIT](DEBUG): Construct Initiated Built In Test.
2013-09-14T18:09:51.287Z,1379182191.287 [IBIT] Loaded
2013-09-14T18:09:51.287Z,1379182191.287 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2013-09-14T18:09:51.289Z,1379182191.289 [CBIT](DEBUG): Construct CBIT Built In Test.
2013-09-14T18:09:51.401Z,1379182191.401 [CBIT] Loaded
2013-09-14T18:09:51.401Z,1379182191.401 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2013-09-14T18:09:51.401Z,1379182191.401 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2013-09-14T18:09:51.402Z,1379182191.402 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2013-09-14T18:09:51.567Z,1379182191.567 [BuoyancyServo] Loaded
2013-09-14T18:09:51.567Z,1379182191.567 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2013-09-14T18:09:51.579Z,1379182191.579 [ElevatorServo] Loaded
2013-09-14T18:09:51.579Z,1379182191.579 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2013-09-14T18:09:51.590Z,1379182191.590 [MassServo] Loaded
2013-09-14T18:09:51.590Z,1379182191.590 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2013-09-14T18:09:51.601Z,1379182191.601 [RudderServo] Loaded
2013-09-14T18:09:51.602Z,1379182191.602 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2013-09-14T18:09:51.613Z,1379182191.613 [ThrusterServo] Loaded
2013-09-14T18:09:51.613Z,1379182191.613 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2013-09-14T18:09:51.613Z,1379182191.613 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2013-09-14T18:09:51.614Z,1379182191.614 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2013-09-14T18:09:51.648Z,1379182191.648 [DepthRateCalculator] Loaded
2013-09-14T18:09:51.649Z,1379182191.649 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2013-09-14T18:09:54.789Z,1379182194.789 [HFRadarModelCalc] Loaded
2013-09-14T18:09:54.789Z,1379182194.789 [ComponentRegistry](DEBUG): SyncComponent "HFRadarModelCalc" handled in the control thread.
2013-09-14T18:09:54.805Z,1379182194.805 [NavChart] Loaded
2013-09-14T18:09:54.805Z,1379182194.805 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2013-09-14T18:09:54.811Z,1379182194.811 [PitchRateCalculator] Loaded
2013-09-14T18:09:54.811Z,1379182194.811 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2013-09-14T18:09:54.821Z,1379182194.821 [SpeedCalculator] Loaded
2013-09-14T18:09:54.822Z,1379182194.822 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2013-09-14T18:09:54.846Z,1379182194.846 [TempGradientCalculator] Loaded
2013-09-14T18:09:54.847Z,1379182194.847 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2013-09-14T18:09:54.860Z,1379182194.860 [YawRateCalculator] Loaded
2013-09-14T18:09:54.860Z,1379182194.860 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2013-09-14T18:09:54.910Z,1379182194.910 [Navigation] Loaded
2013-09-14T18:09:54.910Z,1379182194.910 [ComponentRegistry](DEBUG): SyncComponent "Navigation" handled in the control thread.
2013-09-14T18:09:54.911Z,1379182194.911 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2013-09-14T18:09:54.912Z,1379182194.912 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2013-09-14T18:09:55.144Z,1379182195.144 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2013-09-14T18:09:55.145Z,1379182195.145 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2013-09-14T18:09:55.167Z,1379182195.167 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2013-09-14T18:09:55.168Z,1379182195.168 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2013-09-14T18:09:55.214Z,1379182195.214 [VerticalControl](DEBUG): Construct VerticalControl.
2013-09-14T18:09:55.304Z,1379182195.304 [VerticalControl] Loaded
2013-09-14T18:09:55.304Z,1379182195.304 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2013-09-14T18:09:55.305Z,1379182195.305 [HorizontalControl](DEBUG): Construct HorizontalControl.
2013-09-14T18:09:55.361Z,1379182195.361 [HorizontalControl] Loaded
2013-09-14T18:09:55.361Z,1379182195.361 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2013-09-14T18:09:55.362Z,1379182195.362 [SpeedControl](DEBUG): Construct SpeedControl.
2013-09-14T18:09:55.364Z,1379182195.364 [SpeedControl] Loaded
2013-09-14T18:09:55.364Z,1379182195.364 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2013-09-14T18:09:55.365Z,1379182195.365 [LoopControl](DEBUG): Construct LoopControl.
2013-09-14T18:09:55.365Z,1379182195.365 [LoopControl] Loaded
2013-09-14T18:09:55.365Z,1379182195.365 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2013-09-14T18:09:55.366Z,1379182195.366 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2013-09-14T18:09:55.366Z,1379182195.366 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2013-09-14T18:09:55.372Z,1379182195.372 [AsyncPiEstimator](DEBUG): Construct AsyncPiEstimator.
2013-09-14T18:09:55.377Z,1379182195.377 [AsyncPiEstimator] Loaded
2013-09-14T18:09:55.377Z,1379182195.377 [ComponentRegistry](DEBUG): Component "AsyncPiEstimator" handled in its own thread.
2013-09-14T18:09:55.378Z,1379182195.378 [AsyncPiEstimator ThreadHandler](DEBUG): Created PCaller Thread at 406474E0
2013-09-14T18:09:55.379Z,1379182195.379 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2013-09-14T18:09:55.380Z,1379182195.380 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2013-09-14T18:09:55.570Z,1379182195.570 [AHRS_sp3003D] Loaded
2013-09-14T18:09:55.571Z,1379182195.571 [ComponentRegistry](DEBUG): SyncComponent "AHRS_sp3003D" handled in the control thread.
2013-09-14T18:09:55.812Z,1379182195.812 [Batt_Ocean_Server] Loaded
2013-09-14T18:09:55.813Z,1379182195.813 [ComponentRegistry](DEBUG): SyncComponent "Batt_Ocean_Server" handled in the control thread.
2013-09-14T18:09:55.826Z,1379182195.826 [Depth_Keller] Loaded
2013-09-14T18:09:55.826Z,1379182195.826 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2013-09-14T18:09:55.831Z,1379182195.831 [DropWeight] Loaded
2013-09-14T18:09:55.831Z,1379182195.831 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2013-09-14T18:09:56.008Z,1379182196.008 [DVL_micro] Loaded
2013-09-14T18:09:56.009Z,1379182196.009 [ComponentRegistry](DEBUG): Component "DVL_micro" handled in its own thread.
2013-09-14T18:09:56.010Z,1379182196.010 [DVL_micro ThreadHandler](DEBUG): Created PCaller Thread at 406D54E0
2013-09-14T18:09:56.095Z,1379182196.095 [NAL9602] Loaded
2013-09-14T18:09:56.095Z,1379182196.095 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2013-09-14T18:09:56.137Z,1379182196.137 [Onboard] Loaded
2013-09-14T18:09:56.137Z,1379182196.137 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2013-09-14T18:09:56.144Z,1379182196.144 [Radio_Freewave] Loaded
2013-09-14T18:09:56.144Z,1379182196.144 [ComponentRegistry](DEBUG): SyncComponent "Radio_Freewave" handled in the control thread.
2013-09-14T18:09:56.283Z,1379182196.283 [DAT] Loaded
2013-09-14T18:09:56.283Z,1379182196.283 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2013-09-14T18:09:56.283Z,1379182196.283 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2013-09-14T18:09:56.284Z,1379182196.284 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2013-09-14T18:09:56.346Z,1379182196.346 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2013-09-14T18:09:56.348Z,1379182196.348 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2013-09-14T18:09:56.349Z,1379182196.349 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2013-09-14T18:09:56.356Z,1379182196.356 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2013-09-14T18:09:56.357Z,1379182196.357 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 407324E0
2013-09-14T18:09:56.361Z,1379182196.361 [Supervisor](DEBUG): Running supervisor.
2013-09-14T18:09:56.362Z,1379182196.362 [CommandLine](INFO): Thread ID is 8461
2013-09-14T18:09:56.366Z,1379182196.366 [controlThread](INFO): Thread ID is 8460
2013-09-14T18:09:56.366Z,1379182196.366 [controlThread](DEBUG): Initializing ControlThread
2013-09-14T18:09:56.367Z,1379182196.367 [CycleStarter](INFO): Thread ID is 8459
2013-09-14T18:09:56.367Z,1379182196.367 [InternalSim](DEBUG):  InternalSim initializing...
2013-09-14T18:09:56.401Z,1379182196.401 [logger](INFO): Thread ID is 8462
2013-09-14T18:09:56.418Z,1379182196.418 [SBIT](INFO): Initialize SBIT Component.
2013-09-14T18:09:56.418Z,1379182196.418 [SBIT](IMPORTANT): Tethys CM Info: 
$Rev:10573
2013-09-14T18:09:56.418Z,1379182196.418 [SBIT](IMPORTANT): Kernel Release:2.6.27.8
2013-09-14T18:09:56.419Z,1379182196.419 [SBIT](IMPORTANT): Kernel Version:#634 PREEMPT Wed Feb 13 10:21:48 PST 2013
2013-09-14T18:09:56.419Z,1379182196.419 [IBIT](INFO): Initialize IBIT Component.
2013-09-14T18:09:56.420Z,1379182196.420 [CBIT](DEBUG): Initialize CBIT Component.
2013-09-14T18:09:56.420Z,1379182196.420 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL.
2013-09-14T18:09:56.420Z,1379182196.420 [CBIT](CRITICAL): Watchdog Timer failed to initialize.
2013-09-14T18:09:56.421Z,1379182196.421 [CBIT] Hardware Fault, FailCount= 1
2013-09-14T18:09:56.421Z,1379182196.421 [CBIT](ERROR): Hardware Fault
2013-09-14T18:09:56.430Z,1379182196.430 [AsyncPiEstimator](INFO): Thread ID is 8527
2013-09-14T18:09:56.430Z,1379182196.430 [AsyncPiEstimator](DEBUG): Initialize AsyncPiEstimator.
2013-09-14T18:09:56.451Z,1379182196.451 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2013-09-14T18:09:56.451Z,1379182196.451 [NavChart](DEBUG): Initialize NavChart Derivation.
2013-09-14T18:09:56.452Z,1379182196.452 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2013-09-14T18:09:56.452Z,1379182196.452 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2013-09-14T18:09:56.452Z,1379182196.452 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2013-09-14T18:09:56.453Z,1379182196.453 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2013-09-14T18:09:56.453Z,1379182196.453 [Navigation](DEBUG): Initializing Navigation.
2013-09-14T18:09:56.454Z,1379182196.454 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2013-09-14T18:09:56.455Z,1379182196.455 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2013-09-14T18:09:56.456Z,1379182196.456 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2013-09-14T18:09:56.457Z,1379182196.457 [LoopControl](DEBUG): Initialize LoopControlComponent.
2013-09-14T18:09:56.459Z,1379182196.459 [DVL_micro](INFO): Thread ID is 8528
2013-09-14T18:09:56.468Z,1379182196.468 [DVL_micro](INFO): Initializing
2013-09-14T18:09:56.468Z,1379182196.468 [DVL_micro](INFO): start:Powering up
2013-09-14T18:09:56.469Z,1379182196.469 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:09:56.470Z,1379182196.470 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:09:56.487Z,1379182196.487 [NavChartDb](INFO): Thread ID is 8529
2013-09-14T18:09:56.489Z,1379182196.489 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources
2013-09-14T18:09:56.490Z,1379182196.490 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2013-09-14T18:09:56.491Z,1379182196.491 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2013-09-14T18:09:56.491Z,1379182196.491 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2013-09-14T18:09:56.491Z,1379182196.491 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2013-09-14T18:09:56.491Z,1379182196.491 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2013-09-14T18:09:56.492Z,1379182196.492 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2013-09-14T18:09:56.492Z,1379182196.492 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2013-09-14T18:09:56.492Z,1379182196.492 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2013-09-14T18:09:58.529Z,1379182198.529 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:09:58.530Z,1379182198.530 [DVL_micro](INFO): Querying output modes
2013-09-14T18:09:58.530Z,1379182198.530 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:09:58.541Z,1379182198.541 [DVL_micro](DEBUG): cmdResponse: 01 03 16
2013-09-14T18:09:58.541Z,1379182198.541 [DVL_micro](INFO): NQ1 output enabled
2013-09-14T18:09:58.541Z,1379182198.541 [DVL_micro](INFO): RSSI output enabled
2013-09-14T18:09:58.541Z,1379182198.541 [DVL_micro](INFO): ADCP output enabled
2013-09-14T18:09:58.542Z,1379182198.542 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:09:58.553Z,1379182198.553 [DVL_micro](DEBUG): cmdResponse: AUTO_VEL_ON 
2013-09-14T18:09:58.558Z,1379182198.558 [DVL_micro](INFO): pause:Powering down
2013-09-14T18:10:03.024Z,1379182203.024 [Batt_Ocean_Server](ERROR): Batt_Ocean_Server A initialization uart error: serial timeout
2013-09-14T18:10:03.024Z,1379182203.024 [Batt_Ocean_Server](ERROR): Ocean Server Batteries failed to initialize. Re-initializing
2013-09-14T18:10:03.024Z,1379182203.024 [Batt_Ocean_Server] Communications Fault, FailCount= 1
2013-09-14T18:10:03.024Z,1379182203.024 [Batt_Ocean_Server](ERROR): Communications Fault
2013-09-14T18:10:03.031Z,1379182203.031 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2013-09-14T18:10:03.059Z,1379182203.059 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2013-09-14T18:10:03.089Z,1379182203.089 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://aosn.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://aosn.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://aosn.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://aosn.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://aosn.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

    <Guidance:GoToSurface RunIn="Progression"/>

    <Aggregate Id="StartupSatComms" >

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

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

    </Aggregate>

</Mission>


2013-09-14T18:10:03.089Z,1379182203.089 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2013-09-14T18:10:03.167Z,1379182203.167 [MissionManager](INFO): DefineArg Default.NeedGPS = 1 bool
2013-09-14T18:10:03.181Z,1379182203.181 [Default:GPS:A.SetSpeed](DEBUG): Construct.
2013-09-14T18:10:03.186Z,1379182203.186 [Default:GPS:B.GoToSurface](DEBUG): Construct GoToSurface.
2013-09-14T18:10:03.222Z,1379182203.222 [Default:Iridium:A.SetSpeed](DEBUG): Construct.
2013-09-14T18:10:03.225Z,1379182203.225 [Default:Iridium:B.GoToSurface](DEBUG): Construct GoToSurface.
2013-09-14T18:10:03.289Z,1379182203.289 [Default:Iridium:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2013-09-14T18:10:03.330Z,1379182203.330 [Default:D.SetSpeed](DEBUG): Construct.
2013-09-14T18:10:03.333Z,1379182203.333 [Default:E.GoToSurface](DEBUG): Construct GoToSurface.
2013-09-14T18:10:03.357Z,1379182203.357 [Default:F.Wait](DEBUG): Construct Wait.
2013-09-14T18:10:03.377Z,1379182203.377 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
xmlns:Control="Tethys/Control"
xmlns:Guidance="Tethys/Guidance" 
xmlns:Units="Tethys/Units"
xmlns:Universal="Tethys/Universal"
xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
xsi:schemaLocation="Tethys http://aosn.mbari.org/tethys/Xml/Tethys.xsd
Tethys/Control http://aosn.mbari.org/tethys/Xml/Control.xsd
Tethys/Guidance http://aosn.mbari.org/tethys/Xml/Guidance.xsd
Tethys/Units http://aosn.mbari.org/tethys/Xml/Units.xsd
Tethys/Universal http://aosn.mbari.org/tethys/Xml/Universal.xsd"
Id="Default">

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

    <Aggregate Id="GPS" >

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

<!-- Run at high speed -->

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

<!-- Get to the surface -->

        <Guidance:GoToSurface RunIn="Sequence"/>

<!-- Get GPS fix -->

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

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

    </Aggregate>

    <Aggregate Id="Iridium" >

<!-- Run at high speed -->

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

<!-- Get to the surface -->

        <Guidance:GoToSurface RunIn="Sequence"/>

<!-- Do data comms -->

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

    </Aggregate>

    <Aggregate Id="CallIridium" >

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

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

        <Call RefId="Iridium"/>

    </Aggregate>

<!-- Wait forever at the surface-->

<!-- Run at low speed -->

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

    <Guidance:GoToSurface RunIn="Parallel"/>

    <Guidance:Wait RunIn="Sequence"></Guidance:Wait>

</Mission>


2013-09-14T18:10:03.382Z,1379182203.382 [controlThread](DEBUG): Component order: CycleStarter,InternalSim,AHRS_sp3003D,Batt_Ocean_Server,Depth_Keller,DropWeight,NAL9602,Onboard,Radio_Freewave,DAT,Depth_Keller,DepthRateCalculator,HFRadarModelCalc,NavChart,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,Navigation,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,
2013-09-14T18:10:03.521Z,1379182203.521 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D.
2013-09-14T18:10:03.582Z,1379182203.582 [NAL9602](INFO): Powering up NAL9602
2013-09-14T18:10:03.650Z,1379182203.650 [Radio_Freewave](INFO): Powering up
2013-09-14T18:10:03.659Z,1379182203.659 [DAT](INFO): Powering up
2013-09-14T18:10:03.659Z,1379182203.659 [DAT](DEBUG): Initializing DAT.
2013-09-14T18:10:03.954Z,1379182203.954 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2013-09-14T18:10:03.966Z,1379182203.966 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2013-09-14T18:10:03.988Z,1379182203.988 [ElevatorServo](DEBUG): Initializing EZServoServo.
2013-09-14T18:10:03.994Z,1379182203.994 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2013-09-14T18:10:04.048Z,1379182204.048 [MassServo](DEBUG): Initializing EZServoServo.
2013-09-14T18:10:04.054Z,1379182204.054 [MassServo](DEBUG): Initializing MassServo.
2013-09-14T18:10:04.060Z,1379182204.060 [RudderServo](DEBUG): Initializing EZServoServo.
2013-09-14T18:10:04.070Z,1379182204.070 [RudderServo](DEBUG): Initializing RudderServo.
2013-09-14T18:10:04.091Z,1379182204.091 [ThrusterServo](DEBUG): Initializing EZServoServo.
2013-09-14T18:10:04.100Z,1379182204.100 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2013-09-14T18:10:04.194Z,1379182204.194 [CBIT](DEBUG): Uninitialize CBIT Component.
2013-09-14T18:10:04.538Z,1379182204.538 [AHRS_sp3003D](ERROR): readHeadingMagBin UART error: serial timeout
2013-09-14T18:10:04.538Z,1379182204.538 [AHRS_sp3003D](ERROR): readHeadingMagBin got 0xA409A0
2013-09-14T18:10:04.539Z,1379182204.539 [AHRS_sp3003D](ERROR): SP3003D failed to initialize
2013-09-14T18:10:04.539Z,1379182204.539 [AHRS_sp3003D] Hardware Fault, FailCount= 1
2013-09-14T18:10:04.539Z,1379182204.539 [AHRS_sp3003D](ERROR): Hardware Fault
2013-09-14T18:10:04.583Z,1379182204.583 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:10:04.583Z,1379182204.583 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:10:04.583Z,1379182204.583 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:10:04.583Z,1379182204.583 [DVL_micro](INFO): resume:Powering up
2013-09-14T18:10:04.584Z,1379182204.584 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:10:05.123Z,1379182205.123 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2013-09-14T18:10:05.123Z,1379182205.123 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2013-09-14T18:10:05.123Z,1379182205.123 [BuoyancyServo] Communications Fault, FailCount= 1
2013-09-14T18:10:05.123Z,1379182205.123 [BuoyancyServo](ERROR): Communications Fault
2013-09-14T18:10:05.628Z,1379182205.628 [ElevatorServo](ERROR): Elevator initialization uart error I:serial timeout
2013-09-14T18:10:05.628Z,1379182205.628 [ElevatorServo](FAULT): Elevator failed to initialize
2013-09-14T18:10:05.628Z,1379182205.628 [ElevatorServo] Communications Fault, FailCount= 1
2013-09-14T18:10:05.628Z,1379182205.628 [ElevatorServo](ERROR): Communications Fault
2013-09-14T18:10:06.141Z,1379182206.141 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2013-09-14T18:10:06.141Z,1379182206.141 [RudderServo](FAULT): Rudder failed to initialize
2013-09-14T18:10:06.141Z,1379182206.141 [RudderServo] Communications Fault, FailCount= 1
2013-09-14T18:10:06.141Z,1379182206.141 [RudderServo](ERROR): Communications Fault
2013-09-14T18:10:06.590Z,1379182206.590 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:10:06.590Z,1379182206.590 [DVL_micro](INFO): Querying output modes
2013-09-14T18:10:06.590Z,1379182206.590 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:10:06.653Z,1379182206.653 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout
2013-09-14T18:10:07.174Z,1379182207.174 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout
2013-09-14T18:10:07.174Z,1379182207.174 [ThrusterServo](FAULT): Thruster failed to initialize
2013-09-14T18:10:07.174Z,1379182207.174 [ThrusterServo] Communications Fault, FailCount= 1
2013-09-14T18:10:07.175Z,1379182207.175 [ThrusterServo](ERROR): Communications Fault
2013-09-14T18:10:07.279Z,1379182207.279 [AHRS_sp3003D](INFO): Powering down
2013-09-14T18:10:07.429Z,1379182207.429 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2013-09-14T18:10:07.430Z,1379182207.430 [BuoyancyServo](INFO): Powering down
2013-09-14T18:10:07.491Z,1379182207.491 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2013-09-14T18:10:07.491Z,1379182207.491 [ElevatorServo](INFO): Powering down
2013-09-14T18:10:08.064Z,1379182208.064 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout
2013-09-14T18:10:08.064Z,1379182208.064 [MassServo] Communications Fault, FailCount= 1
2013-09-14T18:10:08.064Z,1379182208.064 [MassServo](ERROR): Communications Fault
2013-09-14T18:10:08.064Z,1379182208.064 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2013-09-14T18:10:08.065Z,1379182208.065 [RudderServo](INFO): Powering down
2013-09-14T18:10:08.083Z,1379182208.083 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2013-09-14T18:10:08.084Z,1379182208.084 [ThrusterServo](INFO): Powering down
2013-09-14T18:10:08.271Z,1379182208.271 [MassServo](DEBUG): Uninitialize Mass Servo.
2013-09-14T18:10:08.271Z,1379182208.271 [MassServo](INFO): Powering down
2013-09-14T18:10:08.596Z,1379182208.596 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:10:08.597Z,1379182208.597 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:10:08.597Z,1379182208.597 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:10:08.663Z,1379182208.663 [ElevatorServo](DEBUG): Initializing EZServoServo.
2013-09-14T18:10:08.778Z,1379182208.778 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2013-09-14T18:10:08.780Z,1379182208.780 [RudderServo](DEBUG): Initializing EZServoServo.
2013-09-14T18:10:08.898Z,1379182208.898 [RudderServo](DEBUG): Initializing RudderServo.
2013-09-14T18:10:10.605Z,1379182210.605 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:10:10.606Z,1379182210.606 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:10:10.607Z,1379182210.607 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:10:10.607Z,1379182210.607 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:10:11.872Z,1379182211.872 [SBIT](IMPORTANT): Beginning Startup BIT
2013-09-14T18:10:12.611Z,1379182212.611 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:10:12.612Z,1379182212.612 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:10:14.626Z,1379182214.626 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:10:14.626Z,1379182214.626 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:10:14.626Z,1379182214.626 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:10:16.256Z,1379182216.256 [NAL9602](ERROR): NAL9602 initialize uart error: serial timeout
2013-09-14T18:10:16.256Z,1379182216.256 [NAL9602] Communications Fault, FailCount= 1
2013-09-14T18:10:16.256Z,1379182216.256 [NAL9602](ERROR): Communications Fault
2013-09-14T18:10:16.426Z,1379182216.426 [NAL9602](INFO): Powering down
2013-09-14T18:10:16.637Z,1379182216.637 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:10:16.637Z,1379182216.637 [DVL_micro](INFO): Querying output modes
2013-09-14T18:10:16.637Z,1379182216.637 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:10:18.640Z,1379182218.640 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:10:18.640Z,1379182218.640 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:10:18.640Z,1379182218.640 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:10:20.643Z,1379182220.643 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:10:22.651Z,1379182222.651 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:10:22.651Z,1379182222.651 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:10:22.651Z,1379182222.651 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:10:23.091Z,1379182223.091 [DAT](INFO): Init failed - response: 
2013-09-14T18:10:23.091Z,1379182223.091 [DAT](FAULT): DAT failed to initialize
2013-09-14T18:10:23.091Z,1379182223.091 [DAT] Communications Fault, FailCount= 1
2013-09-14T18:10:23.091Z,1379182223.091 [DAT](ERROR): Communications Fault
2013-09-14T18:10:23.278Z,1379182223.278 [DAT](INFO): Powering down
2013-09-14T18:10:24.654Z,1379182224.654 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:10:24.654Z,1379182224.654 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:10:26.656Z,1379182226.656 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:10:26.656Z,1379182226.656 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:10:26.657Z,1379182226.657 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:10:28.668Z,1379182228.668 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:10:28.668Z,1379182228.668 [DVL_micro](INFO): Querying output modes
2013-09-14T18:10:28.668Z,1379182228.668 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:10:30.679Z,1379182230.679 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:10:30.679Z,1379182230.679 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:10:30.679Z,1379182230.679 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:10:32.682Z,1379182232.682 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:10:34.686Z,1379182234.686 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:10:34.686Z,1379182234.686 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:10:34.686Z,1379182234.686 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:10:36.688Z,1379182236.688 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:10:36.689Z,1379182236.689 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:10:38.699Z,1379182238.699 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:10:38.699Z,1379182238.699 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:10:38.699Z,1379182238.699 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:10:40.702Z,1379182240.702 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:10:40.702Z,1379182240.702 [DVL_micro](INFO): Querying output modes
2013-09-14T18:10:40.702Z,1379182240.702 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:10:42.713Z,1379182242.713 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:10:42.713Z,1379182242.713 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:10:42.714Z,1379182242.714 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:10:44.724Z,1379182244.724 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:10:46.736Z,1379182246.736 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:10:46.736Z,1379182246.736 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:10:46.736Z,1379182246.736 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:10:48.739Z,1379182248.739 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:10:48.739Z,1379182248.739 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:10:50.746Z,1379182250.746 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:10:50.746Z,1379182250.746 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:10:50.746Z,1379182250.746 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:10:52.765Z,1379182252.765 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:10:52.765Z,1379182252.765 [DVL_micro](INFO): Querying output modes
2013-09-14T18:10:52.765Z,1379182252.765 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:10:54.776Z,1379182254.776 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:10:54.776Z,1379182254.776 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:10:54.776Z,1379182254.776 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:10:56.779Z,1379182256.779 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:10:58.787Z,1379182258.787 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:10:58.787Z,1379182258.787 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:10:58.787Z,1379182258.787 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:11:00.790Z,1379182260.790 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:11:00.790Z,1379182260.790 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:11:02.796Z,1379182262.796 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:11:02.797Z,1379182262.797 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:11:02.797Z,1379182262.797 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:11:04.824Z,1379182264.824 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:11:04.824Z,1379182264.824 [DVL_micro](INFO): Querying output modes
2013-09-14T18:11:04.824Z,1379182264.824 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:11:05.991Z,1379182265.991 [SBIT](IMPORTANT): SBIT PASSED
2013-09-14T18:11:06.376Z,1379182266.376 [MissionManager](IMPORTANT): Started mission Startup
2013-09-14T18:11:06.376Z,1379182266.376 [Startup] Running Loop=1
2013-09-14T18:11:06.376Z,1379182266.376 [Startup](INFO): Aggregate::initialize Startup
2013-09-14T18:11:06.376Z,1379182266.376 [Startup:A.GoToSurface] Running Loop=1
2013-09-14T18:11:06.376Z,1379182266.376 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-09-14T18:11:06.382Z,1379182266.382 [Startup:StartupSatComms] Running Loop=1
2013-09-14T18:11:06.382Z,1379182266.382 [Startup:StartupSatComms](INFO): Aggregate::initialize Startup:StartupSatComms
2013-09-14T18:11:06.382Z,1379182266.382 [Startup:StartupSatComms:A] Running Loop=1
2013-09-14T18:11:06.789Z,1379182266.789 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2013-09-14T18:11:06.835Z,1379182266.835 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:11:06.835Z,1379182266.835 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:11:06.835Z,1379182266.835 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:11:08.842Z,1379182268.842 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:11:10.849Z,1379182270.849 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:11:10.849Z,1379182270.849 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:11:10.850Z,1379182270.850 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:11:12.852Z,1379182272.852 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:11:12.853Z,1379182272.853 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:11:14.863Z,1379182274.863 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:11:14.863Z,1379182274.863 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:11:14.863Z,1379182274.863 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:11:16.870Z,1379182276.870 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:11:16.870Z,1379182276.870 [DVL_micro](INFO): Querying output modes
2013-09-14T18:11:16.871Z,1379182276.871 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:11:18.881Z,1379182278.881 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:11:18.881Z,1379182278.881 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:11:18.882Z,1379182278.882 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:11:20.897Z,1379182280.897 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:11:22.905Z,1379182282.905 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:11:22.905Z,1379182282.905 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:11:22.905Z,1379182282.905 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:11:24.911Z,1379182284.911 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:11:24.911Z,1379182284.911 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:11:26.922Z,1379182286.922 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:11:26.922Z,1379182286.922 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:11:26.922Z,1379182286.922 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:11:28.929Z,1379182288.929 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:11:28.929Z,1379182288.929 [DVL_micro](INFO): Querying output modes
2013-09-14T18:11:28.929Z,1379182288.929 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:11:30.940Z,1379182290.940 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:11:30.940Z,1379182290.940 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:11:30.940Z,1379182290.940 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:11:32.943Z,1379182292.943 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:11:34.955Z,1379182294.955 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:11:34.955Z,1379182294.955 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:11:34.955Z,1379182294.955 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:11:36.958Z,1379182296.958 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:11:36.958Z,1379182296.958 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:11:38.968Z,1379182298.968 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:11:38.969Z,1379182298.969 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:11:38.969Z,1379182298.969 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:11:40.976Z,1379182300.976 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:11:40.976Z,1379182300.976 [DVL_micro](INFO): Querying output modes
2013-09-14T18:11:40.976Z,1379182300.976 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:11:42.979Z,1379182302.979 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:11:42.979Z,1379182302.979 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:11:42.979Z,1379182302.979 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:11:44.982Z,1379182304.982 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:11:46.990Z,1379182306.990 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:11:46.990Z,1379182306.990 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:11:46.990Z,1379182306.990 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:11:48.992Z,1379182308.992 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:11:48.993Z,1379182308.993 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:11:51.003Z,1379182311.003 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:11:51.003Z,1379182311.003 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:11:51.003Z,1379182311.003 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:11:53.014Z,1379182313.014 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:11:53.014Z,1379182313.014 [DVL_micro](INFO): Querying output modes
2013-09-14T18:11:53.015Z,1379182313.015 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:11:55.025Z,1379182315.025 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:11:55.025Z,1379182315.025 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:11:55.026Z,1379182315.026 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:11:57.037Z,1379182317.037 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:11:59.040Z,1379182319.040 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:11:59.040Z,1379182319.040 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:11:59.040Z,1379182319.040 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:12:01.043Z,1379182321.043 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:12:01.044Z,1379182321.044 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:12:03.050Z,1379182323.050 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:12:03.050Z,1379182323.050 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:12:03.050Z,1379182323.050 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:12:05.057Z,1379182325.057 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:12:05.057Z,1379182325.057 [DVL_micro](INFO): Querying output modes
2013-09-14T18:12:05.057Z,1379182325.057 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:12:06.802Z,1379182326.802 [Startup:StartupSatComms:A](INFO): Timed out from 2013-09-14T18:11:06.4Z
2013-09-14T18:12:06.802Z,1379182326.802 [Startup:StartupSatComms:A:A_Timeout] Running Loop=1
2013-09-14T18:12:06.802Z,1379182326.802 [Startup:StartupSatComms:A:A_Timeout](INFO): Aggregate::initialize Startup:StartupSatComms:A:A_Timeout
2013-09-14T18:12:06.802Z,1379182326.802 [Startup:StartupSatComms:A:A_Timeout](INFO): Completed Startup:StartupSatComms:A:A_Timeout
2013-09-14T18:12:06.803Z,1379182326.803 [Startup:StartupSatComms:A] Stopped
2013-09-14T18:12:06.803Z,1379182326.803 [Startup:StartupSatComms:B] Running Loop=1
2013-09-14T18:12:07.068Z,1379182327.068 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:12:07.068Z,1379182327.068 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:12:07.068Z,1379182327.068 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:12:07.179Z,1379182327.179 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2013-09-14T18:12:09.075Z,1379182329.075 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:12:11.079Z,1379182331.079 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:12:11.079Z,1379182331.079 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:12:11.079Z,1379182331.079 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:12:13.082Z,1379182333.082 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:12:13.082Z,1379182333.082 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:12:15.092Z,1379182335.092 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:12:15.093Z,1379182335.093 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:12:15.093Z,1379182335.093 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:12:17.104Z,1379182337.104 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:12:17.104Z,1379182337.104 [DVL_micro](INFO): Querying output modes
2013-09-14T18:12:17.104Z,1379182337.104 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:12:19.115Z,1379182339.115 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:12:19.115Z,1379182339.115 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:12:19.115Z,1379182339.115 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:12:21.126Z,1379182341.126 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:12:23.137Z,1379182343.137 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:12:23.138Z,1379182343.138 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:12:23.138Z,1379182343.138 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:12:25.140Z,1379182345.140 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:12:25.141Z,1379182345.141 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:12:27.147Z,1379182347.147 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:12:27.147Z,1379182347.147 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:12:27.148Z,1379182347.148 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:12:29.150Z,1379182349.150 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:12:29.150Z,1379182349.150 [DVL_micro](INFO): Querying output modes
2013-09-14T18:12:29.151Z,1379182349.151 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:12:31.166Z,1379182351.166 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:12:31.166Z,1379182351.166 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:12:31.166Z,1379182351.166 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:12:33.173Z,1379182353.173 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:12:35.180Z,1379182355.180 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:12:35.181Z,1379182355.181 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:12:35.181Z,1379182355.181 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:12:37.183Z,1379182357.183 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:12:37.184Z,1379182357.184 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:12:39.190Z,1379182359.190 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:12:39.190Z,1379182359.190 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:12:39.190Z,1379182359.190 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:12:41.197Z,1379182361.197 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:12:41.197Z,1379182361.197 [DVL_micro](INFO): Querying output modes
2013-09-14T18:12:41.197Z,1379182361.197 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:12:43.220Z,1379182363.220 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:12:43.220Z,1379182363.220 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:12:43.221Z,1379182363.221 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:12:45.229Z,1379182365.229 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:12:47.239Z,1379182367.239 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:12:47.239Z,1379182367.239 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:12:47.239Z,1379182367.239 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:12:49.242Z,1379182369.242 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:12:49.242Z,1379182369.242 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:12:51.245Z,1379182371.245 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:12:51.245Z,1379182371.245 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:12:51.245Z,1379182371.245 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:12:53.256Z,1379182373.256 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:12:53.256Z,1379182373.256 [DVL_micro](INFO): Querying output modes
2013-09-14T18:12:53.256Z,1379182373.256 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:12:55.263Z,1379182375.263 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:12:55.263Z,1379182375.263 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:12:55.263Z,1379182375.263 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:12:57.270Z,1379182377.270 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:12:59.282Z,1379182379.282 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:12:59.282Z,1379182379.282 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:12:59.282Z,1379182379.282 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:13:01.285Z,1379182381.285 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:13:01.285Z,1379182381.285 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:13:03.287Z,1379182383.287 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:13:03.287Z,1379182383.287 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:13:03.288Z,1379182383.288 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:13:05.298Z,1379182385.298 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:13:05.298Z,1379182385.298 [DVL_micro](INFO): Querying output modes
2013-09-14T18:13:05.299Z,1379182385.299 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:13:07.179Z,1379182387.179 [Startup:StartupSatComms:B](INFO): Timed out from 2013-09-14T18:12:06.8Z
2013-09-14T18:13:07.179Z,1379182387.179 [Startup:StartupSatComms:B:A_Timeout] Running Loop=1
2013-09-14T18:13:07.179Z,1379182387.179 [Startup:StartupSatComms:B:A_Timeout](INFO): Aggregate::initialize Startup:StartupSatComms:B:A_Timeout
2013-09-14T18:13:07.180Z,1379182387.180 [Startup:StartupSatComms:B:A_Timeout](INFO): Completed Startup:StartupSatComms:B:A_Timeout
2013-09-14T18:13:07.180Z,1379182387.180 [Startup:StartupSatComms:B] Stopped
2013-09-14T18:13:07.180Z,1379182387.180 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2013-09-14T18:13:07.180Z,1379182387.180 [Startup:StartupSatComms] Stopped
2013-09-14T18:13:07.180Z,1379182387.180 [Startup:StartupSatComms](INFO): Aggregate::uninitialize Startup:StartupSatComms
2013-09-14T18:13:07.181Z,1379182387.181 [Startup](INFO): Completed Startup
2013-09-14T18:13:07.181Z,1379182387.181 [Startup] Stopped
2013-09-14T18:13:07.181Z,1379182387.181 [Startup](INFO): Aggregate::uninitialize Startup
2013-09-14T18:13:07.181Z,1379182387.181 [Startup:A.GoToSurface] Stopped
2013-09-14T18:13:07.181Z,1379182387.181 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-09-14T18:13:07.306Z,1379182387.306 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:13:07.306Z,1379182387.306 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:13:07.306Z,1379182387.306 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:13:07.580Z,1379182387.580 [MissionManager](IMPORTANT): Started mission Default
2013-09-14T18:13:07.580Z,1379182387.580 [Default] Running Loop=1
2013-09-14T18:13:07.580Z,1379182387.580 [Default](INFO): Aggregate::initialize Default
2013-09-14T18:13:07.580Z,1379182387.580 [Default:D.SetSpeed] Running Loop=1
2013-09-14T18:13:07.580Z,1379182387.580 [Default:D.SetSpeed](DEBUG): Initialize.
2013-09-14T18:13:07.580Z,1379182387.580 [Default:E.GoToSurface] Running Loop=1
2013-09-14T18:13:07.580Z,1379182387.580 [Default:E.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-09-14T18:13:07.581Z,1379182387.581 [Default:Iridium] Running Loop=1
2013-09-14T18:13:07.581Z,1379182387.581 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2013-09-14T18:13:07.581Z,1379182387.581 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-09-14T18:13:07.581Z,1379182387.581 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2013-09-14T18:13:07.581Z,1379182387.581 [Default:Iridium:B.GoToSurface] Running Loop=1
2013-09-14T18:13:07.581Z,1379182387.581 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-09-14T18:13:07.582Z,1379182387.582 [Default:E.GoToSurface] Running Loop=1
2013-09-14T18:13:07.587Z,1379182387.587 [Default:D.SetSpeed] Running Loop=1
2013-09-14T18:13:07.592Z,1379182387.592 [Default:CallIridium] Running Loop=1
2013-09-14T18:13:07.592Z,1379182387.592 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2013-09-14T18:13:07.592Z,1379182387.592 [Default:CallIridium:A] Running Loop=1
2013-09-14T18:13:07.595Z,1379182387.595 [Default:CallIridium:A] Stopped
2013-09-14T18:13:07.595Z,1379182387.595 [Default:CallIridium:B] Running Loop=1
2013-09-14T18:13:07.595Z,1379182387.595 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2013-09-14T18:13:07.601Z,1379182387.601 [Default:Iridium:B.GoToSurface] Stopped
2013-09-14T18:13:07.601Z,1379182387.601 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-09-14T18:13:07.601Z,1379182387.601 [Default:Iridium:Read_Iridium] Running Loop=1
2013-09-14T18:13:07.601Z,1379182387.601 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-09-14T18:13:07.621Z,1379182387.621 [Default:GPS] Running Loop=1
2013-09-14T18:13:07.621Z,1379182387.621 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2013-09-14T18:13:07.621Z,1379182387.621 [Default:GPS:A.SetSpeed] Running Loop=1
2013-09-14T18:13:07.621Z,1379182387.621 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2013-09-14T18:13:07.621Z,1379182387.621 [Default:GPS:B.GoToSurface] Running Loop=1
2013-09-14T18:13:07.621Z,1379182387.621 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-09-14T18:13:07.627Z,1379182387.627 [Default:GPS:B.GoToSurface] Stopped
2013-09-14T18:13:07.627Z,1379182387.627 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-09-14T18:13:07.628Z,1379182387.628 [Default:GPS:Read_GPS] Running Loop=1
2013-09-14T18:13:07.628Z,1379182387.628 [Default:GPS:A.SetSpeed] Running Loop=1
2013-09-14T18:13:07.978Z,1379182387.978 [Default:Iridium:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2013-09-14T18:13:07.980Z,1379182387.980 [Default:GPS:Read_GPS](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2013-09-14T18:13:09.309Z,1379182389.309 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:13:11.320Z,1379182391.320 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:13:11.320Z,1379182391.320 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:13:11.321Z,1379182391.321 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:13:12.169Z,1379182392.169 [CommandLine](IMPORTANT): got command ibit
2013-09-14T18:13:12.383Z,1379182392.383 [IBIT](IMPORTANT): Beginning Initiated BIT
2013-09-14T18:13:12.383Z,1379182392.383 [IBIT](IMPORTANT): Beginning control surface checks.

2013-09-14T18:13:13.323Z,1379182393.323 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:13:13.323Z,1379182393.323 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:13:15.334Z,1379182395.334 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:13:15.334Z,1379182395.334 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:13:15.334Z,1379182395.334 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:13:17.345Z,1379182397.345 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:13:17.345Z,1379182397.345 [DVL_micro](INFO): Querying output modes
2013-09-14T18:13:17.345Z,1379182397.345 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:13:19.356Z,1379182399.356 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:13:19.356Z,1379182399.356 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:13:19.356Z,1379182399.356 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:13:21.359Z,1379182401.359 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:13:23.363Z,1379182403.363 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:13:23.363Z,1379182403.363 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:13:23.363Z,1379182403.363 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:13:25.366Z,1379182405.366 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:13:25.366Z,1379182405.366 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:13:27.377Z,1379182407.377 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:13:27.377Z,1379182407.377 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:13:27.377Z,1379182407.377 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:13:29.388Z,1379182409.388 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:13:29.388Z,1379182409.388 [DVL_micro](INFO): Querying output modes
2013-09-14T18:13:29.388Z,1379182409.388 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:13:31.391Z,1379182411.391 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:13:31.391Z,1379182411.391 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:13:31.391Z,1379182411.391 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:13:33.403Z,1379182413.403 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:13:35.407Z,1379182415.407 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:13:35.407Z,1379182415.407 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:13:35.407Z,1379182415.407 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:13:37.412Z,1379182417.412 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:13:37.413Z,1379182417.413 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:13:39.415Z,1379182419.415 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:13:39.415Z,1379182419.415 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:13:39.416Z,1379182419.416 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:13:41.426Z,1379182421.426 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:13:41.426Z,1379182421.426 [DVL_micro](INFO): Querying output modes
2013-09-14T18:13:41.427Z,1379182421.427 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:13:43.437Z,1379182423.437 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:13:43.438Z,1379182423.438 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:13:43.438Z,1379182423.438 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:13:45.449Z,1379182425.449 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:13:47.452Z,1379182427.452 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:13:47.452Z,1379182427.452 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:13:47.452Z,1379182427.452 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:13:49.455Z,1379182429.455 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:13:49.455Z,1379182429.455 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:13:51.466Z,1379182431.466 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:13:51.466Z,1379182431.466 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:13:51.466Z,1379182431.466 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:13:53.477Z,1379182433.477 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:13:53.477Z,1379182433.477 [DVL_micro](INFO): Querying output modes
2013-09-14T18:13:53.477Z,1379182433.477 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:13:55.488Z,1379182435.488 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:13:55.488Z,1379182435.488 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:13:55.488Z,1379182435.488 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:13:57.499Z,1379182437.499 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:13:59.505Z,1379182439.505 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:13:59.505Z,1379182439.505 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:13:59.505Z,1379182439.505 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:14:01.510Z,1379182441.510 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:14:01.510Z,1379182441.510 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:14:03.521Z,1379182443.521 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:14:03.521Z,1379182443.521 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:14:03.521Z,1379182443.521 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:14:05.524Z,1379182445.524 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:14:05.524Z,1379182445.524 [DVL_micro](INFO): Querying output modes
2013-09-14T18:14:05.524Z,1379182445.524 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:14:07.531Z,1379182447.531 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:14:07.531Z,1379182447.531 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:14:07.531Z,1379182447.531 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:14:09.534Z,1379182449.534 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:14:11.538Z,1379182451.538 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:14:11.538Z,1379182451.538 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:14:11.538Z,1379182451.538 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:14:13.541Z,1379182453.541 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:14:13.541Z,1379182453.541 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:14:15.543Z,1379182455.543 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:14:15.543Z,1379182455.543 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:14:15.544Z,1379182455.544 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:14:17.546Z,1379182457.546 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:14:17.546Z,1379182457.546 [DVL_micro](INFO): Querying output modes
2013-09-14T18:14:17.547Z,1379182457.547 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:14:19.558Z,1379182459.558 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:14:19.558Z,1379182459.558 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:14:19.558Z,1379182459.558 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:14:21.560Z,1379182461.560 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:14:23.572Z,1379182463.572 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:14:23.572Z,1379182463.572 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:14:23.572Z,1379182463.572 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:14:25.575Z,1379182465.575 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:14:25.576Z,1379182465.576 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:14:27.586Z,1379182467.586 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:14:27.586Z,1379182467.586 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:14:27.586Z,1379182467.586 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:14:29.597Z,1379182469.597 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:14:29.597Z,1379182469.597 [DVL_micro](INFO): Querying output modes
2013-09-14T18:14:29.597Z,1379182469.597 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:14:31.612Z,1379182471.612 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:14:31.612Z,1379182471.612 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:14:31.613Z,1379182471.613 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:14:33.623Z,1379182473.623 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:14:35.635Z,1379182475.635 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:14:35.635Z,1379182475.635 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:14:35.635Z,1379182475.635 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:14:37.638Z,1379182477.638 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:14:37.638Z,1379182477.638 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:14:39.649Z,1379182479.649 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:14:39.649Z,1379182479.649 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:14:39.649Z,1379182479.649 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:14:41.656Z,1379182481.656 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:14:41.656Z,1379182481.656 [DVL_micro](INFO): Querying output modes
2013-09-14T18:14:41.656Z,1379182481.656 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:14:43.659Z,1379182483.659 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:14:43.659Z,1379182483.659 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:14:43.659Z,1379182483.659 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:14:45.670Z,1379182485.670 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:14:47.682Z,1379182487.682 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:14:47.682Z,1379182487.682 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:14:47.682Z,1379182487.682 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:14:49.685Z,1379182489.685 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:14:49.685Z,1379182489.685 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:14:51.695Z,1379182491.695 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:14:51.695Z,1379182491.695 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:14:51.696Z,1379182491.696 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:14:53.698Z,1379182493.698 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:14:53.699Z,1379182493.699 [DVL_micro](INFO): Querying output modes
2013-09-14T18:14:53.699Z,1379182493.699 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:14:55.710Z,1379182495.710 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:14:55.710Z,1379182495.710 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:14:55.710Z,1379182495.710 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:14:57.721Z,1379182497.721 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:14:59.729Z,1379182499.729 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:14:59.729Z,1379182499.729 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:14:59.729Z,1379182499.729 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:15:01.731Z,1379182501.731 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:15:01.732Z,1379182501.732 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:15:03.183Z,1379182503.183 [IBIT](FAULT): Error acquiring IBIT communications status. Timeout expired.
2013-09-14T18:15:03.580Z,1379182503.580 [IBIT](FAULT): Warning: Battery Data not active. Expected only when running primaries. Threshold checking not active.
2013-09-14T18:15:03.742Z,1379182503.742 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:15:03.742Z,1379182503.742 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:15:03.742Z,1379182503.742 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:15:03.982Z,1379182503.982 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 %
2013-09-14T18:15:03.982Z,1379182503.982 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi
2013-09-14T18:15:03.983Z,1379182503.983 [IBIT](ERROR): Pressure failed. Onboard reading:14.451184 PSI
2013-09-14T18:15:03.983Z,1379182503.983 [IBIT](IMPORTANT): Humidity:39.244080 %
2013-09-14T18:15:04.381Z,1379182504.381 [IBIT](IMPORTANT): surfaceThreshold: 0.500000 m
2013-09-14T18:15:04.382Z,1379182504.382 [IBIT](IMPORTANT): buoyancyNeutral: 400.000000 cc
2013-09-14T18:15:04.382Z,1379182504.382 [IBIT](IMPORTANT): massDefault: 0.000000 cm
2013-09-14T18:15:04.382Z,1379182504.382 [IBIT](IMPORTANT): stopDepth: 112.000000 m
2013-09-14T18:15:04.383Z,1379182504.383 [IBIT](IMPORTANT): abortDepth: 130.000000 m
2013-09-14T18:15:04.383Z,1379182504.383 [IBIT](IMPORTANT): IBIT FAILED
2013-09-14T18:15:05.753Z,1379182505.753 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:15:05.753Z,1379182505.753 [DVL_micro](INFO): Querying output modes
2013-09-14T18:15:05.753Z,1379182505.753 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:15:07.767Z,1379182507.767 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:15:07.767Z,1379182507.767 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:15:07.767Z,1379182507.767 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:15:09.767Z,1379182509.767 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:15:11.779Z,1379182511.779 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:15:11.779Z,1379182511.779 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:15:11.779Z,1379182511.779 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:15:13.782Z,1379182513.782 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:15:13.783Z,1379182513.783 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:15:15.793Z,1379182515.793 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:15:15.793Z,1379182515.793 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:15:15.793Z,1379182515.793 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:15:17.806Z,1379182517.806 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:15:17.806Z,1379182517.806 [DVL_micro](INFO): Querying output modes
2013-09-14T18:15:17.806Z,1379182517.806 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:15:19.807Z,1379182519.807 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:15:19.807Z,1379182519.807 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:15:19.807Z,1379182519.807 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:15:21.814Z,1379182521.814 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:15:23.818Z,1379182523.818 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:15:23.818Z,1379182523.818 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:15:23.818Z,1379182523.818 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:15:25.821Z,1379182525.821 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:15:25.821Z,1379182525.821 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:15:27.827Z,1379182527.827 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:15:27.827Z,1379182527.827 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:15:27.828Z,1379182527.828 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:15:29.838Z,1379182529.838 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:15:29.839Z,1379182529.839 [DVL_micro](INFO): Querying output modes
2013-09-14T18:15:29.839Z,1379182529.839 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:15:31.842Z,1379182531.842 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:15:31.842Z,1379182531.842 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:15:31.842Z,1379182531.842 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:15:33.853Z,1379182533.853 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:15:35.856Z,1379182535.856 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:15:35.856Z,1379182535.856 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:15:35.857Z,1379182535.857 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:15:37.859Z,1379182537.859 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:15:37.860Z,1379182537.860 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:15:39.862Z,1379182539.862 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:15:39.862Z,1379182539.862 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:15:39.862Z,1379182539.862 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:15:41.865Z,1379182541.865 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:15:41.865Z,1379182541.865 [DVL_micro](INFO): Querying output modes
2013-09-14T18:15:41.865Z,1379182541.865 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:15:43.876Z,1379182543.876 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:15:43.876Z,1379182543.876 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:15:43.877Z,1379182543.876 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:15:45.883Z,1379182545.883 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:15:47.895Z,1379182547.895 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:15:47.895Z,1379182547.895 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:15:47.895Z,1379182547.895 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:15:49.898Z,1379182549.898 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:15:49.898Z,1379182549.898 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:15:51.901Z,1379182551.901 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:15:51.901Z,1379182551.901 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:15:51.901Z,1379182551.901 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:15:53.912Z,1379182553.912 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:15:53.912Z,1379182553.912 [DVL_micro](INFO): Querying output modes
2013-09-14T18:15:53.912Z,1379182553.912 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:15:55.919Z,1379182555.919 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:15:55.919Z,1379182555.919 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:15:55.919Z,1379182555.919 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:15:57.926Z,1379182557.926 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:15:59.938Z,1379182559.938 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:15:59.938Z,1379182559.938 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:15:59.938Z,1379182559.938 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:16:01.941Z,1379182561.941 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:16:01.941Z,1379182561.941 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:16:03.947Z,1379182563.947 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:16:03.947Z,1379182563.947 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:16:03.948Z,1379182563.948 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:16:05.963Z,1379182565.963 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:16:05.964Z,1379182565.964 [DVL_micro](INFO): Querying output modes
2013-09-14T18:16:05.964Z,1379182565.964 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:16:07.974Z,1379182567.974 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:16:07.974Z,1379182567.974 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:16:07.974Z,1379182567.974 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:16:09.985Z,1379182569.985 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:16:11.996Z,1379182571.996 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:16:11.997Z,1379182571.997 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:16:11.997Z,1379182571.997 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:16:13.999Z,1379182573.999 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:16:13.000Z,1379182574.000 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:16:16.014Z,1379182576.014 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:16:16.014Z,1379182576.014 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:16:16.014Z,1379182576.014 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:16:18.021Z,1379182578.021 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:16:18.021Z,1379182578.021 [DVL_micro](INFO): Querying output modes
2013-09-14T18:16:18.021Z,1379182578.021 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:16:20.032Z,1379182580.032 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:16:20.033Z,1379182580.033 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:16:20.033Z,1379182580.033 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:16:22.035Z,1379182582.035 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:16:24.047Z,1379182584.047 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:16:24.047Z,1379182584.047 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:16:24.047Z,1379182584.047 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:16:26.050Z,1379182586.050 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:16:26.050Z,1379182586.050 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:16:28.061Z,1379182588.061 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:16:28.061Z,1379182588.061 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:16:28.061Z,1379182588.061 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:16:30.072Z,1379182590.072 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:16:30.072Z,1379182590.072 [DVL_micro](INFO): Querying output modes
2013-09-14T18:16:30.072Z,1379182590.072 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:16:32.083Z,1379182592.083 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:16:32.083Z,1379182592.083 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:16:32.083Z,1379182592.083 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:16:34.094Z,1379182594.094 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:16:36.107Z,1379182596.107 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:16:36.108Z,1379182596.108 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:16:36.108Z,1379182596.108 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:16:38.113Z,1379182598.113 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:16:38.113Z,1379182598.113 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:16:40.123Z,1379182600.123 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:16:40.124Z,1379182600.124 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:16:40.124Z,1379182600.124 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:16:42.127Z,1379182602.127 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:16:42.127Z,1379182602.127 [DVL_micro](INFO): Querying output modes
2013-09-14T18:16:42.127Z,1379182602.127 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:16:44.130Z,1379182604.130 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:16:44.130Z,1379182604.130 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:16:44.130Z,1379182604.130 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:16:46.133Z,1379182606.133 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:16:48.136Z,1379182608.136 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:16:48.137Z,1379182608.137 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:16:48.137Z,1379182608.137 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:16:50.139Z,1379182610.139 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:16:50.140Z,1379182610.140 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:16:52.150Z,1379182612.150 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:16:52.150Z,1379182612.150 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:16:52.150Z,1379182612.150 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:16:54.161Z,1379182614.161 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:16:54.161Z,1379182614.161 [DVL_micro](INFO): Querying output modes
2013-09-14T18:16:54.161Z,1379182614.161 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:16:56.168Z,1379182616.168 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:16:56.168Z,1379182616.168 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:16:56.169Z,1379182616.169 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:16:58.175Z,1379182618.175 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:17:00.187Z,1379182620.187 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:17:00.187Z,1379182620.187 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:17:00.188Z,1379182620.188 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:17:02.190Z,1379182622.190 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:17:02.190Z,1379182622.190 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:17:04.193Z,1379182624.193 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:17:04.193Z,1379182624.193 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:17:04.193Z,1379182624.193 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:17:06.196Z,1379182626.196 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:17:06.196Z,1379182626.196 [DVL_micro](INFO): Querying output modes
2013-09-14T18:17:06.196Z,1379182626.196 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:17:08.199Z,1379182628.199 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:17:08.199Z,1379182628.199 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:17:08.199Z,1379182628.199 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:17:10.210Z,1379182630.210 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:17:12.227Z,1379182632.227 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:17:12.228Z,1379182632.228 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:17:12.228Z,1379182632.228 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:17:14.233Z,1379182634.233 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:17:14.233Z,1379182634.233 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:17:16.235Z,1379182636.235 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:17:16.235Z,1379182636.235 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:17:16.236Z,1379182636.236 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:17:18.247Z,1379182638.247 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:17:18.247Z,1379182638.247 [DVL_micro](INFO): Querying output modes
2013-09-14T18:17:18.247Z,1379182638.247 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:17:20.250Z,1379182640.250 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:17:20.250Z,1379182640.250 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:17:20.250Z,1379182640.250 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:17:22.253Z,1379182642.253 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:17:24.257Z,1379182644.257 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:17:24.257Z,1379182644.257 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:17:24.257Z,1379182644.257 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:17:26.259Z,1379182646.259 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:17:26.260Z,1379182646.260 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:17:28.270Z,1379182648.270 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:17:28.270Z,1379182648.270 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:17:28.270Z,1379182648.270 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:17:30.273Z,1379182650.273 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:17:30.273Z,1379182650.273 [DVL_micro](INFO): Querying output modes
2013-09-14T18:17:30.274Z,1379182650.274 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:17:32.284Z,1379182652.284 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:17:32.284Z,1379182652.284 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:17:32.285Z,1379182652.285 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:17:34.291Z,1379182654.291 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:17:36.299Z,1379182656.299 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:17:36.299Z,1379182656.299 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:17:36.299Z,1379182656.299 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:17:38.302Z,1379182658.302 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:17:38.302Z,1379182658.302 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:17:40.309Z,1379182660.309 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:17:40.309Z,1379182660.309 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:17:40.309Z,1379182660.309 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:17:42.320Z,1379182662.320 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:17:42.320Z,1379182662.320 [DVL_micro](INFO): Querying output modes
2013-09-14T18:17:42.320Z,1379182662.320 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:17:44.323Z,1379182664.323 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:17:44.323Z,1379182664.323 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:17:44.323Z,1379182664.323 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:17:46.334Z,1379182666.334 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:17:48.338Z,1379182668.338 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:17:48.338Z,1379182668.338 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:17:48.338Z,1379182668.338 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:17:50.341Z,1379182670.341 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:17:50.341Z,1379182670.341 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:17:52.360Z,1379182672.360 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:17:52.360Z,1379182672.360 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:17:52.360Z,1379182672.360 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:17:54.363Z,1379182674.363 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:17:54.363Z,1379182674.363 [DVL_micro](INFO): Querying output modes
2013-09-14T18:17:54.363Z,1379182674.363 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:17:56.370Z,1379182676.370 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:17:56.370Z,1379182676.370 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:17:56.370Z,1379182676.370 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:17:58.373Z,1379182678.373 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:18:00.385Z,1379182680.385 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:18:00.385Z,1379182680.385 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:18:00.385Z,1379182680.385 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:18:02.387Z,1379182682.387 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:18:02.388Z,1379182682.388 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:18:04.398Z,1379182684.398 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:18:04.398Z,1379182684.398 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:18:04.398Z,1379182684.398 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:18:06.413Z,1379182686.413 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:18:06.413Z,1379182686.413 [DVL_micro](INFO): Querying output modes
2013-09-14T18:18:06.414Z,1379182686.414 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:18:08.416Z,1379182688.416 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:18:08.417Z,1379182688.417 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:18:08.417Z,1379182688.417 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:18:10.434Z,1379182690.434 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:18:12.439Z,1379182692.439 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:18:12.439Z,1379182692.439 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:18:12.439Z,1379182692.439 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:18:14.442Z,1379182694.442 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:18:14.442Z,1379182694.442 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:18:16.449Z,1379182696.449 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:18:16.449Z,1379182696.449 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:18:16.449Z,1379182696.449 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:18:18.460Z,1379182698.460 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:18:18.460Z,1379182698.460 [DVL_micro](INFO): Querying output modes
2013-09-14T18:18:18.460Z,1379182698.460 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:18:20.463Z,1379182700.463 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:18:20.463Z,1379182700.463 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:18:20.463Z,1379182700.463 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:18:22.470Z,1379182702.470 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:18:24.482Z,1379182704.482 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:18:24.482Z,1379182704.482 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:18:24.482Z,1379182704.482 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:18:26.485Z,1379182706.485 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:18:26.485Z,1379182706.485 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:18:28.505Z,1379182708.505 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:18:28.505Z,1379182708.505 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:18:28.506Z,1379182708.506 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:18:30.507Z,1379182710.507 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:18:30.507Z,1379182710.507 [DVL_micro](INFO): Querying output modes
2013-09-14T18:18:30.507Z,1379182710.507 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:18:32.510Z,1379182712.510 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:18:32.510Z,1379182712.510 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:18:32.510Z,1379182712.510 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:18:34.517Z,1379182714.517 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:18:36.521Z,1379182716.521 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:18:36.521Z,1379182716.521 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:18:36.521Z,1379182716.521 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:18:38.523Z,1379182718.523 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:18:38.524Z,1379182718.524 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:18:40.530Z,1379182720.530 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:18:40.530Z,1379182720.530 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:18:40.530Z,1379182720.530 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:18:42.533Z,1379182722.533 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:18:42.533Z,1379182722.533 [DVL_micro](INFO): Querying output modes
2013-09-14T18:18:42.533Z,1379182722.533 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:18:44.544Z,1379182724.544 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:18:44.544Z,1379182724.544 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:18:44.545Z,1379182724.545 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:18:46.555Z,1379182726.555 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:18:48.567Z,1379182728.567 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:18:48.567Z,1379182728.567 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:18:48.567Z,1379182728.567 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:18:50.570Z,1379182730.570 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:18:50.570Z,1379182730.570 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:18:52.577Z,1379182732.577 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:18:52.577Z,1379182732.577 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:18:52.577Z,1379182732.577 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:18:54.580Z,1379182734.580 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:18:54.580Z,1379182734.580 [DVL_micro](INFO): Querying output modes
2013-09-14T18:18:54.580Z,1379182734.580 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:18:56.591Z,1379182736.591 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:18:56.591Z,1379182736.591 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:18:56.591Z,1379182736.591 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:18:58.602Z,1379182738.602 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:19:00.607Z,1379182740.607 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:19:00.607Z,1379182740.607 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:19:00.607Z,1379182740.607 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:19:02.613Z,1379182742.613 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:19:02.613Z,1379182742.613 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:19:04.615Z,1379182744.615 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:19:04.616Z,1379182744.616 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:19:04.616Z,1379182744.616 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:19:06.619Z,1379182746.619 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:19:06.619Z,1379182746.619 [DVL_micro](INFO): Querying output modes
2013-09-14T18:19:06.619Z,1379182746.619 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:19:08.630Z,1379182748.630 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:19:08.630Z,1379182748.630 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:19:08.630Z,1379182748.630 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:19:10.637Z,1379182750.637 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:19:12.640Z,1379182752.640 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:19:12.640Z,1379182752.640 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:19:12.641Z,1379182752.641 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:19:14.643Z,1379182754.643 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:19:14.644Z,1379182754.644 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:19:16.654Z,1379182756.654 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:19:16.654Z,1379182756.654 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:19:16.654Z,1379182756.654 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:19:18.665Z,1379182758.665 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:19:18.665Z,1379182758.665 [DVL_micro](INFO): Querying output modes
2013-09-14T18:19:18.666Z,1379182758.666 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:19:20.676Z,1379182760.676 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:19:20.676Z,1379182760.676 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:19:20.677Z,1379182760.677 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:19:22.687Z,1379182762.687 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:19:24.691Z,1379182764.691 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:19:24.691Z,1379182764.691 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:19:24.691Z,1379182764.691 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:19:26.694Z,1379182766.694 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:19:26.694Z,1379182766.694 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:19:28.697Z,1379182768.697 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:19:28.697Z,1379182768.697 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:19:28.697Z,1379182768.697 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:19:30.700Z,1379182770.700 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:19:30.700Z,1379182770.700 [DVL_micro](INFO): Querying output modes
2013-09-14T18:19:30.700Z,1379182770.700 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:19:32.711Z,1379182772.711 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:19:32.711Z,1379182772.711 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:19:32.711Z,1379182772.711 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:19:34.722Z,1379182774.722 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:19:36.726Z,1379182776.726 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:19:36.726Z,1379182776.726 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:19:36.726Z,1379182776.726 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:19:38.729Z,1379182778.729 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:19:38.729Z,1379182778.729 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:19:40.735Z,1379182780.735 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:19:40.736Z,1379182780.736 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:19:40.736Z,1379182780.736 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:19:42.747Z,1379182782.747 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:19:42.747Z,1379182782.747 [DVL_micro](INFO): Querying output modes
2013-09-14T18:19:42.747Z,1379182782.747 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:19:44.762Z,1379182784.762 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:19:44.762Z,1379182784.762 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:19:44.762Z,1379182784.762 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:19:46.773Z,1379182786.773 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:19:48.785Z,1379182788.785 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:19:48.785Z,1379182788.785 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:19:48.785Z,1379182788.785 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:19:50.788Z,1379182790.788 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:19:50.788Z,1379182790.788 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:19:52.798Z,1379182792.798 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:19:52.798Z,1379182792.798 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:19:52.798Z,1379182792.798 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:19:54.805Z,1379182794.805 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:19:54.805Z,1379182794.805 [DVL_micro](INFO): Querying output modes
2013-09-14T18:19:54.806Z,1379182794.806 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:19:56.820Z,1379182796.820 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:19:56.821Z,1379182796.821 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:19:56.821Z,1379182796.821 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:19:58.831Z,1379182798.831 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:20:00.835Z,1379182800.835 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:20:00.835Z,1379182800.835 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:20:00.835Z,1379182800.835 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:20:02.838Z,1379182802.838 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:20:02.838Z,1379182802.838 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:20:04.849Z,1379182804.849 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:20:04.849Z,1379182804.849 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:20:04.849Z,1379182804.849 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:20:06.856Z,1379182806.856 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:20:06.856Z,1379182806.856 [DVL_micro](INFO): Querying output modes
2013-09-14T18:20:06.856Z,1379182806.856 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:20:08.859Z,1379182808.859 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:20:08.859Z,1379182808.859 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:20:08.859Z,1379182808.859 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:20:10.866Z,1379182810.866 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:20:12.878Z,1379182812.878 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:20:12.878Z,1379182812.878 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:20:12.878Z,1379182812.878 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:20:14.881Z,1379182814.881 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:20:14.881Z,1379182814.881 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:20:16.887Z,1379182816.887 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:20:16.888Z,1379182816.888 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:20:16.888Z,1379182816.888 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:20:18.899Z,1379182818.899 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:20:18.899Z,1379182818.899 [DVL_micro](INFO): Querying output modes
2013-09-14T18:20:18.899Z,1379182818.899 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:20:20.907Z,1379182820.907 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:20:20.907Z,1379182820.907 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:20:20.907Z,1379182820.907 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:20:22.917Z,1379182822.917 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:20:24.928Z,1379182824.928 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:20:24.929Z,1379182824.929 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:20:24.929Z,1379182824.929 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:20:26.935Z,1379182826.935 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:20:26.936Z,1379182826.936 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:20:28.946Z,1379182828.946 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:20:28.946Z,1379182828.946 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:20:28.946Z,1379182828.946 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:20:30.953Z,1379182830.953 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:20:30.953Z,1379182830.953 [DVL_micro](INFO): Querying output modes
2013-09-14T18:20:30.954Z,1379182830.954 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:20:32.960Z,1379182832.960 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:20:32.961Z,1379182832.961 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:20:32.961Z,1379182832.961 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:20:34.968Z,1379182834.968 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:20:36.979Z,1379182836.979 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:20:36.979Z,1379182836.979 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:20:36.980Z,1379182836.980 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:20:38.983Z,1379182838.983 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:20:38.983Z,1379182838.983 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:20:40.989Z,1379182840.989 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:20:40.989Z,1379182840.989 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:20:40.989Z,1379182840.989 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:20:42.992Z,1379182842.992 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:20:42.992Z,1379182842.992 [DVL_micro](INFO): Querying output modes
2013-09-14T18:20:42.992Z,1379182842.992 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:20:45.003Z,1379182845.003 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:20:45.003Z,1379182845.003 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:20:45.004Z,1379182845.004 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:20:47.006Z,1379182847.006 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:20:49.014Z,1379182849.014 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:20:49.014Z,1379182849.014 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:20:49.014Z,1379182849.014 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:20:51.017Z,1379182851.017 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:20:51.017Z,1379182851.017 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:20:53.028Z,1379182853.028 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:20:53.028Z,1379182853.028 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:20:53.028Z,1379182853.028 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:20:55.031Z,1379182855.031 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:20:55.031Z,1379182855.031 [DVL_micro](INFO): Querying output modes
2013-09-14T18:20:55.031Z,1379182855.031 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:20:57.042Z,1379182857.042 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:20:57.042Z,1379182857.042 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:20:57.042Z,1379182857.042 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:20:59.049Z,1379182859.049 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:21:01.061Z,1379182861.061 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:21:01.061Z,1379182861.061 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:21:01.061Z,1379182861.061 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:21:03.063Z,1379182863.063 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:21:03.064Z,1379182863.064 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:21:05.066Z,1379182865.066 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:21:05.066Z,1379182865.066 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:21:05.066Z,1379182865.066 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:21:07.077Z,1379182867.077 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:21:07.077Z,1379182867.077 [DVL_micro](INFO): Querying output modes
2013-09-14T18:21:07.078Z,1379182867.078 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:21:09.084Z,1379182869.084 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:21:09.085Z,1379182869.085 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:21:09.085Z,1379182869.085 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:21:11.088Z,1379182871.088 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:21:13.095Z,1379182873.095 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:21:13.095Z,1379182873.095 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:21:13.095Z,1379182873.095 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:21:15.098Z,1379182875.098 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:21:15.098Z,1379182875.098 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:21:17.101Z,1379182877.101 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:21:17.101Z,1379182877.101 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:21:17.101Z,1379182877.101 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:21:19.108Z,1379182879.108 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:21:19.108Z,1379182879.108 [DVL_micro](INFO): Querying output modes
2013-09-14T18:21:19.108Z,1379182879.108 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:21:21.115Z,1379182881.115 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:21:21.115Z,1379182881.115 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:21:21.115Z,1379182881.115 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:21:23.126Z,1379182883.126 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:21:25.138Z,1379182885.138 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:21:25.138Z,1379182885.138 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:21:25.138Z,1379182885.138 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:21:27.141Z,1379182887.141 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:21:27.141Z,1379182887.141 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:21:29.156Z,1379182889.156 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:21:29.156Z,1379182889.156 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:21:29.156Z,1379182889.156 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:21:31.162Z,1379182891.162 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:21:31.162Z,1379182891.162 [DVL_micro](INFO): Querying output modes
2013-09-14T18:21:31.162Z,1379182891.162 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:21:33.166Z,1379182893.166 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:21:33.166Z,1379182893.166 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:21:33.166Z,1379182893.166 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:21:35.173Z,1379182895.173 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:21:37.181Z,1379182897.181 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:21:37.181Z,1379182897.181 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:21:37.181Z,1379182897.181 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:21:39.183Z,1379182899.183 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:21:39.184Z,1379182899.184 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:21:41.186Z,1379182901.186 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:21:41.186Z,1379182901.186 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:21:41.187Z,1379182901.187 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:21:43.197Z,1379182903.197 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:21:43.197Z,1379182903.197 [DVL_micro](INFO): Querying output modes
2013-09-14T18:21:43.198Z,1379182903.198 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:21:45.221Z,1379182905.221 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:21:45.221Z,1379182905.221 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:21:45.221Z,1379182905.221 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:21:47.228Z,1379182907.228 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:21:49.231Z,1379182909.231 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:21:49.231Z,1379182909.231 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:21:49.232Z,1379182909.232 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:21:51.234Z,1379182911.234 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:21:51.234Z,1379182911.234 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:21:53.237Z,1379182913.237 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:21:53.237Z,1379182913.237 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:21:53.237Z,1379182913.237 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:21:55.244Z,1379182915.244 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:21:55.244Z,1379182915.244 [DVL_micro](INFO): Querying output modes
2013-09-14T18:21:55.244Z,1379182915.244 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:21:57.251Z,1379182917.251 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:21:57.251Z,1379182917.251 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:21:57.251Z,1379182917.251 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:21:59.262Z,1379182919.262 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:22:01.274Z,1379182921.274 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:22:01.274Z,1379182921.274 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:22:01.274Z,1379182921.274 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:22:03.277Z,1379182923.277 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:22:03.277Z,1379182923.277 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:22:05.284Z,1379182925.284 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:22:05.284Z,1379182925.284 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:22:05.284Z,1379182925.284 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:22:07.295Z,1379182927.295 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:22:07.295Z,1379182927.295 [DVL_micro](INFO): Querying output modes
2013-09-14T18:22:07.295Z,1379182927.295 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:22:09.298Z,1379182929.298 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:22:09.298Z,1379182929.298 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:22:09.298Z,1379182929.298 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:22:11.306Z,1379182931.306 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:22:13.317Z,1379182933.317 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:22:13.317Z,1379182933.317 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:22:13.317Z,1379182933.317 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:22:15.320Z,1379182935.320 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:22:15.320Z,1379182935.320 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:22:17.330Z,1379182937.330 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:22:17.330Z,1379182937.330 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:22:17.331Z,1379182937.331 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:22:19.341Z,1379182939.341 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:22:19.341Z,1379182939.341 [DVL_micro](INFO): Querying output modes
2013-09-14T18:22:19.342Z,1379182939.342 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:22:21.344Z,1379182941.344 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:22:21.345Z,1379182941.345 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:22:21.345Z,1379182941.345 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:22:23.356Z,1379182943.356 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:22:25.367Z,1379182945.367 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:22:25.367Z,1379182945.367 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:22:25.367Z,1379182945.367 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:22:27.370Z,1379182947.370 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:22:27.370Z,1379182947.370 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:22:29.381Z,1379182949.381 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:22:29.381Z,1379182949.381 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:22:29.381Z,1379182949.381 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:22:31.392Z,1379182951.392 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:22:31.392Z,1379182951.392 [DVL_micro](INFO): Querying output modes
2013-09-14T18:22:31.392Z,1379182951.392 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:22:33.395Z,1379182953.395 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:22:33.395Z,1379182953.395 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:22:33.395Z,1379182953.395 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:22:35.406Z,1379182955.406 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:22:37.418Z,1379182957.418 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:22:37.418Z,1379182957.418 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:22:37.418Z,1379182957.418 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:22:39.421Z,1379182959.421 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:22:39.421Z,1379182959.421 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:22:41.428Z,1379182961.428 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:22:41.428Z,1379182961.428 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:22:41.428Z,1379182961.428 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:22:43.435Z,1379182963.435 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:22:43.435Z,1379182963.435 [DVL_micro](INFO): Querying output modes
2013-09-14T18:22:43.435Z,1379182963.435 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:22:45.442Z,1379182965.442 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:22:45.442Z,1379182965.442 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:22:45.442Z,1379182965.442 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:22:47.449Z,1379182967.449 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:22:49.461Z,1379182969.461 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:22:49.461Z,1379182969.461 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:22:49.461Z,1379182969.461 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:22:51.464Z,1379182971.464 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:22:51.464Z,1379182971.464 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:22:53.470Z,1379182973.470 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:22:53.470Z,1379182973.470 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:22:53.471Z,1379182973.471 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:22:55.473Z,1379182975.473 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:22:55.473Z,1379182975.473 [DVL_micro](INFO): Querying output modes
2013-09-14T18:22:55.474Z,1379182975.474 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:22:57.476Z,1379182977.476 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:22:57.477Z,1379182977.477 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:22:57.477Z,1379182977.477 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:22:59.488Z,1379182979.488 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:23:01.499Z,1379182981.499 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:23:01.499Z,1379182981.499 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:23:01.500Z,1379182981.500 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:23:03.502Z,1379182983.502 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:23:03.503Z,1379182983.503 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:23:05.513Z,1379182985.513 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:23:05.513Z,1379182985.513 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:23:05.513Z,1379182985.513 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:23:07.516Z,1379182987.516 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:23:07.516Z,1379182987.516 [DVL_micro](INFO): Querying output modes
2013-09-14T18:23:07.516Z,1379182987.516 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:23:09.523Z,1379182989.523 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:23:09.523Z,1379182989.523 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:23:09.523Z,1379182989.523 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:23:11.530Z,1379182991.530 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:23:13.538Z,1379182993.538 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:23:13.538Z,1379182993.538 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:23:13.538Z,1379182993.538 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:23:15.541Z,1379182995.541 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:23:15.541Z,1379182995.541 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:23:17.564Z,1379182997.564 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:23:17.564Z,1379182997.564 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:23:17.564Z,1379182997.564 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:23:19.575Z,1379182999.575 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:23:19.575Z,1379182999.575 [DVL_micro](INFO): Querying output modes
2013-09-14T18:23:19.575Z,1379182999.575 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:23:21.586Z,1379183001.586 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:23:21.586Z,1379183001.586 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:23:21.586Z,1379183001.586 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:23:23.597Z,1379183003.597 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:23:25.601Z,1379183005.601 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:23:25.601Z,1379183005.601 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:23:25.601Z,1379183005.601 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:23:27.604Z,1379183007.604 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:23:27.604Z,1379183007.604 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:23:29.629Z,1379183009.629 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:23:29.629Z,1379183009.629 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:23:29.629Z,1379183009.629 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:23:31.641Z,1379183011.641 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:23:31.642Z,1379183011.642 [DVL_micro](INFO): Querying output modes
2013-09-14T18:23:31.642Z,1379183011.642 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:23:33.645Z,1379183013.645 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:23:33.645Z,1379183013.645 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:23:33.645Z,1379183013.645 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:23:35.656Z,1379183015.656 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:23:37.659Z,1379183017.659 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:23:37.660Z,1379183017.660 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:23:37.660Z,1379183017.660 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:23:39.662Z,1379183019.662 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:23:39.663Z,1379183019.663 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:23:41.669Z,1379183021.669 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:23:41.669Z,1379183021.669 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:23:41.669Z,1379183021.669 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:23:43.680Z,1379183023.680 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:23:43.680Z,1379183023.680 [DVL_micro](INFO): Querying output modes
2013-09-14T18:23:43.680Z,1379183023.680 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:23:45.683Z,1379183025.683 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:23:45.683Z,1379183025.683 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:23:45.684Z,1379183025.684 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:23:47.694Z,1379183027.694 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:23:49.707Z,1379183029.707 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:23:49.707Z,1379183029.707 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:23:49.707Z,1379183029.707 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:23:51.713Z,1379183031.713 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:23:51.713Z,1379183031.713 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:23:53.720Z,1379183033.720 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:23:53.720Z,1379183033.720 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:23:53.720Z,1379183033.720 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:23:55.731Z,1379183035.731 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:23:55.731Z,1379183035.731 [DVL_micro](INFO): Querying output modes
2013-09-14T18:23:55.731Z,1379183035.731 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:23:57.742Z,1379183037.742 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:23:57.742Z,1379183037.742 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:23:57.742Z,1379183037.742 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:23:59.753Z,1379183039.753 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:24:01.761Z,1379183041.761 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:24:01.761Z,1379183041.761 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:24:01.761Z,1379183041.761 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:24:03.766Z,1379183043.766 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:24:03.766Z,1379183043.766 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:24:05.774Z,1379183045.774 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:24:05.774Z,1379183045.774 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:24:05.775Z,1379183045.775 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:24:07.785Z,1379183047.785 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:24:07.786Z,1379183047.786 [DVL_micro](INFO): Querying output modes
2013-09-14T18:24:07.786Z,1379183047.786 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:24:09.793Z,1379183049.793 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:24:09.793Z,1379183049.793 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:24:09.793Z,1379183049.793 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:24:11.806Z,1379183051.806 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:24:13.807Z,1379183053.807 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:24:13.808Z,1379183053.808 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:24:13.808Z,1379183053.808 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:24:15.810Z,1379183055.810 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:24:15.811Z,1379183055.811 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:24:17.817Z,1379183057.817 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:24:17.817Z,1379183057.817 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:24:17.817Z,1379183057.817 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:24:19.828Z,1379183059.828 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:24:19.828Z,1379183059.828 [DVL_micro](INFO): Querying output modes
2013-09-14T18:24:19.828Z,1379183059.828 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:24:21.839Z,1379183061.839 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:24:21.839Z,1379183061.839 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:24:21.840Z,1379183061.840 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:24:23.842Z,1379183063.842 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:24:25.850Z,1379183065.850 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:24:25.850Z,1379183065.850 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:24:25.850Z,1379183065.850 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:24:27.853Z,1379183067.853 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:24:27.853Z,1379183067.853 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:24:29.864Z,1379183069.864 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:24:29.864Z,1379183069.864 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:24:29.864Z,1379183069.864 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:24:31.867Z,1379183071.867 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:24:31.867Z,1379183071.867 [DVL_micro](INFO): Querying output modes
2013-09-14T18:24:31.867Z,1379183071.867 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:24:33.874Z,1379183073.874 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:24:33.874Z,1379183073.874 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:24:33.874Z,1379183073.874 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:24:35.877Z,1379183075.877 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:24:37.889Z,1379183077.889 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:24:37.889Z,1379183077.889 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:24:37.889Z,1379183077.889 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:24:39.892Z,1379183079.892 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:24:39.892Z,1379183079.892 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:24:41.894Z,1379183081.894 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:24:41.894Z,1379183081.894 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:24:41.895Z,1379183081.895 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:24:43.906Z,1379183083.906 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:24:43.906Z,1379183083.906 [DVL_micro](INFO): Querying output modes
2013-09-14T18:24:43.907Z,1379183083.907 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:24:45.913Z,1379183085.913 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:24:45.913Z,1379183085.913 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:24:45.913Z,1379183085.913 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:24:47.924Z,1379183087.924 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:24:49.927Z,1379183089.927 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:24:49.928Z,1379183089.928 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:24:49.928Z,1379183089.928 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:24:51.930Z,1379183091.930 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:24:51.931Z,1379183091.931 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:24:53.937Z,1379183093.937 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:24:53.937Z,1379183093.937 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:24:53.937Z,1379183093.937 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:24:55.940Z,1379183095.940 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:24:55.940Z,1379183095.940 [DVL_micro](INFO): Querying output modes
2013-09-14T18:24:55.940Z,1379183095.940 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:24:57.960Z,1379183097.960 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:24:57.960Z,1379183097.960 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:24:57.960Z,1379183097.960 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:24:59.962Z,1379183099.962 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:25:01.974Z,1379183101.974 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:25:01.974Z,1379183101.974 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:25:01.974Z,1379183101.974 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:25:03.977Z,1379183103.977 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:25:03.977Z,1379183103.977 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:25:05.984Z,1379183105.984 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:25:05.984Z,1379183105.984 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:25:05.984Z,1379183105.984 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:25:07.987Z,1379183107.987 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:25:07.987Z,1379183107.987 [DVL_micro](INFO): Querying output modes
2013-09-14T18:25:07.987Z,1379183107.987 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:25:09.998Z,1379183109.998 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:25:09.998Z,1379183109.998 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:25:09.998Z,1379183109.998 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:25:12.021Z,1379183112.021 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:25:14.033Z,1379183114.033 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:25:14.033Z,1379183114.033 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:25:14.033Z,1379183114.033 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:25:16.036Z,1379183116.036 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:25:16.036Z,1379183116.036 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:25:18.038Z,1379183118.038 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:25:18.038Z,1379183118.038 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:25:18.039Z,1379183118.039 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:25:20.046Z,1379183120.046 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:25:20.046Z,1379183120.046 [DVL_micro](INFO): Querying output modes
2013-09-14T18:25:20.046Z,1379183120.046 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:25:22.049Z,1379183122.049 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:25:22.049Z,1379183122.049 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:25:22.049Z,1379183122.049 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:25:24.052Z,1379183124.052 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:25:26.056Z,1379183126.056 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:25:26.056Z,1379183126.056 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:25:26.056Z,1379183126.056 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:25:28.058Z,1379183128.058 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:25:28.059Z,1379183128.059 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:25:30.061Z,1379183130.061 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:25:30.061Z,1379183130.061 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:25:30.061Z,1379183130.061 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:25:32.069Z,1379183132.069 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:25:32.069Z,1379183132.069 [DVL_micro](INFO): Querying output modes
2013-09-14T18:25:32.069Z,1379183132.069 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:25:34.071Z,1379183134.071 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:25:34.071Z,1379183134.071 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:25:34.072Z,1379183134.072 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:25:36.082Z,1379183136.082 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:25:38.086Z,1379183138.086 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:25:38.086Z,1379183138.086 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:25:38.086Z,1379183138.086 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:25:40.089Z,1379183140.089 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:25:40.089Z,1379183140.089 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:25:42.100Z,1379183142.100 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:25:42.100Z,1379183142.100 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:25:42.100Z,1379183142.100 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:25:44.104Z,1379183144.104 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:25:44.105Z,1379183144.105 [DVL_micro](INFO): Querying output modes
2013-09-14T18:25:44.105Z,1379183144.105 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:25:46.106Z,1379183146.106 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:25:46.106Z,1379183146.106 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:25:46.106Z,1379183146.106 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:25:48.117Z,1379183148.117 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:25:50.129Z,1379183150.129 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:25:50.129Z,1379183150.129 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:25:50.129Z,1379183150.129 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:25:52.132Z,1379183152.132 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:25:52.132Z,1379183152.132 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:25:54.138Z,1379183154.138 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:25:54.138Z,1379183154.138 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:25:54.139Z,1379183154.139 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:25:56.149Z,1379183156.149 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:25:56.150Z,1379183156.150 [DVL_micro](INFO): Querying output modes
2013-09-14T18:25:56.150Z,1379183156.150 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:25:58.161Z,1379183158.161 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:25:58.161Z,1379183158.161 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:25:58.161Z,1379183158.161 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:26:00.164Z,1379183160.164 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:26:02.167Z,1379183162.167 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:26:02.168Z,1379183162.168 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:26:02.168Z,1379183162.168 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:26:04.170Z,1379183164.170 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:26:04.171Z,1379183164.171 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:26:06.177Z,1379183166.177 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:26:06.177Z,1379183166.177 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:26:06.177Z,1379183166.177 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:26:08.188Z,1379183168.188 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:26:08.188Z,1379183168.188 [DVL_micro](INFO): Querying output modes
2013-09-14T18:26:08.188Z,1379183168.188 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:26:10.199Z,1379183170.199 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:26:10.200Z,1379183170.200 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:26:10.200Z,1379183170.200 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:26:12.202Z,1379183172.202 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:26:14.214Z,1379183174.214 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:26:14.214Z,1379183174.214 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:26:14.214Z,1379183174.214 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:26:16.217Z,1379183176.217 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:26:16.217Z,1379183176.217 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:26:18.220Z,1379183178.220 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:26:18.220Z,1379183178.220 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:26:18.220Z,1379183178.220 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:26:20.223Z,1379183180.223 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:26:20.223Z,1379183180.223 [DVL_micro](INFO): Querying output modes
2013-09-14T18:26:20.223Z,1379183180.223 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:26:22.226Z,1379183182.226 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:26:22.226Z,1379183182.226 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:26:22.226Z,1379183182.226 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:26:24.233Z,1379183184.233 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:26:26.237Z,1379183186.237 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:26:26.237Z,1379183186.237 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:26:26.237Z,1379183186.237 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:26:27.833Z,1379183187.833 [CommandLine](IMPORTANT): got command failComponent
2013-09-14T18:26:27.833Z,1379183187.833 [CommandLine](IMPORTANT): Failed components:
2013-09-14T18:26:27.834Z,1379183187.834 [CommandLine](IMPORTANT): CBIT: Hardware Fault
2013-09-14T18:26:27.834Z,1379183187.834 [CommandLine](IMPORTANT): BuoyancyServo: Communications Fault
2013-09-14T18:26:27.834Z,1379183187.834 [CommandLine](IMPORTANT): ElevatorServo: Communications Fault
2013-09-14T18:26:27.834Z,1379183187.834 [CommandLine](IMPORTANT): MassServo: Communications Fault
2013-09-14T18:26:27.835Z,1379183187.835 [CommandLine](IMPORTANT): RudderServo: Communications Fault
2013-09-14T18:26:27.835Z,1379183187.835 [CommandLine](IMPORTANT): ThrusterServo: Communications Fault
2013-09-14T18:26:27.835Z,1379183187.835 [CommandLine](IMPORTANT): AHRS_sp3003D: Hardware Fault
2013-09-14T18:26:27.835Z,1379183187.835 [CommandLine](IMPORTANT): Batt_Ocean_Server: Communications Fault
2013-09-14T18:26:27.836Z,1379183187.836 [CommandLine](IMPORTANT): NAL9602: Communications Fault
2013-09-14T18:26:27.836Z,1379183187.836 [CommandLine](IMPORTANT): DAT: Communications Fault
2013-09-14T18:26:28.240Z,1379183188.240 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:26:28.240Z,1379183188.240 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:26:30.250Z,1379183190.250 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:26:30.250Z,1379183190.250 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:26:30.251Z,1379183190.251 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:26:32.257Z,1379183192.257 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:26:32.258Z,1379183192.258 [DVL_micro](INFO): Querying output modes
2013-09-14T18:26:32.258Z,1379183192.258 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:26:34.261Z,1379183194.261 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:26:34.261Z,1379183194.261 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:26:34.261Z,1379183194.261 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:26:36.268Z,1379183196.268 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:26:38.275Z,1379183198.275 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:26:38.276Z,1379183198.276 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:26:38.276Z,1379183198.276 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:26:40.278Z,1379183200.278 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:26:40.279Z,1379183200.279 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:26:42.281Z,1379183202.281 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:26:42.281Z,1379183202.281 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:26:42.281Z,1379183202.281 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:26:44.288Z,1379183204.288 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:26:44.288Z,1379183204.288 [DVL_micro](INFO): Querying output modes
2013-09-14T18:26:44.288Z,1379183204.288 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:26:46.299Z,1379183206.299 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:26:46.299Z,1379183206.299 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:26:46.300Z,1379183206.300 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:26:48.306Z,1379183208.306 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:26:50.318Z,1379183210.318 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:26:50.318Z,1379183210.318 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:26:50.318Z,1379183210.318 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:26:52.321Z,1379183212.321 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:26:52.321Z,1379183212.321 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:26:54.324Z,1379183214.324 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:26:54.324Z,1379183214.324 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:26:54.324Z,1379183214.324 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:26:56.335Z,1379183216.335 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:26:56.335Z,1379183216.335 [DVL_micro](INFO): Querying output modes
2013-09-14T18:26:56.335Z,1379183216.335 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:26:58.342Z,1379183218.342 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:26:58.342Z,1379183218.342 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:26:58.342Z,1379183218.342 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:27:00.357Z,1379183220.357 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:27:02.361Z,1379183222.361 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:27:02.361Z,1379183222.361 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:27:02.361Z,1379183222.361 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:27:04.364Z,1379183224.364 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:27:04.364Z,1379183224.364 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:27:06.370Z,1379183226.370 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:27:06.371Z,1379183226.371 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:27:06.371Z,1379183226.371 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:27:08.381Z,1379183228.381 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:27:08.382Z,1379183228.382 [DVL_micro](INFO): Querying output modes
2013-09-14T18:27:08.382Z,1379183228.382 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:27:10.389Z,1379183230.389 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:27:10.389Z,1379183230.389 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:27:10.389Z,1379183230.389 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:27:12.396Z,1379183232.396 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:27:14.399Z,1379183234.399 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:27:14.400Z,1379183234.399 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:27:14.400Z,1379183234.400 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:27:16.429Z,1379183236.429 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:27:16.430Z,1379183236.430 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:27:18.437Z,1379183238.437 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:27:18.437Z,1379183238.437 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:27:18.437Z,1379183238.437 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:27:20.444Z,1379183240.444 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:27:20.444Z,1379183240.444 [DVL_micro](INFO): Querying output modes
2013-09-14T18:27:20.444Z,1379183240.444 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:27:22.451Z,1379183242.451 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:27:22.451Z,1379183242.451 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:27:22.452Z,1379183242.452 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:27:24.462Z,1379183244.462 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:27:26.466Z,1379183246.466 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:27:26.466Z,1379183246.466 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:27:26.466Z,1379183246.466 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:27:28.469Z,1379183248.469 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:27:28.469Z,1379183248.469 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:27:30.476Z,1379183250.476 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:27:30.476Z,1379183250.476 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:27:30.476Z,1379183250.476 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:27:32.483Z,1379183252.483 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:27:32.483Z,1379183252.483 [DVL_micro](INFO): Querying output modes
2013-09-14T18:27:32.483Z,1379183252.483 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:27:34.494Z,1379183254.494 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:27:34.494Z,1379183254.494 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:27:34.494Z,1379183254.494 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:27:36.497Z,1379183256.497 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:27:38.501Z,1379183258.501 [DVL_micro](INFO): RSSI unrequested
2013-09-14T18:27:38.501Z,1379183258.501 [DVL_micro](INFO): ADCP unrequested
2013-09-14T18:27:38.501Z,1379183258.501 [DVL_micro](INFO): Cycling power to configure device.
2013-09-14T18:27:40.504Z,1379183260.504 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-14T18:27:40.504Z,1379183260.504 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-09-14T18:27:42.510Z,1379183262.510 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:27:42.511Z,1379183262.511 [DVL_micro](INFO): Enabling NQ1 output
2013-09-14T18:27:42.511Z,1379183262.511 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2013-09-14T18:27:44.522Z,1379183264.522 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:27:44.522Z,1379183264.522 [DVL_micro](INFO): Querying output modes
2013-09-14T18:27:44.522Z,1379183264.522 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-14T18:27:46.529Z,1379183266.529 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:27:46.529Z,1379183266.529 [DVL_micro](INFO): Output Modes: No Response
2013-09-14T18:27:46.529Z,1379183266.529 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-14T18:27:47.793Z,1379183267.793 [CommandLine](IMPORTANT): got command restart application
2013-09-14T18:27:48.532Z,1379183268.532 [DVL_micro](DEBUG): cmdResponse: 
2013-09-14T18:27:48.856Z,1379183268.856 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2013-09-14T18:27:48.856Z,1379183268.856 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2013-09-14T18:27:48.997Z,1379183268.997 [ComponentRegistry](INFO): Shutting down DVL_micro ThreadHandler
2013-09-14T18:27:50.543Z,1379183270.543 [DVL_micro](INFO): uninitialize:Powering down
2013-09-14T18:27:50.948Z,1379183270.948 [DVL_micro](INFO): uninitialize:Powering down
2013-09-14T18:27:50.951Z,1379183270.951 [ComponentRegistry](INFO): Shutting down AsyncPiEstimator ThreadHandler
2013-09-14T18:27:51.100Z,1379183271.100 [AsyncPiEstimator](DEBUG): Uninitialize AsyncPiEstimator.
2013-09-14T18:27:51.112Z,1379183271.112 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2013-09-14T18:27:51.216Z,1379183271.216 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2013-09-14T18:27:51.217Z,1379183271.217 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2013-09-14T18:27:51.549Z,1379183271.549 [controlThread](DEBUG): Uninitializing ControlThread
2013-09-14T18:27:51.549Z,1379183271.549 [AHRS_sp3003D](INFO): Powering down
2013-09-14T18:27:51.550Z,1379183271.550 [NAL9602](INFO): Powering down
2013-09-14T18:27:51.551Z,1379183271.551 [DAT](INFO): Powering down
2013-09-14T18:27:51.552Z,1379183271.552 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2013-09-14T18:27:51.552Z,1379183271.552 [NavChart](DEBUG): Uninitialize NavChart Derivation.
2013-09-14T18:27:51.553Z,1379183271.553 [Default] Stopped
2013-09-14T18:27:51.553Z,1379183271.553 [Default](INFO): Aggregate::uninitialize Default
2013-09-14T18:27:51.553Z,1379183271.553 [Default:GPS] Stopped
2013-09-14T18:27:51.553Z,1379183271.553 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2013-09-14T18:27:51.553Z,1379183271.553 [Default:GPS:A.SetSpeed] Stopped
2013-09-14T18:27:51.554Z,1379183271.554 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2013-09-14T18:27:51.554Z,1379183271.554 [Default:GPS:Read_GPS] Stopped
2013-09-14T18:27:51.554Z,1379183271.554 [Default:Iridium] Stopped
2013-09-14T18:27:51.554Z,1379183271.554 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2013-09-14T18:27:51.554Z,1379183271.554 [Default:Iridium:A.SetSpeed] Stopped
2013-09-14T18:27:51.554Z,1379183271.554 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2013-09-14T18:27:51.554Z,1379183271.554 [Default:Iridium:Read_Iridium] Stopped
2013-09-14T18:27:51.554Z,1379183271.554 [Default:CallIridium] Stopped
2013-09-14T18:27:51.554Z,1379183271.554 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2013-09-14T18:27:51.554Z,1379183271.554 [Default:CallIridium:B] Stopped
2013-09-14T18:27:51.554Z,1379183271.554 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2013-09-14T18:27:51.554Z,1379183271.554 [Default:D.SetSpeed] Stopped
2013-09-14T18:27:51.555Z,1379183271.555 [Default:D.SetSpeed](DEBUG): Uninitialize.
2013-09-14T18:27:51.555Z,1379183271.555 [Default:E.GoToSurface] Stopped
2013-09-14T18:27:51.555Z,1379183271.555 [Default:E.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-09-14T18:27:51.559Z,1379183271.559 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2013-09-14T18:27:51.559Z,1379183271.559 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2013-09-14T18:27:51.559Z,1379183271.559 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2013-09-14T18:27:51.559Z,1379183271.559 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2013-09-14T18:27:51.559Z,1379183271.559 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2013-09-14T18:27:51.560Z,1379183271.560 [BuoyancyServo](INFO): Powering down
2013-09-14T18:27:51.577Z,1379183271.577 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2013-09-14T18:27:51.577Z,1379183271.577 [ElevatorServo](INFO): Powering down
2013-09-14T18:27:51.578Z,1379183271.578 [MassServo](DEBUG): Uninitialize Mass Servo.
2013-09-14T18:27:51.578Z,1379183271.578 [MassServo](INFO): Powering down
2013-09-14T18:27:51.578Z,1379183271.578 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2013-09-14T18:27:51.579Z,1379183271.579 [RudderServo](INFO): Powering down
2013-09-14T18:27:51.579Z,1379183271.579 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2013-09-14T18:27:51.579Z,1379183271.579 [ThrusterServo](INFO): Powering down
2013-09-14T18:27:51.580Z,1379183271.580 [SBIT](DEBUG): Uninitialize SBIT Component.
2013-09-14T18:27:51.581Z,1379183271.581 [IBIT](DEBUG): Uninitialize IBIT Component.
2013-09-14T18:27:51.581Z,1379183271.581 [CBIT](DEBUG): Uninitialize CBIT Component.
2013-09-14T18:27:51.624Z,1379183271.624 [CBIT](CRITICAL): run-time exception #7
2013-09-14T18:27:51.624Z,1379183271.624 [CBIT](CRITICAL): Bad address: 0x40309004
2013-09-14T18:27:51.624Z,1379183271.624 [CBIT](CRITICAL): Backtrace: 
./bin/LRAUV(_ZN7PCaller20DefaultSignalHandlerEiP7siginfoPv+0x20) [0x159254]
/lib/libc.so.6(__default_rt_sa_restorer+0) [0x40203510]

2013-09-14T18:27:51.625Z,1379183271.625 [CBIT] Software Fault, FailCount= 1
2013-09-14T18:27:51.625Z,1379183271.625 [CBIT](ERROR): Software Fault
2013-09-14T18:27:51.626Z,1379183271.626 [SyncHandler](DEBUG): Created PCaller Thread at 4033B4E0
2013-09-14T18:27:51.627Z,1379183271.627 [CBIT](INFO): Thread ID is 8983