2013-08-22T16:31:18.511Z,1377189078.511 [Supervisor](DEBUG): Initializing supervisor.
2013-08-22T16:31:18.514Z,1377189078.514 [SyncHandler](DEBUG): Created PCaller Thread at 4033B4E0
2013-08-22T16:31:18.515Z,1377189078.514 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2013-08-22T16:31:18.516Z,1377189078.516 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4036B4E0
2013-08-22T16:31:18.519Z,1377189078.519 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2013-08-22T16:31:18.530Z,1377189078.530 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2013-08-22T16:31:18.531Z,1377189078.531 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 4039B4E0
2013-08-22T16:31:18.532Z,1377189078.532 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2013-08-22T16:31:18.533Z,1377189078.533 [logger ThreadHandler](DEBUG): Created PCaller Thread at 403CB4E0
2013-08-22T16:31:18.533Z,1377189078.533 [Supervisor](INFO): Looking for Config files in directory: Config/
2013-08-22T16:31:18.535Z,1377189078.535 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2013-08-22T16:31:18.812Z,1377189078.812 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2013-08-22T16:31:18.813Z,1377189078.813 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2013-08-22T16:31:19.004Z,1377189079.004 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2013-08-22T16:31:19.004Z,1377189079.004 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2013-08-22T16:31:19.088Z,1377189079.088 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2013-08-22T16:31:19.089Z,1377189079.089 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2013-08-22T16:31:19.200Z,1377189079.200 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2013-08-22T16:31:19.200Z,1377189079.200 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2013-08-22T16:31:19.337Z,1377189079.337 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2013-08-22T16:31:19.338Z,1377189079.338 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2013-08-22T16:31:19.574Z,1377189079.574 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2013-08-22T16:31:19.575Z,1377189079.575 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2013-08-22T16:31:19.737Z,1377189079.737 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2013-08-22T16:31:19.738Z,1377189079.738 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2013-08-22T16:31:19.998Z,1377189079.998 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2013-08-22T16:31:19.998Z,1377189079.998 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2013-08-22T16:31:20.100Z,1377189080.099 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2013-08-22T16:31:20.100Z,1377189080.100 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2013-08-22T16:31:20.510Z,1377189080.510 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2013-08-22T16:31:20.510Z,1377189080.510 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2013-08-22T16:31:20.619Z,1377189080.619 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2013-08-22T16:31:20.620Z,1377189080.620 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2013-08-22T16:31:20.705Z,1377189080.705 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2013-08-22T16:31:20.706Z,1377189080.706 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2013-08-22T16:31:20.804Z,1377189080.804 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2013-08-22T16:31:20.930Z,1377189080.930 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2013-08-22T16:31:21.023Z,1377189081.023 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2013-08-22T16:31:21.127Z,1377189081.127 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2013-08-22T16:31:21.222Z,1377189081.222 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2013-08-22T16:31:21.335Z,1377189081.335 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2013-08-22T16:31:21.430Z,1377189081.430 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2013-08-22T16:31:21.516Z,1377189081.516 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/LOGIN/
2013-08-22T16:31:21.517Z,1377189081.517 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2013-08-22T16:31:21.518Z,1377189081.518 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2013-08-22T16:31:21.678Z,1377189081.678 [InternalSim] Loaded
2013-08-22T16:31:21.678Z,1377189081.678 [ComponentRegistry](DEBUG): SyncComponent "InternalSim" handled in the control thread.
2013-08-22T16:31:21.679Z,1377189081.679 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2013-08-22T16:31:21.679Z,1377189081.679 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2013-08-22T16:31:21.763Z,1377189081.763 [SBIT](DEBUG): Construct Startup Built In Test.
2013-08-22T16:31:21.792Z,1377189081.792 [SBIT] Loaded
2013-08-22T16:31:21.792Z,1377189081.792 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2013-08-22T16:31:21.793Z,1377189081.793 [IBIT](DEBUG): Construct Initiated Built In Test.
2013-08-22T16:31:21.822Z,1377189081.822 [IBIT] Loaded
2013-08-22T16:31:21.822Z,1377189081.822 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2013-08-22T16:31:21.824Z,1377189081.824 [CBIT](DEBUG): Construct CBIT Built In Test.
2013-08-22T16:31:21.946Z,1377189081.946 [CBIT] Loaded
2013-08-22T16:31:21.946Z,1377189081.946 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2013-08-22T16:31:21.947Z,1377189081.947 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2013-08-22T16:31:21.947Z,1377189081.947 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2013-08-22T16:31:22.131Z,1377189082.131 [BuoyancyServo] Loaded
2013-08-22T16:31:22.131Z,1377189082.131 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2013-08-22T16:31:22.143Z,1377189082.143 [ElevatorServo] Loaded
2013-08-22T16:31:22.143Z,1377189082.143 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2013-08-22T16:31:22.154Z,1377189082.154 [MassServo] Loaded
2013-08-22T16:31:22.155Z,1377189082.155 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2013-08-22T16:31:22.166Z,1377189082.166 [RudderServo] Loaded
2013-08-22T16:31:22.166Z,1377189082.166 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2013-08-22T16:31:22.177Z,1377189082.177 [ThrusterServo] Loaded
2013-08-22T16:31:22.178Z,1377189082.178 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2013-08-22T16:31:22.178Z,1377189082.178 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2013-08-22T16:31:22.179Z,1377189082.179 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2013-08-22T16:31:22.213Z,1377189082.213 [DepthRateCalculator] Loaded
2013-08-22T16:31:22.214Z,1377189082.214 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2013-08-22T16:31:25.444Z,1377189085.444 [HFRadarModelCalc] Loaded
2013-08-22T16:31:25.444Z,1377189085.444 [ComponentRegistry](DEBUG): SyncComponent "HFRadarModelCalc" handled in the control thread.
2013-08-22T16:31:25.460Z,1377189085.460 [NavChart] Loaded
2013-08-22T16:31:25.460Z,1377189085.460 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2013-08-22T16:31:25.466Z,1377189085.466 [PitchRateCalculator] Loaded
2013-08-22T16:31:25.466Z,1377189085.466 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2013-08-22T16:31:25.477Z,1377189085.477 [SpeedCalculator] Loaded
2013-08-22T16:31:25.477Z,1377189085.477 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2013-08-22T16:31:25.493Z,1377189085.493 [TempGradientCalculator] Loaded
2013-08-22T16:31:25.493Z,1377189085.493 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2013-08-22T16:31:25.498Z,1377189085.499 [YawRateCalculator] Loaded
2013-08-22T16:31:25.499Z,1377189085.499 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2013-08-22T16:31:25.545Z,1377189085.545 [Navigation] Loaded
2013-08-22T16:31:25.545Z,1377189085.545 [ComponentRegistry](DEBUG): SyncComponent "Navigation" handled in the control thread.
2013-08-22T16:31:25.546Z,1377189085.546 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2013-08-22T16:31:25.546Z,1377189085.546 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2013-08-22T16:31:25.775Z,1377189085.776 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2013-08-22T16:31:25.776Z,1377189085.776 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2013-08-22T16:31:25.799Z,1377189085.799 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2013-08-22T16:31:25.799Z,1377189085.799 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2013-08-22T16:31:25.846Z,1377189085.846 [VerticalControl](DEBUG): Construct VerticalControl.
2013-08-22T16:31:25.938Z,1377189085.938 [VerticalControl] Loaded
2013-08-22T16:31:25.938Z,1377189085.938 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2013-08-22T16:31:25.939Z,1377189085.939 [HorizontalControl](DEBUG): Construct HorizontalControl.
2013-08-22T16:31:25.996Z,1377189085.996 [HorizontalControl] Loaded
2013-08-22T16:31:25.996Z,1377189085.996 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2013-08-22T16:31:25.997Z,1377189085.997 [SpeedControl](DEBUG): Construct SpeedControl.
2013-08-22T16:31:25.999Z,1377189085.999 [SpeedControl] Loaded
2013-08-22T16:31:25.999Z,1377189085.999 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2013-08-22T16:31:25.999Z,1377189086.000 [LoopControl](DEBUG): Construct LoopControl.
2013-08-22T16:31:26.000Z,1377189086.000 [LoopControl] Loaded
2013-08-22T16:31:26.000Z,1377189086.000 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2013-08-22T16:31:26.001Z,1377189086.001 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2013-08-22T16:31:26.001Z,1377189086.001 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2013-08-22T16:31:26.007Z,1377189086.007 [AsyncPiEstimator](DEBUG): Construct AsyncPiEstimator.
2013-08-22T16:31:26.012Z,1377189086.012 [AsyncPiEstimator] Loaded
2013-08-22T16:31:26.012Z,1377189086.012 [ComponentRegistry](DEBUG): Component "AsyncPiEstimator" handled in its own thread.
2013-08-22T16:31:26.014Z,1377189086.013 [AsyncPiEstimator ThreadHandler](DEBUG): Created PCaller Thread at 4064F4E0
2013-08-22T16:31:26.014Z,1377189086.014 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2013-08-22T16:31:26.015Z,1377189086.015 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2013-08-22T16:31:26.206Z,1377189086.206 [AHRS_sp3003D] Loaded
2013-08-22T16:31:26.207Z,1377189086.207 [ComponentRegistry](DEBUG): SyncComponent "AHRS_sp3003D" handled in the control thread.
2013-08-22T16:31:26.452Z,1377189086.452 [Batt_Ocean_Server] Loaded
2013-08-22T16:31:26.452Z,1377189086.453 [ComponentRegistry](DEBUG): SyncComponent "Batt_Ocean_Server" handled in the control thread.
2013-08-22T16:31:26.466Z,1377189086.466 [Depth_Keller] Loaded
2013-08-22T16:31:26.467Z,1377189086.467 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2013-08-22T16:31:26.471Z,1377189086.471 [DropWeight] Loaded
2013-08-22T16:31:26.472Z,1377189086.472 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2013-08-22T16:31:26.651Z,1377189086.651 [DVL_micro] Loaded
2013-08-22T16:31:26.651Z,1377189086.651 [ComponentRegistry](DEBUG): Component "DVL_micro" handled in its own thread.
2013-08-22T16:31:26.653Z,1377189086.653 [DVL_micro ThreadHandler](DEBUG): Created PCaller Thread at 406DE4E0
2013-08-22T16:31:26.738Z,1377189086.739 [NAL9602] Loaded
2013-08-22T16:31:26.739Z,1377189086.739 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2013-08-22T16:31:26.781Z,1377189086.781 [Onboard] Loaded
2013-08-22T16:31:26.781Z,1377189086.782 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2013-08-22T16:31:26.788Z,1377189086.788 [Radio_Freewave] Loaded
2013-08-22T16:31:26.789Z,1377189086.789 [ComponentRegistry](DEBUG): SyncComponent "Radio_Freewave" handled in the control thread.
2013-08-22T16:31:26.937Z,1377189086.937 [DAT] Loaded
2013-08-22T16:31:26.937Z,1377189086.937 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2013-08-22T16:31:26.938Z,1377189086.938 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2013-08-22T16:31:26.938Z,1377189086.938 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2013-08-22T16:31:27.035Z,1377189087.035 [CTD_NeilBrown] Loaded
2013-08-22T16:31:27.035Z,1377189087.035 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2013-08-22T16:31:27.036Z,1377189087.036 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 4073B4E0
2013-08-22T16:31:27.038Z,1377189087.038 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2013-08-22T16:31:27.040Z,1377189087.040 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2013-08-22T16:31:27.041Z,1377189087.041 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2013-08-22T16:31:27.048Z,1377189087.048 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2013-08-22T16:31:27.049Z,1377189087.049 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 4076B4E0
2013-08-22T16:31:27.053Z,1377189087.053 [Supervisor](DEBUG): Running supervisor.
2013-08-22T16:31:27.054Z,1377189087.054 [CommandLine](INFO): Thread ID is 1519
2013-08-22T16:31:27.056Z,1377189087.056 [controlThread](INFO): Thread ID is 1518
2013-08-22T16:31:27.056Z,1377189087.056 [controlThread](DEBUG): Initializing ControlThread
2013-08-22T16:31:27.057Z,1377189087.057 [CycleStarter](INFO): Thread ID is 1517
2013-08-22T16:31:27.058Z,1377189087.057 [InternalSim](DEBUG):  InternalSim initializing...
2013-08-22T16:31:27.092Z,1377189087.092 [logger](INFO): Thread ID is 1520
2013-08-22T16:31:27.114Z,1377189087.114 [SBIT](INFO): Initialize SBIT Component.
2013-08-22T16:31:27.114Z,1377189087.114 [SBIT](IMPORTANT): Tethys CM Info: 
 $Rev:10560
