2013-01-18T17:18:41.243Z,1358529521.243 [Supervisor](DEBUG): Initializing supervisor.
2013-01-18T17:18:41.246Z,1358529521.246 [SyncHandler](DEBUG): Created PCaller Thread at 4033B4E0
2013-01-18T17:18:41.247Z,1358529521.247 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2013-01-18T17:18:41.248Z,1358529521.247 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4036B4E0
2013-01-18T17:18:41.251Z,1358529521.251 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2013-01-18T17:18:41.262Z,1358529521.262 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2013-01-18T17:18:41.263Z,1358529521.263 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 4039B4E0
2013-01-18T17:18:41.264Z,1358529521.264 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2013-01-18T17:18:41.265Z,1358529521.265 [logger ThreadHandler](DEBUG): Created PCaller Thread at 403CB4E0
2013-01-18T17:18:41.265Z,1358529521.265 [Supervisor](INFO): Looking for Config files in directory: Config/
2013-01-18T17:18:41.267Z,1358529521.267 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2013-01-18T17:18:41.565Z,1358529521.565 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2013-01-18T17:18:41.566Z,1358529521.566 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2013-01-18T17:18:41.753Z,1358529521.753 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2013-01-18T17:18:41.753Z,1358529521.753 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2013-01-18T17:18:41.838Z,1358529521.838 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2013-01-18T17:18:41.838Z,1358529521.838 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2013-01-18T17:18:42.033Z,1358529522.033 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2013-01-18T17:18:42.034Z,1358529522.034 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2013-01-18T17:18:42.166Z,1358529522.166 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2013-01-18T17:18:42.167Z,1358529522.167 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2013-01-18T17:18:42.397Z,1358529522.397 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2013-01-18T17:18:42.397Z,1358529522.397 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2013-01-18T17:18:42.566Z,1358529522.566 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2013-01-18T17:18:42.567Z,1358529522.567 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2013-01-18T17:18:42.816Z,1358529522.816 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2013-01-18T17:18:42.817Z,1358529522.817 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2013-01-18T17:18:42.914Z,1358529522.914 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2013-01-18T17:18:42.915Z,1358529522.915 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2013-01-18T17:18:43.313Z,1358529523.313 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2013-01-18T17:18:43.313Z,1358529523.313 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2013-01-18T17:18:43.428Z,1358529523.428 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2013-01-18T17:18:43.428Z,1358529523.428 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2013-01-18T17:18:43.513Z,1358529523.513 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2013-01-18T17:18:43.514Z,1358529523.514 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2013-01-18T17:18:43.615Z,1358529523.615 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2013-01-18T17:18:43.746Z,1358529523.746 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2013-01-18T17:18:43.831Z,1358529523.831 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2013-01-18T17:18:43.932Z,1358529523.932 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2013-01-18T17:18:44.032Z,1358529524.032 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2013-01-18T17:18:44.149Z,1358529524.149 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2013-01-18T17:18:44.242Z,1358529524.242 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2013-01-18T17:18:44.329Z,1358529524.329 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2013-01-18T17:18:44.357Z,1358529524.357 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2013-01-18T17:18:44.508Z,1358529524.508 [InternalSim] Loaded
2013-01-18T17:18:44.508Z,1358529524.508 [ComponentRegistry](DEBUG): SyncComponent "InternalSim" handled in the control thread.
2013-01-18T17:18:44.509Z,1358529524.509 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2013-01-18T17:18:44.510Z,1358529524.510 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2013-01-18T17:18:44.566Z,1358529524.566 [SBIT](DEBUG): Construct Startup Built In Test.
2013-01-18T17:18:44.594Z,1358529524.594 [SBIT] Loaded
2013-01-18T17:18:44.595Z,1358529524.595 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2013-01-18T17:18:44.595Z,1358529524.595 [IBIT](DEBUG): Construct Initiated Built In Test.
2013-01-18T17:18:44.624Z,1358529524.624 [IBIT] Loaded
2013-01-18T17:18:44.625Z,1358529524.625 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2013-01-18T17:18:44.628Z,1358529524.628 [CBIT](DEBUG): Construct CBIT Built In Test.
2013-01-18T17:18:44.748Z,1358529524.748 [CBIT] Loaded
2013-01-18T17:18:44.748Z,1358529524.748 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2013-01-18T17:18:44.749Z,1358529524.749 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2013-01-18T17:18:44.749Z,1358529524.749 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2013-01-18T17:18:44.897Z,1358529524.897 [BuoyancyServo] Loaded
2013-01-18T17:18:44.898Z,1358529524.898 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2013-01-18T17:18:44.910Z,1358529524.910 [ElevatorServo] Loaded
2013-01-18T17:18:44.910Z,1358529524.911 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2013-01-18T17:18:44.922Z,1358529524.922 [MassServo] Loaded
2013-01-18T17:18:44.923Z,1358529524.922 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2013-01-18T17:18:44.935Z,1358529524.935 [RudderServo] Loaded
2013-01-18T17:18:44.935Z,1358529524.935 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2013-01-18T17:18:44.947Z,1358529524.947 [ThrusterServo] Loaded
2013-01-18T17:18:44.947Z,1358529524.947 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2013-01-18T17:18:44.948Z,1358529524.948 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2013-01-18T17:18:44.948Z,1358529524.948 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2013-01-18T17:18:44.965Z,1358529524.965 [DepthRateCalculator] Loaded
2013-01-18T17:18:44.965Z,1358529524.966 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2013-01-18T17:18:48.341Z,1358529528.341 [HFRadarModelCalc] Loaded
2013-01-18T17:18:48.341Z,1358529528.341 [ComponentRegistry](DEBUG): SyncComponent "HFRadarModelCalc" handled in the control thread.
2013-01-18T17:18:48.357Z,1358529528.357 [NavChart] Loaded
2013-01-18T17:18:48.357Z,1358529528.357 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2013-01-18T17:18:48.363Z,1358529528.363 [PitchRateCalculator] Loaded
2013-01-18T17:18:48.363Z,1358529528.363 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2013-01-18T17:18:48.370Z,1358529528.370 [SpeedCalculator] Loaded
2013-01-18T17:18:48.370Z,1358529528.370 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2013-01-18T17:18:48.385Z,1358529528.385 [TempGradientCalculator] Loaded
2013-01-18T17:18:48.385Z,1358529528.385 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2013-01-18T17:18:48.391Z,1358529528.391 [YawRateCalculator] Loaded
2013-01-18T17:18:48.391Z,1358529528.391 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2013-01-18T17:18:48.432Z,1358529528.432 [Navigation] Loaded
2013-01-18T17:18:48.433Z,1358529528.432 [ComponentRegistry](DEBUG): SyncComponent "Navigation" handled in the control thread.
2013-01-18T17:18:48.433Z,1358529528.433 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2013-01-18T17:18:48.433Z,1358529528.433 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2013-01-18T17:18:48.654Z,1358529528.654 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2013-01-18T17:18:48.655Z,1358529528.655 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2013-01-18T17:18:48.676Z,1358529528.676 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2013-01-18T17:18:48.677Z,1358529528.677 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2013-01-18T17:18:48.716Z,1358529528.716 [VerticalControl](DEBUG): Construct VerticalControl.
2013-01-18T17:18:48.811Z,1358529528.811 [VerticalControl] Loaded
2013-01-18T17:18:48.811Z,1358529528.811 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2013-01-18T17:18:48.812Z,1358529528.812 [HorizontalControl](DEBUG): Construct HorizontalControl.
2013-01-18T17:18:48.869Z,1358529528.869 [HorizontalControl] Loaded
2013-01-18T17:18:48.869Z,1358529528.869 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2013-01-18T17:18:48.870Z,1358529528.870 [SpeedControl](DEBUG): Construct SpeedControl.
2013-01-18T17:18:48.872Z,1358529528.872 [SpeedControl] Loaded
2013-01-18T17:18:48.872Z,1358529528.872 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2013-01-18T17:18:48.873Z,1358529528.873 [LoopControl](DEBUG): Construct LoopControl.
2013-01-18T17:18:48.874Z,1358529528.874 [LoopControl] Loaded
2013-01-18T17:18:48.874Z,1358529528.874 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2013-01-18T17:18:48.875Z,1358529528.875 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2013-01-18T17:18:48.875Z,1358529528.875 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2013-01-18T17:18:48.881Z,1358529528.881 [AsyncPiEstimator](DEBUG): Construct AsyncPiEstimator.
2013-01-18T17:18:48.885Z,1358529528.885 [AsyncPiEstimator] Loaded
2013-01-18T17:18:48.886Z,1358529528.886 [ComponentRegistry](DEBUG): Component "AsyncPiEstimator" handled in its own thread.
2013-01-18T17:18:48.887Z,1358529528.887 [AsyncPiEstimator ThreadHandler](DEBUG): Created PCaller Thread at 406A34E0
2013-01-18T17:18:48.887Z,1358529528.888 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2013-01-18T17:18:48.888Z,1358529528.888 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2013-01-18T17:18:49.014Z,1358529529.014 [AHRS_sp3003D] Loaded
2013-01-18T17:18:49.014Z,1358529529.014 [ComponentRegistry](DEBUG): SyncComponent "AHRS_sp3003D" handled in the control thread.
2013-01-18T17:18:49.278Z,1358529529.278 [Batt_Ocean_Server] Loaded
2013-01-18T17:18:49.278Z,1358529529.278 [ComponentRegistry](DEBUG): SyncComponent "Batt_Ocean_Server" handled in the control thread.
2013-01-18T17:18:49.292Z,1358529529.292 [Depth_Keller] Loaded
2013-01-18T17:18:49.292Z,1358529529.292 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2013-01-18T17:18:49.455Z,1358529529.455 [DVL_micro] Loaded
2013-01-18T17:18:49.455Z,1358529529.455 [ComponentRegistry](DEBUG): Component "DVL_micro" handled in its own thread.
2013-01-18T17:18:49.456Z,1358529529.456 [DVL_micro ThreadHandler](DEBUG): Created PCaller Thread at 407274E0
2013-01-18T17:18:49.507Z,1358529529.507 [Onboard] Loaded
2013-01-18T17:18:49.507Z,1358529529.507 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2013-01-18T17:18:49.514Z,1358529529.514 [Radio_Freewave] Loaded
2013-01-18T17:18:49.515Z,1358529529.515 [ComponentRegistry](DEBUG): SyncComponent "Radio_Freewave" handled in the control thread.
2013-01-18T17:18:49.596Z,1358529529.596 [DAT] Loaded
2013-01-18T17:18:49.597Z,1358529529.597 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2013-01-18T17:18:49.597Z,1358529529.597 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2013-01-18T17:18:49.598Z,1358529529.598 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2013-01-18T17:18:49.653Z,1358529529.653 [PAR_Licor] Loaded
2013-01-18T17:18:49.653Z,1358529529.653 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2013-01-18T17:18:49.655Z,1358529529.655 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2013-01-18T17:18:49.657Z,1358529529.657 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2013-01-18T17:18:49.658Z,1358529529.658 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2013-01-18T17:18:49.664Z,1358529529.664 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2013-01-18T17:18:49.665Z,1358529529.665 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 407794E0
2013-01-18T17:18:49.670Z,1358529529.670 [Supervisor](DEBUG): Running supervisor.
2013-01-18T17:18:49.671Z,1358529529.671 [CommandLine](INFO): Thread ID is 3702
2013-01-18T17:18:49.673Z,1358529529.673 [controlThread](INFO): Thread ID is 3701
2013-01-18T17:18:49.674Z,1358529529.674 [controlThread](DEBUG): Initializing ControlThread
2013-01-18T17:18:49.674Z,1358529529.674 [CycleStarter](INFO): Thread ID is 3700
2013-01-18T17:18:49.674Z,1358529529.674 [InternalSim](DEBUG):  InternalSim initializing...
2013-01-18T17:18:49.709Z,1358529529.709 [logger](INFO): Thread ID is 3703
2013-01-18T17:18:49.735Z,1358529529.735 [SBIT](INFO): Initialize SBIT Component.
2013-01-18T17:18:49.736Z,1358529529.736 [SBIT](IMPORTANT): Tethys CM Info:
$Rev: 10106
2013-01-18T17:18:49.736Z,1358529529.736 [IBIT](INFO): Initialize IBIT Component.
2013-01-18T17:18:49.737Z,1358529529.737 [CBIT](DEBUG): Initialize CBIT Component.
2013-01-18T17:18:49.737Z,1358529529.737 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL.
2013-01-18T17:18:49.738Z,1358529529.738 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2013-01-18T17:18:49.749Z,1358529529.749 [AsyncPiEstimator](INFO): Thread ID is 3764
2013-01-18T17:18:49.749Z,1358529529.749 [AsyncPiEstimator](DEBUG): Initialize AsyncPiEstimator.
2013-01-18T17:18:49.763Z,1358529529.763 [DVL_micro](INFO): Thread ID is 3765
2013-01-18T17:18:49.769Z,1358529529.769 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2013-01-18T17:18:49.770Z,1358529529.770 [NavChart](DEBUG): Initialize NavChart Derivation.
2013-01-18T17:18:49.770Z,1358529529.770 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2013-01-18T17:18:49.771Z,1358529529.771 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2013-01-18T17:18:49.771Z,1358529529.771 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2013-01-18T17:18:49.773Z,1358529529.773 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2013-01-18T17:18:49.773Z,1358529529.773 [Navigation](DEBUG): Initializing Navigation.
2013-01-18T17:18:49.774Z,1358529529.774 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2013-01-18T17:18:49.775Z,1358529529.775 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2013-01-18T17:18:49.781Z,1358529529.781 [DVL_micro](INFO): Initializing
2013-01-18T17:18:49.781Z,1358529529.781 [DVL_micro](INFO): start:Powering up
2013-01-18T17:18:49.782Z,1358529529.782 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-01-18T17:18:49.783Z,1358529529.783 [DVL_micro](INFO): Cycling power to configure device.
2013-01-18T17:18:49.784Z,1358529529.784 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2013-01-18T17:18:49.785Z,1358529529.785 [LoopControl](DEBUG): Initialize LoopControlComponent.
2013-01-18T17:18:49.801Z,1358529529.801 [NavChartDb](INFO): Thread ID is 3766
2013-01-18T17:18:49.803Z,1358529529.803 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources
2013-01-18T17:18:49.803Z,1358529529.803 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2013-01-18T17:18:49.804Z,1358529529.804 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2013-01-18T17:18:49.804Z,1358529529.804 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2013-01-18T17:18:49.804Z,1358529529.804 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2013-01-18T17:18:51.667Z,1358529531.667 [Batt_Ocean_Server](INFO): Ocean Server Batteries initialized
2013-01-18T17:18:51.701Z,1358529531.701 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2013-01-18T17:18:51.727Z,1358529531.727 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2013-01-18T17:18:51.773Z,1358529531.773 [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-01-18T17:18:51.774Z,1358529531.774 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2013-01-18T17:18:51.856Z,1358529531.856 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-01-18T17:18:51.857Z,1358529531.857 [DVL_micro](INFO): Querying output modes
2013-01-18T17:18:51.857Z,1358529531.857 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-01-18T17:18:51.865Z,1358529531.865 [MissionManager](INFO): DefineArg Default.NeedGPS = 1 bool
2013-01-18T17:18:51.867Z,1358529531.867 [Default:GPS:A.SetSpeed](DEBUG): Construct.
2013-01-18T17:18:51.868Z,1358529531.868 [DVL_micro](DEBUG): cmdResponse: 01
2013-01-18T17:18:51.868Z,1358529531.868 [DVL_micro](INFO): NQ1 output enabled
2013-01-18T17:18:51.869Z,1358529531.869 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-01-18T17:18:51.880Z,1358529531.880 [DVL_micro](DEBUG): cmdResponse: AUTO_VEL_ON 
2013-01-18T17:18:51.885Z,1358529531.885 [DVL_micro](INFO): pause:Powering down
2013-01-18T17:18:51.893Z,1358529531.893 [Default:GPS:B.GoToSurface](DEBUG): Construct GoToSurface.
2013-01-18T17:18:51.901Z,1358529531.901 [Default:Iridium:A.SetSpeed](DEBUG): Construct.
2013-01-18T17:18:51.944Z,1358529531.944 [Default:Iridium:B.GoToSurface](DEBUG): Construct GoToSurface.
2013-01-18T17:18:51.951Z,1358529531.951 [Default:Iridium:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2013-01-18T17:18:51.976Z,1358529531.976 [Default:D.SetSpeed](DEBUG): Construct.
2013-01-18T17:18:51.979Z,1358529531.979 [Default:E.GoToSurface](DEBUG): Construct GoToSurface.
2013-01-18T17:18:51.996Z,1358529531.996 [Default:F.Wait](DEBUG): Construct Wait.
2013-01-18T17:18:51.999Z,1358529531.999 [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-01-18T17:18:52.028Z,1358529532.028 [controlThread](DEBUG): Component order: CycleStarter,InternalSim,AHRS_sp3003D,Batt_Ocean_Server,Depth_Keller,Onboard,Radio_Freewave,DAT,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,HFRadarModelCalc,NavChart,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,Navigation,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,
2013-01-18T17:18:52.088Z,1358529532.088 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D.
2013-01-18T17:18:52.348Z,1358529532.348 [Radio_Freewave](INFO): Powering up
2013-01-18T17:18:52.357Z,1358529532.357 [DAT](INFO): Powering up
2013-01-18T17:18:52.358Z,1358529532.358 [DAT](DEBUG): Initializing DAT.
2013-01-18T17:18:52.648Z,1358529532.648 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2013-01-18T17:18:52.656Z,1358529532.656 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2013-01-18T17:18:52.675Z,1358529532.675 [ElevatorServo](DEBUG): Initializing EZServoServo.
2013-01-18T17:18:52.680Z,1358529532.680 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2013-01-18T17:18:52.686Z,1358529532.686 [MassServo](DEBUG): Initializing EZServoServo.
2013-01-18T17:18:52.700Z,1358529532.700 [MassServo](DEBUG): Initializing MassServo.
2013-01-18T17:18:52.706Z,1358529532.706 [RudderServo](DEBUG): Initializing EZServoServo.
2013-01-18T17:18:52.736Z,1358529532.736 [RudderServo](DEBUG): Initializing RudderServo.
2013-01-18T17:18:52.743Z,1358529532.743 [ThrusterServo](DEBUG): Initializing EZServoServo.
2013-01-18T17:18:52.748Z,1358529532.748 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2013-01-18T17:19:05.254Z,1358529545.254 [SBIT](IMPORTANT): Beginning Startup BIT
2013-01-18T17:19:05.256Z,1358529545.256 [CBIT](IMPORTANT): Beginning GF scan
2013-01-18T17:19:11.686Z,1358529551.686 [DAT](INFO): Init failed - response: 00:00:08.4127 , LVL= 32752, 32753, 32754, 28995, AGC=  78, IDX= 82-0.11,-0.326, PHS= 2.200, 1.791, 1.594, |v|= 1.181, RAW=  71.4,-74.7, CAL=  79.3,-74.8, ROT= 158.3,-74.8, CMP=  21.6,  2.4,   0.1, 00:00:08.4337 
00:00:09.4126 , LVL= 32752, 32753, 32754, 28467, AGC=  77, IDX= 62-0.10,-0.746, PHS= 2.209, 1.802, 1.627, |v|= 1.189, RAW=  73.0,-75.3, CAL=  80.5,-75.4, ROT= 159.5,-75.4, CMP=  21.7
2013-01-18T17:19:11.687Z,1358529551.687 [DAT](FAULT): DAT failed to initialize
2013-01-18T17:19:11.687Z,1358529551.687 [DAT] Communications Fault, FailCount= 1
2013-01-18T17:19:11.687Z,1358529551.687 [DAT](ERROR): Communications Fault
2013-01-18T17:19:11.820Z,1358529551.819 [CBIT](ERROR): Communications Fault in component: DAT
2013-01-18T17:19:12.054Z,1358529552.054 [DAT](INFO): Powering down
2013-01-18T17:19:12.976Z,1358529552.976 [CBIT](INFO): Clearing failed state for component DAT
2013-01-18T17:19:12.976Z,1358529552.976 [DAT] No Fault, FailCount= 1
2013-01-18T17:19:15.251Z,1358529555.251 [DAT](INFO): Powering up
2013-01-18T17:19:15.251Z,1358529555.251 [DAT](DEBUG): Initializing DAT.
2013-01-18T17:19:31.888Z,1358529571.888 [CBIT](IMPORTANT): No ground fault detected
2013-01-18T17:19:34.679Z,1358529574.679 [DAT](INFO): Init failed - response: 00:00:06.9148 , LVL= 32752, 32753, 32754, 30451, AGC=  77, IDX= 82-0.22, 0.385, PHS= 2.209, 1.788, 1.606, |v|= 1.185, RAW=  72.9,-74.8, CAL=  80.6,-74.9, ROT= 159.6,-74.9, CMP= 293.0,  1.3,   0.5, 00:00:00.0000 
00:00:07.9694 , LVL= 32752, 32753, 32754, 20723, AGC=  82, IDX=114-0.16, 0.609, PHS= 2.897, 0.832, 1.442, |v|= 1.497, RAW= 106.7,-44.7, CAL= 117.9,-52.5, ROT= 196.9,-52.5, CMP=  21.7
2013-01-18T17:19:34.679Z,1358529574.679 [DAT](FAULT): DAT failed to initialize
2013-01-18T17:19:34.679Z,1358529574.679 [DAT] Communications Fault, FailCount= 2
2013-01-18T17:19:34.679Z,1358529574.679 [DAT](ERROR): Communications Fault
2013-01-18T17:19:34.740Z,1358529574.740 [CBIT](ERROR): Communications Fault in component: DAT
2013-01-18T17:19:35.026Z,1358529575.026 [DAT](INFO): Powering down
2013-01-18T17:19:35.840Z,1358529575.840 [CBIT](INFO): Clearing failed state for component DAT
2013-01-18T17:19:35.840Z,1358529575.840 [DAT] No Fault, FailCount= 2
2013-01-18T17:19:38.227Z,1358529578.227 [DAT](INFO): Powering up
2013-01-18T17:19:38.227Z,1358529578.227 [DAT](DEBUG): Initializing DAT.
2013-01-18T17:19:57.638Z,1358529597.638 [DAT](INFO): Init failed - response: 00:00:06.7922 , LVL= 32752, 32753, 32754, 20915, AGC=  79, IDX= 82-0.32,-0.927, PHS= 1.580, 1.003, 0.942, |v|= 0.801, RAW=  85.0,-63.8, CAL=  95.6,-63.5, ROT= 174.6,-63.5, CMP= 293.0,  1.3,   0.5, 00:00:00.0000 
00:00:07.8468 , LVL= 32752, 32753, 32754, 23971, AGC=  83, IDX=106 0.17, 1.093, PHS= 2.508, 1.701, 1.641, |v|= 1.289, RAW=  86.4,-67.8, CAL=  95.4,-67.6, ROT= 174.4,-67.6, CMP= 293.0
2013-01-18T17:19:57.638Z,1358529597.638 [DAT](FAULT): DAT failed to initialize
2013-01-18T17:19:57.638Z,1358529597.638 [DAT] Communications Fault, FailCount= 3
2013-01-18T17:19:57.638Z,1358529597.638 [DAT](ERROR): Communications Fault
2013-01-18T17:19:57.655Z,1358529597.655 [CBIT](ERROR): Communications Fault in component: DAT
2013-01-18T17:19:57.656Z,1358529597.656 [CBIT](CRITICAL): Communications Fault in component: DAT
2013-01-18T17:19:57.979Z,1358529597.979 [DAT](INFO): Powering down
2013-01-18T17:19:58.789Z,1358529598.789 [SBIT](IMPORTANT): SBIT PASSED
2013-01-18T17:19:59.178Z,1358529599.178 [MissionManager](IMPORTANT): Started mission Startup
2013-01-18T17:19:59.179Z,1358529599.179 [Startup] Running Loop=1
2013-01-18T17:19:59.179Z,1358529599.179 [Startup](INFO): Aggregate::initialize Startup
2013-01-18T17:19:59.179Z,1358529599.179 [Startup:A.GoToSurface] Running Loop=1
2013-01-18T17:19:59.179Z,1358529599.179 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-01-18T17:21:25.220Z,1358529685.220 [CommandLine](IMPORTANT): got command failComponent
2013-01-18T17:21:25.228Z,1358529685.228 [CommandLine](IMPORTANT): Failed components:
2013-01-18T17:21:25.228Z,1358529685.228 [CommandLine](IMPORTANT): DAT: Communications Fault
2013-01-18T17:22:00.129Z,1358529720.129 [CommandLine](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 100.000000 cubic_centimeter
2013-01-18T17:22:00.130Z,1358529720.130 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.buoyancyAction" handled in the control thread.
2013-01-18T17:22:00.531Z,1358529720.531 [controlThread](DEBUG): Component order: CycleStarter,InternalSim,AHRS_sp3003D,Batt_Ocean_Server,Depth_Keller,Onboard,Radio_Freewave,DAT,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,HFRadarModelCalc,NavChart,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,Navigation,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.buoyancyAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,
2013-01-18T17:22:57.153Z,1358529777.153 [CommandLine](IMPORTANT): got command maintain control VerticalControl.massPositionAction 0.000000 centimeter
2013-01-18T17:22:57.154Z,1358529777.154 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.massPositionAction" handled in the control thread.
2013-01-18T17:22:57.463Z,1358529777.464 [controlThread](DEBUG): Component order: CycleStarter,InternalSim,AHRS_sp3003D,Batt_Ocean_Server,Depth_Keller,Onboard,Radio_Freewave,DAT,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,HFRadarModelCalc,NavChart,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,Navigation,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.buoyancyAction,Maintain_VerticalControl.massPositionAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,
2013-01-18T17:23:20.372Z,1358529800.372 [CommandLine](IMPORTANT): got command get 
2013-01-18T17:23:20.372Z,1358529800.372 [CommandLine](FAULT): Incomplete syntax. Try: help get
2013-01-18T17:23:40.400Z,1358529820.400 [CommandLine](IMPORTANT): got command show variable pitch
2013-01-18T17:23:40.523Z,1358529820.523 [CommandLine](INFO): platform_pitch_angle (degree)
2013-01-18T17:23:40.523Z,1358529820.523 [CommandLine](INFO): platform_pitch_rate (radian_per_second)
2013-01-18T17:23:40.530Z,1358529820.530 [CommandLine](INFO): Config/Sensor.AHRS_3DMGX3_pitchOffset (degree)
2013-01-18T17:23:40.530Z,1358529820.530 [CommandLine](INFO): Config/Sensor.AHRS_sp3003D_pitchOffset (degree)
2013-01-18T17:23:40.531Z,1358529820.532 [CommandLine](INFO): Config/Sensor.DVL_micro_pitchOffset (degree)
2013-01-18T17:23:40.539Z,1358529820.539 [CommandLine](INFO): PAR_Licor.maxValidPitch (degree)
2013-01-18T17:23:40.539Z,1358529820.539 [CommandLine](INFO): PAR_Licor.minValidPitch (degree)
2013-01-18T17:23:40.541Z,1358529820.541 [CommandLine](INFO): SpeedControl.propPitch (meter_per_radian)
2013-01-18T17:23:40.542Z,1358529820.542 [CommandLine](INFO): VerticalControl.kdPitchElevator (second)
2013-01-18T17:23:40.543Z,1358529820.543 [CommandLine](INFO): VerticalControl.kdPitchMass (second)
2013-01-18T17:23:40.543Z,1358529820.543 [CommandLine](INFO): VerticalControl.kiPitchElevator (reciprocal_second)
2013-01-18T17:23:40.544Z,1358529820.544 [CommandLine](INFO): VerticalControl.kiPitchMass (reciprocal_second)
2013-01-18T17:23:40.544Z,1358529820.545 [CommandLine](INFO): VerticalControl.kpPitchElevator (none)
2013-01-18T17:23:40.545Z,1358529820.545 [CommandLine](INFO): VerticalControl.kpPitchMass (none)
2013-01-18T17:23:40.546Z,1358529820.546 [CommandLine](INFO): VerticalControl.maxPitchElevatorInt (angular_degree)
2013-01-18T17:23:40.546Z,1358529820.546 [CommandLine](INFO): VerticalControl.maxPitchMassInt (millimeter)
2013-01-18T17:23:40.547Z,1358529820.547 [CommandLine](INFO): VerticalControl.maxPitchRate (angular_degree_per_second)
2013-01-18T17:23:40.547Z,1358529820.547 [CommandLine](INFO): VerticalControl.minAscendPitch (angular_degree)
2013-01-18T17:23:40.547Z,1358529820.547 [CommandLine](INFO): VerticalControl.pitchLimit (angular_degree)
2013-01-18T17:23:40.551Z,1358529820.551 [CommandLine](INFO): Config/Simulator.initPitch (angular_degree)
2013-01-18T17:23:40.555Z,1358529820.555 [CommandLine](INFO): Config/Derivation.PitchRateCalculator_enable (bool)
2013-01-18T17:23:40.556Z,1358529820.556 [CommandLine](INFO): InternalSim.platform_pitch_angle (degree)
2013-01-18T17:23:40.559Z,1358529820.559 [CommandLine](INFO): PitchRateCalculator.platform_pitch_rate (radian_per_second)
2013-01-18T17:23:40.560Z,1358529820.560 [CommandLine](INFO): VerticalControl.pitchCmd (radian)
2013-01-18T17:23:40.561Z,1358529820.561 [CommandLine](INFO): VerticalControl.massPitchErrorInternal (radian)
2013-01-18T17:23:40.562Z,1358529820.562 [CommandLine](INFO): VerticalControl.pitchInternal (radian)
2013-01-18T17:23:40.563Z,1358529820.563 [CommandLine](INFO): AHRS_sp3003D.platform_pitch_angle (degree)
2013-01-18T17:23:40.566Z,1358529820.566 [CommandLine](INFO): DVL_micro.platform_pitch_angle (degree)
2013-01-18T17:23:40.570Z,1358529820.570 [CommandLine](INFO): PitchRateCalculator.durationOfLastRun (second)
2013-01-18T17:23:50.356Z,1358529830.356 [CommandLine](IMPORTANT): got command get platform_pitch_angle
2013-01-18T17:23:50.357Z,1358529830.357 [CommandLine](IMPORTANT): platform_pitch_angle 2.109375 degree
2013-01-18T17:24:19.169Z,1358529859.168 [CommandLine](IMPORTANT): got command report periodic 1.000000 platform_pitch_angle
2013-01-18T17:24:19.532Z,1358529859.532 [Reporter](INFO): platform_pitch_angle 2.087402 arcdeg
2013-01-18T17:24:20.788Z,1358529860.787 [Reporter](INFO): platform_pitch_angle 2.087402 arcdeg
2013-01-18T17:24:21.933Z,1358529861.932 [Reporter](INFO): platform_pitch_angle 2.065430 arcdeg
2013-01-18T17:24:23.135Z,1358529863.135 [Reporter](INFO): platform_pitch_angle 2.087402 arcdeg
2013-01-18T17:24:24.335Z,1358529864.335 [Reporter](INFO): platform_pitch_angle 2.131348 arcdeg
2013-01-18T17:24:25.533Z,1358529865.533 [Reporter](INFO): platform_pitch_angle 2.021484 arcdeg
2013-01-18T17:24:26.736Z,1358529866.736 [Reporter](INFO): platform_pitch_angle 2.065430 arcdeg
2013-01-18T17:24:27.959Z,1358529867.959 [Reporter](INFO): platform_pitch_angle 2.109375 arcdeg
2013-01-18T17:24:29.168Z,1358529869.168 [Reporter](INFO): platform_pitch_angle 2.065430 arcdeg
2013-01-18T17:24:30.336Z,1358529870.336 [Reporter](INFO): platform_pitch_angle 2.021484 arcdeg
2013-01-18T17:24:31.533Z,1358529871.533 [Reporter](INFO): platform_pitch_angle 2.109375 arcdeg
2013-01-18T17:24:32.743Z,1358529872.743 [Reporter](INFO): platform_pitch_angle 2.087402 arcdeg
2013-01-18T17:24:33.992Z,1358529873.991 [Reporter](INFO): platform_pitch_angle 2.065430 arcdeg
2013-01-18T17:24:35.133Z,1358529875.133 [Reporter](INFO): platform_pitch_angle 2.131348 arcdeg
2013-01-18T17:24:36.359Z,1358529876.359 [Reporter](INFO): platform_pitch_angle 2.109375 arcdeg
2013-01-18T17:24:37.533Z,1358529877.533 [Reporter](INFO): platform_pitch_angle 2.109375 arcdeg
2013-01-18T17:24:38.796Z,1358529878.796 [Reporter](INFO): platform_pitch_angle 2.131348 arcdeg
2013-01-18T17:24:39.933Z,1358529879.933 [Reporter](INFO): platform_pitch_angle 2.087402 arcdeg
2013-01-18T17:24:40.309Z,1358529880.309 [CommandLine](IMPORTANT): got command report periodic 5.000000 platform_pitch_angle
2013-01-18T17:24:45.139Z,1358529885.139 [Reporter](INFO): platform_pitch_angle 2.131348 arcdeg
2013-01-18T17:24:50.343Z,1358529890.343 [Reporter](INFO): platform_pitch_angle 2.153320 arcdeg
2013-01-18T17:24:55.532Z,1358529895.532 [Reporter](INFO): platform_pitch_angle 2.197266 arcdeg
2013-01-18T17:24:57.958Z,1358529897.958 [CBIT](INFO): Clearing failed count for component DAT
2013-01-18T17:24:57.959Z,1358529897.958 [DAT] No Fault, FailCount= 3
2013-01-18T17:24:58.267Z,1358529898.267 [DAT](INFO): Powering up
2013-01-18T17:24:58.267Z,1358529898.267 [DAT](DEBUG): Initializing DAT.
2013-01-18T17:25:00.739Z,1358529900.739 [Reporter](INFO): platform_pitch_angle 2.109375 arcdeg
2013-01-18T17:25:03.077Z,1358529903.077 [VerticalControl](CRITICAL): Failure to ascend, stopping mission after 300.232788 seconds, depthRate=0.000618 m/s, pitch=2.175293 deg.
2013-01-18T17:25:05.097Z,1358529905.097 [CommandLine](IMPORTANT): got command report periodic 5.000000 platform_mass_position
2013-01-18T17:25:05.136Z,1358529905.136 [Reporter](INFO): platform_mass_position -0.000015 m
2013-01-18T17:25:05.967Z,1358529905.967 [Reporter](INFO): platform_pitch_angle 2.285156 arcdeg
2013-01-18T17:25:10.339Z,1358529910.339 [Reporter](INFO): platform_mass_position -0.000015 m
2013-01-18T17:25:11.133Z,1358529911.133 [Reporter](INFO): platform_pitch_angle 2.153320 arcdeg
2013-01-18T17:25:15.564Z,1358529915.564 [Reporter](INFO): platform_mass_position -0.000015 m
2013-01-18T17:25:16.360Z,1358529916.360 [Reporter](INFO): platform_pitch_angle 2.197266 arcdeg
2013-01-18T17:25:17.508Z,1358529917.508 [DAT](INFO): Init failed - response: 00:00:06.9012 , LVL= 32752, 32753, 32754, 29379, AGC=  77, IDX= 82 0.08, 0.890, PHS= 2.494, 1.751, 1.635, |v|= 1.288, RAW=  82.9,-68.7, CAL=  92.1,-68.5, ROT= 171.1,-68.5, CMP= 293.0,  1.3,   0.5, 00:00:00.0000 
00:00:08.9010 , LVL= 32752, 32753, 32754, 32755, AGC=  77, IDX= 62 0.35,-0.075, PHS= 2.500, 1.729, 1.626, |v|= 1.287, RAW=  83.9,-68.1, CAL=  93.1,-67.9, ROT= 172.1,-67.9, CMP=  23.3
2013-01-18T17:25:17.508Z,1358529917.508 [DAT](FAULT): DAT failed to initialize
2013-01-18T17:25:17.508Z,1358529917.508 [DAT] Communications Fault, FailCount= 1
2013-01-18T17:25:17.508Z,1358529917.508 [DAT](ERROR): Communications Fault
2013-01-18T17:25:17.599Z,1358529917.599 [CBIT](ERROR): Communications Fault in component: DAT
2013-01-18T17:25:17.863Z,1358529917.863 [DAT](INFO): Powering down
2013-01-18T17:25:18.791Z,1358529918.791 [CBIT](INFO): Clearing failed state for component DAT
2013-01-18T17:25:18.791Z,1358529918.791 [DAT] No Fault, FailCount= 1
2013-01-18T17:25:20.735Z,1358529920.735 [Reporter](INFO): platform_mass_position -0.000015 m
2013-01-18T17:25:21.062Z,1358529921.062 [DAT](INFO): Powering up
2013-01-18T17:25:21.063Z,1358529921.063 [DAT](DEBUG): Initializing DAT.
2013-01-18T17:25:21.563Z,1358529921.563 [Reporter](INFO): platform_pitch_angle 2.175293 arcdeg
2013-01-18T17:25:23.105Z,1358529923.105 [CommandLine](IMPORTANT): got command report periodic 5.000000 platform_buoyancy_position
2013-01-18T17:25:23.135Z,1358529923.135 [Reporter](INFO): platform_buoyancy_position 294.509839 cc
2013-01-18T17:25:25.939Z,1358529925.939 [Reporter](INFO): platform_mass_position -0.000015 m
2013-01-18T17:25:26.733Z,1358529926.733 [Reporter](INFO): platform_pitch_angle 2.109375 arcdeg
2013-01-18T17:25:28.392Z,1358529928.392 [Reporter](INFO): platform_buoyancy_position 277.453742 cc
2013-01-18T17:25:31.139Z,1358529931.139 [Reporter](INFO): platform_mass_position -0.000015 m
2013-01-18T17:25:31.943Z,1358529931.943 [Reporter](INFO): platform_pitch_angle 2.241211 arcdeg
2013-01-18T17:25:33.535Z,1358529933.536 [Reporter](INFO): platform_buoyancy_position 260.129018 cc
2013-01-18T17:25:36.347Z,1358529936.347 [Reporter](INFO): platform_mass_position -0.000015 m
2013-01-18T17:25:37.159Z,1358529937.159 [Reporter](INFO): platform_pitch_angle 2.219238 arcdeg
2013-01-18T17:25:38.733Z,1358529938.733 [Reporter](INFO): platform_buoyancy_position 243.072936 cc
2013-01-18T17:25:40.327Z,1358529940.327 [DAT](INFO): Init failed - response: 00:00:07.4701 , LVL= 32752, 32753, 32754, 19763, AGC=  82, IDX=460 0.00, 0.070, PHS= 1.811, 1.334, 1.910, |v|= 1.077, RAW= 159.2,-73.3, CAL= 157.8,-71.9, ROT= 236.8,-71.9, CMP= 293.0,  1.3,   0.5, 00:00:00.0000 
00:00:08.3403 , LVL= 32752, 32753, 32754, 19763, AGC=  75, IDX=294 0.00,-2.661, PHS= 1.797, 1.317, 1.891, |v|= 1.067, RAW= 158.8,-73.1, CAL= 157.4,-71.7, ROT= 236.4,-71.7, CMP=  23.3
2013-01-18T17:25:40.327Z,1358529940.327 [DAT](FAULT): DAT failed to initialize
2013-01-18T17:25:40.327Z,1358529940.327 [DAT] Communications Fault, FailCount= 2
2013-01-18T17:25:40.327Z,1358529940.328 [DAT](ERROR): Communications Fault
2013-01-18T17:25:40.398Z,1358529940.398 [CBIT](ERROR): Communications Fault in component: DAT
2013-01-18T17:25:40.666Z,1358529940.666 [DAT](INFO): Powering down
2013-01-18T17:25:41.538Z,1358529941.538 [CBIT](INFO): Clearing failed state for component DAT
2013-01-18T17:25:41.538Z,1358529941.538 [DAT] No Fault, FailCount= 2
2013-01-18T17:25:41.540Z,1358529941.540 [Reporter](INFO): platform_mass_position -0.000015 m
2013-01-18T17:25:42.359Z,1358529942.359 [Reporter](INFO): platform_pitch_angle 2.153320 arcdeg
2013-01-18T17:25:43.867Z,1358529943.866 [DAT](INFO): Powering up
2013-01-18T17:25:43.867Z,1358529943.867 [DAT](DEBUG): Initializing DAT.
2013-01-18T17:25:43.964Z,1358529943.964 [Reporter](INFO): platform_buoyancy_position 226.016811 cc
2013-01-18T17:25:45.512Z,1358529945.513 [CommandLine](IMPORTANT): got command get depth foot
2013-01-18T17:25:45.513Z,1358529945.513 [CommandLine](IMPORTANT): depth 15.365201 foot
2013-01-18T17:25:46.739Z,1358529946.739 [Reporter](INFO): platform_mass_position -0.000015 m
2013-01-18T17:25:47.587Z,1358529947.588 [Reporter](INFO): platform_pitch_angle 2.263184 arcdeg
2013-01-18T17:25:49.139Z,1358529949.139 [Reporter](INFO): platform_buoyancy_position 208.692145 cc
2013-01-18T17:25:51.931Z,1358529951.931 [Reporter](INFO): platform_mass_position -0.000015 m
2013-01-18T17:25:52.759Z,1358529952.759 [Reporter](INFO): platform_pitch_angle 2.197266 arcdeg
2013-01-18T17:25:54.391Z,1358529954.391 [Reporter](INFO): platform_buoyancy_position 191.501735 cc
2013-01-18T17:25:57.139Z,1358529957.139 [Reporter](INFO): platform_mass_position -0.000015 m
2013-01-18T17:25:57.934Z,1358529957.934 [Reporter](INFO): platform_pitch_angle 2.241211 arcdeg
2013-01-18T17:25:59.539Z,1358529959.539 [Reporter](INFO): platform_buoyancy_position 174.579924 cc
2013-01-18T17:26:02.343Z,1358529962.343 [Reporter](INFO): platform_mass_position -0.000015 m
2013-01-18T17:26:03.118Z,1358529963.118 [DAT](INFO): Init failed - response: 00:00:07.7122 , LVL= 32752, 32753, 32754, 29923, AGC=  76, IDX= 82 0.35,-0.963, PHS= 1.859, 1.753, 1.577, |v|= 1.069, RAW=  51.7,-82.3, CAL=  56.8,-82.5, ROT= 135.8,-82.5, CMP= 293.0,  1.3,   0.5, 00:00:00.0000 
00:00:08.7122 , LVL= 32752, 32753, 32754, 32755, AGC=  73, IDX= 30-0.28, 1.736, PHS= 1.910, 1.810, 1.644, |v|= 1.103, RAW=  51.8,-82.9, CAL=  56.5,-83.1, ROT= 135.5,-83.1, CMP=  23.4
2013-01-18T17:26:03.118Z,1358529963.118 [DAT](FAULT): DAT failed to initialize
2013-01-18T17:26:03.118Z,1358529963.118 [DAT] Communications Fault, FailCount= 3
2013-01-18T17:26:03.118Z,1358529963.118 [DAT](ERROR): Communications Fault
2013-01-18T17:26:03.191Z,1358529963.191 [CBIT](ERROR): Communications Fault in component: DAT
2013-01-18T17:26:03.191Z,1358529963.191 [CBIT](CRITICAL): Communications Fault in component: DAT
2013-01-18T17:26:03.192Z,1358529963.192 [Reporter](INFO): platform_pitch_angle 2.263184 arcdeg
2013-01-18T17:26:03.462Z,1358529963.462 [DAT](INFO): Powering down
2013-01-18T17:26:04.739Z,1358529964.739 [Reporter](INFO): platform_buoyancy_position 157.255214 cc
2013-01-18T17:26:07.535Z,1358529967.535 [Reporter](INFO): platform_mass_position -0.000015 m
2013-01-18T17:26:08.343Z,1358529968.343 [Reporter](INFO): platform_pitch_angle 2.263184 arcdeg
2013-01-18T17:26:09.939Z,1358529969.939 [Reporter](INFO): platform_buoyancy_position 140.064818 cc
2013-01-18T17:26:12.739Z,1358529972.739 [Reporter](INFO): platform_mass_position -0.000015 m
2013-01-18T17:26:13.588Z,1358529973.588 [Reporter](INFO): platform_pitch_angle 2.241211 arcdeg
2013-01-18T17:26:15.139Z,1358529975.139 [Reporter](INFO): platform_buoyancy_position 122.874408 cc
2013-01-18T17:26:17.939Z,1358529977.939 [Reporter](INFO): platform_mass_position -0.000015 m
2013-01-18T17:26:18.739Z,1358529978.739 [Reporter](INFO): platform_pitch_angle 2.241211 arcdeg
2013-01-18T17:26:20.444Z,1358529980.444 [Reporter](INFO): platform_buoyancy_position 109.847315 cc
2013-01-18T17:26:23.163Z,1358529983.163 [Reporter](INFO): platform_mass_position -0.000015 m
2013-01-18T17:26:23.930Z,1358529983.930 [Reporter](INFO): platform_pitch_angle 2.197266 arcdeg
2013-01-18T17:26:25.736Z,1358529985.736 [Reporter](INFO): platform_buoyancy_position 109.847315 cc
2013-01-18T17:26:28.472Z,1358529988.472 [Reporter](INFO): platform_mass_position -0.000015 m
2013-01-18T17:26:29.232Z,1358529989.232 [Reporter](INFO): platform_pitch_angle 2.197266 arcdeg
2013-01-18T17:26:30.944Z,1358529990.944 [Reporter](INFO): platform_buoyancy_position 109.847315 cc
2013-01-18T17:26:33.643Z,1358529993.644 [Reporter](INFO): platform_mass_position -0.000015 m
2013-01-18T17:26:34.439Z,1358529994.439 [Reporter](INFO): platform_pitch_angle 2.241211 arcdeg
2013-01-18T17:26:36.072Z,1358529996.072 [Reporter](INFO): platform_buoyancy_position 109.847315 cc
2013-01-18T17:26:38.537Z,1358529998.537 [CommandLine](IMPORTANT): got command maintain control VerticalControl.massPositionAction 2.000000 centimeter
2013-01-18T17:26:38.855Z,1358529998.855 [Reporter](INFO): platform_mass_position -0.000015 m
2013-01-18T17:26:39.643Z,1358529999.644 [Reporter](INFO): platform_pitch_angle 2.285156 arcdeg
2013-01-18T17:26:41.364Z,1358530001.364 [Reporter](INFO): platform_buoyancy_position 109.847315 cc
2013-01-18T17:26:44.103Z,1358530004.103 [Reporter](INFO): platform_mass_position 0.002241 m
2013-01-18T17:26:44.895Z,1358530004.895 [Reporter](INFO): platform_pitch_angle 2.175293 arcdeg
2013-01-18T17:26:46.560Z,1358530006.560 [Reporter](INFO): platform_buoyancy_position 109.847315 cc
2013-01-18T17:26:49.299Z,1358530009.299 [Reporter](INFO): platform_mass_position 0.006107 m
2013-01-18T17:26:50.095Z,1358530010.095 [Reporter](INFO): platform_pitch_angle 2.109375 arcdeg
2013-01-18T17:26:51.695Z,1358530011.695 [Reporter](INFO): platform_buoyancy_position 109.847315 cc
2013-01-18T17:26:54.500Z,1358530014.500 [Reporter](INFO): platform_mass_position 0.009974 m
2013-01-18T17:26:55.295Z,1358530015.295 [Reporter](INFO): platform_pitch_angle 2.021484 arcdeg
2013-01-18T17:26:56.896Z,1358530016.895 [Reporter](INFO): platform_buoyancy_position 109.847315 cc
2013-01-18T17:26:59.699Z,1358530019.699 [Reporter](INFO): platform_mass_position 0.013837 m
2013-01-18T17:27:00.499Z,1358530020.499 [Reporter](INFO): platform_pitch_angle 1.867676 arcdeg
2013-01-18T17:27:02.127Z,1358530022.127 [Reporter](INFO): platform_buoyancy_position 109.847315 cc
2013-01-18T17:27:04.899Z,1358530024.899 [Reporter](INFO): platform_mass_position 0.017706 m
2013-01-18T17:27:05.699Z,1358530025.699 [Reporter](INFO): platform_pitch_angle 1.911621 arcdeg
2013-01-18T17:27:07.295Z,1358530027.295 [Reporter](INFO): platform_buoyancy_position 109.847315 cc
2013-01-18T17:27:10.056Z,1358530030.056 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:27:10.859Z,1358530030.859 [Reporter](INFO): platform_pitch_angle 1.889648 arcdeg
2013-01-18T17:27:12.460Z,1358530032.460 [Reporter](INFO): platform_buoyancy_position 109.847315 cc
2013-01-18T17:27:15.259Z,1358530035.260 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:27:16.060Z,1358530036.059 [Reporter](INFO): platform_pitch_angle 1.801758 arcdeg
2013-01-18T17:27:17.660Z,1358530037.660 [Reporter](INFO): platform_buoyancy_position 109.847315 cc
2013-01-18T17:27:20.459Z,1358530040.459 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:27:21.284Z,1358530041.284 [Reporter](INFO): platform_pitch_angle 1.801758 arcdeg
2013-01-18T17:27:22.859Z,1358530042.859 [Reporter](INFO): platform_buoyancy_position 109.847315 cc
2013-01-18T17:27:25.667Z,1358530045.667 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:27:26.463Z,1358530046.463 [Reporter](INFO): platform_pitch_angle 1.823731 arcdeg
2013-01-18T17:27:28.059Z,1358530048.059 [Reporter](INFO): platform_buoyancy_position 109.847315 cc
2013-01-18T17:27:30.879Z,1358530050.879 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:27:31.660Z,1358530051.659 [Reporter](INFO): platform_pitch_angle 1.823731 arcdeg
2013-01-18T17:27:33.259Z,1358530053.260 [Reporter](INFO): platform_buoyancy_position 109.847315 cc
2013-01-18T17:27:36.059Z,1358530056.059 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:27:36.859Z,1358530056.859 [Reporter](INFO): platform_pitch_angle 1.779785 arcdeg
2013-01-18T17:27:38.463Z,1358530058.463 [Reporter](INFO): platform_buoyancy_position 109.847315 cc
2013-01-18T17:27:41.259Z,1358530061.259 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:27:42.096Z,1358530062.096 [Reporter](INFO): platform_pitch_angle 1.955566 arcdeg
2013-01-18T17:27:43.684Z,1358530063.684 [Reporter](INFO): platform_buoyancy_position 109.847315 cc
2013-01-18T17:27:46.463Z,1358530066.464 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:27:47.296Z,1358530067.296 [Reporter](INFO): platform_pitch_angle 1.757812 arcdeg
2013-01-18T17:27:48.859Z,1358530068.859 [Reporter](INFO): platform_buoyancy_position 109.847315 cc
2013-01-18T17:27:51.659Z,1358530071.659 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:27:52.504Z,1358530072.504 [Reporter](INFO): platform_pitch_angle 1.757812 arcdeg
2013-01-18T17:27:54.059Z,1358530074.059 [Reporter](INFO): platform_buoyancy_position 109.847315 cc
2013-01-18T17:27:56.884Z,1358530076.884 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:27:57.696Z,1358530077.696 [Reporter](INFO): platform_pitch_angle 1.867676 arcdeg
2013-01-18T17:27:59.259Z,1358530079.260 [Reporter](INFO): platform_buoyancy_position 109.847315 cc
2013-01-18T17:28:02.060Z,1358530082.060 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:28:02.927Z,1358530082.927 [Reporter](INFO): platform_pitch_angle 1.801758 arcdeg
2013-01-18T17:28:04.463Z,1358530084.464 [Reporter](INFO): platform_buoyancy_position 109.847315 cc
2013-01-18T17:28:07.259Z,1358530087.259 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:28:08.060Z,1358530088.059 [Reporter](INFO): platform_pitch_angle 1.889648 arcdeg
2013-01-18T17:28:09.684Z,1358530089.684 [Reporter](INFO): platform_buoyancy_position 109.847315 cc
2013-01-18T17:28:12.463Z,1358530092.463 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:28:13.259Z,1358530093.259 [Reporter](INFO): platform_pitch_angle 1.911621 arcdeg
2013-01-18T17:28:14.859Z,1358530094.859 [Reporter](INFO): platform_buoyancy_position 109.847315 cc
2013-01-18T17:28:17.660Z,1358530097.660 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:28:18.463Z,1358530098.463 [Reporter](INFO): platform_pitch_angle 1.801758 arcdeg
2013-01-18T17:28:20.060Z,1358530100.060 [Reporter](INFO): platform_buoyancy_position 109.847315 cc
2013-01-18T17:28:22.884Z,1358530102.884 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:28:23.675Z,1358530103.675 [Reporter](INFO): platform_pitch_angle 1.779785 arcdeg
2013-01-18T17:28:25.259Z,1358530105.259 [Reporter](INFO): platform_buoyancy_position 109.847315 cc
2013-01-18T17:28:28.059Z,1358530108.059 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:28:28.863Z,1358530108.864 [Reporter](INFO): platform_pitch_angle 1.779785 arcdeg
2013-01-18T17:28:30.487Z,1358530110.487 [Reporter](INFO): platform_buoyancy_position 109.847315 cc
2013-01-18T17:28:33.388Z,1358530113.388 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:28:34.055Z,1358530114.055 [Reporter](INFO): platform_pitch_angle 1.757812 arcdeg
2013-01-18T17:28:35.680Z,1358530115.680 [Reporter](INFO): platform_buoyancy_position 109.847315 cc
2013-01-18T17:28:38.508Z,1358530118.508 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:28:39.259Z,1358530119.260 [Reporter](INFO): platform_pitch_angle 1.933594 arcdeg
2013-01-18T17:28:40.859Z,1358530120.859 [Reporter](INFO): platform_buoyancy_position 109.847315 cc
2013-01-18T17:28:43.696Z,1358530123.696 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:28:44.463Z,1358530124.463 [Reporter](INFO): platform_pitch_angle 1.735840 arcdeg
2013-01-18T17:28:44.677Z,1358530124.677 [CommandLine](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 950.000000 cubic_centimeter
2013-01-18T17:28:46.122Z,1358530126.122 [Reporter](INFO): platform_buoyancy_position 107.698506 cc
2013-01-18T17:28:48.929Z,1358530128.929 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:28:49.684Z,1358530129.684 [Reporter](INFO): platform_pitch_angle 1.757812 arcdeg
2013-01-18T17:28:51.284Z,1358530131.284 [Reporter](INFO): platform_buoyancy_position 120.591314 cc
2013-01-18T17:28:54.091Z,1358530134.092 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:28:54.904Z,1358530134.904 [Reporter](INFO): platform_pitch_angle 1.757812 arcdeg
2013-01-18T17:28:56.488Z,1358530136.488 [Reporter](INFO): platform_buoyancy_position 137.916009 cc
2013-01-18T17:28:59.284Z,1358530139.284 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:29:00.087Z,1358530140.087 [Reporter](INFO): platform_pitch_angle 1.801758 arcdeg
2013-01-18T17:29:01.711Z,1358530141.711 [Reporter](INFO): platform_buoyancy_position 155.106420 cc
2013-01-18T17:29:04.488Z,1358530144.487 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:29:05.287Z,1358530145.287 [Reporter](INFO): platform_pitch_angle 1.823731 arcdeg
2013-01-18T17:29:06.887Z,1358530146.888 [Reporter](INFO): platform_buoyancy_position 172.296815 cc
2013-01-18T17:29:09.688Z,1358530149.688 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:29:10.488Z,1358530150.487 [Reporter](INFO): platform_pitch_angle 1.757812 arcdeg
2013-01-18T17:29:12.087Z,1358530152.087 [Reporter](INFO): platform_buoyancy_position 189.487211 cc
2013-01-18T17:29:14.887Z,1358530154.887 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:29:15.684Z,1358530155.684 [Reporter](INFO): platform_pitch_angle 1.735840 arcdeg
2013-01-18T17:29:17.284Z,1358530157.284 [Reporter](INFO): platform_buoyancy_position 206.543336 cc
2013-01-18T17:29:20.091Z,1358530160.091 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:29:20.911Z,1358530160.911 [Reporter](INFO): platform_pitch_angle 1.823731 arcdeg
2013-01-18T17:29:22.488Z,1358530162.488 [Reporter](INFO): platform_buoyancy_position 223.733732 cc
2013-01-18T17:29:25.284Z,1358530165.284 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:29:26.087Z,1358530166.087 [Reporter](INFO): platform_pitch_angle 1.801758 arcdeg
2013-01-18T17:29:27.684Z,1358530167.684 [Reporter](INFO): platform_buoyancy_position 240.924128 cc
2013-01-18T17:29:30.512Z,1358530170.511 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:29:31.284Z,1358530171.284 [Reporter](INFO): platform_pitch_angle 1.735840 arcdeg
2013-01-18T17:29:32.884Z,1358530172.884 [Reporter](INFO): platform_buoyancy_position 258.114538 cc
2013-01-18T17:29:35.684Z,1358530175.684 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:29:36.487Z,1358530176.487 [Reporter](INFO): platform_pitch_angle 1.801758 arcdeg
2013-01-18T17:29:38.090Z,1358530178.090 [Reporter](INFO): platform_buoyancy_position 274.902035 cc
2013-01-18T17:29:40.884Z,1358530180.884 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:29:41.684Z,1358530181.684 [Reporter](INFO): platform_pitch_angle 1.735840 arcdeg
2013-01-18T17:29:43.327Z,1358530183.327 [Reporter](INFO): platform_buoyancy_position 290.615135 cc
2013-01-18T17:29:46.087Z,1358530186.087 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:29:46.884Z,1358530186.884 [Reporter](INFO): platform_pitch_angle 1.735840 arcdeg
2013-01-18T17:29:48.487Z,1358530188.487 [Reporter](INFO): platform_buoyancy_position 307.671231 cc
2013-01-18T17:29:49.541Z,1358530189.541 [CommandLine](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 100.000000 cubic_centimeter
2013-01-18T17:29:51.287Z,1358530191.287 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:29:52.086Z,1358530192.086 [Reporter](INFO): platform_pitch_angle 1.801758 arcdeg
2013-01-18T17:29:53.688Z,1358530193.688 [Reporter](INFO): platform_buoyancy_position 309.820025 cc
2013-01-18T17:29:56.504Z,1358530196.504 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:29:57.292Z,1358530197.292 [Reporter](INFO): platform_pitch_angle 1.757812 arcdeg
2013-01-18T17:29:58.884Z,1358530198.884 [Reporter](INFO): platform_buoyancy_position 292.629644 cc
2013-01-18T17:30:01.684Z,1358530201.684 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:30:02.488Z,1358530202.487 [Reporter](INFO): platform_pitch_angle 1.823731 arcdeg
2013-01-18T17:30:03.226Z,1358530203.226 [VerticalControl](CRITICAL): Failure to ascend, dropping drop weight after 300.148102 seconds, depthRate=-0.001223 m/s, pitch=1.735840 deg.
2013-01-18T17:30:04.087Z,1358530204.087 [Reporter](INFO): platform_buoyancy_position 275.304919 cc
2013-01-18T17:30:06.001Z,1358530206.001 [CommandLine](IMPORTANT): got command maintain control VerticalControl.massPositionAction -2.000000 centimeter
2013-01-18T17:30:06.887Z,1358530206.888 [Reporter](INFO): platform_mass_position 0.019981 m
2013-01-18T17:30:08.259Z,1358530208.259 [Reporter](INFO): platform_pitch_angle 1.757812 arcdeg
2013-01-18T17:30:09.400Z,1358530209.399 [Reporter](INFO): platform_buoyancy_position 258.114538 cc
2013-01-18T17:30:12.167Z,1358530212.167 [Reporter](INFO): platform_mass_position 0.017109 m
2013-01-18T17:30:13.367Z,1358530213.367 [Reporter](INFO): platform_pitch_angle 1.779785 arcdeg
2013-01-18T17:30:14.564Z,1358530214.564 [Reporter](INFO): platform_buoyancy_position 240.924128 cc
2013-01-18T17:30:17.359Z,1358530217.359 [Reporter](INFO): platform_mass_position 0.013246 m
2013-01-18T17:30:18.567Z,1358530218.568 [Reporter](INFO): platform_pitch_angle 1.801758 arcdeg
2013-01-18T17:30:19.760Z,1358530219.760 [Reporter](INFO): platform_buoyancy_position 223.733732 cc
2013-01-18T17:30:22.571Z,1358530222.571 [Reporter](INFO): platform_mass_position 0.009374 m
2013-01-18T17:30:23.759Z,1358530223.759 [Reporter](INFO): platform_pitch_angle 1.801758 arcdeg
2013-01-18T17:30:24.967Z,1358530224.967 [Reporter](INFO): platform_buoyancy_position 206.543336 cc
2013-01-18T17:30:27.767Z,1358530227.767 [Reporter](INFO): platform_mass_position 0.005508 m
2013-01-18T17:30:28.967Z,1358530228.967 [Reporter](INFO): platform_pitch_angle 1.999512 arcdeg
2013-01-18T17:30:30.168Z,1358530230.168 [Reporter](INFO): platform_buoyancy_position 189.352941 cc
2013-01-18T17:30:32.960Z,1358530232.960 [Reporter](INFO): platform_mass_position 0.001645 m
2013-01-18T17:30:34.167Z,1358530234.167 [Reporter](INFO): platform_pitch_angle 1.955566 arcdeg
2013-01-18T17:30:35.372Z,1358530235.372 [Reporter](INFO): platform_buoyancy_position 172.296815 cc
2013-01-18T17:30:38.204Z,1358530238.204 [Reporter](INFO): platform_mass_position -0.002255 m
2013-01-18T17:30:39.371Z,1358530239.371 [Reporter](INFO): platform_pitch_angle 2.153320 arcdeg
2013-01-18T17:30:40.567Z,1358530240.567 [Reporter](INFO): platform_buoyancy_position 155.106420 cc
2013-01-18T17:30:43.359Z,1358530243.359 [Reporter](INFO): platform_mass_position -0.006092 m
2013-01-18T17:30:44.567Z,1358530244.568 [Reporter](INFO): platform_pitch_angle 2.416992 arcdeg
2013-01-18T17:30:45.768Z,1358530245.768 [Reporter](INFO): platform_buoyancy_position 137.916009 cc
2013-01-18T17:30:48.559Z,1358530248.559 [Reporter](INFO): platform_mass_position -0.009962 m
2013-01-18T17:30:49.760Z,1358530249.760 [Reporter](INFO): platform_pitch_angle 2.988281 arcdeg
2013-01-18T17:30:50.968Z,1358530250.968 [Reporter](INFO): platform_buoyancy_position 120.725606 cc
2013-01-18T17:30:53.771Z,1358530253.771 [Reporter](INFO): platform_mass_position -0.013834 m
2013-01-18T17:30:54.967Z,1358530254.967 [Reporter](INFO): platform_pitch_angle 4.328613 arcdeg
2013-01-18T17:30:56.160Z,1358530256.159 [Reporter](INFO): platform_buoyancy_position 109.981607 cc
2013-01-18T17:30:58.960Z,1358530258.960 [Reporter](INFO): platform_mass_position -0.017699 m
2013-01-18T17:31:00.167Z,1358530260.167 [Reporter](INFO): platform_pitch_angle 6.921387 arcdeg
2013-01-18T17:31:01.360Z,1358530261.360 [Reporter](INFO): platform_buoyancy_position 109.981607 cc
2013-01-18T17:31:03.330Z,1358530263.330 [CBIT](INFO): Clearing failed count for component DAT
2013-01-18T17:31:03.330Z,1358530263.330 [DAT] No Fault, FailCount= 3
2013-01-18T17:31:03.674Z,1358530263.674 [DAT](INFO): Powering up
2013-01-18T17:31:03.675Z,1358530263.675 [DAT](DEBUG): Initializing DAT.
2013-01-18T17:31:04.163Z,1358530264.163 [Reporter](INFO): platform_mass_position -0.019995 m
2013-01-18T17:31:05.331Z,1358530265.331 [Reporter](INFO): platform_pitch_angle 10.349121 arcdeg
2013-01-18T17:31:06.576Z,1358530266.576 [Reporter](INFO): platform_buoyancy_position 109.981607 cc
2013-01-18T17:31:09.330Z,1358530269.330 [Reporter](INFO): platform_mass_position -0.019995 m
2013-01-18T17:31:10.527Z,1358530270.527 [Reporter](INFO): platform_pitch_angle 11.513672 arcdeg
2013-01-18T17:31:11.776Z,1358530271.776 [Reporter](INFO): platform_buoyancy_position 109.981607 cc
2013-01-18T17:31:14.527Z,1358530274.527 [Reporter](INFO): platform_mass_position -0.019995 m
2013-01-18T17:31:15.728Z,1358530275.727 [Reporter](INFO): platform_pitch_angle 9.975586 arcdeg
2013-01-18T17:31:16.984Z,1358530276.984 [Reporter](INFO): platform_buoyancy_position 109.981607 cc
2013-01-18T17:31:19.731Z,1358530279.731 [Reporter](INFO): platform_mass_position -0.019995 m
2013-01-18T17:31:20.931Z,1358530280.931 [Reporter](INFO): platform_pitch_angle 9.316406 arcdeg
2013-01-18T17:31:22.176Z,1358530282.175 [Reporter](INFO): platform_buoyancy_position 109.981607 cc
2013-01-18T17:31:22.922Z,1358530282.922 [DAT](INFO): Init failed - response: 00:00:08.0666 , LVL= 32752, 32753, 32754, 28915, AGC=  76, IDX= 82 0.06, 0.298, PHS= 2.244, 2.011, 1.347, |v|= 1.235, RAW=  44.5,-67.7, CAL=  59.2,-68.4, ROT= 138.2,-68.4, CMP=  12.5, 10.7,   0.6, 00:00:08.0419 
00:00:09.0665 , LVL= 32752, 32753, 32754, 32755, AGC=  74, IDX= 82 0.24,-0.223, PHS= 2.232, 2.021, 1.368, |v|= 1.233, RAW=  43.6,-68.5, CAL=  58.0,-69.1, ROT= 137.0,-69.1, CMP=  12.9
2013-01-18T17:31:22.922Z,1358530282.922 [DAT](FAULT): DAT failed to initialize
2013-01-18T17:31:22.922Z,1358530282.922 [DAT] Communications Fault, FailCount= 1
2013-01-18T17:31:22.922Z,1358530282.922 [DAT](ERROR): Communications Fault
2013-01-18T17:31:22.970Z,1358530282.970 [CBIT](ERROR): Communications Fault in component: DAT
2013-01-18T17:31:23.274Z,1358530283.274 [DAT](INFO): Powering down
2013-01-18T17:31:24.127Z,1358530284.127 [CBIT](INFO): Clearing failed state for component DAT
2013-01-18T17:31:24.127Z,1358530284.127 [DAT] No Fault, FailCount= 1
2013-01-18T17:31:24.931Z,1358530284.931 [Reporter](INFO): platform_mass_position -0.019995 m
2013-01-18T17:31:26.131Z,1358530286.131 [Reporter](INFO): platform_pitch_angle 9.953613 arcdeg
2013-01-18T17:31:26.475Z,1358530286.475 [DAT](INFO): Powering up
2013-01-18T17:31:26.475Z,1358530286.475 [DAT](DEBUG): Initializing DAT.
2013-01-18T17:31:27.380Z,1358530287.380 [Reporter](INFO): platform_buoyancy_position 109.981607 cc
2013-01-18T17:31:30.168Z,1358530290.168 [Reporter](INFO): platform_mass_position -0.019995 m
2013-01-18T17:31:31.327Z,1358530291.328 [Reporter](INFO): platform_pitch_angle 9.821777 arcdeg
2013-01-18T17:31:32.528Z,1358530292.528 [Reporter](INFO): platform_buoyancy_position 109.981607 cc
2013-01-18T17:31:35.331Z,1358530295.331 [Reporter](INFO): platform_mass_position -0.019995 m
2013-01-18T17:31:36.567Z,1358530296.567 [Reporter](INFO): platform_pitch_angle 9.448243 arcdeg
2013-01-18T17:31:37.731Z,1358530297.731 [Reporter](INFO): platform_buoyancy_position 109.981607 cc
2013-01-18T17:31:40.531Z,1358530300.531 [Reporter](INFO): platform_mass_position -0.019995 m
2013-01-18T17:31:41.731Z,1358530301.731 [Reporter](INFO): platform_pitch_angle 9.887695 arcdeg
2013-01-18T17:31:42.964Z,1358530302.964 [Reporter](INFO): platform_buoyancy_position 109.981607 cc
2013-01-18T17:31:45.731Z,1358530305.731 [DAT](INFO): Init failed - response: 00:00:07.2109 , LVL= 32752, 32753, 32754, 30771, AGC=  75, IDX= 82 0.39,-0.853, PHS= 2.384, 2.146, 1.493, |v|= 1.313, RAW=  44.9,-69.3, CAL=  58.7,-69.9, ROT= 137.7,-69.9, CMP= 293.0,  1.3,   0.5, 00:00:00.0000 
00:00:08.2108 , LVL= 32752, 32753, 32754, 30387, AGC=  76, IDX= 82 0.44,-1.373, PHS= 2.256, 2.069, 1.349, |v|= 1.253, RAW=  41.2,-67.4, CAL=  56.6,-68.1, ROT= 135.6,-68.1, CMP=  11.5
2013-01-18T17:31:45.731Z,1358530305.731 [DAT](FAULT): DAT failed to initialize
2013-01-18T17:31:45.731Z,1358530305.731 [DAT] Communications Fault, FailCount= 2
2013-01-18T17:31:45.731Z,1358530305.731 [DAT](ERROR): Communications Fault
2013-01-18T17:31:45.779Z,1358530305.779 [CBIT](ERROR): Communications Fault in component: DAT
2013-01-18T17:31:45.780Z,1358530305.780 [Reporter](INFO): platform_mass_position -0.019995 m
2013-01-18T17:31:46.110Z,1358530306.110 [DAT](INFO): Powering down
2013-01-18T17:31:46.927Z,1358530306.927 [CBIT](INFO): Clearing failed state for component DAT
2013-01-18T17:31:46.927Z,1358530306.927 [DAT] No Fault, FailCount= 2
2013-01-18T17:31:46.928Z,1358530306.928 [Reporter](INFO): platform_pitch_angle 10.458984 arcdeg
2013-01-18T17:31:48.128Z,1358530308.128 [Reporter](INFO): platform_buoyancy_position 109.981607 cc
2013-01-18T17:31:49.275Z,1358530309.275 [DAT](INFO): Powering up
2013-01-18T17:31:49.275Z,1358530309.275 [DAT](DEBUG): Initializing DAT.
2013-01-18T17:31:50.931Z,1358530310.931 [Reporter](INFO): platform_mass_position -0.019995 m
2013-01-18T17:31:52.131Z,1358530312.131 [Reporter](INFO): platform_pitch_angle 9.887695 arcdeg
2013-01-18T17:31:53.331Z,1358530313.330 [Reporter](INFO): platform_buoyancy_position 109.981607 cc
2013-01-18T17:31:56.163Z,1358530316.163 [Reporter](INFO): platform_mass_position -0.019995 m
2013-01-18T17:31:57.331Z,1358530317.331 [Reporter](INFO): platform_pitch_angle 9.448243 arcdeg
2013-01-18T17:31:58.512Z,1358530318.511 [Reporter](INFO): platform_buoyancy_position 109.981607 cc
2013-01-18T17:32:01.334Z,1358530321.334 [Reporter](INFO): platform_mass_position -0.019995 m
2013-01-18T17:32:02.571Z,1358530322.571 [Reporter](INFO): platform_pitch_angle 9.711914 arcdeg
2013-01-18T17:32:03.728Z,1358530323.728 [Reporter](INFO): platform_buoyancy_position 109.981607 cc
2013-01-18T17:32:06.532Z,1358530326.532 [Reporter](INFO): platform_mass_position -0.019995 m
2013-01-18T17:32:07.727Z,1358530327.727 [Reporter](INFO): platform_pitch_angle 10.107422 arcdeg
2013-01-18T17:32:08.528Z,1358530328.528 [DAT](INFO): Init failed - response: 00:00:07.7333 , LVL= 32752, 32753, 32754, 28147, AGC=  77, IDX= 82-0.24,-2.402, PHS= 2.383, 2.061, 1.500, |v|= 1.293, RAW=  51.1,-69.7, CAL=  63.9,-70.2, ROT= 142.9,-70.2, CMP= 293.0,  1.3,   0.5, 00:00:00.0000 
00:00:08.7333 , LVL= 32752, 32753, 32754, 28515, AGC=  76, IDX= 62 0.04, 2.826, PHS= 2.441, 2.142, 1.536, |v|= 1.331, RAW=  48.9,-69.6, CAL=  62.0,-70.2, ROT= 141.0,-70.2, CMP=  13.1
2013-01-18T17:32:08.528Z,1358530328.528 [DAT](FAULT): DAT failed to initialize
2013-01-18T17:32:08.528Z,1358530328.528 [DAT] Communications Fault, FailCount= 3
2013-01-18T17:32:08.528Z,1358530328.528 [DAT](ERROR): Communications Fault
2013-01-18T17:32:08.575Z,1358530328.575 [CBIT](ERROR): Communications Fault in component: DAT
2013-01-18T17:32:08.575Z,1358530328.575 [CBIT](CRITICAL): Communications Fault in component: DAT
2013-01-18T17:32:08.910Z,1358530328.910 [DAT](INFO): Powering down
2013-01-18T17:32:08.971Z,1358530328.971 [Reporter](INFO): platform_buoyancy_position 109.981607 cc
2013-01-18T17:32:11.731Z,1358530331.731 [Reporter](INFO): platform_mass_position -0.019995 m
2013-01-18T17:32:12.976Z,1358530332.976 [Reporter](INFO): platform_pitch_angle 9.975586 arcdeg
2013-01-18T17:32:14.131Z,1358530334.131 [Reporter](INFO): platform_buoyancy_position 109.981607 cc
2013-01-18T17:32:16.931Z,1358530336.931 [Reporter](INFO): platform_mass_position -0.019995 m
2013-01-18T17:32:18.180Z,1358530338.180 [Reporter](INFO): platform_pitch_angle 10.151367 arcdeg
2013-01-18T17:32:19.328Z,1358530339.328 [Reporter](INFO): platform_buoyancy_position 109.981607 cc
2013-01-18T17:32:22.131Z,1358530342.131 [Reporter](INFO): platform_mass_position -0.019995 m
2013-01-18T17:32:23.376Z,1358530343.376 [Reporter](INFO): platform_pitch_angle 9.975586 arcdeg
2013-01-18T17:32:24.528Z,1358530344.528 [Reporter](INFO): platform_buoyancy_position 109.981607 cc
2013-01-18T17:32:27.330Z,1358530347.330 [Reporter](INFO): platform_mass_position -0.019995 m
2013-01-18T17:32:28.584Z,1358530348.584 [Reporter](INFO): platform_pitch_angle 9.799804 arcdeg
2013-01-18T17:32:29.731Z,1358530349.731 [Reporter](INFO): platform_buoyancy_position 109.981607 cc
2013-01-18T17:32:32.531Z,1358530352.531 [Reporter](INFO): platform_mass_position -0.019995 m
2013-01-18T17:32:33.728Z,1358530353.728 [Reporter](INFO): platform_pitch_angle 9.711914 arcdeg
2013-01-18T17:32:34.928Z,1358530354.928 [Reporter](INFO): platform_buoyancy_position 109.981607 cc
2013-01-18T17:32:37.767Z,1358530357.767 [Reporter](INFO): platform_mass_position -0.019995 m
2013-01-18T17:32:38.931Z,1358530358.931 [Reporter](INFO): platform_pitch_angle 9.865722 arcdeg
2013-01-18T17:32:40.131Z,1358530360.131 [Reporter](INFO): platform_buoyancy_position 109.981607 cc
2013-01-18T17:32:42.931Z,1358530362.931 [Reporter](INFO): platform_mass_position -0.019995 m
2013-01-18T17:32:44.164Z,1358530364.164 [Reporter](INFO): platform_pitch_angle 10.041504 arcdeg
2013-01-18T17:32:45.328Z,1358530365.328 [Reporter](INFO): platform_buoyancy_position 109.981607 cc
2013-01-18T17:32:48.128Z,1358530368.128 [Reporter](INFO): platform_mass_position -0.019995 m
2013-01-18T17:32:49.330Z,1358530369.330 [Reporter](INFO): platform_pitch_angle 10.063477 arcdeg
2013-01-18T17:32:50.531Z,1358530370.531 [Reporter](INFO): platform_buoyancy_position 109.981607 cc
2013-01-18T17:32:53.331Z,1358530373.331 [Reporter](INFO): platform_mass_position -0.019995 m
2013-01-18T17:32:54.531Z,1358530374.531 [Reporter](INFO): platform_pitch_angle 9.887695 arcdeg
2013-01-18T17:32:55.736Z,1358530375.736 [Reporter](INFO): platform_buoyancy_position 109.981607 cc
2013-01-18T17:32:58.531Z,1358530378.531 [Reporter](INFO): platform_mass_position -0.019995 m
2013-01-18T17:32:59.731Z,1358530379.731 [Reporter](INFO): platform_pitch_angle 9.887695 arcdeg
2013-01-18T17:33:00.911Z,1358530380.911 [Reporter](INFO): platform_buoyancy_position 109.981607 cc
2013-01-18T17:33:03.764Z,1358530383.764 [Reporter](INFO): platform_mass_position -0.019995 m
2013-01-18T17:33:04.930Z,1358530384.930 [Reporter](INFO): platform_pitch_angle 9.887695 arcdeg
2013-01-18T17:33:06.131Z,1358530386.131 [Reporter](INFO): platform_buoyancy_position 109.981607 cc
2013-01-18T17:33:08.930Z,1358530388.931 [Reporter](INFO): platform_mass_position -0.019995 m
2013-01-18T17:33:10.167Z,1358530390.167 [Reporter](INFO): platform_pitch_angle 9.997559 arcdeg
2013-01-18T17:33:11.331Z,1358530391.331 [Reporter](INFO): platform_buoyancy_position 109.981607 cc
2013-01-18T17:33:14.276Z,1358530394.276 [Reporter](INFO): platform_mass_position -0.019995 m
2013-01-18T17:33:15.328Z,1358530395.328 [Reporter](INFO): platform_pitch_angle 10.063477 arcdeg
2013-01-18T17:33:16.564Z,1358530396.564 [Reporter](INFO): platform_buoyancy_position 109.981607 cc
2013-01-18T17:33:19.384Z,1358530399.384 [Reporter](INFO): platform_mass_position -0.019995 m
2013-01-18T17:33:20.528Z,1358530400.528 [Reporter](INFO): platform_pitch_angle 9.975586 arcdeg
2013-01-18T17:33:21.728Z,1358530401.728 [Reporter](INFO): platform_buoyancy_position 109.981607 cc
2013-01-18T17:33:24.576Z,1358530404.576 [Reporter](INFO): platform_mass_position -0.019995 m
2013-01-18T17:33:25.592Z,1358530405.592 [CommandLine](IMPORTANT): got command maintain control VerticalControl.massPositionAction 2.300000 centimeter
2013-01-18T17:33:25.727Z,1358530405.727 [Reporter](INFO): platform_pitch_angle 9.975586 arcdeg
2013-01-18T17:33:27.015Z,1358530407.015 [Reporter](INFO): platform_buoyancy_position 109.981607 cc
2013-01-18T17:33:29.908Z,1358530409.908 [Reporter](INFO): platform_mass_position -0.018528 m
2013-01-18T17:33:30.983Z,1358530410.983 [Reporter](INFO): platform_pitch_angle 9.975586 arcdeg
2013-01-18T17:33:32.183Z,1358530412.183 [Reporter](INFO): platform_buoyancy_position 109.981607 cc
2013-01-18T17:33:34.996Z,1358530414.996 [Reporter](INFO): platform_mass_position -0.014744 m
2013-01-18T17:33:35.093Z,1358530415.093 [CommandLine](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 950.000000 cubic_centimeter
2013-01-18T17:33:36.212Z,1358530416.212 [Reporter](INFO): platform_pitch_angle 7.250977 arcdeg
2013-01-18T17:33:37.396Z,1358530417.396 [Reporter](INFO): platform_buoyancy_position 107.832821 cc
2013-01-18T17:33:40.212Z,1358530420.211 [Reporter](INFO): platform_mass_position -0.010864 m
2013-01-18T17:33:41.407Z,1358530421.408 [Reporter](INFO): platform_pitch_angle 5.910645 arcdeg
2013-01-18T17:33:42.644Z,1358530422.644 [Reporter](INFO): platform_buoyancy_position 122.874408 cc
2013-01-18T17:33:45.425Z,1358530425.425 [Reporter](INFO): platform_mass_position -0.006988 m
2013-01-18T17:33:46.612Z,1358530426.612 [Reporter](INFO): platform_pitch_angle 3.867187 arcdeg
2013-01-18T17:33:47.812Z,1358530427.812 [Reporter](INFO): platform_buoyancy_position 140.064818 cc
2013-01-18T17:33:50.608Z,1358530430.608 [Reporter](INFO): platform_mass_position -0.003135 m
2013-01-18T17:33:51.811Z,1358530431.811 [Reporter](INFO): platform_pitch_angle 2.570801 arcdeg
2013-01-18T17:33:53.020Z,1358530433.020 [Reporter](INFO): platform_buoyancy_position 157.120914 cc
2013-01-18T17:33:55.812Z,1358530435.812 [Reporter](INFO): platform_mass_position 0.000732 m
2013-01-18T17:33:57.007Z,1358530437.007 [Reporter](INFO): platform_pitch_angle 2.570801 arcdeg
2013-01-18T17:33:58.207Z,1358530438.207 [Reporter](INFO): platform_buoyancy_position 174.177039 cc
2013-01-18T17:34:01.012Z,1358530441.011 [Reporter](INFO): platform_mass_position 0.004599 m
2013-01-18T17:34:02.211Z,1358530442.211 [Reporter](INFO): platform_pitch_angle 2.329102 arcdeg
2013-01-18T17:34:03.412Z,1358530443.411 [Reporter](INFO): platform_buoyancy_position 191.501735 cc
2013-01-18T17:34:06.207Z,1358530446.207 [Reporter](INFO): platform_mass_position 0.008463 m
2013-01-18T17:34:07.407Z,1358530447.407 [Reporter](INFO): platform_pitch_angle 2.197266 arcdeg
2013-01-18T17:34:08.624Z,1358530448.624 [Reporter](INFO): platform_buoyancy_position 208.692145 cc
2013-01-18T17:34:11.460Z,1358530451.460 [Reporter](INFO): platform_mass_position 0.012362 m
2013-01-18T17:34:12.619Z,1358530452.619 [Reporter](INFO): platform_pitch_angle 2.131348 arcdeg
2013-01-18T17:34:13.812Z,1358530453.812 [Reporter](INFO): platform_buoyancy_position 225.882541 cc
2013-01-18T17:34:16.611Z,1358530456.611 [Reporter](INFO): platform_mass_position 0.016198 m
2013-01-18T17:34:17.840Z,1358530457.839 [Reporter](INFO): platform_pitch_angle 2.043457 arcdeg
2013-01-18T17:34:19.016Z,1358530459.016 [Reporter](INFO): platform_buoyancy_position 242.804323 cc
2013-01-18T17:34:21.895Z,1358530461.895 [Reporter](INFO): platform_mass_position 0.020125 m
2013-01-18T17:34:23.095Z,1358530463.095 [Reporter](INFO): platform_pitch_angle 2.043457 arcdeg
2013-01-18T17:34:24.330Z,1358530464.330 [Reporter](INFO): platform_buoyancy_position 260.263332 cc
2013-01-18T17:34:27.056Z,1358530467.056 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:34:28.255Z,1358530468.256 [Reporter](INFO): platform_pitch_angle 1.889648 arcdeg
2013-01-18T17:34:29.456Z,1358530469.455 [Reporter](INFO): platform_buoyancy_position 277.453742 cc
2013-01-18T17:34:32.425Z,1358530472.425 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:34:33.526Z,1358530473.526 [Reporter](INFO): platform_pitch_angle 1.911621 arcdeg
2013-01-18T17:34:34.733Z,1358530474.733 [Reporter](INFO): platform_buoyancy_position 294.644124 cc
2013-01-18T17:34:37.532Z,1358530477.532 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:34:38.703Z,1358530478.703 [Reporter](INFO): platform_pitch_angle 1.867676 arcdeg
2013-01-18T17:34:39.903Z,1358530479.903 [Reporter](INFO): platform_buoyancy_position 311.834534 cc
2013-01-18T17:34:42.704Z,1358530482.704 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:34:43.932Z,1358530483.932 [Reporter](INFO): platform_pitch_angle 1.801758 arcdeg
2013-01-18T17:34:45.103Z,1358530485.103 [Reporter](INFO): platform_buoyancy_position 329.159229 cc
2013-01-18T17:34:47.900Z,1358530487.899 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:34:49.095Z,1358530489.095 [Reporter](INFO): platform_pitch_angle 1.845703 arcdeg
2013-01-18T17:34:50.328Z,1358530490.328 [Reporter](INFO): platform_buoyancy_position 346.215325 cc
2013-01-18T17:34:53.103Z,1358530493.103 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:34:54.299Z,1358530494.299 [Reporter](INFO): platform_pitch_angle 1.845703 arcdeg
2013-01-18T17:34:55.503Z,1358530495.503 [Reporter](INFO): platform_buoyancy_position 362.599938 cc
2013-01-18T17:34:58.303Z,1358530498.303 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:34:59.503Z,1358530499.503 [Reporter](INFO): platform_pitch_angle 1.889648 arcdeg
2013-01-18T17:35:00.700Z,1358530500.700 [Reporter](INFO): platform_buoyancy_position 380.730431 cc
2013-01-18T17:35:03.500Z,1358530503.500 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:35:04.700Z,1358530504.700 [Reporter](INFO): platform_pitch_angle 1.867676 arcdeg
2013-01-18T17:35:05.904Z,1358530505.904 [Reporter](INFO): platform_buoyancy_position 395.772047 cc
2013-01-18T17:35:08.707Z,1358530508.707 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:35:09.939Z,1358530509.939 [Reporter](INFO): platform_pitch_angle 1.823731 arcdeg
2013-01-18T17:35:11.103Z,1358530511.103 [Reporter](INFO): platform_buoyancy_position 412.962429 cc
2013-01-18T17:35:13.900Z,1358530513.899 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:35:15.103Z,1358530515.103 [Reporter](INFO): platform_pitch_angle 1.867676 arcdeg
2013-01-18T17:35:16.300Z,1358530516.300 [Reporter](INFO): platform_buoyancy_position 430.152868 cc
2013-01-18T17:35:19.103Z,1358530519.103 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:35:20.299Z,1358530520.299 [Reporter](INFO): platform_pitch_angle 1.779785 arcdeg
2013-01-18T17:35:21.503Z,1358530521.503 [Reporter](INFO): platform_buoyancy_position 447.343220 cc
2013-01-18T17:35:24.303Z,1358530524.303 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:35:25.503Z,1358530525.503 [Reporter](INFO): platform_pitch_angle 1.757812 arcdeg
2013-01-18T17:35:26.699Z,1358530526.699 [Reporter](INFO): platform_buoyancy_position 464.533659 cc
2013-01-18T17:35:29.503Z,1358530529.503 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:35:30.700Z,1358530530.700 [Reporter](INFO): platform_pitch_angle 1.779785 arcdeg
2013-01-18T17:35:31.900Z,1358530531.900 [Reporter](INFO): platform_buoyancy_position 481.724041 cc
2013-01-18T17:35:34.700Z,1358530534.700 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:35:35.900Z,1358530535.899 [Reporter](INFO): platform_pitch_angle 1.801758 arcdeg
2013-01-18T17:35:37.148Z,1358530537.148 [Reporter](INFO): platform_buoyancy_position 498.780108 cc
2013-01-18T17:35:39.903Z,1358530539.903 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:35:41.103Z,1358530541.103 [Reporter](INFO): platform_pitch_angle 1.845703 arcdeg
2013-01-18T17:35:42.352Z,1358530542.352 [Reporter](INFO): platform_buoyancy_position 516.104803 cc
2013-01-18T17:35:45.103Z,1358530545.103 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:35:46.299Z,1358530546.299 [Reporter](INFO): platform_pitch_angle 1.735840 arcdeg
2013-01-18T17:35:47.575Z,1358530547.575 [Reporter](INFO): platform_buoyancy_position 533.295213 cc
2013-01-18T17:35:50.299Z,1358530550.299 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:35:51.500Z,1358530551.500 [Reporter](INFO): platform_pitch_angle 1.713867 arcdeg
2013-01-18T17:35:52.744Z,1358530552.744 [Reporter](INFO): platform_buoyancy_position 550.485624 cc
2013-01-18T17:35:55.503Z,1358530555.503 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:35:56.703Z,1358530556.703 [Reporter](INFO): platform_pitch_angle 1.735840 arcdeg
2013-01-18T17:35:57.900Z,1358530557.899 [Reporter](INFO): platform_buoyancy_position 567.676034 cc
2013-01-18T17:36:00.700Z,1358530560.700 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:36:01.900Z,1358530561.899 [Reporter](INFO): platform_pitch_angle 1.735840 arcdeg
2013-01-18T17:36:03.103Z,1358530563.103 [Reporter](INFO): platform_buoyancy_position 584.866386 cc
2013-01-18T17:36:05.900Z,1358530565.899 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:36:07.104Z,1358530567.103 [Reporter](INFO): platform_pitch_angle 1.713867 arcdeg
2013-01-18T17:36:08.300Z,1358530568.300 [Reporter](INFO): platform_buoyancy_position 601.922569 cc
2013-01-18T17:36:11.135Z,1358530571.135 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:36:12.299Z,1358530572.299 [Reporter](INFO): platform_pitch_angle 1.669922 arcdeg
2013-01-18T17:36:13.503Z,1358530573.503 [Reporter](INFO): platform_buoyancy_position 619.112921 cc
2013-01-18T17:36:16.299Z,1358530576.299 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:36:17.540Z,1358530577.540 [Reporter](INFO): platform_pitch_angle 1.735840 arcdeg
2013-01-18T17:36:18.700Z,1358530578.700 [Reporter](INFO): platform_buoyancy_position 636.303332 cc
2013-01-18T17:36:21.500Z,1358530581.500 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:36:22.700Z,1358530582.700 [Reporter](INFO): platform_pitch_angle 1.647949 arcdeg
2013-01-18T17:36:23.940Z,1358530583.940 [Reporter](INFO): platform_buoyancy_position 653.359457 cc
2013-01-18T17:36:26.703Z,1358530586.703 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:36:27.899Z,1358530587.899 [Reporter](INFO): platform_pitch_angle 1.691895 arcdeg
2013-01-18T17:36:29.103Z,1358530589.103 [Reporter](INFO): platform_buoyancy_position 668.938213 cc
2013-01-18T17:36:31.908Z,1358530591.908 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:36:33.128Z,1358530593.128 [Reporter](INFO): platform_pitch_angle 1.669922 arcdeg
2013-01-18T17:36:34.303Z,1358530594.303 [Reporter](INFO): platform_buoyancy_position 685.994339 cc
2013-01-18T17:36:37.136Z,1358530597.136 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:36:38.344Z,1358530598.344 [Reporter](INFO): platform_pitch_angle 1.647949 arcdeg
2013-01-18T17:36:39.500Z,1358530599.500 [Reporter](INFO): platform_buoyancy_position 703.050406 cc
2013-01-18T17:36:42.303Z,1358530602.303 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:36:43.580Z,1358530603.579 [Reporter](INFO): platform_pitch_angle 1.647949 arcdeg
2013-01-18T17:36:44.703Z,1358530604.703 [Reporter](INFO): platform_buoyancy_position 720.240816 cc
2013-01-18T17:36:47.503Z,1358530607.503 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:36:48.775Z,1358530608.776 [Reporter](INFO): platform_pitch_angle 1.801758 arcdeg
2013-01-18T17:36:49.940Z,1358530609.940 [Reporter](INFO): platform_buoyancy_position 737.431226 cc
2013-01-18T17:36:52.700Z,1358530612.700 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:36:53.900Z,1358530613.899 [Reporter](INFO): platform_pitch_angle 1.647949 arcdeg
2013-01-18T17:36:55.103Z,1358530615.103 [Reporter](INFO): platform_buoyancy_position 754.487352 cc
2013-01-18T17:36:57.903Z,1358530617.903 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:36:59.103Z,1358530619.103 [Reporter](INFO): platform_pitch_angle 1.691895 arcdeg
2013-01-18T17:37:00.303Z,1358530620.303 [Reporter](INFO): platform_buoyancy_position 771.677762 cc
2013-01-18T17:37:03.103Z,1358530623.103 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:37:04.299Z,1358530624.299 [Reporter](INFO): platform_pitch_angle 1.604004 arcdeg
2013-01-18T17:37:05.504Z,1358530625.504 [Reporter](INFO): platform_buoyancy_position 789.002457 cc
2013-01-18T17:37:08.299Z,1358530628.299 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:37:08.698Z,1358530628.698 [CBIT](INFO): Clearing failed count for component DAT
2013-01-18T17:37:08.698Z,1358530628.698 [DAT] No Fault, FailCount= 3
2013-01-18T17:37:09.114Z,1358530629.114 [DAT](INFO): Powering up
2013-01-18T17:37:09.115Z,1358530629.115 [DAT](DEBUG): Initializing DAT.
2013-01-18T17:37:09.503Z,1358530629.503 [Reporter](INFO): platform_pitch_angle 1.582031 arcdeg
2013-01-18T17:37:10.699Z,1358530630.699 [Reporter](INFO): platform_buoyancy_position 806.192809 cc
2013-01-18T17:37:13.503Z,1358530633.503 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:37:14.703Z,1358530634.703 [Reporter](INFO): platform_pitch_angle 1.582031 arcdeg
2013-01-18T17:37:15.905Z,1358530635.905 [Reporter](INFO): platform_buoyancy_position 823.517505 cc
2013-01-18T17:37:18.739Z,1358530638.740 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:37:19.899Z,1358530639.899 [Reporter](INFO): platform_pitch_angle 1.516113 arcdeg
2013-01-18T17:37:21.103Z,1358530641.103 [Reporter](INFO): platform_buoyancy_position 840.439345 cc
2013-01-18T17:37:23.899Z,1358530643.899 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:37:25.135Z,1358530645.135 [Reporter](INFO): platform_pitch_angle 1.647949 arcdeg
2013-01-18T17:37:26.299Z,1358530646.299 [Reporter](INFO): platform_buoyancy_position 857.629755 cc
2013-01-18T17:37:28.319Z,1358530648.319 [DAT](INFO): Init failed - response: 00:00:08.0517 , LVL= 32752, 32753, 32754, 31587, AGC=  76, IDX= 82 0.12,-2.117, PHS= 1.827, 1.806, 1.621, |v|= 1.079, RAW=  35.5,-83.9, CAL=  40.1,-84.1, ROT= 119.1,-84.1, CMP=  17.7,  2.6,   0.2, 00:00:08.0419 
00:00:09.0516 , LVL= 32752, 32753, 32754, 32211, AGC=  76, IDX= 50 0.05,-1.025, PHS= 1.878, 1.851, 1.674, |v|= 1.108, RAW=  37.0,-84.2, CAL=  41.4,-84.4, ROT= 120.4,-84.4, CMP=  17.9
2013-01-18T17:37:28.319Z,1358530648.319 [DAT](FAULT): DAT failed to initialize
2013-01-18T17:37:28.319Z,1358530648.319 [DAT] Communications Fault, FailCount= 1
2013-01-18T17:37:28.319Z,1358530648.319 [DAT](ERROR): Communications Fault
2013-01-18T17:37:28.399Z,1358530648.399 [CBIT](ERROR): Communications Fault in component: DAT
2013-01-18T17:37:28.619Z,1358530648.619 [DAT](INFO): Powering down
2013-01-18T17:37:29.103Z,1358530649.103 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:37:29.547Z,1358530649.547 [CBIT](INFO): Clearing failed state for component DAT
2013-01-18T17:37:29.547Z,1358530649.547 [DAT] No Fault, FailCount= 1
2013-01-18T17:37:30.303Z,1358530650.303 [Reporter](INFO): platform_pitch_angle 1.560059 arcdeg
2013-01-18T17:37:31.536Z,1358530651.536 [Reporter](INFO): platform_buoyancy_position 874.820107 cc
2013-01-18T17:37:31.823Z,1358530651.823 [DAT](INFO): Powering up
2013-01-18T17:37:31.823Z,1358530651.823 [DAT](DEBUG): Initializing DAT.
2013-01-18T17:37:34.352Z,1358530654.352 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:37:35.503Z,1358530655.503 [Reporter](INFO): platform_pitch_angle 1.516113 arcdeg
2013-01-18T17:37:36.699Z,1358530656.699 [Reporter](INFO): platform_buoyancy_position 892.010576 cc
2013-01-18T17:37:39.503Z,1358530659.503 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:37:40.699Z,1358530660.699 [Reporter](INFO): platform_pitch_angle 1.494141 arcdeg
2013-01-18T17:37:41.900Z,1358530661.899 [Reporter](INFO): platform_buoyancy_position 909.335271 cc
2013-01-18T17:37:44.739Z,1358530664.739 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:37:45.907Z,1358530665.907 [Reporter](INFO): platform_pitch_angle 1.472168 arcdeg
2013-01-18T17:37:47.103Z,1358530667.103 [Reporter](INFO): platform_buoyancy_position 926.525623 cc
2013-01-18T17:37:49.948Z,1358530669.948 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:37:51.110Z,1358530671.110 [DAT](INFO): Init failed - response: 00:00:08.4583 , LVL= 32752, 32753, 32754, 31027, AGC=  76, IDX= 82-0.00,-2.871, PHS= 1.883, 1.872, 1.697, |v|= 1.118, RAW=  33.1,-84.6, CAL=  37.3,-84.8, ROT= 116.3,-84.8, CMP=  23.6,  2.4,   0.2, 00:00:08.5320 
00:00:09.4582 , LVL= 32752, 32753, 32754, 30675, AGC=  74, IDX= 62 0.17,-2.241, PHS= 1.915, 1.905, 1.727, |v|= 1.137, RAW=  32.8,-84.6, CAL=  37.0,-84.8, ROT= 116.0,-84.8, CMP=  23.7
2013-01-18T17:37:51.110Z,1358530671.110 [DAT](FAULT): DAT failed to initialize
2013-01-18T17:37:51.110Z,1358530671.110 [DAT] Communications Fault, FailCount= 2
2013-01-18T17:37:51.110Z,1358530671.110 [DAT](ERROR): Communications Fault
2013-01-18T17:37:51.183Z,1358530671.183 [CBIT](ERROR): Communications Fault in component: DAT
2013-01-18T17:37:51.184Z,1358530671.184 [Reporter](INFO): platform_pitch_angle 1.538086 arcdeg
2013-01-18T17:37:51.425Z,1358530671.425 [DAT](INFO): Powering down
2013-01-18T17:37:52.275Z,1358530672.275 [CBIT](INFO): Clearing failed state for component DAT
2013-01-18T17:37:52.275Z,1358530672.275 [DAT] No Fault, FailCount= 2
2013-01-18T17:37:52.276Z,1358530672.276 [Reporter](INFO): platform_buoyancy_position 941.298727 cc
2013-01-18T17:37:54.623Z,1358530674.623 [DAT](INFO): Powering up
2013-01-18T17:37:54.624Z,1358530674.624 [DAT](DEBUG): Initializing DAT.
2013-01-18T17:37:55.124Z,1358530675.124 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:37:56.271Z,1358530676.272 [Reporter](INFO): platform_pitch_angle 1.494141 arcdeg
2013-01-18T17:37:57.508Z,1358530677.508 [Reporter](INFO): platform_buoyancy_position 941.298727 cc
2013-01-18T17:38:00.328Z,1358530680.328 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:38:01.475Z,1358530681.475 [Reporter](INFO): platform_pitch_angle 1.494141 arcdeg
2013-01-18T17:38:02.675Z,1358530682.675 [Reporter](INFO): platform_buoyancy_position 941.298727 cc
2013-01-18T17:38:05.475Z,1358530685.476 [Reporter](INFO): platform_mass_position 0.022979 m
2013-01-18T17:38:06.700Z,1358530686.700 [Reporter](INFO): platform_pitch_angle 1.516113 arcdeg
2013-01-18T17:38:07.904Z,1358530687.904 [Reporter](INFO): platform_buoyancy_position 941.298727 cc