2010-08-18T11:47:07.250Z,1282132027.250 [Supervisor](DEBUG): Initializing supervisor.
2010-08-18T11:47:07.255Z,1282132027.255 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2010-08-18T11:47:07.255Z,1282132027.255 [SyncHandler](INFO): Protected caller Thread ID is 8763
2010-08-18T11:47:07.256Z,1282132027.256 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2010-08-18T11:47:07.257Z,1282132027.257 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2010-08-18T11:47:07.257Z,1282132027.257 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 8764
2010-08-18T11:47:07.262Z,1282132027.262 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2010-08-18T11:47:07.280Z,1282132027.280 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2010-08-18T11:47:07.281Z,1282132027.281 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2010-08-18T11:47:07.281Z,1282132027.281 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 8765
2010-08-18T11:47:07.286Z,1282132027.286 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2010-08-18T11:47:07.287Z,1282132027.287 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2010-08-18T11:47:07.287Z,1282132027.287 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 8766
2010-08-18T11:47:07.289Z,1282132027.289 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2010-08-18T11:47:07.290Z,1282132027.290 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2010-08-18T11:47:07.290Z,1282132027.290 [logger ThreadHandler](INFO): Protected caller Thread ID is 8767
2010-08-18T11:47:07.294Z,1282132027.294 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2010-08-18T11:47:07.295Z,1282132027.295 [Supervisor](INFO): Looking for Config files in directory: Config/
2010-08-18T11:47:07.296Z,1282132027.296 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2010-08-18T11:47:07.711Z,1282132027.711 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2010-08-18T11:47:07.712Z,1282132027.712 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2010-08-18T11:47:07.920Z,1282132027.920 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2010-08-18T11:47:07.921Z,1282132027.921 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2010-08-18T11:47:08.104Z,1282132028.104 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2010-08-18T11:47:08.105Z,1282132028.105 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2010-08-18T11:47:08.212Z,1282132028.212 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2010-08-18T11:47:08.212Z,1282132028.212 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2010-08-18T11:47:08.562Z,1282132028.562 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2010-08-18T11:47:08.563Z,1282132028.563 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2010-08-18T11:47:08.879Z,1282132028.879 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2010-08-18T11:47:08.880Z,1282132028.880 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2010-08-18T11:47:08.976Z,1282132028.976 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2010-08-18T11:47:08.976Z,1282132028.976 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2010-08-18T11:47:09.125Z,1282132029.125 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2010-08-18T11:47:09.126Z,1282132029.126 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2010-08-18T11:47:09.643Z,1282132029.643 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2010-08-18T11:47:09.644Z,1282132029.644 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2010-08-18T11:47:09.995Z,1282132029.995 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2010-08-18T11:47:09.995Z,1282132029.995 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2010-08-18T11:47:10.077Z,1282132030.077 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2010-08-18T11:47:10.277Z,1282132030.277 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2010-08-18T11:47:10.277Z,1282132030.277 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2010-08-18T11:47:10.403Z,1282132030.403 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2010-08-18T11:47:10.404Z,1282132030.404 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2010-08-18T11:47:11.046Z,1282132031.046 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2010-08-18T11:47:11.047Z,1282132031.047 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2010-08-18T11:47:11.127Z,1282132031.127 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2010-08-18T11:47:11.366Z,1282132031.366 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2010-08-18T11:47:11.368Z,1282132031.368 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/
2010-08-18T11:47:11.369Z,1282132031.369 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg
2010-08-18T11:47:11.533Z,1282132031.533 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg
2010-08-18T11:47:11.626Z,1282132031.626 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg
2010-08-18T11:47:11.737Z,1282132031.737 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg
2010-08-18T11:47:11.844Z,1282132031.844 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg
2010-08-18T11:47:12.063Z,1282132032.063 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg
2010-08-18T11:47:12.189Z,1282132032.189 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg
2010-08-18T11:47:12.344Z,1282132032.344 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg
2010-08-18T11:47:12.442Z,1282132032.442 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg
2010-08-18T11:47:12.580Z,1282132032.580 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg
2010-08-18T11:47:12.837Z,1282132032.837 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2010-08-18T11:47:12.838Z,1282132032.838 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg
2010-08-18T11:47:12.932Z,1282132032.932 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/root/
2010-08-18T11:47:12.933Z,1282132032.933 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2010-08-18T11:47:12.948Z,1282132032.948 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2010-08-18T11:47:13.273Z,1282132033.273 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2010-08-18T11:47:13.273Z,1282132033.273 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2010-08-18T11:47:13.354Z,1282132033.354 [DeadReckonUsingMultipleVelocitySources] Loaded
2010-08-18T11:47:13.354Z,1282132033.354 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2010-08-18T11:47:13.387Z,1282132033.387 [DeadReckonUsingSpeedCalculator] Loaded
2010-08-18T11:47:13.387Z,1282132033.387 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2010-08-18T11:47:13.400Z,1282132033.400 [NavChart] Loaded
2010-08-18T11:47:13.400Z,1282132033.400 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2010-08-18T11:47:13.406Z,1282132033.406 [UniversalFixResidualReporter] Loaded
2010-08-18T11:47:13.406Z,1282132033.406 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2010-08-18T11:47:13.407Z,1282132033.407 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2010-08-18T11:47:13.407Z,1282132033.407 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2010-08-18T11:47:13.418Z,1282132033.418 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2010-08-18T11:47:13.418Z,1282132033.418 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2010-08-18T11:47:13.611Z,1282132033.611 [CTD_Seabird] Loaded
2010-08-18T11:47:13.612Z,1282132033.612 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2010-08-18T11:47:13.613Z,1282132033.613 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406514E0
2010-08-18T11:47:13.613Z,1282132033.613 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 8849
2010-08-18T11:47:13.632Z,1282132033.632 [PAR_Licor] Loaded
2010-08-18T11:47:13.633Z,1282132033.633 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2010-08-18T11:47:13.664Z,1282132033.664 [WetLabsSeaOWL_UV_A] Loaded
2010-08-18T11:47:13.664Z,1282132033.664 [ComponentRegistry](DEBUG): Component "WetLabsSeaOWL_UV_A" handled in its own thread.
2010-08-18T11:47:13.665Z,1282132033.665 [WetLabsSeaOWL_UV_A ThreadHandler](DEBUG): Created PCaller Thread at 406814E0
2010-08-18T11:47:13.666Z,1282132033.666 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Protected caller Thread ID is 8850
2010-08-18T11:47:13.667Z,1282132033.667 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2010-08-18T11:47:13.667Z,1282132033.667 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2010-08-18T11:47:13.721Z,1282132033.721 [VerticalControl](DEBUG): Construct VerticalControl.
2010-08-18T11:47:13.782Z,1282132033.782 [VerticalControl] Loaded
2010-08-18T11:47:13.782Z,1282132033.782 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2010-08-18T11:47:13.785Z,1282132033.785 [HorizontalControl](DEBUG): Construct HorizontalControl.
2010-08-18T11:47:13.823Z,1282132033.823 [HorizontalControl] Loaded
2010-08-18T11:47:13.823Z,1282132033.823 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2010-08-18T11:47:13.825Z,1282132033.825 [SpeedControl](DEBUG): Construct SpeedControl.
2010-08-18T11:47:13.828Z,1282132033.828 [SpeedControl] Loaded
2010-08-18T11:47:13.829Z,1282132033.829 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2010-08-18T11:47:13.831Z,1282132033.831 [LoopControl](DEBUG): Construct LoopControl.
2010-08-18T11:47:13.832Z,1282132033.832 [LoopControl] Loaded
2010-08-18T11:47:13.832Z,1282132033.832 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2010-08-18T11:47:13.832Z,1282132033.832 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2010-08-18T11:47:13.833Z,1282132033.833 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2010-08-18T11:47:13.875Z,1282132033.875 [DepthRateCalculator] Loaded
2010-08-18T11:47:13.875Z,1282132033.875 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2010-08-18T11:47:13.880Z,1282132033.880 [PitchRateCalculator] Loaded
2010-08-18T11:47:13.880Z,1282132033.880 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2010-08-18T11:47:13.890Z,1282132033.890 [SpeedCalculator] Loaded
2010-08-18T11:47:13.890Z,1282132033.890 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2010-08-18T11:47:13.903Z,1282132033.903 [TempGradientCalculator] Loaded
2010-08-18T11:47:13.903Z,1282132033.903 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2010-08-18T11:47:13.907Z,1282132033.907 [YawRateCalculator] Loaded
2010-08-18T11:47:13.908Z,1282132033.908 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2010-08-18T11:47:13.925Z,1282132033.925 [ElevatorOffsetCalculator] Loaded
2010-08-18T11:47:13.925Z,1282132033.925 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2010-08-18T11:47:13.926Z,1282132033.926 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2010-08-18T11:47:13.926Z,1282132033.926 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2010-08-18T11:47:14.019Z,1282132034.019 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2010-08-18T11:47:14.019Z,1282132034.019 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2010-08-18T11:47:14.078Z,1282132034.078 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2010-08-18T11:47:14.078Z,1282132034.078 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2010-08-18T11:47:14.209Z,1282132034.209 [BuoyancyServo] Loaded
2010-08-18T11:47:14.209Z,1282132034.209 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2010-08-18T11:47:14.229Z,1282132034.229 [ElevatorServo] Loaded
2010-08-18T11:47:14.229Z,1282132034.229 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2010-08-18T11:47:14.247Z,1282132034.247 [MassServo] Loaded
2010-08-18T11:47:14.247Z,1282132034.247 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2010-08-18T11:47:14.266Z,1282132034.266 [RudderServo] Loaded
2010-08-18T11:47:14.266Z,1282132034.266 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2010-08-18T11:47:14.281Z,1282132034.281 [ThrusterHE] Loaded
2010-08-18T11:47:14.281Z,1282132034.281 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2010-08-18T11:47:14.281Z,1282132034.281 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2010-08-18T11:47:14.282Z,1282132034.282 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2010-08-18T11:47:14.387Z,1282132034.387 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2010-08-18T11:47:14.388Z,1282132034.388 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2010-08-18T11:47:14.750Z,1282132034.750 [BackseatComponent] Loaded
2010-08-18T11:47:14.750Z,1282132034.750 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2010-08-18T11:47:14.751Z,1282132034.751 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 40A494E0
2010-08-18T11:47:14.751Z,1282132034.751 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 8851
2010-08-18T11:47:14.754Z,1282132034.754 [LcmUniversalReporter] Loaded
2010-08-18T11:47:14.754Z,1282132034.754 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2010-08-18T11:47:16.224Z,1282132036.224 [BPC1] Loaded
2010-08-18T11:47:16.224Z,1282132036.224 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2010-08-18T11:47:16.294Z,1282132036.294 [DataOverHttps] Loaded
2010-08-18T11:47:16.294Z,1282132036.294 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2010-08-18T11:47:16.295Z,1282132036.295 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40A794E0
2010-08-18T11:47:16.296Z,1282132036.296 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 8852
2010-08-18T11:47:16.315Z,1282132036.315 [Depth_Keller] Loaded
2010-08-18T11:47:16.315Z,1282132036.315 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2010-08-18T11:47:16.375Z,1282132036.375 [NAL9602] Loaded
2010-08-18T11:47:16.375Z,1282132036.375 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2010-08-18T11:47:16.404Z,1282132036.404 [Onboard] Loaded
2010-08-18T11:47:16.404Z,1282132036.404 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2010-08-18T11:47:16.405Z,1282132036.405 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40AA94E0
2010-08-18T11:47:16.406Z,1282132036.406 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 8853
2010-08-18T11:47:16.418Z,1282132036.418 [Power24vConverter] Loaded
2010-08-18T11:47:16.419Z,1282132036.419 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2010-08-18T11:47:16.432Z,1282132036.432 [Radio_Surface] Loaded
2010-08-18T11:47:16.432Z,1282132036.432 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2010-08-18T11:47:16.433Z,1282132036.433 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40AD94E0
2010-08-18T11:47:16.433Z,1282132036.433 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 8854
2010-08-18T11:47:16.434Z,1282132036.434 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2010-08-18T11:47:16.435Z,1282132036.435 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2010-08-18T11:47:16.579Z,1282132036.579 [SBIT](DEBUG): Construct Startup Built In Test.
2010-08-18T11:47:16.588Z,1282132036.588 [SBIT] Loaded
2010-08-18T11:47:16.588Z,1282132036.588 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2010-08-18T11:47:16.591Z,1282132036.591 [IBIT](DEBUG): Construct Initiated Built In Test.
2010-08-18T11:47:16.604Z,1282132036.604 [IBIT] Loaded
2010-08-18T11:47:16.604Z,1282132036.604 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2010-08-18T11:47:16.610Z,1282132036.610 [CBIT](DEBUG): Construct Continuous Built In Test.
2010-08-18T11:47:16.710Z,1282132036.710 [CBIT] Loaded
2010-08-18T11:47:16.711Z,1282132036.711 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2010-08-18T11:47:16.711Z,1282132036.711 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2010-08-18T11:47:16.712Z,1282132036.712 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2010-08-18T11:47:16.740Z,1282132036.740 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2010-08-18T11:47:16.746Z,1282132036.746 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2010-08-18T11:47:16.749Z,1282132036.749 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2010-08-18T11:47:16.759Z,1282132036.759 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2010-08-18T11:47:16.760Z,1282132036.760 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B644E0
2010-08-18T11:47:16.761Z,1282132036.761 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 8855
2010-08-18T11:47:16.765Z,1282132036.765 [Supervisor](INFO): Main Thread ID is 6436
2010-08-18T11:47:16.765Z,1282132036.765 [Supervisor](DEBUG): Running supervisor.
2010-08-18T11:47:16.766Z,1282132036.766 [CommandExec ThreadHandler](INFO): Handler Thread ID is 8856
2010-08-18T11:47:16.767Z,1282132036.767 [CommandExec](INFO): Initializing the command executive.
2010-08-18T11:47:16.768Z,1282132036.768 [CommandLine ThreadHandler](INFO): Handler Thread ID is 8857
2010-08-18T11:47:16.770Z,1282132036.770 [controlThread ThreadHandler](INFO): Handler Thread ID is 8858
2010-08-18T11:47:16.771Z,1282132036.771 [controlThread](DEBUG): Initializing ControlThread
2010-08-18T11:47:16.772Z,1282132036.772 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2010-08-18T11:47:16.773Z,1282132036.773 [NavChart](DEBUG): Initialize NavChart Navigation.
2010-08-18T11:47:16.773Z,1282132036.773 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2010-08-18T11:47:16.778Z,1282132036.778 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2010-08-18T11:47:16.780Z,1282132036.780 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2010-08-18T11:47:16.781Z,1282132036.781 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2010-08-18T11:47:16.781Z,1282132036.781 [LoopControl](DEBUG): Initialize LoopControlComponent.
2010-08-18T11:47:16.782Z,1282132036.782 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2010-08-18T11:47:16.782Z,1282132036.782 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2010-08-18T11:47:16.783Z,1282132036.783 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2010-08-18T11:47:16.783Z,1282132036.783 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2010-08-18T11:47:16.784Z,1282132036.784 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2010-08-18T11:47:16.784Z,1282132036.784 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2010-08-18T11:47:16.790Z,1282132036.790 [SBIT](INFO): Initialize SBIT Component.
2010-08-18T11:47:16.791Z,1282132036.791 [SBIT](IMPORTANT): git: 2021-10-11a
2010-08-18T11:47:16.791Z,1282132036.791 [SBIT](INFO): git hash: 36f3a97de7a122c995f034a375e3cefac6406048
2010-08-18T11:47:16.792Z,1282132036.792 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2010-08-18T11:47:16.793Z,1282132036.793 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2010-08-18T11:47:16.794Z,1282132036.794 [SBIT](INFO): Beginning SBIT in 20.000000 seconds.
2010-08-18T11:47:16.794Z,1282132036.794 [IBIT](INFO): Initialize IBIT Component.
2010-08-18T11:47:16.795Z,1282132036.795 [CBIT](DEBUG): Initialize CBIT Component.
2010-08-18T11:47:16.796Z,1282132036.796 [logger ThreadHandler](INFO): Handler Thread ID is 8859
2010-08-18T11:47:16.810Z,1282132036.810 [CBIT](DEBUG): Initialized mux pins.
2010-08-18T11:47:16.810Z,1282132036.810 [CBIT](DEBUG): Initializing the watchdog timer.
2010-08-18T11:47:16.814Z,1282132036.814 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 8860
2010-08-18T11:47:16.815Z,1282132036.815 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2010-08-18T11:47:16.820Z,1282132036.820 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Handler Thread ID is 8862
2010-08-18T11:47:16.830Z,1282132036.830 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 8863
2010-08-18T11:47:16.834Z,1282132036.834 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2010-08-18T11:47:16.834Z,1282132036.834 [CBIT](DEBUG): Initializing heartbeat.
2010-08-18T11:47:16.842Z,1282132036.842 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 8864
2010-08-18T11:47:16.843Z,1282132036.843 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2010-08-18T11:47:16.854Z,1282132036.854 [Onboard ThreadHandler](INFO): Handler Thread ID is 8865
2010-08-18T11:47:16.872Z,1282132036.872 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 8866
2010-08-18T11:47:16.894Z,1282132036.894 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 8867
2010-08-18T11:47:16.898Z,1282132036.898 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2010-08-18T11:47:16.900Z,1282132036.900 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2010-08-18T11:47:16.900Z,1282132036.900 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2010-08-18T11:47:16.901Z,1282132036.901 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2010-08-18T11:47:16.906Z,1282132036.906 [CBIT](DEBUG): Deactivating GF circuits.
2010-08-18T11:47:16.906Z,1282132036.906 [CBIT](DEBUG): Deactivating emergency mode.
2010-08-18T11:47:16.909Z,1282132036.909 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2010-08-18T11:47:16.909Z,1282132036.909 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2010-08-18T11:47:16.909Z,1282132036.909 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2010-08-18T11:47:16.941Z,1282132036.941 [CBIT](DEBUG): Backplane powered.
2010-08-18T11:47:16.942Z,1282132036.942 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2010-08-18T11:47:16.909Z,1282132036.909 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2010-08-18T11:47:16.953Z,1282132036.953 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2010-08-18T11:47:16.953Z,1282132036.953 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2010-08-18T11:47:16.954Z,1282132036.954 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2010-08-18T11:47:16.969Z,1282132036.969 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2010-08-18T11:47:16.982Z,1282132036.982 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="StartupSatComms">

        <Sequence/>

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

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

    </Aggregate>

