2012-09-20T14:47:21.465Z,1348152441.465 [Supervisor](DEBUG): Initializing supervisor.
2012-09-20T14:47:21.468Z,1348152441.468 [SyncHandler](DEBUG): Created PCaller Thread at 4033B4E0
2012-09-20T14:47:21.469Z,1348152441.469 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2012-09-20T14:47:21.470Z,1348152441.470 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4036B4E0
2012-09-20T14:47:21.475Z,1348152441.474 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2012-09-20T14:47:21.486Z,1348152441.486 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2012-09-20T14:47:21.487Z,1348152441.487 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 4039B4E0
2012-09-20T14:47:21.488Z,1348152441.488 [ComponentRegistry](DEBUG): SyncComponent "logger" handled in the control thread.
2012-09-20T14:47:21.489Z,1348152441.489 [Supervisor](INFO): Looking for Config files in directory: Config/
2012-09-20T14:47:21.490Z,1348152441.490 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2012-09-20T14:47:21.768Z,1348152441.768 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2012-09-20T14:47:21.769Z,1348152441.769 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2012-09-20T14:47:21.947Z,1348152441.947 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2012-09-20T14:47:21.947Z,1348152441.947 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2012-09-20T14:47:22.032Z,1348152442.032 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2012-09-20T14:47:22.033Z,1348152442.033 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2012-09-20T14:47:22.227Z,1348152442.227 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2012-09-20T14:47:22.228Z,1348152442.228 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2012-09-20T14:47:22.361Z,1348152442.361 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2012-09-20T14:47:22.362Z,1348152442.362 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2012-09-20T14:47:22.593Z,1348152442.593 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2012-09-20T14:47:22.594Z,1348152442.594 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2012-09-20T14:47:22.764Z,1348152442.764 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2012-09-20T14:47:22.764Z,1348152442.764 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2012-09-20T14:47:23.016Z,1348152443.016 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2012-09-20T14:47:23.017Z,1348152443.017 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2012-09-20T14:47:23.225Z,1348152443.224 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2012-09-20T14:47:23.225Z,1348152443.225 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2012-09-20T14:47:23.636Z,1348152443.636 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2012-09-20T14:47:23.636Z,1348152443.636 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2012-09-20T14:47:23.750Z,1348152443.750 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2012-09-20T14:47:23.750Z,1348152443.750 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2012-09-20T14:47:23.836Z,1348152443.836 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2012-09-20T14:47:23.836Z,1348152443.836 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2012-09-20T14:47:23.937Z,1348152443.937 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2012-09-20T14:47:24.065Z,1348152444.065 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2012-09-20T14:47:24.151Z,1348152444.151 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2012-09-20T14:47:24.253Z,1348152444.253 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2012-09-20T14:47:24.353Z,1348152444.353 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2012-09-20T14:47:24.471Z,1348152444.471 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2012-09-20T14:47:24.561Z,1348152444.560 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2012-09-20T14:47:24.653Z,1348152444.653 [Supervisor](IMPORTANT): Reading configuration overrides from Data/config.db
2012-09-20T14:47:24.665Z,1348152444.665 [ComponentRegistry](DEBUG): Loaded Config Component "configDb
2012-09-20T14:47:24.697Z,1348152444.697 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2012-09-20T14:47:24.834Z,1348152444.834 [InternalSim] Loaded
2012-09-20T14:47:24.835Z,1348152444.835 [ComponentRegistry](DEBUG): SyncComponent "InternalSim" handled in the control thread.
2012-09-20T14:47:24.835Z,1348152444.835 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2012-09-20T14:47:24.836Z,1348152444.836 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2012-09-20T14:47:24.892Z,1348152444.892 [SBIT](DEBUG): Construct Startup Built In Test.
2012-09-20T14:47:24.905Z,1348152444.905 [SBIT] Loaded
2012-09-20T14:47:24.906Z,1348152444.906 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2012-09-20T14:47:24.907Z,1348152444.907 [IBIT](DEBUG): Construct Initiated Built In Test.
2012-09-20T14:47:24.934Z,1348152444.934 [IBIT] Loaded
2012-09-20T14:47:24.934Z,1348152444.934 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2012-09-20T14:47:24.937Z,1348152444.937 [CBIT](DEBUG): Construct CBIT Built In Test.
2012-09-20T14:47:25.051Z,1348152445.051 [CBIT] Loaded
2012-09-20T14:47:25.052Z,1348152445.052 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2012-09-20T14:47:25.052Z,1348152445.052 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2012-09-20T14:47:25.053Z,1348152445.053 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2012-09-20T14:47:25.197Z,1348152445.197 [BuoyancyServo] Loaded
2012-09-20T14:47:25.197Z,1348152445.197 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2012-09-20T14:47:25.206Z,1348152445.207 [ElevatorServo] Loaded
2012-09-20T14:47:25.207Z,1348152445.207 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2012-09-20T14:47:25.218Z,1348152445.218 [MassServo] Loaded
2012-09-20T14:47:25.219Z,1348152445.218 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2012-09-20T14:47:25.230Z,1348152445.230 [RudderServo] Loaded
2012-09-20T14:47:25.230Z,1348152445.230 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2012-09-20T14:47:25.242Z,1348152445.242 [ThrusterServo] Loaded
2012-09-20T14:47:25.242Z,1348152445.242 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2012-09-20T14:47:25.243Z,1348152445.243 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2012-09-20T14:47:25.243Z,1348152445.243 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2012-09-20T14:47:25.260Z,1348152445.260 [DepthRateCalculator] Loaded
2012-09-20T14:47:25.261Z,1348152445.260 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2012-09-20T14:47:27.752Z,1348152447.752 [HFRadarModelCalc] Loaded
2012-09-20T14:47:27.752Z,1348152447.752 [ComponentRegistry](DEBUG): SyncComponent "HFRadarModelCalc" handled in the control thread.
2012-09-20T14:47:27.768Z,1348152447.768 [NavChart] Loaded
2012-09-20T14:47:27.768Z,1348152447.768 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2012-09-20T14:47:27.774Z,1348152447.774 [PitchRateCalculator] Loaded
2012-09-20T14:47:27.774Z,1348152447.774 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2012-09-20T14:47:27.780Z,1348152447.780 [SpeedCalculator] Loaded
2012-09-20T14:47:27.781Z,1348152447.781 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2012-09-20T14:47:27.796Z,1348152447.796 [TempGradientCalculator] Loaded
2012-09-20T14:47:27.796Z,1348152447.796 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2012-09-20T14:47:27.802Z,1348152447.802 [YawRateCalculator] Loaded
2012-09-20T14:47:27.802Z,1348152447.802 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2012-09-20T14:47:27.821Z,1348152447.821 [Navigation] Loaded
2012-09-20T14:47:27.822Z,1348152447.822 [ComponentRegistry](DEBUG): SyncComponent "Navigation" handled in the control thread.
2012-09-20T14:47:27.822Z,1348152447.822 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2012-09-20T14:47:27.823Z,1348152447.823 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2012-09-20T14:47:28.293Z,1348152448.293 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2012-09-20T14:47:28.294Z,1348152448.294 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2012-09-20T14:47:28.316Z,1348152448.316 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2012-09-20T14:47:28.316Z,1348152448.316 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2012-09-20T14:47:28.356Z,1348152448.356 [VerticalControl](DEBUG): Construct VerticalControl.
2012-09-20T14:47:28.400Z,1348152448.400 [VerticalControl] Loaded
2012-09-20T14:47:28.400Z,1348152448.400 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2012-09-20T14:47:28.401Z,1348152448.401 [HorizontalControl](DEBUG): Construct HorizontalControl.
2012-09-20T14:47:28.421Z,1348152448.421 [HorizontalControl] Loaded
2012-09-20T14:47:28.422Z,1348152448.422 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2012-09-20T14:47:28.423Z,1348152448.423 [SpeedControl](DEBUG): Construct SpeedControl.
2012-09-20T14:47:28.424Z,1348152448.424 [SpeedControl] Loaded
2012-09-20T14:47:28.425Z,1348152448.425 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2012-09-20T14:47:28.426Z,1348152448.425 [LoopControl](DEBUG): Construct LoopControl.
2012-09-20T14:47:28.426Z,1348152448.426 [LoopControl] Loaded
2012-09-20T14:47:28.426Z,1348152448.426 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2012-09-20T14:47:28.427Z,1348152448.427 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2012-09-20T14:47:28.427Z,1348152448.427 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2012-09-20T14:47:28.432Z,1348152448.432 [AsyncPiEstimator](DEBUG): Construct AsyncPiEstimator.
2012-09-20T14:47:28.437Z,1348152448.437 [AsyncPiEstimator] Loaded
2012-09-20T14:47:28.438Z,1348152448.438 [ComponentRegistry](DEBUG): Component "AsyncPiEstimator" handled in its own thread.
2012-09-20T14:47:28.439Z,1348152448.439 [AsyncPiEstimator ThreadHandler](DEBUG): Created PCaller Thread at 4060A4E0
2012-09-20T14:47:28.439Z,1348152448.439 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2012-09-20T14:47:28.440Z,1348152448.440 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2012-09-20T14:47:28.558Z,1348152448.558 [AHRS_sp3003D] Loaded
2012-09-20T14:47:28.558Z,1348152448.559 [ComponentRegistry](DEBUG): SyncComponent "AHRS_sp3003D" handled in the control thread.
2012-09-20T14:47:28.572Z,1348152448.572 [Depth_Keller] Loaded
2012-09-20T14:47:28.572Z,1348152448.572 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2012-09-20T14:47:28.578Z,1348152448.578 [DropWeight] Loaded
2012-09-20T14:47:28.578Z,1348152448.578 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2012-09-20T14:47:28.691Z,1348152448.691 [DVL_micro] Loaded
2012-09-20T14:47:28.691Z,1348152448.691 [ComponentRegistry](DEBUG): Component "DVL_micro" handled in its own thread.
2012-09-20T14:47:28.692Z,1348152448.692 [DVL_micro ThreadHandler](DEBUG): Created PCaller Thread at 4068A4E0
2012-09-20T14:47:28.774Z,1348152448.774 [NAL9602] Loaded
2012-09-20T14:47:28.774Z,1348152448.774 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2012-09-20T14:47:28.822Z,1348152448.822 [Onboard] Loaded
2012-09-20T14:47:28.823Z,1348152448.823 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2012-09-20T14:47:28.829Z,1348152448.829 [Radio_Freewave] Loaded
2012-09-20T14:47:28.830Z,1348152448.830 [ComponentRegistry](DEBUG): SyncComponent "Radio_Freewave" handled in the control thread.
2012-09-20T14:47:28.831Z,1348152448.830 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2012-09-20T14:47:28.831Z,1348152448.831 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2012-09-20T14:47:28.902Z,1348152448.902 [CTD_NeilBrown] Loaded
2012-09-20T14:47:28.902Z,1348152448.902 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2012-09-20T14:47:28.903Z,1348152448.903 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 406E24E0
2012-09-20T14:47:28.914Z,1348152448.914 [PAR_Licor] Loaded
2012-09-20T14:47:28.914Z,1348152448.914 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2012-09-20T14:47:28.930Z,1348152448.930 [Turbulence_NPS] Loaded
2012-09-20T14:47:28.930Z,1348152448.931 [ComponentRegistry](DEBUG): Component "Turbulence_NPS" handled in its own thread.
2012-09-20T14:47:28.932Z,1348152448.932 [Turbulence_NPS ThreadHandler](DEBUG): Created PCaller Thread at 407124E0
2012-09-20T14:47:28.961Z,1348152448.961 [WetLabsBB2FL] Loaded
2012-09-20T14:47:28.961Z,1348152448.961 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2012-09-20T14:47:28.962Z,1348152448.963 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 407424E0
2012-09-20T14:47:28.963Z,1348152448.963 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2012-09-20T14:47:28.965Z,1348152448.966 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2012-09-20T14:47:28.967Z,1348152448.967 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2012-09-20T14:47:28.973Z,1348152448.973 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2012-09-20T14:47:28.974Z,1348152448.974 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 407724E0
2012-09-20T14:47:28.979Z,1348152448.979 [Supervisor](DEBUG): Running supervisor.
2012-09-20T14:47:28.982Z,1348152448.982 [controlThread](DEBUG): Initializing ControlThread
2012-09-20T14:47:28.983Z,1348152448.983 [InternalSim](DEBUG):  InternalSim initializing...
2012-09-20T14:47:29.018Z,1348152449.018 [AsyncPiEstimator](DEBUG): Initialize AsyncPiEstimator.
2012-09-20T14:47:29.026Z,1348152449.026 [SBIT](INFO): Initialize SBIT Component.
2012-09-20T14:47:29.026Z,1348152449.026 [SBIT](IMPORTANT): Tethys CM Info:
$Rev: 9842
2012-09-20T14:47:29.027Z,1348152449.027 [IBIT](INFO): Initialize IBIT Component.
2012-09-20T14:47:29.028Z,1348152449.028 [CBIT](DEBUG): Initialize CBIT Component.
2012-09-20T14:47:29.028Z,1348152449.028 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2012-09-20T14:47:29.038Z,1348152449.038 [DVL_micro](INFO): Initializing
2012-09-20T14:47:29.038Z,1348152449.038 [DVL_micro](INFO): start:Powering up
2012-09-20T14:47:29.056Z,1348152449.056 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2012-09-20T14:47:29.057Z,1348152449.057 [NavChart](DEBUG): Initialize NavChart Derivation.
2012-09-20T14:47:29.057Z,1348152449.057 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2012-09-20T14:47:29.057Z,1348152449.057 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2012-09-20T14:47:29.058Z,1348152449.058 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2012-09-20T14:47:29.059Z,1348152449.059 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2012-09-20T14:47:29.059Z,1348152449.059 [Navigation](DEBUG): Initializing Navigation.
2012-09-20T14:47:29.060Z,1348152449.060 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2012-09-20T14:47:29.061Z,1348152449.061 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2012-09-20T14:47:29.062Z,1348152449.062 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2012-09-20T14:47:29.062Z,1348152449.062 [LoopControl](DEBUG): Initialize LoopControlComponent.
2012-09-20T14:47:29.067Z,1348152449.067 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown.
2012-09-20T14:47:29.074Z,1348152449.074 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2012-09-20T14:47:29.087Z,1348152449.087 [Turbulence_NPS](DEBUG): Initializing Turbulence_NPS.
2012-09-20T14:47:29.104Z,1348152449.104 [WetLabsBB2FL](INFO): Powering down
2012-09-20T14:47:29.120Z,1348152449.120 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2012-09-20T14:47:29.139Z,1348152449.139 [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>


2012-09-20T14:47:29.140Z,1348152449.140 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2012-09-20T14:47:29.190Z,1348152449.190 [MissionManager](INFO): DefineArg Default.NeedGPS = 1 bool
2012-09-20T14:47:29.192Z,1348152449.192 [Default:GPS:A.SetSpeed](DEBUG): Construct.
2012-09-20T14:47:29.195Z,1348152449.195 [Default:GPS:B.GoToSurface](DEBUG): Construct GoToSurface.
2012-09-20T14:47:29.203Z,1348152449.203 [Default:Iridium:A.SetSpeed](DEBUG): Construct.
2012-09-20T14:47:29.206Z,1348152449.206 [Default:Iridium:B.GoToSurface](DEBUG): Construct GoToSurface.
2012-09-20T14:47:29.213Z,1348152449.213 [Default:Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2012-09-20T14:47:29.221Z,1348152449.221 [Default:D.SetSpeed](DEBUG): Construct.
2012-09-20T14:47:29.225Z,1348152449.225 [Default:E.GoToSurface](DEBUG): Construct GoToSurface.
2012-09-20T14:47:29.229Z,1348152449.229 [Default:F.Wait](DEBUG): Construct Wait.
2012-09-20T14:47:29.233Z,1348152449.233 [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>


2012-09-20T14:47:29.237Z,1348152449.237 [controlThread](DEBUG): Component order: CycleStarter,InternalSim,AHRS_sp3003D,Depth_Keller,DropWeight,NAL9602,Onboard,Radio_Freewave,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,HFRadarModelCalc,NavChart,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,Navigation,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,logger,
2012-09-20T14:47:29.278Z,1348152449.279 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D.
2012-09-20T14:47:29.427Z,1348152449.427 [Depth_Keller](INFO): A/D timeout, 5 tries over 129 ms

2012-09-20T14:47:29.428Z,1348152449.428 [Depth_Keller] Data Fault, FailCount= 1
2012-09-20T14:47:29.428Z,1348152449.428 [Depth_Keller](ERROR): Data Fault
2012-09-20T14:47:29.811Z,1348152449.811 [Radio_Freewave](INFO): Powering up
2012-09-20T14:47:29.995Z,1348152449.995 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2012-09-20T14:47:29.999Z,1348152449.999 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2012-09-20T14:47:30.005Z,1348152450.005 [ElevatorServo](DEBUG): Initializing EZServoServo.
2012-09-20T14:47:30.007Z,1348152450.007 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2012-09-20T14:47:30.013Z,1348152450.013 [MassServo](DEBUG): Initializing MassServo.
2012-09-20T14:47:30.018Z,1348152450.018 [RudderServo](DEBUG): Initializing EZServoServo.
2012-09-20T14:47:30.027Z,1348152450.027 [RudderServo](DEBUG): Initializing RudderServo.
2012-09-20T14:47:30.032Z,1348152450.033 [ThrusterServo](DEBUG): Initializing EZServoServo.
2012-09-20T14:47:30.034Z,1348152450.034 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2012-09-20T14:47:30.056Z,1348152450.056 [CBIT](ERROR): Data Fault in component: Depth_Keller
2012-09-20T14:47:30.056Z,1348152450.056 [CBIT](INFO): Clearing failed state for component Depth_Keller
2012-09-20T14:47:30.056Z,1348152450.056 [Depth_Keller] No Fault, FailCount= 1
2012-09-20T14:47:30.923Z,1348152450.922 [DVL_micro](INFO): Querying output modes
2012-09-20T14:47:30.923Z,1348152450.923 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2012-09-20T14:47:30.927Z,1348152450.927 [DVL_micro](DEBUG): cmdResponse: 01
2012-09-20T14:47:30.927Z,1348152450.927 [DVL_micro](INFO): NQ1 output enabled
2012-09-20T14:47:30.927Z,1348152450.927 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2012-09-20T14:47:30.931Z,1348152450.931 [DVL_micro](DEBUG): cmdResponse: AUTO_VEL_ON 
2012-09-20T14:47:30.935Z,1348152450.935 [DVL_micro](INFO): pause:Powering down
2012-09-20T14:47:31.001Z,1348152451.001 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources
2012-09-20T14:47:31.776Z,1348152451.776 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2012-09-20T14:47:32.129Z,1348152452.129 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2012-09-20T14:47:32.179Z,1348152452.180 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2012-09-20T14:47:32.199Z,1348152452.199 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2012-09-20T14:47:32.201Z,1348152452.201 [NavChartDb](INFO): Creating index for Soundings
2012-09-20T14:47:32.205Z,1348152452.205 [NavChartDb](INFO): Creating index for Contour 0p0
2012-09-20T14:47:32.209Z,1348152452.209 [NavChartDb](INFO): Creating index for Contour 1p8
2012-09-20T14:47:32.224Z,1348152452.224 [NavChartDb](INFO): Creating index for Contour 3p6
2012-09-20T14:47:32.240Z,1348152452.240 [NavChartDb](INFO): Creating index for Contour 5p4
2012-09-20T14:47:32.242Z,1348152452.241 [NavChartDb](INFO): Creating index for Contour 9p1
2012-09-20T14:47:32.244Z,1348152452.244 [NavChartDb](INFO): Creating index for Contour 10p9
2012-09-20T14:47:32.246Z,1348152452.246 [NavChartDb](INFO): Creating index for Contour 18p2
2012-09-20T14:47:32.249Z,1348152452.249 [NavChartDb](INFO): Creating index for Contour 36p5
2012-09-20T14:47:32.251Z,1348152452.251 [NavChartDb](INFO): Creating index for Contour 54p8
2012-09-20T14:47:32.254Z,1348152452.254 [NavChartDb](INFO): Creating index for Contour 73p1
2012-09-20T14:47:32.280Z,1348152452.280 [NavChartDb](INFO): Creating index for Contour 91p4
2012-09-20T14:47:32.287Z,1348152452.287 [NavChartDb](INFO): Creating index for Contour 182p8
2012-09-20T14:47:32.289Z,1348152452.289 [NavChartDb](INFO): Creating index for Contour 365p7
2012-09-20T14:47:32.290Z,1348152452.290 [NavChartDb](INFO): Creating index for Contour 548p6
2012-09-20T14:47:32.292Z,1348152452.292 [NavChartDb](INFO): Creating index for Contour 731p5
2012-09-20T14:47:32.295Z,1348152452.295 [NavChartDb](INFO): Creating index for Contour 914p4
2012-09-20T14:47:32.297Z,1348152452.297 [NavChartDb](INFO): Creating index for Contour 1097p2
2012-09-20T14:47:32.309Z,1348152452.309 [NavChartDb](INFO): Creating index for Contour 1280p1
2012-09-20T14:47:32.321Z,1348152452.321 [NavChartDb](INFO): Creating index for Contour 1463p0
2012-09-20T14:47:32.333Z,1348152452.333 [NavChartDb](INFO): Creating index for Contour 1645p9
2012-09-20T14:47:32.338Z,1348152452.338 [NavChartDb](INFO): Creating index for Contour 1828p8
2012-09-20T14:47:32.340Z,1348152452.340 [NavChartDb](INFO): Creating index for Contour 2011p6
2012-09-20T14:47:32.342Z,1348152452.342 [NavChartDb](INFO): Creating index for Contour 2194p5
2012-09-20T14:47:32.344Z,1348152452.344 [NavChartDb](INFO): Creating index for Contour 2377p4
2012-09-20T14:47:32.346Z,1348152452.346 [NavChartDb](INFO): Creating index for Contour 2560p3
2012-09-20T14:47:32.349Z,1348152452.349 [NavChartDb](INFO): Creating index for Contour 2743p2
2012-09-20T14:47:32.380Z,1348152452.380 [NavChartDb](INFO): Creating index for Contour 2926p0
2012-09-20T14:47:32.503Z,1348152452.503 [NavChartDb](INFO): Creating index for Contour 3108p9
2012-09-20T14:47:32.505Z,1348152452.505 [NavChartDb](INFO): Creating index for Contour 3291p8
2012-09-20T14:47:32.517Z,1348152452.517 [NavChartDb](INFO): Creating index for Contour 3474p7
2012-09-20T14:47:32.519Z,1348152452.519 [NavChartDb](INFO): Creating index for Contour 3657p6
2012-09-20T14:47:34.019Z,1348152454.019 [NAL9602](INFO): Powering up NAL9602
2012-09-20T14:47:44.451Z,1348152464.451 [NAL9602](INFO): NAL9602 initialized
2012-09-20T14:47:44.472Z,1348152464.472 [SBIT](IMPORTANT): Beginning Startup BIT
2012-09-20T14:47:44.474Z,1348152464.474 [CBIT](IMPORTANT): Beginning GF scan
2012-09-20T14:47:46.471Z,1348152466.471 [ElevatorServo](FAULT): Overload Error
2012-09-20T14:47:46.471Z,1348152466.471 [ElevatorServo] Hardware Fault, FailCount= 1
2012-09-20T14:47:46.471Z,1348152466.471 [ElevatorServo](ERROR): Hardware Fault
2012-09-20T14:47:46.522Z,1348152466.522 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2012-09-20T14:47:46.837Z,1348152466.838 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2012-09-20T14:47:46.838Z,1348152466.838 [ElevatorServo](INFO): Powering down
2012-09-20T14:47:46.874Z,1348152466.874 [CBIT](INFO): Clearing failed state for component ElevatorServo
2012-09-20T14:47:46.874Z,1348152466.874 [ElevatorServo] No Fault, FailCount= 1
2012-09-20T14:47:47.636Z,1348152467.636 [ElevatorServo](DEBUG): Initializing EZServoServo.
2012-09-20T14:47:47.755Z,1348152467.755 [ElevatorServo](DEBUG): Initialization error opening port: port not yet opened
2012-09-20T14:47:47.756Z,1348152467.756 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2012-09-20T14:47:50.017Z,1348152470.017 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2012-09-20T14:47:50.017Z,1348152470.017 [DropWeight] Hardware Fault, FailCount= 1
2012-09-20T14:47:50.017Z,1348152470.017 [DropWeight](ERROR): Hardware Fault
2012-09-20T14:47:50.058Z,1348152470.059 [CBIT](ERROR): Hardware Fault in component: DropWeight
2012-09-20T14:47:50.059Z,1348152470.059 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2012-09-20T14:47:52.458Z,1348152472.458 [ElevatorServo](FAULT): Overload Error
2012-09-20T14:47:52.459Z,1348152472.459 [ElevatorServo] Hardware Fault, FailCount= 2
2012-09-20T14:47:52.459Z,1348152472.459 [ElevatorServo](ERROR): Hardware Fault
2012-09-20T14:47:52.487Z,1348152472.487 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2012-09-20T14:47:52.837Z,1348152472.837 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2012-09-20T14:47:52.837Z,1348152472.837 [ElevatorServo](INFO): Powering down
2012-09-20T14:47:52.841Z,1348152472.841 [CBIT](INFO): Clearing failed state for component ElevatorServo
2012-09-20T14:47:52.841Z,1348152472.842 [ElevatorServo] No Fault, FailCount= 2
2012-09-20T14:47:53.635Z,1348152473.635 [ElevatorServo](DEBUG): Initializing EZServoServo.
2012-09-20T14:47:53.755Z,1348152473.755 [ElevatorServo](DEBUG): Initialization error opening port: port not yet opened
2012-09-20T14:47:53.755Z,1348152473.755 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2012-09-20T14:47:57.666Z,1348152477.666 [SBIT](FAULT): Elevator: EXPECTED:15.000000 ACTUAL:-1.565985
2012-09-20T14:47:57.666Z,1348152477.666 [SBIT](FAULT): Mass: EXPECTED:0.004800 ACTUAL:-0.001040
2012-09-20T14:47:58.462Z,1348152478.462 [ElevatorServo](FAULT): Overload Error
2012-09-20T14:47:58.463Z,1348152478.463 [ElevatorServo] Hardware Fault, FailCount= 3
2012-09-20T14:47:58.463Z,1348152478.463 [ElevatorServo](ERROR): Hardware Fault
2012-09-20T14:47:58.491Z,1348152478.491 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2012-09-20T14:47:58.491Z,1348152478.491 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo
2012-09-20T14:47:58.838Z,1348152478.838 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2012-09-20T14:47:58.838Z,1348152478.838 [ElevatorServo](INFO): Powering down
2012-09-20T14:48:10.847Z,1348152490.847 [CBIT](IMPORTANT): No ground fault detected
2012-09-20T14:48:38.441Z,1348152518.441 [SBIT](CRITICAL): SBIT FAILED
2012-09-20T14:48:38.836Z,1348152518.836 [MissionManager](IMPORTANT): Started mission Startup
2012-09-20T14:48:38.837Z,1348152518.837 [Startup] Running Loop=1
2012-09-20T14:48:38.837Z,1348152518.837 [Startup](INFO): Aggregate::initialize Startup
2012-09-20T14:48:38.837Z,1348152518.837 [Startup:A.GoToSurface] Running Loop=1
2012-09-20T14:48:38.837Z,1348152518.837 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2012-09-20T14:48:38.843Z,1348152518.843 [Startup:StartupSatComms] Running Loop=1
2012-09-20T14:48:38.843Z,1348152518.843 [Startup:StartupSatComms](INFO): Aggregate::initialize Startup:StartupSatComms
2012-09-20T14:48:38.843Z,1348152518.843 [Startup:StartupSatComms:A] Running Loop=1
2012-09-20T14:48:39.233Z,1348152519.233 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2012-09-20T14:49:22.632Z,1348152562.632 [CommandLine](IMPORTANT): got command set NAL9602.latitude_fix 36.799999 degree
2012-09-20T14:49:22.633Z,1348152562.633 [CommandLine](IMPORTANT): got command set NAL9602.longitude_fix -121.779999 degree
2012-09-20T14:49:22.840Z,1348152562.840 [CommandLine](IMPORTANT): got command set NAL9602.platform_communications 1.000000 bool
2012-09-20T14:49:22.859Z,1348152562.859 [Startup:StartupSatComms:A] Stopped
2012-09-20T14:49:22.859Z,1348152562.859 [Startup:StartupSatComms:B] Running Loop=1
2012-09-20T14:49:23.238Z,1348152563.238 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2012-09-20T14:49:32.356Z,1348152572.356 [CommandLine](IMPORTANT): got command set NAL9602.latitude_fix 36.799999 degree
2012-09-20T14:49:32.356Z,1348152572.356 [CommandLine](IMPORTANT): got command set NAL9602.longitude_fix -121.779999 degree
2012-09-20T14:49:32.564Z,1348152572.564 [CommandLine](IMPORTANT): got command set NAL9602.platform_communications 1.000000 bool
2012-09-20T14:49:32.652Z,1348152572.652 [Startup:StartupSatComms:B] Stopped
2012-09-20T14:49:32.652Z,1348152572.652 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2012-09-20T14:49:32.652Z,1348152572.652 [Startup:StartupSatComms] Stopped
2012-09-20T14:49:32.652Z,1348152572.652 [Startup:StartupSatComms](INFO): Aggregate::uninitialize Startup:StartupSatComms
2012-09-20T14:49:32.653Z,1348152572.653 [Startup](INFO): Completed Startup
2012-09-20T14:49:32.653Z,1348152572.653 [Startup] Stopped
2012-09-20T14:49:32.653Z,1348152572.653 [Startup](INFO): Aggregate::uninitialize Startup
2012-09-20T14:49:32.653Z,1348152572.653 [Startup:A.GoToSurface] Stopped
2012-09-20T14:49:32.653Z,1348152572.653 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2012-09-20T14:49:33.049Z,1348152573.049 [MissionManager](IMPORTANT): Started mission Default
2012-09-20T14:49:33.049Z,1348152573.049 [Default] Running Loop=1
2012-09-20T14:49:33.049Z,1348152573.049 [Default](INFO): Aggregate::initialize Default
2012-09-20T14:49:33.049Z,1348152573.049 [Default:D.SetSpeed] Running Loop=1
2012-09-20T14:49:33.049Z,1348152573.049 [Default:D.SetSpeed](DEBUG): Initialize.
2012-09-20T14:49:33.049Z,1348152573.049 [Default:E.GoToSurface] Running Loop=1
2012-09-20T14:49:33.049Z,1348152573.049 [Default:E.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2012-09-20T14:49:33.049Z,1348152573.049 [Default:Iridium] Running Loop=1
2012-09-20T14:49:33.050Z,1348152573.050 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2012-09-20T14:49:33.050Z,1348152573.050 [Default:Iridium:A.SetSpeed] Running Loop=1
2012-09-20T14:49:33.050Z,1348152573.050 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2012-09-20T14:49:33.050Z,1348152573.050 [Default:Iridium:B.GoToSurface] Running Loop=1
2012-09-20T14:49:33.050Z,1348152573.050 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2012-09-20T14:49:33.051Z,1348152573.051 [Default:E.GoToSurface] Running Loop=1
2012-09-20T14:49:33.055Z,1348152573.055 [Default:D.SetSpeed] Running Loop=1
2012-09-20T14:49:33.065Z,1348152573.065 [Default:Iridium:B.GoToSurface] Stopped
2012-09-20T14:49:33.065Z,1348152573.065 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2012-09-20T14:49:33.065Z,1348152573.065 [Default:Iridium:Read_Iridium] Running Loop=1
2012-09-20T14:49:33.065Z,1348152573.065 [Default:Iridium:A.SetSpeed] Running Loop=1
2012-09-20T14:49:33.070Z,1348152573.070 [Default:GPS] Running Loop=1
2012-09-20T14:49:33.070Z,1348152573.070 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2012-09-20T14:49:33.070Z,1348152573.070 [Default:GPS:A.SetSpeed] Running Loop=1
2012-09-20T14:49:33.070Z,1348152573.070 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2012-09-20T14:49:33.070Z,1348152573.070 [Default:GPS:B.GoToSurface] Running Loop=1
2012-09-20T14:49:33.070Z,1348152573.070 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2012-09-20T14:49:33.075Z,1348152573.075 [Default:GPS:B.GoToSurface] Stopped
2012-09-20T14:49:33.075Z,1348152573.076 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2012-09-20T14:49:33.076Z,1348152573.076 [Default:GPS:Read_GPS] Running Loop=1
2012-09-20T14:49:33.076Z,1348152573.076 [Default:GPS:A.SetSpeed] Running Loop=1
2012-09-20T14:49:33.454Z,1348152573.454 [Default:Iridium:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2012-09-20T14:49:33.456Z,1348152573.456 [Default:GPS:Read_GPS](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2012-09-20T14:51:00.223Z,1348152660.223 [CommandLine](IMPORTANT): got command run ./Missions/Science/science_to_67_70.xml
2012-09-20T14:51:00.223Z,1348152660.223 [MissionManager](INFO): Loading Mission: ./Missions/Science/science_to_67_70.xml
2012-09-20T14:51:00.293Z,1348152660.293 [MissionManager](INFO): DefineArg science_to_67_70.MinAltitude = 10.000000 m
2012-09-20T14:51:00.296Z,1348152660.296 [MissionManager](INFO): DefineArg science_to_67_70.MaxDepth = 105.000000 m
2012-09-20T14:51:00.299Z,1348152660.299 [MissionManager](INFO): DefineArg science_to_67_70.MinOffshore = 2000.000000 m
2012-09-20T14:51:00.302Z,1348152660.302 [MissionManager](INFO): DefineArg science_to_67_70.YoYoMinDepth = 3.000000 m
2012-09-20T14:51:00.305Z,1348152660.305 [MissionManager](INFO): DefineArg science_to_67_70.YoYoMaxDepth = 100.000000 m
2012-09-20T14:51:00.308Z,1348152660.308 [MissionManager](INFO): DefineArg science_to_67_70.YoYoUpPitch = 20.000000 arcdeg
2012-09-20T14:51:00.311Z,1348152660.311 [MissionManager](INFO): DefineArg science_to_67_70.YoYoDownPitch = -15.000000 arcdeg
2012-09-20T14:51:00.314Z,1348152660.314 [MissionManager](INFO): DefineArg science_to_67_70.WptLat = 36.120000 arcdeg
2012-09-20T14:51:00.317Z,1348152660.317 [MissionManager](INFO): DefineArg science_to_67_70.WptLon = -123.486000 arcdeg
2012-09-20T14:51:00.320Z,1348152660.320 [MissionManager](INFO): DefineArg science_to_67_70.NeedCommsTime = 120.000000 min
2012-09-20T14:51:00.324Z,1348152660.324 [MissionManager](INFO): DefineArg science_to_67_70.Speed = 1.000000 m/s
2012-09-20T14:51:00.327Z,1348152660.327 [MissionManager](INFO): DefineArg science_to_67_70.Timeout = 36.000000 h
2012-09-20T14:51:00.330Z,1348152660.330 [MissionManager](INFO): DefineArg science_to_67_70.BuoyancyNeutral = 0.000330 n/a
2012-09-20T14:51:00.333Z,1348152660.333 [science_to_67_70:AltEnvWrapper:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2012-09-20T14:51:00.341Z,1348152660.341 [science_to_67_70:AltEnvWrapper:B.Wait](DEBUG): Construct Wait.
2012-09-20T14:51:00.342Z,1348152660.342 [science_to_67_70:B.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2012-09-20T14:51:00.352Z,1348152660.352 [science_to_67_70:OffshoreWrapper:A.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope.
2012-09-20T14:51:00.359Z,1348152660.359 [science_to_67_70:OffshoreWrapper:B.Wait](DEBUG): Construct Wait.
2012-09-20T14:51:00.360Z,1348152660.360 [MissionManager](INFO): Inserting Stack: Missions/Insert/Surface.xml
2012-09-20T14:51:00.381Z,1348152660.381 [MissionManager](INFO): DefineArg science_to_67_70:SURFACECOMMS.SurfaceDepthRate = nan m/s
2012-09-20T14:51:00.384Z,1348152660.384 [MissionManager](INFO): DefineArg science_to_67_70:SURFACECOMMS.SurfacePitch = nan arcdeg
2012-09-20T14:51:00.387Z,1348152660.388 [MissionManager](INFO): DefineArg science_to_67_70:SURFACECOMMS.SurfaceSpeed = 0.500000 m/s
2012-09-20T14:51:00.391Z,1348152660.391 [MissionManager](INFO): DefineArg science_to_67_70:SURFACECOMMS.IridiumTimeout = 30.000000 min
2012-09-20T14:51:00.392Z,1348152660.392 [science_to_67_70:SURFACECOMMS:A.GoToSurface](DEBUG): Construct GoToSurface.
2012-09-20T14:51:00.403Z,1348152660.403 [MissionManager](INFO): RedefineArg science_to_67_70:SURFACECOMMS.SurfacePitch = 20.000000 arcdeg
2012-09-20T14:51:00.408Z,1348152660.408 [MissionManager](INFO): Inserting Stack: Missions/Insert/Science.xml
2012-09-20T14:51:00.541Z,1348152660.541 [MissionManager](INFO): DefineArg science_to_67_70:Science.SampleISUS = 0 bool
2012-09-20T14:51:00.548Z,1348152660.548 [MissionManager](INFO): DefineArg science_to_67_70:Science.SampleRSSI = 1 bool
2012-09-20T14:51:00.555Z,1348152660.555 [MissionManager](INFO): DefineArg science_to_67_70:Science.SampleADCP = 1 bool
2012-09-20T14:51:00.558Z,1348152660.558 [MissionManager](INFO): DefineArg science_to_67_70:Science.PeakDetectChlActive = 0 bool
2012-09-20T14:51:00.564Z,1348152660.565 [MissionManager](INFO): DefineArg science_to_67_70:Science.PeakDetectNO3Active = 0 bool
2012-09-20T14:51:00.572Z,1348152660.572 [MissionManager](INFO): DefineArg science_to_67_70:Science.SampleAanderaaO2 = 0.000000 n/a
2012-09-20T14:51:00.580Z,1348152660.580 [MissionManager](INFO): DefineArg science_to_67_70:Science.SampleNeilBrown = 1.000000 n/a
2012-09-20T14:51:00.587Z,1348152660.587 [MissionManager](INFO): DefineArg science_to_67_70:Science.SampleTurbulence_NPS = 1.000000 n/a
2012-09-20T14:51:00.593Z,1348152660.593 [MissionManager](INFO): DefineArg science_to_67_70:Science.SampleWetLabsBB2FL = 1.000000 n/a
2012-09-20T14:51:00.610Z,1348152660.610 [MissionManager](INFO): DefineArg science_to_67_70:Science.EnabledDVL = 1.000000 n/a
2012-09-20T14:51:00.613Z,1348152660.613 [MissionManager](INFO): DefineOutput science_to_67_70:Science.PeakChl = 0.000000 ug/l
2012-09-20T14:51:00.649Z,1348152660.649 [MissionManager](INFO): DefineOutput science_to_67_70:Science.PeakChlDepth = 0.000000 m
2012-09-20T14:51:00.653Z,1348152660.653 [MissionManager](INFO): DefineOutput science_to_67_70:Science.PeakChlLatitude = nan arcdeg
2012-09-20T14:51:00.672Z,1348152660.672 [MissionManager](INFO): DefineOutput science_to_67_70:Science.PeakChlLongitude = nan arcdeg
2012-09-20T14:51:00.675Z,1348152660.675 [MissionManager](INFO): DefineOutput science_to_67_70:Science.PeakNO3 = 0.000000 umol/l
2012-09-20T14:51:00.678Z,1348152660.678 [MissionManager](INFO): DefineOutput science_to_67_70:Science.PeakNO3Depth = 0.000000 m
2012-09-20T14:51:00.697Z,1348152660.697 [MissionManager](INFO): DefineOutput science_to_67_70:Science.PeakNO3Latitude = nan arcdeg
2012-09-20T14:51:00.700Z,1348152660.700 [MissionManager](INFO): DefineOutput science_to_67_70:Science.PeakNO3Longitude = nan arcdeg
2012-09-20T14:51:00.744Z,1348152660.744 [science_to_67_70:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2012-09-20T14:51:00.762Z,1348152660.761 [science_to_67_70:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2012-09-20T14:51:00.814Z,1348152660.814 [MissionManager](INFO): RedefineArg science_to_67_70:Science.SampleISUS = 1 bool
2012-09-20T14:51:00.816Z,1348152660.816 [MissionManager](INFO): RedefineArg science_to_67_70:Science.PeakDetectChlActive = 1 bool
2012-09-20T14:51:00.817Z,1348152660.817 [science_to_67_70:G.Buoyancy](DEBUG): Construct Buoyancy.
2012-09-20T14:51:00.820Z,1348152660.820 [science_to_67_70:H.SetSpeed](DEBUG): Construct.
2012-09-20T14:51:00.823Z,1348152660.823 [science_to_67_70:I.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2012-09-20T14:51:00.845Z,1348152660.845 [science_to_67_70:J.YoYo](DEBUG): Construct YoYo.
2012-09-20T14:51:00.864Z,1348152660.864 [science_to_67_70:Wpt.Point](DEBUG): Construct.
2012-09-20T14:51:00.895Z,1348152660.895 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       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/Control http://aosn.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://aosn.mbari.org/tethys/Xml/Guidance.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_to_67_70">

    <Description>
        Vehicle yo-yo's to the specified waypoint, with science turned on.
    </Description>

    <DefineArg Name="MinAltitude"><Description>
        Minimum height above the sea floor for the entire mission.
    </Description><Units:meter/><Value>10.0</Value></DefineArg>

    <DefineArg Name="MaxDepth"><Description>
        Maximum depth for the entire mission.
    </Description><Units:meter/><Value>105.0</Value></DefineArg>

    <DefineArg Name="MinOffshore"><Description>
        Minimum offshore distance for the entire mission.
    </Description><Units:meter/><Value>2000.0</Value></DefineArg>

    <DefineArg Name="YoYoMinDepth"><Description>
        Minimum depth while performing the YoYo behavior.
    </Description><Units:meter/><Value>3.0</Value></DefineArg>

    <DefineArg Name="YoYoMaxDepth"><Description>
        Maximum depth while performing the YoYo behavior.
    </Description><Units:meter/><Value>100.0</Value></DefineArg>

    <DefineArg Name="YoYoUpPitch"><Description>
        Vehicle up pitch while performing the YoYo behavior.
    </Description><Units:degree/><Value>20.0</Value></DefineArg>

    <DefineArg Name="YoYoDownPitch"><Description>
        Vehicle down pitch while performing the YoYo behavior.
    </Description><Units:degree/><Value>-15.0</Value></DefineArg>

    <DefineArg Name="WptLat"><Description>
        Latitude of waypoint.
    </Description><Units:degree/><Value>36.120</Value></DefineArg>

    <DefineArg Name="WptLon"><Description>
        Longitude of waypoint.
    </Description><Units:degree/><Value>-123.486</Value></DefineArg>

    <DefineArg Name="NeedCommsTime"><Description>
        Elapsed time after previous surface communications when vehicle will
        begin to ascend for additional surface communications, if the vehicle
        has a positive pitch. If the vehicle has a negative pitch, it will wait
        up to 10 minutes more to begin ascent.
    </Description><Units:minute/><Value>120</Value></DefineArg>

    <DefineArg Name="Speed"><Description>
        Speed while performing the YoYo behavior.
    </Description><Units:meter_per_second/><Value>1</Value></DefineArg>

    <DefineArg Name="Timeout"><Description>
        Maximum length of mission
    </Description><Units:hour/><Value>36</Value></DefineArg>

    <DefineArg Name="BuoyancyNeutral"><Description>
        Buoyancy bladder position while performing the YoYo behavior. Defaults
        to buoyancyNeutral setting in the Config/Control.cfg file.
    </Description><Control:VerticalControl.buoyancyNeutral/></DefineArg>

    <Timeout Duration="Timeout"/>

    <Aggregate Id="AltEnvWrapper">

        <When><Arg Name="MinAltitude"/>
            <Gt><Units:meter/><Value>0</Value></Gt>
        </When>

        <Guidance:AltitudeEnvelope RunIn="Parallel">
            <Description>
                Safety behavior that keeps vehicle off sea floor
            </Description>
            <Setting><Guidance:AltitudeEnvelope.minAltitude/><Arg Name="MinAltitude"/></Setting>
        </Guidance:AltitudeEnvelope>

        <Guidance:Wait RunIn="Sequence"/>

    </Aggregate>

    <Guidance:DepthEnvelope RunIn="Parallel">
        <Description>
            Safety behavior that keeps vehicle from going too deep
        </Description>
        <Setting><Guidance:DepthEnvelope.maxDepth/><Arg Name="MaxDepth"/></Setting>
    </Guidance:DepthEnvelope>

    <Aggregate Id="OffshoreWrapper">

        <When><Arg Name="MinOffshore"/>
            <Gt><Units:meter/><Value>0</Value></Gt>
        </When>

        <Guidance:OffshoreEnvelope RunIn="Parallel">
            <Description>
                Safety behavior that keeps vehicle away from the shore
            </Description>
            <Setting><Guidance:OffshoreEnvelope.minOffshore/><Arg Name="MinOffshore"/></Setting>
        </Guidance:OffshoreEnvelope>

        <Guidance:Wait RunIn="Sequence"/>

    </Aggregate>

    <Insert Filename="Insert/Surface.xml" Id="SURFACECOMMS">
        <RedefineArg Name="SurfacePitch"><Units:degree/><Value>20</Value></RedefineArg>
    </Insert>

<!-- GPS Update.  Don't go too long w/o a GPS fix. -->

    <Aggregate Id="NeedComms">

        <When><Universal:platform_pitch_angle/>
            <Gt><Units:degree/><Value>0</Value></Gt>
            <And>
            <Elapsed><Universal:latitude_fix/></Elapsed><Gt><Arg Name="NeedCommsTime"/></Gt></And>
            <Or>
            <Elapsed><Universal:latitude_fix/></Elapsed><Gt><Arg Name="NeedCommsTime"/><Add><Units:minute/><Value>10</Value></Add></Gt></Or>
        </When>

        <Call RefId="SURFACECOMMS"/>

    </Aggregate>

    <Insert Filename="Insert/Science.xml">
        <Description>
            If we're executing here or below, lets' get science data!
        </Description>
        <RedefineArg Name="SampleISUS"><True/></RedefineArg>
        <RedefineArg Name="PeakDetectChlActive"><True/></RedefineArg>
    </Insert>

    <Guidance:Buoyancy RunIn="Parallel">
        <Setting><Guidance:Buoyancy.position /><Arg Name="BuoyancyNeutral"/></Setting>
    </Guidance:Buoyancy>

    <Guidance:SetSpeed RunIn="Parallel">
        <Setting><Guidance:SetSpeed.speed/><Arg Name="Speed"/></Setting>
    </Guidance:SetSpeed>

    <Guidance:DepthEnvelope RunIn="Parallel">
        <Setting><Guidance:DepthEnvelope.minDepth/><Arg Name="YoYoMinDepth"/></Setting>
        <Setting><Guidance:DepthEnvelope.maxDepth/><Arg Name="YoYoMaxDepth"/></Setting>
        <Setting><Guidance:DepthEnvelope.upPitch/><Arg Name="YoYoUpPitch"/></Setting>
        <Setting><Guidance:DepthEnvelope.downPitch/><Arg Name="YoYoDownPitch"/></Setting>
    </Guidance:DepthEnvelope>

    <Guidance:YoYo RunIn="Parallel">
        <Setting><Guidance:YoYo.upPitch/><Arg Name="YoYoUpPitch"/></Setting>
        <Setting><Guidance:YoYo.downPitch/><Arg Name="YoYoDownPitch"/></Setting>
    </Guidance:YoYo>

    <Guidance:Point Id="Wpt" RunIn="Sequence">
        <Setting><Guidance:Point.latitude/><Arg Name="WptLat"/></Setting>
        <Setting><Guidance:Point.longitude/><Arg Name="WptLon"/></Setting>
    </Guidance:Point>

</Mission>


2012-09-20T14:51:00.896Z,1348152660.895 [CommandLine](IMPORTANT): Running ./Missions/Science/science_to_67_70.xml
2012-09-20T14:51:01.079Z,1348152661.079 [Default] Stopped
2012-09-20T14:51:01.080Z,1348152661.080 [Default](INFO): Aggregate::uninitialize Default
2012-09-20T14:51:01.080Z,1348152661.080 [Default:GPS] Stopped
2012-09-20T14:51:01.080Z,1348152661.080 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2012-09-20T14:51:01.080Z,1348152661.080 [Default:GPS:A.SetSpeed] Stopped
2012-09-20T14:51:01.080Z,1348152661.080 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2012-09-20T14:51:01.080Z,1348152661.080 [Default:GPS:Read_GPS] Stopped
2012-09-20T14:51:01.080Z,1348152661.080 [Default:Iridium] Stopped
2012-09-20T14:51:01.080Z,1348152661.080 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2012-09-20T14:51:01.080Z,1348152661.080 [Default:Iridium:A.SetSpeed] Stopped
2012-09-20T14:51:01.080Z,1348152661.080 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2012-09-20T14:51:01.080Z,1348152661.080 [Default:Iridium:Read_Iridium] Stopped
2012-09-20T14:51:01.080Z,1348152661.080 [Default:D.SetSpeed] Stopped
2012-09-20T14:51:01.080Z,1348152661.080 [Default:D.SetSpeed](DEBUG): Uninitialize.
2012-09-20T14:51:01.081Z,1348152661.081 [Default:E.GoToSurface] Stopped
2012-09-20T14:51:01.081Z,1348152661.081 [Default:E.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2012-09-20T14:51:01.081Z,1348152661.081 [MissionManager](IMPORTANT): Started mission science_to_67_70
2012-09-20T14:51:01.081Z,1348152661.081 [science_to_67_70] Running Loop=1
2012-09-20T14:51:01.081Z,1348152661.081 [science_to_67_70](INFO): Aggregate::initialize science_to_67_70
2012-09-20T14:51:01.081Z,1348152661.081 [science_to_67_70:B.DepthEnvelope] Running Loop=1
2012-09-20T14:51:01.081Z,1348152661.081 [science_to_67_70:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2012-09-20T14:51:01.085Z,1348152661.085 [science_to_67_70:Science] Running Loop=1
2012-09-20T14:51:01.085Z,1348152661.085 [science_to_67_70:Science](INFO): Aggregate::initialize science_to_67_70:Science
2012-09-20T14:51:01.085Z,1348152661.085 [science_to_67_70:Science:A] Running Loop=1
2012-09-20T14:51:01.085Z,1348152661.085 [science_to_67_70:Science:B] Running Loop=1
2012-09-20T14:51:01.085Z,1348152661.085 [science_to_67_70:Science:C] Running Loop=1
2012-09-20T14:51:01.085Z,1348152661.085 [science_to_67_70:Science:D] Running Loop=1
2012-09-20T14:51:01.085Z,1348152661.085 [science_to_67_70:Science:E] Running Loop=1
2012-09-20T14:51:01.086Z,1348152661.086 [science_to_67_70:Science:F] Running Loop=1
2012-09-20T14:51:01.086Z,1348152661.086 [science_to_67_70:Science:G] Running Loop=1
2012-09-20T14:51:01.086Z,1348152661.086 [science_to_67_70:G.Buoyancy] Running Loop=1
2012-09-20T14:51:01.086Z,1348152661.086 [science_to_67_70:G.Buoyancy](DEBUG): Initialize Buoyancy Component.
2012-09-20T14:51:01.086Z,1348152661.086 [science_to_67_70:H.SetSpeed] Running Loop=1
2012-09-20T14:51:01.086Z,1348152661.086 [science_to_67_70:H.SetSpeed](DEBUG): Initialize.
2012-09-20T14:51:01.086Z,1348152661.086 [science_to_67_70:I.DepthEnvelope] Running Loop=1
2012-09-20T14:51:01.086Z,1348152661.086 [science_to_67_70:I.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2012-09-20T14:51:01.087Z,1348152661.087 [science_to_67_70:J.YoYo] Running Loop=1
2012-09-20T14:51:01.087Z,1348152661.087 [science_to_67_70:J.YoYo](DEBUG): Initialize YoYoComponent.
2012-09-20T14:51:01.087Z,1348152661.088 [science_to_67_70:SURFACECOMMS] Running Loop=1
2012-09-20T14:51:01.088Z,1348152661.088 [science_to_67_70:SURFACECOMMS](INFO): Aggregate::initialize science_to_67_70:SURFACECOMMS
2012-09-20T14:51:01.088Z,1348152661.088 [science_to_67_70:SURFACECOMMS:A.GoToSurface] Running Loop=1
2012-09-20T14:51:01.088Z,1348152661.088 [science_to_67_70:SURFACECOMMS:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2012-09-20T14:51:01.089Z,1348152661.089 [science_to_67_70:J.YoYo] Running Loop=1
2012-09-20T14:51:01.094Z,1348152661.094 [science_to_67_70:I.DepthEnvelope] Running Loop=1
2012-09-20T14:51:01.100Z,1348152661.100 [science_to_67_70:H.SetSpeed] Running Loop=1
2012-09-20T14:51:01.104Z,1348152661.104 [science_to_67_70:G.Buoyancy] Running Loop=1
2012-09-20T14:51:01.108Z,1348152661.108 [science_to_67_70:Science] Running Loop=1
2012-09-20T14:51:01.109Z,1348152661.109 [science_to_67_70:Science:PeakDetectChl] Running Loop=1
2012-09-20T14:51:01.109Z,1348152661.109 [science_to_67_70:Science:PeakDetectChl](INFO): Aggregate::initialize science_to_67_70:Science:PeakDetectChl
2012-09-20T14:51:01.109Z,1348152661.109 [science_to_67_70:Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1
2012-09-20T14:51:01.109Z,1348152661.109 [science_to_67_70:Science:PeakDetectChl:A.PeakDetectVsDepth](INFO): Initialize.
2012-09-20T14:51:01.115Z,1348152661.115 [science_to_67_70:Science:G] Running Loop=1
2012-09-20T14:51:01.116Z,1348152661.116 [science_to_67_70:Science:G](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2012-09-20T14:51:01.117Z,1348152661.117 [science_to_67_70:Science:F] Running Loop=1
2012-09-20T14:51:01.118Z,1348152661.118 [science_to_67_70:Science:F](DEBUG): Initialize ReadDataComponent to sense DVL_micro.Beam1RSSI
2012-09-20T14:51:01.119Z,1348152661.119 [science_to_67_70:Science:E] Running Loop=1
2012-09-20T14:51:01.120Z,1348152661.120 [science_to_67_70:Science:E](DEBUG): Initialize ReadDataComponent to sense DVL_micro.AdcpXWaterVelocity
2012-09-20T14:51:01.121Z,1348152661.121 [science_to_67_70:Science:D] Running Loop=1
2012-09-20T14:51:01.122Z,1348152661.122 [science_to_67_70:Science:D](DEBUG): Initialize ReadDataComponent to sense Turbulence_NPS.MicroCond
2012-09-20T14:51:01.123Z,1348152661.123 [science_to_67_70:Science:C] Running Loop=1
2012-09-20T14:51:01.124Z,1348152661.124 [science_to_67_70:Science:C](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature
2012-09-20T14:51:01.124Z,1348152661.124 [science_to_67_70:Science:C](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity
2012-09-20T14:51:01.126Z,1348152661.126 [science_to_67_70:Science:B] Running Loop=1
2012-09-20T14:51:01.126Z,1348152661.126 [science_to_67_70:Science:B](DEBUG): Initialize ReadDataComponent to sense mole_concentration_of_nitrate_in_sea_water
2012-09-20T14:51:01.132Z,1348152661.132 [science_to_67_70:SURFACECOMMS:B] Running Loop=1
2012-09-20T14:51:01.132Z,1348152661.132 [science_to_67_70:SURFACECOMMS:B](INFO): Aggregate::initialize science_to_67_70:SURFACECOMMS:B
2012-09-20T14:51:01.133Z,1348152661.133 [science_to_67_70:SURFACECOMMS:B:A] Running Loop=1
2012-09-20T14:51:01.133Z,1348152661.133 [science_to_67_70:OffshoreWrapper] Running Loop=1
2012-09-20T14:51:01.133Z,1348152661.133 [science_to_67_70:OffshoreWrapper](INFO): Aggregate::initialize science_to_67_70:OffshoreWrapper
2012-09-20T14:51:01.133Z,1348152661.133 [science_to_67_70:OffshoreWrapper:A.OffshoreEnvelope] Running Loop=1
2012-09-20T14:51:01.133Z,1348152661.133 [science_to_67_70:OffshoreWrapper:A.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent.
2012-09-20T14:51:01.133Z,1348152661.133 [science_to_67_70:OffshoreWrapper:B.Wait] Running Loop=1
2012-09-20T14:51:01.133Z,1348152661.133 [science_to_67_70:OffshoreWrapper:B.Wait](DEBUG): Initialize Wait Component.
2012-09-20T14:51:01.138Z,1348152661.138 [science_to_67_70:OffshoreWrapper:A.OffshoreEnvelope] Running Loop=1
2012-09-20T14:51:01.142Z,1348152661.142 [science_to_67_70:B.DepthEnvelope] Running Loop=1
2012-09-20T14:51:01.147Z,1348152661.147 [science_to_67_70:AltEnvWrapper] Running Loop=1
2012-09-20T14:51:01.147Z,1348152661.147 [science_to_67_70:AltEnvWrapper](INFO): Aggregate::initialize science_to_67_70:AltEnvWrapper
2012-09-20T14:51:01.147Z,1348152661.148 [science_to_67_70:AltEnvWrapper:A.AltitudeEnvelope] Running Loop=1
2012-09-20T14:51:01.148Z,1348152661.148 [science_to_67_70:AltEnvWrapper:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2012-09-20T14:51:01.148Z,1348152661.148 [science_to_67_70:AltEnvWrapper:B.Wait] Running Loop=1
2012-09-20T14:51:01.148Z,1348152661.148 [science_to_67_70:AltEnvWrapper:B.Wait](DEBUG): Initialize Wait Component.
2012-09-20T14:51:01.152Z,1348152661.152 [science_to_67_70:AltEnvWrapper:A.AltitudeEnvelope] Running Loop=1
2012-09-20T14:51:01.455Z,1348152661.455 [DVL_micro](INFO): RSSI requested
2012-09-20T14:51:01.455Z,1348152661.455 [DVL_micro](INFO): ADCP requested
2012-09-20T14:51:01.456Z,1348152661.456 [DVL_micro](INFO): resume:Powering up
2012-09-20T14:51:01.475Z,1348152661.475 [WetLabsBB2FL](INFO): Powering up
2012-09-20T14:51:01.485Z,1348152661.485 [science_to_67_70:J.YoYo] Preempted
2012-09-20T14:51:01.485Z,1348152661.485 [science_to_67_70:I.DepthEnvelope] Preempted
2012-09-20T14:51:01.485Z,1348152661.485 [science_to_67_70:H.SetSpeed] Preempted
2012-09-20T14:51:01.485Z,1348152661.485 [science_to_67_70:G.Buoyancy] Preempted
2012-09-20T14:51:01.485Z,1348152661.485 [science_to_67_70:Science] Preempted
2012-09-20T14:51:01.485Z,1348152661.485 [science_to_67_70:Science:B] Preempted
2012-09-20T14:51:01.485Z,1348152661.485 [science_to_67_70:Science:C] Preempted
2012-09-20T14:51:01.485Z,1348152661.485 [science_to_67_70:Science:D] Preempted
2012-09-20T14:51:01.485Z,1348152661.485 [science_to_67_70:Science:E] Preempted
2012-09-20T14:51:01.485Z,1348152661.485 [science_to_67_70:Science:F] Preempted
2012-09-20T14:51:01.485Z,1348152661.485 [science_to_67_70:Science:G] Preempted
2012-09-20T14:51:01.487Z,1348152661.487 [science_to_67_70:SURFACECOMMS:B:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2012-09-20T14:51:02.681Z,1348152662.681 [science_to_67_70:AltEnvWrapper:A.AltitudeEnvelope](ERROR): Altitude Measurement is not Active.
2012-09-20T14:51:02.723Z,1348152662.723 [WetLabsBB2FL](INFO): Powering down
2012-09-20T14:51:02.962Z,1348152662.962 [DVL_micro](INFO): Querying output modes
2012-09-20T14:51:02.963Z,1348152662.963 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2012-09-20T14:51:02.970Z,1348152662.970 [DVL_micro](DEBUG): cmdResponse: 01
2012-09-20T14:51:02.970Z,1348152662.970 [DVL_micro](INFO): NQ1 output enabled
2012-09-20T14:51:02.971Z,1348152662.971 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2012-09-20T14:51:02.979Z,1348152662.978 [DVL_micro](DEBUG): cmdResponse: AUTO_VEL_ON 
2012-09-20T14:51:05.502Z,1348152665.503 [DVL_micro](DEBUG): NQ1
2012-09-20T14:51:08.042Z,1348152668.042 [DVL_micro](DEBUG): NQ1
2012-09-20T14:51:10.578Z,1348152670.578 [DVL_micro](DEBUG): NQ1
2012-09-20T14:51:13.118Z,1348152673.118 [DVL_micro](DEBUG): NQ1
2012-09-20T14:51:15.655Z,1348152675.655 [DVL_micro](DEBUG): NQ1
2012-09-20T14:51:18.194Z,1348152678.194 [DVL_micro](DEBUG): NQ1
2012-09-20T14:51:20.726Z,1348152680.726 [DVL_micro](DEBUG): NQ1
2012-09-20T14:51:23.266Z,1348152683.266 [DVL_micro](DEBUG): NQ1
2012-09-20T14:51:25.803Z,1348152685.803 [DVL_micro](DEBUG): NQ1
2012-09-20T14:51:28.342Z,1348152688.342 [DVL_micro](DEBUG): NQ1
2012-09-20T14:51:30.886Z,1348152690.886 [DVL_micro](DEBUG): NQ1
2012-09-20T14:51:32.549Z,1348152692.549 [CommandLine](IMPORTANT): got command set NAL9602.latitude_fix 36.799999 degree
2012-09-20T14:51:32.550Z,1348152692.550 [CommandLine](IMPORTANT): got command set NAL9602.longitude_fix -121.779999 degree
2012-09-20T14:51:32.700Z,1348152692.700 [science_to_67_70:SURFACECOMMS:B:A] Stopped
2012-09-20T14:51:32.700Z,1348152692.700 [science_to_67_70:SURFACECOMMS:B:B] Running Loop=1
2012-09-20T14:51:32.847Z,1348152692.847 [CommandLine](IMPORTANT): got command set NAL9602.platform_communications 1.000000 bool
2012-09-20T14:51:33.081Z,1348152693.081 [science_to_67_70:SURFACECOMMS:B:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2012-09-20T14:51:33.082Z,1348152693.082 [science_to_67_70:SURFACECOMMS:B:B] Stopped
2012-09-20T14:51:33.085Z,1348152693.085 [science_to_67_70:SURFACECOMMS:B:C] Running Loop=1
2012-09-20T14:51:33.433Z,1348152693.432 [DVL_micro](DEBUG): NQ1
2012-09-20T14:51:33.496Z,1348152693.496 [science_to_67_70:SURFACECOMMS:B:C](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2012-09-20T14:51:35.970Z,1348152695.970 [DVL_micro](DEBUG): NQ1
2012-09-20T14:51:37.978Z,1348152697.978 [CommandLine](IMPORTANT): got command set NAL9602.latitude_fix 36.799999 degree
2012-09-20T14:51:37.979Z,1348152697.979 [CommandLine](IMPORTANT): got command set NAL9602.longitude_fix -121.779999 degree
2012-09-20T14:51:38.212Z,1348152698.212 [CommandLine](IMPORTANT): got command set NAL9602.platform_communications 1.000000 bool
2012-09-20T14:51:38.318Z,1348152698.318 [science_to_67_70:SURFACECOMMS:B:C] Stopped
2012-09-20T14:51:38.318Z,1348152698.318 [science_to_67_70:SURFACECOMMS:B](INFO): Completed science_to_67_70:SURFACECOMMS:B
2012-09-20T14:51:38.318Z,1348152698.318 [science_to_67_70:SURFACECOMMS:B] Stopped
2012-09-20T14:51:38.318Z,1348152698.318 [science_to_67_70:SURFACECOMMS:B](INFO): Aggregate::uninitialize science_to_67_70:SURFACECOMMS:B
2012-09-20T14:51:38.319Z,1348152698.319 [science_to_67_70:SURFACECOMMS](INFO): Completed science_to_67_70:SURFACECOMMS
2012-09-20T14:51:38.319Z,1348152698.319 [science_to_67_70:SURFACECOMMS] Stopped
2012-09-20T14:51:38.319Z,1348152698.319 [science_to_67_70:SURFACECOMMS](INFO): Aggregate::uninitialize science_to_67_70:SURFACECOMMS
2012-09-20T14:51:38.319Z,1348152698.319 [science_to_67_70:SURFACECOMMS:A.GoToSurface] Stopped
2012-09-20T14:51:38.319Z,1348152698.319 [science_to_67_70:SURFACECOMMS:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2012-09-20T14:51:38.320Z,1348152698.320 [science_to_67_70:Wpt.Point] Running Loop=1
2012-09-20T14:51:38.320Z,1348152698.320 [science_to_67_70:Wpt.Point](DEBUG): Initialize.
2012-09-20T14:51:38.514Z,1348152698.514 [DVL_micro](DEBUG): NQ1
2012-09-20T14:51:38.686Z,1348152698.686 [science_to_67_70:J.YoYo] Running Loop=1
2012-09-20T14:51:38.687Z,1348152698.687 [science_to_67_70:I.DepthEnvelope] Running Loop=1
2012-09-20T14:51:38.688Z,1348152698.688 [science_to_67_70:H.SetSpeed] Running Loop=1
2012-09-20T14:51:38.688Z,1348152698.688 [science_to_67_70:G.Buoyancy] Running Loop=1
2012-09-20T14:51:38.689Z,1348152698.689 [science_to_67_70:Science] Running Loop=1
2012-09-20T14:51:38.690Z,1348152698.690 [science_to_67_70:Science:G] Running Loop=1
2012-09-20T14:51:38.690Z,1348152698.690 [science_to_67_70:Science:F] Running Loop=1
2012-09-20T14:51:38.690Z,1348152698.690 [science_to_67_70:Science:E] Running Loop=1
2012-09-20T14:51:38.691Z,1348152698.691 [science_to_67_70:Science:D] Running Loop=1
2012-09-20T14:51:38.691Z,1348152698.691 [science_to_67_70:Science:C] Running Loop=1
2012-09-20T14:51:38.691Z,1348152698.691 [science_to_67_70:Science:B] Running Loop=1
2012-09-20T14:51:39.099Z,1348152699.099 [WetLabsBB2FL](INFO): Powering up
2012-09-20T14:51:40.528Z,1348152700.528 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.008880 psu
2012-09-20T14:51:40.604Z,1348152700.604 [DVL_micro](INFO): RSSI requested
2012-09-20T14:51:40.604Z,1348152700.604 [DVL_micro](INFO): ADCP requested
2012-09-20T14:51:40.725Z,1348152700.725 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.008660 psu
2012-09-20T14:51:40.927Z,1348152700.927 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.024590 psu
2012-09-20T14:51:41.131Z,1348152701.131 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.018000 psu
2012-09-20T14:51:41.336Z,1348152701.336 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.013860 psu
2012-09-20T14:51:41.336Z,1348152701.336 [CTD_NeilBrown](ERROR): Pressure reading out of range: -17.759998 decibar
2012-09-20T14:51:41.543Z,1348152701.543 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.022100 psu
2012-09-20T14:51:41.749Z,1348152701.749 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.036460 psu
2012-09-20T14:51:41.951Z,1348152701.951 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.010980 psu
2012-09-20T14:51:42.111Z,1348152702.111 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD1616 00 0

2012-09-20T14:51:42.156Z,1348152702.156 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.021370 psu
2012-09-20T14:51:42.327Z,1348152702.327 [DVL_micro](DEBUG): cmdResponse: 00
2012-09-20T14:51:42.327Z,1348152702.327 [DVL_micro](INFO): Enabling RSSI output
2012-09-20T14:51:42.327Z,1348152702.327 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 16 7

2012-09-20T14:51:42.360Z,1348152702.360 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.012760 psu
2012-09-20T14:51:42.531Z,1348152702.531 [DVL_micro](DEBUG): cmdResponse: 16
2012-09-20T14:51:42.531Z,1348152702.531 [DVL_micro](INFO): Enabling ADCP output
2012-09-20T14:51:42.531Z,1348152702.531 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 03 3

2012-09-20T14:51:42.567Z,1348152702.567 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.012180 psu
2012-09-20T14:51:42.727Z,1348152702.727 [DVL_micro](DEBUG): cmdResponse: 03 16
2012-09-20T14:51:42.727Z,1348152702.727 [DVL_micro](INFO): Enabling NQ1 output
2012-09-20T14:51:42.728Z,1348152702.728 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0505 01 1

2012-09-20T14:51:42.764Z,1348152702.764 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.007310 psu
2012-09-20T14:51:42.923Z,1348152702.923 [DVL_micro](DEBUG): cmdResponse: 01 03 16
2012-09-20T14:51:42.923Z,1348152702.923 [DVL_micro](INFO): Querying output modes
2012-09-20T14:51:42.923Z,1348152702.923 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2012-09-20T14:51:42.927Z,1348152702.927 [DVL_micro](DEBUG): cmdResponse: 01 03 16
2012-09-20T14:51:42.927Z,1348152702.927 [DVL_micro](INFO): NQ1 output enabled
2012-09-20T14:51:42.927Z,1348152702.927 [DVL_micro](INFO): RSSI output enabled
2012-09-20T14:51:42.927Z,1348152702.927 [DVL_micro](INFO): ADCP output enabled
2012-09-20T14:51:42.927Z,1348152702.927 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2012-09-20T14:51:42.935Z,1348152702.935 [DVL_micro](DEBUG): cmdResponse: AUTO_VEL_ON 
2012-09-20T14:51:42.968Z,1348152702.968 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.014860 psu
2012-09-20T14:51:43.072Z,1348152703.072 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=40
2012-09-20T14:51:43.131Z,1348152703.131 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=92
2012-09-20T14:51:43.176Z,1348152703.176 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.053420 psu
2012-09-20T14:51:43.184Z,1348152703.184 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=80
2012-09-20T14:51:43.231Z,1348152703.231 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2012-09-20T14:51:43.379Z,1348152703.379 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.030940 psu
2012-09-20T14:51:43.511Z,1348152703.511 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=24
2012-09-20T14:51:43.584Z,1348152703.584 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.024870 psu
2012-09-20T14:51:43.616Z,1348152703.616 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=29
2012-09-20T14:51:43.727Z,1348152703.727 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=130
2012-09-20T14:51:43.788Z,1348152703.788 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.054390 psu
2012-09-20T14:51:43.820Z,1348152703.820 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2012-09-20T14:51:43.956Z,1348152703.956 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=8
2012-09-20T14:51:43.992Z,1348152703.992 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.010620 psu
2012-09-20T14:51:44.011Z,1348152704.011 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=28
2012-09-20T14:51:44.067Z,1348152704.067 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=48
2012-09-20T14:51:44.119Z,1348152704.119 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2012-09-20T14:51:44.199Z,1348152704.199 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.023650 psu
2012-09-20T14:51:44.273Z,1348152704.273 [NAL9602](INFO): Powering down
2012-09-20T14:51:44.400Z,1348152704.399 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=24
2012-09-20T14:51:44.403Z,1348152704.403 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.023170 psu
2012-09-20T14:51:44.503Z,1348152704.503 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=28
2012-09-20T14:51:44.615Z,1348152704.615 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.018860 psu
2012-09-20T14:51:44.639Z,1348152704.639 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=416
2012-09-20T14:51:44.711Z,1348152704.711 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2012-09-20T14:51:44.811Z,1348152704.811 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.018860 psu
2012-09-20T14:51:45.016Z,1348152705.016 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.024670 psu
2012-09-20T14:51:45.056Z,1348152705.056 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=25
2012-09-20T14:51:45.203Z,1348152705.203 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=61
2012-09-20T14:51:45.219Z,1348152705.219 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.029770 psu
2012-09-20T14:51:45.343Z,1348152705.343 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=1
2012-09-20T14:51:45.487Z,1348152705.487 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=4
2012-09-20T14:51:45.523Z,1348152705.523 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.035910 psu
2012-09-20T14:51:45.727Z,1348152705.727 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.013040 psu
2012-09-20T14:51:45.815Z,1348152705.815 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=92
2012-09-20T14:51:45.927Z,1348152705.927 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.025480 psu
2012-09-20T14:51:45.931Z,1348152705.931 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=68
2012-09-20T14:51:46.043Z,1348152706.043 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=12
2012-09-20T14:51:46.135Z,1348152706.135 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.030110 psu
2012-09-20T14:51:46.160Z,1348152706.160 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=4
2012-09-20T14:51:46.339Z,1348152706.339 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.020190 psu
2012-09-20T14:51:46.543Z,1348152706.543 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.012080 psu
2012-09-20T14:51:46.687Z,1348152706.687 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=60
2012-09-20T14:51:46.752Z,1348152706.752 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.035400 psu
2012-09-20T14:51:46.923Z,1348152706.923 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=36
2012-09-20T14:51:46.948Z,1348152706.948 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.001000 psu
2012-09-20T14:51:47.148Z,1348152707.148 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.006730 psu
2012-09-20T14:51:47.164Z,1348152707.164 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=76
2012-09-20T14:51:47.352Z,1348152707.352 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.020160 psu
2012-09-20T14:51:47.399Z,1348152707.399 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=4
2012-09-20T14:51:47.556Z,1348152707.556 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.062500 psu
2012-09-20T14:51:47.760Z,1348152707.760 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.020040 psu
2012-09-20T14:51:47.964Z,1348152707.964 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.065510 psu
2012-09-20T14:51:48.172Z,1348152708.172 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.018870 psu
2012-09-20T14:51:48.316Z,1348152708.316 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=61
2012-09-20T14:51:48.368Z,1348152708.368 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.007400 psu
2012-09-20T14:51:48.571Z,1348152708.571 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.011750 psu
2012-09-20T14:51:48.777Z,1348152708.777 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.058000 psu
2012-09-20T14:51:48.787Z,1348152708.787 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=39
2012-09-20T14:51:48.979Z,1348152708.979 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.019490 psu
2012-09-20T14:51:49.183Z,1348152709.183 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.035170 psu
2012-09-20T14:51:49.259Z,1348152709.259 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=15
2012-09-20T14:51:49.387Z,1348152709.387 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.015450 psu
2012-09-20T14:51:49.595Z,1348152709.595 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.071310 psu
2012-09-20T14:51:49.740Z,1348152709.740 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=4
2012-09-20T14:51:49.799Z,1348152709.799 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.021720 psu
2012-09-20T14:51:50.003Z,1348152710.003 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.027460 psu
2012-09-20T14:51:50.207Z,1348152710.207 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.033210 psu
2012-09-20T14:51:50.411Z,1348152710.411 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.029700 psu
2012-09-20T14:51:50.615Z,1348152710.615 [DVL_micro](DEBUG): NQ1
2012-09-20T14:51:50.640Z,1348152710.640 [DVL_micro](DEBUG): ADCP
2012-09-20T14:51:50.715Z,1348152710.716 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.032490 psu
2012-09-20T14:51:50.923Z,1348152710.923 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.051470 psu
2012-09-20T14:51:51.127Z,1348152711.127 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.024400 psu
2012-09-20T14:51:51.331Z,1348152711.331 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.030100 psu
2012-09-20T14:51:51.473Z,1348152711.473 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=19
2012-09-20T14:51:51.536Z,1348152711.536 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.014390 psu
2012-09-20T14:51:51.740Z,1348152711.740 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.057800 psu
2012-09-20T14:51:51.943Z,1348152711.943 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.017420 psu
2012-09-20T14:51:52.152Z,1348152712.152 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.086820 psu
2012-09-20T14:51:52.311Z,1348152712.311 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=27
2012-09-20T14:51:52.356Z,1348152712.355 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.036280 psu
2012-09-20T14:51:52.559Z,1348152712.559 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.023480 psu
2012-09-20T14:51:52.764Z,1348152712.764 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.020980 psu
2012-09-20T14:51:52.967Z,1348152712.967 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.033940 psu
2012-09-20T14:51:53.148Z,1348152713.148 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=35
2012-09-20T14:51:53.175Z,1348152713.175 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.013740 psu
2012-09-20T14:51:53.379Z,1348152713.379 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.022560 psu
2012-09-20T14:51:53.583Z,1348152713.583 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.044700 psu
2012-09-20T14:51:53.743Z,1348152713.743 [Turbulence_NPS](ERROR): No CTD communication! Re-initializing
2012-09-20T14:51:53.743Z,1348152713.743 [Turbulence_NPS] Communications Fault, FailCount= 1
2012-09-20T14:51:53.743Z,1348152713.743 [Turbulence_NPS](ERROR): Communications Fault
2012-09-20T14:51:53.745Z,1348152713.745 [Turbulence_NPS](INFO): Powering down
2012-09-20T14:51:53.787Z,1348152713.787 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.029420 psu
2012-09-20T14:51:53.879Z,1348152713.879 [CBIT](ERROR): Communications Fault in component: Turbulence_NPS
2012-09-20T14:51:53.879Z,1348152713.879 [CBIT](INFO): Clearing failed state for component Turbulence_NPS
2012-09-20T14:51:53.879Z,1348152713.879 [Turbulence_NPS] No Fault, FailCount= 1
2012-09-20T14:51:53.992Z,1348152713.992 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.058420 psu
2012-09-20T14:51:53.994Z,1348152713.994 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=4
2012-09-20T14:51:54.128Z,1348152714.128 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=104
2012-09-20T14:51:54.155Z,1348152714.155 [Turbulence_NPS](DEBUG): Initializing Turbulence_NPS.
2012-09-20T14:51:54.176Z,1348152714.175 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=28
2012-09-20T14:51:54.199Z,1348152714.199 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.053880 psu
2012-09-20T14:51:54.228Z,1348152714.227 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=16
2012-09-20T14:51:54.283Z,1348152714.283 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2012-09-20T14:51:54.403Z,1348152714.403 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.042830 psu
2012-09-20T14:51:54.565Z,1348152714.565 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=56
2012-09-20T14:51:54.607Z,1348152714.607 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.022480 psu
2012-09-20T14:51:54.673Z,1348152714.672 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=92
2012-09-20T14:51:54.767Z,1348152714.767 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=32
2012-09-20T14:51:54.871Z,1348152714.871 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2012-09-20T14:51:54.911Z,1348152714.911 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.013090 psu
2012-09-20T14:51:55.007Z,1348152715.007 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=40
2012-09-20T14:51:55.067Z,1348152715.067 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=92
2012-09-20T14:51:55.115Z,1348152715.115 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.018120 psu
2012-09-20T14:51:55.121Z,1348152715.121 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=80
2012-09-20T14:51:55.167Z,1348152715.167 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2012-09-20T14:51:55.319Z,1348152715.319 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.017650 psu
2012-09-20T14:51:55.451Z,1348152715.451 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=56
2012-09-20T14:51:55.523Z,1348152715.523 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.055710 psu
2012-09-20T14:51:55.551Z,1348152715.551 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=28
2012-09-20T14:51:55.651Z,1348152715.651 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=1
2012-09-20T14:51:55.724Z,1348152715.724 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.007130 psu
2012-09-20T14:51:55.761Z,1348152715.761 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2012-09-20T14:51:55.928Z,1348152715.928 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.011030 psu
2012-09-20T14:51:56.110Z,1348152716.110 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=56
2012-09-20T14:51:56.132Z,1348152716.132 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.041630 psu
2012-09-20T14:51:56.252Z,1348152716.252 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=28
2012-09-20T14:51:56.340Z,1348152716.339 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.037950 psu
2012-09-20T14:51:56.399Z,1348152716.399 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=64
2012-09-20T14:51:56.540Z,1348152716.540 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=4
2012-09-20T14:51:56.543Z,1348152716.543 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.029040 psu
2012-09-20T14:51:56.740Z,1348152716.740 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.005580 psu
2012-09-20T14:51:56.861Z,1348152716.861 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=28
2012-09-20T14:51:56.947Z,1348152716.947 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.015250 psu
2012-09-20T14:51:56.979Z,1348152716.979 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=37
2012-09-20T14:51:57.095Z,1348152717.095 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=45
2012-09-20T14:51:57.152Z,1348152717.151 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.034720 psu
2012-09-20T14:51:57.208Z,1348152717.208 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=4
2012-09-20T14:51:57.355Z,1348152717.355 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.063600 psu
2012-09-20T14:51:57.559Z,1348152717.559 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.014580 psu
2012-09-20T14:51:57.736Z,1348152717.736 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=28
2012-09-20T14:51:57.763Z,1348152717.763 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.027380 psu
2012-09-20T14:51:57.867Z,1348152717.867 [DVL_micro](DEBUG): RSSI read bytes: 508 of 2712, #buffered=0
2012-09-20T14:51:57.964Z,1348152717.964 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.000090 psu
2012-09-20T14:51:57.975Z,1348152717.975 [DVL_micro](DEBUG): RSSI read bytes: 2204 of 2204, #buffered=68
2012-09-20T14:51:58.163Z,1348152718.163 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.007690 psu
2012-09-20T14:51:58.207Z,1348152718.207 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=12
2012-09-20T14:51:58.367Z,1348152718.367 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.014130 psu
2012-09-20T14:51:58.444Z,1348152718.444 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=4
2012-09-20T14:51:58.571Z,1348152718.571 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.034910 psu
2012-09-20T14:51:58.783Z,1348152718.783 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.024480 psu
2012-09-20T14:51:58.983Z,1348152718.983 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.024270 psu
2012-09-20T14:51:59.187Z,1348152719.187 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.033330 psu
2012-09-20T14:51:59.363Z,1348152719.363 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=28
2012-09-20T14:51:59.391Z,1348152719.391 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.035240 psu
2012-09-20T14:51:59.591Z,1348152719.592 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.009030 psu
2012-09-20T14:51:59.795Z,1348152719.795 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.018290 psu
2012-09-20T14:51:59.836Z,1348152719.836 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=5
2012-09-20T14:51:59.999Z,1348152720.000 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.013780 psu
2012-09-20T14:52:00.301Z,1348152720.300 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.032820 psu
2012-09-20T14:52:00.311Z,1348152720.311 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=13
2012-09-20T14:52:00.507Z,1348152720.507 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.027620 psu
2012-09-20T14:52:00.711Z,1348152720.711 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.031460 psu
2012-09-20T14:52:00.803Z,1348152720.803 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=4
2012-09-20T14:52:00.916Z,1348152720.916 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.030130 psu
2012-09-20T14:52:01.120Z,1348152721.120 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.035800 psu
2012-09-20T14:52:01.327Z,1348152721.328 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.064870 psu
2012-09-20T14:52:01.531Z,1348152721.532 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.029230 psu
2012-09-20T14:52:01.664Z,1348152721.664 [DVL_micro](DEBUG): NQ1
2012-09-20T14:52:01.696Z,1348152721.696 [DVL_micro](DEBUG): ADCP
2012-09-20T14:52:01.735Z,1348152721.736 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.039210 psu
2012-09-20T14:52:01.939Z,1348152721.939 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.038790 psu
2012-09-20T14:52:02.143Z,1348152722.143 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.022150 psu
2012-09-20T14:52:02.351Z,1348152722.351 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.036100 psu
2012-09-20T14:52:02.525Z,1348152722.524 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=15
2012-09-20T14:52:02.567Z,1348152722.567 [CTD_NeilBrown](ERROR): Bad response:   0.05
2012-09-20T14:52:02.759Z,1348152722.759 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.031180 psu
2012-09-20T14:52:02.963Z,1348152722.963 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.045710 psu
2012-09-20T14:52:03.167Z,1348152723.167 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.021070 psu
2012-09-20T14:52:03.359Z,1348152723.359 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=23
2012-09-20T14:52:03.371Z,1348152723.371 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.022630 psu
2012-09-20T14:52:03.600Z,1348152723.600 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.031230 psu
2012-09-20T14:52:03.783Z,1348152723.783 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.030310 psu
2012-09-20T14:52:04.004Z,1348152724.004 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.034370 psu
2012-09-20T14:52:04.191Z,1348152724.191 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.044670 psu
2012-09-20T14:52:04.255Z,1348152724.255 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=671
2012-09-20T14:52:04.491Z,1348152724.491 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.007520 psu
2012-09-20T14:52:04.698Z,1348152724.698 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.021310 psu
2012-09-20T14:52:04.904Z,1348152724.904 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.019450 psu
2012-09-20T14:52:05.037Z,1348152725.037 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=4
2012-09-20T14:52:05.108Z,1348152725.108 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.020690 psu
2012-09-20T14:52:05.179Z,1348152725.179 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=104
2012-09-20T14:52:05.227Z,1348152725.227 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=28
2012-09-20T14:52:05.283Z,1348152725.283 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=48
2012-09-20T14:52:05.304Z,1348152725.304 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000580 psu
2012-09-20T14:52:05.339Z,1348152725.339 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2012-09-20T14:52:05.508Z,1348152725.508 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.015910 psu
2012-09-20T14:52:05.612Z,1348152725.612 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=24
2012-09-20T14:52:05.716Z,1348152725.716 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.048160 psu
2012-09-20T14:52:05.720Z,1348152725.720 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=60
2012-09-20T14:52:05.837Z,1348152725.837 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=224
2012-09-20T14:52:05.919Z,1348152725.919 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.023950 psu
2012-09-20T14:52:05.923Z,1348152725.923 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2012-09-20T14:52:06.064Z,1348152726.064 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=104
2012-09-20T14:52:06.112Z,1348152726.112 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=28
2012-09-20T14:52:06.124Z,1348152726.124 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.027350 psu
2012-09-20T14:52:06.167Z,1348152726.167 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=48
2012-09-20T14:52:06.224Z,1348152726.224 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2012-09-20T14:52:06.328Z,1348152726.328 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.030160 psu
2012-09-20T14:52:06.500Z,1348152726.500 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=24
2012-09-20T14:52:06.532Z,1348152726.532 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.050560 psu
2012-09-20T14:52:06.607Z,1348152726.607 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=28
2012-09-20T14:52:06.728Z,1348152726.728 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=288
2012-09-20T14:52:06.739Z,1348152726.739 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.079020 psu
2012-09-20T14:52:06.808Z,1348152726.807 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2012-09-20T14:52:06.944Z,1348152726.944 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.035630 psu
2012-09-20T14:52:07.147Z,1348152727.147 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.028590 psu
2012-09-20T14:52:07.155Z,1348152727.155 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=24
2012-09-20T14:52:07.304Z,1348152727.304 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=60
2012-09-20T14:52:07.357Z,1348152727.357 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.037260 psu
2012-09-20T14:52:07.443Z,1348152727.443 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=0
2012-09-20T14:52:07.556Z,1348152727.556 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.013630 psu
2012-09-20T14:52:07.628Z,1348152727.628 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=4
2012-09-20T14:52:07.759Z,1348152727.759 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.016270 psu
2012-09-20T14:52:07.913Z,1348152727.913 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=28
2012-09-20T14:52:07.967Z,1348152727.967 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.023490 psu
2012-09-20T14:52:08.033Z,1348152728.033 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=68
2012-09-20T14:52:08.144Z,1348152728.144 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=12
2012-09-20T14:52:08.171Z,1348152728.171 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.013240 psu
2012-09-20T14:52:08.259Z,1348152728.259 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=4
2012-09-20T14:52:08.375Z,1348152728.375 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.026320 psu
2012-09-20T14:52:08.575Z,1348152728.575 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.003820 psu
2012-09-20T14:52:08.779Z,1348152728.779 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.020790 psu
2012-09-20T14:52:08.791Z,1348152728.791 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=93
2012-09-20T14:52:08.983Z,1348152728.983 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.033950 psu
2012-09-20T14:52:09.020Z,1348152729.020 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=5
2012-09-20T14:52:09.167Z,1348152729.167 [Turbulence_NPS](ERROR): No CTD communication! Re-initializing
2012-09-20T14:52:09.167Z,1348152729.167 [Turbulence_NPS] Communications Fault, FailCount= 2
2012-09-20T14:52:09.167Z,1348152729.167 [Turbulence_NPS](ERROR): Communications Fault
2012-09-20T14:52:09.168Z,1348152729.168 [Turbulence_NPS](INFO): Powering down
2012-09-20T14:52:09.200Z,1348152729.200 [CBIT](ERROR): Communications Fault in component: Turbulence_NPS
2012-09-20T14:52:09.200Z,1348152729.201 [CBIT](INFO): Clearing failed state for component Turbulence_NPS
2012-09-20T14:52:09.201Z,1348152729.201 [Turbulence_NPS] No Fault, FailCount= 2
2012-09-20T14:52:09.264Z,1348152729.264 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=77
2012-09-20T14:52:09.288Z,1348152729.288 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.029770 psu
2012-09-20T14:52:09.496Z,1348152729.496 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.037610 psu
2012-09-20T14:52:09.500Z,1348152729.500 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=4
2012-09-20T14:52:09.571Z,1348152729.571 [Turbulence_NPS](DEBUG): Initializing Turbulence_NPS.
2012-09-20T14:52:09.699Z,1348152729.699 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.049790 psu
2012-09-20T14:52:09.904Z,1348152729.904 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.032890 psu
2012-09-20T14:52:10.108Z,1348152730.108 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.076130 psu
2012-09-20T14:52:10.312Z,1348152730.312 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.015100 psu
2012-09-20T14:52:10.421Z,1348152730.421 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=61
2012-09-20T14:52:10.519Z,1348152730.519 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.019680 psu
2012-09-20T14:52:10.723Z,1348152730.723 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.030310 psu
2012-09-20T14:52:10.893Z,1348152730.893 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=69
2012-09-20T14:52:10.927Z,1348152730.927 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.039470 psu
2012-09-20T14:52:11.131Z,1348152731.131 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.034710 psu
2012-09-20T14:52:11.336Z,1348152731.336 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.025550 psu
2012-09-20T14:52:11.363Z,1348152731.363 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=13
2012-09-20T14:52:11.543Z,1348152731.543 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.027910 psu
2012-09-20T14:52:11.749Z,1348152731.750 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.014710 psu
2012-09-20T14:52:11.839Z,1348152731.839 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=4
2012-09-20T14:52:11.951Z,1348152731.951 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.034860 psu
2012-09-20T14:52:12.155Z,1348152732.155 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.035430 psu
2012-09-20T14:52:12.359Z,1348152732.359 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.033160 psu
2012-09-20T14:52:12.563Z,1348152732.563 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.049930 psu
2012-09-20T14:52:12.723Z,1348152732.723 [DVL_micro](DEBUG): NQ1
2012-09-20T14:52:12.753Z,1348152732.753 [DVL_micro](DEBUG): ADCP
2012-09-20T14:52:12.771Z,1348152732.771 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.028510 psu
2012-09-20T14:52:12.975Z,1348152732.975 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.034640 psu
2012-09-20T14:52:13.179Z,1348152733.179 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.019400 psu
2012-09-20T14:52:13.479Z,1348152733.479 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.003450 psu
2012-09-20T14:52:13.588Z,1348152733.588 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=79
2012-09-20T14:52:13.684Z,1348152733.684 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.022680 psu
2012-09-20T14:52:13.888Z,1348152733.888 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.046250 psu
2012-09-20T14:52:14.092Z,1348152734.092 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.034980 psu
2012-09-20T14:52:14.235Z,1348152734.235 [DVL_micro](DEBUG): RSSI read bytes: 6799 of 9592, #buffered=0
2012-09-20T14:52:14.296Z,1348152734.296 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.024470 psu
2012-09-20T14:52:14.442Z,1348152734.442 [DVL_micro](DEBUG): RSSI read bytes: 2793 of 2793, #buffered=248
2012-09-20T14:52:14.504Z,1348152734.504 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.072800 psu
2012-09-20T14:52:14.704Z,1348152734.704 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.001940 psu
2012-09-20T14:52:14.908Z,1348152734.908 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.019630 psu
2012-09-20T14:52:15.104Z,1348152735.104 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.009680 psu
2012-09-20T14:52:15.255Z,1348152735.255 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=2
2012-09-20T14:52:15.313Z,1348152735.313 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.020310 psu
2012-09-20T14:52:15.514Z,1348152735.514 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.010750 psu
2012-09-20T14:52:15.719Z,1348152735.719 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.030130 psu
2012-09-20T14:52:15.919Z,1348152735.919 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.008840 psu
2012-09-20T14:52:16.096Z,1348152736.096 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=4
2012-09-20T14:52:16.123Z,1348152736.123 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.015130 psu
2012-09-20T14:52:16.255Z,1348152736.256 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=296
2012-09-20T14:52:16.292Z,1348152736.292 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=92
2012-09-20T14:52:16.327Z,1348152736.327 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.024030 psu
2012-09-20T14:52:16.339Z,1348152736.339 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=16
2012-09-20T14:52:16.396Z,1348152736.396 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2012-09-20T14:52:16.531Z,1348152736.531 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.034190 psu
2012-09-20T14:52:16.680Z,1348152736.680 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=120
2012-09-20T14:52:16.731Z,1348152736.731 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.008870 psu
2012-09-20T14:52:16.777Z,1348152736.777 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=28
2012-09-20T14:52:16.876Z,1348152736.876 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=0
2012-09-20T14:52:16.935Z,1348152736.935 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.030080 psu
2012-09-20T14:52:16.980Z,1348152736.980 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2012-09-20T14:52:17.132Z,1348152737.132 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=200
2012-09-20T14:52:17.140Z,1348152737.139 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.031600 psu
2012-09-20T14:52:17.171Z,1348152737.171 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=28
2012-09-20T14:52:17.227Z,1348152737.227 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=48
2012-09-20T14:52:17.280Z,1348152737.280 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2012-09-20T14:52:17.352Z,1348152737.352 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.019870 psu
2012-09-20T14:52:17.573Z,1348152737.573 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.036110 psu
2012-09-20T14:52:17.588Z,1348152737.588 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=344
2012-09-20T14:52:17.668Z,1348152737.668 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=92
2012-09-20T14:52:17.755Z,1348152737.755 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.021330 psu
2012-09-20T14:52:17.784Z,1348152737.784 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=225
2012-09-20T14:52:17.872Z,1348152737.872 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2012-09-20T14:52:17.952Z,1348152737.953 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.003520 psu
2012-09-20T14:52:18.155Z,1348152738.155 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.003010 psu
2012-09-20T14:52:18.219Z,1348152738.219 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=57
2012-09-20T14:52:18.359Z,1348152738.359 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.011730 psu
2012-09-20T14:52:18.363Z,1348152738.363 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=61
2012-09-20T14:52:18.504Z,1348152738.504 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=1
2012-09-20T14:52:18.563Z,1348152738.563 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.013980 psu
2012-09-20T14:52:18.655Z,1348152738.655 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=4
2012-09-20T14:52:18.767Z,1348152738.767 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.033500 psu
2012-09-20T14:52:18.967Z,1348152738.967 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.005430 psu
2012-09-20T14:52:18.981Z,1348152738.981 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=60
2012-09-20T14:52:19.087Z,1348152739.088 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=36
2012-09-20T14:52:19.172Z,1348152739.172 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.021400 psu
2012-09-20T14:52:19.205Z,1348152739.205 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=12
2012-09-20T14:52:19.323Z,1348152739.323 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=4
2012-09-20T14:52:19.472Z,1348152739.472 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.049400 psu
2012-09-20T14:52:19.680Z,1348152739.680 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.010780 psu
2012-09-20T14:52:19.843Z,1348152739.843 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=28
2012-09-20T14:52:19.883Z,1348152739.883 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.040580 psu
2012-09-20T14:52:20.080Z,1348152740.080 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=4
2012-09-20T14:52:20.089Z,1348152740.089 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.045370 psu
2012-09-20T14:52:20.292Z,1348152740.292 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.028300 psu
2012-09-20T14:52:20.319Z,1348152740.319 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=44
2012-09-20T14:52:20.495Z,1348152740.495 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.076680 psu
2012-09-20T14:52:20.552Z,1348152740.552 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=4
2012-09-20T14:52:20.703Z,1348152740.703 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.041600 psu
2012-09-20T14:52:20.908Z,1348152740.908 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.019480 psu
2012-09-20T14:52:21.111Z,1348152741.111 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.029440 psu
2012-09-20T14:52:21.315Z,1348152741.315 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.014640 psu
2012-09-20T14:52:21.485Z,1348152741.485 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=124
2012-09-20T14:52:21.520Z,1348152741.520 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.010670 psu
2012-09-20T14:52:21.723Z,1348152741.723 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.023600 psu
2012-09-20T14:52:21.931Z,1348152741.931 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.042880 psu
2012-09-20T14:52:21.947Z,1348152741.947 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=5
2012-09-20T14:52:22.135Z,1348152742.135 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.025400 psu
2012-09-20T14:52:22.339Z,1348152742.339 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.048590 psu
2012-09-20T14:52:22.427Z,1348152742.427 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=77
2012-09-20T14:52:22.544Z,1348152742.543 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.025000 psu
2012-09-20T14:52:22.750Z,1348152742.750 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.025310 psu
2012-09-20T14:52:22.897Z,1348152742.897 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=4
2012-09-20T14:52:22.952Z,1348152742.952 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.079910 psu
2012-09-20T14:52:23.160Z,1348152743.160 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.028220 psu
2012-09-20T14:52:23.364Z,1348152743.364 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.044450 psu
2012-09-20T14:52:23.668Z,1348152743.668 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.011200 psu
2012-09-20T14:52:23.779Z,1348152743.779 [DVL_micro](DEBUG): NQ1
2012-09-20T14:52:23.805Z,1348152743.805 [DVL_micro](DEBUG): ADCP
2012-09-20T14:52:23.872Z,1348152743.872 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.082110 psu
2012-09-20T14:52:24.076Z,1348152744.076 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.019060 psu
2012-09-20T14:52:24.276Z,1348152744.276 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.009100 psu
2012-09-20T14:52:24.480Z,1348152744.480 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.043100 psu
2012-09-20T14:52:24.635Z,1348152744.635 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=13
2012-09-20T14:52:24.659Z,1348152744.659 [Turbulence_NPS](ERROR): No CTD communication! Re-initializing
2012-09-20T14:52:24.659Z,1348152744.659 [Turbulence_NPS] Communications Fault, FailCount= 3
2012-09-20T14:52:24.659Z,1348152744.659 [Turbulence_NPS](ERROR): Communications Fault
2012-09-20T14:52:24.661Z,1348152744.661 [Turbulence_NPS](INFO): Powering down
2012-09-20T14:52:24.684Z,1348152744.684 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.020520 psu
2012-09-20T14:52:24.845Z,1348152744.845 [CBIT](ERROR): Communications Fault in component: Turbulence_NPS
2012-09-20T14:52:24.845Z,1348152744.845 [CBIT](FAULT): Communications Fault in component: Turbulence_NPS
2012-09-20T14:52:24.891Z,1348152744.891 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.033780 psu
2012-09-20T14:52:25.091Z,1348152745.091 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.003360 psu
2012-09-20T14:52:25.295Z,1348152745.295 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.024170 psu
2012-09-20T14:52:25.475Z,1348152745.476 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=21
2012-09-20T14:52:25.499Z,1348152745.499 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.036690 psu
2012-09-20T14:52:25.703Z,1348152745.703 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.018520 psu
2012-09-20T14:52:25.903Z,1348152745.903 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.008780 psu
2012-09-20T14:52:26.107Z,1348152746.107 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.023180 psu
2012-09-20T14:52:26.311Z,1348152746.311 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.039690 psu
2012-09-20T14:52:26.320Z,1348152746.320 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=93
2012-09-20T14:52:26.519Z,1348152746.519 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.024710 psu
2012-09-20T14:52:26.715Z,1348152746.715 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.009390 psu
2012-09-20T14:52:26.919Z,1348152746.919 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.013530 psu
2012-09-20T14:52:27.127Z,1348152747.127 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.036280 psu
2012-09-20T14:52:27.152Z,1348152747.152 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=4
2012-09-20T14:52:27.297Z,1348152747.297 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=136
2012-09-20T14:52:27.331Z,1348152747.331 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.034250 psu
2012-09-20T14:52:27.339Z,1348152747.339 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=28
2012-09-20T14:52:27.395Z,1348152747.395 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=48
2012-09-20T14:52:27.487Z,1348152747.487 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2012-09-20T14:52:27.535Z,1348152747.535 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.044100 psu
2012-09-20T14:52:27.731Z,1348152747.731 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=88
2012-09-20T14:52:27.739Z,1348152747.739 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.034440 psu
2012-09-20T14:52:27.843Z,1348152747.843 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=189
2012-09-20T14:52:27.933Z,1348152747.933 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=1
2012-09-20T14:52:27.944Z,1348152747.944 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.020740 psu
2012-09-20T14:52:28.047Z,1348152748.047 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2012-09-20T14:52:28.152Z,1348152748.151 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.047660 psu
2012-09-20T14:52:28.171Z,1348152748.171 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=8
2012-09-20T14:52:28.235Z,1348152748.235 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=124
2012-09-20T14:52:28.285Z,1348152748.285 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=48
2012-09-20T14:52:28.343Z,1348152748.343 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2012-09-20T14:52:28.356Z,1348152748.356 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.016850 psu
2012-09-20T14:52:28.560Z,1348152748.560 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.040650 psu
2012-09-20T14:52:28.615Z,1348152748.615 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=24
2012-09-20T14:52:28.727Z,1348152748.727 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=156
2012-09-20T14:52:28.827Z,1348152748.827 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=96
2012-09-20T14:52:28.860Z,1348152748.860 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.071380 psu
2012-09-20T14:52:28.948Z,1348152748.948 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2012-09-20T14:52:29.063Z,1348152749.063 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.015660 psu
2012-09-20T14:52:29.268Z,1348152749.268 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.022100 psu
2012-09-20T14:52:29.272Z,1348152749.272 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=24
2012-09-20T14:52:29.423Z,1348152749.423 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=92
2012-09-20T14:52:29.476Z,1348152749.476 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.025450 psu
2012-09-20T14:52:29.567Z,1348152749.568 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=96
2012-09-20T14:52:29.679Z,1348152749.679 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.038880 psu
2012-09-20T14:52:29.703Z,1348152749.703 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=4
2012-09-20T14:52:29.881Z,1348152749.881 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.024860 psu
2012-09-20T14:52:30.027Z,1348152750.027 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=28
2012-09-20T14:52:30.086Z,1348152750.086 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.004160 psu
2012-09-20T14:52:30.148Z,1348152750.148 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=68
2012-09-20T14:52:30.260Z,1348152750.260 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=12
2012-09-20T14:52:30.287Z,1348152750.287 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.026120 psu
2012-09-20T14:52:30.377Z,1348152750.377 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=4
2012-09-20T14:52:30.491Z,1348152750.491 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.029770 psu
2012-09-20T14:52:30.695Z,1348152750.695 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.034390 psu
2012-09-20T14:52:30.903Z,1348152750.903 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.020330 psu
2012-09-20T14:52:30.911Z,1348152750.911 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=156
2012-09-20T14:52:31.107Z,1348152751.107 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.034510 psu
2012-09-20T14:52:31.140Z,1348152751.140 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=68
2012-09-20T14:52:31.315Z,1348152751.315 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.039450 psu
2012-09-20T14:52:31.379Z,1348152751.379 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=108
2012-09-20T14:52:31.515Z,1348152751.515 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.019290 psu
2012-09-20T14:52:31.627Z,1348152751.627 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=4
2012-09-20T14:52:31.719Z,1348152751.719 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.035910 psu
2012-09-20T14:52:31.924Z,1348152751.924 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.029000 psu
2012-09-20T14:52:32.127Z,1348152752.127 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.013390 psu
2012-09-20T14:52:32.335Z,1348152752.335 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.016320 psu
2012-09-20T14:52:32.540Z,1348152752.540 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.034840 psu
2012-09-20T14:52:32.551Z,1348152752.551 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=253
2012-09-20T14:52:32.744Z,1348152752.744 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.034050 psu
2012-09-20T14:52:32.948Z,1348152752.948 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.040980 psu
2012-09-20T14:52:33.003Z,1348152753.003 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=5
2012-09-20T14:52:33.252Z,1348152753.252 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.014220 psu
2012-09-20T14:52:33.456Z,1348152753.456 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.035490 psu
2012-09-20T14:52:33.483Z,1348152753.483 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=77
2012-09-20T14:52:33.656Z,1348152753.656 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.055790 psu
2012-09-20T14:52:33.863Z,1348152753.863 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.024440 psu
2012-09-20T14:52:33.956Z,1348152753.955 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=4
2012-09-20T14:52:34.067Z,1348152754.067 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.018110 psu
2012-09-20T14:52:34.270Z,1348152754.270 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.024350 psu
2012-09-20T14:52:34.471Z,1348152754.471 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.003540 psu
2012-09-20T14:52:34.675Z,1348152754.675 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.022590 psu
2012-09-20T14:52:34.836Z,1348152754.836 [DVL_micro](DEBUG): NQ1
2012-09-20T14:52:34.865Z,1348152754.865 [DVL_micro](DEBUG): ADCP
2012-09-20T14:52:34.879Z,1348152754.879 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.028910 psu
2012-09-20T14:52:35.079Z,1348152755.079 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.000470 psu
2012-09-20T14:52:35.283Z,1348152755.283 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.019060 psu
2012-09-20T14:52:35.488Z,1348152755.488 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.017110 psu
2012-09-20T14:52:35.695Z,1348152755.695 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.010850 psu
2012-09-20T14:52:35.697Z,1348152755.697 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=49
2012-09-20T14:52:35.899Z,1348152755.899 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.037800 psu
2012-09-20T14:52:36.103Z,1348152756.103 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.023810 psu
2012-09-20T14:52:36.307Z,1348152756.307 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.028370 psu
2012-09-20T14:52:36.511Z,1348152756.511 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.048090 psu
2012-09-20T14:52:36.539Z,1348152756.539 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=121
2012-09-20T14:52:36.723Z,1348152756.723 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.018290 psu
2012-09-20T14:52:36.915Z,1348152756.915 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.006500 psu
2012-09-20T14:52:37.123Z,1348152757.123 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.065480 psu
2012-09-20T14:52:37.328Z,1348152757.328 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.022770 psu
2012-09-20T14:52:37.371Z,1348152757.371 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=66
2012-09-20T14:52:37.531Z,1348152757.532 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.024210 psu
2012-09-20T14:52:37.735Z,1348152757.735 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.017480 psu
2012-09-20T14:52:37.939Z,1348152757.939 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.043060 psu
2012-09-20T14:52:38.144Z,1348152758.144 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.014680 psu
2012-09-20T14:52:38.211Z,1348152758.211 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=4
2012-09-20T14:52:38.356Z,1348152758.356 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=168
2012-09-20T14:52:38.403Z,1348152758.403 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=92
2012-09-20T14:52:38.444Z,1348152758.444 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.021600 psu
2012-09-20T14:52:38.452Z,1348152758.452 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=48
2012-09-20T14:52:38.503Z,1348152758.503 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2012-09-20T14:52:38.655Z,1348152758.655 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.021210 psu
2012-09-20T14:52:38.783Z,1348152758.783 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=24
2012-09-20T14:52:38.857Z,1348152758.857 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.032100 psu
2012-09-20T14:52:38.895Z,1348152758.895 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=124
2012-09-20T14:52:38.991Z,1348152758.991 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=32
2012-09-20T14:52:39.061Z,1348152759.061 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.051260 psu
2012-09-20T14:52:39.099Z,1348152759.099 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2012-09-20T14:52:39.228Z,1348152759.228 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=8
2012-09-20T14:52:39.263Z,1348152759.263 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.029750 psu
2012-09-20T14:52:39.300Z,1348152759.300 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=220
2012-09-20T14:52:39.335Z,1348152759.335 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=16
2012-09-20T14:52:39.399Z,1348152759.399 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2012-09-20T14:52:39.469Z,1348152759.469 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.028440 psu
2012-09-20T14:52:39.672Z,1348152759.672 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=24
2012-09-20T14:52:39.675Z,1348152759.675 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.027320 psu
2012-09-20T14:52:39.779Z,1348152759.779 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=92
2012-09-20T14:52:39.879Z,1348152759.879 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.037550 psu
2012-09-20T14:52:39.895Z,1348152759.895 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=224
2012-09-20T14:52:39.979Z,1348152759.979 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2012-09-20T14:52:40.083Z,1348152760.083 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.040220 psu
2012-09-20T14:52:40.287Z,1348152760.287 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.077430 psu
2012-09-20T14:52:40.332Z,1348152760.332 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=56
2012-09-20T14:52:40.479Z,1348152760.480 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=92
2012-09-20T14:52:40.491Z,1348152760.491 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.023250 psu
2012-09-20T14:52:40.615Z,1348152760.615 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=0
2012-09-20T14:52:40.699Z,1348152760.699 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.059640 psu
2012-09-20T14:52:40.763Z,1348152760.763 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=4
2012-09-20T14:52:40.903Z,1348152760.903 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.015260 psu
2012-09-20T14:52:41.103Z,1348152761.103 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=252
2012-09-20T14:52:41.107Z,1348152761.107 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.036820 psu
2012-09-20T14:52:41.220Z,1348152761.220 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=260
2012-09-20T14:52:41.311Z,1348152761.311 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.022060 psu
2012-09-20T14:52:41.335Z,1348152761.335 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=236
2012-09-20T14:52:41.431Z,1348152761.431 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=4
2012-09-20T14:52:41.516Z,1348152761.516 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.065720 psu
2012-09-20T14:52:41.728Z,1348152761.728 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.030200 psu
2012-09-20T14:52:41.928Z,1348152761.928 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.011230 psu
2012-09-20T14:52:41.959Z,1348152761.959 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=64
2012-09-20T14:52:42.132Z,1348152762.132 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.023040 psu
2012-09-20T14:52:42.191Z,1348152762.191 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=8
2012-09-20T14:52:42.335Z,1348152762.335 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.036160 psu
2012-09-20T14:52:42.428Z,1348152762.428 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=16
2012-09-20T14:52:42.639Z,1348152762.639 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.039240 psu
2012-09-20T14:52:42.671Z,1348152762.671 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=4
2012-09-20T14:52:42.844Z,1348152762.844 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.028410 psu
2012-09-20T14:52:43.049Z,1348152763.049 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.026610 psu
2012-09-20T14:52:43.251Z,1348152763.251 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.026800 psu
2012-09-20T14:52:43.459Z,1348152763.459 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.035620 psu
2012-09-20T14:52:43.595Z,1348152763.595 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=28
2012-09-20T14:52:43.663Z,1348152763.663 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.032150 psu
2012-09-20T14:52:43.867Z,1348152763.867 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.029440 psu
2012-09-20T14:52:44.063Z,1348152764.063 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=68
2012-09-20T14:52:44.071Z,1348152764.071 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.019230 psu
2012-09-20T14:52:44.275Z,1348152764.275 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.028410 psu
2012-09-20T14:52:44.483Z,1348152764.483 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.034050 psu
2012-09-20T14:52:44.555Z,1348152764.555 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=268
2012-09-20T14:52:44.687Z,1348152764.687 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.016920 psu
2012-09-20T14:52:44.887Z,1348152764.887 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.009680 psu
2012-09-20T14:52:45.019Z,1348152765.019 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=4
2012-09-20T14:52:45.091Z,1348152765.091 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.025150 psu
2012-09-20T14:52:45.295Z,1348152765.295 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.019270 psu
2012-09-20T14:52:45.499Z,1348152765.499 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.012850 psu
2012-09-20T14:52:45.699Z,1348152765.699 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.006780 psu
2012-09-20T14:52:45.887Z,1348152765.887 [DVL_micro](DEBUG): NQ1
2012-09-20T14:52:45.904Z,1348152765.904 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.040620 psu
2012-09-20T14:52:45.936Z,1348152765.936 [DVL_micro](DEBUG): ADCP
2012-09-20T14:52:46.108Z,1348152766.108 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.049970 psu
2012-09-20T14:52:46.308Z,1348152766.308 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000490 psu
2012-09-20T14:52:46.512Z,1348152766.512 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.028190 psu
2012-09-20T14:52:46.716Z,1348152766.716 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.062480 psu
2012-09-20T14:52:46.755Z,1348152766.755 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=110
2012-09-20T14:52:46.924Z,1348152766.924 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.016520 psu
2012-09-20T14:52:47.127Z,1348152767.127 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.038770 psu
2012-09-20T14:52:47.327Z,1348152767.327 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.006430 psu
2012-09-20T14:52:47.531Z,1348152767.532 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.025220 psu
2012-09-20T14:52:47.587Z,1348152767.587 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=55
2012-09-20T14:52:47.832Z,1348152767.832 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.032360 psu
2012-09-20T14:52:48.037Z,1348152768.037 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.066340 psu
2012-09-20T14:52:48.239Z,1348152768.239 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.018580 psu
2012-09-20T14:52:48.424Z,1348152768.424 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=63
2012-09-20T14:52:48.444Z,1348152768.444 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.032130 psu
2012-09-20T14:52:48.651Z,1348152768.651 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.021020 psu
2012-09-20T14:52:48.855Z,1348152768.855 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.020590 psu
2012-09-20T14:52:49.059Z,1348152769.059 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.032410 psu
2012-09-20T14:52:49.263Z,1348152769.263 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.046700 psu
2012-09-20T14:52:49.265Z,1348152769.265 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=4
2012-09-20T14:52:49.405Z,1348152769.405 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=104
2012-09-20T14:52:49.456Z,1348152769.455 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=92
2012-09-20T14:52:49.468Z,1348152769.468 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.021970 psu
2012-09-20T14:52:49.504Z,1348152769.504 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=16
2012-09-20T14:52:49.563Z,1348152769.563 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2012-09-20T14:52:49.672Z,1348152769.672 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.038540 psu
2012-09-20T14:52:49.839Z,1348152769.839 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=56
2012-09-20T14:52:49.879Z,1348152769.879 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.037210 psu
2012-09-20T14:52:49.947Z,1348152769.947 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=92
2012-09-20T14:52:50.043Z,1348152770.043 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=32
2012-09-20T14:52:50.083Z,1348152770.083 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.040590 psu
2012-09-20T14:52:50.151Z,1348152770.151 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2012-09-20T14:52:50.232Z,1348152770.232 [CBIT](INFO): Clearing failed count for component DropWeight
2012-09-20T14:52:50.232Z,1348152770.232 [DropWeight] No Fault, FailCount= 1
2012-09-20T14:52:50.279Z,1348152770.279 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=8
2012-09-20T14:52:50.287Z,1348152770.287 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.017510 psu
2012-09-20T14:52:50.339Z,1348152770.339 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=60
2012-09-20T14:52:50.400Z,1348152770.400 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=112
2012-09-20T14:52:50.447Z,1348152770.447 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2012-09-20T14:52:50.491Z,1348152770.491 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.031670 psu
2012-09-20T14:52:50.696Z,1348152770.696 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.035370 psu
2012-09-20T14:52:50.731Z,1348152770.731 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=120
2012-09-20T14:52:50.831Z,1348152770.831 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=60
2012-09-20T14:52:50.904Z,1348152770.904 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.020620 psu
2012-09-20T14:52:50.931Z,1348152770.931 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=32
2012-09-20T14:52:51.031Z,1348152771.031 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2012-09-20T14:52:51.108Z,1348152771.108 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.027780 psu
2012-09-20T14:52:51.311Z,1348152771.311 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.037020 psu
2012-09-20T14:52:51.387Z,1348152771.387 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=88
2012-09-20T14:52:51.517Z,1348152771.517 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.026930 psu
2012-09-20T14:52:51.539Z,1348152771.539 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=92
2012-09-20T14:52:51.679Z,1348152771.679 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=128
2012-09-20T14:52:51.720Z,1348152771.720 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.030560 psu
2012-09-20T14:52:51.846Z,1348152771.846 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=4
2012-09-20T14:52:52.024Z,1348152772.024 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.013970 psu
2012-09-20T14:52:52.140Z,1348152772.139 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=60
2012-09-20T14:52:52.231Z,1348152772.231 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.013170 psu
2012-09-20T14:52:52.259Z,1348152772.260 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=100
2012-09-20T14:52:52.375Z,1348152772.375 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=76
2012-09-20T14:52:52.435Z,1348152772.435 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.032980 psu
2012-09-20T14:52:52.492Z,1348152772.492 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=4
2012-09-20T14:52:52.642Z,1348152772.642 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.010960 psu
2012-09-20T14:52:52.843Z,1348152772.843 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.049660 psu
2012-09-20T14:52:53.020Z,1348152773.020 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=124
2012-09-20T14:52:53.048Z,1348152773.048 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.026080 psu
2012-09-20T14:52:53.251Z,1348152773.251 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=69
2012-09-20T14:52:53.255Z,1348152773.255 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.045810 psu
2012-09-20T14:52:53.459Z,1348152773.459 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.049760 psu
2012-09-20T14:52:53.491Z,1348152773.491 [CommandLine](IMPORTANT): got command stop
2012-09-20T14:52:53.493Z,1348152773.493 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=109
2012-09-20T14:52:53.663Z,1348152773.663 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.031640 psu
2012-09-20T14:52:53.670Z,1348152773.670 [science_to_67_70] Stopped
2012-09-20T14:52:53.670Z,1348152773.670 [science_to_67_70](INFO): Aggregate::uninitialize science_to_67_70
2012-09-20T14:52:53.670Z,1348152773.670 [science_to_67_70:AltEnvWrapper] Stopped
2012-09-20T14:52:53.674Z,1348152773.674 [science_to_67_70:AltEnvWrapper](INFO): Aggregate::uninitialize science_to_67_70:AltEnvWrapper
2012-09-20T14:52:53.675Z,1348152773.675 [science_to_67_70:AltEnvWrapper:A.AltitudeEnvelope] Stopped
2012-09-20T14:52:53.675Z,1348152773.675 [science_to_67_70:AltEnvWrapper:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2012-09-20T14:52:53.675Z,1348152773.675 [science_to_67_70:AltEnvWrapper:B.Wait] Stopped
2012-09-20T14:52:53.675Z,1348152773.675 [science_to_67_70:AltEnvWrapper:B.Wait](DEBUG): Uninitialize Wait Component.
2012-09-20T14:52:53.675Z,1348152773.675 [science_to_67_70:B.DepthEnvelope] Stopped
2012-09-20T14:52:53.675Z,1348152773.675 [science_to_67_70:B.DepthEnvelope](DEBUG): Uninitialize.
2012-09-20T14:52:53.675Z,1348152773.675 [science_to_67_70:OffshoreWrapper] Stopped
2012-09-20T14:52:53.675Z,1348152773.675 [science_to_67_70:OffshoreWrapper](INFO): Aggregate::uninitialize science_to_67_70:OffshoreWrapper
2012-09-20T14:52:53.675Z,1348152773.675 [science_to_67_70:OffshoreWrapper:A.OffshoreEnvelope] Stopped
2012-09-20T14:52:53.675Z,1348152773.675 [science_to_67_70:OffshoreWrapper:A.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent.
2012-09-20T14:52:53.675Z,1348152773.675 [science_to_67_70:OffshoreWrapper:B.Wait] Stopped
2012-09-20T14:52:53.675Z,1348152773.675 [science_to_67_70:OffshoreWrapper:B.Wait](DEBUG): Uninitialize Wait Component.
2012-09-20T14:52:53.675Z,1348152773.675 [science_to_67_70:Science] Stopped
2012-09-20T14:52:53.676Z,1348152773.676 [science_to_67_70:Science](INFO): Aggregate::uninitialize science_to_67_70:Science
2012-09-20T14:52:53.676Z,1348152773.676 [science_to_67_70:Science:A] Stopped
2012-09-20T14:52:53.676Z,1348152773.676 [science_to_67_70:Science:B] Stopped
2012-09-20T14:52:53.676Z,1348152773.676 [science_to_67_70:Science:C] Stopped
2012-09-20T14:52:53.676Z,1348152773.676 [science_to_67_70:Science:D] Stopped
2012-09-20T14:52:53.676Z,1348152773.676 [science_to_67_70:Science:E] Stopped
2012-09-20T14:52:53.676Z,1348152773.676 [science_to_67_70:Science:F] Stopped
2012-09-20T14:52:53.676Z,1348152773.676 [science_to_67_70:Science:G] Stopped
2012-09-20T14:52:53.676Z,1348152773.676 [science_to_67_70:Science:PeakDetectChl] Stopped
2012-09-20T14:52:53.676Z,1348152773.676 [science_to_67_70:Science:PeakDetectChl](INFO): Aggregate::uninitialize science_to_67_70:Science:PeakDetectChl
2012-09-20T14:52:53.676Z,1348152773.676 [science_to_67_70:Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped
2012-09-20T14:52:53.676Z,1348152773.676 [science_to_67_70:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2012-09-20T14:52:53.676Z,1348152773.676 [science_to_67_70:G.Buoyancy] Stopped
2012-09-20T14:52:53.677Z,1348152773.677 [science_to_67_70:G.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2012-09-20T14:52:53.677Z,1348152773.677 [science_to_67_70:H.SetSpeed] Stopped
2012-09-20T14:52:53.677Z,1348152773.677 [science_to_67_70:H.SetSpeed](DEBUG): Uninitialize.
2012-09-20T14:52:53.677Z,1348152773.677 [science_to_67_70:I.DepthEnvelope] Stopped
2012-09-20T14:52:53.677Z,1348152773.677 [science_to_67_70:I.DepthEnvelope](DEBUG): Uninitialize.
2012-09-20T14:52:53.677Z,1348152773.677 [science_to_67_70:J.YoYo] Stopped
2012-09-20T14:52:53.677Z,1348152773.677 [science_to_67_70:J.YoYo](DEBUG): Uninitialize YoYoComponent.
2012-09-20T14:52:53.677Z,1348152773.677 [science_to_67_70:Wpt.Point] Stopped
2012-09-20T14:52:53.727Z,1348152773.727 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=4
2012-09-20T14:52:53.766Z,1348152773.766 [DVL_micro](INFO): pause:Powering down
2012-09-20T14:52:53.815Z,1348152773.815 [WetLabsBB2FL](INFO): Powering down
2012-09-20T14:52:53.867Z,1348152773.867 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.049510 psu
2012-09-20T14:52:54.139Z,1348152774.139 [MissionManager](IMPORTANT): Started mission Default
2012-09-20T14:52:54.139Z,1348152774.139 [Default] Running Loop=1
2012-09-20T14:52:54.140Z,1348152774.139 [Default](INFO): Aggregate::initialize Default
2012-09-20T14:52:54.140Z,1348152774.140 [Default:D.SetSpeed] Running Loop=1
2012-09-20T14:52:54.140Z,1348152774.140 [Default:D.SetSpeed](DEBUG): Initialize.
2012-09-20T14:52:54.140Z,1348152774.140 [Default:E.GoToSurface] Running Loop=1
2012-09-20T14:52:54.140Z,1348152774.140 [Default:E.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2012-09-20T14:52:54.140Z,1348152774.140 [Default:Iridium] Running Loop=1
2012-09-20T14:52:54.140Z,1348152774.140 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2012-09-20T14:52:54.140Z,1348152774.140 [Default:Iridium:A.SetSpeed] Running Loop=1
2012-09-20T14:52:54.140Z,1348152774.140 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2012-09-20T14:52:54.140Z,1348152774.141 [Default:Iridium:B.GoToSurface] Running Loop=1
2012-09-20T14:52:54.141Z,1348152774.141 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2012-09-20T14:52:54.147Z,1348152774.147 [Default:Iridium:B.GoToSurface] Stopped
2012-09-20T14:52:54.147Z,1348152774.147 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2012-09-20T14:52:54.147Z,1348152774.147 [Default:Iridium:Read_Iridium] Running Loop=1
2012-09-20T14:52:54.147Z,1348152774.147 [Default:GPS] Running Loop=1
2012-09-20T14:52:54.147Z,1348152774.147 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2012-09-20T14:52:54.147Z,1348152774.147 [Default:GPS:A.SetSpeed] Running Loop=1
2012-09-20T14:52:54.147Z,1348152774.148 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2012-09-20T14:52:54.148Z,1348152774.148 [Default:GPS:B.GoToSurface] Running Loop=1
2012-09-20T14:52:54.148Z,1348152774.148 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2012-09-20T14:52:54.148Z,1348152774.148 [Default:GPS:B.GoToSurface] Stopped
2012-09-20T14:52:54.148Z,1348152774.148 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2012-09-20T14:52:54.149Z,1348152774.149 [Default:GPS:Read_GPS] Running Loop=1
2012-09-20T14:52:54.880Z,1348152774.880 [NAL9602](INFO): Powering up
2012-09-20T14:53:05.315Z,1348152785.315 [NAL9602](INFO): NAL9602 initialized
2012-09-20T14:54:54.918Z,1348152894.918 [CBIT](INFO): Clearing failed count for component Turbulence_NPS
2012-09-20T14:54:54.918Z,1348152894.918 [Turbulence_NPS] No Fault, FailCount= 3
2012-09-20T14:54:54.930Z,1348152894.930 [Turbulence_NPS](DEBUG): Initializing Turbulence_NPS.
2012-09-20T14:55:14.767Z,1348152914.767 [BuoyancyServo](FAULT): Overload Error
2012-09-20T14:55:14.768Z,1348152914.768 [BuoyancyServo] Hardware Fault, FailCount= 1
2012-09-20T14:55:14.768Z,1348152914.768 [BuoyancyServo](ERROR): Hardware Fault
2012-09-20T14:55:14.794Z,1348152914.794 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo
2012-09-20T14:55:14.888Z,1348152914.888 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2012-09-20T14:55:14.888Z,1348152914.888 [BuoyancyServo](INFO): Powering down
2012-09-20T14:55:14.892Z,1348152914.892 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2012-09-20T14:55:14.892Z,1348152914.892 [BuoyancyServo] No Fault, FailCount= 1
2012-09-20T14:55:15.685Z,1348152915.685 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2012-09-20T14:55:15.804Z,1348152915.804 [BuoyancyServo](DEBUG): Initialization error opening port: port not yet opened
2012-09-20T14:55:15.804Z,1348152915.804 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2012-09-20T14:56:38.413Z,1348152998.413 [Default:CallIridium] Running Loop=1
2012-09-20T14:56:38.413Z,1348152998.413 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2012-09-20T14:56:38.414Z,1348152998.414 [Default:CallIridium:A] Running Loop=1
2012-09-20T14:56:38.418Z,1348152998.418 [Default:CallIridium:A] Stopped
2012-09-20T14:56:38.419Z,1348152998.418 [Default:CallIridium:B] Running Loop=1
2012-09-20T14:56:38.419Z,1348152998.419 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2012-09-20T14:56:54.547Z,1348153014.547 [CommandLine](IMPORTANT): got command quit
2012-09-20T14:56:55.658Z,1348153015.658 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2012-09-20T14:56:55.658Z,1348153015.658 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2012-09-20T14:56:55.822Z,1348153015.822 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2012-09-20T14:56:55.995Z,1348153015.995 [WetLabsBB2FL](INFO): Powering down
2012-09-20T14:56:56.010Z,1348153016.010 [ComponentRegistry](INFO): Shutting down Turbulence_NPS ThreadHandler
2012-09-20T14:56:56.291Z,1348153016.291 [Turbulence_NPS](INFO): Powering down
2012-09-20T14:56:56.302Z,1348153016.302 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2012-09-20T14:56:56.563Z,1348153016.563 [CTD_NeilBrown](INFO): Powering down
2012-09-20T14:56:56.564Z,1348153016.564 [ComponentRegistry](INFO): Shutting down DVL_micro ThreadHandler
2012-09-20T14:56:56.759Z,1348153016.759 [DVL_micro](INFO): uninitialize:Powering down
2012-09-20T14:56:56.763Z,1348153016.763 [ComponentRegistry](INFO): Shutting down AsyncPiEstimator ThreadHandler
2012-09-20T14:56:57.083Z,1348153017.083 [AsyncPiEstimator](DEBUG): Uninitialize AsyncPiEstimator.
2012-09-20T14:56:57.103Z,1348153017.103 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2012-09-20T14:56:57.105Z,1348153017.105 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2012-09-20T14:56:57.327Z,1348153017.327 [controlThread](DEBUG): Uninitializing ControlThread
2012-09-20T14:56:57.327Z,1348153017.327 [AHRS_sp3003D](INFO): Powering down
2012-09-20T14:56:57.415Z,1348153017.415 [NAL9602](INFO): Powering down
2012-09-20T14:56:57.417Z,1348153017.417 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2012-09-20T14:56:57.417Z,1348153017.417 [NavChart](DEBUG): Uninitialize NavChart Derivation.
2012-09-20T14:56:57.419Z,1348153017.419 [Default] Stopped
2012-09-20T14:56:57.419Z,1348153017.419 [Default](INFO): Aggregate::uninitialize Default
2012-09-20T14:56:57.419Z,1348153017.419 [Default:GPS] Stopped
2012-09-20T14:56:57.419Z,1348153017.419 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2012-09-20T14:56:57.419Z,1348153017.419 [Default:GPS:A.SetSpeed] Stopped
2012-09-20T14:56:57.419Z,1348153017.419 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2012-09-20T14:56:57.419Z,1348153017.419 [Default:GPS:Read_GPS] Stopped
2012-09-20T14:56:57.419Z,1348153017.419 [Default:Iridium] Stopped
2012-09-20T14:56:57.419Z,1348153017.419 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2012-09-20T14:56:57.419Z,1348153017.420 [Default:Iridium:A.SetSpeed] Stopped
2012-09-20T14:56:57.420Z,1348153017.420 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2012-09-20T14:56:57.420Z,1348153017.420 [Default:Iridium:Read_Iridium] Stopped
2012-09-20T14:56:57.420Z,1348153017.420 [Default:CallIridium] Stopped
2012-09-20T14:56:57.420Z,1348153017.420 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2012-09-20T14:56:57.420Z,1348153017.420 [Default:CallIridium:B] Stopped
2012-09-20T14:56:57.420Z,1348153017.420 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2012-09-20T14:56:57.420Z,1348153017.420 [Default:D.SetSpeed] Stopped
2012-09-20T14:56:57.420Z,1348153017.420 [Default:D.SetSpeed](DEBUG): Uninitialize.
2012-09-20T14:56:57.420Z,1348153017.420 [Default:E.GoToSurface] Stopped
2012-09-20T14:56:57.420Z,1348153017.420 [Default:E.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2012-09-20T14:56:57.425Z,1348153017.425 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2012-09-20T14:56:57.425Z,1348153017.425 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2012-09-20T14:56:57.425Z,1348153017.425 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2012-09-20T14:56:57.426Z,1348153017.426 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2012-09-20T14:56:57.426Z,1348153017.426 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2012-09-20T14:56:57.426Z,1348153017.426 [BuoyancyServo](INFO): Powering down
2012-09-20T14:56:57.427Z,1348153017.427 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2012-09-20T14:56:57.427Z,1348153017.427 [ElevatorServo](INFO): Powering down
2012-09-20T14:56:57.428Z,1348153017.428 [MassServo](DEBUG): Uninitialize Mass Servo.
2012-09-20T14:56:57.428Z,1348153017.428 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2012-09-20T14:56:57.428Z,1348153017.428 [RudderServo](INFO): Powering down
2012-09-20T14:56:57.429Z,1348153017.429 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2012-09-20T14:56:57.429Z,1348153017.429 [ThrusterServo](INFO): Powering down
2012-09-20T14:56:57.430Z,1348153017.430 [SBIT](DEBUG): Uninitialize SBIT Component.
2012-09-20T14:56:57.431Z,1348153017.431 [IBIT](DEBUG): Uninitialize IBIT Component.
2012-09-20T14:56:57.431Z,1348153017.431 [CBIT](DEBUG): Uninitialize CBIT Component.