2013-08-22T16:31:27.115Z,1377189087.115 [SBIT](IMPORTANT): Kernel Release:2.6.27.8
2013-08-22T16:31:27.115Z,1377189087.115 [SBIT](IMPORTANT): Kernel Version:#634 PREEMPT Wed Feb 13 10:21:48 PST 2013
2013-08-22T16:31:27.115Z,1377189087.115 [IBIT](INFO): Initialize IBIT Component.
2013-08-22T16:31:27.116Z,1377189087.116 [CBIT](DEBUG): Initialize CBIT Component.
2013-08-22T16:31:27.116Z,1377189087.116 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2013-08-22T16:31:27.126Z,1377189087.126 [AsyncPiEstimator](INFO): Thread ID is 1581
2013-08-22T16:31:27.126Z,1377189087.126 [AsyncPiEstimator](DEBUG): Initialize AsyncPiEstimator.
2013-08-22T16:31:27.147Z,1377189087.147 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2013-08-22T16:31:27.147Z,1377189087.147 [NavChart](DEBUG): Initialize NavChart Derivation.
2013-08-22T16:31:27.148Z,1377189087.148 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2013-08-22T16:31:27.148Z,1377189087.148 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2013-08-22T16:31:27.148Z,1377189087.148 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2013-08-22T16:31:27.149Z,1377189087.149 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2013-08-22T16:31:27.149Z,1377189087.149 [Navigation](DEBUG): Initializing Navigation.
2013-08-22T16:31:27.150Z,1377189087.150 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2013-08-22T16:31:27.152Z,1377189087.151 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2013-08-22T16:31:27.152Z,1377189087.152 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2013-08-22T16:31:27.153Z,1377189087.153 [LoopControl](DEBUG): Initialize LoopControlComponent.
2013-08-22T16:31:27.155Z,1377189087.155 [DVL_micro](INFO): Thread ID is 1582
2013-08-22T16:31:27.164Z,1377189087.164 [DVL_micro](INFO): Initializing
2013-08-22T16:31:27.164Z,1377189087.164 [DVL_micro](INFO): start:Powering up
2013-08-22T16:31:27.165Z,1377189087.165 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-08-22T16:31:27.166Z,1377189087.166 [DVL_micro](INFO): Cycling power to configure device.
2013-08-22T16:31:27.179Z,1377189087.179 [CTD_NeilBrown](INFO): Thread ID is 1583
2013-08-22T16:31:27.179Z,1377189087.179 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown.
2013-08-22T16:31:27.182Z,1377189087.182 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2013-08-22T16:31:27.191Z,1377189087.191 [NavChartDb](INFO): Thread ID is 1584
2013-08-22T16:31:27.198Z,1377189087.198 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources
2013-08-22T16:31:27.199Z,1377189087.199 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2013-08-22T16:31:27.199Z,1377189087.199 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2013-08-22T16:31:27.199Z,1377189087.199 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2013-08-22T16:31:27.200Z,1377189087.200 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2013-08-22T16:31:27.200Z,1377189087.200 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2013-08-22T16:31:27.200Z,1377189087.200 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2013-08-22T16:31:27.200Z,1377189087.200 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2013-08-22T16:31:27.201Z,1377189087.201 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2013-08-22T16:31:28.813Z,1377189088.813 [Batt_Ocean_Server](INFO): Ocean Server Batteries initialized
2013-08-22T16:31:28.845Z,1377189088.845 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2013-08-22T16:31:28.864Z,1377189088.864 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2013-08-22T16:31:28.887Z,1377189088.886 [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-08-22T16:31:28.887Z,1377189088.887 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2013-08-22T16:31:28.973Z,1377189088.973 [MissionManager](INFO): DefineArg Default.NeedGPS = 1 bool
2013-08-22T16:31:28.975Z,1377189088.976 [Default:GPS:A.SetSpeed](DEBUG): Construct.
2013-08-22T16:31:28.991Z,1377189088.991 [Default:GPS:B.GoToSurface](DEBUG): Construct GoToSurface.
2013-08-22T16:31:29.031Z,1377189089.031 [Default:Iridium:A.SetSpeed](DEBUG): Construct.
2013-08-22T16:31:29.034Z,1377189089.034 [Default:Iridium:B.GoToSurface](DEBUG): Construct GoToSurface.
2013-08-22T16:31:29.052Z,1377189089.052 [Default:Iridium:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2013-08-22T16:31:29.062Z,1377189089.062 [Default:D.SetSpeed](DEBUG): Construct.
2013-08-22T16:31:29.065Z,1377189089.065 [Default:E.GoToSurface](DEBUG): Construct GoToSurface.
2013-08-22T16:31:29.091Z,1377189089.091 [Default:F.Wait](DEBUG): Construct Wait.
2013-08-22T16:31:29.118Z,1377189089.118 [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-08-22T16:31:29.123Z,1377189089.123 [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-08-22T16:31:29.171Z,1377189089.171 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D.
2013-08-22T16:31:29.242Z,1377189089.242 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-08-22T16:31:29.242Z,1377189089.242 [DVL_micro](INFO): Querying output modes
2013-08-22T16:31:29.243Z,1377189089.243 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-08-22T16:31:29.254Z,1377189089.254 [DVL_micro](DEBUG): cmdResponse: 01 03 16
2013-08-22T16:31:29.254Z,1377189089.254 [DVL_micro](INFO): NQ1 output enabled
2013-08-22T16:31:29.254Z,1377189089.254 [DVL_micro](INFO): RSSI output enabled
2013-08-22T16:31:29.254Z,1377189089.254 [DVL_micro](INFO): ADCP output enabled
2013-08-22T16:31:29.255Z,1377189089.255 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-08-22T16:31:29.266Z,1377189089.266 [DVL_micro](DEBUG): cmdResponse: AUTO_VEL_ON 
2013-08-22T16:31:29.271Z,1377189089.271 [DVL_micro](INFO): pause:Powering down
2013-08-22T16:31:29.421Z,1377189089.421 [Radio_Freewave](INFO): Powering up
2013-08-22T16:31:29.450Z,1377189089.450 [DAT](INFO): Powering up
2013-08-22T16:31:29.450Z,1377189089.450 [DAT](DEBUG): Initializing DAT.
2013-08-22T16:31:29.645Z,1377189089.645 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2013-08-22T16:31:29.646Z,1377189089.647 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2013-08-22T16:31:29.657Z,1377189089.657 [ElevatorServo](DEBUG): Initializing EZServoServo.
2013-08-22T16:31:29.662Z,1377189089.662 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2013-08-22T16:31:29.668Z,1377189089.668 [MassServo](DEBUG): Initializing EZServoServo.
2013-08-22T16:31:29.674Z,1377189089.674 [MassServo](DEBUG): Initializing MassServo.
2013-08-22T16:31:29.680Z,1377189089.680 [RudderServo](DEBUG): Initializing EZServoServo.
2013-08-22T16:31:29.686Z,1377189089.686 [RudderServo](DEBUG): Initializing RudderServo.
2013-08-22T16:31:29.692Z,1377189089.691 [ThrusterServo](DEBUG): Initializing EZServoServo.
2013-08-22T16:31:29.726Z,1377189089.726 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2013-08-22T16:31:32.168Z,1377189092.168 [NAL9602](INFO): Powering up NAL9602
2013-08-22T16:31:42.532Z,1377189102.532 [SBIT](IMPORTANT): Beginning Startup BIT
2013-08-22T16:31:42.535Z,1377189102.535 [CBIT](IMPORTANT): Beginning GF scan
2013-08-22T16:31:42.930Z,1377189102.930 [NAL9602](INFO): NAL9602 initialized
2013-08-22T16:31:47.134Z,1377189107.134 [CommandLine](IMPORTANT): got command failComponent
2013-08-22T16:31:47.134Z,1377189107.134 [CommandLine](IMPORTANT): Failed components:
2013-08-22T16:31:47.134Z,1377189107.134 [CommandLine](IMPORTANT): No failed Components.
2013-08-22T16:31:49.541Z,1377189109.541 [DAT](INFO): Powering down
2013-08-22T16:32:09.066Z,1377189129.066 [CBIT](IMPORTANT): No ground fault detected
2013-08-22T16:32:28.838Z,1377189148.838 [CommandLine](IMPORTANT): got command run ./Missions/Insert/Science.xml
2013-08-22T16:32:28.838Z,1377189148.838 [MissionManager](INFO): Loading Mission: ./Missions/Insert/Science.xml
2013-08-22T16:32:28.971Z,1377189148.971 [MissionManager](INFO): DefineArg Science.SampleISUS = 0 bool
2013-08-22T16:32:28.975Z,1377189148.975 [MissionManager](INFO): DefineArg Science.SampleISUSmaxPitch = 60.000000 arcdeg
2013-08-22T16:32:28.978Z,1377189148.978 [MissionManager](INFO): DefineArg Science.SampleISUSminPitch = -60.000000 arcdeg
2013-08-22T16:32:28.981Z,1377189148.981 [MissionManager](INFO): DefineArg Science.SampleRSSI = 1 bool
2013-08-22T16:32:28.984Z,1377189148.984 [MissionManager](INFO): DefineArg Science.SampleADCP = 1 bool
2013-08-22T16:32:28.987Z,1377189148.987 [MissionManager](INFO): DefineArg Science.PeakDetectChlActive = 0 bool
2013-08-22T16:32:28.989Z,1377189148.990 [MissionManager](INFO): DefineArg Science.PeakDetectNO3Active = 0 bool
2013-08-22T16:32:28.992Z,1377189148.992 [MissionManager](INFO): DefineArg Science.PeakDetectRSSIActive = 0 bool
2013-08-22T16:32:29.044Z,1377189149.044 [MissionManager](INFO): DefineArg Science.UpwardDerivativeOfTemperatureActive = 0 bool
2013-08-22T16:32:29.047Z,1377189149.047 [MissionManager](INFO): DefineArg Science.ComputeWaterCurrent = 0 bool
2013-08-22T16:32:29.050Z,1377189149.050 [MissionManager](INFO): DefineArg Science.ComputeWaterCurrentMinDepth = 2.000000 m
2013-08-22T16:32:29.053Z,1377189149.053 [MissionManager](INFO): DefineArg Science.ComputeWaterCurrentMaxDepth = 5.000000 m
2013-08-22T16:32:29.057Z,1377189149.057 [MissionManager](INFO): DefineArg Science.EnabledAanderaaO2 = 0.000000 n/a
2013-08-22T16:32:29.060Z,1377189149.060 [MissionManager](INFO): DefineArg Science.EnabledNeilBrown = 1.000000 n/a
2013-08-22T16:32:29.064Z,1377189149.064 [MissionManager](INFO): DefineArg Science.EnabledTurbulence_NPS = 0.000000 n/a
2013-08-22T16:32:29.069Z,1377189149.069 [MissionManager](INFO): DefineArg Science.EnabledWetLabsBB2FL = 0.000000 n/a
2013-08-22T16:32:29.073Z,1377189149.073 [MissionManager](INFO): DefineArg Science.EnabledDVL = 1.000000 n/a
2013-08-22T16:32:29.076Z,1377189149.076 [MissionManager](INFO): DefineArg Science.EnabledISUS = 0.000000 n/a
2013-08-22T16:32:29.081Z,1377189149.081 [MissionManager](INFO): DefineArg Science.HFRadarModelActive = 0 bool
2013-08-22T16:32:29.084Z,1377189149.084 [MissionManager](INFO): DefineOutput Science.PeakChl = 0.000000 ug/l
2013-08-22T16:32:29.088Z,1377189149.088 [MissionManager](INFO): DefineOutput Science.PeakChlDepth = 0.000000 m
2013-08-22T16:32:29.091Z,1377189149.091 [MissionManager](INFO): DefineOutput Science.PeakChlLatitude = nan arcdeg
2013-08-22T16:32:29.115Z,1377189149.115 [MissionManager](INFO): DefineOutput Science.PeakChlLongitude = nan arcdeg
2013-08-22T16:32:29.118Z,1377189149.118 [MissionManager](INFO): DefineOutput Science.PeakNO3 = 0.000000 umol/l
2013-08-22T16:32:29.122Z,1377189149.122 [MissionManager](INFO): DefineOutput Science.PeakNO3Depth = 0.000000 m
2013-08-22T16:32:29.125Z,1377189149.125 [MissionManager](INFO): DefineOutput Science.PeakNO3Latitude = nan arcdeg
2013-08-22T16:32:29.136Z,1377189149.136 [MissionManager](INFO): DefineOutput Science.PeakNO3Longitude = nan arcdeg
2013-08-22T16:32:29.140Z,1377189149.140 [MissionManager](INFO): DefineOutput Science.PeakRSSI = 0.000000 dB
2013-08-22T16:32:29.144Z,1377189149.144 [MissionManager](INFO): DefineOutput Science.PeakRSSIDepth = 0.000000 m
2013-08-22T16:32:29.147Z,1377189149.147 [MissionManager](INFO): DefineOutput Science.PeakRSSILatitude = nan arcdeg
2013-08-22T16:32:29.152Z,1377189149.151 [MissionManager](INFO): DefineOutput Science.PeakRSSILongitude = nan arcdeg
2013-08-22T16:32:29.155Z,1377189149.155 [MissionManager](INFO): DefineOutput Science.eastwardSurfaceCurrent = nan m/s
2013-08-22T16:32:29.158Z,1377189149.158 [MissionManager](INFO): DefineOutput Science.northwardSurfaceCurrent = nan m/s
2013-08-22T16:32:29.210Z,1377189149.210 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2013-08-22T16:32:29.242Z,1377189149.242 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2013-08-22T16:32:29.257Z,1377189149.257 [Science:PeakDetectRSSI:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2013-08-22T16:32:29.288Z,1377189149.288 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Aggregate xmlns="Tethys"
       xmlns:Derivation="Tethys/Derivation"
       xmlns:Science="Tethys/Science"
       xmlns:Sensor="Tethys/Sensor"
       xmlns:Trigger="Tethys/Trigger"
       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/Derivation http://aosn.mbari.org/tethys/Xml/Derivation.xsd
                           Tethys/Science http://aosn.mbari.org/tethys/Xml/Science.xsd
                           Tethys/Sensor http://aosn.mbari.org/tethys/Xml/Sensor.xsd
                           Tethys/Trigger http://aosn.mbari.org/tethys/Xml/Trigger.xsd
                           Tethys/Units http://aosn.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://aosn.mbari.org/tethys/Xml/Universal.xsd"
       Id="Science"
       RunIn="Parallel">

    <DefineArg Name="SampleISUS"><Description>
        Set either this or PeakDetectNO3Active to True in order to sample
        Nitrate. EnabledISUS must also be true.
    </Description><False/></DefineArg>

    <DefineArg Name="SampleISUSmaxPitch"><Description>
        Maximum pitch to sample ISUS. (EnabledISUS must also be true.)
    </Description><Units:degree/><Value>60.0</Value></DefineArg>

    <DefineArg Name="SampleISUSminPitch"><Description>
        Minimum pitch to sample ISUS. (EnabledISUS must also be true.)
    </Description><Units:degree/><Value>-60.0</Value></DefineArg>

    <DefineArg Name="SampleRSSI"><Description>
        Set to True in order to sample RSSI data from the DVL. EnabledDVL must
        also be true.
    </Description><True/></DefineArg>

    <DefineArg Name="SampleADCP"><Description>
        Set to True in order to sample ADCP data from the DVL. EnabledDVL must
        also be true.
    </Description><True/></DefineArg>

    <DefineArg Name="PeakDetectChlActive"><Description>
        Turns on peak detection of Cholorphyll.
    </Description><False/></DefineArg>

    <DefineArg Name="PeakDetectNO3Active"><Description>
        Turns on peak detection of Nitrate (and turns on ISUS).
    </Description><False/></DefineArg>

    <DefineArg Name="PeakDetectRSSIActive"><Description>
        Turns on peak detection of RSSI (and turns on RSSI mode of DVL).
    </Description><False/></DefineArg>

    <DefineArg Name="UpwardDerivativeOfTemperatureActive"><Description>
        Turns on seawater temperature derivative.
    </Description><False/></DefineArg>

    <DefineArg Name="ComputeWaterCurrent"><Description>
        Compute and report water current (from LinkQuest full column average)
    </Description><False/></DefineArg>

    <DefineArg Name="ComputeWaterCurrentMinDepth"><Description>
        Minimum depth to compute and report water current (from LinkQuest full
        column average)
    </Description><Units:meter/><Value>2.0</Value></DefineArg>

    <DefineArg Name="ComputeWaterCurrentMaxDepth"><Description>
        Maximum depth to compute and report water current (from LinkQuest full
        column average)
    </Description><Units:meter/><Value>5.0</Value></DefineArg>

    <DefineArg Name="EnabledAanderaaO2"><Description>
        Automatically set to True if the Aanderaa O2 sensor is installed. Set to
        false to disable reading Aandera O2.
    </Description><CustomUri Uri="Aanderaa_O2.loadAtStartup"/></DefineArg>

    <DefineArg Name="EnabledNeilBrown"><Description>
        Automatically set to true if the Neil Brown CTD is enabled. Set to false
        to disable reading from the Neil Brown.
    </Description><CustomUri Uri="CTD_NeilBrown.loadAtStartup"/></DefineArg>

    <DefineArg Name="EnabledTurbulence_NPS"><Description>
        Automatically set to true if the NPS Turbulence sensor is enabled. Set
        to false to disable reading from the NPS Turbulence sensor.
    </Description><CustomUri Uri="Turbulence_NPS.loadAtStartup"/></DefineArg>

    <DefineArg Name="EnabledWetLabsBB2FL"><Description>
        Automatically set to true if the the WetLabs BB2FL is enabled. Set to
        false to disable the WetLabs BB2FL.
    </Description><CustomUri Uri="WetLabsBB2FL.loadAtStartup"/></DefineArg>

    <DefineArg Name="EnabledDVL"><Description>
        Automatically set to True if DVL is enabled. Set to false to disable the
        DVL.
    </Description><CustomUri Uri="DVL_micro.loadAtStartup"/></DefineArg>

    <DefineArg Name="EnabledISUS"><Description>
        Automatically set to True if ISUS is enabled. Set to false to disable
        ISUS.
    </Description><CustomUri Uri="ISUS.loadAtStartup"/></DefineArg>

    <DefineArg Name="HFRadarModelActive"><Description>
        Set True to enable continuous surface current estimation at vehicle
        position.
    </Description><False/></DefineArg>

    <DefineOutput Name="PeakChl"><Units:microgram_per_liter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakChlDepth"><Units:meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakChlLatitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PeakChlLongitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PeakNO3"><Units:micromole_per_liter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakNO3Depth"><Units:meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakNO3Latitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PeakNO3Longitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PeakRSSI"><Units:decibel/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakRSSIDepth"><Units:meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakRSSILatitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PeakRSSILongitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="eastwardSurfaceCurrent"><Units:meter_per_second/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="northwardSurfaceCurrent"><Units:meter_per_second/><Value>NaN</Value></DefineOutput>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledAanderaaO2"/>
        </While>
        <Universal:mass_concentration_of_oxygen_in_sea_water/>
    </ReadData>

<!-- See if the ISUS should get turned on -->

    <ReadData>
        <While>
            <Arg Name="EnabledISUS"/>
            <And><Universal:platform_pitch_angle/><Lt><Arg Name="SampleISUSmaxPitch"/></Lt><And><Universal:platform_pitch_angle/><Gt><Arg Name="SampleISUSminPitch"/></Gt><And><Arg Name="SampleISUS"/><Or><Arg Name="PeakDetectNO3Active"/></Or></And></And></And>
        </While>
        <Universal:mole_concentration_of_nitrate_in_sea_water/>
    </ReadData>

<!-- Get computed currents. Having this disabled _shouldn't_ kill other DVL data. -->

    <ReadData>
        <While>
            <Arg Name="EnabledDVL"/>
            <And><Arg Name="ComputeWaterCurrent"/><And><Universal:depth/><Gt><Arg Name="ComputeWaterCurrentMinDepth"/></Gt><And><Universal:depth/><Lt><Arg Name="ComputeWaterCurrentMaxDepth"/></Lt></And></And></And>
        </While>
        <Universal:platform_x_velocity_current/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledNeilBrown"/>
        </While>
        <Universal:sea_water_temperature/>
        <Universal:sea_water_salinity/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledNeilBrown"/>
            <And><Arg Name="UpwardDerivativeOfTemperatureActive"/></And>
        </While>
        <Universal:upward_derivative_of_sea_water_temperature/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledTurbulence_NPS"/>
        </While>
        <Science:Turbulence_NPS.MicroCond/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="SampleADCP"/>
            <And><Arg Name="EnabledDVL"/></And>
        </While>
        <Sensor:DVL_micro.AdcpXWaterVelocity/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledDVL"/>
            <And><Arg Name="SampleRSSI"/><Or><Arg Name="PeakDetectRSSIActive"/></Or></And>
        </While>
        <Sensor:DVL_micro.Beam1RSSI/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledWetLabsBB2FL"/>
            <Or><Arg Name="PeakDetectChlActive"/></Or>
        </While>
        <Universal:mass_concentration_of_chlorophyll_in_sea_water/>
    </ReadData>

    <Aggregate  Id="PeakDetectChl">

        <While>
            <Arg Name="PeakDetectChlActive"/>
        </While>

        <Trigger:PeakDetectVsDepth RunIn="Sequence" >
            <Setting><Trigger:PeakDetectVsDepth.detect/><Universal:mass_concentration_of_chlorophyll_in_sea_water/></Setting>
            <OutputArg Name="PeakChl"><Trigger:PeakDetectVsDepth.peakDetect/></OutputArg>
            <OutputArg Name="PeakChlDepth"><Trigger:PeakDetectVsDepth.peakDepth/></OutputArg>
            <OutputArg Name="PeakChlLatitude"><Trigger:PeakDetectVsDepth.peakLatitude/></OutputArg>
            <OutputArg Name="PeakChlLongitude"><Trigger:PeakDetectVsDepth.peakLongitude/></OutputArg>
        </Trigger:PeakDetectVsDepth>

        <SendData Service="Express"><Arg Name="PeakChl"/><Arg Name="PeakChlDepth"/>
        </SendData>

    </Aggregate>

    <Aggregate Id="PeakDetectNO3">

        <While>
            <Arg Name="PeakDetectNO3Active"/>
        </While>

        <Trigger:PeakDetectVsDepth RunIn="Sequence">
            <Setting><Trigger:PeakDetectVsDepth.detect/><Universal:mole_concentration_of_nitrate_in_sea_water/></Setting>
            <OutputArg Name="PeakNO3"><Trigger:PeakDetectVsDepth.peakDetect/></OutputArg>
            <OutputArg Name="PeakNO3Depth"><Trigger:PeakDetectVsDepth.peakDepth/></OutputArg>
            <OutputArg Name="PeakNO3Latitude"><Trigger:PeakDetectVsDepth.peakLatitude/></OutputArg>
            <OutputArg Name="PeakNO3Longitude"><Trigger:PeakDetectVsDepth.peakLongitude/></OutputArg>
        </Trigger:PeakDetectVsDepth>

        <SendData Service="Express"><Arg Name="PeakNO3"/><Arg Name="PeakNO3Depth"/>
        </SendData>

    </Aggregate>

    <Aggregate Id="PeakDetectRSSI">

        <While>
            <Arg Name="PeakDetectRSSIActive"/>
        </While>

        <Trigger:PeakDetectVsDepth RunIn="Sequence">
            <Setting><Trigger:PeakDetectVsDepth.detect/><Sensor:DVL_micro.RSSIMax/></Setting>
            <OutputArg Name="PeakRSSI"><Trigger:PeakDetectVsDepth.peakDetect/></OutputArg>
            <OutputArg Name="PeakRSSIDepth"><Trigger:PeakDetectVsDepth.peakDepth/></OutputArg>
            <OutputArg Name="PeakRSSILatitude"><Trigger:PeakDetectVsDepth.peakLatitude/></OutputArg>
            <OutputArg Name="PeakRSSILongitude"><Trigger:PeakDetectVsDepth.peakLongitude/></OutputArg>
        </Trigger:PeakDetectVsDepth>

        <SendData Service="Express"><Arg Name="PeakRSSI"/><Arg Name="PeakRSSIDepth"/>
        </SendData>

    </Aggregate>

    <Aggregate Id="HFRadarModel">

        <While>
            <Arg Name="HFRadarModelActive"/>
        </While>

        <Derivation:HFRadarModel RunIn="Parallel">
            <OutputArg Name="eastwardSurfaceCurrent"><Derivation:HFRadarModel.eastwardSurfaceCurrent/></OutputArg>
            <OutputArg Name="northwardSurfaceCurrent"><Derivation:HFRadarModel.northwardSurfaceCurrent/></OutputArg>
        </Derivation:HFRadarModel>

    </Aggregate>

</Aggregate>


2013-08-22T16:32:29.291Z,1377189149.291 [CommandLine](IMPORTANT): Running ./Missions/Insert/Science.xml
2013-08-22T16:32:33.954Z,1377189153.954 [CommandLine](IMPORTANT): got command show variable CTD
2013-08-22T16:32:33.961Z,1377189153.961 [CommandLine](INFO): CTD_NeilBrown.loadControl (none)
2013-08-22T16:32:33.962Z,1377189153.962 [CommandLine](INFO): CTD_NeilBrown.uart (none)
2013-08-22T16:32:33.962Z,1377189153.962 [CommandLine](INFO): CTD_NeilBrown.baud (bit_per_second)
2013-08-22T16:32:33.970Z,1377189153.970 [CommandLine](INFO): CTD_NeilBrown.loadAtStartup (bool)
2013-08-22T16:32:33.971Z,1377189153.971 [CommandLine](INFO): CTD_NeilBrown.simulateHardware (bool)
2013-08-22T16:32:33.971Z,1377189153.971 [CommandLine](INFO): CTD_NeilBrown.power (watt)
2013-08-22T16:32:33.971Z,1377189153.971 [CommandLine](INFO): CTD_NeilBrown.maxPressBound (decibar)
2013-08-22T16:32:33.972Z,1377189153.972 [CommandLine](INFO): CTD_NeilBrown.minPressBound (decibar)
2013-08-22T16:32:33.972Z,1377189153.972 [CommandLine](INFO): CTD_NeilBrown.offset (decibar)
2013-08-22T16:32:33.972Z,1377189153.972 [CommandLine](INFO): CTD_NeilBrown.maxSalinityBound (practical_salinity_unit)
2013-08-22T16:32:33.973Z,1377189153.973 [CommandLine](INFO): CTD_NeilBrown.minSalinityBound (practical_salinity_unit)
2013-08-22T16:32:34.047Z,1377189154.046 [CommandLine](INFO): CTD_NeilBrown.sea_water_density (kilogram_per_cubic_meter)
2013-08-22T16:32:34.047Z,1377189154.047 [CommandLine](INFO): CTD_NeilBrown.depth (meter)
2013-08-22T16:32:34.047Z,1377189154.047 [CommandLine](INFO): CTD_NeilBrown.sea_water_pressure (decibar)
2013-08-22T16:32:34.048Z,1377189154.048 [CommandLine](INFO): CTD_NeilBrown.sea_water_salinity (practical_salinity_unit)
2013-08-22T16:32:34.048Z,1377189154.048 [CommandLine](INFO): CTD_NeilBrown.sea_water_temperature (celsius)
2013-08-22T16:32:34.048Z,1377189154.048 [CommandLine](INFO): CTD_NeilBrown.sea_water_electrical_conductivity (millimho_per_centimeter)
2013-08-22T16:32:34.057Z,1377189154.057 [CommandLine](INFO): CTD_NeilBrown.durationOfLastRun (second)
2013-08-22T16:32:34.058Z,1377189154.058 [CommandLine](INFO): CTD_NeilBrown.component_voltage (volt)
2013-08-22T16:32:34.058Z,1377189154.058 [CommandLine](INFO): CTD_NeilBrown.component_avgVoltage (volt)
2013-08-22T16:32:34.058Z,1377189154.058 [CommandLine](INFO): CTD_NeilBrown.component_current (milliampere)
2013-08-22T16:32:34.059Z,1377189154.059 [CommandLine](INFO): CTD_NeilBrown.component_avgCurrent (milliampere)
2013-08-22T16:32:36.419Z,1377189156.419 [SBIT](IMPORTANT): SBIT PASSED
2013-08-22T16:32:36.856Z,1377189156.856 [MissionManager](IMPORTANT): Started mission Startup
2013-08-22T16:32:36.856Z,1377189156.856 [Startup] Running Loop=1
2013-08-22T16:32:36.856Z,1377189156.856 [Startup](INFO): Aggregate::initialize Startup
2013-08-22T16:32:36.856Z,1377189156.856 [Startup:A.GoToSurface] Running Loop=1
2013-08-22T16:32:36.856Z,1377189156.856 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-08-22T16:32:36.862Z,1377189156.862 [Startup:StartupSatComms] Running Loop=1
2013-08-22T16:32:36.863Z,1377189156.862 [Startup:StartupSatComms](INFO): Aggregate::initialize Startup:StartupSatComms
2013-08-22T16:32:36.863Z,1377189156.863 [Startup:StartupSatComms:A] Running Loop=1
2013-08-22T16:32:37.214Z,1377189157.214 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2013-08-22T16:32:46.526Z,1377189166.526 [CommandLine](IMPORTANT): got command report mod CTD_NeilBrown.sea_water_pressure
2013-08-22T16:32:46.865Z,1377189166.865 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure no_value
2013-08-22T16:32:51.246Z,1377189171.246 [CommandLine](IMPORTANT): got command report touch CTD_NeilBrown.sea_water_pressure
2013-08-22T16:33:05.422Z,1377189185.422 [CommandLine](IMPORTANT): got command report touch CTD_NeilBrown.component_voltage 
2013-08-22T16:33:09.470Z,1377189189.470 [CommandLine](IMPORTANT): got command show stack
2013-08-22T16:33:09.470Z,1377189189.470 [CommandLine](INFO): Behavior Stack:

2013-08-22T16:33:09.470Z,1377189189.470 [Startup](INFO): Priority 0: Startup:A.GoToSurface
2013-08-22T16:33:09.471Z,1377189189.471 [Startup:StartupSatComms](INFO): Priority 1: Startup:StartupSatComms:A
2013-08-22T16:33:17.518Z,1377189197.518 [CommandLine](IMPORTANT): got command set NAL9602.platform_communications 1.000000 bool
2013-08-22T16:33:26.026Z,1377189206.026 [CommandLine](IMPORTANT): got command set NAL9602.latitude_fix 36.799999 degree
2013-08-22T16:33:26.149Z,1377189206.149 [Startup:StartupSatComms:A] Stopped
2013-08-22T16:33:26.149Z,1377189206.149 [Startup:StartupSatComms:B] Running Loop=1
2013-08-22T16:33:26.515Z,1377189206.515 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2013-08-22T16:33:30.310Z,1377189210.310 [CommandLine](IMPORTANT): got command set NAL9602.platform_communications 1.000000 bool
2013-08-22T16:33:34.154Z,1377189214.154 [Startup:StartupSatComms:B] Stopped
2013-08-22T16:33:34.154Z,1377189214.155 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2013-08-22T16:33:34.155Z,1377189214.155 [Startup:StartupSatComms] Stopped
2013-08-22T16:33:34.155Z,1377189214.155 [Startup:StartupSatComms](INFO): Aggregate::uninitialize Startup:StartupSatComms
2013-08-22T16:33:34.155Z,1377189214.155 [Startup](INFO): Completed Startup
2013-08-22T16:33:34.156Z,1377189214.156 [Startup] Stopped
2013-08-22T16:33:34.156Z,1377189214.156 [Startup](INFO): Aggregate::uninitialize Startup
2013-08-22T16:33:34.156Z,1377189214.156 [Startup:A.GoToSurface] Stopped
2013-08-22T16:33:34.156Z,1377189214.156 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-08-22T16:33:35.056Z,1377189215.056 [MissionManager](IMPORTANT): Started mission Science
2013-08-22T16:33:35.056Z,1377189215.056 [Science] Running Loop=1
2013-08-22T16:33:35.057Z,1377189215.057 [Science](INFO): Aggregate::initialize Science
2013-08-22T16:33:35.057Z,1377189215.057 [Science:A] Running Loop=1
2013-08-22T16:33:35.057Z,1377189215.057 [Science:B] Running Loop=1
2013-08-22T16:33:35.057Z,1377189215.057 [Science:C] Running Loop=1
2013-08-22T16:33:35.057Z,1377189215.057 [Science:D] Running Loop=1
2013-08-22T16:33:35.057Z,1377189215.057 [Science:E] Running Loop=1
2013-08-22T16:33:35.057Z,1377189215.057 [Science:F] Running Loop=1
2013-08-22T16:33:35.057Z,1377189215.057 [Science:G] Running Loop=1
2013-08-22T16:33:35.057Z,1377189215.057 [Science:H] Running Loop=1
2013-08-22T16:33:35.057Z,1377189215.057 [Science:I] Running Loop=1
2013-08-22T16:33:35.058Z,1377189215.058 [Science:H] Running Loop=1
2013-08-22T16:33:35.059Z,1377189215.059 [Science:H](DEBUG): Initialize ReadDataComponent to sense DVL_micro.Beam1RSSI
2013-08-22T16:33:35.061Z,1377189215.061 [Science:G] Running Loop=1
2013-08-22T16:33:35.062Z,1377189215.062 [Science:G](DEBUG): Initialize ReadDataComponent to sense DVL_micro.AdcpXWaterVelocity
2013-08-22T16:33:35.063Z,1377189215.063 [Science:D] Running Loop=1
2013-08-22T16:33:35.064Z,1377189215.064 [Science:D](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature
2013-08-22T16:33:35.064Z,1377189215.064 [Science:D](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity
2013-08-22T16:33:35.243Z,1377189215.243 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2013-08-22T16:33:35.398Z,1377189215.398 [DVL_micro](INFO): NQ1 unrequested
2013-08-22T16:33:35.399Z,1377189215.399 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-08-22T16:33:35.399Z,1377189215.399 [DVL_micro](INFO): resume:Powering up
2013-08-22T16:33:35.399Z,1377189215.399 [DVL_micro](INFO): Cycling power to configure device.
2013-08-22T16:33:36.859Z,1377189216.859 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.189420 psu
2013-08-22T16:33:36.943Z,1377189216.943 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure -0.600000 db
2013-08-22T16:33:37.062Z,1377189217.062 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.957820 psu
2013-08-22T16:33:37.258Z,1377189217.258 [CTD_NeilBrown](ERROR): Salinity reading out of range: -2.986080 psu
2013-08-22T16:33:37.315Z,1377189217.315 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure -0.600000 db
2013-08-22T16:33:37.316Z,1377189217.316 [Reporter](INFO): CTD_NeilBrown.component_voltage 4.927440 V
2013-08-22T16:33:37.406Z,1377189217.406 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-08-22T16:33:37.406Z,1377189217.406 [DVL_micro](INFO): Querying output modes
2013-08-22T16:33:37.406Z,1377189217.406 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-08-22T16:33:37.418Z,1377189217.418 [DVL_micro](DEBUG): cmdResponse: 01 03 16
2013-08-22T16:33:37.418Z,1377189217.418 [DVL_micro](INFO): NQ1 output enabled
2013-08-22T16:33:37.418Z,1377189217.418 [DVL_micro](INFO): RSSI output enabled
2013-08-22T16:33:37.418Z,1377189217.418 [DVL_micro](INFO): ADCP output enabled
2013-08-22T16:33:37.418Z,1377189217.418 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-08-22T16:33:37.430Z,1377189217.430 [DVL_micro](DEBUG): cmdResponse: AUTO_VEL_ON 
2013-08-22T16:33:37.432Z,1377189217.432 [DVL_micro](INFO): NQ1 unrequested
2013-08-22T16:33:37.432Z,1377189217.432 [DVL_micro](INFO): Cycling power to configure device.
2013-08-22T16:33:37.470Z,1377189217.470 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.409790 psu
2013-08-22T16:33:37.670Z,1377189217.670 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.350040 psu
2013-08-22T16:33:37.738Z,1377189217.738 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure -0.610000 db
2013-08-22T16:33:37.870Z,1377189217.870 [CTD_NeilBrown](ERROR): Salinity reading out of range: -3.202310 psu
2013-08-22T16:33:38.070Z,1377189218.070 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.088830 psu
2013-08-22T16:33:38.119Z,1377189218.119 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure -0.600000 db
2013-08-22T16:33:38.266Z,1377189218.266 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.350460 psu
2013-08-22T16:33:38.474Z,1377189218.474 [CTD_NeilBrown](ERROR): Salinity reading out of range: -2.923830 psu
2013-08-22T16:33:38.530Z,1377189218.530 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure -0.610000 db
2013-08-22T16:33:38.658Z,1377189218.658 [CTD_NeilBrown](ERROR): Salinity reading out of range: 46.664719 psu
2013-08-22T16:33:38.870Z,1377189218.870 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.522290 psu
2013-08-22T16:33:38.940Z,1377189218.940 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure -0.600000 db
2013-08-22T16:33:38.940Z,1377189218.940 [Reporter](INFO): CTD_NeilBrown.component_voltage 4.852020 V
2013-08-22T16:33:39.062Z,1377189219.062 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.486890 psu
2013-08-22T16:33:39.258Z,1377189219.258 [CTD_NeilBrown](ERROR): Salinity reading out of range: -2.106950 psu
2013-08-22T16:33:39.312Z,1377189219.312 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure -0.600000 db
2013-08-22T16:33:39.442Z,1377189219.442 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-08-22T16:33:39.442Z,1377189219.442 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-08-22T16:33:39.467Z,1377189219.467 [DVL_micro](DEBUG): cmdResponse: ��v��|�����m�n�Y����j���j�W�m�c�i�p�q���������c�{�e�L�b����a�c�?�B�_�c�l�c�����
2013-08-22T16:33:39.467Z,1377189219.467 [DVL_micro](INFO): Enabling RSSI output
2013-08-22T16:33:39.467Z,1377189219.467 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 16 7

2013-08-22T16:33:39.470Z,1377189219.470 [CTD_NeilBrown](ERROR): Salinity reading out of range: -2.031630 psu
2013-08-22T16:33:39.491Z,1377189219.490 [DVL_micro](DEBUG): cmdResponse: ��������z��z�h�_�v��d�e�c�s�[�i�����x�p�_�B�H�V�`�Q�K�V�^�z���t�n�p��������f�S���
2013-08-22T16:33:39.491Z,1377189219.491 [DVL_micro](INFO): Enabling ADCP output
2013-08-22T16:33:39.491Z,1377189219.491 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 03 3

2013-08-22T16:33:39.494Z,1377189219.494 [DVL_micro](DEBUG): cmdResponse: a�w������r�g�a�f�^�Z�{�k�x�l�k�����s��e�S�T�?�e�S�H�P�]�y����z������e�U�Q�T�D�k�
2013-08-22T16:33:39.494Z,1377189219.494 [DVL_micro](INFO): Querying output modes
2013-08-22T16:33:39.494Z,1377189219.494 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-08-22T16:33:39.511Z,1377189219.511 [DVL_micro](DEBUG): cmdResponse: ��u�j�w�q�z�����u�����x�������q�d����q����x��j����������i�o�������
2013-08-22T16:33:39.511Z,1377189219.511 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-08-22T16:33:39.524Z,1377189219.524 [DVL_micro](DEBUG): cmdResponse: m�t�f�a�H�=�A�K�B�1�*�>�O�i�[���|�W�X����|����y�Z�Q�d�]�i�`��p�Q�q���r�����z�����
2013-08-22T16:33:39.666Z,1377189219.666 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.518350 psu
2013-08-22T16:33:39.777Z,1377189219.777 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure -0.610000 db
2013-08-22T16:33:39.866Z,1377189219.866 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.487480 psu
2013-08-22T16:33:40.078Z,1377189220.078 [CTD_NeilBrown](ERROR): Salinity reading out of range: 2.212260 psu
2013-08-22T16:33:40.135Z,1377189220.135 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure -0.600000 db
2013-08-22T16:33:40.274Z,1377189220.274 [CTD_NeilBrown](ERROR): Salinity reading out of range: 1.577300 psu
2013-08-22T16:33:40.478Z,1377189220.478 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.917650 psu
2013-08-22T16:33:40.541Z,1377189220.541 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure -0.600000 db
2013-08-22T16:33:40.541Z,1377189220.541 [Reporter](INFO): CTD_NeilBrown.component_voltage 4.826880 V
2013-08-22T16:33:40.690Z,1377189220.690 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.932300 psu
2013-08-22T16:33:40.876Z,1377189220.876 [NAL9602](INFO): Powering down
2013-08-22T16:33:40.886Z,1377189220.886 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.979400 psu
2013-08-22T16:33:40.959Z,1377189220.958 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure -0.600000 db
2013-08-22T16:33:41.090Z,1377189221.090 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.014180 psu
2013-08-22T16:33:41.263Z,1377189221.263 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=9096
2013-08-22T16:33:41.263Z,1377189221.263 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=8476
2013-08-22T16:33:41.264Z,1377189221.264 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=7856
2013-08-22T16:33:41.265Z,1377189221.265 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=7236
2013-08-22T16:33:41.286Z,1377189221.286 [CTD_NeilBrown](ERROR): Salinity reading out of range: -2.292980 psu
2013-08-22T16:33:41.322Z,1377189221.322 [DVL_micro](INFO): RSSI requested
2013-08-22T16:33:41.322Z,1377189221.322 [DVL_micro](INFO): ADCP requested
2013-08-22T16:33:41.322Z,1377189221.322 [DVL_micro](INFO): Cycling power to configure device.
2013-08-22T16:33:41.417Z,1377189221.417 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure -0.600000 db
2013-08-22T16:33:41.486Z,1377189221.486 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.041260 psu
2013-08-22T16:33:41.683Z,1377189221.682 [CTD_NeilBrown](ERROR): Salinity reading out of range: -2.355860 psu
2013-08-22T16:33:41.731Z,1377189221.731 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure -0.600000 db
2013-08-22T16:33:41.732Z,1377189221.731 [Reporter](INFO): CTD_NeilBrown.component_voltage 4.902300 V
2013-08-22T16:33:41.886Z,1377189221.886 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.851450 psu
2013-08-22T16:33:42.086Z,1377189222.086 [CTD_NeilBrown](ERROR): Salinity reading out of range: -2.229770 psu
2013-08-22T16:33:42.138Z,1377189222.138 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure -0.600000 db
2013-08-22T16:33:42.286Z,1377189222.286 [CTD_NeilBrown](ERROR): Salinity reading out of range: -2.527130 psu
2013-08-22T16:33:42.486Z,1377189222.487 [CTD_NeilBrown](ERROR): Salinity reading out of range: -2.166530 psu
2013-08-22T16:33:42.533Z,1377189222.533 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure -0.600000 db
2013-08-22T16:33:42.700Z,1377189222.700 [CTD_NeilBrown](ERROR): Salinity reading out of range: -2.372540 psu
2013-08-22T16:33:42.902Z,1377189222.902 [CTD_NeilBrown](ERROR): Salinity reading out of range: -2.720700 psu
2013-08-22T16:33:42.919Z,1377189222.919 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure -0.610000 db
2013-08-22T16:33:43.091Z,1377189223.091 [CTD_NeilBrown](ERROR): Salinity reading out of range: -2.335280 psu
2013-08-22T16:33:43.302Z,1377189223.302 [CTD_NeilBrown](ERROR): Salinity reading out of range: -2.229310 psu
2013-08-22T16:33:43.308Z,1377189223.309 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure -0.600000 db
2013-08-22T16:33:43.309Z,1377189223.309 [Reporter](INFO): CTD_NeilBrown.component_voltage 4.852020 V
2013-08-22T16:33:43.330Z,1377189223.330 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-08-22T16:33:43.330Z,1377189223.330 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2013-08-22T16:33:43.498Z,1377189223.499 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.732250 psu
2013-08-22T16:33:43.550Z,1377189223.550 [DVL_micro](DEBUG): cmdResponse: 00
2013-08-22T16:33:43.550Z,1377189223.550 [DVL_micro](INFO): Enabling RSSI output
2013-08-22T16:33:43.550Z,1377189223.550 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 16 7

2013-08-22T16:33:43.702Z,1377189223.702 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.977050 psu
2013-08-22T16:33:43.727Z,1377189223.727 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure -0.600000 db
2013-08-22T16:33:43.766Z,1377189223.766 [DVL_micro](DEBUG): cmdResponse: 16
2013-08-22T16:33:43.766Z,1377189223.766 [DVL_micro](INFO): Enabling ADCP output
2013-08-22T16:33:43.766Z,1377189223.766 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 03 3

2013-08-22T16:33:43.902Z,1377189223.902 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.861420 psu
2013-08-22T16:33:43.962Z,1377189223.962 [DVL_micro](DEBUG): cmdResponse: 03 16
2013-08-22T16:33:43.962Z,1377189223.962 [DVL_micro](INFO): Querying output modes
2013-08-22T16:33:43.962Z,1377189223.962 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-08-22T16:33:43.974Z,1377189223.974 [DVL_micro](DEBUG): cmdResponse: 03 16
2013-08-22T16:33:43.974Z,1377189223.974 [DVL_micro](INFO): RSSI output enabled
2013-08-22T16:33:43.974Z,1377189223.974 [DVL_micro](INFO): ADCP output enabled
2013-08-22T16:33:43.974Z,1377189223.974 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-08-22T16:33:43.986Z,1377189223.986 [DVL_micro](DEBUG): cmdResponse: AUTO_VEL_ON 
2013-08-22T16:33:44.102Z,1377189224.102 [CTD_NeilBrown](ERROR): Salinity reading out of range: -2.091280 psu
2013-08-22T16:33:44.134Z,1377189224.134 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=233
2013-08-22T16:33:44.147Z,1377189224.148 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure -0.600000 db
2013-08-22T16:33:44.182Z,1377189224.182 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=93
2013-08-22T16:33:44.234Z,1377189224.234 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=81
2013-08-22T16:33:44.286Z,1377189224.286 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2013-08-22T16:33:44.310Z,1377189224.310 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.388370 psu
2013-08-22T16:33:44.505Z,1377189224.505 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.398040 psu
2013-08-22T16:33:44.537Z,1377189224.537 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure -0.600000 db
2013-08-22T16:33:44.566Z,1377189224.566 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=88
2013-08-22T16:33:44.666Z,1377189224.666 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=28
2013-08-22T16:33:44.714Z,1377189224.714 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.963180 psu
2013-08-22T16:33:44.766Z,1377189224.766 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=0
2013-08-22T16:33:44.878Z,1377189224.878 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2013-08-22T16:33:44.914Z,1377189224.914 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.679720 psu
2013-08-22T16:33:44.936Z,1377189224.936 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure -0.600000 db
2013-08-22T16:33:44.937Z,1377189224.937 [Reporter](INFO): CTD_NeilBrown.component_voltage 4.902300 V
2013-08-22T16:33:45.010Z,1377189225.010 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=104
2013-08-22T16:33:45.070Z,1377189225.070 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=124
2013-08-22T16:33:45.114Z,1377189225.114 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.463150 psu
2013-08-22T16:33:45.116Z,1377189225.116 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=48
2013-08-22T16:33:45.170Z,1377189225.170 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2013-08-22T16:33:45.314Z,1377189225.314 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.382430 psu
2013-08-22T16:33:45.357Z,1377189225.357 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure -0.600000 db
2013-08-22T16:33:45.450Z,1377189225.450 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=56
2013-08-22T16:33:45.526Z,1377189225.526 [CTD_NeilBrown](ERROR): Salinity reading out of range: 4.940110 psu
2013-08-22T16:33:45.562Z,1377189225.562 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=156
2013-08-22T16:33:45.658Z,1377189225.658 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=64
2013-08-22T16:33:45.726Z,1377189225.726 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.583100 psu
2013-08-22T16:33:45.740Z,1377189225.740 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure -0.610000 db
2013-08-22T16:33:45.758Z,1377189225.758 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2013-08-22T16:33:45.926Z,1377189225.926 [CTD_NeilBrown](ERROR): Salinity reading out of range: -2.691430 psu
2013-08-22T16:33:46.102Z,1377189226.102 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=24
2013-08-22T16:33:46.127Z,1377189226.127 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.221360 psu
2013-08-22T16:33:46.142Z,1377189226.142 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure -0.600000 db
2013-08-22T16:33:46.250Z,1377189226.250 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=92
2013-08-22T16:33:46.326Z,1377189226.326 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.995600 psu
2013-08-22T16:33:46.386Z,1377189226.386 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=1
2013-08-22T16:33:46.526Z,1377189226.526 [CTD_NeilBrown](ERROR): Salinity reading out of range: -3.617900 psu
2013-08-22T16:33:46.534Z,1377189226.534 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=4
2013-08-22T16:33:46.591Z,1377189226.591 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure -0.600000 db
2013-08-22T16:33:46.591Z,1377189226.591 [Reporter](INFO): CTD_NeilBrown.component_voltage 4.902300 V
2013-08-22T16:33:46.734Z,1377189226.734 [CTD_NeilBrown](ERROR): Salinity reading out of range: -2.320830 psu
2013-08-22T16:33:46.858Z,1377189226.858 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=92
2013-08-22T16:33:46.930Z,1377189226.930 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.568740 psu
2013-08-22T16:33:46.947Z,1377189226.947 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure -0.600000 db
2013-08-22T16:33:46.970Z,1377189226.970 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=36
2013-08-22T16:33:47.086Z,1377189227.086 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=76
2013-08-22T16:33:47.126Z,1377189227.126 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.887810 psu
2013-08-22T16:33:47.210Z,1377189227.210 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=4
2013-08-22T16:33:47.330Z,1377189227.330 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.599110 psu
2013-08-22T16:33:47.358Z,1377189227.358 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure -0.600000 db
2013-08-22T16:33:47.530Z,1377189227.530 [CTD_NeilBrown](ERROR): Salinity reading out of range: -2.647540 psu
2013-08-22T16:33:47.714Z,1377189227.714 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure -0.600000 db
2013-08-22T16:33:47.723Z,1377189227.723 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=28
2013-08-22T16:33:47.735Z,1377189227.735 [CTD_NeilBrown](ERROR): Salinity reading out of range: 5.399580 psu
2013-08-22T16:33:47.934Z,1377189227.934 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.945670 psu
2013-08-22T16:33:47.958Z,1377189227.958 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=4
2013-08-22T16:33:48.093Z,1377189228.093 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure -0.600000 db
2013-08-22T16:33:48.146Z,1377189228.146 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.856060 psu
2013-08-22T16:33:48.198Z,1377189228.198 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=12
2013-08-22T16:33:48.346Z,1377189228.346 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.206760 psu
2013-08-22T16:33:48.434Z,1377189228.434 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=4
2013-08-22T16:33:48.572Z,1377189228.572 [Reporter](INFO): CTD_NeilBrown.sea_water_pressure -0.610000 db
2013-08-22T16:33:48.573Z,1377189228.573 [Reporter](INFO): CTD_NeilBrown.component_voltage 4.977720 V
2013-08-22T16:33:48.614Z,1377189228.614 [CommandLine](IMPORTANT): got command report clear
2013-08-22T16:33:48.642Z,1377189228.642 [CTD_NeilBrown](ERROR): Salinity reading out of range: -2.540680 psu
2013-08-22T16:33:48.846Z,1377189228.846 [CTD_NeilBrown](ERROR): Salinity reading out of range: -2.089440 psu
2013-08-22T16:33:49.046Z,1377189229.046 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.105960 psu
2013-08-22T16:33:49.246Z,1377189229.246 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.480160 psu
2013-08-22T16:33:49.358Z,1377189229.358 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=92
2013-08-22T16:33:49.446Z,1377189229.446 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.714950 psu
2013-08-22T16:33:49.646Z,1377189229.646 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.275780 psu
2013-08-22T16:33:49.834Z,1377189229.834 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=132
2013-08-22T16:33:49.846Z,1377189229.846 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.979510 psu
2013-08-22T16:33:50.047Z,1377189230.046 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.354640 psu
2013-08-22T16:33:50.258Z,1377189230.258 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.986600 psu
2013-08-22T16:33:50.302Z,1377189230.302 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=76
2013-08-22T16:33:50.458Z,1377189230.458 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.916960 psu
2013-08-22T16:33:50.658Z,1377189230.658 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.999890 psu
2013-08-22T16:33:50.774Z,1377189230.774 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=4
2013-08-22T16:33:50.850Z,1377189230.851 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.167760 psu
2013-08-22T16:33:51.058Z,1377189231.058 [CTD_NeilBrown](ERROR): Salinity reading out of range: -2.157120 psu
2013-08-22T16:33:51.258Z,1377189231.258 [CTD_NeilBrown](ERROR): Salinity reading out of range: -2.017030 psu
2013-08-22T16:33:51.454Z,1377189231.454 [CTD_NeilBrown](ERROR): Salinity reading out of range: -2.679370 psu
2013-08-22T16:33:51.658Z,1377189231.658 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.957550 psu
2013-08-22T16:33:51.660Z,1377189231.659 [DVL_micro](DEBUG): ADCP
2013-08-22T16:33:51.862Z,1377189231.862 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.916750 psu
2013-08-22T16:33:52.058Z,1377189232.058 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.599090 psu
2013-08-22T16:33:52.270Z,1377189232.270 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.049800 psu
2013-08-22T16:33:52.475Z,1377189232.474 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.486370 psu
2013-08-22T16:33:52.502Z,1377189232.502 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=51
2013-08-22T16:33:52.670Z,1377189232.670 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.130230 psu
2013-08-22T16:33:52.870Z,1377189232.870 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.994440 psu
2013-08-22T16:33:53.070Z,1377189233.070 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.496300 psu
2013-08-22T16:33:53.270Z,1377189233.270 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.416120 psu
2013-08-22T16:33:53.338Z,1377189233.338 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=59
2013-08-22T16:33:53.470Z,1377189233.470 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.981990 psu
2013-08-22T16:33:53.670Z,1377189233.671 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.914020 psu
2013-08-22T16:33:53.886Z,1377189233.886 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.532930 psu
2013-08-22T16:33:54.086Z,1377189234.086 [CTD_NeilBrown](ERROR): Salinity reading out of range: -2.017310 psu
2013-08-22T16:33:54.174Z,1377189234.174 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=35
2013-08-22T16:33:54.290Z,1377189234.290 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.154960 psu
2013-08-22T16:33:54.486Z,1377189234.486 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.963470 psu
2013-08-22T16:33:54.687Z,1377189234.687 [CTD_NeilBrown](ERROR): Salinity reading out of range: -3.797810 psu
2013-08-22T16:33:54.902Z,1377189234.902 [CTD_NeilBrown](ERROR): Salinity reading out of range: 41.151821 psu
2013-08-22T16:33:55.018Z,1377189235.018 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=4
2013-08-22T16:33:55.098Z,1377189235.098 [CTD_NeilBrown](ERROR): Salinity reading out of range: 2.122650 psu
2013-08-22T16:33:55.302Z,1377189235.302 [CTD_NeilBrown](ERROR): Salinity reading out of range: -2.244910 psu
2013-08-22T16:33:55.346Z,1377189235.346 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=72
2013-08-22T16:33:55.410Z,1377189235.410 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=156
2013-08-22T16:33:55.458Z,1377189235.458 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=80
2013-08-22T16:33:55.502Z,1377189235.502 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.414250 psu
2013-08-22T16:33:55.504Z,1377189235.504 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2013-08-22T16:33:55.702Z,1377189235.702 [CTD_NeilBrown](ERROR): Salinity reading out of range: -2.627880 psu
2013-08-22T16:33:55.786Z,1377189235.786 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=24
2013-08-22T16:33:55.891Z,1377189235.891 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=92
2013-08-22T16:33:55.914Z,1377189235.914 [CTD_NeilBrown](ERROR): Salinity reading out of range: 8.197930 psu
2013-08-22T16:33:55.998Z,1377189235.998 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=64
2013-08-22T16:33:56.102Z,1377189236.102 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2013-08-22T16:33:56.114Z,1377189236.114 [CTD_NeilBrown](ERROR): Salinity reading out of range: 69.322090 psu
2013-08-22T16:33:56.234Z,1377189236.234 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=72
2013-08-22T16:33:56.291Z,1377189236.291 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=92
2013-08-22T16:33:56.314Z,1377189236.314 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.903340 psu
2013-08-22T16:33:56.342Z,1377189236.342 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=48
2013-08-22T16:33:56.402Z,1377189236.402 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2013-08-22T16:33:56.515Z,1377189236.515 [CTD_NeilBrown](ERROR): Salinity reading out of range: -2.010040 psu
2013-08-22T16:33:56.674Z,1377189236.674 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=24
2013-08-22T16:33:56.726Z,1377189236.726 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.095990 psu
2013-08-22T16:33:56.774Z,1377189236.774 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=60
2013-08-22T16:33:56.882Z,1377189236.882 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=64
2013-08-22T16:33:56.923Z,1377189236.922 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.211250 psu
2013-08-22T16:33:56.982Z,1377189236.982 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2013-08-22T16:33:57.119Z,1377189237.118 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.626930 psu
2013-08-22T16:33:57.326Z,1377189237.326 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=88
2013-08-22T16:33:57.327Z,1377189237.327 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.909940 psu
2013-08-22T16:33:57.470Z,1377189237.470 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=28
2013-08-22T16:33:57.526Z,1377189237.526 [CTD_NeilBrown](ERROR): Salinity reading out of range: -3.776000 psu
2013-08-22T16:33:57.622Z,1377189237.622 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=96
2013-08-22T16:33:57.726Z,1377189237.727 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.948140 psu
2013-08-22T16:33:57.762Z,1377189237.762 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=4
2013-08-22T16:33:57.926Z,1377189237.926 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.644840 psu
2013-08-22T16:33:58.082Z,1377189238.082 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=124
2013-08-22T16:33:58.123Z,1377189238.123 [CTD_NeilBrown](ERROR): Salinity reading out of range: -2.520830 psu
2013-08-22T16:33:58.202Z,1377189238.202 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=132
2013-08-22T16:33:58.315Z,1377189238.315 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=76
2013-08-22T16:33:58.338Z,1377189238.338 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.954230 psu
2013-08-22T16:33:58.426Z,1377189238.426 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=4
2013-08-22T16:33:58.634Z,1377189238.634 [CTD_NeilBrown](ERROR): Salinity reading out of range: -2.261900 psu
2013-08-22T16:33:58.834Z,1377189238.834 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.170360 psu
2013-08-22T16:33:58.954Z,1377189238.954 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=92
2013-08-22T16:33:59.034Z,1377189239.034 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.034750 psu
2013-08-22T16:33:59.162Z,1377189239.162 [CommandLine](IMPORTANT): got command stop
2013-08-22T16:33:59.186Z,1377189239.186 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=36
2013-08-22T16:33:59.238Z,1377189239.238 [CTD_NeilBrown](ERROR): Salinity reading out of range: -1.293010 psu
2013-08-22T16:33:59.287Z,1377189239.287 [Science] Stopped
2013-08-22T16:33:59.287Z,1377189239.287 [Science](INFO): Aggregate::uninitialize Science
2013-08-22T16:33:59.287Z,1377189239.287 [Science:A] Stopped
2013-08-22T16:33:59.287Z,1377189239.287 [Science:B] Stopped
2013-08-22T16:33:59.287Z,1377189239.287 [Science:C] Stopped
2013-08-22T16:33:59.287Z,1377189239.287 [Science:D] Stopped
2013-08-22T16:33:59.287Z,1377189239.287 [Science:E] Stopped
2013-08-22T16:33:59.287Z,1377189239.287 [Science:F] Stopped
2013-08-22T16:33:59.287Z,1377189239.287 [Science:G] Stopped
2013-08-22T16:33:59.287Z,1377189239.287 [Science:H] Stopped
2013-08-22T16:33:59.288Z,1377189239.288 [Science:I] Stopped
2013-08-22T16:33:59.426Z,1377189239.426 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=76
2013-08-22T16:33:59.438Z,1377189239.438 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.194130 psu
2013-08-22T16:33:59.658Z,1377189239.658 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=4
2013-08-22T16:33:59.715Z,1377189239.715 [DVL_micro](INFO): pause:Powering down
2013-08-22T16:33:59.727Z,1377189239.727 [MissionManager](IMPORTANT): Started mission Default
2013-08-22T16:33:59.727Z,1377189239.727 [Default] Running Loop=1
2013-08-22T16:33:59.728Z,1377189239.727 [Default](INFO): Aggregate::initialize Default
2013-08-22T16:33:59.728Z,1377189239.728 [Default:D.SetSpeed] Running Loop=1
2013-08-22T16:33:59.728Z,1377189239.728 [Default:D.SetSpeed](DEBUG): Initialize.
2013-08-22T16:33:59.728Z,1377189239.728 [Default:E.GoToSurface] Running Loop=1
2013-08-22T16:33:59.728Z,1377189239.728 [Default:E.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-08-22T16:33:59.728Z,1377189239.728 [Default:Iridium] Running Loop=1
2013-08-22T16:33:59.729Z,1377189239.728 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2013-08-22T16:33:59.729Z,1377189239.729 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-08-22T16:33:59.729Z,1377189239.729 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2013-08-22T16:33:59.729Z,1377189239.729 [Default:Iridium:B.GoToSurface] Running Loop=1
2013-08-22T16:33:59.729Z,1377189239.729 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-08-22T16:33:59.729Z,1377189239.729 [Default:E.GoToSurface] Running Loop=1
2013-08-22T16:33:59.735Z,1377189239.735 [Default:D.SetSpeed] Running Loop=1
2013-08-22T16:33:59.745Z,1377189239.745 [Default:Iridium:B.GoToSurface] Stopped
2013-08-22T16:33:59.745Z,1377189239.745 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-08-22T16:33:59.745Z,1377189239.745 [Default:Iridium:Read_Iridium] Running Loop=1
2013-08-22T16:33:59.745Z,1377189239.745 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-08-22T16:33:59.750Z,1377189239.750 [Default:GPS] Running Loop=1
2013-08-22T16:33:59.750Z,1377189239.750 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2013-08-22T16:33:59.750Z,1377189239.750 [Default:GPS:A.SetSpeed] Running Loop=1
2013-08-22T16:33:59.750Z,1377189239.750 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2013-08-22T16:33:59.751Z,1377189239.750 [Default:GPS:B.GoToSurface] Running Loop=1
2013-08-22T16:33:59.751Z,1377189239.750 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-08-22T16:33:59.756Z,1377189239.756 [Default:GPS:B.GoToSurface] Stopped
2013-08-22T16:33:59.756Z,1377189239.756 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-08-22T16:33:59.756Z,1377189239.756 [Default:GPS:Read_GPS] Running Loop=1
2013-08-22T16:33:59.756Z,1377189239.756 [Default:GPS:A.SetSpeed] Running Loop=1
2013-08-22T16:34:00.081Z,1377189240.081 [Default:Iridium:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2013-08-22T16:34:00.084Z,1377189240.084 [Default:GPS:Read_GPS](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2013-08-22T16:34:00.465Z,1377189240.465 [NAL9602](INFO): Powering up
2013-08-22T16:34:10.915Z,1377189250.915 [NAL9602](INFO): NAL9602 initialized
2013-08-22T16:34:12.962Z,1377189252.962 [CommandLine](IMPORTANT): got command restart application
2013-08-22T16:34:13.996Z,1377189253.996 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2013-08-22T16:34:13.996Z,1377189253.996 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2013-08-22T16:34:14.034Z,1377189254.034 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2013-08-22T16:34:14.106Z,1377189254.106 [CTD_NeilBrown](INFO): Powering down
2013-08-22T16:34:14.122Z,1377189254.122 [ComponentRegistry](INFO): Shutting down DVL_micro ThreadHandler
2013-08-22T16:34:14.262Z,1377189254.262 [DVL_micro](INFO): uninitialize:Powering down
2013-08-22T16:34:14.282Z,1377189254.282 [ComponentRegistry](INFO): Shutting down AsyncPiEstimator ThreadHandler
2013-08-22T16:34:14.462Z,1377189254.462 [AsyncPiEstimator](DEBUG): Uninitialize AsyncPiEstimator.
2013-08-22T16:34:14.481Z,1377189254.481 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2013-08-22T16:34:14.502Z,1377189254.503 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2013-08-22T16:34:14.504Z,1377189254.504 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2013-08-22T16:34:14.599Z,1377189254.599 [controlThread](DEBUG): Uninitializing ControlThread
2013-08-22T16:34:14.599Z,1377189254.599 [AHRS_sp3003D](INFO): Powering down
2013-08-22T16:34:14.687Z,1377189254.687 [NAL9602](INFO): Powering down
2013-08-22T16:34:14.688Z,1377189254.688 [DAT](INFO): Powering down
2013-08-22T16:34:14.689Z,1377189254.689 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2013-08-22T16:34:14.690Z,1377189254.690 [NavChart](DEBUG): Uninitialize NavChart Derivation.
2013-08-22T16:34:14.691Z,1377189254.691 [Default] Stopped
2013-08-22T16:34:14.691Z,1377189254.691 [Default](INFO): Aggregate::uninitialize Default
2013-08-22T16:34:14.691Z,1377189254.691 [Default:GPS] Stopped
2013-08-22T16:34:14.691Z,1377189254.691 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2013-08-22T16:34:14.691Z,1377189254.691 [Default:GPS:A.SetSpeed] Stopped
2013-08-22T16:34:14.691Z,1377189254.691 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2013-08-22T16:34:14.691Z,1377189254.691 [Default:GPS:Read_GPS] Stopped
2013-08-22T16:34:14.691Z,1377189254.691 [Default:Iridium] Stopped
2013-08-22T16:34:14.692Z,1377189254.691 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2013-08-22T16:34:14.692Z,1377189254.692 [Default:Iridium:A.SetSpeed] Stopped
2013-08-22T16:34:14.692Z,1377189254.692 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2013-08-22T16:34:14.692Z,1377189254.692 [Default:Iridium:Read_Iridium] Stopped
2013-08-22T16:34:14.692Z,1377189254.692 [Default:D.SetSpeed] Stopped
2013-08-22T16:34:14.692Z,1377189254.692 [Default:D.SetSpeed](DEBUG): Uninitialize.
2013-08-22T16:34:14.692Z,1377189254.692 [Default:E.GoToSurface] Stopped
2013-08-22T16:34:14.692Z,1377189254.692 [Default:E.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-08-22T16:34:14.696Z,1377189254.696 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2013-08-22T16:34:14.696Z,1377189254.696 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2013-08-22T16:34:14.697Z,1377189254.697 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2013-08-22T16:34:14.697Z,1377189254.697 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2013-08-22T16:34:14.697Z,1377189254.697 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2013-08-22T16:34:14.697Z,1377189254.697 [BuoyancyServo](INFO): Powering down
2013-08-22T16:34:14.710Z,1377189254.710 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2013-08-22T16:34:14.710Z,1377189254.710 [ElevatorServo](INFO): Powering down
2013-08-22T16:34:14.711Z,1377189254.711 [MassServo](DEBUG): Uninitialize Mass Servo.
2013-08-22T16:34:14.711Z,1377189254.711 [MassServo](INFO): Powering down
2013-08-22T16:34:14.712Z,1377189254.712 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2013-08-22T16:34:14.712Z,1377189254.712 [RudderServo](INFO): Powering down
2013-08-22T16:34:14.712Z,1377189254.713 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2013-08-22T16:34:14.713Z,1377189254.713 [ThrusterServo](INFO): Powering down
2013-08-22T16:34:14.714Z,1377189254.714 [SBIT](DEBUG): Uninitialize SBIT Component.
2013-08-22T16:34:14.714Z,1377189254.714 [IBIT](DEBUG): Uninitialize IBIT Component.
2013-08-22T16:34:14.714Z,1377189254.714 [CBIT](DEBUG): Uninitialize CBIT Component.