</Mission>


2010-08-18T11:47:16.983Z,1282132036.983 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2010-08-18T11:47:16.989Z,1282132036.989 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2010-08-18T11:47:16.990Z,1282132036.990 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2010-08-18T11:47:16.990Z,1282132036.990 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2010-08-18T11:47:16.990Z,1282132036.990 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2010-08-18T11:47:16.990Z,1282132036.990 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2010-08-18T11:47:17.083Z,1282132037.083 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2010-08-18T11:47:17.084Z,1282132037.084 [Default:A.Wait](DEBUG): Construct Wait.
2010-08-18T11:47:17.098Z,1282132037.098 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2010-08-18T11:47:17.126Z,1282132037.126 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2010-08-18T11:47:17.129Z,1282132037.129 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2010-08-18T11:47:17.231Z,1282132037.231 [Default:E.Execute](DEBUG): Construct Execute.
2010-08-18T11:47:17.267Z,1282132037.267 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="Default">

    <DefineArg Name="ElapsedSinceDefaultStarted"><Units:minute/><Value>0</Value></DefineArg>

    <Guidance:Wait>
        <Description>
            Wait a moment to see if the scheduler starts a new mission before
            starting to actually run Default.
        </Description>
        <Sequence/>
        <Setting><Guidance:Wait.duration/><Units:second/><Value>13</Value></Setting>
    </Guidance:Wait>

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

        <ReadDatum Id="Read_GPS">
            <Timeout Duration="P5M"/>
            <Universal:time_fix/>
        </ReadDatum>

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

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

        <Assign><Sequence/><Arg Name="ElapsedSinceDefaultStarted"/><Elapsed><Universal:mission_started/></Elapsed></Assign>

        <Syslog Severity="Important">Default mission has been running for <Arg Name="ElapsedSinceDefaultStarted"/><Units:minute/></Syslog>

    </Aggregate>

    <Syslog Severity="Important">Restarting logs and Default mission.</Syslog>

    <Guidance:Execute>
        <Sequence/>
        <Setting><Guidance:Execute.command/><String>restart logs</String></Setting>
    </Guidance:Execute>

