2013-09-16T16:50:50.282Z,1379350250.282 [Supervisor](DEBUG): Initializing supervisor.
2013-09-16T16:50:50.284Z,1379350250.284 [SyncHandler](DEBUG): Created PCaller Thread at 4033B4E0
2013-09-16T16:50:50.285Z,1379350250.285 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2013-09-16T16:50:50.286Z,1379350250.286 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4036B4E0
2013-09-16T16:50:50.289Z,1379350250.289 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2013-09-16T16:50:50.299Z,1379350250.299 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2013-09-16T16:50:50.300Z,1379350250.300 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 4039B4E0
2013-09-16T16:50:50.301Z,1379350250.301 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2013-09-16T16:50:50.302Z,1379350250.302 [logger ThreadHandler](DEBUG): Created PCaller Thread at 403CB4E0
2013-09-16T16:50:50.303Z,1379350250.303 [Supervisor](INFO): Looking for Config files in directory: Config/
2013-09-16T16:50:50.304Z,1379350250.304 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2013-09-16T16:50:50.581Z,1379350250.581 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2013-09-16T16:50:50.582Z,1379350250.582 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2013-09-16T16:50:50.773Z,1379350250.773 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2013-09-16T16:50:50.774Z,1379350250.774 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2013-09-16T16:50:50.859Z,1379350250.859 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2013-09-16T16:50:50.860Z,1379350250.860 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2013-09-16T16:50:50.970Z,1379350250.970 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2013-09-16T16:50:50.971Z,1379350250.971 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2013-09-16T16:50:51.114Z,1379350251.114 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2013-09-16T16:50:51.115Z,1379350251.115 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2013-09-16T16:50:51.351Z,1379350251.351 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2013-09-16T16:50:51.352Z,1379350251.352 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2013-09-16T16:50:51.516Z,1379350251.516 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2013-09-16T16:50:51.516Z,1379350251.516 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2013-09-16T16:50:51.783Z,1379350251.783 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2013-09-16T16:50:51.783Z,1379350251.783 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2013-09-16T16:50:51.898Z,1379350251.898 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2013-09-16T16:50:51.899Z,1379350251.899 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2013-09-16T16:50:52.316Z,1379350252.316 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2013-09-16T16:50:52.316Z,1379350252.316 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2013-09-16T16:50:52.426Z,1379350252.426 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2013-09-16T16:50:52.427Z,1379350252.427 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2013-09-16T16:50:52.513Z,1379350252.513 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2013-09-16T16:50:52.514Z,1379350252.514 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2013-09-16T16:50:52.612Z,1379350252.612 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2013-09-16T16:50:52.738Z,1379350252.738 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2013-09-16T16:50:52.833Z,1379350252.833 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2013-09-16T16:50:52.937Z,1379350252.937 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2013-09-16T16:50:53.033Z,1379350253.033 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2013-09-16T16:50:53.041Z,1379350253.041 [Config/Science](ERROR): Could not parse value: 	
2013-09-16T16:50:53.148Z,1379350253.148 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2013-09-16T16:50:53.244Z,1379350253.244 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2013-09-16T16:50:53.330Z,1379350253.330 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/LOGIN/
2013-09-16T16:50:53.330Z,1379350253.330 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2013-09-16T16:50:53.334Z,1379350253.334 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2013-09-16T16:50:53.490Z,1379350253.490 [InternalSim] Loaded
2013-09-16T16:50:53.491Z,1379350253.491 [ComponentRegistry](DEBUG): SyncComponent "InternalSim" handled in the control thread.
2013-09-16T16:50:53.491Z,1379350253.491 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2013-09-16T16:50:53.492Z,1379350253.492 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2013-09-16T16:50:53.574Z,1379350253.574 [SBIT](DEBUG): Construct Startup Built In Test.
2013-09-16T16:50:53.602Z,1379350253.602 [SBIT] Loaded
2013-09-16T16:50:53.602Z,1379350253.602 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2013-09-16T16:50:53.603Z,1379350253.603 [IBIT](DEBUG): Construct Initiated Built In Test.
2013-09-16T16:50:53.632Z,1379350253.632 [IBIT] Loaded
2013-09-16T16:50:53.632Z,1379350253.632 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2013-09-16T16:50:53.635Z,1379350253.635 [CBIT](DEBUG): Construct CBIT Built In Test.
2013-09-16T16:50:53.746Z,1379350253.746 [CBIT] Loaded
2013-09-16T16:50:53.746Z,1379350253.746 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2013-09-16T16:50:53.747Z,1379350253.747 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2013-09-16T16:50:53.747Z,1379350253.747 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2013-09-16T16:50:53.906Z,1379350253.906 [ElevatorServo] Loaded
2013-09-16T16:50:53.906Z,1379350253.906 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2013-09-16T16:50:53.918Z,1379350253.918 [MassServo] Loaded
2013-09-16T16:50:53.918Z,1379350253.918 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2013-09-16T16:50:53.929Z,1379350253.929 [RudderServo] Loaded
2013-09-16T16:50:53.929Z,1379350253.929 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2013-09-16T16:50:53.940Z,1379350253.940 [ThrusterServo] Loaded
2013-09-16T16:50:53.940Z,1379350253.940 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2013-09-16T16:50:53.940Z,1379350253.940 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2013-09-16T16:50:53.941Z,1379350253.941 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2013-09-16T16:50:53.975Z,1379350253.975 [DepthRateCalculator] Loaded
2013-09-16T16:50:53.975Z,1379350253.975 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2013-09-16T16:50:56.815Z,1379350256.815 [HFRadarModelCalc] Loaded
2013-09-16T16:50:56.815Z,1379350256.815 [ComponentRegistry](DEBUG): SyncComponent "HFRadarModelCalc" handled in the control thread.
2013-09-16T16:50:56.831Z,1379350256.831 [NavChart] Loaded
2013-09-16T16:50:56.831Z,1379350256.831 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2013-09-16T16:50:56.837Z,1379350256.837 [PitchRateCalculator] Loaded
2013-09-16T16:50:56.837Z,1379350256.837 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2013-09-16T16:50:56.847Z,1379350256.847 [SpeedCalculator] Loaded
2013-09-16T16:50:56.848Z,1379350256.848 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2013-09-16T16:50:56.863Z,1379350256.863 [TempGradientCalculator] Loaded
2013-09-16T16:50:56.864Z,1379350256.864 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2013-09-16T16:50:56.869Z,1379350256.869 [YawRateCalculator] Loaded
2013-09-16T16:50:56.869Z,1379350256.869 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2013-09-16T16:50:56.915Z,1379350256.915 [Navigation] Loaded
2013-09-16T16:50:56.915Z,1379350256.915 [ComponentRegistry](DEBUG): SyncComponent "Navigation" handled in the control thread.
2013-09-16T16:50:56.915Z,1379350256.915 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2013-09-16T16:50:56.916Z,1379350256.916 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2013-09-16T16:50:57.144Z,1379350257.144 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2013-09-16T16:50:57.144Z,1379350257.144 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2013-09-16T16:50:57.166Z,1379350257.166 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2013-09-16T16:50:57.167Z,1379350257.167 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2013-09-16T16:50:57.211Z,1379350257.211 [VerticalControl](DEBUG): Construct VerticalControl.
2013-09-16T16:50:57.306Z,1379350257.306 [VerticalControl] Loaded
2013-09-16T16:50:57.306Z,1379350257.306 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2013-09-16T16:50:57.307Z,1379350257.307 [HorizontalControl](DEBUG): Construct HorizontalControl.
2013-09-16T16:50:57.363Z,1379350257.363 [HorizontalControl] Loaded
2013-09-16T16:50:57.363Z,1379350257.363 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2013-09-16T16:50:57.364Z,1379350257.364 [SpeedControl](DEBUG): Construct SpeedControl.
2013-09-16T16:50:57.366Z,1379350257.366 [SpeedControl] Loaded
2013-09-16T16:50:57.366Z,1379350257.366 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2013-09-16T16:50:57.367Z,1379350257.367 [LoopControl](DEBUG): Construct LoopControl.
2013-09-16T16:50:57.367Z,1379350257.367 [LoopControl] Loaded
2013-09-16T16:50:57.367Z,1379350257.367 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2013-09-16T16:50:57.368Z,1379350257.368 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2013-09-16T16:50:57.368Z,1379350257.368 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2013-09-16T16:50:57.374Z,1379350257.374 [AsyncPiEstimator](DEBUG): Construct AsyncPiEstimator.
2013-09-16T16:50:57.379Z,1379350257.379 [AsyncPiEstimator] Loaded
2013-09-16T16:50:57.379Z,1379350257.379 [ComponentRegistry](DEBUG): Component "AsyncPiEstimator" handled in its own thread.
2013-09-16T16:50:57.380Z,1379350257.380 [AsyncPiEstimator ThreadHandler](DEBUG): Created PCaller Thread at 406474E0
2013-09-16T16:50:57.381Z,1379350257.381 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2013-09-16T16:50:57.381Z,1379350257.381 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2013-09-16T16:50:57.621Z,1379350257.621 [AHRS_sp3003D] Loaded
2013-09-16T16:50:57.622Z,1379350257.622 [ComponentRegistry](DEBUG): SyncComponent "AHRS_sp3003D" handled in the control thread.
2013-09-16T16:50:57.635Z,1379350257.635 [Depth_Keller] Loaded
2013-09-16T16:50:57.636Z,1379350257.636 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2013-09-16T16:50:57.835Z,1379350257.835 [DVL_micro] Loaded
2013-09-16T16:50:57.835Z,1379350257.835 [ComponentRegistry](DEBUG): Component "DVL_micro" handled in its own thread.
2013-09-16T16:50:57.836Z,1379350257.836 [DVL_micro ThreadHandler](DEBUG): Created PCaller Thread at 406CE4E0
2013-09-16T16:50:57.922Z,1379350257.922 [NAL9602] Loaded
2013-09-16T16:50:57.923Z,1379350257.923 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2013-09-16T16:50:57.963Z,1379350257.963 [Onboard] Loaded
2013-09-16T16:50:57.964Z,1379350257.964 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2013-09-16T16:50:57.970Z,1379350257.970 [Radio_Freewave] Loaded
2013-09-16T16:50:57.970Z,1379350257.970 [ComponentRegistry](DEBUG): SyncComponent "Radio_Freewave" handled in the control thread.
2013-09-16T16:50:58.109Z,1379350258.109 [DAT] Loaded
2013-09-16T16:50:58.109Z,1379350258.109 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2013-09-16T16:50:58.109Z,1379350258.109 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2013-09-16T16:50:58.110Z,1379350258.110 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2013-09-16T16:50:58.203Z,1379350258.203 [CTD_NeilBrown] Loaded
2013-09-16T16:50:58.203Z,1379350258.203 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2013-09-16T16:50:58.204Z,1379350258.204 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 4072B4E0
2013-09-16T16:50:58.219Z,1379350258.219 [PAR_Licor] Loaded
2013-09-16T16:50:58.219Z,1379350258.219 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2013-09-16T16:50:58.251Z,1379350258.251 [WetLabsBB2FL] Loaded
2013-09-16T16:50:58.251Z,1379350258.251 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2013-09-16T16:50:58.252Z,1379350258.252 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 4075B4E0
2013-09-16T16:50:58.253Z,1379350258.253 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2013-09-16T16:50:58.255Z,1379350258.255 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2013-09-16T16:50:58.256Z,1379350258.256 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2013-09-16T16:50:58.262Z,1379350258.262 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2013-09-16T16:50:58.264Z,1379350258.264 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 4078B4E0
2013-09-16T16:50:58.268Z,1379350258.268 [Supervisor](DEBUG): Running supervisor.
2013-09-16T16:50:58.269Z,1379350258.269 [CommandLine](INFO): Thread ID is 1803
2013-09-16T16:50:58.271Z,1379350258.271 [controlThread](INFO): Thread ID is 1802
2013-09-16T16:50:58.271Z,1379350258.271 [controlThread](DEBUG): Initializing ControlThread
2013-09-16T16:50:58.272Z,1379350258.272 [CycleStarter](INFO): Thread ID is 1801
2013-09-16T16:50:58.272Z,1379350258.272 [InternalSim](DEBUG):  InternalSim initializing...
2013-09-16T16:50:58.307Z,1379350258.307 [logger](INFO): Thread ID is 1804
2013-09-16T16:50:58.323Z,1379350258.323 [SBIT](INFO): Initialize SBIT Component.
2013-09-16T16:50:58.324Z,1379350258.324 [SBIT](IMPORTANT): Tethys CM Info: 
$Rev:10634
2013-09-16T16:50:58.324Z,1379350258.324 [SBIT](IMPORTANT): Kernel Release:2.6.27.8
2013-09-16T16:50:58.324Z,1379350258.324 [SBIT](IMPORTANT): Kernel Version:#634 PREEMPT Wed Feb 13 10:21:48 PST 2013
2013-09-16T16:50:58.325Z,1379350258.325 [IBIT](INFO): Initialize IBIT Component.
2013-09-16T16:50:58.326Z,1379350258.326 [CBIT](DEBUG): Initialize CBIT Component.
2013-09-16T16:50:58.326Z,1379350258.326 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2013-09-16T16:50:58.336Z,1379350258.336 [AsyncPiEstimator](INFO): Thread ID is 1865
2013-09-16T16:50:58.336Z,1379350258.336 [AsyncPiEstimator](DEBUG): Initialize AsyncPiEstimator.
2013-09-16T16:50:58.356Z,1379350258.356 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2013-09-16T16:50:58.357Z,1379350258.357 [NavChart](DEBUG): Initialize NavChart Derivation.
2013-09-16T16:50:58.357Z,1379350258.357 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2013-09-16T16:50:58.358Z,1379350258.358 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2013-09-16T16:50:58.358Z,1379350258.358 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2013-09-16T16:50:58.358Z,1379350258.358 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2013-09-16T16:50:58.359Z,1379350258.359 [Navigation](DEBUG): Initializing Navigation.
2013-09-16T16:50:58.359Z,1379350258.359 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2013-09-16T16:50:58.361Z,1379350258.361 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2013-09-16T16:50:58.362Z,1379350258.362 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2013-09-16T16:50:58.362Z,1379350258.362 [LoopControl](DEBUG): Initialize LoopControlComponent.
2013-09-16T16:50:58.368Z,1379350258.368 [DVL_micro](INFO): Thread ID is 1866
2013-09-16T16:50:58.377Z,1379350258.377 [DVL_micro](INFO): Initializing
2013-09-16T16:50:58.377Z,1379350258.377 [DVL_micro](INFO): start:Powering up
2013-09-16T16:50:58.378Z,1379350258.378 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-16T16:50:58.379Z,1379350258.379 [DVL_micro](INFO): Cycling power to configure device.
2013-09-16T16:50:58.395Z,1379350258.395 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2013-09-16T16:50:58.404Z,1379350258.404 [CTD_NeilBrown](INFO): Thread ID is 1867
2013-09-16T16:50:58.405Z,1379350258.405 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown.
2013-09-16T16:50:58.427Z,1379350258.427 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2013-09-16T16:50:58.431Z,1379350258.431 [WetLabsBB2FL](INFO): Thread ID is 1868
2013-09-16T16:50:58.431Z,1379350258.431 [WetLabsBB2FL](INFO): Powering down
2013-09-16T16:50:58.464Z,1379350258.464 [NavChartDb](INFO): Thread ID is 1869
2013-09-16T16:50:58.467Z,1379350258.467 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources
2013-09-16T16:50:58.468Z,1379350258.468 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2013-09-16T16:50:58.468Z,1379350258.468 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2013-09-16T16:50:58.468Z,1379350258.468 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2013-09-16T16:50:58.469Z,1379350258.469 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2013-09-16T16:50:58.469Z,1379350258.469 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2013-09-16T16:50:58.469Z,1379350258.469 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2013-09-16T16:50:58.469Z,1379350258.469 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2013-09-16T16:50:58.470Z,1379350258.470 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2013-09-16T16:50:58.490Z,1379350258.490 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://aosn.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://aosn.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://aosn.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://aosn.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://aosn.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

    <Guidance:GoToSurface RunIn="Progression"/>

    <Aggregate Id="StartupSatComms" >

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

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

    </Aggregate>

</Mission>


