2013-09-16T03:33:43.638Z,1379302423.638 [Supervisor](DEBUG): Initializing supervisor. 2013-09-16T03:33:43.641Z,1379302423.641 [SyncHandler](DEBUG): Created PCaller Thread at 4033B4E0 2013-09-16T03:33:43.642Z,1379302423.642 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2013-09-16T03:33:43.643Z,1379302423.643 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4036B4E0 2013-09-16T03:33:43.645Z,1379302423.645 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2013-09-16T03:33:43.656Z,1379302423.656 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2013-09-16T03:33:43.657Z,1379302423.657 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 4039B4E0 2013-09-16T03:33:43.658Z,1379302423.658 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2013-09-16T03:33:43.659Z,1379302423.659 [logger ThreadHandler](DEBUG): Created PCaller Thread at 403CB4E0 2013-09-16T03:33:43.660Z,1379302423.660 [Supervisor](INFO): Looking for Config files in directory: Config/ 2013-09-16T03:33:43.661Z,1379302423.661 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2013-09-16T03:33:43.939Z,1379302423.939 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2013-09-16T03:33:43.940Z,1379302423.940 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2013-09-16T03:33:44.131Z,1379302424.131 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2013-09-16T03:33:44.132Z,1379302424.132 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2013-09-16T03:33:44.217Z,1379302424.217 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2013-09-16T03:33:44.218Z,1379302424.218 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2013-09-16T03:33:44.329Z,1379302424.329 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2013-09-16T03:33:44.330Z,1379302424.330 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2013-09-16T03:33:44.473Z,1379302424.473 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2013-09-16T03:33:44.473Z,1379302424.473 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2013-09-16T03:33:44.710Z,1379302424.710 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2013-09-16T03:33:44.710Z,1379302424.710 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2013-09-16T03:33:44.877Z,1379302424.877 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2013-09-16T03:33:44.877Z,1379302424.877 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2013-09-16T03:33:45.139Z,1379302425.139 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2013-09-16T03:33:45.139Z,1379302425.139 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2013-09-16T03:33:45.241Z,1379302425.241 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2013-09-16T03:33:45.242Z,1379302425.242 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2013-09-16T03:33:45.653Z,1379302425.653 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2013-09-16T03:33:45.653Z,1379302425.653 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2013-09-16T03:33:45.796Z,1379302425.796 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2013-09-16T03:33:45.796Z,1379302425.796 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2013-09-16T03:33:45.883Z,1379302425.883 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/ 2013-09-16T03:33:45.884Z,1379302425.884 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg 2013-09-16T03:33:45.982Z,1379302425.982 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg 2013-09-16T03:33:46.109Z,1379302426.109 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg 2013-09-16T03:33:46.205Z,1379302426.205 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg 2013-09-16T03:33:46.310Z,1379302426.310 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg 2013-09-16T03:33:46.407Z,1379302426.407 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg 2013-09-16T03:33:46.414Z,1379302426.414 [Config/Science](ERROR): Could not parse value: 2013-09-16T03:33:46.522Z,1379302426.522 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg 2013-09-16T03:33:46.619Z,1379302426.619 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg 2013-09-16T03:33:46.705Z,1379302426.705 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2013-09-16T03:33:46.713Z,1379302426.713 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2013-09-16T03:33:46.874Z,1379302426.874 [InternalSim] Loaded 2013-09-16T03:33:46.874Z,1379302426.874 [ComponentRegistry](DEBUG): SyncComponent "InternalSim" handled in the control thread. 2013-09-16T03:33:46.875Z,1379302426.875 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2013-09-16T03:33:46.875Z,1379302426.875 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2013-09-16T03:33:46.961Z,1379302426.961 [SBIT](DEBUG): Construct Startup Built In Test. 2013-09-16T03:33:46.990Z,1379302426.990 [SBIT] Loaded 2013-09-16T03:33:46.990Z,1379302426.990 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2013-09-16T03:33:46.991Z,1379302426.991 [IBIT](DEBUG): Construct Initiated Built In Test. 2013-09-16T03:33:47.020Z,1379302427.020 [IBIT] Loaded 2013-09-16T03:33:47.020Z,1379302427.020 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2013-09-16T03:33:47.022Z,1379302427.022 [CBIT](DEBUG): Construct CBIT Built In Test. 2013-09-16T03:33:47.137Z,1379302427.137 [CBIT] Loaded 2013-09-16T03:33:47.137Z,1379302427.137 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2013-09-16T03:33:47.138Z,1379302427.138 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2013-09-16T03:33:47.138Z,1379302427.138 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2013-09-16T03:33:47.307Z,1379302427.307 [BuoyancyServo] Loaded 2013-09-16T03:33:47.307Z,1379302427.307 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2013-09-16T03:33:47.318Z,1379302427.318 [ElevatorServo] Loaded 2013-09-16T03:33:47.319Z,1379302427.319 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2013-09-16T03:33:47.330Z,1379302427.330 [MassServo] Loaded 2013-09-16T03:33:47.330Z,1379302427.330 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2013-09-16T03:33:47.342Z,1379302427.342 [RudderServo] Loaded 2013-09-16T03:33:47.342Z,1379302427.342 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2013-09-16T03:33:47.353Z,1379302427.353 [ThrusterServo] Loaded 2013-09-16T03:33:47.353Z,1379302427.353 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2013-09-16T03:33:47.354Z,1379302427.354 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2013-09-16T03:33:47.354Z,1379302427.354 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2013-09-16T03:33:47.389Z,1379302427.389 [DepthRateCalculator] Loaded 2013-09-16T03:33:47.389Z,1379302427.389 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2013-09-16T03:33:50.455Z,1379302430.455 [HFRadarModelCalc] Loaded 2013-09-16T03:33:50.455Z,1379302430.455 [ComponentRegistry](DEBUG): SyncComponent "HFRadarModelCalc" handled in the control thread. 2013-09-16T03:33:50.471Z,1379302430.471 [NavChart] Loaded 2013-09-16T03:33:50.471Z,1379302430.471 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2013-09-16T03:33:50.477Z,1379302430.477 [PitchRateCalculator] Loaded 2013-09-16T03:33:50.477Z,1379302430.477 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2013-09-16T03:33:50.488Z,1379302430.488 [SpeedCalculator] Loaded 2013-09-16T03:33:50.488Z,1379302430.488 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2013-09-16T03:33:50.504Z,1379302430.504 [TempGradientCalculator] Loaded 2013-09-16T03:33:50.504Z,1379302430.504 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2013-09-16T03:33:50.510Z,1379302430.510 [YawRateCalculator] Loaded 2013-09-16T03:33:50.510Z,1379302430.510 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2013-09-16T03:33:50.557Z,1379302430.557 [Navigation] Loaded 2013-09-16T03:33:50.557Z,1379302430.557 [ComponentRegistry](DEBUG): SyncComponent "Navigation" handled in the control thread. 2013-09-16T03:33:50.558Z,1379302430.558 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2013-09-16T03:33:50.558Z,1379302430.558 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2013-09-16T03:33:50.813Z,1379302430.813 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2013-09-16T03:33:50.814Z,1379302430.814 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2013-09-16T03:33:50.837Z,1379302430.837 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2013-09-16T03:33:50.837Z,1379302430.837 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2013-09-16T03:33:50.885Z,1379302430.885 [VerticalControl](DEBUG): Construct VerticalControl. 2013-09-16T03:33:50.978Z,1379302430.978 [VerticalControl] Loaded 2013-09-16T03:33:50.978Z,1379302430.978 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2013-09-16T03:33:50.979Z,1379302430.979 [HorizontalControl](DEBUG): Construct HorizontalControl. 2013-09-16T03:33:51.036Z,1379302431.036 [HorizontalControl] Loaded 2013-09-16T03:33:51.037Z,1379302431.037 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2013-09-16T03:33:51.037Z,1379302431.037 [SpeedControl](DEBUG): Construct SpeedControl. 2013-09-16T03:33:51.039Z,1379302431.039 [SpeedControl] Loaded 2013-09-16T03:33:51.039Z,1379302431.039 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2013-09-16T03:33:51.040Z,1379302431.040 [LoopControl](DEBUG): Construct LoopControl. 2013-09-16T03:33:51.040Z,1379302431.040 [LoopControl] Loaded 2013-09-16T03:33:51.041Z,1379302431.041 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2013-09-16T03:33:51.041Z,1379302431.041 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2013-09-16T03:33:51.042Z,1379302431.042 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2013-09-16T03:33:51.047Z,1379302431.047 [AsyncPiEstimator](DEBUG): Construct AsyncPiEstimator. 2013-09-16T03:33:51.052Z,1379302431.052 [AsyncPiEstimator] Loaded 2013-09-16T03:33:51.053Z,1379302431.053 [ComponentRegistry](DEBUG): Component "AsyncPiEstimator" handled in its own thread. 2013-09-16T03:33:51.054Z,1379302431.054 [AsyncPiEstimator ThreadHandler](DEBUG): Created PCaller Thread at 406474E0 2013-09-16T03:33:51.055Z,1379302431.055 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2013-09-16T03:33:51.055Z,1379302431.055 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2013-09-16T03:33:51.250Z,1379302431.250 [AHRS_sp3003D] Loaded 2013-09-16T03:33:51.251Z,1379302431.251 [ComponentRegistry](DEBUG): SyncComponent "AHRS_sp3003D" handled in the control thread. 2013-09-16T03:33:51.264Z,1379302431.264 [Depth_Keller] Loaded 2013-09-16T03:33:51.265Z,1379302431.265 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2013-09-16T03:33:51.447Z,1379302431.447 [DVL_micro] Loaded 2013-09-16T03:33:51.447Z,1379302431.447 [ComponentRegistry](DEBUG): Component "DVL_micro" handled in its own thread. 2013-09-16T03:33:51.448Z,1379302431.448 [DVL_micro ThreadHandler](DEBUG): Created PCaller Thread at 406CE4E0 2013-09-16T03:33:51.536Z,1379302431.536 [NAL9602] Loaded 2013-09-16T03:33:51.537Z,1379302431.537 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2013-09-16T03:33:51.579Z,1379302431.579 [Onboard] Loaded 2013-09-16T03:33:51.580Z,1379302431.580 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2013-09-16T03:33:51.586Z,1379302431.586 [Radio_Freewave] Loaded 2013-09-16T03:33:51.587Z,1379302431.587 [ComponentRegistry](DEBUG): SyncComponent "Radio_Freewave" handled in the control thread. 2013-09-16T03:33:51.727Z,1379302431.727 [DAT] Loaded 2013-09-16T03:33:51.727Z,1379302431.727 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread. 2013-09-16T03:33:51.728Z,1379302431.728 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2013-09-16T03:33:51.728Z,1379302431.728 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2013-09-16T03:33:51.826Z,1379302431.826 [CTD_NeilBrown] Loaded 2013-09-16T03:33:51.827Z,1379302431.827 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread. 2013-09-16T03:33:51.828Z,1379302431.828 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 4072B4E0 2013-09-16T03:33:51.843Z,1379302431.843 [PAR_Licor] Loaded 2013-09-16T03:33:51.843Z,1379302431.843 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2013-09-16T03:33:51.875Z,1379302431.875 [WetLabsBB2FL] Loaded 2013-09-16T03:33:51.875Z,1379302431.875 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2013-09-16T03:33:51.876Z,1379302431.876 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 4075B4E0 2013-09-16T03:33:51.877Z,1379302431.877 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2013-09-16T03:33:51.879Z,1379302431.879 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2013-09-16T03:33:51.880Z,1379302431.880 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2013-09-16T03:33:51.887Z,1379302431.887 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2013-09-16T03:33:51.888Z,1379302431.888 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 4078B4E0 2013-09-16T03:33:51.892Z,1379302431.892 [Supervisor](DEBUG): Running supervisor. 2013-09-16T03:33:51.893Z,1379302431.893 [CommandLine](INFO): Thread ID is 866 2013-09-16T03:33:51.895Z,1379302431.895 [controlThread](INFO): Thread ID is 865 2013-09-16T03:33:51.896Z,1379302431.896 [controlThread](DEBUG): Initializing ControlThread 2013-09-16T03:33:51.896Z,1379302431.896 [CycleStarter](INFO): Thread ID is 864 2013-09-16T03:33:51.896Z,1379302431.896 [InternalSim](DEBUG): InternalSim initializing... 2013-09-16T03:33:51.932Z,1379302431.932 [logger](INFO): Thread ID is 867 2013-09-16T03:33:51.933Z,1379302431.933 [SBIT](INFO): Initialize SBIT Component. 2013-09-16T03:33:51.933Z,1379302431.933 [SBIT](IMPORTANT): Tethys CM Info: $Rev:10634 2013-09-16T03:33:51.934Z,1379302431.934 [SBIT](IMPORTANT): Kernel Release:2.6.27.8 2013-09-16T03:33:51.934Z,1379302431.934 [SBIT](IMPORTANT): Kernel Version:#634 PREEMPT Wed Feb 13 10:21:48 PST 2013 2013-09-16T03:33:51.935Z,1379302431.935 [IBIT](INFO): Initialize IBIT Component. 2013-09-16T03:33:51.935Z,1379302431.935 [CBIT](DEBUG): Initialize CBIT Component. 2013-09-16T03:33:51.936Z,1379302431.936 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2013-09-16T03:33:51.962Z,1379302431.962 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2013-09-16T03:33:51.962Z,1379302431.962 [NavChart](DEBUG): Initialize NavChart Derivation. 2013-09-16T03:33:51.963Z,1379302431.963 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2013-09-16T03:33:51.963Z,1379302431.963 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2013-09-16T03:33:51.963Z,1379302431.963 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2013-09-16T03:33:51.964Z,1379302431.964 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2013-09-16T03:33:51.964Z,1379302431.964 [Navigation](DEBUG): Initializing Navigation. 2013-09-16T03:33:51.965Z,1379302431.965 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2013-09-16T03:33:51.967Z,1379302431.967 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2013-09-16T03:33:51.967Z,1379302431.967 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2013-09-16T03:33:51.968Z,1379302431.968 [LoopControl](DEBUG): Initialize LoopControlComponent. 2013-09-16T03:33:51.970Z,1379302431.970 [AsyncPiEstimator](INFO): Thread ID is 928 2013-09-16T03:33:51.970Z,1379302431.970 [AsyncPiEstimator](DEBUG): Initialize AsyncPiEstimator. 2013-09-16T03:33:51.981Z,1379302431.981 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2013-09-16T03:33:51.989Z,1379302431.989 [DVL_micro](INFO): Thread ID is 929 2013-09-16T03:33:51.998Z,1379302431.998 [DVL_micro](INFO): Initializing 2013-09-16T03:33:51.999Z,1379302431.999 [DVL_micro](INFO): start:Powering up 2013-09-16T03:33:51.000Z,1379302432.000 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-16T03:33:52.000Z,1379302432.000 [DVL_micro](INFO): Cycling power to configure device. 2013-09-16T03:33:52.015Z,1379302432.015 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2013-09-16T03:33:52.018Z,1379302432.018 [CTD_NeilBrown](INFO): Thread ID is 930 2013-09-16T03:33:52.018Z,1379302432.018 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown. 2013-09-16T03:33:52.050Z,1379302432.050 [WetLabsBB2FL](INFO): Thread ID is 931 2013-09-16T03:33:52.050Z,1379302432.050 [WetLabsBB2FL](INFO): Powering down 2013-09-16T03:33:52.054Z,1379302432.054 [MissionManager](DEBUG): 2013-09-16T03:33:52.061Z,1379302432.061 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2013-09-16T03:33:52.070Z,1379302432.070 [NavChartDb](INFO): Thread ID is 932 2013-09-16T03:33:52.072Z,1379302432.072 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources 2013-09-16T03:33:52.073Z,1379302432.073 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2013-09-16T03:33:52.074Z,1379302432.074 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2013-09-16T03:33:52.074Z,1379302432.074 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2013-09-16T03:33:52.074Z,1379302432.074 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2013-09-16T03:33:52.075Z,1379302432.075 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2013-09-16T03:33:52.075Z,1379302432.075 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2013-09-16T03:33:52.075Z,1379302432.075 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2013-09-16T03:33:52.075Z,1379302432.075 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2013-09-16T03:33:52.186Z,1379302432.186 [MissionManager](INFO): DefineArg Default.NeedGPS = 1 bool 2013-09-16T03:33:52.188Z,1379302432.188 [Default:GPS:A.SetSpeed](DEBUG): Construct. 2013-09-16T03:33:52.196Z,1379302432.196 [Default:GPS:B.GoToSurface](DEBUG): Construct GoToSurface. 2013-09-16T03:33:52.216Z,1379302432.216 [Default:Iridium:A.SetSpeed](DEBUG): Construct. 2013-09-16T03:33:52.219Z,1379302432.219 [Default:Iridium:B.GoToSurface](DEBUG): Construct GoToSurface. 2013-09-16T03:33:52.262Z,1379302432.262 [Default:Iridium:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2013-09-16T03:33:52.287Z,1379302432.287 [Default:D.SetSpeed](DEBUG): Construct. 2013-09-16T03:33:52.290Z,1379302432.290 [Default:E.GoToSurface](DEBUG): Construct GoToSurface. 2013-09-16T03:33:52.310Z,1379302432.310 [Default:F.Wait](DEBUG): Construct Wait. 2013-09-16T03:33:52.313Z,1379302432.313 [MissionManager](DEBUG): 400 400 Burn 300 Dropped drop weight due to communications timeout 5.0 1.0 5 2013-09-16T03:33:52.329Z,1379302432.329 [controlThread](DEBUG): Component order: CycleStarter,InternalSim,AHRS_sp3003D,Depth_Keller,NAL9602,Onboard,Radio_Freewave,DAT,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,HFRadarModelCalc,NavChart,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,Navigation,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter, 2013-09-16T03:33:52.395Z,1379302432.395 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D. 2013-09-16T03:33:52.430Z,1379302432.430 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu 2013-09-16T03:33:52.509Z,1379302432.509 [Radio_Freewave](INFO): Powering up 2013-09-16T03:33:52.551Z,1379302432.551 [DAT](INFO): Powering up 2013-09-16T03:33:52.551Z,1379302432.551 [DAT](DEBUG): Initializing DAT. 2013-09-16T03:33:52.850Z,1379302432.850 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:33:52.858Z,1379302432.858 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2013-09-16T03:33:52.880Z,1379302432.880 [ElevatorServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:33:52.886Z,1379302432.886 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2013-09-16T03:33:52.892Z,1379302432.892 [MassServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:33:52.894Z,1379302432.894 [MassServo](DEBUG): Initializing MassServo. 2013-09-16T03:33:52.900Z,1379302432.900 [RudderServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:33:52.906Z,1379302432.906 [RudderServo](DEBUG): Initializing RudderServo. 2013-09-16T03:33:52.912Z,1379302432.912 [ThrusterServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:33:52.918Z,1379302432.918 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2013-09-16T03:33:53.944Z,1379302433.944 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2013-09-16T03:33:53.944Z,1379302433.944 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2013-09-16T03:33:53.944Z,1379302433.944 [BuoyancyServo] Communications Fault, FailCount= 1 2013-09-16T03:33:53.944Z,1379302433.944 [BuoyancyServo](ERROR): Communications Fault 2013-09-16T03:33:54.127Z,1379302434.127 [DVL_micro](INFO): Opening uart, block timeout 10ths=20 2013-09-16T03:33:54.129Z,1379302434.129 [DVL_micro](INFO): Querying output modes 2013-09-16T03:33:54.130Z,1379302434.130 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606 2013-09-16T03:33:54.148Z,1379302434.148 [DVL_micro](DEBUG): cmdResponse: 01 16 2013-09-16T03:33:54.148Z,1379302434.148 [DVL_micro](INFO): NQ1 output enabled 2013-09-16T03:33:54.148Z,1379302434.148 [DVL_micro](INFO): RSSI output enabled 2013-09-16T03:33:54.149Z,1379302434.149 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525 2013-09-16T03:33:54.154Z,1379302434.154 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2013-09-16T03:33:54.164Z,1379302434.164 [DVL_micro](DEBUG): cmdResponse: AUTO_VEL_ON 2013-09-16T03:33:54.169Z,1379302434.169 [DVL_micro](INFO): pause:Powering down 2013-09-16T03:33:54.425Z,1379302434.425 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2013-09-16T03:33:54.425Z,1379302434.425 [BuoyancyServo](INFO): Powering down 2013-09-16T03:33:56.546Z,1379302436.546 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2013-09-16T03:33:56.546Z,1379302436.546 [BuoyancyServo] No Fault, FailCount= 1 2013-09-16T03:33:56.743Z,1379302436.743 [NAL9602](INFO): Powering up NAL9602 2013-09-16T03:33:56.826Z,1379302436.826 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:33:56.949Z,1379302436.949 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2013-09-16T03:33:57.562Z,1379302437.562 [MassServo](FAULT): Overload Error 2013-09-16T03:33:57.562Z,1379302437.562 [MassServo] Hardware Fault, FailCount= 1 2013-09-16T03:33:57.562Z,1379302437.562 [MassServo](ERROR): Hardware Fault 2013-09-16T03:33:57.692Z,1379302437.692 [CBIT](ERROR): Hardware Fault in component: MassServo 2013-09-16T03:33:57.928Z,1379302437.928 [MassServo](DEBUG): Uninitialize Mass Servo. 2013-09-16T03:33:57.928Z,1379302437.928 [MassServo](INFO): Powering down 2013-09-16T03:33:58.855Z,1379302438.855 [CBIT](INFO): Clearing failed state for component MassServo 2013-09-16T03:33:58.855Z,1379302438.855 [MassServo] No Fault, FailCount= 1 2013-09-16T03:33:59.153Z,1379302439.153 [MassServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:33:59.160Z,1379302439.160 [MassServo](DEBUG): Initializing MassServo. 2013-09-16T03:34:03.226Z,1379302443.226 [MassServo](FAULT): Overload Error 2013-09-16T03:34:03.226Z,1379302443.226 [MassServo] Hardware Fault, FailCount= 2 2013-09-16T03:34:03.226Z,1379302443.226 [MassServo](ERROR): Hardware Fault 2013-09-16T03:34:03.230Z,1379302443.230 [CBIT](ERROR): Hardware Fault in component: MassServo 2013-09-16T03:34:03.544Z,1379302443.544 [MassServo](DEBUG): Uninitialize Mass Servo. 2013-09-16T03:34:03.544Z,1379302443.544 [MassServo](INFO): Powering down 2013-09-16T03:34:04.404Z,1379302444.404 [BuoyancyServo](ERROR): getPosition uart error serial timeout 2013-09-16T03:34:04.404Z,1379302444.404 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout 2013-09-16T03:34:04.404Z,1379302444.404 [BuoyancyServo] Communications Fault, FailCount= 2 2013-09-16T03:34:04.404Z,1379302444.404 [BuoyancyServo](ERROR): Communications Fault 2013-09-16T03:34:04.408Z,1379302444.408 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2013-09-16T03:34:04.634Z,1379302444.634 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2013-09-16T03:34:04.634Z,1379302444.634 [BuoyancyServo](INFO): Powering down 2013-09-16T03:34:04.780Z,1379302444.780 [CBIT](INFO): Clearing failed state for component MassServo 2013-09-16T03:34:04.780Z,1379302444.780 [MassServo] No Fault, FailCount= 2 2013-09-16T03:34:05.024Z,1379302445.024 [MassServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:34:05.029Z,1379302445.029 [MassServo](DEBUG): Initializing MassServo. 2013-09-16T03:34:06.229Z,1379302446.229 [BuoyancyServo](FAULT): LCB fault: Current Limiter Activated. 2013-09-16T03:34:06.229Z,1379302446.229 [BuoyancyServo] Hardware Fault, FailCount= 2 2013-09-16T03:34:06.229Z,1379302446.229 [BuoyancyServo](ERROR): Hardware Fault 2013-09-16T03:34:06.628Z,1379302446.628 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2013-09-16T03:34:06.629Z,1379302446.629 [BuoyancyServo] No Fault, FailCount= 2 2013-09-16T03:34:07.060Z,1379302447.060 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:34:07.185Z,1379302447.185 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2013-09-16T03:34:07.426Z,1379302447.426 [NAL9602](INFO): NAL9602 initialized 2013-09-16T03:34:07.543Z,1379302447.543 [SBIT](IMPORTANT): Beginning Startup BIT 2013-09-16T03:34:07.545Z,1379302447.545 [CBIT](IMPORTANT): Beginning GF scan 2013-09-16T03:34:09.120Z,1379302449.120 [MassServo](FAULT): Overload Error 2013-09-16T03:34:09.120Z,1379302449.120 [MassServo] Hardware Fault, FailCount= 3 2013-09-16T03:34:09.120Z,1379302449.120 [MassServo](ERROR): Hardware Fault 2013-09-16T03:34:09.187Z,1379302449.187 [CBIT](ERROR): Hardware Fault in component: MassServo 2013-09-16T03:34:09.537Z,1379302449.537 [MassServo](DEBUG): Uninitialize Mass Servo. 2013-09-16T03:34:09.537Z,1379302449.537 [MassServo](INFO): Powering down 2013-09-16T03:34:10.374Z,1379302450.374 [MassServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:34:10.494Z,1379302450.494 [MassServo](DEBUG): Initializing MassServo. 2013-09-16T03:34:10.525Z,1379302450.525 [CBIT](INFO): Clearing failed state for component MassServo 2013-09-16T03:34:10.525Z,1379302450.525 [MassServo] No Fault, FailCount= 3 2013-09-16T03:34:13.003Z,1379302453.003 [DAT](INFO): Powering down 2013-09-16T03:34:14.536Z,1379302454.536 [BuoyancyServo](ERROR): getPosition uart error serial timeout 2013-09-16T03:34:14.536Z,1379302454.536 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout 2013-09-16T03:34:14.536Z,1379302454.536 [BuoyancyServo] Communications Fault, FailCount= 3 2013-09-16T03:34:14.536Z,1379302454.536 [BuoyancyServo](ERROR): Communications Fault 2013-09-16T03:34:14.628Z,1379302454.628 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2013-09-16T03:34:14.880Z,1379302454.880 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2013-09-16T03:34:14.881Z,1379302454.881 [BuoyancyServo](INFO): Powering down 2013-09-16T03:34:14.985Z,1379302454.985 [MassServo](FAULT): Overload Error 2013-09-16T03:34:14.985Z,1379302454.985 [MassServo] Hardware Fault, FailCount= 4 2013-09-16T03:34:14.985Z,1379302454.985 [MassServo](ERROR): Hardware Fault 2013-09-16T03:34:14.989Z,1379302454.989 [CBIT](ERROR): Hardware Fault in component: MassServo 2013-09-16T03:34:15.350Z,1379302455.350 [MassServo](DEBUG): Uninitialize Mass Servo. 2013-09-16T03:34:15.350Z,1379302455.350 [MassServo](INFO): Powering down 2013-09-16T03:34:16.179Z,1379302456.179 [MassServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:34:16.299Z,1379302456.299 [MassServo](DEBUG): Initializing MassServo. 2013-09-16T03:34:16.303Z,1379302456.303 [CBIT](INFO): Clearing failed state for component MassServo 2013-09-16T03:34:16.304Z,1379302456.304 [MassServo] No Fault, FailCount= 4 2013-09-16T03:34:16.566Z,1379302456.566 [BuoyancyServo](FAULT): LCB fault: Current Limiter Activated. 2013-09-16T03:34:16.566Z,1379302456.566 [BuoyancyServo] Hardware Fault, FailCount= 3 2013-09-16T03:34:16.566Z,1379302456.566 [BuoyancyServo](ERROR): Hardware Fault 2013-09-16T03:34:17.006Z,1379302457.006 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2013-09-16T03:34:17.006Z,1379302457.006 [BuoyancyServo] No Fault, FailCount= 3 2013-09-16T03:34:17.376Z,1379302457.376 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:34:17.493Z,1379302457.493 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2013-09-16T03:34:20.313Z,1379302460.313 [MassServo](FAULT): Overload Error 2013-09-16T03:34:20.313Z,1379302460.313 [MassServo] Hardware Fault, FailCount= 5 2013-09-16T03:34:20.313Z,1379302460.313 [MassServo](ERROR): Hardware Fault 2013-09-16T03:34:20.317Z,1379302460.317 [CBIT](ERROR): Hardware Fault in component: MassServo 2013-09-16T03:34:20.318Z,1379302460.318 [CBIT](CRITICAL): Hardware Fault in component: MassServo 2013-09-16T03:34:20.754Z,1379302460.754 [MassServo](DEBUG): Uninitialize Mass Servo. 2013-09-16T03:34:20.754Z,1379302460.754 [MassServo](INFO): Powering down 2013-09-16T03:34:20.758Z,1379302460.758 [CommandLine](FAULT): Scheduling is paused 2013-09-16T03:34:21.515Z,1379302461.515 [MassServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:34:21.644Z,1379302461.644 [MassServo](DEBUG): Initializing MassServo. 2013-09-16T03:34:24.787Z,1379302464.787 [BuoyancyServo](ERROR): getPosition uart error serial timeout 2013-09-16T03:34:24.788Z,1379302464.788 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout 2013-09-16T03:34:24.788Z,1379302464.788 [BuoyancyServo] Communications Fault, FailCount= 4 2013-09-16T03:34:24.788Z,1379302464.788 [BuoyancyServo](ERROR): Communications Fault 2013-09-16T03:34:24.844Z,1379302464.844 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2013-09-16T03:34:25.162Z,1379302465.162 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2013-09-16T03:34:25.162Z,1379302465.162 [BuoyancyServo](INFO): Powering down 2013-09-16T03:34:26.710Z,1379302466.710 [BuoyancyServo](FAULT): LCB fault: Current Limiter Activated. 2013-09-16T03:34:26.710Z,1379302466.710 [BuoyancyServo] Hardware Fault, FailCount= 4 2013-09-16T03:34:26.710Z,1379302466.710 [BuoyancyServo](ERROR): Hardware Fault 2013-09-16T03:34:27.254Z,1379302467.254 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2013-09-16T03:34:27.254Z,1379302467.254 [BuoyancyServo] No Fault, FailCount= 4 2013-09-16T03:34:27.573Z,1379302467.573 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:34:27.693Z,1379302467.693 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2013-09-16T03:34:34.055Z,1379302474.055 [CBIT](IMPORTANT): No ground fault detected 2013-09-16T03:34:34.907Z,1379302474.907 [BuoyancyServo](ERROR): getPosition uart error serial timeout 2013-09-16T03:34:34.907Z,1379302474.907 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout 2013-09-16T03:34:34.907Z,1379302474.907 [BuoyancyServo] Communications Fault, FailCount= 5 2013-09-16T03:34:34.908Z,1379302474.908 [BuoyancyServo](ERROR): Communications Fault 2013-09-16T03:34:34.912Z,1379302474.912 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2013-09-16T03:34:34.912Z,1379302474.912 [CBIT](CRITICAL): Communications Fault in component: BuoyancyServo 2013-09-16T03:34:35.123Z,1379302475.123 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2013-09-16T03:34:35.124Z,1379302475.124 [BuoyancyServo](INFO): Powering down 2013-09-16T03:34:36.719Z,1379302476.719 [BuoyancyServo](FAULT): LCB fault: Current Limiter Activated. 2013-09-16T03:34:36.719Z,1379302476.719 [BuoyancyServo] Hardware Fault, FailCount= 5 2013-09-16T03:34:36.719Z,1379302476.719 [BuoyancyServo](ERROR): Hardware Fault 2013-09-16T03:34:41.586Z,1379302481.586 [CommandLine](IMPORTANT): got command failComponent 2013-09-16T03:34:41.586Z,1379302481.586 [CommandLine](IMPORTANT): Failed components: 2013-09-16T03:34:41.586Z,1379302481.586 [CommandLine](IMPORTANT): BuoyancyServo: Hardware Fault 2013-09-16T03:34:41.586Z,1379302481.586 [CommandLine](IMPORTANT): MassServo: Hardware Fault 2013-09-16T03:35:01.613Z,1379302501.613 [SBIT](IMPORTANT): SBIT PASSED 2013-09-16T03:35:01.997Z,1379302501.997 [MissionManager](IMPORTANT): Started mission Startup 2013-09-16T03:35:01.997Z,1379302501.997 [Startup] Running Loop=1 2013-09-16T03:35:01.998Z,1379302501.998 [Startup](INFO): Aggregate::initialize Startup 2013-09-16T03:35:01.998Z,1379302501.998 [Startup:A.GoToSurface] Running Loop=1 2013-09-16T03:35:01.998Z,1379302501.998 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2013-09-16T03:35:02.004Z,1379302502.004 [Startup:StartupSatComms] Running Loop=1 2013-09-16T03:35:02.004Z,1379302502.004 [Startup:StartupSatComms](INFO): Aggregate::initialize Startup:StartupSatComms 2013-09-16T03:35:02.004Z,1379302502.004 [Startup:StartupSatComms:A] Running Loop=1 2013-09-16T03:35:02.398Z,1379302502.398 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2013-09-16T03:35:04.387Z,1379302504.387 [NAL9602](IMPORTANT): GPS fix at: 1379302502.00 2013-09-16T03:35:04.403Z,1379302504.403 [Startup:StartupSatComms:A] Stopped 2013-09-16T03:35:04.403Z,1379302504.403 [Startup:StartupSatComms:B] Running Loop=1 2013-09-16T03:35:04.821Z,1379302504.821 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2013-09-16T03:35:23.491Z,1379302523.491 [CommandLine](IMPORTANT): got command failComponent none MassServo 2013-09-16T03:35:23.491Z,1379302523.491 [MassServo] No Fault, FailCount= 5 2013-09-16T03:35:23.491Z,1379302523.491 [CommandLine](IMPORTANT): MassServo failureMode is No Fault 2013-09-16T03:35:27.225Z,1379302527.225 [MassServo](FAULT): Overload Error 2013-09-16T03:35:27.225Z,1379302527.225 [MassServo] Hardware Fault, FailCount= 6 2013-09-16T03:35:27.225Z,1379302527.225 [MassServo](ERROR): Hardware Fault 2013-09-16T03:35:27.228Z,1379302527.228 [CBIT](ERROR): Hardware Fault in component: MassServo 2013-09-16T03:35:27.229Z,1379302527.229 [CBIT](CRITICAL): Hardware Fault in component: MassServo 2013-09-16T03:35:27.594Z,1379302527.594 [MassServo](DEBUG): Uninitialize Mass Servo. 2013-09-16T03:35:27.594Z,1379302527.594 [MassServo](INFO): Powering down 2013-09-16T03:35:34.062Z,1379302534.062 [CommandLine](IMPORTANT): got command failComponent none BuoyancyServo 2013-09-16T03:35:34.062Z,1379302534.062 [BuoyancyServo] No Fault, FailCount= 5 2013-09-16T03:35:34.063Z,1379302534.063 [CommandLine](IMPORTANT): BuoyancyServo failureMode is No Fault 2013-09-16T03:35:34.273Z,1379302534.273 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:35:34.392Z,1379302534.392 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2013-09-16T03:35:41.494Z,1379302541.494 [BuoyancyServo](ERROR): getPosition uart error serial timeout 2013-09-16T03:35:41.495Z,1379302541.495 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout 2013-09-16T03:35:41.495Z,1379302541.495 [BuoyancyServo] Communications Fault, FailCount= 6 2013-09-16T03:35:41.495Z,1379302541.495 [BuoyancyServo](ERROR): Communications Fault 2013-09-16T03:35:41.500Z,1379302541.500 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2013-09-16T03:35:41.501Z,1379302541.501 [CBIT](CRITICAL): Communications Fault in component: BuoyancyServo 2013-09-16T03:35:41.713Z,1379302541.713 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2013-09-16T03:35:41.714Z,1379302541.714 [BuoyancyServo](INFO): Powering down 2013-09-16T03:35:43.314Z,1379302543.314 [BuoyancyServo](FAULT): LCB fault: Current Limiter Activated. 2013-09-16T03:35:43.314Z,1379302543.314 [BuoyancyServo] Hardware Fault, FailCount= 6 2013-09-16T03:35:43.314Z,1379302543.314 [BuoyancyServo](ERROR): Hardware Fault 2013-09-16T03:35:49.464Z,1379302549.464 [NAL9602](INFO): SBD MO Status=2, MOMSN=14840, MT Status=2, MTMSN=0 2013-09-16T03:35:49.464Z,1379302549.464 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2013-09-16T03:35:58.816Z,1379302558.816 [NAL9602](INFO): SBD MO Status=2, MOMSN=14840, MT Status=2, MTMSN=0 2013-09-16T03:35:58.816Z,1379302558.816 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2013-09-16T03:36:06.373Z,1379302566.373 [Startup:StartupSatComms:B](INFO): Timed out from 2013-09-16T03:35:04.4Z 2013-09-16T03:36:06.374Z,1379302566.374 [Startup:StartupSatComms:B:A_Timeout] Running Loop=1 2013-09-16T03:36:06.374Z,1379302566.374 [Startup:StartupSatComms:B:A_Timeout](INFO): Aggregate::initialize Startup:StartupSatComms:B:A_Timeout 2013-09-16T03:36:06.374Z,1379302566.374 [Startup:StartupSatComms:B:A_Timeout](INFO): Completed Startup:StartupSatComms:B:A_Timeout 2013-09-16T03:36:06.374Z,1379302566.374 [Startup:StartupSatComms:B] Stopped 2013-09-16T03:36:06.374Z,1379302566.374 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2013-09-16T03:36:06.374Z,1379302566.374 [Startup:StartupSatComms] Stopped 2013-09-16T03:36:06.374Z,1379302566.374 [Startup:StartupSatComms](INFO): Aggregate::uninitialize Startup:StartupSatComms 2013-09-16T03:36:06.375Z,1379302566.375 [Startup](INFO): Completed Startup 2013-09-16T03:36:06.375Z,1379302566.375 [Startup] Stopped 2013-09-16T03:36:06.375Z,1379302566.375 [Startup](INFO): Aggregate::uninitialize Startup 2013-09-16T03:36:06.375Z,1379302566.375 [Startup:A.GoToSurface] Stopped 2013-09-16T03:36:06.375Z,1379302566.375 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2013-09-16T03:36:06.624Z,1379302566.624 [MissionManager](IMPORTANT): Started mission Default 2013-09-16T03:36:06.624Z,1379302566.624 [Default] Running Loop=1 2013-09-16T03:36:06.624Z,1379302566.624 [Default](INFO): Aggregate::initialize Default 2013-09-16T03:36:06.624Z,1379302566.624 [Default:D.SetSpeed] Running Loop=1 2013-09-16T03:36:06.625Z,1379302566.625 [Default:D.SetSpeed](DEBUG): Initialize. 2013-09-16T03:36:06.625Z,1379302566.625 [Default:E.GoToSurface] Running Loop=1 2013-09-16T03:36:06.625Z,1379302566.625 [Default:E.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2013-09-16T03:36:06.625Z,1379302566.625 [Default:Iridium] Running Loop=1 2013-09-16T03:36:06.625Z,1379302566.625 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium 2013-09-16T03:36:06.625Z,1379302566.625 [Default:Iridium:A.SetSpeed] Running Loop=1 2013-09-16T03:36:06.625Z,1379302566.625 [Default:Iridium:A.SetSpeed](DEBUG): Initialize. 2013-09-16T03:36:06.626Z,1379302566.626 [Default:Iridium:B.GoToSurface] Running Loop=1 2013-09-16T03:36:06.626Z,1379302566.626 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2013-09-16T03:36:06.626Z,1379302566.626 [Default:E.GoToSurface] Running Loop=1 2013-09-16T03:36:06.632Z,1379302566.632 [Default:D.SetSpeed] Running Loop=1 2013-09-16T03:36:06.637Z,1379302566.637 [Default:CallIridium] Running Loop=1 2013-09-16T03:36:06.640Z,1379302566.640 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium 2013-09-16T03:36:06.640Z,1379302566.640 [Default:CallIridium:A] Running Loop=1 2013-09-16T03:36:06.643Z,1379302566.643 [Default:CallIridium:A] Stopped 2013-09-16T03:36:06.643Z,1379302566.643 [Default:CallIridium:B] Running Loop=1 2013-09-16T03:36:06.643Z,1379302566.643 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B 2013-09-16T03:36:06.648Z,1379302566.648 [Default:Iridium:B.GoToSurface] Stopped 2013-09-16T03:36:06.649Z,1379302566.649 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2013-09-16T03:36:06.649Z,1379302566.649 [Default:Iridium:Read_Iridium] Running Loop=1 2013-09-16T03:36:06.649Z,1379302566.649 [Default:Iridium:A.SetSpeed] Running Loop=1 2013-09-16T03:36:06.670Z,1379302566.670 [Default:GPS] Running Loop=1 2013-09-16T03:36:06.670Z,1379302566.670 [Default:GPS](INFO): Aggregate::initialize Default:GPS 2013-09-16T03:36:06.670Z,1379302566.670 [Default:GPS:A.SetSpeed] Running Loop=1 2013-09-16T03:36:06.670Z,1379302566.670 [Default:GPS:A.SetSpeed](DEBUG): Initialize. 2013-09-16T03:36:06.671Z,1379302566.671 [Default:GPS:B.GoToSurface] Running Loop=1 2013-09-16T03:36:06.671Z,1379302566.671 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2013-09-16T03:36:06.688Z,1379302566.688 [Default:GPS:B.GoToSurface] Stopped 2013-09-16T03:36:06.688Z,1379302566.688 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2013-09-16T03:36:06.688Z,1379302566.688 [Default:GPS:Read_GPS] Running Loop=1 2013-09-16T03:36:06.688Z,1379302566.688 [Default:GPS:A.SetSpeed] Running Loop=1 2013-09-16T03:36:06.000Z,1379302567.000 [Default:Iridium:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2013-09-16T03:36:07.003Z,1379302567.003 [Default:GPS:Read_GPS](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2013-09-16T03:36:12.172Z,1379302572.172 [NAL9602](INFO): SBD MO Status=2, MOMSN=14840, MT Status=2, MTMSN=0 2013-09-16T03:36:12.172Z,1379302572.172 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2013-09-16T03:36:13.374Z,1379302573.374 [NAL9602](IMPORTANT): GPS fix at: 1379302571.00 2013-09-16T03:36:13.391Z,1379302573.391 [Default:GPS:Read_GPS] Stopped 2013-09-16T03:36:13.391Z,1379302573.391 [Default:GPS:D] Running Loop=1 2013-09-16T03:36:13.799Z,1379302573.799 [Default:GPS:D] Stopped 2013-09-16T03:36:13.799Z,1379302573.799 [Default:GPS](INFO): Completed Default:GPS 2013-09-16T03:36:13.800Z,1379302573.800 [Default:GPS] Stopped 2013-09-16T03:36:13.800Z,1379302573.800 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS 2013-09-16T03:36:13.800Z,1379302573.800 [Default:GPS:A.SetSpeed] Stopped 2013-09-16T03:36:13.800Z,1379302573.800 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize. 2013-09-16T03:37:22.141Z,1379302642.141 [NAL9602](INFO): SBD MO Status=2, MOMSN=14840, MT Status=2, MTMSN=0 2013-09-16T03:37:22.141Z,1379302642.141 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2013-09-16T03:37:41.538Z,1379302661.538 [CBIT](INFO): Clearing failed count for component BuoyancyServo 2013-09-16T03:37:41.538Z,1379302661.538 [BuoyancyServo] No Fault, FailCount= 6 2013-09-16T03:37:41.941Z,1379302661.941 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:37:42.059Z,1379302662.059 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2013-09-16T03:37:49.682Z,1379302669.682 [BuoyancyServo](ERROR): getPosition uart error serial timeout 2013-09-16T03:37:49.682Z,1379302669.682 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout 2013-09-16T03:37:49.682Z,1379302669.682 [BuoyancyServo] Communications Fault, FailCount= 1 2013-09-16T03:37:49.682Z,1379302669.682 [BuoyancyServo](ERROR): Communications Fault 2013-09-16T03:37:49.686Z,1379302669.686 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2013-09-16T03:37:49.896Z,1379302669.896 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2013-09-16T03:37:49.897Z,1379302669.897 [BuoyancyServo](INFO): Powering down 2013-09-16T03:37:51.501Z,1379302671.501 [BuoyancyServo](FAULT): LCB fault: Current Limiter Activated. 2013-09-16T03:37:51.501Z,1379302671.501 [BuoyancyServo] Hardware Fault, FailCount= 1 2013-09-16T03:37:51.501Z,1379302671.501 [BuoyancyServo](ERROR): Hardware Fault 2013-09-16T03:37:51.903Z,1379302671.903 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2013-09-16T03:37:51.903Z,1379302671.903 [BuoyancyServo] No Fault, FailCount= 1 2013-09-16T03:37:52.337Z,1379302672.337 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:37:52.456Z,1379302672.456 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2013-09-16T03:38:01.455Z,1379302681.455 [BuoyancyServo](ERROR): getPosition uart error serial timeout 2013-09-16T03:38:01.456Z,1379302681.456 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout 2013-09-16T03:38:01.456Z,1379302681.456 [BuoyancyServo] Communications Fault, FailCount= 2 2013-09-16T03:38:01.456Z,1379302681.456 [BuoyancyServo](ERROR): Communications Fault 2013-09-16T03:38:01.459Z,1379302681.459 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2013-09-16T03:38:01.682Z,1379302681.682 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2013-09-16T03:38:01.683Z,1379302681.683 [BuoyancyServo](INFO): Powering down 2013-09-16T03:38:03.293Z,1379302683.293 [BuoyancyServo](FAULT): LCB fault: Current Limiter Activated. 2013-09-16T03:38:03.293Z,1379302683.293 [BuoyancyServo] Hardware Fault, FailCount= 2 2013-09-16T03:38:03.293Z,1379302683.293 [BuoyancyServo](ERROR): Hardware Fault 2013-09-16T03:38:03.685Z,1379302683.685 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2013-09-16T03:38:03.685Z,1379302683.685 [BuoyancyServo] No Fault, FailCount= 2 2013-09-16T03:38:04.080Z,1379302684.080 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:38:04.213Z,1379302684.213 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2013-09-16T03:38:06.850Z,1379302686.850 [NAL9602](INFO): SBD MO Status=2, MOMSN=14840, MT Status=2, MTMSN=0 2013-09-16T03:38:06.850Z,1379302686.850 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2013-09-16T03:38:10.990Z,1379302690.990 [BuoyancyServo](ERROR): getPosition uart error serial timeout 2013-09-16T03:38:10.990Z,1379302690.990 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout 2013-09-16T03:38:10.990Z,1379302690.990 [BuoyancyServo] Communications Fault, FailCount= 3 2013-09-16T03:38:10.991Z,1379302690.991 [BuoyancyServo](ERROR): Communications Fault 2013-09-16T03:38:10.994Z,1379302690.994 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2013-09-16T03:38:11.204Z,1379302691.204 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2013-09-16T03:38:11.205Z,1379302691.205 [BuoyancyServo](INFO): Powering down 2013-09-16T03:38:12.737Z,1379302692.737 [BuoyancyServo](FAULT): LCB fault: Current Limiter Activated. 2013-09-16T03:38:12.737Z,1379302692.737 [BuoyancyServo] Hardware Fault, FailCount= 3 2013-09-16T03:38:12.737Z,1379302692.737 [BuoyancyServo](ERROR): Hardware Fault 2013-09-16T03:38:13.144Z,1379302693.144 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2013-09-16T03:38:13.144Z,1379302693.144 [BuoyancyServo] No Fault, FailCount= 3 2013-09-16T03:38:13.540Z,1379302693.540 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:38:13.657Z,1379302693.657 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2013-09-16T03:38:20.353Z,1379302700.353 [BuoyancyServo](ERROR): getPosition uart error serial timeout 2013-09-16T03:38:20.353Z,1379302700.353 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout 2013-09-16T03:38:20.353Z,1379302700.353 [BuoyancyServo] Communications Fault, FailCount= 4 2013-09-16T03:38:20.354Z,1379302700.354 [BuoyancyServo](ERROR): Communications Fault 2013-09-16T03:38:20.360Z,1379302700.360 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2013-09-16T03:38:20.591Z,1379302700.591 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2013-09-16T03:38:20.592Z,1379302700.592 [BuoyancyServo](INFO): Powering down 2013-09-16T03:38:22.142Z,1379302702.142 [BuoyancyServo](FAULT): LCB fault: Current Limiter Activated. 2013-09-16T03:38:22.142Z,1379302702.142 [BuoyancyServo] Hardware Fault, FailCount= 4 2013-09-16T03:38:22.142Z,1379302702.142 [BuoyancyServo](ERROR): Hardware Fault 2013-09-16T03:38:22.515Z,1379302702.515 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2013-09-16T03:38:22.515Z,1379302702.515 [BuoyancyServo] No Fault, FailCount= 4 2013-09-16T03:38:22.911Z,1379302702.911 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:38:23.026Z,1379302703.026 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2013-09-16T03:38:30.589Z,1379302710.589 [BuoyancyServo](ERROR): getPosition uart error serial timeout 2013-09-16T03:38:30.589Z,1379302710.589 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout 2013-09-16T03:38:30.589Z,1379302710.589 [BuoyancyServo] Communications Fault, FailCount= 5 2013-09-16T03:38:30.589Z,1379302710.589 [BuoyancyServo](ERROR): Communications Fault 2013-09-16T03:38:30.592Z,1379302710.592 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2013-09-16T03:38:30.593Z,1379302710.593 [CBIT](CRITICAL): Communications Fault in component: BuoyancyServo 2013-09-16T03:38:31.318Z,1379302711.318 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2013-09-16T03:38:31.319Z,1379302711.319 [BuoyancyServo](INFO): Powering down 2013-09-16T03:38:33.152Z,1379302713.152 [BuoyancyServo](FAULT): LCB fault: Current Limiter Activated. 2013-09-16T03:38:33.152Z,1379302713.152 [BuoyancyServo] Hardware Fault, FailCount= 5 2013-09-16T03:38:33.152Z,1379302713.152 [BuoyancyServo](ERROR): Hardware Fault 2013-09-16T03:40:27.614Z,1379302827.614 [CBIT](INFO): Clearing failed count for component MassServo 2013-09-16T03:40:27.614Z,1379302827.614 [MassServo] No Fault, FailCount= 6 2013-09-16T03:40:28.542Z,1379302828.542 [MassServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:40:28.543Z,1379302828.543 [MassServo](DEBUG): Initializing MassServo. 2013-09-16T03:40:31.380Z,1379302831.380 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout 2013-09-16T03:40:31.380Z,1379302831.380 [MassServo] Communications Fault, FailCount= 1 2013-09-16T03:40:31.380Z,1379302831.380 [MassServo](ERROR): Communications Fault 2013-09-16T03:40:31.383Z,1379302831.383 [CBIT](INFO): Clearing failed count for component BuoyancyServo 2013-09-16T03:40:31.383Z,1379302831.383 [BuoyancyServo] No Fault, FailCount= 5 2013-09-16T03:40:31.384Z,1379302831.384 [CBIT](ERROR): Communications Fault in component: MassServo 2013-09-16T03:40:31.629Z,1379302831.629 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:40:31.749Z,1379302831.749 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2013-09-16T03:40:31.751Z,1379302831.751 [MassServo](DEBUG): Uninitialize Mass Servo. 2013-09-16T03:40:31.751Z,1379302831.751 [MassServo](INFO): Powering down 2013-09-16T03:40:32.593Z,1379302832.593 [CBIT](INFO): Clearing failed state for component MassServo 2013-09-16T03:40:32.593Z,1379302832.593 [MassServo] No Fault, FailCount= 1 2013-09-16T03:40:32.821Z,1379302832.821 [MassServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:40:32.822Z,1379302832.822 [MassServo](DEBUG): Initializing MassServo. 2013-09-16T03:40:39.709Z,1379302839.709 [BuoyancyServo](ERROR): getPosition uart error serial timeout 2013-09-16T03:40:39.709Z,1379302839.709 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout 2013-09-16T03:40:39.709Z,1379302839.709 [BuoyancyServo] Communications Fault, FailCount= 1 2013-09-16T03:40:39.709Z,1379302839.709 [BuoyancyServo](ERROR): Communications Fault 2013-09-16T03:40:39.740Z,1379302839.740 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2013-09-16T03:40:39.981Z,1379302839.981 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2013-09-16T03:40:39.981Z,1379302839.981 [BuoyancyServo](INFO): Powering down 2013-09-16T03:40:42.076Z,1379302842.076 [BuoyancyServo](FAULT): LCB fault: Current Limiter Activated. 2013-09-16T03:40:42.076Z,1379302842.076 [BuoyancyServo] Hardware Fault, FailCount= 1 2013-09-16T03:40:42.076Z,1379302842.076 [BuoyancyServo](ERROR): Hardware Fault 2013-09-16T03:40:42.487Z,1379302842.487 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2013-09-16T03:40:42.487Z,1379302842.487 [BuoyancyServo] No Fault, FailCount= 1 2013-09-16T03:40:42.821Z,1379302842.821 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:40:42.939Z,1379302842.939 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2013-09-16T03:40:50.021Z,1379302850.021 [BuoyancyServo](ERROR): getPosition uart error serial timeout 2013-09-16T03:40:50.021Z,1379302850.021 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout 2013-09-16T03:40:50.021Z,1379302850.021 [BuoyancyServo] Communications Fault, FailCount= 2 2013-09-16T03:40:50.021Z,1379302850.021 [BuoyancyServo](ERROR): Communications Fault 2013-09-16T03:40:50.027Z,1379302850.027 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2013-09-16T03:40:50.240Z,1379302850.240 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2013-09-16T03:40:50.241Z,1379302850.241 [BuoyancyServo](INFO): Powering down 2013-09-16T03:40:51.802Z,1379302851.802 [BuoyancyServo](FAULT): LCB fault: Current Limiter Activated. 2013-09-16T03:40:51.802Z,1379302851.802 [BuoyancyServo] Hardware Fault, FailCount= 2 2013-09-16T03:40:51.802Z,1379302851.802 [BuoyancyServo](ERROR): Hardware Fault 2013-09-16T03:40:52.187Z,1379302852.187 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2013-09-16T03:40:52.187Z,1379302852.187 [BuoyancyServo] No Fault, FailCount= 2 2013-09-16T03:40:52.578Z,1379302852.578 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:40:52.702Z,1379302852.702 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2013-09-16T03:41:00.184Z,1379302860.184 [BuoyancyServo](ERROR): getPosition uart error serial timeout 2013-09-16T03:41:00.185Z,1379302860.185 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout 2013-09-16T03:41:00.185Z,1379302860.185 [BuoyancyServo] Communications Fault, FailCount= 3 2013-09-16T03:41:00.185Z,1379302860.185 [BuoyancyServo](ERROR): Communications Fault 2013-09-16T03:41:00.189Z,1379302860.189 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2013-09-16T03:41:00.404Z,1379302860.404 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2013-09-16T03:41:00.406Z,1379302860.406 [BuoyancyServo](INFO): Powering down 2013-09-16T03:41:02.508Z,1379302862.508 [BuoyancyServo](FAULT): LCB fault: Current Limiter Activated. 2013-09-16T03:41:02.508Z,1379302862.508 [BuoyancyServo] Hardware Fault, FailCount= 3 2013-09-16T03:41:02.508Z,1379302862.508 [BuoyancyServo](ERROR): Hardware Fault 2013-09-16T03:41:02.747Z,1379302862.747 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2013-09-16T03:41:02.747Z,1379302862.747 [BuoyancyServo] No Fault, FailCount= 3 2013-09-16T03:41:03.121Z,1379302863.121 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:41:03.238Z,1379302863.238 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2013-09-16T03:41:09.944Z,1379302869.944 [BuoyancyServo](ERROR): getPosition uart error serial timeout 2013-09-16T03:41:09.944Z,1379302869.944 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout 2013-09-16T03:41:09.944Z,1379302869.944 [BuoyancyServo] Communications Fault, FailCount= 4 2013-09-16T03:41:09.944Z,1379302869.944 [BuoyancyServo](ERROR): Communications Fault 2013-09-16T03:41:09.948Z,1379302869.948 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2013-09-16T03:41:10.179Z,1379302870.179 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2013-09-16T03:41:10.180Z,1379302870.180 [BuoyancyServo](INFO): Powering down 2013-09-16T03:41:11.880Z,1379302871.880 [BuoyancyServo](FAULT): LCB fault: Current Limiter Activated. 2013-09-16T03:41:11.880Z,1379302871.880 [BuoyancyServo] Hardware Fault, FailCount= 4 2013-09-16T03:41:11.880Z,1379302871.880 [BuoyancyServo](ERROR): Hardware Fault 2013-09-16T03:41:12.123Z,1379302872.123 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2013-09-16T03:41:12.123Z,1379302872.123 [BuoyancyServo] No Fault, FailCount= 4 2013-09-16T03:41:12.524Z,1379302872.524 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:41:12.643Z,1379302872.643 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2013-09-16T03:41:19.751Z,1379302879.751 [BuoyancyServo](ERROR): getPosition uart error serial timeout 2013-09-16T03:41:19.751Z,1379302879.751 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout 2013-09-16T03:41:19.751Z,1379302879.751 [BuoyancyServo] Communications Fault, FailCount= 5 2013-09-16T03:41:19.751Z,1379302879.751 [BuoyancyServo](ERROR): Communications Fault 2013-09-16T03:41:19.755Z,1379302879.755 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2013-09-16T03:41:19.756Z,1379302879.756 [CBIT](CRITICAL): Communications Fault in component: BuoyancyServo 2013-09-16T03:41:19.981Z,1379302879.981 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2013-09-16T03:41:19.982Z,1379302879.982 [BuoyancyServo](INFO): Powering down 2013-09-16T03:41:21.581Z,1379302881.581 [BuoyancyServo](FAULT): LCB fault: Current Limiter Activated. 2013-09-16T03:41:21.581Z,1379302881.581 [BuoyancyServo] Hardware Fault, FailCount= 5 2013-09-16T03:41:21.581Z,1379302881.581 [BuoyancyServo](ERROR): Hardware Fault 2013-09-16T03:43:19.847Z,1379302999.847 [CBIT](INFO): Clearing failed count for component BuoyancyServo 2013-09-16T03:43:19.847Z,1379302999.847 [BuoyancyServo] No Fault, FailCount= 5 2013-09-16T03:43:20.233Z,1379303000.233 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:43:20.347Z,1379303000.347 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2013-09-16T03:43:27.829Z,1379303007.829 [BuoyancyServo](ERROR): getPosition uart error serial timeout 2013-09-16T03:43:27.830Z,1379303007.830 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout 2013-09-16T03:43:27.830Z,1379303007.830 [BuoyancyServo] Communications Fault, FailCount= 1 2013-09-16T03:43:27.830Z,1379303007.830 [BuoyancyServo](ERROR): Communications Fault 2013-09-16T03:43:27.834Z,1379303007.834 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2013-09-16T03:43:28.068Z,1379303008.068 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2013-09-16T03:43:28.069Z,1379303008.069 [BuoyancyServo](INFO): Powering down 2013-09-16T03:43:29.611Z,1379303009.611 [BuoyancyServo](FAULT): LCB fault: Current Limiter Activated. 2013-09-16T03:43:29.611Z,1379303009.611 [BuoyancyServo] Hardware Fault, FailCount= 1 2013-09-16T03:43:29.611Z,1379303009.611 [BuoyancyServo](ERROR): Hardware Fault 2013-09-16T03:43:30.003Z,1379303010.003 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2013-09-16T03:43:30.003Z,1379303010.003 [BuoyancyServo] No Fault, FailCount= 1 2013-09-16T03:43:30.388Z,1379303010.388 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:43:30.510Z,1379303010.510 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2013-09-16T03:43:38.081Z,1379303018.081 [BuoyancyServo](ERROR): getPosition uart error serial timeout 2013-09-16T03:43:38.081Z,1379303018.081 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout 2013-09-16T03:43:38.082Z,1379303018.082 [BuoyancyServo] Communications Fault, FailCount= 2 2013-09-16T03:43:38.082Z,1379303018.082 [BuoyancyServo](ERROR): Communications Fault 2013-09-16T03:43:38.086Z,1379303018.086 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2013-09-16T03:43:38.800Z,1379303018.800 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2013-09-16T03:43:38.801Z,1379303018.801 [BuoyancyServo](INFO): Powering down 2013-09-16T03:43:40.643Z,1379303020.643 [BuoyancyServo](FAULT): LCB fault: Current Limiter Activated. 2013-09-16T03:43:40.644Z,1379303020.644 [BuoyancyServo] Hardware Fault, FailCount= 2 2013-09-16T03:43:40.644Z,1379303020.644 [BuoyancyServo](ERROR): Hardware Fault 2013-09-16T03:43:41.092Z,1379303021.092 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2013-09-16T03:43:41.092Z,1379303021.092 [BuoyancyServo] No Fault, FailCount= 2 2013-09-16T03:43:41.439Z,1379303021.439 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:43:41.557Z,1379303021.557 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2013-09-16T03:43:49.000Z,1379303030.000 [BuoyancyServo](ERROR): getPosition uart error serial timeout 2013-09-16T03:43:49.000Z,1379303030.000 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout 2013-09-16T03:43:50.000Z,1379303030.000 [BuoyancyServo] Communications Fault, FailCount= 3 2013-09-16T03:43:50.000Z,1379303030.000 [BuoyancyServo](ERROR): Communications Fault 2013-09-16T03:43:50.004Z,1379303030.004 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2013-09-16T03:43:50.278Z,1379303030.278 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2013-09-16T03:43:50.279Z,1379303030.279 [BuoyancyServo](INFO): Powering down 2013-09-16T03:43:52.334Z,1379303032.334 [BuoyancyServo](FAULT): LCB fault: Current Limiter Activated. 2013-09-16T03:43:52.334Z,1379303032.334 [BuoyancyServo] Hardware Fault, FailCount= 3 2013-09-16T03:43:52.334Z,1379303032.334 [BuoyancyServo](ERROR): Hardware Fault 2013-09-16T03:43:52.593Z,1379303032.593 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2013-09-16T03:43:52.593Z,1379303032.593 [BuoyancyServo] No Fault, FailCount= 3 2013-09-16T03:43:52.980Z,1379303032.980 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:43:53.106Z,1379303033.106 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2013-09-16T03:44:01.055Z,1379303041.055 [BuoyancyServo](ERROR): getPosition uart error serial timeout 2013-09-16T03:44:01.055Z,1379303041.055 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout 2013-09-16T03:44:01.055Z,1379303041.055 [BuoyancyServo] Communications Fault, FailCount= 4 2013-09-16T03:44:01.055Z,1379303041.055 [BuoyancyServo](ERROR): Communications Fault 2013-09-16T03:44:01.059Z,1379303041.059 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2013-09-16T03:44:01.282Z,1379303041.282 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2013-09-16T03:44:01.283Z,1379303041.283 [BuoyancyServo](INFO): Powering down 2013-09-16T03:44:03.387Z,1379303043.387 [BuoyancyServo](FAULT): LCB fault: Current Limiter Activated. 2013-09-16T03:44:03.387Z,1379303043.387 [BuoyancyServo] Hardware Fault, FailCount= 4 2013-09-16T03:44:03.387Z,1379303043.387 [BuoyancyServo](ERROR): Hardware Fault 2013-09-16T03:44:03.622Z,1379303043.622 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2013-09-16T03:44:03.622Z,1379303043.622 [BuoyancyServo] No Fault, FailCount= 4 2013-09-16T03:44:04.002Z,1379303044.002 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:44:04.123Z,1379303044.123 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2013-09-16T03:44:10.820Z,1379303050.820 [BuoyancyServo](ERROR): getPosition uart error serial timeout 2013-09-16T03:44:10.820Z,1379303050.820 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout 2013-09-16T03:44:10.820Z,1379303050.820 [BuoyancyServo] Communications Fault, FailCount= 5 2013-09-16T03:44:10.820Z,1379303050.820 [BuoyancyServo](ERROR): Communications Fault 2013-09-16T03:44:10.824Z,1379303050.824 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2013-09-16T03:44:10.825Z,1379303050.825 [CBIT](CRITICAL): Communications Fault in component: BuoyancyServo 2013-09-16T03:44:11.034Z,1379303051.034 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2013-09-16T03:44:11.035Z,1379303051.035 [BuoyancyServo](INFO): Powering down 2013-09-16T03:44:12.738Z,1379303052.738 [BuoyancyServo](FAULT): LCB fault: Current Limiter Activated. 2013-09-16T03:44:12.738Z,1379303052.738 [BuoyancyServo] Hardware Fault, FailCount= 5 2013-09-16T03:44:12.738Z,1379303052.738 [BuoyancyServo](ERROR): Hardware Fault 2013-09-16T03:46:10.995Z,1379303170.995 [CBIT](INFO): Clearing failed count for component BuoyancyServo 2013-09-16T03:46:10.995Z,1379303170.995 [BuoyancyServo] No Fault, FailCount= 5 2013-09-16T03:46:11.385Z,1379303171.385 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:46:11.500Z,1379303171.500 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2013-09-16T03:46:19.083Z,1379303179.083 [BuoyancyServo](ERROR): getPosition uart error serial timeout 2013-09-16T03:46:19.083Z,1379303179.083 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout 2013-09-16T03:46:19.083Z,1379303179.083 [BuoyancyServo] Communications Fault, FailCount= 1 2013-09-16T03:46:19.083Z,1379303179.083 [BuoyancyServo](ERROR): Communications Fault 2013-09-16T03:46:19.087Z,1379303179.087 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2013-09-16T03:46:19.793Z,1379303179.793 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2013-09-16T03:46:19.794Z,1379303179.794 [BuoyancyServo](INFO): Powering down 2013-09-16T03:46:21.626Z,1379303181.626 [BuoyancyServo](FAULT): LCB fault: Current Limiter Activated. 2013-09-16T03:46:21.627Z,1379303181.627 [BuoyancyServo] Hardware Fault, FailCount= 1 2013-09-16T03:46:21.629Z,1379303181.629 [BuoyancyServo](ERROR): Hardware Fault 2013-09-16T03:46:22.035Z,1379303182.035 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2013-09-16T03:46:22.035Z,1379303182.035 [BuoyancyServo] No Fault, FailCount= 1 2013-09-16T03:46:22.424Z,1379303182.424 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:46:22.541Z,1379303182.541 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2013-09-16T03:46:30.957Z,1379303190.957 [BuoyancyServo](ERROR): getPosition uart error serial timeout 2013-09-16T03:46:30.958Z,1379303190.958 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout 2013-09-16T03:46:30.958Z,1379303190.958 [BuoyancyServo] Communications Fault, FailCount= 2 2013-09-16T03:46:30.958Z,1379303190.958 [BuoyancyServo](ERROR): Communications Fault 2013-09-16T03:46:30.962Z,1379303190.962 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2013-09-16T03:46:31.206Z,1379303191.206 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2013-09-16T03:46:31.207Z,1379303191.207 [BuoyancyServo](INFO): Powering down 2013-09-16T03:46:33.288Z,1379303193.288 [BuoyancyServo](FAULT): LCB fault: Current Limiter Activated. 2013-09-16T03:46:33.288Z,1379303193.288 [BuoyancyServo] Hardware Fault, FailCount= 2 2013-09-16T03:46:33.288Z,1379303193.288 [BuoyancyServo](ERROR): Hardware Fault 2013-09-16T03:46:33.523Z,1379303193.523 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2013-09-16T03:46:33.523Z,1379303193.523 [BuoyancyServo] No Fault, FailCount= 2 2013-09-16T03:46:33.902Z,1379303193.902 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:46:34.023Z,1379303194.023 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2013-09-16T03:46:41.582Z,1379303201.582 [BuoyancyServo](ERROR): getPosition uart error serial timeout 2013-09-16T03:46:41.582Z,1379303201.582 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout 2013-09-16T03:46:41.582Z,1379303201.582 [BuoyancyServo] Communications Fault, FailCount= 3 2013-09-16T03:46:41.582Z,1379303201.582 [BuoyancyServo](ERROR): Communications Fault 2013-09-16T03:46:41.586Z,1379303201.586 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2013-09-16T03:46:41.809Z,1379303201.809 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2013-09-16T03:46:41.810Z,1379303201.810 [BuoyancyServo](INFO): Powering down 2013-09-16T03:46:43.401Z,1379303203.401 [BuoyancyServo](FAULT): LCB fault: Current Limiter Activated. 2013-09-16T03:46:43.401Z,1379303203.401 [BuoyancyServo] Hardware Fault, FailCount= 3 2013-09-16T03:46:43.401Z,1379303203.401 [BuoyancyServo](ERROR): Hardware Fault 2013-09-16T03:46:44.314Z,1379303204.314 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2013-09-16T03:46:44.314Z,1379303204.314 [BuoyancyServo] No Fault, FailCount= 3 2013-09-16T03:46:44.545Z,1379303204.545 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2013-09-16T03:46:44.660Z,1379303204.660 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2013-09-16T03:46:51.497Z,1379303211.497 [BuoyancyServo](ERROR): getPosition uart error serial timeout 2013-09-16T03:46:51.497Z,1379303211.497 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout 2013-09-16T03:46:51.497Z,1379303211.497 [BuoyancyServo] Communications Fault, FailCount= 4 2013-09-16T03:46:51.498Z,1379303211.498 [BuoyancyServo](ERROR): Communications Fault 2013-09-16T03:46:51.501Z,1379303211.501 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2013-09-16T03:46:51.793Z,1379303211.793 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2013-09-16T03:46:51.794Z,1379303211.794