</Mission>


2010-08-18T11:47:17.272Z,1282132037.272 [controlThread](DEBUG): Component order: CycleStarter,PAR_Licor,BPC1,Depth_Keller,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2010-08-18T11:47:17.278Z,1282132037.278 [Radio_Surface](INFO): Powering up
2010-08-18T11:47:17.384Z,1282132037.384 [Depth_Keller](ERROR): Pressure reading out of range: 1628.471313 decibar
2010-08-18T11:47:17.385Z,1282132037.385 [Power24vConverter](INFO): Powering up.
2010-08-18T11:47:17.386Z,1282132037.386 [DepthRateCalculator](ERROR): Depth measurement is not active
2010-08-18T11:47:17.399Z,1282132037.399 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2010-08-18T11:47:17.417Z,1282132037.417 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2010-08-18T11:47:17.418Z,1282132037.418 [ElevatorServo](DEBUG): Initializing EZServoServo.
2010-08-18T11:47:17.426Z,1282132037.426 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2010-08-18T11:47:17.427Z,1282132037.427 [MassServo](DEBUG): Initializing EZServoServo.
2010-08-18T11:47:17.434Z,1282132037.434 [MassServo](DEBUG): Initializing MassServo.
2010-08-18T11:47:17.435Z,1282132037.435 [RudderServo](DEBUG): Initializing EZServoServo.
2010-08-18T11:47:17.443Z,1282132037.443 [RudderServo](DEBUG): Initializing RudderServo.
2010-08-18T11:47:17.444Z,1282132037.444 [ThrusterHE](INFO): Start
2010-08-18T11:47:17.444Z,1282132037.444 [ThrusterHE](DEBUG): Initializing EZServoServo.
2010-08-18T11:47:17.450Z,1282132037.450 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2010-08-18T11:47:17.758Z,1282132037.758 [ThrusterHE](INFO): Starting
2010-08-18T11:47:18.171Z,1282132038.171 [ThrusterHE](INFO): Starting
2010-08-18T11:47:18.635Z,1282132038.635 [ThrusterHE](INFO): Starting
2010-08-18T11:47:18.915Z,1282132038.915 [ThrusterHE](INFO): Starting
2010-08-18T11:47:19.319Z,1282132039.319 [ThrusterHE](INFO): Starting
2010-08-18T11:47:19.774Z,1282132039.774 [ThrusterHE](INFO): Starting
2010-08-18T11:47:19.774Z,1282132039.774 [ThrusterHE](INFO): Normal Promp. Good Init
2010-08-18T11:47:20.222Z,1282132040.222 [ThrusterHE](INFO): Starting
2010-08-18T11:47:20.699Z,1282132040.699 [ThrusterHE](INFO): Starting
2010-08-18T11:47:21.074Z,1282132041.074 [ThrusterHE](INFO): Starting
2010-08-18T11:47:21.510Z,1282132041.510 [ThrusterHE](INFO): Starting
2010-08-18T11:47:21.882Z,1282132041.882 [ThrusterHE](INFO): Starting
2010-08-18T11:47:22.160Z,1282132042.160 [ThrusterHE](INFO): Starting
2010-08-18T11:47:22.560Z,1282132042.560 [ThrusterHE](INFO): Starting
2010-08-18T11:47:23.095Z,1282132043.095 [ThrusterHE](INFO): Runnable
2010-08-18T11:47:23.095Z,1282132043.095 [ThrusterHE](INFO): Unexpected data on serial port:ZSpeed
2010-08-18T11:47:23.096Z,1282132043.096 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:47:23.096Z,1282132043.096 [ThrusterHE](INFO): Fault detected
2010-08-18T11:47:23.096Z,1282132043.096 [ThrusterHE](INFO): Send speed command forward:0000
2010-08-18T11:47:23.411Z,1282132043.411 [ThrusterHE](INFO): Pause
2010-08-18T11:47:29.866Z,1282132049.866 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2010-08-18T11:47:29.866Z,1282132049.866 [CTD_Seabird] Communications Fault, FailCount= 1
2010-08-18T11:47:29.866Z,1282132049.866 [CTD_Seabird](ERROR): Communications Fault
2010-08-18T11:47:30.248Z,1282132050.248 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2010-08-18T11:47:30.271Z,1282132050.271 [CTD_Seabird](INFO): Powering down
2010-08-18T11:47:31.456Z,1282132051.456 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2010-08-18T11:47:31.456Z,1282132051.456 [CTD_Seabird] No Fault, FailCount= 1
2010-08-18T11:47:31.614Z,1282132051.614 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2010-08-18T11:47:37.518Z,1282132057.518 [SBIT](IMPORTANT): Beginning Startup BIT
2010-08-18T11:47:37.526Z,1282132057.526 [CBIT](IMPORTANT): Beginning ground fault scan
2010-08-18T11:47:44.666Z,1282132064.666 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2010-08-18T11:47:44.666Z,1282132064.666 [CTD_Seabird] Communications Fault, FailCount= 2
2010-08-18T11:47:44.666Z,1282132064.666 [CTD_Seabird](ERROR): Communications Fault
2010-08-18T11:47:44.831Z,1282132064.831 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2010-08-18T11:47:45.070Z,1282132065.070 [CTD_Seabird](INFO): Powering down
2010-08-18T11:47:46.029Z,1282132066.029 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2010-08-18T11:47:46.029Z,1282132066.029 [CTD_Seabird] No Fault, FailCount= 2
2010-08-18T11:47:46.422Z,1282132066.422 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2010-08-18T11:47:46.775Z,1282132066.775 [NAL9602](INFO): Powering up NAL9602
2010-08-18T11:47:47.750Z,1282132067.750 [CommandExec](IMPORTANT): got command failComponent
2010-08-18T11:47:47.750Z,1282132067.750 [CommandExec](IMPORTANT): Failed components:
2010-08-18T11:47:47.751Z,1282132067.751 [CommandExec](IMPORTANT): No failed Components.
2010-08-18T11:47:48.455Z,1282132068.455 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.028741
CHAN A1 (24V): 0.000443
CHAN A2 (12V): -0.004846
CHAN A3 (5V): -0.002763
CHAN B0 (3.3V): -0.001713
CHAN B1 (3.15aV): -0.001206
CHAN B2 (3.15bV): -0.001394
CHAN B3 (GND): -0.000545
OPEN: 0.004780
Full Scale: +/- 1 mA
2010-08-18T11:47:57.720Z,1282132077.720 [NAL9602](INFO): NAL9602 initialized
2010-08-18T11:47:57.912Z,1282132077.912 [CommandExec](IMPORTANT): got command maintain control SpeedControl.propOmegaAction 300.000000 revolution_per_minute
2010-08-18T11:47:57.915Z,1282132077.915 [ComponentRegistry](DEBUG): SyncComponent "Maintain_SpeedControl.propOmegaAction" handled in the control thread.
2010-08-18T11:47:58.328Z,1282132078.328 [controlThread](DEBUG): Component order: CycleStarter,PAR_Licor,BPC1,Depth_Keller,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_SpeedControl.propOmegaAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2010-08-18T11:47:58.702Z,1282132078.702 [ThrusterHE](INFO): Resume
2010-08-18T11:47:58.987Z,1282132078.987 [ThrusterHE](INFO): Resuming
2010-08-18T11:47:59.371Z,1282132079.371 [ThrusterHE](INFO): Resuming
2010-08-18T11:47:59.474Z,1282132079.474 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2010-08-18T11:47:59.474Z,1282132079.474 [CTD_Seabird] Communications Fault, FailCount= 3
2010-08-18T11:47:59.474Z,1282132079.474 [CTD_Seabird](ERROR): Communications Fault
2010-08-18T11:47:59.782Z,1282132079.782 [ThrusterHE](INFO): Resuming
2010-08-18T11:47:59.787Z,1282132079.787 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2010-08-18T11:47:59.787Z,1282132079.787 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2010-08-18T11:47:59.878Z,1282132079.878 [CTD_Seabird](INFO): Powering down
2010-08-18T11:48:00.183Z,1282132080.183 [ThrusterHE](INFO): Resuming
2010-08-18T11:48:00.583Z,1282132080.583 [ThrusterHE](INFO): Resuming
2010-08-18T11:48:01.025Z,1282132081.025 [ThrusterHE](INFO): Resuming
2010-08-18T11:48:01.395Z,1282132081.395 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:01.397Z,1282132081.397 [ThrusterHE](INFO): Send speed command forward:00FF
2010-08-18T11:48:01.851Z,1282132081.851 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:01.851Z,1282132081.851 [ThrusterHE](INFO): Unexpected data on serial port:FF