2013-09-16T16:50:58.491Z,1379350258.491 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2013-09-16T16:50:58.581Z,1379350258.581 [MissionManager](INFO): DefineArg Default.NeedGPS = 1 bool
2013-09-16T16:50:58.583Z,1379350258.583 [Default:GPS:A.SetSpeed](DEBUG): Construct.
2013-09-16T16:50:58.586Z,1379350258.586 [Default:GPS:B.GoToSurface](DEBUG): Construct GoToSurface.
2013-09-16T16:50:58.600Z,1379350258.600 [Default:Iridium:A.SetSpeed](DEBUG): Construct.
2013-09-16T16:50:58.603Z,1379350258.603 [Default:Iridium:B.GoToSurface](DEBUG): Construct GoToSurface.
2013-09-16T16:50:58.647Z,1379350258.647 [Default:Iridium:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2013-09-16T16:50:58.675Z,1379350258.675 [Default:D.SetSpeed](DEBUG): Construct.
2013-09-16T16:50:58.678Z,1379350258.678 [Default:E.GoToSurface](DEBUG): Construct GoToSurface.
2013-09-16T16:50:58.683Z,1379350258.683 [Default:F.Wait](DEBUG): Construct Wait.
2013-09-16T16:50:58.698Z,1379350258.698 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
xmlns:Control="Tethys/Control"
xmlns:Guidance="Tethys/Guidance" 
xmlns:Units="Tethys/Units"
xmlns:Universal="Tethys/Universal"
xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
xsi:schemaLocation="Tethys http://aosn.mbari.org/tethys/Xml/Tethys.xsd
Tethys/Control http://aosn.mbari.org/tethys/Xml/Control.xsd
Tethys/Guidance http://aosn.mbari.org/tethys/Xml/Guidance.xsd
Tethys/Units http://aosn.mbari.org/tethys/Xml/Units.xsd
Tethys/Universal http://aosn.mbari.org/tethys/Xml/Universal.xsd"
Id="Default">

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

    <Aggregate Id="GPS" >

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

<!-- Run at high speed -->

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

<!-- Get to the surface -->

        <Guidance:GoToSurface RunIn="Sequence"/>

<!-- Get GPS fix -->

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

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

    </Aggregate>

    <Aggregate Id="Iridium" >

<!-- Run at high speed -->

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

<!-- Get to the surface -->

        <Guidance:GoToSurface RunIn="Sequence"/>

<!-- Do data comms -->

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

    </Aggregate>

    <Aggregate Id="CallIridium" >

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

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

        <Call RefId="Iridium"/>

    </Aggregate>

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

<!-- Run at low speed -->

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

    <Guidance:GoToSurface RunIn="Parallel"/>

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

</Mission>


2013-09-16T16:50:58.703Z,1379350258.703 [controlThread](DEBUG): Component order: CycleStarter,InternalSim,AHRS_sp3003D,Depth_Keller,NAL9602,Onboard,Radio_Freewave,DAT,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,HFRadarModelCalc,NavChart,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,Navigation,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,
2013-09-16T16:50:58.768Z,1379350258.768 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D.
2013-09-16T16:50:58.805Z,1379350258.805 [Depth_Keller](ERROR): Pressure reading out of range: 1831.078247 decibar
2013-09-16T16:50:58.820Z,1379350258.820 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:50:58.888Z,1379350258.888 [Radio_Freewave](INFO): Powering up
2013-09-16T16:50:58.894Z,1379350258.894 [DAT](INFO): Powering up
2013-09-16T16:50:58.894Z,1379350258.894 [DAT](DEBUG): Initializing DAT.
2013-09-16T16:50:59.206Z,1379350259.206 [ElevatorServo](DEBUG): Initializing EZServoServo.
2013-09-16T16:50:59.229Z,1379350259.229 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2013-09-16T16:50:59.235Z,1379350259.235 [MassServo](DEBUG): Initializing EZServoServo.
2013-09-16T16:50:59.241Z,1379350259.241 [MassServo](DEBUG): Initializing MassServo.
2013-09-16T16:50:59.262Z,1379350259.262 [RudderServo](DEBUG): Initializing EZServoServo.
2013-09-16T16:50:59.269Z,1379350259.269 [RudderServo](DEBUG): Initializing RudderServo.
2013-09-16T16:50:59.275Z,1379350259.275 [ThrusterServo](DEBUG): Initializing EZServoServo.
2013-09-16T16:50:59.281Z,1379350259.281 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2013-09-16T16:50:59.541Z,1379350259.541 [AHRS_sp3003D](ERROR): readHeadingMagBin UART error: serial timeout
2013-09-16T16:50:59.541Z,1379350259.541 [AHRS_sp3003D](ERROR): readHeadingMagBin got 0x42360D0A
2013-09-16T16:50:59.541Z,1379350259.541 [AHRS_sp3003D](ERROR): SP3003D failed to initialize
2013-09-16T16:50:59.542Z,1379350259.542 [AHRS_sp3003D] Hardware Fault, FailCount= 1
2013-09-16T16:50:59.542Z,1379350259.542 [AHRS_sp3003D](ERROR): Hardware Fault
2013-09-16T16:50:59.697Z,1379350259.697 [CBIT](ERROR): Hardware Fault in component: AHRS_sp3003D
2013-09-16T16:50:59.765Z,1379350259.765 [AHRS_sp3003D](INFO): Powering down
2013-09-16T16:51:00.435Z,1379350260.435 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-16T16:51:00.435Z,1379350260.435 [DVL_micro](INFO): Querying output modes
2013-09-16T16:51:00.436Z,1379350260.436 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-16T16:51:00.447Z,1379350260.447 [DVL_micro](DEBUG): cmdResponse: 01 16
2013-09-16T16:51:00.447Z,1379350260.447 [DVL_micro](INFO): NQ1 output enabled
2013-09-16T16:51:00.447Z,1379350260.447 [DVL_micro](INFO): RSSI output enabled
2013-09-16T16:51:00.447Z,1379350260.447 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-16T16:51:00.459Z,1379350260.459 [DVL_micro](DEBUG): cmdResponse: AUTO_VEL_ON 
2013-09-16T16:51:00.464Z,1379350260.464 [DVL_micro](INFO): pause:Powering down
2013-09-16T16:51:00.466Z,1379350260.466 [DVL_micro](INFO): RSSI unrequested
2013-09-16T16:51:00.467Z,1379350260.467 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-16T16:51:00.468Z,1379350260.468 [DVL_micro](INFO): resume:Powering up
2013-09-16T16:51:00.468Z,1379350260.468 [DVL_micro](INFO): Cycling power to configure device.
2013-09-16T16:51:01.177Z,1379350261.177 [CBIT](INFO): Clearing failed state for component AHRS_sp3003D
2013-09-16T16:51:01.178Z,1379350261.178 [AHRS_sp3003D] No Fault, FailCount= 1
2013-09-16T16:51:01.451Z,1379350261.451 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D.
2013-09-16T16:51:02.470Z,1379350262.470 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-16T16:51:02.470Z,1379350262.470 [DVL_micro](INFO): Querying output modes
2013-09-16T16:51:02.471Z,1379350262.471 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-16T16:51:02.485Z,1379350262.485 [DVL_micro](DEBUG): cmdResponse: �������������������a����g��w��u�������a�S����������������e���k�f�]�r�`�X�
2013-09-16T16:51:02.485Z,1379350262.485 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-16T16:51:02.499Z,1379350262.499 [DVL_micro](DEBUG): cmdResponse: ��������}�]�w����������x�q�u�S��x�h�B�)�&�6�u�l�m���|�n�K�>�}����������{�v�b�[�
2013-09-16T16:51:02.502Z,1379350262.502 [DVL_micro](INFO): pause:Powering down
2013-09-16T16:51:03.460Z,1379350263.460 [NAL9602](INFO): Powering up NAL9602
2013-09-16T16:51:13.979Z,1379350273.979 [SBIT](IMPORTANT): Beginning Startup BIT
2013-09-16T16:51:13.993Z,1379350273.993 [CBIT](IMPORTANT): Beginning GF scan
2013-09-16T16:51:14.296Z,1379350274.296 [NAL9602](INFO): NAL9602 initialized
2013-09-16T16:51:18.938Z,1379350278.938 [DAT](INFO): Powering down
2013-09-16T16:51:22.001Z,1379350282.001 [CommandLine](IMPORTANT): got command set NAL9602.latitude_fix 36.799999 degree
2013-09-16T16:51:25.298Z,1379350285.298 [CommandLine](IMPORTANT): got command set NAL9602.latitude_fix 36.799999 degree
2013-09-16T16:51:27.938Z,1379350287.938 [NAL9602](INFO): Powering down
2013-09-16T16:51:33.123Z,1379350293.123 [CommandLine](IMPORTANT): got command set NAL9602.platform_communications 1.000000 bool
2013-09-16T16:51:46.245Z,1379350306.245 [CBIT](FAULT): Chan 4 High side GF detected
mA:
CHAN 5 (24V): 0.031278
CHAN 4 (Batt): 0.003730
CHAN 2 (12V): 0.000574
CHAN 1 (5V): 0.000670
CHAN 0 (3.3V): 0.000670
OPEN: 0.000574
Full Scale Calc: 0.392
2013-09-16T16:52:07.970Z,1379350327.970 [SBIT](IMPORTANT): SBIT PASSED
2013-09-16T16:52:08.368Z,1379350328.368 [MissionManager](IMPORTANT): Started mission Startup
2013-09-16T16:52:08.368Z,1379350328.368 [Startup] Running Loop=1
2013-09-16T16:52:08.368Z,1379350328.368 [Startup](INFO): Aggregate::initialize Startup
2013-09-16T16:52:08.368Z,1379350328.368 [Startup:A.GoToSurface] Running Loop=1
2013-09-16T16:52:08.368Z,1379350328.368 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-09-16T16:52:08.374Z,1379350328.374 [Startup:StartupSatComms] Running Loop=1
2013-09-16T16:52:08.375Z,1379350328.375 [Startup:StartupSatComms](INFO): Aggregate::initialize Startup:StartupSatComms
2013-09-16T16:52:08.375Z,1379350328.375 [Startup:StartupSatComms:A] Running Loop=1
2013-09-16T16:52:08.761Z,1379350328.761 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2013-09-16T16:52:09.146Z,1379350329.146 [NAL9602](INFO): Powering up
2013-09-16T16:52:19.982Z,1379350339.982 [NAL9602](INFO): NAL9602 initialized
2013-09-16T16:52:24.898Z,1379350344.898 [CommandLine](IMPORTANT): got command set NAL9602.platform_communications 1.000000 bool
2013-09-16T16:52:40.033Z,1379350360.033 [CommandLine](IMPORTANT): got command set NAL9602.latitude_fix 36.799999 degree
2013-09-16T16:52:40.150Z,1379350360.150 [Startup:StartupSatComms:A] Stopped
2013-09-16T16:52:40.151Z,1379350360.151 [Startup:StartupSatComms:B] Running Loop=1
2013-09-16T16:52:40.542Z,1379350360.542 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2013-09-16T16:52:55.686Z,1379350375.686 [CommandLine](IMPORTANT): got command set NAL9602.platform_communications 1.000000 bool
2013-09-16T16:53:00.249Z,1379350380.249 [Startup:StartupSatComms:B] Stopped
2013-09-16T16:53:00.249Z,1379350380.249 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2013-09-16T16:53:00.249Z,1379350380.249 [Startup:StartupSatComms] Stopped
2013-09-16T16:53:00.250Z,1379350380.250 [Startup:StartupSatComms](INFO): Aggregate::uninitialize Startup:StartupSatComms
2013-09-16T16:53:00.250Z,1379350380.250 [Startup](INFO): Completed Startup
2013-09-16T16:53:00.251Z,1379350380.251 [Startup] Stopped
2013-09-16T16:53:00.251Z,1379350380.251 [Startup](INFO): Aggregate::uninitialize Startup
2013-09-16T16:53:00.251Z,1379350380.251 [Startup:A.GoToSurface] Stopped
2013-09-16T16:53:00.251Z,1379350380.251 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-09-16T16:53:01.077Z,1379350381.077 [MissionManager](IMPORTANT): Started mission Default
2013-09-16T16:53:01.077Z,1379350381.077 [Default] Running Loop=1
2013-09-16T16:53:01.077Z,1379350381.077 [Default](INFO): Aggregate::initialize Default
2013-09-16T16:53:01.077Z,1379350381.077 [Default:D.SetSpeed] Running Loop=1
2013-09-16T16:53:01.078Z,1379350381.078 [Default:D.SetSpeed](DEBUG): Initialize.
2013-09-16T16:53:01.078Z,1379350381.078 [Default:E.GoToSurface] Running Loop=1
2013-09-16T16:53:01.078Z,1379350381.078 [Default:E.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-09-16T16:53:01.078Z,1379350381.078 [Default:Iridium] Running Loop=1
2013-09-16T16:53:01.078Z,1379350381.078 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2013-09-16T16:53:01.078Z,1379350381.078 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-09-16T16:53:01.078Z,1379350381.078 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2013-09-16T16:53:01.078Z,1379350381.078 [Default:Iridium:B.GoToSurface] Running Loop=1
2013-09-16T16:53:01.078Z,1379350381.078 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-09-16T16:53:01.079Z,1379350381.079 [Default:E.GoToSurface] Running Loop=1
2013-09-16T16:53:01.084Z,1379350381.084 [Default:D.SetSpeed] Running Loop=1
2013-09-16T16:53:01.097Z,1379350381.097 [Default:Iridium:B.GoToSurface] Stopped
2013-09-16T16:53:01.097Z,1379350381.097 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-09-16T16:53:01.098Z,1379350381.098 [Default:Iridium:Read_Iridium] Running Loop=1
2013-09-16T16:53:01.098Z,1379350381.098 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-09-16T16:53:01.103Z,1379350381.103 [Default:GPS] Running Loop=1
2013-09-16T16:53:01.103Z,1379350381.103 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2013-09-16T16:53:01.103Z,1379350381.103 [Default:GPS:A.SetSpeed] Running Loop=1
2013-09-16T16:53:01.103Z,1379350381.103 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2013-09-16T16:53:01.104Z,1379350381.104 [Default:GPS:B.GoToSurface] Running Loop=1
2013-09-16T16:53:01.104Z,1379350381.104 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-09-16T16:53:01.133Z,1379350381.133 [Default:GPS:B.GoToSurface] Stopped
2013-09-16T16:53:01.133Z,1379350381.133 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-09-16T16:53:01.133Z,1379350381.133 [Default:GPS:Read_GPS] Running Loop=1
2013-09-16T16:53:01.133Z,1379350381.133 [Default:GPS:A.SetSpeed] Running Loop=1
2013-09-16T16:53:01.397Z,1379350381.397 [Default:Iridium:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2013-09-16T16:53:01.400Z,1379350381.400 [Default:GPS:Read_GPS](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2013-09-16T16:53:08.474Z,1379350388.474 [CommandLine](IMPORTANT): got command run ./Missions/Maintenance/tank_weight.xml
2013-09-16T16:53:08.474Z,1379350388.474 [MissionManager](INFO): Loading Mission: ./Missions/Maintenance/tank_weight.xml
2013-09-16T16:53:08.527Z,1379350388.527 [MissionManager](INFO): DefineArg tank_weight.BuoyancyLimitHiCC = 0.000955 n/a
2013-09-16T16:53:08.535Z,1379350388.535 [MissionManager](INFO): DefineArg tank_weight.BuoyancyLimitLoCC = 0.000080 n/a
2013-09-16T16:53:08.541Z,1379350388.541 [tank_weight:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2013-09-16T16:53:08.553Z,1379350388.553 [tank_weight:B.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2013-09-16T16:53:08.571Z,1379350388.571 [MissionManager](INFO): Inserting Stack: Missions/Insert/Science.xml
2013-09-16T16:53:08.746Z,1379350388.746 [MissionManager](INFO): DefineArg tank_weight:Science.SampleISUS = 0 bool
2013-09-16T16:53:08.761Z,1379350388.761 [MissionManager](INFO): DefineArg tank_weight:Science.SampleISUSmaxPitch = 60.000000 arcdeg
2013-09-16T16:53:08.765Z,1379350388.765 [MissionManager](INFO): DefineArg tank_weight:Science.SampleISUSminPitch = -60.000000 arcdeg
2013-09-16T16:53:08.767Z,1379350388.767 [MissionManager](INFO): DefineArg tank_weight:Science.SampleRSSI = 1 bool
2013-09-16T16:53:08.770Z,1379350388.770 [MissionManager](INFO): DefineArg tank_weight:Science.SampleADCP = 0 bool
2013-09-16T16:53:08.773Z,1379350388.773 [MissionManager](INFO): DefineArg tank_weight:Science.PeakDetectChlActive = 0 bool
2013-09-16T16:53:08.776Z,1379350388.776 [MissionManager](INFO): DefineArg tank_weight:Science.PeakDetectNO3Active = 0 bool
2013-09-16T16:53:08.779Z,1379350388.779 [MissionManager](INFO): DefineArg tank_weight:Science.PeakDetectRSSIActive = 0 bool
2013-09-16T16:53:08.781Z,1379350388.781 [MissionManager](INFO): DefineArg tank_weight:Science.UpwardDerivativeOfTemperatureActive = 0 bool
2013-09-16T16:53:08.784Z,1379350388.784 [MissionManager](INFO): DefineArg tank_weight:Science.ComputeWaterCurrent = 0 bool
2013-09-16T16:53:08.788Z,1379350388.788 [MissionManager](INFO): DefineArg tank_weight:Science.ComputeWaterCurrentMinDepth = 2.000000 m
2013-09-16T16:53:08.791Z,1379350388.791 [MissionManager](INFO): DefineArg tank_weight:Science.ComputeWaterCurrentMaxDepth = 5.000000 m
2013-09-16T16:53:08.795Z,1379350388.795 [MissionManager](INFO): DefineArg tank_weight:Science.EnabledAanderaaO2 = 0.000000 n/a
2013-09-16T16:53:08.798Z,1379350388.798 [MissionManager](INFO): DefineArg tank_weight:Science.EnabledNeilBrown = 1.000000 n/a
2013-09-16T16:53:08.802Z,1379350388.802 [MissionManager](INFO): DefineArg tank_weight:Science.EnabledTurbulence_NPS = 0.000000 n/a
2013-09-16T16:53:08.805Z,1379350388.805 [MissionManager](INFO): DefineArg tank_weight:Science.EnabledWetLabsBB2FL = 1.000000 n/a
2013-09-16T16:53:08.808Z,1379350388.808 [MissionManager](INFO): DefineArg tank_weight:Science.EnabledDVL = 1.000000 n/a
2013-09-16T16:53:08.848Z,1379350388.848 [MissionManager](INFO): DefineArg tank_weight:Science.EnabledISUS = 0.000000 n/a
2013-09-16T16:53:08.851Z,1379350388.851 [MissionManager](INFO): DefineOutput tank_weight:Science.PeakChl = 0.000000 ug/l
2013-09-16T16:53:08.854Z,1379350388.854 [MissionManager](INFO): DefineOutput tank_weight:Science.PeakChlDepth = 0.000000 m
2013-09-16T16:53:08.861Z,1379350388.861 [MissionManager](INFO): DefineOutput tank_weight:Science.PeakChlLatitude = nan arcdeg
2013-09-16T16:53:08.864Z,1379350388.864 [MissionManager](INFO): DefineOutput tank_weight:Science.PeakChlLongitude = nan arcdeg
2013-09-16T16:53:08.867Z,1379350388.867 [MissionManager](INFO): DefineOutput tank_weight:Science.PeakNO3 = 0.000000 umol/l
2013-09-16T16:53:08.871Z,1379350388.871 [MissionManager](INFO): DefineOutput tank_weight:Science.PeakNO3Depth = 0.000000 m
2013-09-16T16:53:08.874Z,1379350388.874 [MissionManager](INFO): DefineOutput tank_weight:Science.PeakNO3Latitude = nan arcdeg
2013-09-16T16:53:08.877Z,1379350388.877 [MissionManager](INFO): DefineOutput tank_weight:Science.PeakNO3Longitude = nan arcdeg
2013-09-16T16:53:08.880Z,1379350388.880 [MissionManager](INFO): DefineOutput tank_weight:Science.PeakRSSI = 0.000000 dB
2013-09-16T16:53:08.895Z,1379350388.895 [MissionManager](INFO): DefineOutput tank_weight:Science.PeakRSSIDepth = 0.000000 m
2013-09-16T16:53:08.898Z,1379350388.898 [MissionManager](INFO): DefineOutput tank_weight:Science.PeakRSSILatitude = nan arcdeg
2013-09-16T16:53:08.901Z,1379350388.901 [MissionManager](INFO): DefineOutput tank_weight:Science.PeakRSSILongitude = nan arcdeg
2013-09-16T16:53:08.961Z,1379350388.961 [tank_weight:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2013-09-16T16:53:08.975Z,1379350388.975 [tank_weight:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2013-09-16T16:53:08.990Z,1379350388.990 [tank_weight:Science:PeakDetectRSSI:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2013-09-16T16:53:09.005Z,1379350389.005 [MissionManager](INFO): RedefineArg tank_weight:Science.SampleISUS = 1 bool
2013-09-16T16:53:09.027Z,1379350389.027 [tank_weight:D:A.SetSpeed](DEBUG): Construct.
2013-09-16T16:53:09.036Z,1379350389.036 [tank_weight:D:BuoyancyLo:A.Buoyancy](DEBUG): Construct Buoyancy.
2013-09-16T16:53:09.047Z,1379350389.047 [tank_weight:D:BuoyancyLo:B.Pitch](DEBUG): Construct.
2013-09-16T16:53:09.057Z,1379350389.057 [tank_weight:D:BuoyancyLo:C.Wait](DEBUG): Construct Wait.
2013-09-16T16:53:09.068Z,1379350389.068 [tank_weight:D:BuoyancyHi:A.Buoyancy](DEBUG): Construct Buoyancy.
2013-09-16T16:53:09.072Z,1379350389.072 [tank_weight:D:BuoyancyHi:B.Pitch](DEBUG): Construct.
2013-09-16T16:53:09.079Z,1379350389.079 [tank_weight:D:BuoyancyHi:C.Wait](DEBUG): Construct Wait.
2013-09-16T16:53:09.105Z,1379350389.105 [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/Units http://aosn.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://aosn.mbari.org/tethys/Xml/Universal.xsd"
       Id="tank_weight">

    <DefineArg Name="BuoyancyLimitHiCC"><Control:VerticalControl.buoyancyLimitHiCC/></DefineArg>

    <DefineArg Name="BuoyancyLimitLoCC"><Control:VerticalControl.buoyancyLimitLoCC/></DefineArg>

    <Timeout Duration="P75M"/>

    <Guidance:AltitudeEnvelope RunIn="Parallel">
        <Setting><Guidance:AltitudeEnvelope.minAltitude/><Units:meter/><Value>0</Value></Setting>
    </Guidance:AltitudeEnvelope>

    <Guidance:DepthEnvelope RunIn="Parallel">
        <Setting><Guidance:DepthEnvelope.minDepth/><Units:meter/><Value>0</Value></Setting>
        <Setting><Guidance:DepthEnvelope.maxDepth/><Units:meter/><Value>15</Value></Setting>
    </Guidance:DepthEnvelope>

    <Insert Filename="Insert/Science.xml">
        <RedefineArg Name="SampleISUS"><True/></RedefineArg>
    </Insert>

    <Aggregate>

        <Guidance:SetSpeed RunIn="Parallel">
            <Setting><Guidance:SetSpeed.speed/><Units:meter_per_second/><Value>0</Value></Setting>
        </Guidance:SetSpeed>

        <Aggregate Id="BuoyancyLo">

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

            <Guidance:Pitch RunIn="Parallel">
                <Setting><Guidance:Pitch.massPosition/><Units:meter/><Value>0</Value></Setting>
                <Setting><Guidance:Pitch.depth/><Units:meter/><Value>15</Value></Setting>
            </Guidance:Pitch>

            <Guidance:Wait RunIn="Sequence">
                <Setting><Guidance:Wait.duration/><Units:minute/><Value>65</Value></Setting>
            </Guidance:Wait>

        </Aggregate>

        <Aggregate Id="BuoyancyHi">

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

            <Guidance:Pitch RunIn="Parallel">
                <Setting><Guidance:Pitch.massPosition/><Units:meter/><Value>0</Value></Setting>
                <Setting><Guidance:Pitch.depth/><Units:meter/><Value>15</Value></Setting>
            </Guidance:Pitch>

            <Guidance:Wait RunIn="Sequence">
                <Setting><Guidance:Wait.duration/><Units:minute/><Value>5</Value></Setting>
            </Guidance:Wait>

        </Aggregate>

    </Aggregate>

</Mission>


2013-09-16T16:53:09.108Z,1379350389.108 [CommandLine](IMPORTANT): Running ./Missions/Maintenance/tank_weight.xml
2013-09-16T16:53:09.827Z,1379350389.827 [Default] Stopped
2013-09-16T16:53:09.827Z,1379350389.827 [Default](INFO): Aggregate::uninitialize Default
2013-09-16T16:53:09.827Z,1379350389.827 [Default:GPS] Stopped
2013-09-16T16:53:09.828Z,1379350389.828 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2013-09-16T16:53:09.828Z,1379350389.828 [Default:GPS:A.SetSpeed] Stopped
2013-09-16T16:53:09.828Z,1379350389.828 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2013-09-16T16:53:09.828Z,1379350389.828 [Default:GPS:Read_GPS] Stopped
2013-09-16T16:53:09.828Z,1379350389.828 [Default:Iridium] Stopped
2013-09-16T16:53:09.828Z,1379350389.828 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2013-09-16T16:53:09.828Z,1379350389.828 [Default:Iridium:A.SetSpeed] Stopped
2013-09-16T16:53:09.828Z,1379350389.828 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2013-09-16T16:53:09.828Z,1379350389.828 [Default:Iridium:Read_Iridium] Stopped
2013-09-16T16:53:09.828Z,1379350389.828 [Default:D.SetSpeed] Stopped
2013-09-16T16:53:09.828Z,1379350389.828 [Default:D.SetSpeed](DEBUG): Uninitialize.
2013-09-16T16:53:09.828Z,1379350389.828 [Default:E.GoToSurface] Stopped
2013-09-16T16:53:09.828Z,1379350389.828 [Default:E.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-09-16T16:53:09.829Z,1379350389.829 [MissionManager](IMPORTANT): Started mission tank_weight
2013-09-16T16:53:09.829Z,1379350389.829 [tank_weight] Running Loop=1
2013-09-16T16:53:09.829Z,1379350389.829 [tank_weight](INFO): Aggregate::initialize tank_weight
2013-09-16T16:53:09.829Z,1379350389.829 [tank_weight:A.AltitudeEnvelope] Running Loop=1
2013-09-16T16:53:09.829Z,1379350389.829 [tank_weight:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2013-09-16T16:53:09.829Z,1379350389.829 [tank_weight:B.DepthEnvelope] Running Loop=1
2013-09-16T16:53:09.829Z,1379350389.829 [tank_weight:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2013-09-16T16:53:09.830Z,1379350389.830 [tank_weight:Science] Running Loop=1
2013-09-16T16:53:09.830Z,1379350389.830 [tank_weight:Science](INFO): Aggregate::initialize tank_weight:Science
2013-09-16T16:53:09.831Z,1379350389.831 [tank_weight:Science:A] Running Loop=1
2013-09-16T16:53:09.831Z,1379350389.831 [tank_weight:Science:B] Running Loop=1
2013-09-16T16:53:09.831Z,1379350389.831 [tank_weight:Science:C] Running Loop=1
2013-09-16T16:53:09.831Z,1379350389.831 [tank_weight:Science:D] Running Loop=1
2013-09-16T16:53:09.831Z,1379350389.831 [tank_weight:Science:E] Running Loop=1
2013-09-16T16:53:09.831Z,1379350389.831 [tank_weight:Science:F] Running Loop=1
2013-09-16T16:53:09.831Z,1379350389.831 [tank_weight:Science:G] Running Loop=1
2013-09-16T16:53:09.831Z,1379350389.831 [tank_weight:Science:H] Running Loop=1
2013-09-16T16:53:09.831Z,1379350389.831 [tank_weight:Science:I] Running Loop=1
2013-09-16T16:53:09.831Z,1379350389.831 [tank_weight:D] Running Loop=1
2013-09-16T16:53:09.831Z,1379350389.831 [tank_weight:D](INFO): Aggregate::initialize tank_weight:D
2013-09-16T16:53:09.832Z,1379350389.832 [tank_weight:D:A.SetSpeed] Running Loop=1
2013-09-16T16:53:09.832Z,1379350389.832 [tank_weight:D:A.SetSpeed](DEBUG): Initialize.
2013-09-16T16:53:09.832Z,1379350389.832 [tank_weight:D:BuoyancyLo] Running Loop=1
2013-09-16T16:53:09.832Z,1379350389.832 [tank_weight:D:BuoyancyLo](INFO): Aggregate::initialize tank_weight:D:BuoyancyLo
2013-09-16T16:53:09.832Z,1379350389.832 [tank_weight:D:BuoyancyLo:A.Buoyancy] Running Loop=1
2013-09-16T16:53:09.832Z,1379350389.832 [tank_weight:D:BuoyancyLo:A.Buoyancy](DEBUG): Initialize Buoyancy Component.
2013-09-16T16:53:09.832Z,1379350389.832 [tank_weight:D:BuoyancyLo:B.Pitch] Running Loop=1
2013-09-16T16:53:09.832Z,1379350389.832 [tank_weight:D:BuoyancyLo:B.Pitch](DEBUG): Initialize.
2013-09-16T16:53:09.832Z,1379350389.832 [tank_weight:D:BuoyancyLo:C.Wait] Running Loop=1
2013-09-16T16:53:09.833Z,1379350389.833 [tank_weight:D:BuoyancyLo:C.Wait](DEBUG): Initialize Wait Component.
2013-09-16T16:53:09.837Z,1379350389.837 [tank_weight:D:BuoyancyLo:B.Pitch] Running Loop=1
2013-09-16T16:53:09.842Z,1379350389.842 [tank_weight:D:BuoyancyLo:A.Buoyancy] Running Loop=1
2013-09-16T16:53:09.847Z,1379350389.847 [tank_weight:D:A.SetSpeed] Running Loop=1
2013-09-16T16:53:09.851Z,1379350389.851 [tank_weight:Science] Running Loop=1
2013-09-16T16:53:09.852Z,1379350389.852 [tank_weight:Science:I] Running Loop=1
2013-09-16T16:53:09.853Z,1379350389.853 [tank_weight:Science:I](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2013-09-16T16:53:09.854Z,1379350389.854 [tank_weight:Science:H] Running Loop=1
2013-09-16T16:53:09.855Z,1379350389.855 [tank_weight:Science:H](DEBUG): Initialize ReadDataComponent to sense DVL_micro.Beam1RSSI
2013-09-16T16:53:09.856Z,1379350389.856 [tank_weight:Science:D] Running Loop=1
2013-09-16T16:53:09.857Z,1379350389.857 [tank_weight:Science:D](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature
2013-09-16T16:53:09.858Z,1379350389.858 [tank_weight:Science:D](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity
2013-09-16T16:53:09.859Z,1379350389.859 [tank_weight:B.DepthEnvelope] Running Loop=1
2013-09-16T16:53:09.864Z,1379350389.864 [tank_weight:A.AltitudeEnvelope] Running Loop=1
2013-09-16T16:53:09.944Z,1379350389.944 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=4
2013-09-16T16:53:09.944Z,1379350389.944 [WetLabsBB2FL](INFO): Powering up
2013-09-16T16:53:10.200Z,1379350390.200 [DVL_micro](INFO): RSSI requested
2013-09-16T16:53:10.200Z,1379350390.200 [DVL_micro](INFO): NQ1 requested
2013-09-16T16:53:10.201Z,1379350390.201 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-16T16:53:10.201Z,1379350390.201 [DVL_micro](INFO): resume:Powering up
2013-09-16T16:53:10.201Z,1379350390.201 [DVL_micro](INFO): Cycling power to configure device.
2013-09-16T16:53:10.332Z,1379350390.332 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:10.737Z,1379350390.737 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:11.141Z,1379350391.141 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:11.546Z,1379350391.546 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:11.951Z,1379350391.951 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:12.207Z,1379350392.207 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-16T16:53:12.207Z,1379350392.207 [DVL_micro](INFO): Querying output modes
2013-09-16T16:53:12.208Z,1379350392.208 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-16T16:53:12.219Z,1379350392.219 [DVL_micro](DEBUG): cmdResponse: 01 16
2013-09-16T16:53:12.220Z,1379350392.220 [DVL_micro](INFO): NQ1 output enabled
2013-09-16T16:53:12.220Z,1379350392.220 [DVL_micro](INFO): RSSI output enabled
2013-09-16T16:53:12.220Z,1379350392.220 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-16T16:53:12.231Z,1379350392.231 [DVL_micro](DEBUG): cmdResponse: AUTO_VEL_ON 
2013-09-16T16:53:12.355Z,1379350392.355 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:12.376Z,1379350392.376 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=136
2013-09-16T16:53:12.428Z,1379350392.428 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=156
2013-09-16T16:53:12.476Z,1379350392.476 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=16
2013-09-16T16:53:12.524Z,1379350392.524 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2013-09-16T16:53:12.760Z,1379350392.760 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:12.816Z,1379350392.816 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=152
2013-09-16T16:53:12.916Z,1379350392.916 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=124
2013-09-16T16:53:13.017Z,1379350393.017 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=96
2013-09-16T16:53:13.122Z,1379350393.122 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2013-09-16T16:53:13.165Z,1379350393.165 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:13.261Z,1379350393.261 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=104
2013-09-16T16:53:13.313Z,1379350393.313 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=61
2013-09-16T16:53:13.365Z,1379350393.365 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=113
2013-09-16T16:53:13.421Z,1379350393.421 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2013-09-16T16:53:13.569Z,1379350393.569 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:13.694Z,1379350393.694 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=56
2013-09-16T16:53:13.802Z,1379350393.802 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=60
2013-09-16T16:53:13.902Z,1379350393.902 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=64
2013-09-16T16:53:13.974Z,1379350393.974 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:14.002Z,1379350394.002 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2013-09-16T16:53:14.355Z,1379350394.355 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=56
2013-09-16T16:53:14.378Z,1379350394.378 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:14.503Z,1379350394.503 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=124
2013-09-16T16:53:14.643Z,1379350394.643 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=32
2013-09-16T16:53:14.783Z,1379350394.783 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:14.795Z,1379350394.795 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=4
2013-09-16T16:53:15.112Z,1379350395.112 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=60
2013-09-16T16:53:15.188Z,1379350395.188 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:15.220Z,1379350395.220 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=4
2013-09-16T16:53:15.344Z,1379350395.344 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=76
2013-09-16T16:53:15.464Z,1379350395.464 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=4
2013-09-16T16:53:15.592Z,1379350395.592 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:15.661Z,1379350395.661 [NAL9602](INFO): Powering down
2013-09-16T16:53:15.989Z,1379350395.989 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=92
2013-09-16T16:53:15.997Z,1379350395.997 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:16.225Z,1379350396.225 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=100
2013-09-16T16:53:16.401Z,1379350396.401 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:16.455Z,1379350396.455 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=12
2013-09-16T16:53:16.705Z,1379350396.705 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=4
2013-09-16T16:53:16.806Z,1379350396.806 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:17.215Z,1379350397.215 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:17.617Z,1379350397.617 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=124
2013-09-16T16:53:17.619Z,1379350397.619 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:18.025Z,1379350398.025 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:18.092Z,1379350398.092 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=132
2013-09-16T16:53:18.429Z,1379350398.429 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:18.557Z,1379350398.557 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=13
2013-09-16T16:53:18.833Z,1379350398.833 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:19.042Z,1379350399.042 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=4
2013-09-16T16:53:19.238Z,1379350399.238 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:19.642Z,1379350399.642 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:19.931Z,1379350399.931 [DVL_micro](DEBUG): NQ1
2013-09-16T16:53:20.047Z,1379350400.047 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:20.452Z,1379350400.452 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:20.773Z,1379350400.773 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=8
2013-09-16T16:53:20.856Z,1379350400.856 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:21.261Z,1379350401.261 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:21.614Z,1379350401.614 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=48
2013-09-16T16:53:21.666Z,1379350401.666 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:22.074Z,1379350402.074 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:22.455Z,1379350402.455 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=24
2013-09-16T16:53:22.479Z,1379350402.479 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:22.884Z,1379350402.884 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:23.288Z,1379350403.288 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:23.297Z,1379350403.297 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=4
2013-09-16T16:53:23.681Z,1379350403.681 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=104
2013-09-16T16:53:23.693Z,1379350403.693 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:23.729Z,1379350403.729 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=28
2013-09-16T16:53:23.789Z,1379350403.789 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=48
2013-09-16T16:53:23.841Z,1379350403.841 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2013-09-16T16:53:24.097Z,1379350404.097 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:24.130Z,1379350404.130 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=184
2013-09-16T16:53:24.218Z,1379350404.218 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=28
2013-09-16T16:53:24.322Z,1379350404.322 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=32
2013-09-16T16:53:24.430Z,1379350404.430 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2013-09-16T16:53:24.502Z,1379350404.502 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:24.567Z,1379350404.567 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=40
2013-09-16T16:53:24.619Z,1379350404.619 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=60
2013-09-16T16:53:24.678Z,1379350404.678 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=80
2013-09-16T16:53:24.723Z,1379350404.723 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2013-09-16T16:53:24.907Z,1379350404.907 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:25.015Z,1379350405.015 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=56
2013-09-16T16:53:25.107Z,1379350405.107 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=28
2013-09-16T16:53:25.215Z,1379350405.215 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=96
2013-09-16T16:53:25.311Z,1379350405.311 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:25.319Z,1379350405.319 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2013-09-16T16:53:25.669Z,1379350405.669 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=88
2013-09-16T16:53:25.716Z,1379350405.716 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:25.816Z,1379350405.816 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=124
2013-09-16T16:53:25.949Z,1379350405.949 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=2
2013-09-16T16:53:26.101Z,1379350406.101 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=4
2013-09-16T16:53:26.121Z,1379350406.121 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:26.420Z,1379350406.420 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=28
2013-09-16T16:53:26.526Z,1379350406.526 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:26.543Z,1379350406.543 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=69
2013-09-16T16:53:26.656Z,1379350406.656 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=48
2013-09-16T16:53:26.778Z,1379350406.778 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=4
2013-09-16T16:53:26.930Z,1379350406.930 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:27.295Z,1379350407.295 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=29
2013-09-16T16:53:27.335Z,1379350407.335 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:27.535Z,1379350407.535 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=102
2013-09-16T16:53:27.739Z,1379350407.739 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:27.767Z,1379350407.767 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=47
2013-09-16T16:53:28.009Z,1379350408.009 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=4
2013-09-16T16:53:28.144Z,1379350408.144 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:28.548Z,1379350408.548 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:28.926Z,1379350408.926 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=30
2013-09-16T16:53:28.953Z,1379350408.953 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:29.358Z,1379350409.358 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:29.402Z,1379350409.402 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=39
2013-09-16T16:53:29.762Z,1379350409.762 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:29.927Z,1379350409.927 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=655
2013-09-16T16:53:30.167Z,1379350410.167 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:30.355Z,1379350410.355 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=4
2013-09-16T16:53:30.572Z,1379350410.572 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:30.976Z,1379350410.976 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:31.236Z,1379350411.236 [DVL_micro](DEBUG): NQ1
2013-09-16T16:53:31.381Z,1379350411.381 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:31.785Z,1379350411.785 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:32.090Z,1379350412.090 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=96
2013-09-16T16:53:32.190Z,1379350412.190 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:32.595Z,1379350412.595 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:32.931Z,1379350412.931 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=136
2013-09-16T16:53:32.999Z,1379350412.999 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:33.404Z,1379350413.404 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:33.765Z,1379350413.765 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=16
2013-09-16T16:53:33.812Z,1379350413.812 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:34.217Z,1379350414.217 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:34.613Z,1379350414.613 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=4
2013-09-16T16:53:34.622Z,1379350414.622 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:34.939Z,1379350414.939 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=40
2013-09-16T16:53:34.998Z,1379350414.998 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=92
2013-09-16T16:53:35.026Z,1379350415.026 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:35.051Z,1379350415.051 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=48
2013-09-16T16:53:35.103Z,1379350415.103 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2013-09-16T16:53:35.391Z,1379350415.391 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=152
2013-09-16T16:53:35.431Z,1379350415.431 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:35.499Z,1379350415.499 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=92
2013-09-16T16:53:35.595Z,1379350415.595 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=128
2013-09-16T16:53:35.688Z,1379350415.688 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2013-09-16T16:53:35.836Z,1379350415.836 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:35.838Z,1379350415.838 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=168
2013-09-16T16:53:35.900Z,1379350415.900 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=284
2013-09-16T16:53:35.936Z,1379350415.936 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=80
2013-09-16T16:53:35.996Z,1379350415.996 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2013-09-16T16:53:36.240Z,1379350416.240 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:36.273Z,1379350416.273 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=56
2013-09-16T16:53:36.381Z,1379350416.381 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=124
2013-09-16T16:53:36.477Z,1379350416.477 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=32
2013-09-16T16:53:36.585Z,1379350416.585 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2013-09-16T16:53:36.645Z,1379350416.645 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:36.934Z,1379350416.934 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=152
2013-09-16T16:53:37.049Z,1379350417.049 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:37.078Z,1379350417.078 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=92
2013-09-16T16:53:37.214Z,1379350417.214 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=32
2013-09-16T16:53:37.358Z,1379350417.358 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=4
2013-09-16T16:53:37.454Z,1379350417.454 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:37.687Z,1379350417.687 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=124
2013-09-16T16:53:37.807Z,1379350417.807 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=100
2013-09-16T16:53:37.859Z,1379350417.859 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:37.919Z,1379350417.919 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=12
2013-09-16T16:53:38.039Z,1379350418.039 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=4
2013-09-16T16:53:38.263Z,1379350418.263 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:38.552Z,1379350418.552 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=28
2013-09-16T16:53:38.668Z,1379350418.668 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:38.800Z,1379350418.800 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=100
2013-09-16T16:53:39.037Z,1379350419.037 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=108
2013-09-16T16:53:39.073Z,1379350419.073 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:39.273Z,1379350419.273 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=4
2013-09-16T16:53:39.477Z,1379350419.477 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:39.890Z,1379350419.890 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:40.199Z,1379350420.199 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=156
2013-09-16T16:53:40.295Z,1379350420.295 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:40.663Z,1379350420.663 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=37
2013-09-16T16:53:40.699Z,1379350420.699 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:41.104Z,1379350421.104 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:41.136Z,1379350421.136 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=77
2013-09-16T16:53:41.519Z,1379350421.519 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:41.613Z,1379350421.613 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=4
2013-09-16T16:53:41.921Z,1379350421.921 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:42.326Z,1379350422.326 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:42.499Z,1379350422.499 [DVL_micro](DEBUG): NQ1
2013-09-16T16:53:42.730Z,1379350422.730 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:43.135Z,1379350423.135 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:43.344Z,1379350423.344 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=2
2013-09-16T16:53:43.540Z,1379350423.540 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:43.944Z,1379350423.944 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:44.185Z,1379350424.185 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=10
2013-09-16T16:53:44.349Z,1379350424.349 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:44.754Z,1379350424.754 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:45.026Z,1379350425.026 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=18
2013-09-16T16:53:45.158Z,1379350425.158 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:45.563Z,1379350425.563 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:45.868Z,1379350425.868 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=4
2013-09-16T16:53:45.968Z,1379350425.968 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:46.208Z,1379350426.208 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=8
2013-09-16T16:53:46.261Z,1379350426.261 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=28
2013-09-16T16:53:46.328Z,1379350426.328 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=208
2013-09-16T16:53:46.369Z,1379350426.369 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2013-09-16T16:53:46.372Z,1379350426.372 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:46.645Z,1379350426.645 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=24
2013-09-16T16:53:46.761Z,1379350426.761 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=124
2013-09-16T16:53:46.777Z,1379350426.777 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:46.857Z,1379350426.857 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=32
2013-09-16T16:53:46.957Z,1379350426.957 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2013-09-16T16:53:47.105Z,1379350427.105 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=104
2013-09-16T16:53:47.153Z,1379350427.153 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=60
2013-09-16T16:53:47.181Z,1379350427.181 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:47.214Z,1379350427.214 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=80
2013-09-16T16:53:47.262Z,1379350427.262 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2013-09-16T16:53:47.542Z,1379350427.542 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=120
2013-09-16T16:53:47.586Z,1379350427.586 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:47.650Z,1379350427.650 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=124
2013-09-16T16:53:47.747Z,1379350427.747 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=96
2013-09-16T16:53:47.855Z,1379350427.855 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2013-09-16T16:53:47.991Z,1379350427.991 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:48.199Z,1379350428.199 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=56
2013-09-16T16:53:48.343Z,1379350428.343 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=60
2013-09-16T16:53:48.395Z,1379350428.395 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:48.492Z,1379350428.492 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=128
2013-09-16T16:53:48.632Z,1379350428.632 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=4
2013-09-16T16:53:48.800Z,1379350428.800 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:48.948Z,1379350428.948 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=28
2013-09-16T16:53:49.072Z,1379350429.072 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=68
2013-09-16T16:53:49.184Z,1379350429.184 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=12
2013-09-16T16:53:49.204Z,1379350429.204 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:49.297Z,1379350429.297 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=4
2013-09-16T16:53:49.613Z,1379350429.613 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:49.826Z,1379350429.826 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=28
2013-09-16T16:53:50.019Z,1379350430.019 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:50.062Z,1379350430.062 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=36
2013-09-16T16:53:50.310Z,1379350430.310 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=140
2013-09-16T16:53:50.422Z,1379350430.422 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:50.535Z,1379350430.535 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=4
2013-09-16T16:53:50.827Z,1379350430.827 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:51.231Z,1379350431.231 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:51.464Z,1379350431.464 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=124
2013-09-16T16:53:51.636Z,1379350431.636 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:51.933Z,1379350431.933 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=36
2013-09-16T16:53:52.041Z,1379350432.041 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:52.419Z,1379350432.419 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=204
2013-09-16T16:53:52.446Z,1379350432.446 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:52.850Z,1379350432.850 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:52.874Z,1379350432.874 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=4
2013-09-16T16:53:53.255Z,1379350433.255 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:53.659Z,1379350433.659 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:53.760Z,1379350433.760 [DVL_micro](DEBUG): NQ1
2013-09-16T16:53:54.064Z,1379350434.064 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:54.469Z,1379350434.469 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:54.625Z,1379350434.625 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=163
2013-09-16T16:53:54.873Z,1379350434.873 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:55.279Z,1379350435.279 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:55.454Z,1379350435.454 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=44
2013-09-16T16:53:55.659Z,1379350435.659 [CommandLine](IMPORTANT): got command stop
2013-09-16T16:53:55.683Z,1379350435.683 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:55.702Z,1379350435.702 [tank_weight] Stopped
2013-09-16T16:53:55.702Z,1379350435.702 [tank_weight](INFO): Aggregate::uninitialize tank_weight
2013-09-16T16:53:55.703Z,1379350435.703 [tank_weight:A.AltitudeEnvelope] Stopped
2013-09-16T16:53:55.703Z,1379350435.703 [tank_weight:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2013-09-16T16:53:55.703Z,1379350435.703 [tank_weight:B.DepthEnvelope] Stopped
2013-09-16T16:53:55.703Z,1379350435.703 [tank_weight:B.DepthEnvelope](DEBUG): Uninitialize.
2013-09-16T16:53:55.703Z,1379350435.703 [tank_weight:Science] Stopped
2013-09-16T16:53:55.703Z,1379350435.703 [tank_weight:Science](INFO): Aggregate::uninitialize tank_weight:Science
2013-09-16T16:53:55.703Z,1379350435.703 [tank_weight:Science:A] Stopped
2013-09-16T16:53:55.703Z,1379350435.703 [tank_weight:Science:B] Stopped
2013-09-16T16:53:55.703Z,1379350435.703 [tank_weight:Science:C] Stopped
2013-09-16T16:53:55.703Z,1379350435.703 [tank_weight:Science:D] Stopped
2013-09-16T16:53:55.703Z,1379350435.703 [tank_weight:Science:E] Stopped
2013-09-16T16:53:55.703Z,1379350435.703 [tank_weight:Science:F] Stopped
2013-09-16T16:53:55.703Z,1379350435.703 [tank_weight:Science:G] Stopped
2013-09-16T16:53:55.703Z,1379350435.703 [tank_weight:Science:H] Stopped
2013-09-16T16:53:55.703Z,1379350435.703 [tank_weight:Science:I] Stopped
2013-09-16T16:53:55.704Z,1379350435.704 [tank_weight:D] Stopped
2013-09-16T16:53:55.704Z,1379350435.704 [tank_weight:D](INFO): Aggregate::uninitialize tank_weight:D
2013-09-16T16:53:55.704Z,1379350435.704 [tank_weight:D:A.SetSpeed] Stopped
2013-09-16T16:53:55.704Z,1379350435.704 [tank_weight:D:A.SetSpeed](DEBUG): Uninitialize.
2013-09-16T16:53:55.704Z,1379350435.704 [tank_weight:D:BuoyancyLo] Stopped
2013-09-16T16:53:55.704Z,1379350435.704 [tank_weight:D:BuoyancyLo](INFO): Aggregate::uninitialize tank_weight:D:BuoyancyLo
2013-09-16T16:53:55.704Z,1379350435.704 [tank_weight:D:BuoyancyLo:A.Buoyancy] Stopped
2013-09-16T16:53:55.704Z,1379350435.704 [tank_weight:D:BuoyancyLo:A.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2013-09-16T16:53:55.704Z,1379350435.704 [tank_weight:D:BuoyancyLo:B.Pitch] Stopped
2013-09-16T16:53:55.704Z,1379350435.704 [tank_weight:D:BuoyancyLo:C.Wait] Stopped
2013-09-16T16:53:55.704Z,1379350435.704 [tank_weight:D:BuoyancyLo:C.Wait](DEBUG): Uninitialize Wait Component.
2013-09-16T16:53:55.883Z,1379350435.883 [WetLabsBB2FL](INFO): Powering down
2013-09-16T16:53:56.087Z,1379350436.087 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:53:56.091Z,1379350436.091 [MissionManager](IMPORTANT): Started mission Default
2013-09-16T16:53:56.091Z,1379350436.091 [Default] Running Loop=1
2013-09-16T16:53:56.091Z,1379350436.091 [Default](INFO): Aggregate::initialize Default
2013-09-16T16:53:56.091Z,1379350436.091 [Default:D.SetSpeed] Running Loop=1
2013-09-16T16:53:56.091Z,1379350436.091 [Default:D.SetSpeed](DEBUG): Initialize.
2013-09-16T16:53:56.091Z,1379350436.091 [Default:E.GoToSurface] Running Loop=1
2013-09-16T16:53:56.092Z,1379350436.092 [Default:E.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-09-16T16:53:56.092Z,1379350436.092 [Default:Iridium] Running Loop=1
2013-09-16T16:53:56.092Z,1379350436.092 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2013-09-16T16:53:56.092Z,1379350436.092 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-09-16T16:53:56.092Z,1379350436.092 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2013-09-16T16:53:56.092Z,1379350436.092 [Default:Iridium:B.GoToSurface] Running Loop=1
2013-09-16T16:53:56.092Z,1379350436.092 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-09-16T16:53:56.094Z,1379350436.094 [Default:Iridium:B.GoToSurface] Stopped
2013-09-16T16:53:56.094Z,1379350436.094 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-09-16T16:53:56.095Z,1379350436.095 [Default:Iridium:Read_Iridium] Running Loop=1
2013-09-16T16:53:56.096Z,1379350436.096 [Default:GPS] Running Loop=1
2013-09-16T16:53:56.096Z,1379350436.096 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2013-09-16T16:53:56.096Z,1379350436.096 [Default:GPS:A.SetSpeed] Running Loop=1
2013-09-16T16:53:56.096Z,1379350436.096 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2013-09-16T16:53:56.096Z,1379350436.096 [Default:GPS:B.GoToSurface] Running Loop=1
2013-09-16T16:53:56.096Z,1379350436.096 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-09-16T16:53:56.097Z,1379350436.097 [Default:GPS:B.GoToSurface] Stopped
2013-09-16T16:53:56.097Z,1379350436.097 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-09-16T16:53:56.097Z,1379350436.097 [Default:GPS:Read_GPS] Running Loop=1
2013-09-16T16:53:56.304Z,1379350436.304 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=212
2013-09-16T16:53:56.869Z,1379350436.869 [NAL9602](INFO): Powering up
2013-09-16T16:53:57.129Z,1379350437.129 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=4
2013-09-16T16:53:57.254Z,1379350437.254 [DVL_micro](INFO): pause:Powering down
2013-09-16T16:53:58.042Z,1379350438.042 [CommandLine](IMPORTANT): got command show variable CTD
2013-09-16T16:53:58.050Z,1379350438.050 [CommandLine](INFO): CTD_NeilBrown.loadControl (none)
2013-09-16T16:53:58.051Z,1379350438.051 [CommandLine](INFO): CTD_NeilBrown.uart (none)
2013-09-16T16:53:58.051Z,1379350438.051 [CommandLine](INFO): CTD_NeilBrown.baud (bit_per_second)
2013-09-16T16:53:58.060Z,1379350438.060 [CommandLine](INFO): CTD_NeilBrown.loadAtStartup (bool)
2013-09-16T16:53:58.060Z,1379350438.060 [CommandLine](INFO): CTD_NeilBrown.simulateHardware (bool)
2013-09-16T16:53:58.061Z,1379350438.061 [CommandLine](INFO): CTD_NeilBrown.power (watt)
2013-09-16T16:53:58.061Z,1379350438.061 [CommandLine](INFO): CTD_NeilBrown.maxPressBound (decibar)
2013-09-16T16:53:58.061Z,1379350438.061 [CommandLine](INFO): CTD_NeilBrown.minPressBound (decibar)
2013-09-16T16:53:58.070Z,1379350438.070 [CommandLine](INFO): CTD_NeilBrown.offset (decibar)
2013-09-16T16:53:58.070Z,1379350438.070 [CommandLine](INFO): CTD_NeilBrown.maxSalinityBound (practical_salinity_unit)
2013-09-16T16:53:58.071Z,1379350438.071 [CommandLine](INFO): CTD_NeilBrown.minSalinityBound (practical_salinity_unit)
2013-09-16T16:53:58.142Z,1379350438.142 [CommandLine](INFO): CTD_NeilBrown.sea_water_density (kilogram_per_cubic_meter)
2013-09-16T16:53:58.143Z,1379350438.143 [CommandLine](INFO): CTD_NeilBrown.depth (meter)
2013-09-16T16:53:58.143Z,1379350438.143 [CommandLine](INFO): CTD_NeilBrown.sea_water_pressure (decibar)
2013-09-16T16:53:58.143Z,1379350438.143 [CommandLine](INFO): CTD_NeilBrown.sea_water_salinity (practical_salinity_unit)
2013-09-16T16:53:58.144Z,1379350438.144 [CommandLine](INFO): CTD_NeilBrown.sea_water_temperature (celsius)
2013-09-16T16:53:58.144Z,1379350438.144 [CommandLine](INFO): CTD_NeilBrown.sea_water_electrical_conductivity (millimho_per_centimeter)
2013-09-16T16:53:58.146Z,1379350438.146 [CommandLine](INFO): CTD_NeilBrown.durationOfLastRun (second)
2013-09-16T16:54:07.702Z,1379350447.702 [NAL9602](INFO): NAL9602 initialized
2013-09-16T16:54:09.837Z,1379350449.837 [CommandLine](IMPORTANT): got command report touch CTD_NeilBrown.sea_water_temperature
2013-09-16T16:54:15.081Z,1379350455.081 [CommandLine](IMPORTANT): got command run ./Missions/Maintenance/tank_weight.xml
2013-09-16T16:54:15.081Z,1379350455.081 [MissionManager](INFO): Loading Mission: ./Missions/Maintenance/tank_weight.xml
2013-09-16T16:54:15.129Z,1379350455.129 [MissionManager](INFO): DefineArg tank_weight.BuoyancyLimitHiCC = 0.000955 n/a
2013-09-16T16:54:15.131Z,1379350455.131 [MissionManager](INFO): DefineArg tank_weight.BuoyancyLimitLoCC = 0.000080 n/a
2013-09-16T16:54:15.134Z,1379350455.134 [tank_weight:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2013-09-16T16:54:15.139Z,1379350455.139 [tank_weight:B.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2013-09-16T16:54:15.146Z,1379350455.146 [MissionManager](INFO): Inserting Stack: Missions/Insert/Science.xml
2013-09-16T16:54:15.258Z,1379350455.258 [MissionManager](INFO): DefineArg tank_weight:Science.SampleISUS = 0 bool
2013-09-16T16:54:15.260Z,1379350455.260 [MissionManager](INFO): DefineArg tank_weight:Science.SampleISUSmaxPitch = 60.000000 arcdeg
2013-09-16T16:54:15.263Z,1379350455.263 [MissionManager](INFO): DefineArg tank_weight:Science.SampleISUSminPitch = -60.000000 arcdeg
2013-09-16T16:54:15.265Z,1379350455.265 [MissionManager](INFO): DefineArg tank_weight:Science.SampleRSSI = 1 bool
2013-09-16T16:54:15.267Z,1379350455.267 [MissionManager](INFO): DefineArg tank_weight:Science.SampleADCP = 0 bool
2013-09-16T16:54:15.269Z,1379350455.269 [MissionManager](INFO): DefineArg tank_weight:Science.PeakDetectChlActive = 0 bool
2013-09-16T16:54:15.271Z,1379350455.271 [MissionManager](INFO): DefineArg tank_weight:Science.PeakDetectNO3Active = 0 bool
2013-09-16T16:54:15.273Z,1379350455.273 [MissionManager](INFO): DefineArg tank_weight:Science.PeakDetectRSSIActive = 0 bool
2013-09-16T16:54:15.275Z,1379350455.275 [MissionManager](INFO): DefineArg tank_weight:Science.UpwardDerivativeOfTemperatureActive = 0 bool
2013-09-16T16:54:15.277Z,1379350455.277 [MissionManager](INFO): DefineArg tank_weight:Science.ComputeWaterCurrent = 0 bool
2013-09-16T16:54:15.279Z,1379350455.279 [MissionManager](INFO): DefineArg tank_weight:Science.ComputeWaterCurrentMinDepth = 2.000000 m
2013-09-16T16:54:15.281Z,1379350455.281 [MissionManager](INFO): DefineArg tank_weight:Science.ComputeWaterCurrentMaxDepth = 5.000000 m
2013-09-16T16:54:15.284Z,1379350455.284 [MissionManager](INFO): DefineArg tank_weight:Science.EnabledAanderaaO2 = 0.000000 n/a
2013-09-16T16:54:15.287Z,1379350455.287 [MissionManager](INFO): DefineArg tank_weight:Science.EnabledNeilBrown = 1.000000 n/a
2013-09-16T16:54:15.289Z,1379350455.289 [MissionManager](INFO): DefineArg tank_weight:Science.EnabledTurbulence_NPS = 0.000000 n/a
2013-09-16T16:54:15.291Z,1379350455.291 [MissionManager](INFO): DefineArg tank_weight:Science.EnabledWetLabsBB2FL = 1.000000 n/a
2013-09-16T16:54:15.294Z,1379350455.294 [MissionManager](INFO): DefineArg tank_weight:Science.EnabledDVL = 1.000000 n/a
2013-09-16T16:54:15.297Z,1379350455.297 [MissionManager](INFO): DefineArg tank_weight:Science.EnabledISUS = 0.000000 n/a
2013-09-16T16:54:15.299Z,1379350455.299 [MissionManager](INFO): DefineOutput tank_weight:Science.PeakChl = 0.000000 ug/l
2013-09-16T16:54:15.302Z,1379350455.302 [MissionManager](INFO): DefineOutput tank_weight:Science.PeakChlDepth = 0.000000 m
2013-09-16T16:54:15.304Z,1379350455.304 [MissionManager](INFO): DefineOutput tank_weight:Science.PeakChlLatitude = nan arcdeg
2013-09-16T16:54:15.306Z,1379350455.306 [MissionManager](INFO): DefineOutput tank_weight:Science.PeakChlLongitude = nan arcdeg
2013-09-16T16:54:15.345Z,1379350455.345 [MissionManager](INFO): DefineOutput tank_weight:Science.PeakNO3 = 0.000000 umol/l
2013-09-16T16:54:15.347Z,1379350455.347 [MissionManager](INFO): DefineOutput tank_weight:Science.PeakNO3Depth = 0.000000 m
2013-09-16T16:54:15.350Z,1379350455.350 [MissionManager](INFO): DefineOutput tank_weight:Science.PeakNO3Latitude = nan arcdeg
2013-09-16T16:54:15.360Z,1379350455.360 [MissionManager](INFO): DefineOutput tank_weight:Science.PeakNO3Longitude = nan arcdeg
2013-09-16T16:54:15.363Z,1379350455.363 [MissionManager](INFO): DefineOutput tank_weight:Science.PeakRSSI = 0.000000 dB
2013-09-16T16:54:15.366Z,1379350455.366 [MissionManager](INFO): DefineOutput tank_weight:Science.PeakRSSIDepth = 0.000000 m
2013-09-16T16:54:15.369Z,1379350455.369 [MissionManager](INFO): DefineOutput tank_weight:Science.PeakRSSILatitude = nan arcdeg
2013-09-16T16:54:15.371Z,1379350455.371 [MissionManager](INFO): DefineOutput tank_weight:Science.PeakRSSILongitude = nan arcdeg
2013-09-16T16:54:15.389Z,1379350455.389 [tank_weight:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2013-09-16T16:54:15.397Z,1379350455.397 [tank_weight:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2013-09-16T16:54:15.405Z,1379350455.405 [tank_weight:Science:PeakDetectRSSI:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2013-09-16T16:54:15.432Z,1379350455.432 [MissionManager](INFO): RedefineArg tank_weight:Science.SampleISUS = 1 bool
2013-09-16T16:54:15.434Z,1379350455.434 [tank_weight:D:A.SetSpeed](DEBUG): Construct.
2013-09-16T16:54:15.440Z,1379350455.440 [tank_weight:D:BuoyancyLo:A.Buoyancy](DEBUG): Construct Buoyancy.
2013-09-16T16:54:15.451Z,1379350455.451 [tank_weight:D:BuoyancyLo:B.Pitch](DEBUG): Construct.
2013-09-16T16:54:15.462Z,1379350455.462 [tank_weight:D:BuoyancyLo:C.Wait](DEBUG): Construct Wait.
2013-09-16T16:54:15.464Z,1379350455.464 [tank_weight:D:BuoyancyHi:A.Buoyancy](DEBUG): Construct Buoyancy.
2013-09-16T16:54:15.467Z,1379350455.467 [tank_weight:D:BuoyancyHi:B.Pitch](DEBUG): Construct.
2013-09-16T16:54:15.472Z,1379350455.472 [tank_weight:D:BuoyancyHi:C.Wait](DEBUG): Construct Wait.
2013-09-16T16:54:15.483Z,1379350455.483 [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/Units http://aosn.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://aosn.mbari.org/tethys/Xml/Universal.xsd"
       Id="tank_weight">

    <DefineArg Name="BuoyancyLimitHiCC"><Control:VerticalControl.buoyancyLimitHiCC/></DefineArg>

    <DefineArg Name="BuoyancyLimitLoCC"><Control:VerticalControl.buoyancyLimitLoCC/></DefineArg>

    <Timeout Duration="P75M"/>

    <Guidance:AltitudeEnvelope RunIn="Parallel">
        <Setting><Guidance:AltitudeEnvelope.minAltitude/><Units:meter/><Value>0</Value></Setting>
    </Guidance:AltitudeEnvelope>

    <Guidance:DepthEnvelope RunIn="Parallel">
        <Setting><Guidance:DepthEnvelope.minDepth/><Units:meter/><Value>0</Value></Setting>
        <Setting><Guidance:DepthEnvelope.maxDepth/><Units:meter/><Value>15</Value></Setting>
    </Guidance:DepthEnvelope>

    <Insert Filename="Insert/Science.xml">
        <RedefineArg Name="SampleISUS"><True/></RedefineArg>
    </Insert>

    <Aggregate>

        <Guidance:SetSpeed RunIn="Parallel">
            <Setting><Guidance:SetSpeed.speed/><Units:meter_per_second/><Value>0</Value></Setting>
        </Guidance:SetSpeed>

        <Aggregate Id="BuoyancyLo">

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

            <Guidance:Pitch RunIn="Parallel">
                <Setting><Guidance:Pitch.massPosition/><Units:meter/><Value>0</Value></Setting>
                <Setting><Guidance:Pitch.depth/><Units:meter/><Value>15</Value></Setting>
            </Guidance:Pitch>

            <Guidance:Wait RunIn="Sequence">
                <Setting><Guidance:Wait.duration/><Units:minute/><Value>65</Value></Setting>
            </Guidance:Wait>

        </Aggregate>

        <Aggregate Id="BuoyancyHi">

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

            <Guidance:Pitch RunIn="Parallel">
                <Setting><Guidance:Pitch.massPosition/><Units:meter/><Value>0</Value></Setting>
                <Setting><Guidance:Pitch.depth/><Units:meter/><Value>15</Value></Setting>
            </Guidance:Pitch>

            <Guidance:Wait RunIn="Sequence">
                <Setting><Guidance:Wait.duration/><Units:minute/><Value>5</Value></Setting>
            </Guidance:Wait>

        </Aggregate>

    </Aggregate>

</Mission>


2013-09-16T16:54:15.529Z,1379350455.529 [CommandLine](IMPORTANT): Running ./Missions/Maintenance/tank_weight.xml
2013-09-16T16:54:15.726Z,1379350455.726 [Default] Stopped
2013-09-16T16:54:15.726Z,1379350455.726 [Default](INFO): Aggregate::uninitialize Default
2013-09-16T16:54:15.726Z,1379350455.726 [Default:GPS] Stopped
2013-09-16T16:54:15.727Z,1379350455.727 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2013-09-16T16:54:15.727Z,1379350455.727 [Default:GPS:A.SetSpeed] Stopped
2013-09-16T16:54:15.727Z,1379350455.727 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2013-09-16T16:54:15.727Z,1379350455.727 [Default:GPS:Read_GPS] Stopped
2013-09-16T16:54:15.727Z,1379350455.727 [Default:Iridium] Stopped
2013-09-16T16:54:15.727Z,1379350455.727 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2013-09-16T16:54:15.727Z,1379350455.727 [Default:Iridium:A.SetSpeed] Stopped
2013-09-16T16:54:15.727Z,1379350455.727 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2013-09-16T16:54:15.727Z,1379350455.727 [Default:Iridium:Read_Iridium] Stopped
2013-09-16T16:54:15.727Z,1379350455.727 [Default:D.SetSpeed] Stopped
2013-09-16T16:54:15.727Z,1379350455.727 [Default:D.SetSpeed](DEBUG): Uninitialize.
2013-09-16T16:54:15.727Z,1379350455.727 [Default:E.GoToSurface] Stopped
2013-09-16T16:54:15.727Z,1379350455.727 [Default:E.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-09-16T16:54:15.728Z,1379350455.728 [MissionManager](IMPORTANT): Started mission tank_weight
2013-09-16T16:54:15.728Z,1379350455.728 [tank_weight] Running Loop=1
2013-09-16T16:54:15.728Z,1379350455.728 [tank_weight](INFO): Aggregate::initialize tank_weight
2013-09-16T16:54:15.728Z,1379350455.728 [tank_weight:A.AltitudeEnvelope] Running Loop=1
2013-09-16T16:54:15.728Z,1379350455.728 [tank_weight:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2013-09-16T16:54:15.728Z,1379350455.728 [tank_weight:B.DepthEnvelope] Running Loop=1
2013-09-16T16:54:15.728Z,1379350455.728 [tank_weight:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2013-09-16T16:54:15.729Z,1379350455.729 [tank_weight:Science] Running Loop=1
2013-09-16T16:54:15.729Z,1379350455.729 [tank_weight:Science](INFO): Aggregate::initialize tank_weight:Science
2013-09-16T16:54:15.729Z,1379350455.729 [tank_weight:Science:A] Running Loop=1
2013-09-16T16:54:15.730Z,1379350455.730 [tank_weight:Science:B] Running Loop=1
2013-09-16T16:54:15.730Z,1379350455.730 [tank_weight:Science:C] Running Loop=1
2013-09-16T16:54:15.730Z,1379350455.730 [tank_weight:Science:D] Running Loop=1
2013-09-16T16:54:15.730Z,1379350455.730 [tank_weight:Science:E] Running Loop=1
2013-09-16T16:54:15.730Z,1379350455.730 [tank_weight:Science:F] Running Loop=1
2013-09-16T16:54:15.730Z,1379350455.730 [tank_weight:Science:G] Running Loop=1
2013-09-16T16:54:15.730Z,1379350455.730 [tank_weight:Science:H] Running Loop=1
2013-09-16T16:54:15.730Z,1379350455.730 [tank_weight:Science:I] Running Loop=1
2013-09-16T16:54:15.730Z,1379350455.730 [tank_weight:D] Running Loop=1
2013-09-16T16:54:15.730Z,1379350455.730 [tank_weight:D](INFO): Aggregate::initialize tank_weight:D
2013-09-16T16:54:15.730Z,1379350455.730 [tank_weight:D:A.SetSpeed] Running Loop=1
2013-09-16T16:54:15.730Z,1379350455.730 [tank_weight:D:A.SetSpeed](DEBUG): Initialize.
2013-09-16T16:54:15.731Z,1379350455.731 [tank_weight:D:BuoyancyLo] Running Loop=1
2013-09-16T16:54:15.731Z,1379350455.731 [tank_weight:D:BuoyancyLo](INFO): Aggregate::initialize tank_weight:D:BuoyancyLo
2013-09-16T16:54:15.731Z,1379350455.731 [tank_weight:D:BuoyancyLo:A.Buoyancy] Running Loop=1
2013-09-16T16:54:15.731Z,1379350455.731 [tank_weight:D:BuoyancyLo:A.Buoyancy](DEBUG): Initialize Buoyancy Component.
2013-09-16T16:54:15.731Z,1379350455.731 [tank_weight:D:BuoyancyLo:B.Pitch] Running Loop=1
2013-09-16T16:54:15.731Z,1379350455.731 [tank_weight:D:BuoyancyLo:B.Pitch](DEBUG): Initialize.
2013-09-16T16:54:15.731Z,1379350455.731 [tank_weight:D:BuoyancyLo:C.Wait] Running Loop=1
2013-09-16T16:54:15.731Z,1379350455.731 [tank_weight:D:BuoyancyLo:C.Wait](DEBUG): Initialize Wait Component.
2013-09-16T16:54:15.733Z,1379350455.733 [tank_weight:D:BuoyancyLo:B.Pitch] Running Loop=1
2013-09-16T16:54:15.734Z,1379350455.734 [DVL_micro](INFO): RSSI unrequested
2013-09-16T16:54:15.734Z,1379350455.734 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-16T16:54:15.735Z,1379350455.735 [DVL_micro](INFO): resume:Powering up
2013-09-16T16:54:15.735Z,1379350455.735 [DVL_micro](INFO): Cycling power to configure device.
2013-09-16T16:54:15.737Z,1379350455.737 [tank_weight:D:BuoyancyLo:A.Buoyancy] Running Loop=1
2013-09-16T16:54:15.738Z,1379350455.738 [tank_weight:D:A.SetSpeed] Running Loop=1
2013-09-16T16:54:15.739Z,1379350455.739 [tank_weight:Science] Running Loop=1
2013-09-16T16:54:15.740Z,1379350455.740 [tank_weight:Science:I] Running Loop=1
2013-09-16T16:54:15.740Z,1379350455.740 [tank_weight:Science:I](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2013-09-16T16:54:15.741Z,1379350455.741 [tank_weight:Science:H] Running Loop=1
2013-09-16T16:54:15.742Z,1379350455.742 [tank_weight:Science:H](DEBUG): Initialize ReadDataComponent to sense DVL_micro.Beam1RSSI
2013-09-16T16:54:15.743Z,1379350455.743 [tank_weight:Science:D] Running Loop=1
2013-09-16T16:54:15.743Z,1379350455.743 [tank_weight:Science:D](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature
2013-09-16T16:54:15.744Z,1379350455.744 [tank_weight:Science:D](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity
2013-09-16T16:54:15.745Z,1379350455.745 [tank_weight:B.DepthEnvelope] Running Loop=1
2013-09-16T16:54:15.746Z,1379350455.746 [tank_weight:A.AltitudeEnvelope] Running Loop=1
2013-09-16T16:54:15.946Z,1379350455.946 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=4
2013-09-16T16:54:15.946Z,1379350455.946 [WetLabsBB2FL](INFO): Powering up
2013-09-16T16:54:16.170Z,1379350456.170 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:16.575Z,1379350456.575 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:16.979Z,1379350456.979 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:17.384Z,1379350457.384 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:17.741Z,1379350457.741 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-09-16T16:54:17.741Z,1379350457.741 [DVL_micro](INFO): Querying output modes
2013-09-16T16:54:17.741Z,1379350457.741 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-09-16T16:54:17.753Z,1379350457.753 [DVL_micro](DEBUG): cmdResponse: 01 16
2013-09-16T16:54:17.753Z,1379350457.753 [DVL_micro](INFO): NQ1 output enabled
2013-09-16T16:54:17.753Z,1379350457.753 [DVL_micro](INFO): RSSI output enabled
2013-09-16T16:54:17.753Z,1379350457.753 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-09-16T16:54:17.777Z,1379350457.777 [DVL_micro](DEBUG): cmdResponse: AUTO_VEL_ON 
2013-09-16T16:54:17.789Z,1379350457.789 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:18.085Z,1379350458.085 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=1864
2013-09-16T16:54:18.085Z,1379350458.085 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=1244
2013-09-16T16:54:18.086Z,1379350458.086 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=624
2013-09-16T16:54:18.087Z,1379350458.087 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2013-09-16T16:54:18.193Z,1379350458.193 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:18.344Z,1379350458.344 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=24
2013-09-16T16:54:18.446Z,1379350458.446 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=92
2013-09-16T16:54:18.554Z,1379350458.554 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=96
2013-09-16T16:54:18.598Z,1379350458.598 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:18.658Z,1379350458.658 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2013-09-16T16:54:18.791Z,1379350458.791 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=104
2013-09-16T16:54:18.839Z,1379350458.839 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=60
2013-09-16T16:54:18.899Z,1379350458.899 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=80
2013-09-16T16:54:18.955Z,1379350458.955 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2013-09-16T16:54:19.003Z,1379350459.003 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:19.231Z,1379350459.231 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=88
2013-09-16T16:54:19.340Z,1379350459.340 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=92
2013-09-16T16:54:19.407Z,1379350459.407 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:19.443Z,1379350459.443 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=128
2013-09-16T16:54:19.544Z,1379350459.544 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2013-09-16T16:54:19.812Z,1379350459.812 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:19.897Z,1379350459.897 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=216
2013-09-16T16:54:20.028Z,1379350460.028 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=60
2013-09-16T16:54:20.177Z,1379350460.177 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=0
2013-09-16T16:54:20.216Z,1379350460.216 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:20.325Z,1379350460.325 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=4
2013-09-16T16:54:20.621Z,1379350460.621 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:20.649Z,1379350460.649 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=124
2013-09-16T16:54:20.758Z,1379350460.758 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=68
2013-09-16T16:54:20.874Z,1379350460.874 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=44
2013-09-16T16:54:20.990Z,1379350460.990 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=4
2013-09-16T16:54:21.026Z,1379350461.026 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:21.431Z,1379350461.431 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:21.527Z,1379350461.527 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=188
2013-09-16T16:54:21.551Z,1379350461.551 [NAL9602](INFO): Powering down
2013-09-16T16:54:21.747Z,1379350461.747 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=4
2013-09-16T16:54:21.835Z,1379350461.835 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:21.988Z,1379350461.988 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=76
2013-09-16T16:54:22.221Z,1379350462.221 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=4
2013-09-16T16:54:22.240Z,1379350462.240 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:22.644Z,1379350462.644 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:23.049Z,1379350463.049 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:23.150Z,1379350463.150 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=92
2013-09-16T16:54:23.454Z,1379350463.454 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:23.634Z,1379350463.634 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=228
2013-09-16T16:54:23.858Z,1379350463.858 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:24.095Z,1379350464.095 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=12
2013-09-16T16:54:24.263Z,1379350464.263 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:24.575Z,1379350464.575 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=4
2013-09-16T16:54:24.668Z,1379350464.668 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:25.072Z,1379350465.072 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:25.453Z,1379350465.453 [DVL_micro](DEBUG): NQ1
2013-09-16T16:54:25.477Z,1379350465.477 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:25.881Z,1379350465.881 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:26.062Z,1379350466.062 [CommandLine](IMPORTANT): got command report
2013-09-16T16:54:26.062Z,1379350466.062 [Reporter](INFO): CTD_NeilBrown.sea_water_temperature reporting when touched
2013-09-16T16:54:26.288Z,1379350466.288 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:26.302Z,1379350466.302 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=10
2013-09-16T16:54:26.690Z,1379350466.690 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:27.095Z,1379350467.095 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:27.152Z,1379350467.152 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=178
2013-09-16T16:54:27.500Z,1379350467.500 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:27.904Z,1379350467.904 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:27.985Z,1379350467.985 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=123
2013-09-16T16:54:28.313Z,1379350468.313 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:28.718Z,1379350468.718 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:28.830Z,1379350468.830 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=4
2013-09-16T16:54:29.122Z,1379350469.122 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:29.179Z,1379350469.179 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=40
2013-09-16T16:54:29.231Z,1379350469.231 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=28
2013-09-16T16:54:29.291Z,1379350469.291 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=48
2013-09-16T16:54:29.347Z,1379350469.347 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2013-09-16T16:54:29.527Z,1379350469.527 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:29.631Z,1379350469.631 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=184
2013-09-16T16:54:29.727Z,1379350469.727 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=60
2013-09-16T16:54:29.832Z,1379350469.832 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=96
2013-09-16T16:54:29.931Z,1379350469.931 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:29.940Z,1379350469.940 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2013-09-16T16:54:30.068Z,1379350470.068 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=40
2013-09-16T16:54:30.122Z,1379350470.122 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=60
2013-09-16T16:54:30.172Z,1379350470.172 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=48
2013-09-16T16:54:30.236Z,1379350470.236 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2013-09-16T16:54:30.336Z,1379350470.336 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:30.513Z,1379350470.513 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=24
2013-09-16T16:54:30.619Z,1379350470.619 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=124
2013-09-16T16:54:30.718Z,1379350470.718 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=32
2013-09-16T16:54:30.741Z,1379350470.741 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:30.823Z,1379350470.823 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2013-09-16T16:54:31.145Z,1379350471.145 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:31.162Z,1379350471.162 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=24
2013-09-16T16:54:31.319Z,1379350471.319 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=92
2013-09-16T16:54:31.454Z,1379350471.454 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=0
2013-09-16T16:54:31.550Z,1379350471.550 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:31.602Z,1379350471.602 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=4
2013-09-16T16:54:31.927Z,1379350471.927 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=124
2013-09-16T16:54:31.955Z,1379350471.955 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:32.035Z,1379350472.035 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=36
2013-09-16T16:54:32.155Z,1379350472.155 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=76
2013-09-16T16:54:32.280Z,1379350472.280 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=4
2013-09-16T16:54:32.359Z,1379350472.359 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:32.764Z,1379350472.764 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:32.792Z,1379350472.792 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=28
2013-09-16T16:54:33.040Z,1379350473.040 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=100
2013-09-16T16:54:33.169Z,1379350473.169 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:33.270Z,1379350473.270 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=12
2013-09-16T16:54:33.505Z,1379350473.505 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=4
2013-09-16T16:54:33.573Z,1379350473.573 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:33.978Z,1379350473.978 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:34.383Z,1379350474.383 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:34.431Z,1379350474.431 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=60
2013-09-16T16:54:34.787Z,1379350474.787 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:34.907Z,1379350474.907 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=36
2013-09-16T16:54:35.192Z,1379350475.192 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:35.388Z,1379350475.388 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=113
2013-09-16T16:54:35.597Z,1379350475.597 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:35.853Z,1379350475.853 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=4
2013-09-16T16:54:36.001Z,1379350476.001 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:36.406Z,1379350476.406 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:36.730Z,1379350476.730 [DVL_micro](DEBUG): NQ1
2013-09-16T16:54:36.826Z,1379350476.826 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:37.231Z,1379350477.231 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:37.580Z,1379350477.580 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=14
2013-09-16T16:54:37.636Z,1379350477.636 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:38.040Z,1379350478.040 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:38.430Z,1379350478.430 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=118
2013-09-16T16:54:38.445Z,1379350478.445 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:38.849Z,1379350478.849 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:39.254Z,1379350479.254 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:39.262Z,1379350479.262 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=62
2013-09-16T16:54:39.659Z,1379350479.659 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:40.063Z,1379350480.063 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:40.108Z,1379350480.108 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=4
2013-09-16T16:54:40.420Z,1379350480.420 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=8
2013-09-16T16:54:40.468Z,1379350480.468 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:40.480Z,1379350480.480 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=28
2013-09-16T16:54:40.540Z,1379350480.540 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=112
2013-09-16T16:54:40.588Z,1379350480.588 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2013-09-16T16:54:40.865Z,1379350480.865 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=30
2013-09-16T16:54:40.872Z,1379350480.872 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:40.969Z,1379350480.969 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=3
2013-09-16T16:54:41.069Z,1379350481.069 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=7
2013-09-16T16:54:41.177Z,1379350481.177 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2013-09-16T16:54:41.277Z,1379350481.277 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:41.314Z,1379350481.314 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=8
2013-09-16T16:54:41.378Z,1379350481.378 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=124
2013-09-16T16:54:41.429Z,1379350481.429 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=144
2013-09-16T16:54:41.478Z,1379350481.478 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2013-09-16T16:54:41.682Z,1379350481.682 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:41.762Z,1379350481.762 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=120
2013-09-16T16:54:41.866Z,1379350481.866 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=156
2013-09-16T16:54:41.955Z,1379350481.955 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=32
2013-09-16T16:54:42.062Z,1379350482.062 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2013-09-16T16:54:42.086Z,1379350482.086 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:42.411Z,1379350482.411 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=24
2013-09-16T16:54:42.491Z,1379350482.491 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:42.576Z,1379350482.576 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=220
2013-09-16T16:54:42.703Z,1379350482.703 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=64
2013-09-16T16:54:42.840Z,1379350482.840 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=4
2013-09-16T16:54:42.896Z,1379350482.896 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:43.165Z,1379350483.165 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=60
2013-09-16T16:54:43.277Z,1379350483.277 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=5
2013-09-16T16:54:43.300Z,1379350483.300 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:43.397Z,1379350483.397 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=13
2013-09-16T16:54:43.513Z,1379350483.513 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=4
2013-09-16T16:54:43.705Z,1379350483.705 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:44.062Z,1379350484.062 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=316
2013-09-16T16:54:44.110Z,1379350484.110 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:44.274Z,1379350484.274 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=4
2013-09-16T16:54:44.514Z,1379350484.514 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:44.518Z,1379350484.518 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=108
2013-09-16T16:54:44.751Z,1379350484.751 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=4
2013-09-16T16:54:44.919Z,1379350484.919 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:45.323Z,1379350485.323 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:45.668Z,1379350485.668 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=60
2013-09-16T16:54:45.728Z,1379350485.728 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:46.133Z,1379350486.133 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:46.153Z,1379350486.153 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=164
2013-09-16T16:54:46.537Z,1379350486.537 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:46.626Z,1379350486.626 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=120
2013-09-16T16:54:46.942Z,1379350486.942 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:47.098Z,1379350487.098 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=4
2013-09-16T16:54:47.347Z,1379350487.347 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:47.751Z,1379350487.751 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:47.976Z,1379350487.976 [DVL_micro](DEBUG): NQ1
2013-09-16T16:54:48.156Z,1379350488.156 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:48.564Z,1379350488.564 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:48.837Z,1379350488.837 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=36
2013-09-16T16:54:48.969Z,1379350488.969 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:49.374Z,1379350489.374 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:49.666Z,1379350489.666 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=76
2013-09-16T16:54:49.779Z,1379350489.779 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:50.183Z,1379350490.183 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:50.516Z,1379350490.516 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=148
2013-09-16T16:54:50.588Z,1379350490.588 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:50.992Z,1379350490.992 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:51.349Z,1379350491.349 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=4
2013-09-16T16:54:51.397Z,1379350491.397 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:51.778Z,1379350491.778 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=8
2013-09-16T16:54:51.801Z,1379350491.801 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:51.838Z,1379350491.838 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=124
2013-09-16T16:54:51.890Z,1379350491.890 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=80
2013-09-16T16:54:51.938Z,1379350491.938 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2013-09-16T16:54:52.206Z,1379350492.206 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:52.222Z,1379350492.222 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=88
2013-09-16T16:54:52.330Z,1379350492.330 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=156
2013-09-16T16:54:52.427Z,1379350492.427 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=64
2013-09-16T16:54:52.527Z,1379350492.527 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2013-09-16T16:54:52.611Z,1379350492.611 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:52.663Z,1379350492.663 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=72
2013-09-16T16:54:52.715Z,1379350492.715 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=28
2013-09-16T16:54:52.775Z,1379350492.775 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=112
2013-09-16T16:54:52.823Z,1379350492.823 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2013-09-16T16:54:53.015Z,1379350493.015 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:53.120Z,1379350493.120 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=248
2013-09-16T16:54:53.210Z,1379350493.210 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=60
2013-09-16T16:54:53.309Z,1379350493.309 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=0
2013-09-16T16:54:53.412Z,1379350493.412 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2013-09-16T16:54:53.420Z,1379350493.420 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:53.773Z,1379350493.773 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=24
2013-09-16T16:54:53.825Z,1379350493.825 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:53.913Z,1379350493.913 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=92
2013-09-16T16:54:54.062Z,1379350494.062 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=160
2013-09-16T16:54:54.201Z,1379350494.201 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=4
2013-09-16T16:54:54.229Z,1379350494.229 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:54.526Z,1379350494.526 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=124
2013-09-16T16:54:54.634Z,1379350494.634 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:54.635Z,1379350494.635 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=4
2013-09-16T16:54:54.763Z,1379350494.763 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=204
2013-09-16T16:54:54.863Z,1379350494.863 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=4
2013-09-16T16:54:55.038Z,1379350495.038 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:55.391Z,1379350495.391 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=60
2013-09-16T16:54:55.447Z,1379350495.447 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:55.632Z,1379350495.632 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=68
2013-09-16T16:54:55.852Z,1379350495.852 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:55.868Z,1379350495.868 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=44
2013-09-16T16:54:56.112Z,1379350496.112 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=4
2013-09-16T16:54:56.256Z,1379350496.256 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:56.661Z,1379350496.661 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:57.034Z,1379350497.034 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=124
2013-09-16T16:54:57.068Z,1379350497.068 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:57.470Z,1379350497.470 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:57.502Z,1379350497.502 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=36
2013-09-16T16:54:57.875Z,1379350497.875 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:57.971Z,1379350497.971 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=49
2013-09-16T16:54:58.279Z,1379350498.279 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:58.454Z,1379350498.454 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=4
2013-09-16T16:54:58.686Z,1379350498.686 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:59.089Z,1379350499.089 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:59.333Z,1379350499.333 [DVL_micro](DEBUG): NQ1
2013-09-16T16:54:59.493Z,1379350499.493 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:54:59.898Z,1379350499.898 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:00.179Z,1379350500.179 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=34
2013-09-16T16:55:00.303Z,1379350500.303 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:00.707Z,1379350500.707 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:01.021Z,1379350501.021 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=10
2013-09-16T16:55:01.112Z,1379350501.112 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:01.517Z,1379350501.517 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:01.865Z,1379350501.865 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=82
2013-09-16T16:55:01.921Z,1379350501.921 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:02.326Z,1379350502.326 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:02.703Z,1379350502.703 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=4
2013-09-16T16:55:02.730Z,1379350502.730 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:03.087Z,1379350503.087 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=72
2013-09-16T16:55:03.135Z,1379350503.135 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:03.148Z,1379350503.148 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=188
2013-09-16T16:55:03.196Z,1379350503.196 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=112
2013-09-16T16:55:03.264Z,1379350503.264 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2013-09-16T16:55:03.524Z,1379350503.524 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=24
2013-09-16T16:55:03.540Z,1379350503.540 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:03.636Z,1379350503.636 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=124
2013-09-16T16:55:03.736Z,1379350503.736 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=64
2013-09-16T16:55:03.836Z,1379350503.836 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2013-09-16T16:55:03.948Z,1379350503.948 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:03.965Z,1379350503.965 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=8
2013-09-16T16:55:04.025Z,1379350504.025 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=60
2013-09-16T16:55:04.077Z,1379350504.077 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=48
2013-09-16T16:55:04.137Z,1379350504.137 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2013-09-16T16:55:04.357Z,1379350504.357 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:04.413Z,1379350504.413 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=88
2013-09-16T16:55:04.513Z,1379350504.513 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=28
2013-09-16T16:55:04.621Z,1379350504.621 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=64
2013-09-16T16:55:04.722Z,1379350504.722 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2013-09-16T16:55:04.762Z,1379350504.762 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:05.078Z,1379350505.078 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=120
2013-09-16T16:55:05.166Z,1379350505.166 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:05.218Z,1379350505.218 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=60
2013-09-16T16:55:05.372Z,1379350505.372 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=32
2013-09-16T16:55:05.503Z,1379350505.503 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=4
2013-09-16T16:55:05.571Z,1379350505.571 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:05.831Z,1379350505.831 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=92
2013-09-16T16:55:05.939Z,1379350505.939 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=4
2013-09-16T16:55:05.978Z,1379350505.978 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:06.069Z,1379350506.069 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=172
2013-09-16T16:55:06.186Z,1379350506.186 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=4
2013-09-16T16:55:06.380Z,1379350506.380 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:06.701Z,1379350506.701 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=28
2013-09-16T16:55:06.785Z,1379350506.785 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:06.941Z,1379350506.941 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=68
2013-09-16T16:55:07.175Z,1379350507.175 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=44
2013-09-16T16:55:07.189Z,1379350507.189 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:07.414Z,1379350507.414 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=4
2013-09-16T16:55:07.594Z,1379350507.594 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:07.999Z,1379350507.999 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:08.336Z,1379350508.336 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=28
2013-09-16T16:55:08.403Z,1379350508.403 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:08.808Z,1379350508.808 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:08.809Z,1379350508.809 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=12
2013-09-16T16:55:09.212Z,1379350509.212 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:09.281Z,1379350509.281 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=52
2013-09-16T16:55:09.617Z,1379350509.617 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:09.778Z,1379350509.778 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=4
2013-09-16T16:55:10.022Z,1379350510.022 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:10.426Z,1379350510.426 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:10.647Z,1379350510.647 [DVL_micro](DEBUG): NQ1
2013-09-16T16:55:10.831Z,1379350510.831 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:11.236Z,1379350511.236 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:11.501Z,1379350511.501 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=101
2013-09-16T16:55:11.640Z,1379350511.640 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:12.053Z,1379350512.053 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:12.338Z,1379350512.338 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=77
2013-09-16T16:55:12.457Z,1379350512.457 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:12.862Z,1379350512.862 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:13.175Z,1379350513.175 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=117
2013-09-16T16:55:13.267Z,1379350513.267 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:13.677Z,1379350513.677 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:14.008Z,1379350514.008 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=4
2013-09-16T16:55:14.084Z,1379350514.084 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:14.457Z,1379350514.457 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=104
2013-09-16T16:55:14.490Z,1379350514.490 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:14.517Z,1379350514.517 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=124
2013-09-16T16:55:14.570Z,1379350514.570 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=48
2013-09-16T16:55:14.621Z,1379350514.621 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2013-09-16T16:55:14.890Z,1379350514.890 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=24
2013-09-16T16:55:14.893Z,1379350514.893 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:14.999Z,1379350514.999 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=94
2013-09-16T16:55:15.106Z,1379350515.106 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=99
2013-09-16T16:55:15.202Z,1379350515.202 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2013-09-16T16:55:15.298Z,1379350515.298 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:15.340Z,1379350515.340 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=8
2013-09-16T16:55:15.390Z,1379350515.390 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=60
2013-09-16T16:55:15.456Z,1379350515.456 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=112
2013-09-16T16:55:15.496Z,1379350515.496 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2013-09-16T16:55:15.703Z,1379350515.703 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:15.784Z,1379350515.784 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=88
2013-09-16T16:55:15.891Z,1379350515.891 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=156
2013-09-16T16:55:15.983Z,1379350515.983 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=32
2013-09-16T16:55:16.087Z,1379350516.087 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2013-09-16T16:55:16.107Z,1379350516.107 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:16.436Z,1379350516.436 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=56
2013-09-16T16:55:16.512Z,1379350516.512 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:16.584Z,1379350516.584 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=60
2013-09-16T16:55:16.724Z,1379350516.724 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=0
2013-09-16T16:55:16.878Z,1379350516.878 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=4
2013-09-16T16:55:16.916Z,1379350516.916 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:17.189Z,1379350517.189 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=29
2013-09-16T16:55:17.317Z,1379350517.317 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=101
2013-09-16T16:55:17.321Z,1379350517.321 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:17.434Z,1379350517.434 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=109
2013-09-16T16:55:17.550Z,1379350517.550 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=4
2013-09-16T16:55:17.726Z,1379350517.726 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:18.064Z,1379350518.064 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=28
2013-09-16T16:55:18.130Z,1379350518.130 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:18.307Z,1379350518.307 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=68
2013-09-16T16:55:18.535Z,1379350518.535 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:18.550Z,1379350518.550 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=108
2013-09-16T16:55:18.776Z,1379350518.776 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=4
2013-09-16T16:55:18.940Z,1379350518.940 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:19.346Z,1379350519.346 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:19.705Z,1379350519.705 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=124
2013-09-16T16:55:19.753Z,1379350519.753 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:20.157Z,1379350520.157 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:20.182Z,1379350520.182 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=196
2013-09-16T16:55:20.562Z,1379350520.562 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:20.655Z,1379350520.655 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=178
2013-09-16T16:55:20.967Z,1379350520.967 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:21.123Z,1379350521.123 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=4
2013-09-16T16:55:21.371Z,1379350521.371 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:21.776Z,1379350521.776 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:22.000Z,1379350522.000 [DVL_micro](DEBUG): NQ1
2013-09-16T16:55:22.181Z,1379350522.181 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:22.586Z,1379350522.586 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:22.866Z,1379350522.866 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=198
2013-09-16T16:55:22.991Z,1379350522.991 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:23.394Z,1379350523.394 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:23.699Z,1379350523.699 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=78
2013-09-16T16:55:23.800Z,1379350523.800 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:24.204Z,1379350524.204 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:24.540Z,1379350524.540 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=118
2013-09-16T16:55:24.608Z,1379350524.608 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:25.013Z,1379350525.013 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:25.386Z,1379350525.386 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=4
2013-09-16T16:55:25.418Z,1379350525.418 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:25.738Z,1379350525.738 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=40
2013-09-16T16:55:25.796Z,1379350525.796 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=92
2013-09-16T16:55:25.822Z,1379350525.822 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:25.850Z,1379350525.850 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=48
2013-09-16T16:55:25.902Z,1379350525.902 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2013-09-16T16:55:26.183Z,1379350526.183 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=120
2013-09-16T16:55:26.227Z,1379350526.227 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:26.289Z,1379350526.289 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=92
2013-09-16T16:55:26.387Z,1379350526.387 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=96
2013-09-16T16:55:26.487Z,1379350526.487 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2013-09-16T16:55:26.624Z,1379350526.624 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=40
2013-09-16T16:55:26.631Z,1379350526.631 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:26.688Z,1379350526.688 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=156
2013-09-16T16:55:26.736Z,1379350526.736 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=112
2013-09-16T16:55:26.784Z,1379350526.784 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2013-09-16T16:55:27.036Z,1379350527.036 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:27.075Z,1379350527.075 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=152
2013-09-16T16:55:27.177Z,1379350527.177 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=92
2013-09-16T16:55:27.277Z,1379350527.277 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=130
2013-09-16T16:55:27.375Z,1379350527.375 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2013-09-16T16:55:27.441Z,1379350527.441 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:27.725Z,1379350527.725 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=56
2013-09-16T16:55:27.845Z,1379350527.845 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:27.870Z,1379350527.870 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=93
2013-09-16T16:55:28.014Z,1379350528.014 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=66
2013-09-16T16:55:28.176Z,1379350528.176 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=4
2013-09-16T16:55:28.250Z,1379350528.250 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:28.491Z,1379350528.491 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=190
2013-09-16T16:55:28.595Z,1379350528.595 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=70
2013-09-16T16:55:28.655Z,1379350528.655 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:28.716Z,1379350528.716 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=111
2013-09-16T16:55:28.835Z,1379350528.835 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=4
2013-09-16T16:55:29.061Z,1379350529.061 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:29.354Z,1379350529.354 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=93
2013-09-16T16:55:29.464Z,1379350529.464 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:29.584Z,1379350529.584 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=5
2013-09-16T16:55:29.825Z,1379350529.825 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=47
2013-09-16T16:55:29.869Z,1379350529.869 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:30.061Z,1379350530.061 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=4
2013-09-16T16:55:30.273Z,1379350530.273 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:30.678Z,1379350530.678 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:30.983Z,1379350530.983 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=28
2013-09-16T16:55:31.083Z,1379350531.083 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:31.459Z,1379350531.459 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=4
2013-09-16T16:55:31.487Z,1379350531.487 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:31.892Z,1379350531.892 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:31.940Z,1379350531.940 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=77
2013-09-16T16:55:32.296Z,1379350532.296 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:32.409Z,1379350532.409 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=4
2013-09-16T16:55:32.701Z,1379350532.701 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:33.106Z,1379350533.106 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:33.302Z,1379350533.302 [DVL_micro](DEBUG): NQ1
2013-09-16T16:55:33.510Z,1379350533.510 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:33.915Z,1379350533.915 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:34.151Z,1379350534.151 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=70
2013-09-16T16:55:34.319Z,1379350534.319 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:34.724Z,1379350534.724 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:34.989Z,1379350534.989 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=46
2013-09-16T16:55:35.129Z,1379350535.129 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:35.533Z,1379350535.533 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:35.834Z,1379350535.834 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=150
2013-09-16T16:55:35.938Z,1379350535.938 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:36.351Z,1379350536.351 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:36.663Z,1379350536.663 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=4
2013-09-16T16:55:36.755Z,1379350536.755 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:37.052Z,1379350537.052 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=40
2013-09-16T16:55:37.104Z,1379350537.104 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=124
2013-09-16T16:55:37.152Z,1379350537.152 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=48
2013-09-16T16:55:37.160Z,1379350537.160 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:37.204Z,1379350537.204 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2013-09-16T16:55:37.490Z,1379350537.490 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=56
2013-09-16T16:55:37.565Z,1379350537.565 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:37.593Z,1379350537.593 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=156
2013-09-16T16:55:37.689Z,1379350537.689 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=65
2013-09-16T16:55:37.793Z,1379350537.793 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2013-09-16T16:55:37.969Z,1379350537.969 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:38.132Z,1379350538.132 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=1864
2013-09-16T16:55:38.133Z,1379350538.133 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=1244
2013-09-16T16:55:38.134Z,1379350538.134 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=624
2013-09-16T16:55:38.134Z,1379350538.134 [DVL_micro](DEBUG): RSSI read bytes: 620 of 620, #buffered=4
2013-09-16T16:55:38.372Z,1379350538.372 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=56
2013-09-16T16:55:38.374Z,1379350538.374 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:38.470Z,1379350538.470 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=28
2013-09-16T16:55:38.586Z,1379350538.586 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=192
2013-09-16T16:55:38.687Z,1379350538.687 [DVL_micro](DEBUG): RSSI read bytes: 1180 of 1180, #buffered=4
2013-09-16T16:55:38.778Z,1379350538.778 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:39.027Z,1379350539.027 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=56
2013-09-16T16:55:39.175Z,1379350539.175 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=28
2013-09-16T16:55:39.183Z,1379350539.183 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:39.323Z,1379350539.323 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=64
2013-09-16T16:55:39.464Z,1379350539.464 [DVL_micro](DEBUG): RSSI read bytes: 1660 of 1660, #buffered=4
2013-09-16T16:55:39.588Z,1379350539.588 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:39.784Z,1379350539.784 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=28
2013-09-16T16:55:39.904Z,1379350539.904 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=100
2013-09-16T16:55:39.992Z,1379350539.992 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:40.021Z,1379350540.021 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=44
2013-09-16T16:55:40.133Z,1379350540.133 [DVL_micro](DEBUG): RSSI read bytes: 1336 of 1336, #buffered=4
2013-09-16T16:55:40.397Z,1379350540.397 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:40.662Z,1379350540.662 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=92
2013-09-16T16:55:40.801Z,1379350540.801 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:40.894Z,1379350540.894 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=36
2013-09-16T16:55:41.135Z,1379350541.135 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=76
2013-09-16T16:55:41.206Z,1379350541.206 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:41.371Z,1379350541.371 [DVL_micro](DEBUG): RSSI read bytes: 2712 of 2712, #buffered=4
2013-09-16T16:55:41.611Z,1379350541.611 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:42.015Z,1379350542.015 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:42.301Z,1379350542.301 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=124
2013-09-16T16:55:42.420Z,1379350542.420 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:42.761Z,1379350542.761 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=4
2013-09-16T16:55:42.826Z,1379350542.826 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:43.233Z,1379350543.233 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:43.245Z,1379350543.245 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=79
2013-09-16T16:55:43.638Z,1379350543.638 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:43.715Z,1379350543.715 [DVL_micro](DEBUG): RSSI read bytes: 5432 of 5432, #buffered=4
2013-09-16T16:55:44.042Z,1379350544.042 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:44.447Z,1379350544.447 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:44.595Z,1379350544.595 [DVL_micro](DEBUG): NQ1
2013-09-16T16:55:44.852Z,1379350544.852 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:44.892Z,1379350544.892 [CommandLine](IMPORTANT): got command stop
2013-09-16T16:55:45.182Z,1379350545.182 [tank_weight] Stopped
2013-09-16T16:55:45.182Z,1379350545.182 [tank_weight](INFO): Aggregate::uninitialize tank_weight
2013-09-16T16:55:45.182Z,1379350545.182 [tank_weight:A.AltitudeEnvelope] Stopped
2013-09-16T16:55:45.182Z,1379350545.182 [tank_weight:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2013-09-16T16:55:45.182Z,1379350545.182 [tank_weight:B.DepthEnvelope] Stopped
2013-09-16T16:55:45.182Z,1379350545.182 [tank_weight:B.DepthEnvelope](DEBUG): Uninitialize.
2013-09-16T16:55:45.182Z,1379350545.182 [tank_weight:Science] Stopped
2013-09-16T16:55:45.182Z,1379350545.182 [tank_weight:Science](INFO): Aggregate::uninitialize tank_weight:Science
2013-09-16T16:55:45.182Z,1379350545.182 [tank_weight:Science:A] Stopped
2013-09-16T16:55:45.182Z,1379350545.182 [tank_weight:Science:B] Stopped
2013-09-16T16:55:45.183Z,1379350545.183 [tank_weight:Science:C] Stopped
2013-09-16T16:55:45.183Z,1379350545.183 [tank_weight:Science:D] Stopped
2013-09-16T16:55:45.183Z,1379350545.183 [tank_weight:Science:E] Stopped
2013-09-16T16:55:45.183Z,1379350545.183 [tank_weight:Science:F] Stopped
2013-09-16T16:55:45.183Z,1379350545.183 [tank_weight:Science:G] Stopped
2013-09-16T16:55:45.183Z,1379350545.183 [tank_weight:Science:H] Stopped
2013-09-16T16:55:45.183Z,1379350545.183 [tank_weight:Science:I] Stopped
2013-09-16T16:55:45.183Z,1379350545.183 [tank_weight:D] Stopped
2013-09-16T16:55:45.183Z,1379350545.183 [tank_weight:D](INFO): Aggregate::uninitialize tank_weight:D
2013-09-16T16:55:45.183Z,1379350545.183 [tank_weight:D:A.SetSpeed] Stopped
2013-09-16T16:55:45.183Z,1379350545.183 [tank_weight:D:A.SetSpeed](DEBUG): Uninitialize.
2013-09-16T16:55:45.183Z,1379350545.183 [tank_weight:D:BuoyancyLo] Stopped
2013-09-16T16:55:45.183Z,1379350545.183 [tank_weight:D:BuoyancyLo](INFO): Aggregate::uninitialize tank_weight:D:BuoyancyLo
2013-09-16T16:55:45.184Z,1379350545.184 [tank_weight:D:BuoyancyLo:A.Buoyancy] Stopped
2013-09-16T16:55:45.184Z,1379350545.184 [tank_weight:D:BuoyancyLo:A.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2013-09-16T16:55:45.184Z,1379350545.184 [tank_weight:D:BuoyancyLo:B.Pitch] Stopped
2013-09-16T16:55:45.184Z,1379350545.184 [tank_weight:D:BuoyancyLo:C.Wait] Stopped
2013-09-16T16:55:45.184Z,1379350545.184 [tank_weight:D:BuoyancyLo:C.Wait](DEBUG): Uninitialize Wait Component.
2013-09-16T16:55:45.256Z,1379350545.256 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2013-09-16T16:55:45.301Z,1379350545.301 [WetLabsBB2FL](INFO): Powering down
2013-09-16T16:55:45.457Z,1379350545.457 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=72
2013-09-16T16:55:45.566Z,1379350545.566 [MissionManager](IMPORTANT): Started mission Default
2013-09-16T16:55:45.566Z,1379350545.566 [Default] Running Loop=1
2013-09-16T16:55:45.567Z,1379350545.567 [Default](INFO): Aggregate::initialize Default
2013-09-16T16:55:45.567Z,1379350545.567 [Default:D.SetSpeed] Running Loop=1
2013-09-16T16:55:45.567Z,1379350545.567 [Default:D.SetSpeed](DEBUG): Initialize.
2013-09-16T16:55:45.567Z,1379350545.567 [Default:E.GoToSurface] Running Loop=1
2013-09-16T16:55:45.567Z,1379350545.567 [Default:E.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-09-16T16:55:45.567Z,1379350545.567 [Default:Iridium] Running Loop=1
2013-09-16T16:55:45.567Z,1379350545.567 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2013-09-16T16:55:45.568Z,1379350545.568 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-09-16T16:55:45.568Z,1379350545.568 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2013-09-16T16:55:45.568Z,1379350545.568 [Default:Iridium:B.GoToSurface] Running Loop=1
2013-09-16T16:55:45.568Z,1379350545.568 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-09-16T16:55:45.570Z,1379350545.570 [Default:Iridium:B.GoToSurface] Stopped
2013-09-16T16:55:45.570Z,1379350545.570 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-09-16T16:55:45.570Z,1379350545.570 [Default:Iridium:Read_Iridium] Running Loop=1
2013-09-16T16:55:45.571Z,1379350545.571 [Default:GPS] Running Loop=1
2013-09-16T16:55:45.571Z,1379350545.571 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2013-09-16T16:55:45.571Z,1379350545.571 [Default:GPS:A.SetSpeed] Running Loop=1
2013-09-16T16:55:45.571Z,1379350545.571 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2013-09-16T16:55:45.571Z,1379350545.571 [Default:GPS:B.GoToSurface] Running Loop=1
2013-09-16T16:55:45.571Z,1379350545.571 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-09-16T16:55:45.572Z,1379350545.572 [Default:GPS:B.GoToSurface] Stopped
2013-09-16T16:55:45.572Z,1379350545.572 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-09-16T16:55:45.573Z,1379350545.573 [Default:GPS:Read_GPS] Running Loop=1
2013-09-16T16:55:46.290Z,1379350546.290 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=16
2013-09-16T16:55:46.357Z,1379350546.357 [NAL9602](INFO): Powering up
2013-09-16T16:55:47.135Z,1379350547.135 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=88
2013-09-16T16:55:47.973Z,1379350547.973 [DVL_micro](DEBUG): RSSI read bytes: 9592 of 9592, #buffered=4
2013-09-16T16:55:48.157Z,1379350548.157 [DVL_micro](INFO): pause:Powering down
2013-09-16T16:55:53.393Z,1379350553.393 [CommandLine](IMPORTANT): got command quit
2013-09-16T16:55:54.518Z,1379350554.518 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2013-09-16T16:55:54.519Z,1379350554.519 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2013-09-16T16:55:54.699Z,1379350554.699 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2013-09-16T16:55:54.931Z,1379350554.931 [WetLabsBB2FL](INFO): Powering down
2013-09-16T16:55:54.939Z,1379350554.939 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2013-09-16T16:55:55.304Z,1379350555.304 [ComponentRegistry](INFO): Shutting down DVL_micro ThreadHandler
2013-09-16T16:55:55.372Z,1379350555.372 [DVL_micro](INFO): uninitialize:Powering down
2013-09-16T16:55:55.380Z,1379350555.380 [ComponentRegistry](INFO): Shutting down AsyncPiEstimator ThreadHandler
2013-09-16T16:55:55.672Z,1379350555.672 [AsyncPiEstimator](DEBUG): Uninitialize AsyncPiEstimator.
2013-09-16T16:55:55.685Z,1379350555.685 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2013-09-16T16:55:55.777Z,1379350555.777 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2013-09-16T16:55:55.781Z,1379350555.781 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2013-09-16T16:55:55.973Z,1379350555.973 [controlThread](DEBUG): Uninitializing ControlThread
2013-09-16T16:55:55.974Z,1379350555.974 [AHRS_sp3003D](INFO): Powering down
2013-09-16T16:55:56.061Z,1379350556.061 [NAL9602](INFO): Powering down
2013-09-16T16:55:56.063Z,1379350556.063 [DAT](INFO): Powering down
2013-09-16T16:55:56.064Z,1379350556.064 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2013-09-16T16:55:56.065Z,1379350556.065 [NavChart](DEBUG): Uninitialize NavChart Derivation.
2013-09-16T16:55:56.066Z,1379350556.066 [Default] Stopped
2013-09-16T16:55:56.066Z,1379350556.066 [Default](INFO): Aggregate::uninitialize Default
2013-09-16T16:55:56.066Z,1379350556.066 [Default:GPS] Stopped
2013-09-16T16:55:56.066Z,1379350556.066 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2013-09-16T16:55:56.066Z,1379350556.066 [Default:GPS:A.SetSpeed] Stopped
2013-09-16T16:55:56.066Z,1379350556.066 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2013-09-16T16:55:56.067Z,1379350556.067 [Default:GPS:Read_GPS] Stopped
2013-09-16T16:55:56.067Z,1379350556.067 [Default:Iridium] Stopped
2013-09-16T16:55:56.067Z,1379350556.067 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2013-09-16T16:55:56.067Z,1379350556.067 [Default:Iridium:A.SetSpeed] Stopped
2013-09-16T16:55:56.067Z,1379350556.067 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2013-09-16T16:55:56.067Z,1379350556.067 [Default:Iridium:Read_Iridium] Stopped
2013-09-16T16:55:56.067Z,1379350556.067 [Default:D.SetSpeed] Stopped
2013-09-16T16:55:56.067Z,1379350556.067 [Default:D.SetSpeed](DEBUG): Uninitialize.
2013-09-16T16:55:56.067Z,1379350556.067 [Default:E.GoToSurface] Stopped
2013-09-16T16:55:56.067Z,1379350556.067 [Default:E.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-09-16T16:55:56.071Z,1379350556.071 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2013-09-16T16:55:56.071Z,1379350556.071 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2013-09-16T16:55:56.072Z,1379350556.072 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2013-09-16T16:55:56.072Z,1379350556.072 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2013-09-16T16:55:56.072Z,1379350556.072 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2013-09-16T16:55:56.072Z,1379350556.072 [ElevatorServo](INFO): Powering down
2013-09-16T16:55:56.074Z,1379350556.074 [MassServo](DEBUG): Uninitialize Mass Servo.
2013-09-16T16:55:56.074Z,1379350556.074 [MassServo](INFO): Powering down
2013-09-16T16:55:56.075Z,1379350556.075 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2013-09-16T16:55:56.075Z,1379350556.075 [RudderServo](INFO): Powering down
2013-09-16T16:55:56.075Z,1379350556.075 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2013-09-16T16:55:56.076Z,1379350556.076 [ThrusterServo](INFO): Powering down
2013-09-16T16:55:56.076Z,1379350556.076 [SBIT](DEBUG): Uninitialize SBIT Component.
2013-09-16T16:55:56.077Z,1379350556.077 [IBIT](DEBUG): Uninitialize IBIT Component.
2013-09-16T16:55:56.077Z,1379350556.077 [CBIT](DEBUG): Uninitialize CBIT Component.