2012-10-08T17:24:15.237Z,1349717055.237 [Supervisor](DEBUG): Initializing supervisor. 2012-10-08T17:24:15.240Z,1349717055.240 [SyncHandler](DEBUG): Created PCaller Thread at 4033B4E0 2012-10-08T17:24:15.241Z,1349717055.241 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2012-10-08T17:24:15.242Z,1349717055.242 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4036B4E0 2012-10-08T17:24:15.261Z,1349717055.261 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2012-10-08T17:24:15.272Z,1349717055.272 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2012-10-08T17:24:15.273Z,1349717055.273 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 4039B4E0 2012-10-08T17:24:15.274Z,1349717055.274 [ComponentRegistry](DEBUG): SyncComponent "logger" handled in the control thread. 2012-10-08T17:24:15.275Z,1349717055.275 [Supervisor](INFO): Looking for Config files in directory: Config/ 2012-10-08T17:24:15.276Z,1349717055.276 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2012-10-08T17:24:15.624Z,1349717055.624 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2012-10-08T17:24:15.625Z,1349717055.625 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2012-10-08T17:24:15.812Z,1349717055.812 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2012-10-08T17:24:15.812Z,1349717055.812 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2012-10-08T17:24:15.897Z,1349717055.897 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2012-10-08T17:24:15.897Z,1349717055.897 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2012-10-08T17:24:16.098Z,1349717056.098 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2012-10-08T17:24:16.099Z,1349717056.099 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2012-10-08T17:24:16.232Z,1349717056.232 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2012-10-08T17:24:16.232Z,1349717056.232 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2012-10-08T17:24:16.459Z,1349717056.459 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2012-10-08T17:24:16.459Z,1349717056.459 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2012-10-08T17:24:16.627Z,1349717056.626 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2012-10-08T17:24:16.627Z,1349717056.627 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2012-10-08T17:24:16.877Z,1349717056.877 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2012-10-08T17:24:16.877Z,1349717056.877 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2012-10-08T17:24:16.975Z,1349717056.976 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2012-10-08T17:24:16.976Z,1349717056.976 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2012-10-08T17:24:17.372Z,1349717057.372 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2012-10-08T17:24:17.373Z,1349717057.372 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2012-10-08T17:24:17.486Z,1349717057.486 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2012-10-08T17:24:17.486Z,1349717057.486 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2012-10-08T17:24:17.571Z,1349717057.571 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/ 2012-10-08T17:24:17.572Z,1349717057.572 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg 2012-10-08T17:24:17.702Z,1349717057.702 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg 2012-10-08T17:24:17.830Z,1349717057.830 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg 2012-10-08T17:24:17.915Z,1349717057.915 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg 2012-10-08T17:24:18.016Z,1349717058.016 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg 2012-10-08T17:24:18.114Z,1349717058.114 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg 2012-10-08T17:24:18.231Z,1349717058.231 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg 2012-10-08T17:24:18.321Z,1349717058.321 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg 2012-10-08T17:24:18.407Z,1349717058.407 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2012-10-08T17:24:18.438Z,1349717058.438 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2012-10-08T17:24:18.584Z,1349717058.584 [InternalSim] Loaded 2012-10-08T17:24:18.584Z,1349717058.584 [ComponentRegistry](DEBUG): SyncComponent "InternalSim" handled in the control thread. 2012-10-08T17:24:18.585Z,1349717058.585 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2012-10-08T17:24:18.586Z,1349717058.586 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2012-10-08T17:24:18.646Z,1349717058.646 [SBIT](DEBUG): Construct Startup Built In Test. 2012-10-08T17:24:18.660Z,1349717058.660 [SBIT] Loaded 2012-10-08T17:24:18.660Z,1349717058.660 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2012-10-08T17:24:18.661Z,1349717058.661 [IBIT](DEBUG): Construct Initiated Built In Test. 2012-10-08T17:24:18.689Z,1349717058.689 [IBIT] Loaded 2012-10-08T17:24:18.690Z,1349717058.690 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2012-10-08T17:24:18.693Z,1349717058.693 [CBIT](DEBUG): Construct CBIT Built In Test. 2012-10-08T17:24:18.812Z,1349717058.812 [CBIT] Loaded 2012-10-08T17:24:18.813Z,1349717058.813 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2012-10-08T17:24:18.813Z,1349717058.813 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2012-10-08T17:24:18.814Z,1349717058.814 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2012-10-08T17:24:18.961Z,1349717058.961 [BuoyancyServo] Loaded 2012-10-08T17:24:18.961Z,1349717058.961 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2012-10-08T17:24:18.970Z,1349717058.970 [ElevatorServo] Loaded 2012-10-08T17:24:18.970Z,1349717058.970 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2012-10-08T17:24:18.982Z,1349717058.982 [MassServo] Loaded 2012-10-08T17:24:18.982Z,1349717058.982 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2012-10-08T17:24:18.994Z,1349717058.994 [RudderServo] Loaded 2012-10-08T17:24:18.994Z,1349717058.994 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2012-10-08T17:24:19.006Z,1349717059.006 [ThrusterServo] Loaded 2012-10-08T17:24:19.006Z,1349717059.006 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2012-10-08T17:24:19.007Z,1349717059.007 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2012-10-08T17:24:19.007Z,1349717059.007 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2012-10-08T17:24:19.026Z,1349717059.026 [DepthRateCalculator] Loaded 2012-10-08T17:24:19.026Z,1349717059.026 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2012-10-08T17:24:30.108Z,1349717070.108 [HFRadarModelCalc] Loaded 2012-10-08T17:24:30.108Z,1349717070.108 [ComponentRegistry](DEBUG): SyncComponent "HFRadarModelCalc" handled in the control thread. 2012-10-08T17:24:30.124Z,1349717070.124 [NavChart] Loaded 2012-10-08T17:24:30.124Z,1349717070.125 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2012-10-08T17:24:30.130Z,1349717070.130 [PitchRateCalculator] Loaded 2012-10-08T17:24:30.131Z,1349717070.131 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2012-10-08T17:24:30.137Z,1349717070.137 [SpeedCalculator] Loaded 2012-10-08T17:24:30.137Z,1349717070.137 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2012-10-08T17:24:30.152Z,1349717070.152 [TempGradientCalculator] Loaded 2012-10-08T17:24:30.152Z,1349717070.152 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2012-10-08T17:24:30.158Z,1349717070.158 [YawRateCalculator] Loaded 2012-10-08T17:24:30.159Z,1349717070.158 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2012-10-08T17:24:30.178Z,1349717070.178 [Navigation] Loaded 2012-10-08T17:24:30.178Z,1349717070.178 [ComponentRegistry](DEBUG): SyncComponent "Navigation" handled in the control thread. 2012-10-08T17:24:30.179Z,1349717070.179 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2012-10-08T17:24:30.179Z,1349717070.179 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2012-10-08T17:24:30.419Z,1349717070.419 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2012-10-08T17:24:30.419Z,1349717070.420 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2012-10-08T17:24:30.444Z,1349717070.444 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2012-10-08T17:24:30.444Z,1349717070.444 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2012-10-08T17:24:30.488Z,1349717070.487 [VerticalControl](DEBUG): Construct VerticalControl. 2012-10-08T17:24:30.532Z,1349717070.532 [VerticalControl] Loaded 2012-10-08T17:24:30.532Z,1349717070.532 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2012-10-08T17:24:30.533Z,1349717070.533 [HorizontalControl](DEBUG): Construct HorizontalControl. 2012-10-08T17:24:30.553Z,1349717070.553 [HorizontalControl] Loaded 2012-10-08T17:24:30.553Z,1349717070.553 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2012-10-08T17:24:30.554Z,1349717070.554 [SpeedControl](DEBUG): Construct SpeedControl. 2012-10-08T17:24:30.556Z,1349717070.556 [SpeedControl] Loaded 2012-10-08T17:24:30.556Z,1349717070.556 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2012-10-08T17:24:30.557Z,1349717070.557 [LoopControl](DEBUG): Construct LoopControl. 2012-10-08T17:24:30.558Z,1349717070.558 [LoopControl] Loaded 2012-10-08T17:24:30.558Z,1349717070.558 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2012-10-08T17:24:30.558Z,1349717070.559 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2012-10-08T17:24:30.559Z,1349717070.559 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2012-10-08T17:24:30.564Z,1349717070.565 [AsyncPiEstimator](DEBUG): Construct AsyncPiEstimator. 2012-10-08T17:24:30.569Z,1349717070.569 [AsyncPiEstimator] Loaded 2012-10-08T17:24:30.570Z,1349717070.570 [ComponentRegistry](DEBUG): Component "AsyncPiEstimator" handled in its own thread. 2012-10-08T17:24:30.571Z,1349717070.571 [AsyncPiEstimator ThreadHandler](DEBUG): Created PCaller Thread at 406724E0 2012-10-08T17:24:30.572Z,1349717070.572 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2012-10-08T17:24:30.572Z,1349717070.572 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2012-10-08T17:24:30.709Z,1349717070.709 [AHRS_sp3003D] Loaded 2012-10-08T17:24:30.709Z,1349717070.709 [ComponentRegistry](DEBUG): SyncComponent "AHRS_sp3003D" handled in the control thread. 2012-10-08T17:24:30.724Z,1349717070.724 [Depth_Keller] Loaded 2012-10-08T17:24:30.724Z,1349717070.724 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2012-10-08T17:24:30.729Z,1349717070.729 [DropWeight] Loaded 2012-10-08T17:24:30.730Z,1349717070.730 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2012-10-08T17:24:30.848Z,1349717070.848 [DVL_micro] Loaded 2012-10-08T17:24:30.848Z,1349717070.848 [ComponentRegistry](DEBUG): Component "DVL_micro" handled in its own thread. 2012-10-08T17:24:30.849Z,1349717070.849 [DVL_micro ThreadHandler](DEBUG): Created PCaller Thread at 406F34E0 2012-10-08T17:24:30.933Z,1349717070.933 [NAL9602] Loaded 2012-10-08T17:24:30.933Z,1349717070.933 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2012-10-08T17:24:30.985Z,1349717070.985 [Onboard] Loaded 2012-10-08T17:24:30.985Z,1349717070.985 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2012-10-08T17:24:30.992Z,1349717070.992 [Radio_Freewave] Loaded 2012-10-08T17:24:30.993Z,1349717070.993 [ComponentRegistry](DEBUG): SyncComponent "Radio_Freewave" handled in the control thread. 2012-10-08T17:24:30.993Z,1349717070.993 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2012-10-08T17:24:30.994Z,1349717070.994 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2012-10-08T17:24:31.068Z,1349717071.068 [CTD_NeilBrown] Loaded 2012-10-08T17:24:31.069Z,1349717071.069 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread. 2012-10-08T17:24:31.070Z,1349717071.070 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 4074B4E0 2012-10-08T17:24:31.080Z,1349717071.080 [PAR_Licor] Loaded 2012-10-08T17:24:31.080Z,1349717071.080 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2012-10-08T17:24:31.097Z,1349717071.097 [Turbulence_NPS] Loaded 2012-10-08T17:24:31.097Z,1349717071.097 [ComponentRegistry](DEBUG): Component "Turbulence_NPS" handled in its own thread. 2012-10-08T17:24:31.098Z,1349717071.098 [Turbulence_NPS ThreadHandler](DEBUG): Created PCaller Thread at 4077B4E0 2012-10-08T17:24:31.128Z,1349717071.128 [WetLabsBB2FL] Loaded 2012-10-08T17:24:31.129Z,1349717071.129 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2012-10-08T17:24:31.130Z,1349717071.130 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 407AB4E0 2012-10-08T17:24:31.130Z,1349717071.130 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2012-10-08T17:24:31.133Z,1349717071.133 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2012-10-08T17:24:31.134Z,1349717071.134 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2012-10-08T17:24:31.140Z,1349717071.141 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2012-10-08T17:24:31.142Z,1349717071.142 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 407DB4E0 2012-10-08T17:24:31.146Z,1349717071.146 [Supervisor](DEBUG): Running supervisor. 2012-10-08T17:24:31.149Z,1349717071.149 [CommandLine](INFO): Thread ID is 4125 2012-10-08T17:24:31.152Z,1349717071.152 [controlThread](INFO): Thread ID is 4124 2012-10-08T17:24:31.152Z,1349717071.152 [controlThread](DEBUG): Initializing ControlThread 2012-10-08T17:24:31.153Z,1349717071.152 [CycleStarter](INFO): Thread ID is 4123 2012-10-08T17:24:31.153Z,1349717071.153 [InternalSim](DEBUG): InternalSim initializing... 2012-10-08T17:24:31.187Z,1349717071.187 [AsyncPiEstimator](INFO): Thread ID is 4186 2012-10-08T17:24:31.187Z,1349717071.187 [AsyncPiEstimator](DEBUG): Initialize AsyncPiEstimator. 2012-10-08T17:24:31.266Z,1349717071.266 [DVL_micro](INFO): Thread ID is 4187 2012-10-08T17:24:31.383Z,1349717071.383 [CTD_NeilBrown](INFO): Thread ID is 4188 2012-10-08T17:24:31.383Z,1349717071.383 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown. 2012-10-08T17:24:31.387Z,1349717071.387 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4 2012-10-08T17:24:31.439Z,1349717071.439 [Turbulence_NPS](INFO): Thread ID is 4189 2012-10-08T17:24:31.439Z,1349717071.439 [Turbulence_NPS](DEBUG): Initializing Turbulence_NPS. 2012-10-08T17:24:31.440Z,1349717071.440 [Turbulence_NPS](INFO): Opening uart, block timeout 10ths=1 2012-10-08T17:24:31.449Z,1349717071.450 [SBIT](INFO): Initialize SBIT Component. 2012-10-08T17:24:31.450Z,1349717071.450 [SBIT](IMPORTANT): Tethys CM Info: $Rev: 9936 2012-10-08T17:24:31.453Z,1349717071.453 [WetLabsBB2FL](INFO): Thread ID is 4190 2012-10-08T17:24:31.454Z,1349717071.454 [WetLabsBB2FL](INFO): Powering down 2012-10-08T17:24:31.487Z,1349717071.487 [IBIT](INFO): Initialize IBIT Component. 2012-10-08T17:24:31.488Z,1349717071.488 [CBIT](DEBUG): Initialize CBIT Component. 2012-10-08T17:24:31.488Z,1349717071.488 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL. 2012-10-08T17:24:31.488Z,1349717071.488 [CBIT](CRITICAL): LAST REBOOT DUE TO WATCHDOG TIMER RESET. 2012-10-08T17:24:31.495Z,1349717071.495 [NavChartDb](INFO): Thread ID is 4191 2012-10-08T17:24:31.498Z,1349717071.499 [DVL_micro](INFO): Initializing 2012-10-08T17:24:31.499Z,1349717071.499 [DVL_micro](INFO): start:Powering up 2012-10-08T17:24:31.500Z,1349717071.500 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2012-10-08T17:24:31.500Z,1349717071.500 [DVL_micro](INFO): Cycling power to configure device. 2012-10-08T17:24:31.504Z,1349717071.504 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources 2012-10-08T17:24:31.505Z,1349717071.505 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2012-10-08T17:24:31.505Z,1349717071.505 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2012-10-08T17:24:31.506Z,1349717071.506 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2012-10-08T17:24:31.506Z,1349717071.506 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2012-10-08T17:24:31.507Z,1349717071.507 [Turbulence_NPS](INFO): Pause powering down 2012-10-08T17:24:31.516Z,1349717071.516 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2012-10-08T17:24:31.517Z,1349717071.517 [NavChart](DEBUG): Initialize NavChart Derivation. 2012-10-08T17:24:31.517Z,1349717071.517 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2012-10-08T17:24:31.518Z,1349717071.518 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2012-10-08T17:24:31.518Z,1349717071.518 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2012-10-08T17:24:31.528Z,1349717071.528 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2012-10-08T17:24:31.528Z,1349717071.528 [Navigation](DEBUG): Initializing Navigation. 2012-10-08T17:24:31.529Z,1349717071.529 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2012-10-08T17:24:31.543Z,1349717071.543 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2012-10-08T17:24:31.543Z,1349717071.543 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2012-10-08T17:24:31.544Z,1349717071.544 [LoopControl](DEBUG): Initialize LoopControlComponent. 2012-10-08T17:24:31.549Z,1349717071.549 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2012-10-08T17:24:31.577Z,1349717071.577 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2012-10-08T17:24:31.591Z,1349717071.591 [MissionManager](DEBUG): 2012-10-08T17:24:31.592Z,1349717071.592 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2012-10-08T17:24:31.620Z,1349717071.620 [MissionManager](INFO): DefineArg Default.NeedGPS = 1 bool 2012-10-08T17:24:31.622Z,1349717071.622 [Default:GPS:A.SetSpeed](DEBUG): Construct. 2012-10-08T17:24:31.626Z,1349717071.625 [Default:GPS:B.GoToSurface](DEBUG): Construct GoToSurface. 2012-10-08T17:24:31.634Z,1349717071.634 [Default:Iridium:A.SetSpeed](DEBUG): Construct. 2012-10-08T17:24:31.637Z,1349717071.637 [Default:Iridium:B.GoToSurface](DEBUG): Construct GoToSurface. 2012-10-08T17:24:31.643Z,1349717071.644 [Default:Iridium:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2012-10-08T17:24:31.653Z,1349717071.653 [Default:D.SetSpeed](DEBUG): Construct. 2012-10-08T17:24:31.656Z,1349717071.656 [Default:E.GoToSurface](DEBUG): Construct GoToSurface. 2012-10-08T17:24:31.661Z,1349717071.661 [Default:F.Wait](DEBUG): Construct Wait. 2012-10-08T17:24:31.664Z,1349717071.664 [MissionManager](DEBUG): 400 400 Burn 300 Dropped drop weight due to communications timeout 5.0 1.0 5 2012-10-08T17:24:31.669Z,1349717071.669 [controlThread](DEBUG): Component order: CycleStarter,InternalSim,AHRS_sp3003D,Depth_Keller,DropWeight,NAL9602,Onboard,Radio_Freewave,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,HFRadarModelCalc,NavChart,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,Navigation,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,logger, 2012-10-08T17:24:31.690Z,1349717071.690 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D. 2012-10-08T17:24:32.754Z,1349717072.754 [Radio_Freewave](INFO): Powering up 2012-10-08T17:24:32.852Z,1349717072.852 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2012-10-08T17:24:32.858Z,1349717072.858 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2012-10-08T17:24:32.865Z,1349717072.865 [ElevatorServo](DEBUG): Initializing EZServoServo. 2012-10-08T17:24:32.866Z,1349717072.866 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2012-10-08T17:24:32.872Z,1349717072.872 [MassServo](DEBUG): Initializing EZServoServo. 2012-10-08T17:24:32.875Z,1349717072.875 [MassServo](DEBUG): Initializing MassServo. 2012-10-08T17:24:32.881Z,1349717072.881 [RudderServo](DEBUG): Initializing EZServoServo. 2012-10-08T17:24:32.882Z,1349717072.882 [RudderServo](DEBUG): Initializing RudderServo. 2012-10-08T17:24:32.888Z,1349717072.888 [ThrusterServo](DEBUG): Initializing EZServoServo. 2012-10-08T17:24:32.891Z,1349717072.891 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2012-10-08T17:24:33.711Z,1349717073.711 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2012-10-08T17:24:33.711Z,1349717073.711 [DVL_micro](INFO): Querying output modes 2012-10-08T17:24:33.711Z,1349717073.711 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2012-10-08T17:24:33.715Z,1349717073.715 [DVL_micro](DEBUG): cmdResponse: 01 2012-10-08T17:24:33.715Z,1349717073.715 [DVL_micro](INFO): NQ1 output enabled 2012-10-08T17:24:33.715Z,1349717073.715 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2012-10-08T17:24:33.719Z,1349717073.719 [DVL_micro](DEBUG): cmdResponse: AUTO_VEL_ON 2012-10-08T17:24:33.724Z,1349717073.724 [DVL_micro](INFO): pause:Powering down 2012-10-08T17:24:37.165Z,1349717077.165 [NAL9602](INFO): Powering up NAL9602 2012-10-08T17:24:48.178Z,1349717088.178 [SBIT](IMPORTANT): Beginning Startup BIT 2012-10-08T17:24:48.181Z,1349717088.181 [CBIT](IMPORTANT): Beginning GF scan 2012-10-08T17:24:48.807Z,1349717088.807 [NAL9602](INFO): NAL9602 initialized 2012-10-08T17:25:01.389Z,1349717101.389 [SBIT](FAULT): Rudder: EXPECTED:15.000000 ACTUAL:14.828468 2012-10-08T17:25:02.307Z,1349717102.307 [CommandLine](IMPORTANT): got command report mod platform_mass_position 2012-10-08T17:25:02.691Z,1349717102.691 [Reporter](INFO): platform_mass_position 0.005557 m 2012-10-08T17:25:07.515Z,1349717107.515 [Reporter](INFO): platform_mass_position 0.004817 m 2012-10-08T17:25:07.827Z,1349717107.828 [Reporter](INFO): platform_mass_position 0.004579 m 2012-10-08T17:25:08.575Z,1349717108.575 [Reporter](INFO): platform_mass_position 0.004024 m 2012-10-08T17:25:09.596Z,1349717109.596 [Reporter](INFO): platform_mass_position 0.003283 m 2012-10-08T17:25:11.036Z,1349717111.036 [Reporter](INFO): platform_mass_position 0.002283 m 2012-10-08T17:25:11.340Z,1349717111.339 [Reporter](INFO): platform_mass_position 0.001958 m 2012-10-08T17:25:12.044Z,1349717112.044 [Reporter](INFO): platform_mass_position 0.001426 m 2012-10-08T17:25:12.700Z,1349717112.700 [Reporter](INFO): platform_mass_position 0.000942 m 2012-10-08T17:25:13.552Z,1349717113.552 [Reporter](INFO): platform_mass_position 0.000305 m 2012-10-08T17:25:14.252Z,1349717114.251 [Reporter](INFO): platform_mass_position -0.000209 m 2012-10-08T17:25:15.163Z,1349717115.163 [Reporter](INFO): platform_mass_position -0.000897 m 2012-10-08T17:25:15.828Z,1349717115.828 [Reporter](INFO): platform_mass_position -0.001380 m 2012-10-08T17:25:16.752Z,1349717116.752 [Reporter](INFO): platform_mass_position -0.002071 m 2012-10-08T17:25:17.707Z,1349717117.707 [CBIT](IMPORTANT): No ground fault detected 2012-10-08T17:25:17.708Z,1349717117.708 [Reporter](INFO): platform_mass_position -0.002788 m 2012-10-08T17:25:19.020Z,1349717119.020 [Reporter](INFO): platform_mass_position -0.003763 m 2012-10-08T17:25:19.942Z,1349717119.942 [Reporter](INFO): platform_mass_position -0.004446 m 2012-10-08T17:25:20.888Z,1349717120.888 [Reporter](INFO): platform_mass_position -0.005149 m 2012-10-08T17:25:21.432Z,1349717121.432 [Reporter](INFO): platform_mass_position -0.005553 m 2012-10-08T17:25:35.316Z,1349717135.316 [Reporter](INFO): platform_mass_position -0.005256 m 2012-10-08T17:25:35.595Z,1349717135.595 [Reporter](INFO): platform_mass_position -0.005046 m 2012-10-08T17:25:36.003Z,1349717136.003 [Reporter](INFO): platform_mass_position -0.004748 m 2012-10-08T17:25:36.403Z,1349717136.403 [Reporter](INFO): platform_mass_position -0.004450 m 2012-10-08T17:25:36.995Z,1349717136.995 [Reporter](INFO): platform_mass_position -0.004086 m 2012-10-08T17:25:37.228Z,1349717137.228 [Reporter](INFO): platform_mass_position -0.003817 m 2012-10-08T17:25:37.631Z,1349717137.631 [Reporter](INFO): platform_mass_position -0.003520 m 2012-10-08T17:25:38.100Z,1349717138.100 [Reporter](INFO): platform_mass_position -0.003172 m 2012-10-08T17:25:38.434Z,1349717138.434 [Reporter](INFO): platform_mass_position -0.002930 m 2012-10-08T17:25:38.827Z,1349717138.828 [Reporter](INFO): platform_mass_position -0.002627 m 2012-10-08T17:25:39.231Z,1349717139.231 [Reporter](INFO): platform_mass_position -0.002332 m 2012-10-08T17:25:39.628Z,1349717139.628 [Reporter](INFO): platform_mass_position -0.002038 m 2012-10-08T17:25:40.032Z,1349717140.032 [Reporter](INFO): platform_mass_position -0.001733 m 2012-10-08T17:25:40.435Z,1349717140.435 [Reporter](INFO): platform_mass_position -0.001436 m 2012-10-08T17:25:40.831Z,1349717140.831 [Reporter](INFO): platform_mass_position -0.001144 m 2012-10-08T17:25:41.247Z,1349717141.247 [Reporter](INFO): platform_mass_position -0.000835 m 2012-10-08T17:25:41.636Z,1349717141.635 [Reporter](INFO): platform_mass_position -0.000538 m 2012-10-08T17:25:42.031Z,1349717142.031 [Reporter](INFO): platform_mass_position -0.000251 m 2012-10-08T17:25:42.432Z,1349717142.432 [Reporter](INFO): platform_mass_position -0.000038 m 2012-10-08T17:25:44.397Z,1349717144.397 [SBIT](CRITICAL): SBIT FAILED 2012-10-08T17:25:44.789Z,1349717144.789 [MissionManager](IMPORTANT): Started mission Startup 2012-10-08T17:25:44.789Z,1349717144.789 [Startup] Running Loop=1 2012-10-08T17:25:44.789Z,1349717144.789 [Startup](INFO): Aggregate::initialize Startup 2012-10-08T17:25:44.789Z,1349717144.789 [Startup:A.GoToSurface] Running Loop=1 2012-10-08T17:25:44.789Z,1349717144.789 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2012-10-08T17:25:44.795Z,1349717144.795 [Startup:StartupSatComms] Running Loop=1 2012-10-08T17:25:44.795Z,1349717144.795 [Startup:StartupSatComms](INFO): Aggregate::initialize Startup:StartupSatComms 2012-10-08T17:25:44.795Z,1349717144.795 [Startup:StartupSatComms:A] Running Loop=1 2012-10-08T17:25:45.193Z,1349717145.194 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2012-10-08T17:26:41.963Z,1349717201.963 [CommandLine](IMPORTANT): got command maintain control VerticalControl.massPositionAction 3.000000 centimeter 2012-10-08T17:26:41.965Z,1349717201.965 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.massPositionAction" handled in the control thread. 2012-10-08T17:26:42.033Z,1349717202.033 [controlThread](DEBUG): Component order: CycleStarter,InternalSim,AHRS_sp3003D,Depth_Keller,DropWeight,NAL9602,Onboard,Radio_Freewave,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,HFRadarModelCalc,NavChart,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,Navigation,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.massPositionAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,logger, 2012-10-08T17:26:44.799Z,1349717204.799 [Reporter](INFO): platform_mass_position 0.000079 m 2012-10-08T17:26:45.160Z,1349717205.160 [Startup:StartupSatComms:A](INFO): Timed out from 2012-10-08T17:25:44.8Z 2012-10-08T17:26:45.160Z,1349717205.160 [Startup:StartupSatComms:A:A_Timeout] Running Loop=1 2012-10-08T17:26:45.160Z,1349717205.160 [Startup:StartupSatComms:A:A_Timeout](INFO): Aggregate::initialize Startup:StartupSatComms:A:A_Timeout 2012-10-08T17:26:45.161Z,1349717205.161 [Startup:StartupSatComms:A:A_Timeout](INFO): Completed Startup:StartupSatComms:A:A_Timeout 2012-10-08T17:26:45.161Z,1349717205.161 [Startup:StartupSatComms:A] Stopped 2012-10-08T17:26:45.161Z,1349717205.161 [Startup:StartupSatComms:B] Running Loop=1 2012-10-08T17:26:45.195Z,1349717205.195 [Reporter](INFO): platform_mass_position 0.000372 m 2012-10-08T17:26:45.564Z,1349717205.565 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2012-10-08T17:26:45.605Z,1349717205.605 [Reporter](INFO): platform_mass_position 0.000681 m 2012-10-08T17:26:45.995Z,1349717205.995 [Reporter](INFO): platform_mass_position 0.000960 m 2012-10-08T17:26:46.432Z,1349717206.432 [Reporter](INFO): platform_mass_position 0.001296 m 2012-10-08T17:26:46.807Z,1349717206.807 [Reporter](INFO): platform_mass_position 0.001567 m 2012-10-08T17:26:47.247Z,1349717207.247 [Reporter](INFO): platform_mass_position 0.001893 m 2012-10-08T17:26:48.099Z,1349717208.099 [Reporter](INFO): platform_mass_position 0.002526 m 2012-10-08T17:26:48.395Z,1349717208.395 [Reporter](INFO): platform_mass_position 0.002745 m 2012-10-08T17:26:48.735Z,1349717208.735 [Reporter](INFO): platform_mass_position 0.003003 m 2012-10-08T17:26:49.135Z,1349717209.135 [Reporter](INFO): platform_mass_position 0.003295 m 2012-10-08T17:26:49.687Z,1349717209.687 [Reporter](INFO): platform_mass_position 0.003706 m 2012-10-08T17:26:49.955Z,1349717209.955 [Reporter](INFO): platform_mass_position 0.003900 m 2012-10-08T17:26:50.351Z,1349717210.351 [Reporter](INFO): platform_mass_position 0.004206 m 2012-10-08T17:26:50.784Z,1349717210.783 [Reporter](INFO): platform_mass_position 0.004519 m 2012-10-08T17:26:51.163Z,1349717211.163 [Reporter](INFO): platform_mass_position 0.004806 m 2012-10-08T17:26:51.606Z,1349717211.606 [Reporter](INFO): platform_mass_position 0.005127 m 2012-10-08T17:26:52.487Z,1349717212.487 [Reporter](INFO): platform_mass_position 0.005792 m 2012-10-08T17:26:52.843Z,1349717212.843 [Reporter](INFO): platform_mass_position 0.006049 m 2012-10-08T17:26:53.179Z,1349717213.179 [Reporter](INFO): platform_mass_position 0.006307 m 2012-10-08T17:26:53.571Z,1349717213.571 [Reporter](INFO): platform_mass_position 0.006596 m 2012-10-08T17:26:53.947Z,1349717213.947 [Reporter](INFO): platform_mass_position 0.006866 m 2012-10-08T17:26:54.351Z,1349717214.351 [Reporter](INFO): platform_mass_position 0.007180 m 2012-10-08T17:26:54.739Z,1349717214.739 [Reporter](INFO): platform_mass_position 0.007457 m 2012-10-08T17:26:55.143Z,1349717215.143 [Reporter](INFO): platform_mass_position 0.007765 m 2012-10-08T17:26:55.543Z,1349717215.543 [Reporter](INFO): platform_mass_position 0.008049 m 2012-10-08T17:26:55.956Z,1349717215.956 [Reporter](INFO): platform_mass_position 0.008373 m 2012-10-08T17:26:56.347Z,1349717216.347 [Reporter](INFO): platform_mass_position 0.008653 m 2012-10-08T17:26:57.251Z,1349717217.251 [Reporter](INFO): platform_mass_position 0.009325 m 2012-10-08T17:26:57.492Z,1349717217.492 [Reporter](INFO): platform_mass_position 0.009514 m 2012-10-08T17:26:57.892Z,1349717217.892 [Reporter](INFO): platform_mass_position 0.009798 m 2012-10-08T17:26:58.292Z,1349717218.292 [Reporter](INFO): platform_mass_position 0.010106 m 2012-10-08T17:26:58.692Z,1349717218.692 [Reporter](INFO): platform_mass_position 0.010402 m 2012-10-08T17:26:59.099Z,1349717219.099 [Reporter](INFO): platform_mass_position 0.010696 m 2012-10-08T17:26:59.496Z,1349717219.496 [Reporter](INFO): platform_mass_position 0.010999 m 2012-10-08T17:26:59.892Z,1349717219.892 [Reporter](INFO): platform_mass_position 0.011285 m 2012-10-08T17:27:00.296Z,1349717220.296 [Reporter](INFO): platform_mass_position 0.011600 m 2012-10-08T17:27:00.687Z,1349717220.687 [Reporter](INFO): platform_mass_position 0.011873 m 2012-10-08T17:27:01.595Z,1349717221.595 [Reporter](INFO): platform_mass_position 0.012559 m 2012-10-08T17:27:01.839Z,1349717221.839 [Reporter](INFO): platform_mass_position 0.012740 m 2012-10-08T17:27:02.235Z,1349717222.236 [Reporter](INFO): platform_mass_position 0.013033 m 2012-10-08T17:27:02.643Z,1349717222.644 [Reporter](INFO): platform_mass_position 0.013338 m 2012-10-08T17:27:03.043Z,1349717223.043 [Reporter](INFO): platform_mass_position 0.013625 m 2012-10-08T17:27:03.439Z,1349717223.439 [Reporter](INFO): platform_mass_position 0.013928 m 2012-10-08T17:27:03.867Z,1349717223.867 [Reporter](INFO): platform_mass_position 0.014240 m 2012-10-08T17:27:04.235Z,1349717224.235 [Reporter](INFO): platform_mass_position 0.014514 m 2012-10-08T17:27:04.639Z,1349717224.639 [Reporter](INFO): platform_mass_position 0.014820 m 2012-10-08T17:27:05.035Z,1349717225.035 [Reporter](INFO): platform_mass_position 0.015111 m 2012-10-08T17:27:05.943Z,1349717225.943 [Reporter](INFO): platform_mass_position 0.015782 m 2012-10-08T17:27:06.207Z,1349717226.207 [Reporter](INFO): platform_mass_position 0.015985 m 2012-10-08T17:27:06.587Z,1349717226.587 [Reporter](INFO): platform_mass_position 0.016257 m 2012-10-08T17:27:06.995Z,1349717226.995 [Reporter](INFO): platform_mass_position 0.016567 m 2012-10-08T17:27:07.383Z,1349717227.383 [Reporter](INFO): platform_mass_position 0.016860 m 2012-10-08T17:27:07.791Z,1349717227.791 [Reporter](INFO): platform_mass_position 0.017156 m 2012-10-08T17:27:08.187Z,1349717228.187 [Reporter](INFO): platform_mass_position 0.017453 m 2012-10-08T17:27:08.601Z,1349717228.602 [Reporter](INFO): platform_mass_position 0.017758 m 2012-10-08T17:27:08.987Z,1349717228.987 [Reporter](INFO): platform_mass_position 0.018056 m 2012-10-08T17:27:09.383Z,1349717229.383 [Reporter](INFO): platform_mass_position 0.018346 m 2012-10-08T17:27:10.287Z,1349717230.287 [Reporter](INFO): platform_mass_position 0.019014 m 2012-10-08T17:27:10.527Z,1349717230.527 [Reporter](INFO): platform_mass_position 0.019200 m 2012-10-08T17:27:10.927Z,1349717230.927 [Reporter](INFO): platform_mass_position 0.019488 m 2012-10-08T17:27:11.327Z,1349717231.327 [Reporter](INFO): platform_mass_position 0.019797 m 2012-10-08T17:27:11.727Z,1349717231.727 [Reporter](INFO): platform_mass_position 0.020089 m 2012-10-08T17:27:12.127Z,1349717232.127 [Reporter](INFO): platform_mass_position 0.020392 m 2012-10-08T17:27:12.519Z,1349717232.519 [Reporter](INFO): platform_mass_position 0.020676 m 2012-10-08T17:27:12.923Z,1349717232.923 [Reporter](INFO): platform_mass_position 0.020985 m 2012-10-08T17:27:13.327Z,1349717233.327 [Reporter](INFO): platform_mass_position 0.021275 m 2012-10-08T17:27:14.227Z,1349717234.227 [Reporter](INFO): platform_mass_position 0.021948 m 2012-10-08T17:27:14.548Z,1349717234.548 [Reporter](INFO): platform_mass_position 0.022189 m 2012-10-08T17:27:14.867Z,1349717234.867 [Reporter](INFO): platform_mass_position 0.022426 m 2012-10-08T17:27:15.269Z,1349717235.269 [Reporter](INFO): platform_mass_position 0.022721 m 2012-10-08T17:27:15.667Z,1349717235.667 [Reporter](INFO): platform_mass_position 0.023026 m 2012-10-08T17:27:16.067Z,1349717236.067 [Reporter](INFO): platform_mass_position 0.023318 m 2012-10-08T17:27:16.460Z,1349717236.460 [Reporter](INFO): platform_mass_position 0.023607 m 2012-10-08T17:27:16.864Z,1349717236.864 [Reporter](INFO): platform_mass_position 0.023916 m 2012-10-08T17:27:17.270Z,1349717237.270 [Reporter](INFO): platform_mass_position 0.024208 m 2012-10-08T17:27:17.695Z,1349717237.695 [Reporter](INFO): platform_mass_position 0.024530 m 2012-10-08T17:27:18.567Z,1349717238.567 [Reporter](INFO): platform_mass_position 0.025178 m 2012-10-08T17:27:18.807Z,1349717238.807 [Reporter](INFO): platform_mass_position 0.025360 m 2012-10-08T17:27:19.207Z,1349717239.207 [Reporter](INFO): platform_mass_position 0.025654 m 2012-10-08T17:27:19.606Z,1349717239.606 [Reporter](INFO): platform_mass_position 0.025953 m 2012-10-08T17:27:20.007Z,1349717240.007 [Reporter](INFO): platform_mass_position 0.026246 m 2012-10-08T17:27:20.407Z,1349717240.407 [Reporter](INFO): platform_mass_position 0.026541 m 2012-10-08T17:27:20.815Z,1349717240.815 [Reporter](INFO): platform_mass_position 0.026856 m 2012-10-08T17:27:21.203Z,1349717241.203 [Reporter](INFO): platform_mass_position 0.027129 m 2012-10-08T17:27:21.605Z,1349717241.605 [Reporter](INFO): platform_mass_position 0.027434 m 2012-10-08T17:27:22.007Z,1349717242.007 [Reporter](INFO): platform_mass_position 0.027731 m 2012-10-08T17:27:22.903Z,1349717242.903 [Reporter](INFO): platform_mass_position 0.028404 m 2012-10-08T17:27:23.147Z,1349717243.147 [Reporter](INFO): platform_mass_position 0.028576 m 2012-10-08T17:27:23.551Z,1349717243.551 [Reporter](INFO): platform_mass_position 0.028880 m 2012-10-08T17:27:23.955Z,1349717243.955 [Reporter](INFO): platform_mass_position 0.029183 m 2012-10-08T17:27:24.343Z,1349717244.343 [Reporter](INFO): platform_mass_position 0.029462 m 2012-10-08T17:27:24.751Z,1349717244.751 [Reporter](INFO): platform_mass_position 0.029776 m 2012-10-08T17:27:25.175Z,1349717245.175 [Reporter](INFO): platform_mass_position 0.029946 m 2012-10-08T17:27:45.340Z,1349717265.340 [Startup:StartupSatComms:B](INFO): Timed out from 2012-10-08T17:26:45.2Z 2012-10-08T17:27:45.340Z,1349717265.340 [Startup:StartupSatComms:B:A_Timeout] Running Loop=1 2012-10-08T17:27:45.340Z,1349717265.340 [Startup:StartupSatComms:B:A_Timeout](INFO): Aggregate::initialize Startup:StartupSatComms:B:A_Timeout 2012-10-08T17:27:45.340Z,1349717265.341 [Startup:StartupSatComms:B:A_Timeout](INFO): Completed Startup:StartupSatComms:B:A_Timeout 2012-10-08T17:27:45.341Z,1349717265.341 [Startup:StartupSatComms:B] Stopped 2012-10-08T17:27:45.341Z,1349717265.341 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2012-10-08T17:27:45.341Z,1349717265.341 [Startup:StartupSatComms] Stopped 2012-10-08T17:27:45.341Z,1349717265.341 [Startup:StartupSatComms](INFO): Aggregate::uninitialize Startup:StartupSatComms 2012-10-08T17:27:45.342Z,1349717265.342 [Startup](INFO): Completed Startup 2012-10-08T17:27:45.342Z,1349717265.342 [Startup] Stopped 2012-10-08T17:27:45.342Z,1349717265.342 [Startup](INFO): Aggregate::uninitialize Startup 2012-10-08T17:27:45.342Z,1349717265.342 [Startup:A.GoToSurface] Stopped 2012-10-08T17:27:45.342Z,1349717265.342 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2012-10-08T17:27:45.748Z,1349717265.748 [MissionManager](IMPORTANT): Started mission Default 2012-10-08T17:27:45.748Z,1349717265.748 [Default] Running Loop=1 2012-10-08T17:27:45.748Z,1349717265.748 [Default](INFO): Aggregate::initialize Default 2012-10-08T17:27:45.748Z,1349717265.748 [Default:D.SetSpeed] Running Loop=1 2012-10-08T17:27:45.748Z,1349717265.748 [Default:D.SetSpeed](DEBUG): Initialize. 2012-10-08T17:27:45.748Z,1349717265.748 [Default:E.GoToSurface] Running Loop=1 2012-10-08T17:27:45.748Z,1349717265.748 [Default:E.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2012-10-08T17:27:45.748Z,1349717265.749 [Default:Iridium] Running Loop=1 2012-10-08T17:27:45.749Z,1349717265.749 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium 2012-10-08T17:27:45.749Z,1349717265.749 [Default:Iridium:A.SetSpeed] Running Loop=1 2012-10-08T17:27:45.749Z,1349717265.749 [Default:Iridium:A.SetSpeed](DEBUG): Initialize. 2012-10-08T17:27:45.749Z,1349717265.749 [Default:Iridium:B.GoToSurface] Running Loop=1 2012-10-08T17:27:45.749Z,1349717265.749 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2012-10-08T17:27:45.749Z,1349717265.750 [Default:E.GoToSurface] Running Loop=1 2012-10-08T17:27:45.755Z,1349717265.755 [Default:D.SetSpeed] Running Loop=1 2012-10-08T17:27:45.760Z,1349717265.760 [Default:CallIridium] Running Loop=1 2012-10-08T17:27:45.760Z,1349717265.760 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium 2012-10-08T17:27:45.761Z,1349717265.760 [Default:CallIridium:A] Running Loop=1 2012-10-08T17:27:45.762Z,1349717265.762 [Default:CallIridium:A] Stopped 2012-10-08T17:27:45.762Z,1349717265.763 [Default:CallIridium:B] Running Loop=1 2012-10-08T17:27:45.763Z,1349717265.763 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B 2012-10-08T17:27:45.768Z,1349717265.769 [Default:Iridium:B.GoToSurface] Stopped 2012-10-08T17:27:45.769Z,1349717265.769 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2012-10-08T17:27:45.769Z,1349717265.769 [Default:Iridium:Read_Iridium] Running Loop=1 2012-10-08T17:27:45.769Z,1349717265.769 [Default:Iridium:A.SetSpeed] Running Loop=1 2012-10-08T17:27:45.774Z,1349717265.774 [Default:GPS] Running Loop=1 2012-10-08T17:27:45.774Z,1349717265.774 [Default:GPS](INFO): Aggregate::initialize Default:GPS 2012-10-08T17:27:45.774Z,1349717265.774 [Default:GPS:A.SetSpeed] Running Loop=1 2012-10-08T17:27:45.774Z,1349717265.774 [Default:GPS:A.SetSpeed](DEBUG): Initialize. 2012-10-08T17:27:45.774Z,1349717265.774 [Default:GPS:B.GoToSurface] Running Loop=1 2012-10-08T17:27:45.775Z,1349717265.774 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2012-10-08T17:27:45.780Z,1349717265.780 [Default:GPS:B.GoToSurface] Stopped 2012-10-08T17:27:45.780Z,1349717265.780 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2012-10-08T17:27:45.780Z,1349717265.780 [Default:GPS:Read_GPS] Running Loop=1 2012-10-08T17:27:45.780Z,1349717265.780 [Default:GPS:A.SetSpeed] Running Loop=1 2012-10-08T17:27:46.145Z,1349717266.145 [Default:Iridium:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2012-10-08T17:27:46.148Z,1349717266.148 [Default:GPS:Read_GPS](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2012-10-08T17:28:54.179Z,1349717334.180 [CommandLine](IMPORTANT): got command maintain control VerticalControl.massPositionAction -3.000000 centimeter 2012-10-08T17:28:54.692Z,1349717334.692 [Reporter](INFO): platform_mass_position 0.029890 m 2012-10-08T17:28:55.323Z,1349717335.323 [Reporter](INFO): platform_mass_position 0.029406 m 2012-10-08T17:28:55.719Z,1349717335.719 [Reporter](INFO): platform_mass_position 0.029124 m 2012-10-08T17:28:56.123Z,1349717336.123 [Reporter](INFO): platform_mass_position 0.028815 m 2012-10-08T17:28:56.523Z,1349717336.523 [Reporter](INFO): platform_mass_position 0.028512 m 2012-10-08T17:28:56.915Z,1349717336.915 [Reporter](INFO): platform_mass_position 0.028232 m 2012-10-08T17:28:57.371Z,1349717337.371 [Reporter](INFO): platform_mass_position 0.027885 m 2012-10-08T17:28:57.723Z,1349717337.723 [Reporter](INFO): platform_mass_position 0.027622 m 2012-10-08T17:28:58.123Z,1349717338.123 [Reporter](INFO): platform_mass_position 0.027329 m 2012-10-08T17:28:59.027Z,1349717339.027 [Reporter](INFO): platform_mass_position 0.026657 m 2012-10-08T17:28:59.347Z,1349717339.347 [Reporter](INFO): platform_mass_position 0.026412 m 2012-10-08T17:28:59.667Z,1349717339.667 [Reporter](INFO): platform_mass_position 0.026181 m 2012-10-08T17:29:00.067Z,1349717340.067 [Reporter](INFO): platform_mass_position 0.025874 m 2012-10-08T17:29:00.515Z,1349717340.515 [Reporter](INFO): platform_mass_position 0.025541 m 2012-10-08T17:29:00.867Z,1349717340.867 [Reporter](INFO): platform_mass_position 0.025289 m 2012-10-08T17:29:01.269Z,1349717341.269 [Reporter](INFO): platform_mass_position 0.024987 m 2012-10-08T17:29:01.667Z,1349717341.667 [Reporter](INFO): platform_mass_position 0.024682 m 2012-10-08T17:29:02.067Z,1349717342.067 [Reporter](INFO): platform_mass_position 0.024396 m 2012-10-08T17:29:02.467Z,1349717342.467 [Reporter](INFO): platform_mass_position 0.024098 m 2012-10-08T17:29:03.367Z,1349717343.367 [Reporter](INFO): platform_mass_position 0.023428 m 2012-10-08T17:29:03.647Z,1349717343.647 [Reporter](INFO): platform_mass_position 0.023218 m 2012-10-08T17:29:04.011Z,1349717344.011 [Reporter](INFO): platform_mass_position 0.022953 m 2012-10-08T17:29:04.407Z,1349717344.407 [Reporter](INFO): platform_mass_position 0.022646 m 2012-10-08T17:29:04.807Z,1349717344.807 [Reporter](INFO): platform_mass_position 0.022362 m 2012-10-08T17:29:05.207Z,1349717345.207 [Reporter](INFO): platform_mass_position 0.022056 m 2012-10-08T17:29:05.605Z,1349717345.605 [Reporter](INFO): platform_mass_position 0.021769 m 2012-10-08T17:29:06.007Z,1349717346.007 [Reporter](INFO): platform_mass_position 0.021461 m 2012-10-08T17:29:06.407Z,1349717346.407 [Reporter](INFO): platform_mass_position 0.021163 m 2012-10-08T17:29:06.835Z,1349717346.835 [Reporter](INFO): platform_mass_position 0.020851 m 2012-10-08T17:29:07.707Z,1349717347.707 [Reporter](INFO): platform_mass_position 0.020199 m 2012-10-08T17:29:07.947Z,1349717347.947 [Reporter](INFO): platform_mass_position 0.020015 m 2012-10-08T17:29:08.347Z,1349717348.347 [Reporter](INFO): platform_mass_position 0.019716 m 2012-10-08T17:29:08.755Z,1349717348.755 [Reporter](INFO): platform_mass_position 0.019425 m 2012-10-08T17:29:09.151Z,1349717349.151 [Reporter](INFO): platform_mass_position 0.019126 m 2012-10-08T17:29:09.547Z,1349717349.547 [Reporter](INFO): platform_mass_position 0.018826 m 2012-10-08T17:29:09.941Z,1349717349.941 [Reporter](INFO): platform_mass_position 0.018542 m 2012-10-08T17:29:10.339Z,1349717350.339 [Reporter](INFO): platform_mass_position 0.018248 m 2012-10-08T17:29:10.747Z,1349717350.747 [Reporter](INFO): platform_mass_position 0.017938 m 2012-10-08T17:29:11.147Z,1349717351.147 [Reporter](INFO): platform_mass_position 0.017644 m 2012-10-08T17:29:12.047Z,1349717352.047 [Reporter](INFO): platform_mass_position 0.016970 m 2012-10-08T17:29:12.287Z,1349717352.287 [Reporter](INFO): platform_mass_position 0.016797 m 2012-10-08T17:29:12.692Z,1349717352.692 [Reporter](INFO): platform_mass_position 0.016489 m 2012-10-08T17:29:13.091Z,1349717353.092 [Reporter](INFO): platform_mass_position 0.016201 m 2012-10-08T17:29:13.492Z,1349717353.492 [Reporter](INFO): platform_mass_position 0.015902 m 2012-10-08T17:29:13.891Z,1349717353.891 [Reporter](INFO): platform_mass_position 0.015600 m 2012-10-08T17:29:14.287Z,1349717354.287 [Reporter](INFO): platform_mass_position 0.015308 m 2012-10-08T17:29:14.696Z,1349717354.695 [Reporter](INFO): platform_mass_position 0.015001 m 2012-10-08T17:29:15.091Z,1349717355.091 [Reporter](INFO): platform_mass_position 0.014712 m 2012-10-08T17:29:15.991Z,1349717355.991 [Reporter](INFO): platform_mass_position 0.014037 m 2012-10-08T17:29:16.231Z,1349717356.231 [Reporter](INFO): platform_mass_position 0.013865 m 2012-10-08T17:29:16.635Z,1349717356.635 [Reporter](INFO): platform_mass_position 0.013558 m 2012-10-08T17:29:17.035Z,1349717357.035 [Reporter](INFO): platform_mass_position 0.013270 m 2012-10-08T17:29:17.439Z,1349717357.439 [Reporter](INFO): platform_mass_position 0.012962 m 2012-10-08T17:29:17.831Z,1349717357.831 [Reporter](INFO): platform_mass_position 0.012670 m 2012-10-08T17:29:18.235Z,1349717358.235 [Reporter](INFO): platform_mass_position 0.012370 m 2012-10-08T17:29:18.639Z,1349717358.639 [Reporter](INFO): platform_mass_position 0.012066 m 2012-10-08T17:29:19.051Z,1349717359.051 [Reporter](INFO): platform_mass_position 0.011762 m 2012-10-08T17:29:19.427Z,1349717359.427 [Reporter](INFO): platform_mass_position 0.011483 m 2012-10-08T17:29:20.335Z,1349717360.335 [Reporter](INFO): platform_mass_position 0.010812 m 2012-10-08T17:29:20.575Z,1349717360.575 [Reporter](INFO): platform_mass_position 0.010629 m 2012-10-08T17:29:20.975Z,1349717360.975 [Reporter](INFO): platform_mass_position 0.010335 m 2012-10-08T17:29:21.379Z,1349717361.379 [Reporter](INFO): platform_mass_position 0.010031 m 2012-10-08T17:29:21.771Z,1349717361.771 [Reporter](INFO): platform_mass_position 0.009735 m 2012-10-08T17:29:22.183Z,1349717362.183 [Reporter](INFO): platform_mass_position 0.009428 m 2012-10-08T17:29:22.571Z,1349717362.571 [Reporter](INFO): platform_mass_position 0.009144 m 2012-10-08T17:29:22.971Z,1349717362.971 [Reporter](INFO): platform_mass_position 0.008850 m 2012-10-08T17:29:23.379Z,1349717363.379 [Reporter](INFO): platform_mass_position 0.008536 m 2012-10-08T17:29:23.771Z,1349717363.771 [Reporter](INFO): platform_mass_position 0.008255 m 2012-10-08T17:29:24.675Z,1349717364.675 [Reporter](INFO): platform_mass_position 0.007571 m 2012-10-08T17:29:24.938Z,1349717364.938 [Reporter](INFO): platform_mass_position 0.007391 m 2012-10-08T17:29:25.315Z,1349717365.315 [Reporter](INFO): platform_mass_position 0.007098 m 2012-10-08T17:29:25.719Z,1349717365.719 [Reporter](INFO): platform_mass_position 0.006809 m 2012-10-08T17:29:26.123Z,1349717366.123 [Reporter](INFO): platform_mass_position 0.006499 m 2012-10-08T17:29:26.523Z,1349717366.523 [Reporter](INFO): platform_mass_position 0.006213 m 2012-10-08T17:29:26.911Z,1349717366.911 [Reporter](INFO): platform_mass_position 0.005915 m 2012-10-08T17:29:27.319Z,1349717367.319 [Reporter](INFO): platform_mass_position 0.005613 m 2012-10-08T17:29:27.719Z,1349717367.719 [Reporter](INFO): platform_mass_position 0.005315 m 2012-10-08T17:29:28.119Z,1349717368.119 [Reporter](INFO): platform_mass_position 0.005023 m 2012-10-08T17:29:29.019Z,1349717369.019 [Reporter](INFO): platform_mass_position 0.004350 m 2012-10-08T17:29:29.259Z,1349717369.259 [Reporter](INFO): platform_mass_position 0.004175 m 2012-10-08T17:29:29.663Z,1349717369.663 [Reporter](INFO): platform_mass_position 0.003878 m 2012-10-08T17:29:30.059Z,1349717370.059 [Reporter](INFO): platform_mass_position 0.003583 m 2012-10-08T17:29:30.455Z,1349717370.455 [Reporter](INFO): platform_mass_position 0.003280 m 2012-10-08T17:29:30.859Z,1349717370.859 [Reporter](INFO): platform_mass_position 0.002988 m 2012-10-08T17:29:31.291Z,1349717371.291 [Reporter](INFO): platform_mass_position 0.002656 m 2012-10-08T17:29:31.655Z,1349717371.655 [Reporter](INFO): platform_mass_position 0.002393 m 2012-10-08T17:29:32.059Z,1349717372.059 [Reporter](INFO): platform_mass_position 0.002093 m 2012-10-08T17:29:32.959Z,1349717372.959 [Reporter](INFO): platform_mass_position 0.001410 m 2012-10-08T17:29:33.199Z,1349717373.199 [Reporter](INFO): platform_mass_position 0.001240 m 2012-10-08T17:29:33.601Z,1349717373.601 [Reporter](INFO): platform_mass_position 0.000940 m 2012-10-08T17:29:33.999Z,1349717373.999 [Reporter](INFO): platform_mass_position 0.000638 m 2012-10-08T17:29:34.475Z,1349717374.475 [Reporter](INFO): platform_mass_position 0.000291 m 2012-10-08T17:29:34.795Z,1349717374.795 [Reporter](INFO): platform_mass_position 0.000047 m 2012-10-08T17:29:35.203Z,1349717375.203 [Reporter](INFO): platform_mass_position -0.000242 m 2012-10-08T17:29:35.601Z,1349717375.601 [Reporter](INFO): platform_mass_position -0.000557 m 2012-10-08T17:29:35.999Z,1349717375.999 [Reporter](INFO): platform_mass_position -0.000835 m 2012-10-08T17:29:36.395Z,1349717376.395 [Reporter](INFO): platform_mass_position -0.001137 m 2012-10-08T17:29:37.307Z,1349717377.307 [Reporter](INFO): platform_mass_position -0.001820 m 2012-10-08T17:29:37.595Z,1349717377.595 [Reporter](INFO): platform_mass_position -0.002020 m 2012-10-08T17:29:37.951Z,1349717377.951 [Reporter](INFO): platform_mass_position -0.002301 m 2012-10-08T17:29:38.347Z,1349717378.347 [Reporter](INFO): platform_mass_position -0.002590 m 2012-10-08T17:29:38.755Z,1349717378.755 [Reporter](INFO): platform_mass_position -0.002895 m 2012-10-08T17:29:39.151Z,1349717379.151 [Reporter](INFO): platform_mass_position -0.003185 m 2012-10-08T17:29:39.543Z,1349717379.543 [Reporter](INFO): platform_mass_position -0.003485 m 2012-10-08T17:29:39.947Z,1349717379.947 [Reporter](INFO): platform_mass_position -0.003782 m 2012-10-08T17:29:40.347Z,1349717380.347 [Reporter](INFO): platform_mass_position -0.004075 m 2012-10-08T17:29:40.823Z,1349717380.823 [Reporter](INFO): platform_mass_position -0.004436 m 2012-10-08T17:29:41.675Z,1349717381.675 [Reporter](INFO): platform_mass_position -0.005064 m 2012-10-08T17:29:41.942Z,1349717381.942 [Reporter](INFO): platform_mass_position -0.005259 m 2012-10-08T17:29:42.343Z,1349717382.343 [Reporter](INFO): platform_mass_position -0.005567 m 2012-10-08T17:29:42.743Z,1349717382.743 [Reporter](INFO): platform_mass_position -0.005854 m 2012-10-08T17:29:43.143Z,1349717383.143 [Reporter](INFO): platform_mass_position -0.006162 m 2012-10-08T17:29:43.539Z,1349717383.539 [Reporter](INFO): platform_mass_position -0.006453 m 2012-10-08T17:29:44.040Z,1349717384.039 [Reporter](INFO): platform_mass_position -0.006832 m 2012-10-08T17:29:44.315Z,1349717384.315 [Reporter](INFO): platform_mass_position -0.007027 m 2012-10-08T17:29:44.719Z,1349717384.719 [Reporter](INFO): platform_mass_position -0.007334 m 2012-10-08T17:29:45.119Z,1349717385.119 [Reporter](INFO): platform_mass_position -0.007626 m 2012-10-08T17:29:46.019Z,1349717386.019 [Reporter](INFO): platform_mass_position -0.008294 m 2012-10-08T17:29:46.259Z,1349717386.259 [Reporter](INFO): platform_mass_position -0.008480 m 2012-10-08T17:29:46.659Z,1349717386.659 [Reporter](INFO): platform_mass_position -0.008771 m 2012-10-08T17:29:47.059Z,1349717387.059 [Reporter](INFO): platform_mass_position -0.009069 m 2012-10-08T17:29:47.463Z,1349717387.463 [Reporter](INFO): platform_mass_position -0.009371 m 2012-10-08T17:29:47.863Z,1349717387.863 [Reporter](INFO): platform_mass_position -0.009664 m 2012-10-08T17:29:48.292Z,1349717388.292 [Reporter](INFO): platform_mass_position -0.009987 m 2012-10-08T17:29:48.680Z,1349717388.680 [Reporter](INFO): platform_mass_position -0.010281 m 2012-10-08T17:29:49.083Z,1349717389.083 [Reporter](INFO): platform_mass_position -0.010568 m 2012-10-08T17:29:50.032Z,1349717390.032 [Reporter](INFO): platform_mass_position -0.011273 m 2012-10-08T17:29:50.364Z,1349717390.364 [Reporter](INFO): platform_mass_position -0.011529 m 2012-10-08T17:29:50.755Z,1349717390.755 [Reporter](INFO): platform_mass_position -0.011815 m 2012-10-08T17:29:51.124Z,1349717391.124 [Reporter](INFO): platform_mass_position -0.012092 m 2012-10-08T17:29:51.524Z,1349717391.523 [Reporter](INFO): platform_mass_position -0.012385 m 2012-10-08T17:29:51.915Z,1349717391.915 [Reporter](INFO): platform_mass_position -0.012679 m 2012-10-08T17:29:52.356Z,1349717392.355 [Reporter](INFO): platform_mass_position -0.013009 m 2012-10-08T17:29:52.707Z,1349717392.707 [Reporter](INFO): platform_mass_position -0.013262 m 2012-10-08T17:29:53.132Z,1349717393.132 [Reporter](INFO): platform_mass_position -0.013587 m 2012-10-08T17:29:53.496Z,1349717393.496 [Reporter](INFO): platform_mass_position -0.013853 m 2012-10-08T17:29:54.403Z,1349717394.403 [Reporter](INFO): platform_mass_position -0.014529 m 2012-10-08T17:29:54.647Z,1349717394.647 [Reporter](INFO): platform_mass_position -0.014703 m 2012-10-08T17:29:55.051Z,1349717395.051 [Reporter](INFO): platform_mass_position -0.015011 m 2012-10-08T17:29:55.451Z,1349717395.451 [Reporter](INFO): platform_mass_position -0.015306 m 2012-10-08T17:29:55.843Z,1349717395.843 [Reporter](INFO): platform_mass_position -0.015594 m 2012-10-08T17:29:56.323Z,1349717396.323 [Reporter](INFO): platform_mass_position -0.015956 m 2012-10-08T17:29:56.647Z,1349717396.647 [Reporter](INFO): platform_mass_position -0.016189 m 2012-10-08T17:29:57.039Z,1349717397.039 [Reporter](INFO): platform_mass_position -0.016492 m 2012-10-08T17:29:57.451Z,1349717397.451 [Reporter](INFO): platform_mass_position -0.016795 m 2012-10-08T17:29:57.847Z,1349717397.847 [Reporter](INFO): platform_mass_position -0.017077 m 2012-10-08T17:29:58.747Z,1349717398.747 [Reporter](INFO): platform_mass_position -0.017762 m 2012-10-08T17:29:58.992Z,1349717398.992 [Reporter](INFO): platform_mass_position -0.017931 m 2012-10-08T17:29:59.427Z,1349717399.427 [Reporter](INFO): platform_mass_position -0.018267 m 2012-10-08T17:29:59.791Z,1349717399.791 [Reporter](INFO): platform_mass_position -0.018531 m 2012-10-08T17:30:00.195Z,1349717400.195 [Reporter](INFO): platform_mass_position -0.018831 m 2012-10-08T17:30:00.595Z,1349717400.595 [Reporter](INFO): platform_mass_position -0.019123 m 2012-10-08T17:30:00.987Z,1349717400.987 [Reporter](INFO): platform_mass_position -0.019427 m 2012-10-08T17:30:01.391Z,1349717401.391 [Reporter](INFO): platform_mass_position -0.019724 m 2012-10-08T17:30:01.791Z,1349717401.791 [Reporter](INFO): platform_mass_position -0.020013 m 2012-10-08T17:30:02.191Z,1349717402.191 [Reporter](INFO): platform_mass_position -0.020317 m 2012-10-08T17:30:03.107Z,1349717403.107 [Reporter](INFO): platform_mass_position -0.020996 m 2012-10-08T17:30:03.359Z,1349717403.359 [Reporter](INFO): platform_mass_position -0.021176 m 2012-10-08T17:30:03.751Z,1349717403.751 [Reporter](INFO): platform_mass_position -0.021483 m 2012-10-08T17:30:04.151Z,1349717404.151 [Reporter](INFO): platform_mass_position -0.021765 m 2012-10-08T17:30:04.547Z,1349717404.547 [Reporter](INFO): platform_mass_position -0.022069 m 2012-10-08T17:30:04.951Z,1349717404.951 [Reporter](INFO): platform_mass_position -0.022370 m 2012-10-08T17:30:05.351Z,1349717405.351 [Reporter](INFO): platform_mass_position -0.022663 m 2012-10-08T17:30:05.744Z,1349717405.744 [Reporter](INFO): platform_mass_position -0.022953 m 2012-10-08T17:30:06.148Z,1349717406.148 [Reporter](INFO): platform_mass_position -0.023252 m 2012-10-08T17:30:06.552Z,1349717406.552 [Reporter](INFO): platform_mass_position -0.023566 m 2012-10-08T17:30:06.947Z,1349717406.947 [Reporter](INFO): platform_mass_position -0.023842 m 2012-10-08T17:30:07.851Z,1349717407.851 [Reporter](INFO): platform_mass_position -0.024526 m 2012-10-08T17:30:08.091Z,1349717408.091 [Reporter](INFO): platform_mass_position -0.024697 m 2012-10-08T17:30:08.495Z,1349717408.495 [Reporter](INFO): platform_mass_position -0.024997 m 2012-10-08T17:30:08.891Z,1349717408.891 [Reporter](INFO): platform_mass_position -0.025298 m 2012-10-08T17:30:09.287Z,1349717409.287 [Reporter](INFO): platform_mass_position -0.025592 m 2012-10-08T17:30:09.691Z,1349717409.691 [Reporter](INFO): platform_mass_position -0.025895 m 2012-10-08T17:30:10.087Z,1349717410.087 [Reporter](INFO): platform_mass_position -0.026176 m 2012-10-08T17:30:10.491Z,1349717410.491 [Reporter](INFO): platform_mass_position -0.026494 m 2012-10-08T17:30:10.891Z,1349717410.891 [Reporter](INFO): platform_mass_position -0.026781 m 2012-10-08T17:30:11.287Z,1349717411.287 [Reporter](INFO): platform_mass_position -0.027071 m 2012-10-08T17:30:12.191Z,1349717412.191 [Reporter](INFO): platform_mass_position -0.027760 m 2012-10-08T17:30:12.435Z,1349717412.435 [Reporter](INFO): platform_mass_position -0.027937 m 2012-10-08T17:30:12.839Z,1349717412.839 [Reporter](INFO): platform_mass_position -0.028234 m 2012-10-08T17:30:13.239Z,1349717413.239 [Reporter](INFO): platform_mass_position -0.028526 m 2012-10-08T17:30:13.643Z,1349717413.643 [Reporter](INFO): platform_mass_position -0.028823 m 2012-10-08T17:30:14.039Z,1349717414.039 [Reporter](INFO): platform_mass_position -0.029119 m 2012-10-08T17:30:14.427Z,1349717414.427 [Reporter](INFO): platform_mass_position -0.029401 m 2012-10-08T17:30:14.872Z,1349717414.872 [Reporter](INFO): platform_mass_position -0.029706 m 2012-10-08T17:30:15.259Z,1349717415.259 [Reporter](INFO): platform_mass_position -0.029926 m 2012-10-08T17:30:15.659Z,1349717415.659 [Reporter](INFO): platform_mass_position -0.029927 m 2012-10-08T17:30:23.923Z,1349717423.923 [CommandLine](IMPORTANT): got command maintain clear 2012-10-08T17:30:24.056Z,1349717424.056 [controlThread](DEBUG): Component order: CycleStarter,InternalSim,AHRS_sp3003D,Depth_Keller,DropWeight,NAL9602,Onboard,Radio_Freewave,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,HFRadarModelCalc,NavChart,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,Navigation,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,logger, 2012-10-08T17:30:24.775Z,1349717424.775 [Reporter](INFO): platform_mass_position -0.029769 m 2012-10-08T17:30:25.679Z,1349717425.679 [Reporter](INFO): platform_mass_position -0.029102 m 2012-10-08T17:30:25.919Z,1349717425.919 [Reporter](INFO): platform_mass_position -0.028921 m 2012-10-08T17:30:26.319Z,1349717426.319 [Reporter](INFO): platform_mass_position -0.028630 m 2012-10-08T17:30:26.723Z,1349717426.723 [Reporter](INFO): platform_mass_position -0.028336 m 2012-10-08T17:30:27.151Z,1349717427.151 [Reporter](INFO): platform_mass_position -0.028036 m 2012-10-08T17:30:27.523Z,1349717427.523 [Reporter](INFO): platform_mass_position -0.027742 m 2012-10-08T17:30:27.915Z,1349717427.915 [Reporter](INFO): platform_mass_position -0.027445 m 2012-10-08T17:30:28.316Z,1349717428.316 [Reporter](INFO): platform_mass_position -0.027160 m 2012-10-08T17:30:28.720Z,1349717428.720 [Reporter](INFO): platform_mass_position -0.026857 m 2012-10-08T17:30:29.115Z,1349717429.115 [Reporter](INFO): platform_mass_position -0.026554 m 2012-10-08T17:30:30.023Z,1349717430.023 [Reporter](INFO): platform_mass_position -0.025890 m 2012-10-08T17:30:30.312Z,1349717430.312 [Reporter](INFO): platform_mass_position -0.025667 m 2012-10-08T17:30:30.663Z,1349717430.663 [Reporter](INFO): platform_mass_position -0.025416 m 2012-10-08T17:30:31.067Z,1349717431.067 [Reporter](INFO): platform_mass_position -0.025114 m 2012-10-08T17:30:31.467Z,1349717431.467 [Reporter](INFO): platform_mass_position -0.024821 m 2012-10-08T17:30:31.867Z,1349717431.867 [Reporter](INFO): platform_mass_position -0.024512 m 2012-10-08T17:30:32.270Z,1349717432.270 [Reporter](INFO): platform_mass_position -0.024224 m 2012-10-08T17:30:32.667Z,1349717432.667 [Reporter](INFO): platform_mass_position -0.023930 m 2012-10-08T17:30:33.567Z,1349717433.568 [Reporter](INFO): platform_mass_position -0.023263 m 2012-10-08T17:30:33.811Z,1349717433.811 [Reporter](INFO): platform_mass_position -0.023083 m 2012-10-08T17:30:34.207Z,1349717434.207 [Reporter](INFO): platform_mass_position -0.022776 m 2012-10-08T17:30:34.606Z,1349717434.606 [Reporter](INFO): platform_mass_position -0.022484 m 2012-10-08T17:30:35.003Z,1349717435.003 [Reporter](INFO): platform_mass_position -0.022189 m 2012-10-08T17:30:35.407Z,1349717435.407 [Reporter](INFO): platform_mass_position -0.021899 m 2012-10-08T17:30:35.803Z,1349717435.803 [Reporter](INFO): platform_mass_position -0.021591 m 2012-10-08T17:30:36.203Z,1349717436.203 [Reporter](INFO): platform_mass_position -0.021305 m 2012-10-08T17:30:36.611Z,1349717436.611 [Reporter](INFO): platform_mass_position -0.020997 m 2012-10-08T17:30:37.007Z,1349717437.007 [Reporter](INFO): platform_mass_position -0.020704 m 2012-10-08T17:30:37.907Z,1349717437.907 [Reporter](INFO): platform_mass_position -0.020041 m 2012-10-08T17:30:38.151Z,1349717438.151 [Reporter](INFO): platform_mass_position -0.019848 m 2012-10-08T17:30:38.551Z,1349717438.551 [Reporter](INFO): platform_mass_position -0.019553 m 2012-10-08T17:30:38.951Z,1349717438.951 [Reporter](INFO): platform_mass_position -0.019256 m 2012-10-08T17:30:39.347Z,1349717439.347 [Reporter](INFO): platform_mass_position -0.018974 m 2012-10-08T17:30:39.747Z,1349717439.747 [Reporter](INFO): platform_mass_position -0.018658 m 2012-10-08T17:30:40.151Z,1349717440.151 [Reporter](INFO): platform_mass_position -0.018370 m 2012-10-08T17:30:40.539Z,1349717440.539 [Reporter](INFO): platform_mass_position -0.018077 m 2012-10-08T17:30:40.947Z,1349717440.947 [Reporter](INFO): platform_mass_position -0.017770 m 2012-10-08T17:30:41.843Z,1349717441.843 [Reporter](INFO): platform_mass_position -0.017105 m 2012-10-08T17:30:42.083Z,1349717442.083 [Reporter](INFO): platform_mass_position -0.016936 m 2012-10-08T17:30:42.479Z,1349717442.479 [Reporter](INFO): platform_mass_position -0.016627 m 2012-10-08T17:30:42.879Z,1349717442.879 [Reporter](INFO): platform_mass_position -0.016344 m 2012-10-08T17:30:43.283Z,1349717443.283 [Reporter](INFO): platform_mass_position -0.016032 m 2012-10-08T17:30:43.683Z,1349717443.683 [Reporter](INFO): platform_mass_position -0.015736 m 2012-10-08T17:30:44.080Z,1349717444.080 [Reporter](INFO): platform_mass_position -0.015443 m 2012-10-08T17:30:44.488Z,1349717444.488 [Reporter](INFO): platform_mass_position -0.015137 m 2012-10-08T17:30:44.883Z,1349717444.883 [Reporter](INFO): platform_mass_position -0.014851 m 2012-10-08T17:30:45.279Z,1349717445.279 [Reporter](INFO): platform_mass_position -0.014544 m 2012-10-08T17:30:46.183Z,1349717446.183 [Reporter](INFO): platform_mass_position -0.013875 m 2012-10-08T17:30:46.423Z,1349717446.423 [Reporter](INFO): platform_mass_position -0.013701 m 2012-10-08T17:30:46.819Z,1349717446.819 [Reporter](INFO): platform_mass_position -0.013398 m 2012-10-08T17:30:47.223Z,1349717447.223 [Reporter](INFO): platform_mass_position -0.013101 m 2012-10-08T17:30:47.619Z,1349717447.619 [Reporter](INFO): platform_mass_position -0.012808 m 2012-10-08T17:30:48.023Z,1349717448.023 [Reporter](INFO): platform_mass_position -0.012498 m 2012-10-08T17:30:48.419Z,1349717448.419 [Reporter](INFO): platform_mass_position -0.012214 m 2012-10-08T17:30:48.860Z,1349717448.860 [Reporter](INFO): platform_mass_position -0.011889 m 2012-10-08T17:30:49.255Z,1349717449.256 [Reporter](INFO): platform_mass_position -0.011592 m 2012-10-08T17:30:49.647Z,1349717449.647 [Reporter](INFO): platform_mass_position -0.011299 m 2012-10-08T17:30:50.536Z,1349717450.536 [Reporter](INFO): platform_mass_position -0.010640 m 2012-10-08T17:30:50.844Z,1349717450.844 [Reporter](INFO): platform_mass_position -0.010402 m 2012-10-08T17:30:51.232Z,1349717451.232 [Reporter](INFO): platform_mass_position -0.010123 m 2012-10-08T17:30:51.616Z,1349717451.616 [Reporter](INFO): platform_mass_position -0.009827 m 2012-10-08T17:30:52.016Z,1349717452.016 [Reporter](INFO): platform_mass_position -0.009533 m 2012-10-08T17:30:52.423Z,1349717452.423 [Reporter](INFO): platform_mass_position -0.009236 m 2012-10-08T17:30:52.819Z,1349717452.819 [Reporter](INFO): platform_mass_position -0.008931 m 2012-10-08T17:30:53.220Z,1349717453.220 [Reporter](INFO): platform_mass_position -0.008641 m 2012-10-08T17:30:53.715Z,1349717453.715 [Reporter](INFO): platform_mass_position -0.008267 m 2012-10-08T17:30:53.995Z,1349717453.995 [Reporter](INFO): platform_mass_position -0.008064 m 2012-10-08T17:30:54.895Z,1349717454.895 [Reporter](INFO): platform_mass_position -0.007389 m 2012-10-08T17:30:55.139Z,1349717455.139 [Reporter](INFO): platform_mass_position -0.007213 m 2012-10-08T17:30:55.527Z,1349717455.527 [Reporter](INFO): platform_mass_position -0.006924 m 2012-10-08T17:30:55.931Z,1349717455.931 [Reporter](INFO): platform_mass_position -0.006618 m 2012-10-08T17:30:56.331Z,1349717456.331 [Reporter](INFO): platform_mass_position -0.006317 m 2012-10-08T17:30:56.735Z,1349717456.735 [Reporter](INFO): platform_mass_position -0.006021 m 2012-10-08T17:30:57.135Z,1349717457.135 [Reporter](INFO): platform_mass_position -0.005724 m 2012-10-08T17:30:57.527Z,1349717457.527 [Reporter](INFO): platform_mass_position -0.005428 m 2012-10-08T17:30:57.938Z,1349717457.938 [Reporter](INFO): platform_mass_position -0.005124 m 2012-10-08T17:30:58.831Z,1349717458.831 [Reporter](INFO): platform_mass_position -0.004460 m 2012-10-08T17:30:59.071Z,1349717459.071 [Reporter](INFO): platform_mass_position -0.004283 m 2012-10-08T17:30:59.467Z,1349717459.467 [Reporter](INFO): platform_mass_position -0.003982 m 2012-10-08T17:30:59.871Z,1349717459.871 [Reporter](INFO): platform_mass_position -0.003686 m 2012-10-08T17:31:00.274Z,1349717460.274 [Reporter](INFO): platform_mass_position -0.003390 m 2012-10-08T17:31:00.672Z,1349717460.672 [Reporter](INFO): platform_mass_position -0.003091 m 2012-10-08T17:31:01.063Z,1349717461.063 [Reporter](INFO): platform_mass_position -0.002799 m 2012-10-08T17:31:01.472Z,1349717461.471 [Reporter](INFO): platform_mass_position -0.002497 m 2012-10-08T17:31:01.871Z,1349717461.871 [Reporter](INFO): platform_mass_position -0.002204 m 2012-10-08T17:31:02.269Z,1349717462.269 [Reporter](INFO): platform_mass_position -0.001906 m 2012-10-08T17:31:03.171Z,1349717463.171 [Reporter](INFO): platform_mass_position -0.001229 m 2012-10-08T17:31:03.415Z,1349717463.415 [Reporter](INFO): platform_mass_position -0.001059 m 2012-10-08T17:31:03.811Z,1349717463.811 [Reporter](INFO): platform_mass_position -0.000758 m 2012-10-08T17:31:04.215Z,1349717464.215 [Reporter](INFO): platform_mass_position -0.000453 m 2012-10-08T17:31:04.668Z,1349717464.668 [Reporter](INFO): platform_mass_position -0.000130 m 2012-10-08T17:31:05.015Z,1349717465.015 [Reporter](INFO): platform_mass_position -0.000049 m 2012-10-08T17:34:54.084Z,1349717694.084 [NAL9602](FAULT): GPS failed to acquire within timeout. 2012-10-08T17:34:54.084Z,1349717694.084 [NAL9602] Data Fault, FailCount= 1 2012-10-08T17:34:54.084Z,1349717694.084 [NAL9602](ERROR): Data Fault 2012-10-08T17:34:54.107Z,1349717694.107 [CBIT](ERROR): Data Fault in component: NAL9602 2012-10-08T17:34:54.478Z,1349717694.478 [NAL9602](INFO): Powering down 2012-10-08T17:34:54.502Z,1349717694.502 [CBIT](INFO): Clearing failed state for component NAL9602 2012-10-08T17:34:54.502Z,1349717694.502 [NAL9602] No Fault, FailCount= 1 2012-10-08T17:34:59.682Z,1349717699.682 [NAL9602](INFO): Powering up NAL9602 2012-10-08T17:35:10.507Z,1349717710.507 [NAL9602](INFO): NAL9602 initialized