>
2010-08-18T11:48:01.851Z,1282132081.851 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:02.190Z,1282132082.190 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:02.603Z,1282132082.603 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:03.015Z,1282132083.015 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:03.031Z,1282132083.031 [ThrusterHE](INFO): Speed Good:23.726879
2010-08-18T11:48:03.394Z,1282132083.394 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:03.395Z,1282132083.395 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

0039

2010-08-18T11:48:03.395Z,1282132083.395 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:03.422Z,1282132083.422 [ThrusterHE](INFO): Speed Good:24.975662
2010-08-18T11:48:03.812Z,1282132083.812 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:03.812Z,1282132083.812 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

003C

2010-08-18T11:48:03.812Z,1282132083.812 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:03.838Z,1282132083.838 [ThrusterHE](INFO): Speed Good:25.808184
2010-08-18T11:48:04.231Z,1282132084.231 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:04.231Z,1282132084.231 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

003E

2010-08-18T11:48:04.231Z,1282132084.231 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:04.258Z,1282132084.258 [ThrusterHE](INFO): Speed Good:27.056967
2010-08-18T11:48:04.619Z,1282132084.619 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:04.619Z,1282132084.619 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

0041

2010-08-18T11:48:04.619Z,1282132084.619 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:04.646Z,1282132084.646 [ThrusterHE](INFO): Speed Good:27.473228
2010-08-18T11:48:05.023Z,1282132085.023 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:05.023Z,1282132085.023 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

0042

2010-08-18T11:48:05.023Z,1282132085.023 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:05.050Z,1282132085.050 [ThrusterHE](INFO): Speed Good:28.305750
2010-08-18T11:48:05.415Z,1282132085.415 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:05.415Z,1282132085.415 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

0044

2010-08-18T11:48:05.415Z,1282132085.415 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:05.431Z,1282132085.431 [ThrusterHE](INFO): Speed Good:28.722012
2010-08-18T11:48:05.846Z,1282132085.846 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:05.846Z,1282132085.846 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

0045

2010-08-18T11:48:05.847Z,1282132085.847 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:05.870Z,1282132085.870 [ThrusterHE](INFO): Speed Good:29.138271
2010-08-18T11:48:06.262Z,1282132086.262 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:06.262Z,1282132086.262 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

0046

2010-08-18T11:48:06.262Z,1282132086.262 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:06.286Z,1282132086.286 [ThrusterHE](INFO): Speed Good:29.554533
2010-08-18T11:48:06.659Z,1282132086.659 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:06.659Z,1282132086.659 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

0047

2010-08-18T11:48:06.659Z,1282132086.659 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:06.688Z,1282132086.688 [ThrusterHE](INFO): Speed Good:29.970795
2010-08-18T11:48:07.063Z,1282132087.063 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:07.063Z,1282132087.063 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

0048

2010-08-18T11:48:07.063Z,1282132087.063 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:07.102Z,1282132087.102 [ThrusterHE](INFO): Speed Good:29.970795
2010-08-18T11:48:07.439Z,1282132087.439 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:07.439Z,1282132087.439 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

0048

2010-08-18T11:48:07.439Z,1282132087.439 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:07.468Z,1282132087.468 [ThrusterHE](INFO): Speed Good:30.387054
2010-08-18T11:48:07.871Z,1282132087.871 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:07.871Z,1282132087.871 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

0049

2010-08-18T11:48:07.872Z,1282132087.872 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:07.895Z,1282132087.895 [ThrusterHE](INFO): Speed Good:30.387054
2010-08-18T11:48:08.259Z,1282132088.259 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:08.259Z,1282132088.259 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

0049

2010-08-18T11:48:08.259Z,1282132088.259 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:08.275Z,1282132088.275 [ThrusterHE](INFO): Speed Good:30.387054
2010-08-18T11:48:08.679Z,1282132088.679 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:08.680Z,1282132088.680 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

0049

2010-08-18T11:48:08.680Z,1282132088.680 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:08.706Z,1282132088.706 [ThrusterHE](INFO): Speed Good:30.803316
2010-08-18T11:48:09.073Z,1282132089.073 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:09.074Z,1282132089.074 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004A

2010-08-18T11:48:09.074Z,1282132089.074 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:09.098Z,1282132089.098 [ThrusterHE](INFO): Speed Good:30.803316
2010-08-18T11:48:09.488Z,1282132089.488 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:09.488Z,1282132089.488 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004A

2010-08-18T11:48:09.488Z,1282132089.488 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:09.514Z,1282132089.514 [ThrusterHE](INFO): Speed Good:30.803316
2010-08-18T11:48:09.883Z,1282132089.883 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:09.883Z,1282132089.883 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004A

2010-08-18T11:48:09.883Z,1282132089.883 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:09.902Z,1282132089.902 [ThrusterHE](INFO): Speed Good:30.803316
2010-08-18T11:48:10.342Z,1282132090.342 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:10.343Z,1282132090.343 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004A

2010-08-18T11:48:10.343Z,1282132090.343 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:10.382Z,1282132090.382 [ThrusterHE](INFO): Speed Good:30.803316
2010-08-18T11:48:10.652Z,1282132090.652 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:10.653Z,1282132090.653 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004A

2010-08-18T11:48:10.653Z,1282132090.653 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:10.674Z,1282132090.674 [ThrusterHE](INFO): Speed Good:31.219578
2010-08-18T11:48:11.072Z,1282132091.072 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:11.073Z,1282132091.073 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004B

2010-08-18T11:48:11.073Z,1282132091.073 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:11.112Z,1282132091.112 [ThrusterHE](INFO): Speed Good:31.219578
2010-08-18T11:48:11.457Z,1282132091.457 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:11.458Z,1282132091.458 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004B

2010-08-18T11:48:11.458Z,1282132091.458 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:11.502Z,1282132091.502 [ThrusterHE](INFO): Speed Good:31.219578
2010-08-18T11:48:11.867Z,1282132091.867 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:11.867Z,1282132091.867 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004B

2010-08-18T11:48:11.867Z,1282132091.867 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:11.894Z,1282132091.894 [ThrusterHE](INFO): Speed Good:30.803316
2010-08-18T11:48:12.267Z,1282132092.267 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:12.267Z,1282132092.267 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004A

2010-08-18T11:48:12.268Z,1282132092.268 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:12.286Z,1282132092.286 [ThrusterHE](INFO): Speed Good:31.219578
2010-08-18T11:48:12.660Z,1282132092.660 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:12.660Z,1282132092.660 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004B

2010-08-18T11:48:12.660Z,1282132092.660 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:12.686Z,1282132092.686 [ThrusterHE](INFO): Speed Good:31.219578
2010-08-18T11:48:13.077Z,1282132093.077 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:13.077Z,1282132093.077 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004B

2010-08-18T11:48:13.077Z,1282132093.077 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:13.102Z,1282132093.102 [ThrusterHE](INFO): Speed Good:31.219578
2010-08-18T11:48:13.459Z,1282132093.459 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:13.460Z,1282132093.460 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004B

2010-08-18T11:48:13.460Z,1282132093.460 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:13.490Z,1282132093.490 [ThrusterHE](INFO): Speed Good:31.219578
2010-08-18T11:48:13.869Z,1282132093.869 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:13.869Z,1282132093.869 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004B

2010-08-18T11:48:13.869Z,1282132093.869 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:13.911Z,1282132093.911 [ThrusterHE](INFO): Speed Good:31.219578
2010-08-18T11:48:14.275Z,1282132094.275 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:14.275Z,1282132094.275 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004B

2010-08-18T11:48:14.275Z,1282132094.275 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:14.302Z,1282132094.302 [ThrusterHE](INFO): Speed Good:31.219578
2010-08-18T11:48:14.672Z,1282132094.672 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:14.672Z,1282132094.672 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004B

2010-08-18T11:48:14.672Z,1282132094.672 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:14.698Z,1282132094.698 [ThrusterHE](INFO): Speed Good:31.219578
2010-08-18T11:48:15.077Z,1282132095.077 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:15.078Z,1282132095.078 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004B

2010-08-18T11:48:15.078Z,1282132095.078 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:15.106Z,1282132095.106 [ThrusterHE](INFO): Speed Good:31.219578
2010-08-18T11:48:15.488Z,1282132095.488 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:15.489Z,1282132095.489 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004B

2010-08-18T11:48:15.489Z,1282132095.489 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:15.506Z,1282132095.506 [ThrusterHE](INFO): Speed Good:31.219578
2010-08-18T11:48:15.881Z,1282132095.881 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:15.881Z,1282132095.881 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004B

2010-08-18T11:48:15.881Z,1282132095.881 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:15.922Z,1282132095.922 [ThrusterHE](INFO): Speed Good:31.219578
2010-08-18T11:48:16.310Z,1282132096.310 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:16.310Z,1282132096.310 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004B

2010-08-18T11:48:16.311Z,1282132096.311 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:16.326Z,1282132096.326 [ThrusterHE](INFO): Speed Good:31.219578
2010-08-18T11:48:16.713Z,1282132096.713 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:16.713Z,1282132096.713 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004B

2010-08-18T11:48:16.740Z,1282132096.740 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:16.766Z,1282132096.766 [ThrusterHE](INFO): Speed Good:31.219578
2010-08-18T11:48:17.122Z,1282132097.122 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:17.122Z,1282132097.122 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004B

2010-08-18T11:48:17.122Z,1282132097.122 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:17.149Z,1282132097.149 [ThrusterHE](INFO): Speed Good:30.803316
2010-08-18T11:48:17.513Z,1282132097.513 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:17.514Z,1282132097.514 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004A

2010-08-18T11:48:17.514Z,1282132097.514 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:17.538Z,1282132097.538 [ThrusterHE](INFO): Speed Good:30.803316
2010-08-18T11:48:17.939Z,1282132097.939 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:17.939Z,1282132097.939 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004A

2010-08-18T11:48:17.940Z,1282132097.940 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:17.966Z,1282132097.966 [ThrusterHE](INFO): Speed Good:31.219578
2010-08-18T11:48:18.322Z,1282132098.322 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:18.322Z,1282132098.322 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004B

2010-08-18T11:48:18.322Z,1282132098.322 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:18.342Z,1282132098.342 [ThrusterHE](INFO): Speed Good:31.219578
2010-08-18T11:48:18.721Z,1282132098.721 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:18.721Z,1282132098.721 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004B

2010-08-18T11:48:18.722Z,1282132098.722 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:18.746Z,1282132098.746 [ThrusterHE](INFO): Speed Good:31.219578
2010-08-18T11:48:19.130Z,1282132099.130 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:19.131Z,1282132099.131 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004B

2010-08-18T11:48:19.131Z,1282132099.131 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:19.158Z,1282132099.158 [ThrusterHE](INFO): Speed Good:30.803316
2010-08-18T11:48:19.662Z,1282132099.662 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:19.662Z,1282132099.662 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004A

2010-08-18T11:48:19.663Z,1282132099.663 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:19.694Z,1282132099.694 [ThrusterHE](INFO): Speed Good:30.803316
2010-08-18T11:48:20.038Z,1282132100.038 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:20.039Z,1282132100.039 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004A

2010-08-18T11:48:20.039Z,1282132100.039 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:20.055Z,1282132100.055 [ThrusterHE](INFO): Speed Good:30.803316
2010-08-18T11:48:20.418Z,1282132100.418 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:20.419Z,1282132100.419 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004A

2010-08-18T11:48:20.419Z,1282132100.419 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:20.446Z,1282132100.446 [ThrusterHE](INFO): Speed Good:30.803316
2010-08-18T11:48:20.833Z,1282132100.833 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:20.834Z,1282132100.834 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004A

2010-08-18T11:48:20.834Z,1282132100.834 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:20.858Z,1282132100.858 [ThrusterHE](INFO): Speed Good:30.803316
2010-08-18T11:48:21.238Z,1282132101.238 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:21.239Z,1282132101.239 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004A

2010-08-18T11:48:21.239Z,1282132101.239 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:21.266Z,1282132101.266 [ThrusterHE](INFO): Speed Good:31.219578
2010-08-18T11:48:21.658Z,1282132101.658 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:21.659Z,1282132101.659 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004B

2010-08-18T11:48:21.659Z,1282132101.659 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:21.690Z,1282132101.690 [ThrusterHE](INFO): Speed Good:31.219578
2010-08-18T11:48:22.074Z,1282132102.074 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:22.075Z,1282132102.075 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004B

2010-08-18T11:48:22.075Z,1282132102.075 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:22.102Z,1282132102.102 [ThrusterHE](INFO): Speed Good:31.219578
2010-08-18T11:48:22.498Z,1282132102.498 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:22.499Z,1282132102.499 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004B

2010-08-18T11:48:22.499Z,1282132102.499 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:22.526Z,1282132102.526 [ThrusterHE](INFO): Speed Good:31.219578
2010-08-18T11:48:23.050Z,1282132103.050 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:23.050Z,1282132103.050 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004B

2010-08-18T11:48:23.051Z,1282132103.051 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:23.082Z,1282132103.082 [ThrusterHE](INFO): Speed Good:31.219578
2010-08-18T11:48:23.191Z,1282132103.191 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:23.191Z,1282132103.191 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

004B

2010-08-18T11:48:23.191Z,1282132103.191 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:23.218Z,1282132103.218 [ThrusterHE](INFO): Speed Good:31.219578
2010-08-18T11:48:23.595Z,1282132103.595 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:23.682Z,1282132103.682 [ThrusterHE](FAULT): getSpeed error serial timeout
2010-08-18T11:48:23.682Z,1282132103.682 [ThrusterHE](INFO): Speed is bad
2010-08-18T11:48:23.682Z,1282132103.682 [ThrusterHE](FAULT): Thruster uart error: serial timeout
2010-08-18T11:48:23.682Z,1282132103.682 [ThrusterHE] Communications Fault, FailCount= 1
2010-08-18T11:48:23.682Z,1282132103.682 [ThrusterHE](ERROR): Communications Fault
2010-08-18T11:48:23.687Z,1282132103.687 [CBIT](ERROR): Communications Fault in component: ThrusterHE
2010-08-18T11:48:24.007Z,1282132104.007 [ThrusterHE](INFO): Stop
2010-08-18T11:48:24.007Z,1282132104.007 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2010-08-18T11:48:24.007Z,1282132104.007 [ThrusterHE](INFO): Powering down
2010-08-18T11:48:24.399Z,1282132104.399 [ThrusterHE](INFO): Stopping
2010-08-18T11:48:24.807Z,1282132104.807 [ThrusterHE](INFO): Stopped
2010-08-18T11:48:24.807Z,1282132104.807 [ThrusterHE](INFO): Start
2010-08-18T11:48:24.807Z,1282132104.807 [ThrusterHE](DEBUG): Initializing EZServoServo.
2010-08-18T11:48:24.808Z,1282132104.808 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2010-08-18T11:48:24.821Z,1282132104.821 [CBIT](INFO): Clearing failed state for component ThrusterHE
2010-08-18T11:48:24.821Z,1282132104.821 [ThrusterHE] No Fault, FailCount= 1
2010-08-18T11:48:25.207Z,1282132105.207 [ThrusterHE](INFO): Starting
2010-08-18T11:48:25.610Z,1282132105.610 [ThrusterHE](INFO): Starting
2010-08-18T11:48:26.019Z,1282132106.019 [ThrusterHE](INFO): Starting
2010-08-18T11:48:26.427Z,1282132106.427 [ThrusterHE](INFO): Starting
2010-08-18T11:48:26.843Z,1282132106.843 [ThrusterHE](INFO): Starting
2010-08-18T11:48:26.843Z,1282132106.843 [ThrusterHE](INFO): Normal Promp. Good Init
2010-08-18T11:48:27.256Z,1282132107.256 [ThrusterHE](INFO): Starting
2010-08-18T11:48:27.746Z,1282132107.746 [ThrusterHE](INFO): Starting
2010-08-18T11:48:28.025Z,1282132108.025 [ThrusterHE](INFO): Starting
2010-08-18T11:48:28.411Z,1282132108.411 [ThrusterHE](INFO): Starting
2010-08-18T11:48:28.823Z,1282132108.823 [ThrusterHE](INFO): Starting
2010-08-18T11:48:29.218Z,1282132109.218 [ThrusterHE](INFO): Starting
2010-08-18T11:48:29.623Z,1282132109.623 [ThrusterHE](INFO): Starting
2010-08-18T11:48:30.027Z,1282132110.027 [ThrusterHE](INFO): Starting
2010-08-18T11:48:30.438Z,1282132110.438 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:30.438Z,1282132110.438 [ThrusterHE](INFO): Unexpected data on serial port:ZSpeedng

2010-08-18T11:48:30.438Z,1282132110.438 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:30.438Z,1282132110.438 [ThrusterHE](INFO): Fault detected
2010-08-18T11:48:30.440Z,1282132110.440 [ThrusterHE](INFO): Send speed command forward:00FF
2010-08-18T11:48:30.891Z,1282132110.891 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:30.891Z,1282132110.891 [ThrusterHE](INFO): Unexpected data on serial port:FW,00FF

>B

2010-08-18T11:48:30.891Z,1282132110.891 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:31.246Z,1282132111.246 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:31.653Z,1282132111.653 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:31.654Z,1282132111.654 [SBIT](IMPORTANT): SBIT PASSED
2010-08-18T11:48:31.654Z,1282132111.654 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2010-08-18T11:48:31.655Z,1282132111.655 [SBIT](IMPORTANT): AHRS_M2.loadAtStartup=0 bool;

2010-08-18T11:48:31.655Z,1282132111.655 [SBIT](IMPORTANT): BackseatComponent.loadAtStartup=1 bool;

2010-08-18T11:48:31.656Z,1282132111.656 [SBIT](IMPORTANT): CBIT.gf24Offset=149 microampere;

2010-08-18T11:48:31.656Z,1282132111.656 [SBIT](IMPORTANT): CTD_NeilBrown.loadAtStartup=0 bool;

2010-08-18T11:48:31.656Z,1282132111.656 [SBIT](IMPORTANT): CTD_Seabird.loadAtStartup=1 bool;

2010-08-18T11:48:31.656Z,1282132111.656 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool;

2010-08-18T11:48:31.656Z,1282132111.656 [SBIT](IMPORTANT): IBIT.batteryCapacityThreshold=5 ampere_hour;

2010-08-18T11:48:31.656Z,1282132111.656 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=11 volt;

2010-08-18T11:48:31.656Z,1282132111.656 [SBIT](IMPORTANT): NAL9602.fastGPSFix=1 bool;

2010-08-18T11:48:31.656Z,1282132111.656 [SBIT](IMPORTANT): PAR_Licor.adcCal=8.76539e-06 microampere_per_count;

2010-08-18T11:48:31.657Z,1282132111.657 [SBIT](IMPORTANT): PAR_Licor.darkCount=4 count;

2010-08-18T11:48:31.657Z,1282132111.657 [SBIT](IMPORTANT): PAR_Licor.loadAtStartup=1 bool;

2010-08-18T11:48:31.657Z,1282132111.657 [SBIT](IMPORTANT): PAR_Licor.multiplier=269.34 micromole_per_second_per_square_meter_per_microampere;

2010-08-18T11:48:31.657Z,1282132111.657 [SBIT](IMPORTANT): PAR_Licor.parCal=1.221 none;

2010-08-18T11:48:31.657Z,1282132111.657 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=235 cubic_centimeter;

2010-08-18T11:48:31.658Z,1282132111.658 [SBIT](IMPORTANT): VerticalControl.massDefault=0 centimeter;

2010-08-18T11:48:31.658Z,1282132111.658 [SBIT](IMPORTANT): VerticalControl.massPositionLimitAft=-27 millimeter;

2010-08-18T11:48:31.658Z,1282132111.658 [SBIT](IMPORTANT): VerticalControl.massPositionLimitFwd=37 millimeter;

2010-08-18T11:48:32.060Z,1282132112.060 [MissionManager](IMPORTANT): Started mission Startup
2010-08-18T11:48:32.060Z,1282132112.060 [Startup] Running Loop=1
2010-08-18T11:48:32.060Z,1282132112.060 [Startup](DEBUG): Aggregate::initialize Startup
2010-08-18T11:48:32.060Z,1282132112.060 [Startup:A.GoToSurface] Running Loop=1
2010-08-18T11:48:32.060Z,1282132112.060 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2010-08-18T11:48:32.061Z,1282132112.061 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2010-08-18T11:48:32.062Z,1282132112.062 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2010-08-18T11:48:32.062Z,1282132112.062 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2010-08-18T11:48:32.063Z,1282132112.063 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2010-08-18T11:48:32.063Z,1282132112.063 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2010-08-18T11:48:32.064Z,1282132112.064 [Startup:StartupSatComms] Running Loop=1
2010-08-18T11:48:32.065Z,1282132112.065 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2010-08-18T11:48:32.065Z,1282132112.065 [Startup:StartupSatComms:A] Running Loop=1
2010-08-18T11:48:32.071Z,1282132112.071 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:32.106Z,1282132112.106 [ThrusterHE](INFO): Speed Good:23.726879
2010-08-18T11:48:32.476Z,1282132112.476 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2010-08-18T11:48:32.499Z,1282132112.499 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:32.499Z,1282132112.499 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

0039

2010-08-18T11:48:32.499Z,1282132112.499 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:32.526Z,1282132112.526 [ThrusterHE](INFO): Speed Good:24.975662
2010-08-18T11:48:32.890Z,1282132112.890 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:32.890Z,1282132112.890 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

003C

2010-08-18T11:48:32.891Z,1282132112.891 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:32.910Z,1282132112.910 [ThrusterHE](INFO): Speed Good:26.224445
2010-08-18T11:48:33.282Z,1282132113.282 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:33.282Z,1282132113.282 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

003F

2010-08-18T11:48:33.282Z,1282132113.282 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:33.314Z,1282132113.314 [ThrusterHE](INFO): Speed Good:27.056967
2010-08-18T11:48:33.679Z,1282132113.679 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:33.679Z,1282132113.679 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

0041

2010-08-18T11:48:33.679Z,1282132113.679 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:33.706Z,1282132113.706 [ThrusterHE](INFO): Speed Good:27.889488
2010-08-18T11:48:34.071Z,1282132114.071 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:34.071Z,1282132114.071 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

0043

2010-08-18T11:48:34.071Z,1282132114.071 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:34.090Z,1282132114.090 [ThrusterHE](INFO): Speed Good:28.305750
2010-08-18T11:48:34.476Z,1282132114.476 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:34.476Z,1282132114.476 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

0044

2010-08-18T11:48:34.476Z,1282132114.476 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:34.502Z,1282132114.502 [ThrusterHE](INFO): Speed Good:28.722012
2010-08-18T11:48:34.891Z,1282132114.891 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:34.891Z,1282132114.891 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

0045

2010-08-18T11:48:34.891Z,1282132114.891 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:34.918Z,1282132114.918 [ThrusterHE](INFO): Speed Good:29.138271
2010-08-18T11:48:35.279Z,1282132115.279 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:35.279Z,1282132115.279 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

0046

2010-08-18T11:48:35.279Z,1282132115.279 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:35.303Z,1282132115.303 [ThrusterHE](INFO): Speed Good:29.554533
2010-08-18T11:48:35.688Z,1282132115.688 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:35.688Z,1282132115.688 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

0047

2010-08-18T11:48:35.688Z,1282132115.688 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:35.718Z,1282132115.718 [ThrusterHE](INFO): Speed Good:29.970795
2010-08-18T11:48:36.092Z,1282132116.092 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:36.093Z,1282132116.093 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

0048

2010-08-18T11:48:36.093Z,1282132116.093 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:36.118Z,1282132116.118 [ThrusterHE](INFO): Speed Good:29.970795
2010-08-18T11:48:36.348Z,1282132116.348 [CommandExec](IMPORTANT): got command maintain clear
2010-08-18T11:48:36.490Z,1282132116.490 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:36.491Z,1282132116.491 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

0048

2010-08-18T11:48:36.491Z,1282132116.491 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:36.510Z,1282132116.510 [ThrusterHE](INFO): Speed Good:30.387054
2010-08-18T11:48:36.519Z,1282132116.519 [controlThread](DEBUG): Component order: CycleStarter,PAR_Licor,BPC1,Depth_Keller,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2010-08-18T11:48:36.897Z,1282132116.897 [ThrusterHE](INFO): Runnable
2010-08-18T11:48:36.898Z,1282132116.898 [ThrusterHE](INFO): Unexpected data on serial port:
>,78

0049

2010-08-18T11:48:36.898Z,1282132116.898 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:48:37.325Z,1282132117.325 [ThrusterHE](INFO): Pause
2010-08-18T11:49:16.889Z,1282132156.889 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2010-08-18T11:49:16.889Z,1282132156.889 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2010-08-18T11:49:16.889Z,1282132156.889 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2010-08-18T11:49:16.891Z,1282132156.891 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2010-08-18T11:49:16.891Z,1282132156.891 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2010-08-18T11:49:16.891Z,1282132156.891 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2010-08-18T11:49:16.903Z,1282132156.903 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2010-08-18T11:49:16.904Z,1282132156.904 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2010-08-18T11:49:17.316Z,1282132157.316 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2010-08-18T11:49:17.316Z,1282132157.316 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2010-08-18T11:49:17.317Z,1282132157.317 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2010-08-18T11:49:17.317Z,1282132157.317 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2010-08-18T11:49:17.690Z,1282132157.690 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2010-08-18T11:49:32.230Z,1282132172.230 [Startup:StartupSatComms:A](INFO): Timed out from 2010-08-18T11:48:32.1Z
2010-08-18T11:49:32.230Z,1282132172.230 [Startup:StartupSatComms:A] Stopped
2010-08-18T11:49:32.230Z,1282132172.230 [Startup:StartupSatComms:B] Running Loop=1
2010-08-18T11:49:32.635Z,1282132172.635 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2010-08-18T11:49:44.552Z,1282132184.552 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004894
2010-08-18T11:49:51.654Z,1282132191.654 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20100818T114318/Courier0004.lzma
2010-08-18T11:49:52.655Z,1282132192.655 [DataOverHttps](INFO): Moved sent file to Logs/20100818T114318/Courier0004.lzma.bak
2010-08-18T11:49:52.656Z,1282132192.656 [DataOverHttps](INFO): SBD MOMSN=16171741
2010-08-18T11:50:09.205Z,1282132209.205 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20100818T114707/Courier0000.lzma
2010-08-18T11:50:10.212Z,1282132210.212 [DataOverHttps](INFO): Moved sent file to Logs/20100818T114707/Courier0000.lzma.bak
2010-08-18T11:50:10.212Z,1282132210.212 [DataOverHttps](INFO): SBD MOMSN=16171743
2010-08-18T11:50:29.730Z,1282132229.730 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2010-08-18T11:50:29.730Z,1282132229.730 [CTD_Seabird] No Fault, FailCount= 3
2010-08-18T11:50:29.950Z,1282132229.950 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2010-08-18T11:50:32.513Z,1282132232.513 [Startup:StartupSatComms:B](INFO): Timed out from 2010-08-18T11:49:32.2Z
2010-08-18T11:50:32.513Z,1282132232.513 [Startup:StartupSatComms:B] Stopped
2010-08-18T11:50:32.513Z,1282132232.513 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2010-08-18T11:50:32.513Z,1282132232.513 [Startup:StartupSatComms] Stopped
2010-08-18T11:50:32.513Z,1282132232.513 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2010-08-18T11:50:32.514Z,1282132232.514 [Startup](INFO): Completed Startup
2010-08-18T11:50:32.514Z,1282132232.514 [MissionManager](INFO): Startup is completed.
2010-08-18T11:50:32.514Z,1282132232.514 [MissionManager](INFO): Uninitializing Mission Startup
2010-08-18T11:50:32.515Z,1282132232.515 [Startup] Stopped
2010-08-18T11:50:32.515Z,1282132232.515 [Startup](DEBUG): Aggregate::uninitialize Startup
2010-08-18T11:50:32.515Z,1282132232.515 [Startup:A.GoToSurface] Stopped
2010-08-18T11:50:32.515Z,1282132232.515 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2010-08-18T11:50:32.911Z,1282132232.911 [MissionManager](IMPORTANT): Started mission Default
2010-08-18T11:50:32.911Z,1282132232.911 [Default] Running Loop=1
2010-08-18T11:50:32.911Z,1282132232.911 [Default](DEBUG): Aggregate::initialize Default
2010-08-18T11:50:32.911Z,1282132232.911 [Default:B.GoToSurface] Running Loop=1
2010-08-18T11:50:32.911Z,1282132232.911 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2010-08-18T11:50:32.912Z,1282132232.912 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2010-08-18T11:50:32.912Z,1282132232.912 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2010-08-18T11:50:32.912Z,1282132232.912 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2010-08-18T11:50:32.913Z,1282132232.913 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2010-08-18T11:50:32.913Z,1282132232.913 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2010-08-18T11:50:32.913Z,1282132232.913 [Default:A.Wait] Running Loop=1
2010-08-18T11:50:32.913Z,1282132232.913 [Default:A.Wait](DEBUG): Initialize Wait Component.
2010-08-18T11:50:34.031Z,1282132234.031 [DataOverHttps](INFO): Sending 1237 bytes from file Logs/20100818T114318/Express0001.lzma
2010-08-18T11:50:35.040Z,1282132235.040 [DataOverHttps](INFO): Moved sent file to Logs/20100818T114318/Express0001.lzma.bak
2010-08-18T11:50:35.040Z,1282132235.040 [DataOverHttps](INFO): SBD MOMSN=16171746
2010-08-18T11:50:43.034Z,1282132243.034 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2010-08-18T11:50:43.034Z,1282132243.034 [CTD_Seabird] Communications Fault, FailCount= 1
2010-08-18T11:50:43.034Z,1282132243.034 [CTD_Seabird](ERROR): Communications Fault
2010-08-18T11:50:43.183Z,1282132243.183 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2010-08-18T11:50:43.442Z,1282132243.442 [CTD_Seabird](INFO): Powering down
2010-08-18T11:50:44.440Z,1282132244.440 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2010-08-18T11:50:44.440Z,1282132244.440 [CTD_Seabird] No Fault, FailCount= 1
2010-08-18T11:50:44.790Z,1282132244.790 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2010-08-18T11:50:45.944Z,1282132245.944 [Default:A.Wait](INFO): Done Waiting.
2010-08-18T11:50:45.944Z,1282132245.944 [Default:A.Wait] Stopped
2010-08-18T11:50:45.944Z,1282132245.944 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2010-08-18T11:50:46.352Z,1282132246.352 [Default:CheckIn] Running Loop=1
2010-08-18T11:50:46.352Z,1282132246.352 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2010-08-18T11:50:46.352Z,1282132246.352 [Default:CheckIn:Read_GPS] Running Loop=1
2010-08-18T11:50:46.803Z,1282132246.803 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2010-08-18T11:50:56.103Z,1282132256.103 [CommandExec](IMPORTANT): got command restart application
2010-08-18T11:50:57.106Z,1282132257.106 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2010-08-18T11:50:57.106Z,1282132257.106 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2010-08-18T11:50:57.106Z,1282132257.106 [CommandExec](INFO): Uninitializing the command executive.
2010-08-18T11:50:57.106Z,1282132257.106 [CommandExec](INFO): Uninitializing the command scheduler.
2010-08-18T11:50:57.106Z,1282132257.106 [CommandExec ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:50:57.193Z,1282132257.193 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2010-08-18T11:50:57.194Z,1282132257.194 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2010-08-18T11:50:57.194Z,1282132257.194 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:50:57.194Z,1282132257.194 [NavChartDb](INFO): Join timeout helper Thread ID is 8900
2010-08-18T11:50:57.438Z,1282132257.438 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2010-08-18T11:50:57.438Z,1282132257.438 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:50:57.457Z,1282132257.457 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2010-08-18T11:50:57.458Z,1282132257.458 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:50:57.458Z,1282132257.458 [Radio_Surface](INFO): Join timeout helper Thread ID is 8901
2010-08-18T11:50:57.722Z,1282132257.722 [Radio_Surface](INFO): Powering down
2010-08-18T11:50:57.723Z,1282132257.723 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2010-08-18T11:50:57.723Z,1282132257.723 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:50:57.726Z,1282132257.726 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2010-08-18T11:50:57.726Z,1282132257.726 [Onboard ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:50:57.726Z,1282132257.726 [Onboard](INFO): Join timeout helper Thread ID is 8902
2010-08-18T11:50:58.282Z,1282132258.282 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2010-08-18T11:50:58.862Z,1282132258.862 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2010-08-18T11:50:58.862Z,1282132258.862 [CTD_Seabird] Communications Fault, FailCount= 2
2010-08-18T11:50:58.862Z,1282132258.862 [CTD_Seabird](ERROR): Communications Fault
2010-08-18T11:50:58.917Z,1282132258.917 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2010-08-18T11:50:59.266Z,1282132259.266 [CTD_Seabird](INFO): Powering down
2010-08-18T11:51:00.489Z,1282132260.489 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2010-08-18T11:51:00.490Z,1282132260.490 [CTD_Seabird] No Fault, FailCount= 2
2010-08-18T11:51:00.606Z,1282132260.606 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2010-08-18T11:51:02.066Z,1282132262.066 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2010-08-18T11:51:02.066Z,1282132262.066 [Onboard ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:51:02.079Z,1282132262.079 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2010-08-18T11:51:02.079Z,1282132262.079 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:51:02.079Z,1282132262.079 [DataOverHttps](INFO): Join timeout helper Thread ID is 8904
2010-08-18T11:51:02.298Z,1282132262.298 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2010-08-18T11:51:02.298Z,1282132262.298 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:51:02.305Z,1282132262.305 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2010-08-18T11:51:02.306Z,1282132262.306 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:51:02.306Z,1282132262.306 [BackseatComponent](INFO): Join timeout helper Thread ID is 8905
2010-08-18T11:51:02.502Z,1282132262.502 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2010-08-18T11:51:02.502Z,1282132262.502 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:51:02.510Z,1282132262.510 [ComponentRegistry](INFO): Shutting down WetLabsSeaOWL_UV_A ThreadHandler
2010-08-18T11:51:02.511Z,1282132262.511 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:51:02.511Z,1282132262.511 [WetLabsSeaOWL_UV_A](INFO): Join timeout helper Thread ID is 8906
2010-08-18T11:51:02.582Z,1282132262.582 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Uninitializing protected caller thread.
2010-08-18T11:51:02.582Z,1282132262.582 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:51:02.594Z,1282132262.594 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2010-08-18T11:51:02.594Z,1282132262.594 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:51:02.595Z,1282132262.595 [CTD_Seabird](INFO): Join timeout helper Thread ID is 8907
2010-08-18T11:51:02.614Z,1282132262.614 [CTD_Seabird](INFO): Powering down
2010-08-18T11:51:02.746Z,1282132262.746 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2010-08-18T11:51:02.746Z,1282132262.746 [CTD_Seabird](INFO): Powering down
2010-08-18T11:51:02.758Z,1282132262.758 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:51:02.778Z,1282132262.778 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2010-08-18T11:51:02.778Z,1282132262.778 [logger ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:51:02.779Z,1282132262.779 [logger](INFO): Join timeout helper Thread ID is 8908
2010-08-18T11:51:02.786Z,1282132262.786 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2010-08-18T11:51:02.786Z,1282132262.786 [logger ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:51:02.798Z,1282132262.798 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2010-08-18T11:51:02.798Z,1282132262.798 [CommandLine ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:51:02.799Z,1282132262.799 [CommandLine](INFO): Join timeout helper Thread ID is 8909
2010-08-18T11:51:02.802Z,1282132262.802 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2010-08-18T11:51:02.802Z,1282132262.802 [CommandLine ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:51:02.818Z,1282132262.818 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2010-08-18T11:51:02.819Z,1282132262.819 [CommandExec ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:51:02.819Z,1282132262.819 [CommandExec](INFO): Join timeout helper Thread ID is 8910
2010-08-18T11:51:02.820Z,1282132262.820 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2010-08-18T11:51:02.820Z,1282132262.820 [controlThread ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:51:02.821Z,1282132262.821 [controlThread](INFO): Join timeout helper Thread ID is 8911
2010-08-18T11:51:02.882Z,1282132262.882 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2010-08-18T11:51:02.882Z,1282132262.882 [controlThread](DEBUG): Uninitializing ControlThread
2010-08-18T11:51:02.884Z,1282132262.884 [NAL9602](INFO): Powering down
2010-08-18T11:51:02.885Z,1282132262.885 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2010-08-18T11:51:02.886Z,1282132262.886 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2010-08-18T11:51:02.887Z,1282132262.887 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2010-08-18T11:51:02.887Z,1282132262.887 [MissionManager](INFO): Uninitializing Mission Default
2010-08-18T11:51:02.887Z,1282132262.887 [Default] Stopped
2010-08-18T11:51:02.887Z,1282132262.887 [Default](DEBUG): Aggregate::uninitialize Default
2010-08-18T11:51:02.887Z,1282132262.887 [Default:B.GoToSurface] Stopped
2010-08-18T11:51:02.887Z,1282132262.887 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2010-08-18T11:51:02.888Z,1282132262.888 [Default:CheckIn] Stopped
2010-08-18T11:51:02.888Z,1282132262.888 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2010-08-18T11:51:02.888Z,1282132262.888 [Default:CheckIn:Read_GPS] Stopped
2010-08-18T11:51:02.891Z,1282132262.891 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2010-08-18T11:51:02.891Z,1282132262.891 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2010-08-18T11:51:02.891Z,1282132262.891 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2010-08-18T11:51:02.892Z,1282132262.892 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2010-08-18T11:51:02.892Z,1282132262.892 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2010-08-18T11:51:02.892Z,1282132262.892 [BuoyancyServo](INFO): Powering down
2010-08-18T11:51:02.906Z,1282132262.906 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2010-08-18T11:51:02.906Z,1282132262.906 [ElevatorServo](INFO): Powering down
2010-08-18T11:51:02.907Z,1282132262.907 [MassServo](DEBUG): Uninitialize Mass Servo.
2010-08-18T11:51:02.907Z,1282132262.907 [MassServo](INFO): Powering down
2010-08-18T11:51:02.908Z,1282132262.908 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2010-08-18T11:51:02.908Z,1282132262.908 [RudderServo](INFO): Powering down
2010-08-18T11:51:02.909Z,1282132262.909 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2010-08-18T11:51:02.909Z,1282132262.909 [ThrusterHE](INFO): Powering down
2010-08-18T11:51:02.910Z,1282132262.910 [SBIT](DEBUG): Uninitialize SBIT Component.
2010-08-18T11:51:02.910Z,1282132262.910 [IBIT](DEBUG): Uninitialize IBIT Component.
2010-08-18T11:51:02.910Z,1282132262.910 [CBIT](DEBUG): Uninitialize CBIT Component.
2010-08-18T11:51:02.911Z,1282132262.911 [CBIT](DEBUG): Powering off loads.
2010-08-18T11:51:02.921Z,1282132262.921 [CBIT](DEBUG): Disabling WDT.
2010-08-18T11:51:02.933Z,1282132262.933 [CBIT](DEBUG): Opening all GF detection circuits.
2010-08-18T11:51:02.934Z,1282132262.934 [controlThread ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:51:02.959Z,1282132262.959 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:51:02.963Z,1282132262.963 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:51:03.009Z,1282132263.009 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:51:03.011Z,1282132263.011 [Onboard ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:51:03.017Z,1282132263.017 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:51:03.060Z,1282132263.060 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:51:03.097Z,1282132263.097 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:51:03.159Z,1282132263.159 [logger ThreadHandler](INFO): Thread cancelled.