2010-08-18T11:09:38.158Z,1282129778.158 [Supervisor](DEBUG): Initializing supervisor.
2010-08-18T11:09:38.163Z,1282129778.163 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2010-08-18T11:09:38.164Z,1282129778.164 [SyncHandler](INFO): Protected caller Thread ID is 7610
2010-08-18T11:09:38.164Z,1282129778.164 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2010-08-18T11:09:38.166Z,1282129778.166 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2010-08-18T11:09:38.166Z,1282129778.166 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 7611
2010-08-18T11:09:38.171Z,1282129778.171 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2010-08-18T11:09:38.189Z,1282129778.189 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2010-08-18T11:09:38.190Z,1282129778.190 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2010-08-18T11:09:38.190Z,1282129778.190 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 7612
2010-08-18T11:09:38.195Z,1282129778.195 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2010-08-18T11:09:38.196Z,1282129778.196 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2010-08-18T11:09:38.196Z,1282129778.196 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 7613
2010-08-18T11:09:38.198Z,1282129778.198 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2010-08-18T11:09:38.199Z,1282129778.199 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2010-08-18T11:09:38.200Z,1282129778.200 [logger ThreadHandler](INFO): Protected caller Thread ID is 7614
2010-08-18T11:09:38.203Z,1282129778.203 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2010-08-18T11:09:38.204Z,1282129778.204 [Supervisor](INFO): Looking for Config files in directory: Config/
2010-08-18T11:09:38.206Z,1282129778.206 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2010-08-18T11:09:38.642Z,1282129778.642 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2010-08-18T11:09:38.643Z,1282129778.643 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2010-08-18T11:09:38.851Z,1282129778.851 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2010-08-18T11:09:38.852Z,1282129778.852 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2010-08-18T11:09:39.035Z,1282129779.035 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2010-08-18T11:09:39.035Z,1282129779.035 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2010-08-18T11:09:39.142Z,1282129779.142 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2010-08-18T11:09:39.142Z,1282129779.142 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2010-08-18T11:09:39.493Z,1282129779.493 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2010-08-18T11:09:39.494Z,1282129779.494 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2010-08-18T11:09:39.811Z,1282129779.811 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2010-08-18T11:09:39.812Z,1282129779.812 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2010-08-18T11:09:39.907Z,1282129779.907 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2010-08-18T11:09:39.908Z,1282129779.908 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2010-08-18T11:09:40.056Z,1282129780.056 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2010-08-18T11:09:40.057Z,1282129780.057 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2010-08-18T11:09:40.575Z,1282129780.575 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2010-08-18T11:09:40.576Z,1282129780.576 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2010-08-18T11:09:40.926Z,1282129780.926 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2010-08-18T11:09:40.927Z,1282129780.927 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2010-08-18T11:09:41.007Z,1282129781.007 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2010-08-18T11:09:41.207Z,1282129781.207 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2010-08-18T11:09:41.208Z,1282129781.208 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2010-08-18T11:09:41.333Z,1282129781.333 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2010-08-18T11:09:41.334Z,1282129781.334 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2010-08-18T11:09:41.979Z,1282129781.979 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2010-08-18T11:09:41.979Z,1282129781.979 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2010-08-18T11:09:42.058Z,1282129782.058 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2010-08-18T11:09:42.298Z,1282129782.298 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2010-08-18T11:09:42.300Z,1282129782.300 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/
2010-08-18T11:09:42.301Z,1282129782.301 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg
2010-08-18T11:09:42.465Z,1282129782.465 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg
2010-08-18T11:09:42.556Z,1282129782.556 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg
2010-08-18T11:09:42.666Z,1282129782.666 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg
2010-08-18T11:09:42.765Z,1282129782.765 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg
2010-08-18T11:09:42.847Z,1282129782.847 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg
2010-08-18T11:09:42.967Z,1282129782.967 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg
2010-08-18T11:09:43.079Z,1282129783.079 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg
2010-08-18T11:09:43.178Z,1282129783.178 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg
2010-08-18T11:09:43.315Z,1282129783.315 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg
2010-08-18T11:09:43.572Z,1282129783.572 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2010-08-18T11:09:43.573Z,1282129783.573 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg
2010-08-18T11:09:43.740Z,1282129783.740 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/root/
2010-08-18T11:09:43.740Z,1282129783.740 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2010-08-18T11:09:43.756Z,1282129783.756 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2010-08-18T11:09:44.368Z,1282129784.368 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2010-08-18T11:09:44.368Z,1282129784.368 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2010-08-18T11:09:44.450Z,1282129784.450 [DeadReckonUsingMultipleVelocitySources] Loaded
2010-08-18T11:09:44.450Z,1282129784.450 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2010-08-18T11:09:44.483Z,1282129784.483 [DeadReckonUsingSpeedCalculator] Loaded
2010-08-18T11:09:44.484Z,1282129784.484 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2010-08-18T11:09:44.497Z,1282129784.497 [NavChart] Loaded
2010-08-18T11:09:44.497Z,1282129784.497 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2010-08-18T11:09:44.503Z,1282129784.503 [UniversalFixResidualReporter] Loaded
2010-08-18T11:09:44.503Z,1282129784.503 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2010-08-18T11:09:44.503Z,1282129784.503 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2010-08-18T11:09:44.504Z,1282129784.504 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2010-08-18T11:09:44.515Z,1282129784.515 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2010-08-18T11:09:44.515Z,1282129784.515 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2010-08-18T11:09:44.708Z,1282129784.708 [CTD_Seabird] Loaded
2010-08-18T11:09:44.709Z,1282129784.709 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2010-08-18T11:09:44.710Z,1282129784.710 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406514E0
2010-08-18T11:09:44.710Z,1282129784.710 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 7696
2010-08-18T11:09:44.730Z,1282129784.730 [PAR_Licor] Loaded
2010-08-18T11:09:44.730Z,1282129784.730 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2010-08-18T11:09:44.762Z,1282129784.762 [WetLabsSeaOWL_UV_A] Loaded
2010-08-18T11:09:44.762Z,1282129784.762 [ComponentRegistry](DEBUG): Component "WetLabsSeaOWL_UV_A" handled in its own thread.
2010-08-18T11:09:44.763Z,1282129784.763 [WetLabsSeaOWL_UV_A ThreadHandler](DEBUG): Created PCaller Thread at 406814E0
2010-08-18T11:09:44.763Z,1282129784.763 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Protected caller Thread ID is 7697
2010-08-18T11:09:44.764Z,1282129784.764 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2010-08-18T11:09:44.765Z,1282129784.765 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2010-08-18T11:09:44.819Z,1282129784.819 [VerticalControl](DEBUG): Construct VerticalControl.
2010-08-18T11:09:44.881Z,1282129784.881 [VerticalControl] Loaded
2010-08-18T11:09:44.881Z,1282129784.881 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2010-08-18T11:09:44.884Z,1282129784.884 [HorizontalControl](DEBUG): Construct HorizontalControl.
2010-08-18T11:09:44.923Z,1282129784.923 [HorizontalControl] Loaded
2010-08-18T11:09:44.923Z,1282129784.923 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2010-08-18T11:09:44.926Z,1282129784.926 [SpeedControl](DEBUG): Construct SpeedControl.
2010-08-18T11:09:44.929Z,1282129784.929 [SpeedControl] Loaded
2010-08-18T11:09:44.929Z,1282129784.929 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2010-08-18T11:09:44.932Z,1282129784.932 [LoopControl](DEBUG): Construct LoopControl.
2010-08-18T11:09:44.932Z,1282129784.932 [LoopControl] Loaded
2010-08-18T11:09:44.933Z,1282129784.933 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2010-08-18T11:09:44.933Z,1282129784.933 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2010-08-18T11:09:44.934Z,1282129784.934 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2010-08-18T11:09:44.977Z,1282129784.977 [DepthRateCalculator] Loaded
2010-08-18T11:09:44.977Z,1282129784.977 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2010-08-18T11:09:44.982Z,1282129784.982 [PitchRateCalculator] Loaded
2010-08-18T11:09:44.982Z,1282129784.982 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2010-08-18T11:09:44.992Z,1282129784.992 [SpeedCalculator] Loaded
2010-08-18T11:09:44.992Z,1282129784.992 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2010-08-18T11:09:45.005Z,1282129785.005 [TempGradientCalculator] Loaded
2010-08-18T11:09:45.005Z,1282129785.005 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2010-08-18T11:09:45.010Z,1282129785.010 [YawRateCalculator] Loaded
2010-08-18T11:09:45.010Z,1282129785.010 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2010-08-18T11:09:45.027Z,1282129785.027 [ElevatorOffsetCalculator] Loaded
2010-08-18T11:09:45.027Z,1282129785.027 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2010-08-18T11:09:45.028Z,1282129785.028 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2010-08-18T11:09:45.028Z,1282129785.028 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2010-08-18T11:09:45.123Z,1282129785.123 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2010-08-18T11:09:45.123Z,1282129785.123 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2010-08-18T11:09:45.182Z,1282129785.182 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2010-08-18T11:09:45.183Z,1282129785.183 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2010-08-18T11:09:45.313Z,1282129785.313 [BuoyancyServo] Loaded
2010-08-18T11:09:45.314Z,1282129785.314 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2010-08-18T11:09:45.333Z,1282129785.333 [ElevatorServo] Loaded
2010-08-18T11:09:45.334Z,1282129785.334 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2010-08-18T11:09:45.352Z,1282129785.352 [MassServo] Loaded
2010-08-18T11:09:45.352Z,1282129785.352 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2010-08-18T11:09:45.371Z,1282129785.371 [RudderServo] Loaded
2010-08-18T11:09:45.371Z,1282129785.371 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2010-08-18T11:09:45.386Z,1282129785.386 [ThrusterHE] Loaded
2010-08-18T11:09:45.386Z,1282129785.386 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2010-08-18T11:09:45.386Z,1282129785.386 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2010-08-18T11:09:45.387Z,1282129785.387 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2010-08-18T11:09:45.493Z,1282129785.493 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2010-08-18T11:09:45.494Z,1282129785.494 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2010-08-18T11:09:45.858Z,1282129785.858 [BackseatComponent] Loaded
2010-08-18T11:09:45.859Z,1282129785.859 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2010-08-18T11:09:45.860Z,1282129785.860 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 40A494E0
2010-08-18T11:09:45.860Z,1282129785.860 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 7698
2010-08-18T11:09:45.863Z,1282129785.863 [LcmUniversalReporter] Loaded
2010-08-18T11:09:45.863Z,1282129785.863 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2010-08-18T11:09:46.679Z,1282129786.679 [BPC1] Loaded
2010-08-18T11:09:46.679Z,1282129786.679 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2010-08-18T11:09:46.757Z,1282129786.757 [DataOverHttps] Loaded
2010-08-18T11:09:46.758Z,1282129786.758 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2010-08-18T11:09:46.759Z,1282129786.759 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40A794E0
2010-08-18T11:09:46.759Z,1282129786.759 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 7699
2010-08-18T11:09:46.779Z,1282129786.779 [Depth_Keller] Loaded
2010-08-18T11:09:46.779Z,1282129786.779 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2010-08-18T11:09:46.840Z,1282129786.840 [NAL9602] Loaded
2010-08-18T11:09:46.840Z,1282129786.840 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2010-08-18T11:09:46.869Z,1282129786.869 [Onboard] Loaded
2010-08-18T11:09:46.870Z,1282129786.870 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2010-08-18T11:09:46.871Z,1282129786.871 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40AA94E0
2010-08-18T11:09:46.871Z,1282129786.871 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 7700
2010-08-18T11:09:46.884Z,1282129786.884 [Power24vConverter] Loaded
2010-08-18T11:09:46.885Z,1282129786.885 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2010-08-18T11:09:46.898Z,1282129786.898 [Radio_Surface] Loaded
2010-08-18T11:09:46.898Z,1282129786.898 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2010-08-18T11:09:46.899Z,1282129786.899 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40AD94E0
2010-08-18T11:09:46.899Z,1282129786.899 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 7701
2010-08-18T11:09:46.900Z,1282129786.900 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2010-08-18T11:09:46.901Z,1282129786.901 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2010-08-18T11:09:47.048Z,1282129787.048 [SBIT](DEBUG): Construct Startup Built In Test.
2010-08-18T11:09:47.057Z,1282129787.057 [SBIT] Loaded
2010-08-18T11:09:47.057Z,1282129787.057 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2010-08-18T11:09:47.060Z,1282129787.060 [IBIT](DEBUG): Construct Initiated Built In Test.
2010-08-18T11:09:47.074Z,1282129787.074 [IBIT] Loaded
2010-08-18T11:09:47.074Z,1282129787.074 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2010-08-18T11:09:47.080Z,1282129787.080 [CBIT](DEBUG): Construct Continuous Built In Test.
2010-08-18T11:09:47.181Z,1282129787.181 [CBIT] Loaded
2010-08-18T11:09:47.182Z,1282129787.182 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2010-08-18T11:09:47.182Z,1282129787.182 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2010-08-18T11:09:47.183Z,1282129787.183 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2010-08-18T11:09:47.212Z,1282129787.212 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2010-08-18T11:09:47.218Z,1282129787.218 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2010-08-18T11:09:47.221Z,1282129787.221 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2010-08-18T11:09:47.231Z,1282129787.231 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2010-08-18T11:09:47.232Z,1282129787.232 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B644E0
2010-08-18T11:09:47.233Z,1282129787.233 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 7702
2010-08-18T11:09:47.237Z,1282129787.237 [Supervisor](INFO): Main Thread ID is 6436
2010-08-18T11:09:47.237Z,1282129787.237 [Supervisor](DEBUG): Running supervisor.
2010-08-18T11:09:47.238Z,1282129787.238 [CommandExec ThreadHandler](INFO): Handler Thread ID is 7703
2010-08-18T11:09:47.239Z,1282129787.239 [CommandExec](INFO): Initializing the command executive.
2010-08-18T11:09:47.240Z,1282129787.240 [CommandLine ThreadHandler](INFO): Handler Thread ID is 7704
2010-08-18T11:09:47.242Z,1282129787.242 [controlThread ThreadHandler](INFO): Handler Thread ID is 7705
2010-08-18T11:09:47.243Z,1282129787.243 [controlThread](DEBUG): Initializing ControlThread
2010-08-18T11:09:47.244Z,1282129787.244 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2010-08-18T11:09:47.245Z,1282129787.245 [NavChart](DEBUG): Initialize NavChart Navigation.
2010-08-18T11:09:47.245Z,1282129787.245 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2010-08-18T11:09:47.250Z,1282129787.250 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2010-08-18T11:09:47.252Z,1282129787.252 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2010-08-18T11:09:47.253Z,1282129787.253 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2010-08-18T11:09:47.253Z,1282129787.253 [LoopControl](DEBUG): Initialize LoopControlComponent.
2010-08-18T11:09:47.254Z,1282129787.254 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2010-08-18T11:09:47.254Z,1282129787.254 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2010-08-18T11:09:47.255Z,1282129787.255 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2010-08-18T11:09:47.255Z,1282129787.255 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2010-08-18T11:09:47.256Z,1282129787.256 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2010-08-18T11:09:47.256Z,1282129787.256 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2010-08-18T11:09:47.262Z,1282129787.262 [SBIT](INFO): Initialize SBIT Component.
2010-08-18T11:09:47.263Z,1282129787.263 [SBIT](IMPORTANT): git: 2021-10-11a
2010-08-18T11:09:47.263Z,1282129787.263 [SBIT](INFO): git hash: 36f3a97de7a122c995f034a375e3cefac6406048
2010-08-18T11:09:47.264Z,1282129787.264 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2010-08-18T11:09:47.265Z,1282129787.265 [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:09:47.266Z,1282129787.266 [SBIT](INFO): Beginning SBIT in 20.000000 seconds.
2010-08-18T11:09:47.266Z,1282129787.266 [IBIT](INFO): Initialize IBIT Component.
2010-08-18T11:09:47.267Z,1282129787.267 [CBIT](DEBUG): Initialize CBIT Component.
2010-08-18T11:09:47.268Z,1282129787.268 [logger ThreadHandler](INFO): Handler Thread ID is 7706
2010-08-18T11:09:47.282Z,1282129787.282 [CBIT](DEBUG): Initialized mux pins.
2010-08-18T11:09:47.282Z,1282129787.282 [CBIT](DEBUG): Initializing the watchdog timer.
2010-08-18T11:09:47.286Z,1282129787.286 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 7707
2010-08-18T11:09:47.287Z,1282129787.287 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2010-08-18T11:09:47.292Z,1282129787.292 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Handler Thread ID is 7709
2010-08-18T11:09:47.302Z,1282129787.302 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 7710
2010-08-18T11:09:47.306Z,1282129787.306 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2010-08-18T11:09:47.306Z,1282129787.306 [CBIT](DEBUG): Initializing heartbeat.
2010-08-18T11:09:47.314Z,1282129787.314 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 7711
2010-08-18T11:09:47.315Z,1282129787.315 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2010-08-18T11:09:47.326Z,1282129787.326 [Onboard ThreadHandler](INFO): Handler Thread ID is 7712
2010-08-18T11:09:47.344Z,1282129787.344 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 7713
2010-08-18T11:09:47.366Z,1282129787.366 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 7714
2010-08-18T11:09:47.369Z,1282129787.369 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2010-08-18T11:09:47.369Z,1282129787.369 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2010-08-18T11:09:47.370Z,1282129787.370 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2010-08-18T11:09:47.370Z,1282129787.370 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2010-08-18T11:09:47.370Z,1282129787.370 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2010-08-18T11:09:47.370Z,1282129787.370 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2010-08-18T11:09:47.370Z,1282129787.370 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2010-08-18T11:09:47.371Z,1282129787.371 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2010-08-18T11:09:47.371Z,1282129787.371 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2010-08-18T11:09:47.371Z,1282129787.371 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2010-08-18T11:09:47.371Z,1282129787.371 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2010-08-18T11:09:47.371Z,1282129787.371 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2010-08-18T11:09:47.371Z,1282129787.371 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2010-08-18T11:09:47.372Z,1282129787.372 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2010-08-18T11:09:47.372Z,1282129787.372 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2010-08-18T11:09:47.372Z,1282129787.372 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2010-08-18T11:09:47.378Z,1282129787.378 [CBIT](DEBUG): Deactivating GF circuits.
2010-08-18T11:09:47.378Z,1282129787.378 [CBIT](DEBUG): Deactivating emergency mode.
2010-08-18T11:09:47.414Z,1282129787.414 [CBIT](DEBUG): Backplane powered.
2010-08-18T11:09:47.415Z,1282129787.415 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2010-08-18T11:09:47.428Z,1282129787.428 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2010-08-18T11:09:47.455Z,1282129787.455 [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:09:47.456Z,1282129787.456 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2010-08-18T11:09:47.550Z,1282129787.550 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2010-08-18T11:09:47.551Z,1282129787.551 [Default:A.Wait](DEBUG): Construct Wait.
2010-08-18T11:09:47.554Z,1282129787.554 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2010-08-18T11:09:47.585Z,1282129787.585 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2010-08-18T11:09:47.605Z,1282129787.605 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2010-08-18T11:09:47.637Z,1282129787.637 [Default:E.Execute](DEBUG): Construct Execute.
2010-08-18T11:09:47.640Z,1282129787.640 [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:09:47.655Z,1282129787.655 [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:09:47.720Z,1282129787.720 [Power24vConverter](INFO): Powering up.
2010-08-18T11:09:47.750Z,1282129787.750 [Radio_Surface](INFO): Powering up
2010-08-18T11:09:47.784Z,1282129787.784 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2010-08-18T11:09:47.790Z,1282129787.790 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2010-08-18T11:09:47.791Z,1282129787.791 [ElevatorServo](DEBUG): Initializing EZServoServo.
2010-08-18T11:09:47.798Z,1282129787.798 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2010-08-18T11:09:47.799Z,1282129787.799 [MassServo](DEBUG): Initializing EZServoServo.
2010-08-18T11:09:47.806Z,1282129787.806 [MassServo](DEBUG): Initializing MassServo.
2010-08-18T11:09:47.807Z,1282129787.807 [RudderServo](DEBUG): Initializing EZServoServo.
2010-08-18T11:09:47.818Z,1282129787.818 [RudderServo](DEBUG): Initializing RudderServo.
2010-08-18T11:09:47.819Z,1282129787.819 [ThrusterHE](INFO): Start
2010-08-18T11:09:47.819Z,1282129787.819 [ThrusterHE](DEBUG): Initializing EZServoServo.
2010-08-18T11:09:47.830Z,1282129787.830 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2010-08-18T11:09:48.112Z,1282129788.112 [ThrusterHE](INFO): Starting
2010-08-18T11:09:48.543Z,1282129788.543 [ThrusterHE](INFO): Starting
2010-08-18T11:09:49.015Z,1282129789.015 [ThrusterHE](INFO): Starting
2010-08-18T11:09:49.299Z,1282129789.299 [ThrusterHE](INFO): Starting
2010-08-18T11:09:49.703Z,1282129789.703 [ThrusterHE](INFO): Starting
2010-08-18T11:09:50.142Z,1282129790.142 [ThrusterHE](INFO): Starting
2010-08-18T11:09:50.606Z,1282129790.606 [ThrusterHE](INFO): Runnable
2010-08-18T11:09:50.607Z,1282129790.607 [ThrusterHE](INFO): Unexpected data on serial port:
tarting

2010-08-18T11:09:50.608Z,1282129790.608 [ThrusterHE](INFO): Send speed command forward:0000
2010-08-18T11:09:50.979Z,1282129790.979 [ThrusterHE](INFO): Pause
2010-08-18T11:09:51.443Z,1282129791.443 [ThrusterHE](INFO): Paused
2010-08-18T11:09:51.795Z,1282129791.795 [ThrusterHE](INFO): Paused
2010-08-18T11:09:52.179Z,1282129792.179 [ThrusterHE](INFO): Paused
2010-08-18T11:09:52.590Z,1282129792.590 [ThrusterHE](INFO): Paused
2010-08-18T11:09:52.994Z,1282129792.994 [ThrusterHE](INFO): Paused
2010-08-18T11:09:53.531Z,1282129793.531 [ThrusterHE](INFO): Paused
2010-08-18T11:09:53.846Z,1282129793.846 [ThrusterHE](INFO): Paused
2010-08-18T11:09:54.294Z,1282129794.294 [ThrusterHE](INFO): Paused
2010-08-18T11:09:54.582Z,1282129794.582 [ThrusterHE](INFO): Paused
2010-08-18T11:09:54.990Z,1282129794.990 [ThrusterHE](INFO): Paused
2010-08-18T11:09:55.386Z,1282129795.386 [ThrusterHE](INFO): Paused
2010-08-18T11:09:55.794Z,1282129795.794 [ThrusterHE](INFO): Paused
2010-08-18T11:09:56.254Z,1282129796.254 [ThrusterHE](INFO): Paused
2010-08-18T11:09:56.606Z,1282129796.606 [ThrusterHE](INFO): Paused
2010-08-18T11:09:57.002Z,1282129797.002 [ThrusterHE](INFO): Paused
2010-08-18T11:09:57.434Z,1282129797.434 [ThrusterHE](INFO): Paused
2010-08-18T11:09:57.847Z,1282129797.847 [ThrusterHE](INFO): Paused
2010-08-18T11:09:58.222Z,1282129798.222 [ThrusterHE](INFO): Paused
2010-08-18T11:09:58.619Z,1282129798.619 [ThrusterHE](INFO): Paused
2010-08-18T11:09:59.123Z,1282129799.123 [ThrusterHE](INFO): Paused
2010-08-18T11:09:59.534Z,1282129799.534 [ThrusterHE](INFO): Paused
2010-08-18T11:09:59.812Z,1282129799.812 [ThrusterHE](INFO): Paused
2010-08-18T11:10:00.224Z,1282129800.224 [ThrusterHE](INFO): Paused
2010-08-18T11:10:00.354Z,1282129800.354 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2010-08-18T11:10:00.354Z,1282129800.354 [CTD_Seabird] Communications Fault, FailCount= 1
2010-08-18T11:10:00.354Z,1282129800.354 [CTD_Seabird](ERROR): Communications Fault
2010-08-18T11:10:00.617Z,1282129800.617 [ThrusterHE](INFO): Paused
2010-08-18T11:10:00.636Z,1282129800.636 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2010-08-18T11:10:00.759Z,1282129800.759 [CTD_Seabird](INFO): Powering down
2010-08-18T11:10:01.020Z,1282129801.020 [ThrusterHE](INFO): Paused
2010-08-18T11:10:01.420Z,1282129801.420 [ThrusterHE](INFO): Paused
2010-08-18T11:10:01.832Z,1282129801.832 [ThrusterHE](INFO): Paused
2010-08-18T11:10:01.835Z,1282129801.835 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2010-08-18T11:10:01.835Z,1282129801.835 [CTD_Seabird] No Fault, FailCount= 1
2010-08-18T11:10:02.102Z,1282129802.102 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2010-08-18T11:10:02.236Z,1282129802.236 [ThrusterHE](INFO): Paused
2010-08-18T11:10:02.640Z,1282129802.640 [ThrusterHE](INFO): Paused
2010-08-18T11:10:03.044Z,1282129803.044 [ThrusterHE](INFO): Paused
2010-08-18T11:10:03.448Z,1282129803.448 [ThrusterHE](INFO): Paused
2010-08-18T11:10:03.897Z,1282129803.897 [ThrusterHE](INFO): Paused
2010-08-18T11:10:04.249Z,1282129804.249 [ThrusterHE](INFO): Paused
2010-08-18T11:10:04.660Z,1282129804.660 [ThrusterHE](INFO): Paused
2010-08-18T11:10:05.064Z,1282129805.064 [ThrusterHE](INFO): Paused
2010-08-18T11:10:05.460Z,1282129805.460 [ThrusterHE](INFO): Paused
2010-08-18T11:10:05.873Z,1282129805.873 [ThrusterHE](INFO): Paused
2010-08-18T11:10:06.272Z,1282129806.272 [ThrusterHE](INFO): Paused
2010-08-18T11:10:06.672Z,1282129806.672 [ThrusterHE](INFO): Paused
2010-08-18T11:10:07.088Z,1282129807.088 [ThrusterHE](INFO): Paused
2010-08-18T11:10:07.516Z,1282129807.516 [ThrusterHE](INFO): Paused
2010-08-18T11:10:07.884Z,1282129807.884 [ThrusterHE](INFO): Paused
2010-08-18T11:10:07.885Z,1282129807.885 [SBIT](IMPORTANT): Beginning Startup BIT
2010-08-18T11:10:07.901Z,1282129807.901 [CBIT](IMPORTANT): Beginning ground fault scan
2010-08-18T11:10:08.367Z,1282129808.367 [ThrusterHE](INFO): Paused
2010-08-18T11:10:08.759Z,1282129808.759 [ThrusterHE](INFO): Paused
2010-08-18T11:10:09.139Z,1282129809.139 [ThrusterHE](INFO): Paused
2010-08-18T11:10:09.646Z,1282129809.646 [ThrusterHE](INFO): Paused
2010-08-18T11:10:10.050Z,1282129810.050 [ThrusterHE](INFO): Paused
2010-08-18T11:10:10.411Z,1282129810.411 [ThrusterHE](INFO): Paused
2010-08-18T11:10:10.811Z,1282129810.811 [ThrusterHE](INFO): Paused
2010-08-18T11:10:11.227Z,1282129811.227 [ThrusterHE](INFO): Paused
2010-08-18T11:10:11.614Z,1282129811.614 [ThrusterHE](INFO): Paused
2010-08-18T11:10:12.010Z,1282129812.010 [ThrusterHE](INFO): Paused
2010-08-18T11:10:12.506Z,1282129812.506 [ThrusterHE](INFO): Paused
2010-08-18T11:10:12.942Z,1282129812.942 [ThrusterHE](INFO): Paused
2010-08-18T11:10:13.203Z,1282129813.203 [ThrusterHE](INFO): Paused
2010-08-18T11:10:13.647Z,1282129813.647 [ThrusterHE](INFO): Paused
2010-08-18T11:10:14.115Z,1282129814.115 [ThrusterHE](INFO): Paused
2010-08-18T11:10:14.387Z,1282129814.387 [ThrusterHE](INFO): Paused
2010-08-18T11:10:14.802Z,1282129814.802 [ThrusterHE](INFO): Paused
2010-08-18T11:10:15.167Z,1282129815.167 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2010-08-18T11:10:15.168Z,1282129815.168 [CTD_Seabird] Communications Fault, FailCount= 2
2010-08-18T11:10:15.168Z,1282129815.168 [CTD_Seabird](ERROR): Communications Fault
2010-08-18T11:10:15.199Z,1282129815.199 [ThrusterHE](INFO): Paused
2010-08-18T11:10:15.203Z,1282129815.203 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2010-08-18T11:10:15.570Z,1282129815.570 [CTD_Seabird](INFO): Powering down
2010-08-18T11:10:15.620Z,1282129815.620 [ThrusterHE](INFO): Paused
2010-08-18T11:10:16.032Z,1282129816.032 [ThrusterHE](INFO): Paused
2010-08-18T11:10:16.411Z,1282129816.411 [ThrusterHE](INFO): Paused
2010-08-18T11:10:16.822Z,1282129816.822 [ThrusterHE](INFO): Paused
2010-08-18T11:10:16.827Z,1282129816.827 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2010-08-18T11:10:16.827Z,1282129816.827 [CTD_Seabird] No Fault, FailCount= 2
2010-08-18T11:10:16.914Z,1282129816.914 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2010-08-18T11:10:17.159Z,1282129817.159 [NAL9602](INFO): Powering up NAL9602
2010-08-18T11:10:17.238Z,1282129817.238 [ThrusterHE](INFO): Paused
2010-08-18T11:10:17.639Z,1282129817.639 [ThrusterHE](INFO): Paused
2010-08-18T11:10:18.012Z,1282129818.012 [ThrusterHE](INFO): Paused
2010-08-18T11:10:18.439Z,1282129818.439 [ThrusterHE](INFO): Paused
2010-08-18T11:10:18.851Z,1282129818.851 [ThrusterHE](INFO): Paused
2010-08-18T11:10:18.859Z,1282129818.859 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.030566
CHAN A1 (24V): 0.000365
CHAN A2 (12V): -0.005694
CHAN A3 (5V): -0.003211
CHAN B0 (3.3V): -0.000752
CHAN B1 (3.15aV): -0.001581
CHAN B2 (3.15bV): -0.001532
CHAN B3 (GND): -0.000282
OPEN: -0.000994
Full Scale: +/- 1 mA
2010-08-18T11:10:19.230Z,1282129819.230 [ThrusterHE](INFO): Paused
2010-08-18T11:10:19.632Z,1282129819.632 [ThrusterHE](INFO): Paused
2010-08-18T11:10:20.134Z,1282129820.134 [ThrusterHE](INFO): Paused
2010-08-18T11:10:20.436Z,1282129820.436 [ThrusterHE](INFO): Paused
2010-08-18T11:10:20.827Z,1282129820.827 [ThrusterHE](INFO): Paused
2010-08-18T11:10:21.228Z,1282129821.228 [ThrusterHE](INFO): Paused
2010-08-18T11:10:21.632Z,1282129821.632 [ThrusterHE](INFO): Paused
2010-08-18T11:10:22.046Z,1282129822.046 [ThrusterHE](INFO): Paused
2010-08-18T11:10:22.450Z,1282129822.450 [ThrusterHE](INFO): Paused
2010-08-18T11:10:22.900Z,1282129822.900 [ThrusterHE](INFO): Paused
2010-08-18T11:10:23.430Z,1282129823.430 [ThrusterHE](INFO): Paused
2010-08-18T11:10:23.739Z,1282129823.739 [ThrusterHE](INFO): Paused
2010-08-18T11:10:24.139Z,1282129824.139 [ThrusterHE](INFO): Paused
2010-08-18T11:10:24.550Z,1282129824.550 [ThrusterHE](INFO): Paused
2010-08-18T11:10:24.970Z,1282129824.970 [ThrusterHE](INFO): Paused
2010-08-18T11:10:25.355Z,1282129825.355 [ThrusterHE](INFO): Paused
2010-08-18T11:10:25.767Z,1282129825.767 [ThrusterHE](INFO): Paused
2010-08-18T11:10:26.170Z,1282129826.170 [ThrusterHE](INFO): Paused
2010-08-18T11:10:26.574Z,1282129826.574 [ThrusterHE](INFO): Paused
2010-08-18T11:10:26.982Z,1282129826.982 [ThrusterHE](INFO): Paused
2010-08-18T11:10:27.371Z,1282129827.371 [ThrusterHE](INFO): Paused
2010-08-18T11:10:27.790Z,1282129827.790 [ThrusterHE](INFO): Paused
2010-08-18T11:10:28.063Z,1282129828.063 [NAL9602](INFO): NAL9602 initialized
2010-08-18T11:10:28.186Z,1282129828.186 [ThrusterHE](INFO): Paused
2010-08-18T11:10:28.674Z,1282129828.674 [ThrusterHE](INFO): Paused
2010-08-18T11:10:29.186Z,1282129829.186 [ThrusterHE](INFO): Paused
2010-08-18T11:10:29.363Z,1282129829.363 [ThrusterHE](INFO): Paused
2010-08-18T11:10:29.759Z,1282129829.759 [ThrusterHE](INFO): Paused
2010-08-18T11:10:29.966Z,1282129829.966 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2010-08-18T11:10:29.966Z,1282129829.966 [CTD_Seabird] Communications Fault, FailCount= 3
2010-08-18T11:10:29.966Z,1282129829.966 [CTD_Seabird](ERROR): Communications Fault
2010-08-18T11:10:30.150Z,1282129830.150 [ThrusterHE](INFO): Paused
2010-08-18T11:10:30.155Z,1282129830.155 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2010-08-18T11:10:30.155Z,1282129830.155 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2010-08-18T11:10:30.370Z,1282129830.370 [CTD_Seabird](INFO): Powering down
2010-08-18T11:10:30.551Z,1282129830.551 [ThrusterHE](INFO): Paused
2010-08-18T11:10:30.942Z,1282129830.942 [ThrusterHE](INFO): Paused
2010-08-18T11:10:31.362Z,1282129831.362 [ThrusterHE](INFO): Paused
2010-08-18T11:10:31.764Z,1282129831.764 [ThrusterHE](INFO): Paused
2010-08-18T11:10:32.186Z,1282129832.186 [ThrusterHE](INFO): Paused
2010-08-18T11:10:32.592Z,1282129832.592 [ThrusterHE](INFO): Paused
2010-08-18T11:10:32.975Z,1282129832.975 [ThrusterHE](INFO): Paused
2010-08-18T11:10:33.378Z,1282129833.378 [ThrusterHE](INFO): Paused
2010-08-18T11:10:33.778Z,1282129833.778 [ThrusterHE](INFO): Paused
2010-08-18T11:10:34.195Z,1282129834.195 [ThrusterHE](INFO): Paused
2010-08-18T11:10:34.620Z,1282129834.620 [ThrusterHE](INFO): Paused
2010-08-18T11:10:34.996Z,1282129834.996 [ThrusterHE](INFO): Paused
2010-08-18T11:10:35.395Z,1282129835.395 [ThrusterHE](INFO): Paused
2010-08-18T11:10:35.824Z,1282129835.824 [ThrusterHE](INFO): Paused
2010-08-18T11:10:36.206Z,1282129836.206 [ThrusterHE](INFO): Paused
2010-08-18T11:10:36.639Z,1282129836.639 [ThrusterHE](INFO): Paused
2010-08-18T11:10:37.020Z,1282129837.020 [ThrusterHE](INFO): Paused
2010-08-18T11:10:37.439Z,1282129837.439 [ThrusterHE](INFO): Paused
2010-08-18T11:10:37.847Z,1282129837.847 [ThrusterHE](INFO): Paused
2010-08-18T11:10:38.247Z,1282129838.247 [ThrusterHE](INFO): Paused
2010-08-18T11:10:38.614Z,1282129838.614 [ThrusterHE](INFO): Paused
2010-08-18T11:10:39.007Z,1282129839.007 [ThrusterHE](INFO): Paused
2010-08-18T11:10:39.426Z,1282129839.426 [ThrusterHE](INFO): Paused
2010-08-18T11:10:39.833Z,1282129839.833 [ThrusterHE](INFO): Paused
2010-08-18T11:10:40.322Z,1282129840.322 [ThrusterHE](INFO): Paused
2010-08-18T11:10:40.615Z,1282129840.615 [ThrusterHE](INFO): Paused
2010-08-18T11:10:41.008Z,1282129841.008 [ThrusterHE](INFO): Paused
2010-08-18T11:10:41.406Z,1282129841.406 [ThrusterHE](INFO): Paused
2010-08-18T11:10:41.829Z,1282129841.829 [ThrusterHE](INFO): Paused
2010-08-18T11:10:42.233Z,1282129842.233 [ThrusterHE](INFO): Paused
2010-08-18T11:10:42.645Z,1282129842.645 [ThrusterHE](INFO): Paused
2010-08-18T11:10:43.041Z,1282129843.041 [ThrusterHE](INFO): Paused
2010-08-18T11:10:43.432Z,1282129843.432 [ThrusterHE](INFO): Paused
2010-08-18T11:10:43.841Z,1282129843.841 [ThrusterHE](INFO): Paused
2010-08-18T11:10:44.254Z,1282129844.254 [ThrusterHE](INFO): Paused
2010-08-18T11:10:44.644Z,1282129844.644 [ThrusterHE](INFO): Paused
2010-08-18T11:10:45.042Z,1282129845.042 [ThrusterHE](INFO): Paused
2010-08-18T11:10:45.453Z,1282129845.453 [ThrusterHE](INFO): Paused
2010-08-18T11:10:45.867Z,1282129845.867 [ThrusterHE](INFO): Paused
2010-08-18T11:10:46.260Z,1282129846.260 [ThrusterHE](INFO): Paused
2010-08-18T11:10:46.664Z,1282129846.664 [ThrusterHE](INFO): Paused
2010-08-18T11:10:47.081Z,1282129847.081 [ThrusterHE](INFO): Paused
2010-08-18T11:10:47.489Z,1282129847.489 [ThrusterHE](INFO): Paused
2010-08-18T11:10:47.928Z,1282129847.928 [ThrusterHE](INFO): Paused
2010-08-18T11:10:48.322Z,1282129848.322 [ThrusterHE](INFO): Paused
2010-08-18T11:10:48.701Z,1282129848.701 [ThrusterHE](INFO): Paused
2010-08-18T11:10:49.100Z,1282129849.100 [ThrusterHE](INFO): Paused
2010-08-18T11:10:49.495Z,1282129849.495 [ThrusterHE](INFO): Paused
2010-08-18T11:10:50.066Z,1282129850.066 [ThrusterHE](INFO): Paused
2010-08-18T11:10:50.422Z,1282129850.422 [ThrusterHE](INFO): Paused
2010-08-18T11:10:50.798Z,1282129850.798 [ThrusterHE](INFO): Paused
2010-08-18T11:10:51.198Z,1282129851.198 [ThrusterHE](INFO): Paused
2010-08-18T11:10:51.594Z,1282129851.594 [ThrusterHE](INFO): Paused
2010-08-18T11:10:52.003Z,1282129852.003 [ThrusterHE](INFO): Paused
2010-08-18T11:10:52.426Z,1282129852.426 [ThrusterHE](INFO): Paused
2010-08-18T11:10:52.906Z,1282129852.906 [ThrusterHE](INFO): Paused
2010-08-18T11:10:53.422Z,1282129853.422 [ThrusterHE](INFO): Paused
2010-08-18T11:10:53.575Z,1282129853.575 [ThrusterHE](INFO): Paused
2010-08-18T11:10:53.967Z,1282129853.967 [ThrusterHE](INFO): Paused
2010-08-18T11:10:54.371Z,1282129854.371 [ThrusterHE](INFO): Paused
2010-08-18T11:10:54.771Z,1282129854.771 [ThrusterHE](INFO): Paused
2010-08-18T11:10:55.187Z,1282129855.187 [ThrusterHE](INFO): Paused
2010-08-18T11:10:55.614Z,1282129855.614 [ThrusterHE](INFO): Paused
2010-08-18T11:10:55.995Z,1282129855.995 [ThrusterHE](INFO): Paused
2010-08-18T11:10:56.407Z,1282129856.407 [ThrusterHE](INFO): Paused
2010-08-18T11:10:56.799Z,1282129856.799 [ThrusterHE](INFO): Paused
2010-08-18T11:10:57.199Z,1282129857.199 [ThrusterHE](INFO): Paused
2010-08-18T11:10:57.615Z,1282129857.615 [ThrusterHE](INFO): Paused
2010-08-18T11:10:58.122Z,1282129858.122 [ThrusterHE](INFO): Paused
2010-08-18T11:10:58.401Z,1282129858.401 [ThrusterHE](INFO): Paused
2010-08-18T11:10:58.797Z,1282129858.797 [ThrusterHE](INFO): Paused
2010-08-18T11:10:59.199Z,1282129859.199 [ThrusterHE](INFO): Paused
2010-08-18T11:10:59.587Z,1282129859.587 [ThrusterHE](INFO): Paused
2010-08-18T11:10:59.997Z,1282129859.997 [ThrusterHE](INFO): Paused
2010-08-18T11:11:00.399Z,1282129860.399 [ThrusterHE](INFO): Paused
2010-08-18T11:11:00.814Z,1282129860.814 [ThrusterHE](INFO): Paused
2010-08-18T11:11:01.210Z,1282129861.210 [ThrusterHE](INFO): Paused
2010-08-18T11:11:01.613Z,1282129861.613 [ThrusterHE](INFO): Paused
2010-08-18T11:11:02.022Z,1282129862.022 [ThrusterHE](INFO): Paused
2010-08-18T11:11:02.023Z,1282129862.023 [SBIT](IMPORTANT): SBIT PASSED
2010-08-18T11:11:02.023Z,1282129862.023 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2010-08-18T11:11:02.024Z,1282129862.024 [SBIT](IMPORTANT): AHRS_M2.loadAtStartup=0 bool;

2010-08-18T11:11:02.024Z,1282129862.024 [SBIT](IMPORTANT): BackseatComponent.loadAtStartup=1 bool;

2010-08-18T11:11:02.025Z,1282129862.025 [SBIT](IMPORTANT): CBIT.gf24Offset=149 microampere;

2010-08-18T11:11:02.025Z,1282129862.025 [SBIT](IMPORTANT): CTD_NeilBrown.loadAtStartup=0 bool;

2010-08-18T11:11:02.025Z,1282129862.025 [SBIT](IMPORTANT): CTD_Seabird.loadAtStartup=1 bool;

2010-08-18T11:11:02.025Z,1282129862.025 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool;

2010-08-18T11:11:02.025Z,1282129862.025 [SBIT](IMPORTANT): IBIT.batteryCapacityThreshold=5 ampere_hour;

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

2010-08-18T11:11:02.038Z,1282129862.038 [SBIT](IMPORTANT): NAL9602.fastGPSFix=1 bool;

2010-08-18T11:11:02.038Z,1282129862.038 [SBIT](IMPORTANT): PAR_Licor.adcCal=8.76539e-06 microampere_per_count;

2010-08-18T11:11:02.038Z,1282129862.038 [SBIT](IMPORTANT): PAR_Licor.darkCount=4 count;

2010-08-18T11:11:02.038Z,1282129862.038 [SBIT](IMPORTANT): PAR_Licor.loadAtStartup=1 bool;

2010-08-18T11:11:02.038Z,1282129862.038 [SBIT](IMPORTANT): PAR_Licor.multiplier=269.34 micromole_per_second_per_square_meter_per_microampere;

2010-08-18T11:11:02.038Z,1282129862.038 [SBIT](IMPORTANT): PAR_Licor.parCal=1.221 none;

2010-08-18T11:11:02.038Z,1282129862.038 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=235 cubic_centimeter;

2010-08-18T11:11:02.039Z,1282129862.039 [SBIT](IMPORTANT): VerticalControl.massDefault=0 centimeter;

2010-08-18T11:11:02.039Z,1282129862.039 [SBIT](IMPORTANT): VerticalControl.massPositionLimitAft=-27 millimeter;

2010-08-18T11:11:02.039Z,1282129862.039 [SBIT](IMPORTANT): VerticalControl.massPositionLimitFwd=37 millimeter;

2010-08-18T11:11:02.424Z,1282129862.424 [MissionManager](IMPORTANT): Started mission Startup
2010-08-18T11:11:02.424Z,1282129862.424 [Startup] Running Loop=1
2010-08-18T11:11:02.425Z,1282129862.425 [Startup](DEBUG): Aggregate::initialize Startup
2010-08-18T11:11:02.425Z,1282129862.425 [Startup:A.GoToSurface] Running Loop=1
2010-08-18T11:11:02.425Z,1282129862.425 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2010-08-18T11:11:02.426Z,1282129862.426 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2010-08-18T11:11:02.426Z,1282129862.426 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2010-08-18T11:11:02.426Z,1282129862.426 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2010-08-18T11:11:02.427Z,1282129862.427 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2010-08-18T11:11:02.427Z,1282129862.427 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2010-08-18T11:11:02.429Z,1282129862.429 [Startup:StartupSatComms] Running Loop=1
2010-08-18T11:11:02.429Z,1282129862.429 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2010-08-18T11:11:02.429Z,1282129862.429 [Startup:StartupSatComms:A] Running Loop=1
2010-08-18T11:11:02.483Z,1282129862.483 [ThrusterHE](INFO): Paused
2010-08-18T11:11:02.852Z,1282129862.852 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2010-08-18T11:11:02.859Z,1282129862.859 [ThrusterHE](INFO): Paused
2010-08-18T11:11:03.246Z,1282129863.246 [ThrusterHE](INFO): Paused
2010-08-18T11:11:03.651Z,1282129863.651 [ThrusterHE](INFO): Paused
2010-08-18T11:11:04.055Z,1282129864.055 [ThrusterHE](INFO): Paused
2010-08-18T11:11:04.443Z,1282129864.443 [ThrusterHE](INFO): Paused
2010-08-18T11:11:04.848Z,1282129864.848 [ThrusterHE](INFO): Paused
2010-08-18T11:11:05.251Z,1282129865.251 [ThrusterHE](INFO): Paused
2010-08-18T11:11:05.670Z,1282129865.670 [ThrusterHE](INFO): Paused
2010-08-18T11:11:06.088Z,1282129866.088 [ThrusterHE](INFO): Paused
2010-08-18T11:11:06.472Z,1282129866.472 [ThrusterHE](INFO): Paused
2010-08-18T11:11:06.867Z,1282129866.867 [ThrusterHE](INFO): Paused
2010-08-18T11:11:07.301Z,1282129867.301 [ThrusterHE](INFO): Paused
2010-08-18T11:11:07.705Z,1282129867.705 [ThrusterHE](INFO): Paused
2010-08-18T11:11:08.112Z,1282129868.112 [ThrusterHE](INFO): Paused
2010-08-18T11:11:08.505Z,1282129868.505 [ThrusterHE](INFO): Paused
2010-08-18T11:11:08.958Z,1282129868.958 [ThrusterHE](INFO): Paused
2010-08-18T11:11:09.341Z,1282129869.341 [ThrusterHE](INFO): Paused
2010-08-18T11:11:09.708Z,1282129869.708 [ThrusterHE](INFO): Paused
2010-08-18T11:11:10.110Z,1282129870.110 [ThrusterHE](INFO): Paused
2010-08-18T11:11:10.503Z,1282129870.503 [ThrusterHE](INFO): Paused
2010-08-18T11:11:10.920Z,1282129870.920 [ThrusterHE](INFO): Paused
2010-08-18T11:11:11.310Z,1282129871.310 [ThrusterHE](INFO): Paused
2010-08-18T11:11:11.715Z,1282129871.715 [ThrusterHE](INFO): Paused
2010-08-18T11:11:12.122Z,1282129872.122 [ThrusterHE](INFO): Paused
2010-08-18T11:11:12.536Z,1282129872.536 [ThrusterHE](INFO): Paused
2010-08-18T11:11:12.923Z,1282129872.923 [ThrusterHE](INFO): Paused
2010-08-18T11:11:13.368Z,1282129873.368 [ThrusterHE](INFO): Paused
2010-08-18T11:11:13.769Z,1282129873.769 [ThrusterHE](INFO): Paused
2010-08-18T11:11:14.166Z,1282129874.166 [ThrusterHE](INFO): Paused
2010-08-18T11:11:14.295Z,1282129874.295 [CommandExec](IMPORTANT): got command maintain control SpeedControl.propOmegaAction 300.000000 revolution_per_minute
2010-08-18T11:11:14.299Z,1282129874.299 [ComponentRegistry](DEBUG): SyncComponent "Maintain_SpeedControl.propOmegaAction" handled in the control thread.
2010-08-18T11:11:14.565Z,1282129874.565 [ThrusterHE](INFO): Paused
2010-08-18T11:11:14.576Z,1282129874.576 [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:11:14.946Z,1282129874.946 [ThrusterHE](INFO): Paused
2010-08-18T11:11:14.947Z,1282129874.947 [ThrusterHE](INFO): Resume
2010-08-18T11:11:15.352Z,1282129875.352 [ThrusterHE](INFO): Resuming
2010-08-18T11:11:15.763Z,1282129875.763 [ThrusterHE](INFO): Runnable
2010-08-18T11:11:15.768Z,1282129875.768 [ThrusterHE](INFO): Send speed command forward:00FF
2010-08-18T11:11:16.158Z,1282129876.158 [ThrusterHE](INFO): Runnable
2010-08-18T11:11:16.158Z,1282129876.158 [ThrusterHE](INFO): Unexpected data on serial port:Ftarting

2010-08-18T11:11:16.563Z,1282129876.563 [ThrusterHE](INFO): Runnable
2010-08-18T11:11:16.563Z,1282129876.563 [ThrusterHE](INFO): Unexpected data on serial port:Wtarting

2010-08-18T11:11:16.968Z,1282129876.968 [ThrusterHE](INFO): Runnable
2010-08-18T11:11:16.968Z,1282129876.968 [ThrusterHE](INFO): Unexpected data on serial port:,tarting

2010-08-18T11:11:17.381Z,1282129877.381 [ThrusterHE](INFO): Runnable
2010-08-18T11:11:17.381Z,1282129877.381 [ThrusterHE](INFO): Unexpected data on serial port:0tarting

2010-08-18T11:11:17.385Z,1282129877.385 [ThrusterHE](INFO): Speed is bad
2010-08-18T11:11:17.778Z,1282129877.778 [ThrusterHE](INFO): Runnable
2010-08-18T11:11:17.779Z,1282129877.779 [ThrusterHE](INFO): Unexpected data on serial port:
FF

Starting

>

2010-08-18T11:11:17.781Z,1282129877.781 [ThrusterHE](INFO): Send speed command forward:00FF
2010-08-18T11:11:18.186Z,1282129878.186 [ThrusterHE](INFO): Runnable
2010-08-18T11:11:18.186Z,1282129878.186 [ThrusterHE](INFO): Unexpected data on serial port:>FF

Starting

>

2010-08-18T11:11:18.602Z,1282129878.602 [ThrusterHE](INFO): Runnable
2010-08-18T11:11:18.602Z,1282129878.602 [ThrusterHE](INFO): Unexpected data on serial port:RFF

Starting

>

2010-08-18T11:11:19.007Z,1282129879.007 [ThrusterHE](INFO): Runnable
2010-08-18T11:11:19.007Z,1282129879.007 [ThrusterHE](INFO): Unexpected data on serial port:WFF

Starting

>

2010-08-18T11:11:19.420Z,1282129879.420 [ThrusterHE](INFO): Runnable
2010-08-18T11:11:19.421Z,1282129879.421 [ThrusterHE](INFO): Unexpected data on serial port:,FF

Starting

>

2010-08-18T11:11:19.423Z,1282129879.423 [ThrusterHE](INFO): Speed is bad
2010-08-18T11:11:19.806Z,1282129879.806 [ThrusterHE](INFO): Runnable
2010-08-18T11:11:19.807Z,1282129879.807 [ThrusterHE](INFO): Unexpected data on serial port:
8

002F

2010-08-18T11:11:19.809Z,1282129879.809 [ThrusterHE](INFO): Send speed command forward:00FF
2010-08-18T11:11:20.209Z,1282129880.209 [ThrusterHE](INFO): Runnable
2010-08-18T11:11:20.209Z,1282129880.209 [ThrusterHE](INFO): Unexpected data on serial port:>8

002F

2010-08-18T11:11:20.608Z,1282129880.608 [ThrusterHE](INFO): Runnable
2010-08-18T11:11:20.608Z,1282129880.608 [ThrusterHE](INFO): Unexpected data on serial port:F8

002F

2010-08-18T11:11:21.007Z,1282129881.007 [ThrusterHE](INFO): Runnable
2010-08-18T11:11:21.007Z,1282129881.007 [ThrusterHE](INFO): Unexpected data on serial port:W8

002F

2010-08-18T11:11:21.417Z,1282129881.417 [ThrusterHE](INFO): Runnable
2010-08-18T11:11:21.417Z,1282129881.417 [ThrusterHE](INFO): Unexpected data on serial port:,8

002F

2010-08-18T11:11:21.420Z,1282129881.420 [ThrusterHE](INFO): Speed is bad
2010-08-18T11:11:21.825Z,1282129881.825 [ThrusterHE](INFO): Runnable
2010-08-18T11:11:21.826Z,1282129881.826 [ThrusterHE](INFO): Unexpected data on serial port:
0FF

>RW,78
2010-08-18T11:11:21.828Z,1282129881.828 [ThrusterHE](INFO): Send speed command forward:00FF
2010-08-18T11:11:22.224Z,1282129882.224 [ThrusterHE](INFO): Runnable
2010-08-18T11:11:22.224Z,1282129882.224 [ThrusterHE](INFO): Unexpected data on serial port:
0FF

>RW,78
2010-08-18T11:11:22.668Z,1282129882.668 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2010-08-18T11:11:22.684Z,1282129882.684 [ThrusterHE](INFO): Runnable
2010-08-18T11:11:22.684Z,1282129882.684 [ThrusterHE](INFO): Unexpected data on serial port:00FF

>RW,78
2010-08-18T11:11:23.041Z,1282129883.041 [ThrusterHE](INFO): Runnable
2010-08-18T11:11:23.041Z,1282129883.041 [ThrusterHE](INFO): Unexpected data on serial port:00FF

>RW,78
2010-08-18T11:11:23.447Z,1282129883.447 [ThrusterHE](INFO): Runnable
2010-08-18T11:11:23.448Z,1282129883.448 [ThrusterHE](INFO): Unexpected data on serial port:40FF

>RW,78
2010-08-18T11:11:23.451Z,1282129883.451 [ThrusterHE](INFO): Speed is bad
2010-08-18T11:11:23.863Z,1282129883.863 [ThrusterHE](INFO): Runnable
2010-08-18T11:11:23.863Z,1282129883.863 [ThrusterHE](INFO): Unexpected data on serial port:>

>FW,00FF

2010-08-18T11:11:23.866Z,1282129883.866 [ThrusterHE](INFO): Send speed command forward:00FF
2010-08-18T11:11:24.250Z,1282129884.250 [ThrusterHE](INFO): Runnable
2010-08-18T11:11:24.251Z,1282129884.251 [ThrusterHE](INFO): Unexpected data on serial port:R

>FW,00FF

2010-08-18T11:11:24.662Z,1282129884.662 [ThrusterHE](INFO): Runnable
2010-08-18T11:11:24.662Z,1282129884.662 [ThrusterHE](INFO): Unexpected data on serial port:W

>FW,00FF

2010-08-18T11:11:25.070Z,1282129885.070 [ThrusterHE](INFO): Runnable
2010-08-18T11:11:25.070Z,1282129885.070 [ThrusterHE](INFO): Unexpected data on serial port:,

>FW,00FF

2010-08-18T11:11:25.456Z,1282129885.456 [ThrusterHE](INFO): Runnable
2010-08-18T11:11:25.456Z,1282129885.456 [ThrusterHE](INFO): Unexpected data on serial port:7

>FW,00FF

2010-08-18T11:11:25.860Z,1282129885.860 [ThrusterHE](INFO): Runnable
2010-08-18T11:11:25.860Z,1282129885.860 [ThrusterHE](INFO): Unexpected data on serial port:8

>FW,00FF

2010-08-18T11:11:25.863Z,1282129885.863 [ThrusterHE](INFO): Speed is bad
2010-08-18T11:11:26.264Z,1282129886.264 [ThrusterHE](INFO): Runnable
2010-08-18T11:11:26.264Z,1282129886.264 [ThrusterHE](INFO): Unexpected data on serial port:


0047

>FW,00FF
2010-08-18T11:11:26.266Z,1282129886.266 [ThrusterHE](INFO): Send speed command forward:00FF
2010-08-18T11:11:26.684Z,1282129886.684 [ThrusterHE](INFO): Runnable
2010-08-18T11:11:26.684Z,1282129886.684 [ThrusterHE](INFO): Unexpected data on serial port:

0047

>FW,00FF
2010-08-18T11:11:27.073Z,1282129887.073 [ThrusterHE](INFO): Runnable
2010-08-18T11:11:27.073Z,1282129887.073 [ThrusterHE](INFO): Unexpected data on serial port:>

0047

>FW,00FF
2010-08-18T11:11:27.480Z,1282129887.480 [ThrusterHE](INFO): Runnable
2010-08-18T11:11:27.480Z,1282129887.480 [ThrusterHE](INFO): Unexpected data on serial port:R

0047

>FW,00FF
2010-08-18T11:11:27.885Z,1282129887.885 [ThrusterHE](INFO): Runnable
2010-08-18T11:11:27.885Z,1282129887.885 [ThrusterHE](INFO): Unexpected data on serial port:W

0047

>FW,00FF
2010-08-18T11:11:27.888Z,1282129887.888 [ThrusterHE](INFO): Speed is bad
2010-08-18T11:11:28.282Z,1282129888.282 [ThrusterHE](INFO): Stop
2010-08-18T11:11:28.282Z,1282129888.282 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2010-08-18T11:11:28.282Z,1282129888.282 [ThrusterHE](INFO): Powering down
2010-08-18T11:11:28.678Z,1282129888.678 [ThrusterHE](INFO): Stopping
2010-08-18T11:11:29.106Z,1282129889.106 [ThrusterHE](INFO): Stopped
2010-08-18T11:11:29.106Z,1282129889.106 [ThrusterHE](INFO): Start
2010-08-18T11:11:29.106Z,1282129889.106 [ThrusterHE](DEBUG): Initializing EZServoServo.
2010-08-18T11:11:29.227Z,1282129889.227 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2010-08-18T11:11:29.503Z,1282129889.503 [ThrusterHE](INFO): Starting
2010-08-18T11:11:29.916Z,1282129889.916 [ThrusterHE](INFO): Starting
2010-08-18T11:11:30.310Z,1282129890.310 [ThrusterHE](INFO): Starting
2010-08-18T11:11:30.432Z,1282129890.432 [CommandExec](IMPORTANT): got command maintain clear
2010-08-18T11:11:30.704Z,1282129890.704 [ThrusterHE](INFO): Starting
2010-08-18T11:11:30.713Z,1282129890.713 [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:11:31.113Z,1282129891.113 [ThrusterHE](INFO): Starting
2010-08-18T11:11:31.510Z,1282129891.510 [ThrusterHE](INFO): Starting
2010-08-18T11:11:31.913Z,1282129891.913 [ThrusterHE](INFO): Runnable
2010-08-18T11:11:31.914Z,1282129891.914 [ThrusterHE](INFO): Unexpected data on serial port:
tarting

2010-08-18T11:11:31.916Z,1282129891.916 [ThrusterHE](INFO): Send speed command forward:0000
2010-08-18T11:11:32.328Z,1282129892.328 [ThrusterHE](INFO): Pause
2010-08-18T11:11:32.732Z,1282129892.732 [ThrusterHE](INFO): Paused
2010-08-18T11:11:33.126Z,1282129893.126 [ThrusterHE](INFO): Paused
2010-08-18T11:11:33.530Z,1282129893.530 [ThrusterHE](INFO): Paused
2010-08-18T11:11:33.936Z,1282129893.936 [ThrusterHE](INFO): Paused
2010-08-18T11:11:34.353Z,1282129894.353 [ThrusterHE](INFO): Paused
2010-08-18T11:11:34.762Z,1282129894.762 [ThrusterHE](INFO): Paused
2010-08-18T11:11:35.176Z,1282129895.176 [ThrusterHE](INFO): Paused
2010-08-18T11:11:35.622Z,1282129895.622 [ThrusterHE](INFO): Paused
2010-08-18T11:11:35.972Z,1282129895.972 [ThrusterHE](INFO): Paused
2010-08-18T11:11:36.373Z,1282129896.373 [ThrusterHE](INFO): Paused
2010-08-18T11:11:36.762Z,1282129896.762 [ThrusterHE](INFO): Paused
2010-08-18T11:11:37.177Z,1282129897.177 [ThrusterHE](INFO): Paused
2010-08-18T11:11:37.570Z,1282129897.570 [ThrusterHE](INFO): Paused
2010-08-18T11:11:37.983Z,1282129897.983 [ThrusterHE](INFO): Paused
2010-08-18T11:11:38.378Z,1282129898.378 [ThrusterHE](INFO): Paused
2010-08-18T11:11:38.783Z,1282129898.783 [ThrusterHE](INFO): Paused
2010-08-18T11:11:39.188Z,1282129899.188 [ThrusterHE](INFO): Paused
2010-08-18T11:11:39.602Z,1282129899.602 [ThrusterHE](INFO): Paused
2010-08-18T11:11:40.013Z,1282129900.013 [ThrusterHE](INFO): Paused
2010-08-18T11:11:40.410Z,1282129900.410 [ThrusterHE](INFO): Paused
2010-08-18T11:11:40.811Z,1282129900.811 [ThrusterHE](INFO): Paused
2010-08-18T11:11:41.210Z,1282129901.210 [ThrusterHE](INFO): Paused
2010-08-18T11:11:41.623Z,1282129901.623 [ThrusterHE](INFO): Paused
2010-08-18T11:11:42.014Z,1282129902.014 [ThrusterHE](INFO): Paused
2010-08-18T11:11:42.414Z,1282129902.414 [ThrusterHE](INFO): Paused
2010-08-18T11:11:42.830Z,1282129902.830 [ThrusterHE](INFO): Paused
2010-08-18T11:11:43.220Z,1282129903.220 [ThrusterHE](INFO): Paused
2010-08-18T11:11:43.624Z,1282129903.624 [ThrusterHE](INFO): Paused
2010-08-18T11:11:44.032Z,1282129904.032 [ThrusterHE](INFO): Paused
2010-08-18T11:11:44.434Z,1282129904.434 [ThrusterHE](INFO): Paused
2010-08-18T11:11:44.854Z,1282129904.854 [ThrusterHE](INFO): Paused
2010-08-18T11:11:45.265Z,1282129905.265 [ThrusterHE](INFO): Paused
2010-08-18T11:11:45.663Z,1282129905.663 [ThrusterHE](INFO): Paused
2010-08-18T11:11:46.075Z,1282129906.075 [ThrusterHE](INFO): Paused
2010-08-18T11:11:46.462Z,1282129906.462 [ThrusterHE](INFO): Paused
2010-08-18T11:11:46.877Z,1282129906.877 [ThrusterHE](INFO): Paused
2010-08-18T11:11:47.258Z,1282129907.258 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2010-08-18T11:11:47.258Z,1282129907.258 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2010-08-18T11:11:47.258Z,1282129907.258 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2010-08-18T11:11:47.260Z,1282129907.260 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2010-08-18T11:11:47.260Z,1282129907.260 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2010-08-18T11:11:47.260Z,1282129907.260 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2010-08-18T11:11:47.269Z,1282129907.269 [ThrusterHE](INFO): Paused
2010-08-18T11:11:47.272Z,1282129907.272 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2010-08-18T11:11:47.272Z,1282129907.272 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2010-08-18T11:11:47.674Z,1282129907.674 [ThrusterHE](INFO): Paused
2010-08-18T11:11:47.678Z,1282129907.678 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2010-08-18T11:11:47.678Z,1282129907.678 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2010-08-18T11:11:47.678Z,1282129907.678 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2010-08-18T11:11:47.678Z,1282129907.678 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2010-08-18T11:11:48.066Z,1282129908.066 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2010-08-18T11:11:48.074Z,1282129908.074 [ThrusterHE](INFO): Paused
2010-08-18T11:11:48.488Z,1282129908.488 [ThrusterHE](INFO): Paused
2010-08-18T11:11:48.882Z,1282129908.882 [ThrusterHE](INFO): Paused
2010-08-18T11:11:49.286Z,1282129909.286 [ThrusterHE](INFO): Paused
2010-08-18T11:11:49.752Z,1282129909.752 [ThrusterHE](INFO): Paused
2010-08-18T11:11:50.134Z,1282129910.134 [ThrusterHE](INFO): Paused
2010-08-18T11:11:50.527Z,1282129910.527 [ThrusterHE](INFO): Paused
2010-08-18T11:11:50.938Z,1282129910.938 [ThrusterHE](INFO): Paused
2010-08-18T11:11:51.318Z,1282129911.318 [ThrusterHE](INFO): Paused
2010-08-18T11:11:51.705Z,1282129911.705 [ThrusterHE](INFO): Paused
2010-08-18T11:11:52.114Z,1282129912.114 [ThrusterHE](INFO): Paused
2010-08-18T11:11:52.518Z,1282129912.518 [ThrusterHE](INFO): Paused
2010-08-18T11:11:52.923Z,1282129912.923 [ThrusterHE](INFO): Paused
2010-08-18T11:11:53.336Z,1282129913.336 [ThrusterHE](INFO): Paused
2010-08-18T11:11:53.730Z,1282129913.730 [ThrusterHE](INFO): Paused
2010-08-18T11:11:54.127Z,1282129914.127 [ThrusterHE](INFO): Paused
2010-08-18T11:11:54.534Z,1282129914.534 [ThrusterHE](INFO): Paused
2010-08-18T11:11:54.949Z,1282129914.949 [ThrusterHE](INFO): Paused
2010-08-18T11:11:55.366Z,1282129915.366 [ThrusterHE](INFO): Paused
2010-08-18T11:11:55.780Z,1282129915.780 [ThrusterHE](INFO): Paused
2010-08-18T11:11:56.166Z,1282129916.166 [ThrusterHE](INFO): Paused
2010-08-18T11:11:56.563Z,1282129916.563 [ThrusterHE](INFO): Paused
2010-08-18T11:11:56.956Z,1282129916.956 [ThrusterHE](INFO): Paused
2010-08-18T11:11:57.368Z,1282129917.368 [ThrusterHE](INFO): Paused
2010-08-18T11:11:57.764Z,1282129917.764 [ThrusterHE](INFO): Paused
2010-08-18T11:11:58.175Z,1282129918.175 [ThrusterHE](INFO): Paused
2010-08-18T11:11:58.587Z,1282129918.587 [ThrusterHE](INFO): Paused
2010-08-18T11:11:58.982Z,1282129918.982 [ThrusterHE](INFO): Paused
2010-08-18T11:11:59.387Z,1282129919.387 [ThrusterHE](INFO): Paused
2010-08-18T11:11:59.792Z,1282129919.792 [ThrusterHE](INFO): Paused
2010-08-18T11:12:00.205Z,1282129920.205 [ThrusterHE](INFO): Paused
2010-08-18T11:12:00.622Z,1282129920.622 [ThrusterHE](INFO): Paused
2010-08-18T11:12:01.021Z,1282129921.021 [ThrusterHE](INFO): Paused
2010-08-18T11:12:01.426Z,1282129921.426 [ThrusterHE](INFO): Paused
2010-08-18T11:12:01.834Z,1282129921.834 [ThrusterHE](INFO): Paused
2010-08-18T11:12:02.215Z,1282129922.215 [ThrusterHE](INFO): Paused
2010-08-18T11:12:02.608Z,1282129922.608 [Startup:StartupSatComms:A](INFO): Timed out from 2010-08-18T11:11:02.4Z
2010-08-18T11:12:02.608Z,1282129922.608 [Startup:StartupSatComms:A] Stopped
2010-08-18T11:12:02.608Z,1282129922.608 [Startup:StartupSatComms:B] Running Loop=1
2010-08-18T11:12:02.615Z,1282129922.615 [ThrusterHE](INFO): Paused
2010-08-18T11:12:03.022Z,1282129923.022 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2010-08-18T11:12:03.029Z,1282129923.029 [ThrusterHE](INFO): Paused
2010-08-18T11:12:03.488Z,1282129923.488 [ThrusterHE](INFO): Paused
2010-08-18T11:12:03.831Z,1282129923.831 [ThrusterHE](INFO): Paused
2010-08-18T11:12:04.248Z,1282129924.248 [ThrusterHE](INFO): Paused
2010-08-18T11:12:04.653Z,1282129924.653 [ThrusterHE](INFO): Paused
2010-08-18T11:12:05.052Z,1282129925.052 [ThrusterHE](INFO): Paused
2010-08-18T11:12:05.440Z,1282129925.440 [ThrusterHE](INFO): Paused
2010-08-18T11:12:05.866Z,1282129925.866 [ThrusterHE](INFO): Paused
2010-08-18T11:12:06.266Z,1282129926.266 [ThrusterHE](INFO): Paused
2010-08-18T11:12:06.682Z,1282129926.682 [ThrusterHE](INFO): Paused
2010-08-18T11:12:07.084Z,1282129927.084 [ThrusterHE](INFO): Paused
2010-08-18T11:12:07.482Z,1282129927.482 [ThrusterHE](INFO): Paused
2010-08-18T11:12:07.867Z,1282129927.867 [ThrusterHE](INFO): Paused
2010-08-18T11:12:08.281Z,1282129928.281 [ThrusterHE](INFO): Paused
2010-08-18T11:12:08.671Z,1282129928.671 [ThrusterHE](INFO): Paused
2010-08-18T11:12:09.084Z,1282129929.084 [ThrusterHE](INFO): Paused
2010-08-18T11:12:09.527Z,1282129929.527 [ThrusterHE](INFO): Paused
2010-08-18T11:12:09.979Z,1282129929.979 [ThrusterHE](INFO): Paused
2010-08-18T11:12:10.356Z,1282129930.356 [ThrusterHE](INFO): Paused
2010-08-18T11:12:10.750Z,1282129930.750 [ThrusterHE](INFO): Paused
2010-08-18T11:12:11.181Z,1282129931.181 [ThrusterHE](INFO): Paused
2010-08-18T11:12:11.566Z,1282129931.566 [ThrusterHE](INFO): Paused
2010-08-18T11:12:11.998Z,1282129931.998 [ThrusterHE](INFO): Paused
2010-08-18T11:12:12.404Z,1282129932.404 [ThrusterHE](INFO): Paused
2010-08-18T11:12:12.757Z,1282129932.757 [ThrusterHE](INFO): Paused
2010-08-18T11:12:13.223Z,1282129933.223 [ThrusterHE](INFO): Paused
2010-08-18T11:12:13.577Z,1282129933.577 [ThrusterHE](INFO): Paused
2010-08-18T11:12:14.006Z,1282129934.006 [ThrusterHE](INFO): Paused
2010-08-18T11:12:14.413Z,1282129934.413 [ThrusterHE](INFO): Paused
2010-08-18T11:12:14.825Z,1282129934.825 [ThrusterHE](INFO): Paused
2010-08-18T11:12:15.255Z,1282129935.255 [ThrusterHE](INFO): Paused
2010-08-18T11:12:15.621Z,1282129935.621 [ThrusterHE](INFO): Paused
2010-08-18T11:12:15.998Z,1282129935.998 [ThrusterHE](INFO): Paused
2010-08-18T11:12:16.410Z,1282129936.410 [ThrusterHE](INFO): Paused
2010-08-18T11:12:16.869Z,1282129936.869 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2010-08-18T11:12:16.935Z,1282129936.935 [ThrusterHE](INFO): Paused
2010-08-18T11:12:17.234Z,1282129937.234 [ThrusterHE](INFO): Paused
2010-08-18T11:12:17.492Z,1282129937.492 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004928
2010-08-18T11:12:17.656Z,1282129937.656 [ThrusterHE](INFO): Paused
2010-08-18T11:12:18.020Z,1282129938.020 [ThrusterHE](INFO): Paused
2010-08-18T11:12:18.435Z,1282129938.435 [ThrusterHE](INFO): Paused
2010-08-18T11:12:18.820Z,1282129938.820 [ThrusterHE](INFO): Paused
2010-08-18T11:12:19.230Z,1282129939.230 [ThrusterHE](INFO): Paused
2010-08-18T11:12:19.684Z,1282129939.684 [ThrusterHE](INFO): Paused
2010-08-18T11:12:20.056Z,1282129940.056 [ThrusterHE](INFO): Paused
2010-08-18T11:12:20.449Z,1282129940.449 [ThrusterHE](INFO): Paused
2010-08-18T11:12:20.845Z,1282129940.845 [ThrusterHE](INFO): Paused
2010-08-18T11:12:21.298Z,1282129941.298 [ThrusterHE](INFO): Paused
2010-08-18T11:12:21.698Z,1282129941.698 [ThrusterHE](INFO): Paused
2010-08-18T11:12:22.086Z,1282129942.086 [ThrusterHE](INFO): Paused
2010-08-18T11:12:22.515Z,1282129942.515 [ThrusterHE](INFO): Paused
2010-08-18T11:12:22.911Z,1282129942.911 [ThrusterHE](INFO): Paused
2010-08-18T11:12:23.289Z,1282129943.289 [ThrusterHE](INFO): Paused
2010-08-18T11:12:23.693Z,1282129943.693 [ThrusterHE](INFO): Paused
2010-08-18T11:12:24.089Z,1282129944.089 [ThrusterHE](INFO): Paused
2010-08-18T11:12:24.532Z,1282129944.532 [ThrusterHE](INFO): Paused
2010-08-18T11:12:24.938Z,1282129944.938 [ThrusterHE](INFO): Paused
2010-08-18T11:12:25.296Z,1282129945.296 [ThrusterHE](INFO): Paused
2010-08-18T11:12:25.709Z,1282129945.709 [ThrusterHE](INFO): Paused
2010-08-18T11:12:26.091Z,1282129946.091 [ThrusterHE](INFO): Paused
2010-08-18T11:12:26.114Z,1282129946.114 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20100818T103638/Courier0013.lzma
2010-08-18T11:12:26.505Z,1282129946.505 [ThrusterHE](INFO): Paused
2010-08-18T11:12:26.915Z,1282129946.915 [ThrusterHE](INFO): Paused
2010-08-18T11:12:27.116Z,1282129947.116 [DataOverHttps](INFO): Moved sent file to Logs/20100818T103638/Courier0013.lzma.bak
2010-08-18T11:12:27.116Z,1282129947.116 [DataOverHttps](INFO): SBD MOMSN=16171233
2010-08-18T11:12:27.338Z,1282129947.338 [ThrusterHE](INFO): Paused
2010-08-18T11:12:27.721Z,1282129947.721 [ThrusterHE](INFO): Paused
2010-08-18T11:12:28.172Z,1282129948.172 [ThrusterHE](INFO): Paused
2010-08-18T11:12:28.537Z,1282129948.537 [ThrusterHE](INFO): Paused
2010-08-18T11:12:28.926Z,1282129948.926 [ThrusterHE](INFO): Paused
2010-08-18T11:12:29.330Z,1282129949.330 [ThrusterHE](INFO): Paused
2010-08-18T11:12:29.736Z,1282129949.736 [ThrusterHE](INFO): Paused
2010-08-18T11:12:30.403Z,1282129950.403 [ThrusterHE](INFO): Paused
2010-08-18T11:12:30.604Z,1282129950.604 [ThrusterHE](INFO): Paused
2010-08-18T11:12:30.984Z,1282129950.984 [ThrusterHE](INFO): Paused
2010-08-18T11:12:31.470Z,1282129951.470 [ThrusterHE](INFO): Paused
2010-08-18T11:12:31.809Z,1282129951.809 [ThrusterHE](INFO): Paused
2010-08-18T11:12:32.233Z,1282129952.233 [ThrusterHE](INFO): Paused
2010-08-18T11:12:32.739Z,1282129952.739 [ThrusterHE](INFO): Paused
2010-08-18T11:12:33.073Z,1282129953.073 [ThrusterHE](INFO): Paused
2010-08-18T11:12:33.504Z,1282129953.504 [ThrusterHE](INFO): Paused
2010-08-18T11:12:33.853Z,1282129953.853 [ThrusterHE](INFO): Paused
2010-08-18T11:12:34.210Z,1282129954.210 [ThrusterHE](INFO): Paused
2010-08-18T11:12:34.628Z,1282129954.628 [ThrusterHE](INFO): Paused
2010-08-18T11:12:35.024Z,1282129955.024 [ThrusterHE](INFO): Paused
2010-08-18T11:12:35.432Z,1282129955.432 [ThrusterHE](INFO): Paused
2010-08-18T11:12:35.828Z,1282129955.828 [ThrusterHE](INFO): Paused
2010-08-18T11:12:36.271Z,1282129956.271 [ThrusterHE](INFO): Paused
2010-08-18T11:12:36.637Z,1282129956.637 [ThrusterHE](INFO): Paused
2010-08-18T11:12:37.038Z,1282129957.038 [ThrusterHE](INFO): Paused
2010-08-18T11:12:37.469Z,1282129957.469 [ThrusterHE](INFO): Paused
2010-08-18T11:12:37.862Z,1282129957.862 [ThrusterHE](INFO): Paused
2010-08-18T11:12:38.278Z,1282129958.278 [ThrusterHE](INFO): Paused
2010-08-18T11:12:38.674Z,1282129958.674 [ThrusterHE](INFO): Paused
2010-08-18T11:12:39.059Z,1282129959.059 [ThrusterHE](INFO): Paused
2010-08-18T11:12:39.472Z,1282129959.472 [ThrusterHE](INFO): Paused
2010-08-18T11:12:39.866Z,1282129959.866 [ThrusterHE](INFO): Paused
2010-08-18T11:12:40.270Z,1282129960.270 [ThrusterHE](INFO): Paused
2010-08-18T11:12:40.676Z,1282129960.676 [ThrusterHE](INFO): Paused
2010-08-18T11:12:41.088Z,1282129961.088 [ThrusterHE](INFO): Paused
2010-08-18T11:12:41.482Z,1282129961.482 [ThrusterHE](INFO): Paused
2010-08-18T11:12:41.887Z,1282129961.887 [ThrusterHE](INFO): Paused
2010-08-18T11:12:42.310Z,1282129962.310 [ThrusterHE](INFO): Paused
2010-08-18T11:12:42.717Z,1282129962.717 [ThrusterHE](INFO): Paused
2010-08-18T11:12:43.146Z,1282129963.146 [ThrusterHE](INFO): Paused
2010-08-18T11:12:43.529Z,1282129963.529 [ThrusterHE](INFO): Paused
2010-08-18T11:12:44.072Z,1282129964.072 [ThrusterHE](INFO): Paused
2010-08-18T11:12:44.359Z,1282129964.359 [ThrusterHE](INFO): Paused
2010-08-18T11:12:44.762Z,1282129964.762 [ThrusterHE](INFO): Paused
2010-08-18T11:12:45.161Z,1282129965.161 [ThrusterHE](INFO): Paused
2010-08-18T11:12:45.523Z,1282129965.523 [ThrusterHE](INFO): Paused
2010-08-18T11:12:45.935Z,1282129965.935 [ThrusterHE](INFO): Paused
2010-08-18T11:12:46.329Z,1282129966.329 [ThrusterHE](INFO): Paused
2010-08-18T11:12:46.482Z,1282129966.482 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20100818T110826/Courier0000.lzma
2010-08-18T11:12:46.746Z,1282129966.746 [ThrusterHE](INFO): Paused
2010-08-18T11:12:47.158Z,1282129967.158 [ThrusterHE](INFO): Paused
2010-08-18T11:12:47.485Z,1282129967.485 [DataOverHttps](INFO): Moved sent file to Logs/20100818T110826/Courier0000.lzma.bak
2010-08-18T11:12:47.485Z,1282129967.485 [DataOverHttps](INFO): SBD MOMSN=16171235
2010-08-18T11:12:47.561Z,1282129967.561 [ThrusterHE](INFO): Paused
2010-08-18T11:12:47.978Z,1282129967.978 [ThrusterHE](INFO): Paused
2010-08-18T11:12:48.381Z,1282129968.381 [ThrusterHE](INFO): Paused
2010-08-18T11:12:48.800Z,1282129968.800 [ThrusterHE](INFO): Paused
2010-08-18T11:12:49.183Z,1282129969.183 [ThrusterHE](INFO): Paused
2010-08-18T11:12:49.582Z,1282129969.582 [ThrusterHE](INFO): Paused
2010-08-18T11:12:49.977Z,1282129969.977 [ThrusterHE](INFO): Paused
2010-08-18T11:12:50.383Z,1282129970.383 [ThrusterHE](INFO): Paused
2010-08-18T11:12:50.804Z,1282129970.804 [ThrusterHE](INFO): Paused
2010-08-18T11:12:51.200Z,1282129971.200 [ThrusterHE](INFO): Paused
2010-08-18T11:12:51.610Z,1282129971.610 [ThrusterHE](INFO): Paused
2010-08-18T11:12:51.989Z,1282129971.989 [ThrusterHE](INFO): Paused
2010-08-18T11:12:52.409Z,1282129972.409 [ThrusterHE](INFO): Paused
2010-08-18T11:12:52.814Z,1282129972.814 [ThrusterHE](INFO): Paused
2010-08-18T11:12:53.225Z,1282129973.225 [ThrusterHE](INFO): Paused
2010-08-18T11:12:53.634Z,1282129973.634 [ThrusterHE](INFO): Paused
2010-08-18T11:12:54.030Z,1282129974.030 [ThrusterHE](INFO): Paused
2010-08-18T11:12:54.433Z,1282129974.433 [ThrusterHE](INFO): Paused
2010-08-18T11:12:54.813Z,1282129974.813 [ThrusterHE](INFO): Paused
2010-08-18T11:12:55.220Z,1282129975.220 [ThrusterHE](INFO): Paused
2010-08-18T11:12:55.624Z,1282129975.624 [ThrusterHE](INFO): Paused
2010-08-18T11:12:56.034Z,1282129976.034 [ThrusterHE](INFO): Paused
2010-08-18T11:12:56.430Z,1282129976.430 [ThrusterHE](INFO): Paused
2010-08-18T11:12:56.834Z,1282129976.834 [ThrusterHE](INFO): Paused
2010-08-18T11:12:57.238Z,1282129977.239 [ThrusterHE](INFO): Paused
2010-08-18T11:12:57.647Z,1282129977.647 [ThrusterHE](INFO): Paused
2010-08-18T11:12:58.118Z,1282129978.118 [ThrusterHE](INFO): Paused
2010-08-18T11:12:58.482Z,1282129978.482 [ThrusterHE](INFO): Paused
2010-08-18T11:12:58.892Z,1282129978.892 [ThrusterHE](INFO): Paused
2010-08-18T11:12:59.286Z,1282129979.286 [ThrusterHE](INFO): Paused
2010-08-18T11:12:59.672Z,1282129979.672 [ThrusterHE](INFO): Paused
2010-08-18T11:13:00.091Z,1282129980.091 [ThrusterHE](INFO): Paused
2010-08-18T11:13:00.099Z,1282129980.099 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2010-08-18T11:13:00.099Z,1282129980.099 [CTD_Seabird] No Fault, FailCount= 3
2010-08-18T11:13:00.162Z,1282129980.162 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2010-08-18T11:13:00.508Z,1282129980.508 [ThrusterHE](INFO): Paused
2010-08-18T11:13:00.888Z,1282129980.888 [ThrusterHE](INFO): Paused
2010-08-18T11:13:01.294Z,1282129981.294 [ThrusterHE](INFO): Paused
2010-08-18T11:13:01.701Z,1282129981.701 [ThrusterHE](INFO): Paused
2010-08-18T11:13:02.126Z,1282129982.126 [ThrusterHE](INFO): Paused
2010-08-18T11:13:02.536Z,1282129982.536 [ThrusterHE](INFO): Paused
2010-08-18T11:13:02.919Z,1282129982.919 [Startup:StartupSatComms:B](INFO): Timed out from 2010-08-18T11:12:02.6Z
2010-08-18T11:13:02.919Z,1282129982.919 [Startup:StartupSatComms:B] Stopped
2010-08-18T11:13:02.919Z,1282129982.919 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2010-08-18T11:13:02.919Z,1282129982.919 [Startup:StartupSatComms] Stopped
2010-08-18T11:13:02.919Z,1282129982.919 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2010-08-18T11:13:02.920Z,1282129982.920 [Startup](INFO): Completed Startup
2010-08-18T11:13:02.920Z,1282129982.920 [MissionManager](INFO): Startup is completed.
2010-08-18T11:13:02.920Z,1282129982.920 [MissionManager](INFO): Uninitializing Mission Startup
2010-08-18T11:13:02.920Z,1282129982.920 [Startup] Stopped
2010-08-18T11:13:02.921Z,1282129982.921 [Startup](DEBUG): Aggregate::uninitialize Startup
2010-08-18T11:13:02.921Z,1282129982.921 [Startup:A.GoToSurface] Stopped
2010-08-18T11:13:02.921Z,1282129982.921 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2010-08-18T11:13:02.928Z,1282129982.928 [ThrusterHE](INFO): Paused
2010-08-18T11:13:03.310Z,1282129983.310 [MissionManager](IMPORTANT): Started mission Default
2010-08-18T11:13:03.310Z,1282129983.310 [Default] Running Loop=1
2010-08-18T11:13:03.310Z,1282129983.310 [Default](DEBUG): Aggregate::initialize Default
2010-08-18T11:13:03.310Z,1282129983.310 [Default:B.GoToSurface] Running Loop=1
2010-08-18T11:13:03.311Z,1282129983.311 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2010-08-18T11:13:03.311Z,1282129983.311 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2010-08-18T11:13:03.311Z,1282129983.311 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2010-08-18T11:13:03.311Z,1282129983.311 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2010-08-18T11:13:03.312Z,1282129983.312 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2010-08-18T11:13:03.312Z,1282129983.312 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2010-08-18T11:13:03.312Z,1282129983.312 [Default:A.Wait] Running Loop=1
2010-08-18T11:13:03.313Z,1282129983.313 [Default:A.Wait](DEBUG): Initialize Wait Component.
2010-08-18T11:13:03.320Z,1282129983.320 [ThrusterHE](INFO): Paused
2010-08-18T11:13:03.730Z,1282129983.730 [ThrusterHE](INFO): Paused
2010-08-18T11:13:04.123Z,1282129984.123 [ThrusterHE](INFO): Paused
2010-08-18T11:13:04.233Z,1282129984.233 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20100818T110938/Courier0000.lzma
2010-08-18T11:13:04.518Z,1282129984.518 [ThrusterHE](INFO): Paused
2010-08-18T11:13:04.916Z,1282129984.916 [ThrusterHE](INFO): Paused
2010-08-18T11:13:05.235Z,1282129985.235 [DataOverHttps](INFO): Moved sent file to Logs/20100818T110938/Courier0000.lzma.bak
2010-08-18T11:13:05.236Z,1282129985.236 [DataOverHttps](INFO): SBD MOMSN=16171238
2010-08-18T11:13:05.318Z,1282129985.318 [ThrusterHE](INFO): Paused
2010-08-18T11:13:05.733Z,1282129985.733 [ThrusterHE](INFO): Paused
2010-08-18T11:13:06.126Z,1282129986.126 [ThrusterHE](INFO): Paused
2010-08-18T11:13:06.530Z,1282129986.530 [ThrusterHE](INFO): Paused
2010-08-18T11:13:06.936Z,1282129986.936 [ThrusterHE](INFO): Paused
2010-08-18T11:13:07.348Z,1282129987.348 [ThrusterHE](INFO): Paused
2010-08-18T11:13:07.741Z,1282129987.741 [ThrusterHE](INFO): Paused
2010-08-18T11:13:08.146Z,1282129988.146 [ThrusterHE](INFO): Paused
2010-08-18T11:13:08.670Z,1282129988.670 [ThrusterHE](INFO): Paused
2010-08-18T11:13:08.992Z,1282129988.992 [ThrusterHE](INFO): Paused
2010-08-18T11:13:09.407Z,1282129989.407 [ThrusterHE](INFO): Paused
2010-08-18T11:13:09.793Z,1282129989.793 [ThrusterHE](INFO): Paused
2010-08-18T11:13:10.190Z,1282129990.190 [ThrusterHE](INFO): Paused
2010-08-18T11:13:10.573Z,1282129990.573 [ThrusterHE](INFO): Paused
2010-08-18T11:13:10.986Z,1282129990.986 [ThrusterHE](INFO): Paused
2010-08-18T11:13:11.504Z,1282129991.504 [ThrusterHE](INFO): Paused
2010-08-18T11:13:11.815Z,1282129991.815 [ThrusterHE](INFO): Paused
2010-08-18T11:13:12.205Z,1282129992.205 [ThrusterHE](INFO): Paused
2010-08-18T11:13:12.601Z,1282129992.601 [ThrusterHE](INFO): Paused
2010-08-18T11:13:12.994Z,1282129992.994 [ThrusterHE](INFO): Paused
2010-08-18T11:13:13.214Z,1282129993.214 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2010-08-18T11:13:13.214Z,1282129993.214 [CTD_Seabird] Communications Fault, FailCount= 1
2010-08-18T11:13:13.214Z,1282129993.214 [CTD_Seabird](ERROR): Communications Fault
2010-08-18T11:13:13.402Z,1282129993.402 [ThrusterHE](INFO): Paused
2010-08-18T11:13:13.406Z,1282129993.406 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2010-08-18T11:13:13.618Z,1282129993.618 [CTD_Seabird](INFO): Powering down
2010-08-18T11:13:13.819Z,1282129993.819 [ThrusterHE](INFO): Paused
2010-08-18T11:13:14.233Z,1282129994.233 [ThrusterHE](INFO): Paused
2010-08-18T11:13:14.622Z,1282129994.622 [ThrusterHE](INFO): Paused
2010-08-18T11:13:14.626Z,1282129994.626 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2010-08-18T11:13:14.626Z,1282129994.626 [CTD_Seabird] No Fault, FailCount= 1
2010-08-18T11:13:14.962Z,1282129994.962 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2010-08-18T11:13:15.034Z,1282129995.034 [ThrusterHE](INFO): Paused
2010-08-18T11:13:15.428Z,1282129995.428 [ThrusterHE](INFO): Paused
2010-08-18T11:13:15.823Z,1282129995.823 [ThrusterHE](INFO): Paused
2010-08-18T11:13:16.226Z,1282129996.226 [ThrusterHE](INFO): Paused
2010-08-18T11:13:16.621Z,1282129996.621 [Default:A.Wait](INFO): Done Waiting.
2010-08-18T11:13:16.621Z,1282129996.621 [Default:A.Wait] Stopped
2010-08-18T11:13:16.621Z,1282129996.621 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2010-08-18T11:13:16.627Z,1282129996.627 [ThrusterHE](INFO): Paused
2010-08-18T11:13:17.035Z,1282129997.035 [Default:CheckIn] Running Loop=1
2010-08-18T11:13:17.035Z,1282129997.035 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2010-08-18T11:13:17.035Z,1282129997.035 [Default:CheckIn:Read_GPS] Running Loop=1
2010-08-18T11:13:17.041Z,1282129997.041 [ThrusterHE](INFO): Paused
2010-08-18T11:13:17.432Z,1282129997.432 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2010-08-18T11:13:17.439Z,1282129997.439 [ThrusterHE](INFO): Paused
2010-08-18T11:13:17.836Z,1282129997.836 [ThrusterHE](INFO): Paused
2010-08-18T11:13:18.245Z,1282129998.245 [ThrusterHE](INFO): Paused
2010-08-18T11:13:18.654Z,1282129998.654 [ThrusterHE](INFO): Paused
2010-08-18T11:13:19.078Z,1282129999.078 [ThrusterHE](INFO): Paused
2010-08-18T11:13:19.483Z,1282129999.483 [ThrusterHE](INFO): Paused
2010-08-18T11:13:19.874Z,1282129999.874 [ThrusterHE](INFO): Paused
2010-08-18T11:13:20.286Z,1282130000.286 [ThrusterHE](INFO): Paused
2010-08-18T11:13:20.679Z,1282130000.679 [ThrusterHE](INFO): Paused
2010-08-18T11:13:21.074Z,1282130001.074 [ThrusterHE](INFO): Paused
2010-08-18T11:13:21.480Z,1282130001.480 [ThrusterHE](INFO): Paused
2010-08-18T11:13:21.883Z,1282130001.883 [ThrusterHE](INFO): Paused
2010-08-18T11:13:22.294Z,1282130002.294 [ThrusterHE](INFO): Paused
2010-08-18T11:13:22.690Z,1282130002.690 [ThrusterHE](INFO): Paused
2010-08-18T11:13:23.094Z,1282130003.094 [ThrusterHE](INFO): Paused
2010-08-18T11:13:23.498Z,1282130003.498 [ThrusterHE](INFO): Paused
2010-08-18T11:13:23.907Z,1282130003.907 [ThrusterHE](INFO): Paused
2010-08-18T11:13:24.330Z,1282130004.330 [ThrusterHE](INFO): Paused
2010-08-18T11:13:24.788Z,1282130004.788 [ThrusterHE](INFO): Paused
2010-08-18T11:13:25.162Z,1282130005.162 [ThrusterHE](INFO): Paused
2010-08-18T11:13:25.542Z,1282130005.542 [ThrusterHE](INFO): Paused
2010-08-18T11:13:25.936Z,1282130005.936 [ThrusterHE](INFO): Paused
2010-08-18T11:13:26.327Z,1282130006.327 [ThrusterHE](INFO): Paused
2010-08-18T11:13:26.731Z,1282130006.731 [ThrusterHE](INFO): Paused
2010-08-18T11:13:27.136Z,1282130007.136 [ThrusterHE](INFO): Paused
2010-08-18T11:13:27.558Z,1282130007.558 [ThrusterHE](INFO): Paused
2010-08-18T11:13:27.944Z,1282130007.944 [ThrusterHE](INFO): Paused
2010-08-18T11:13:28.014Z,1282130008.014 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2010-08-18T11:13:28.014Z,1282130008.014 [CTD_Seabird] Communications Fault, FailCount= 2
2010-08-18T11:13:28.014Z,1282130008.014 [CTD_Seabird](ERROR): Communications Fault
2010-08-18T11:13:28.342Z,1282130008.342 [ThrusterHE](INFO): Paused
2010-08-18T11:13:28.345Z,1282130008.345 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2010-08-18T11:13:28.418Z,1282130008.418 [CTD_Seabird](INFO): Powering down
2010-08-18T11:13:28.747Z,1282130008.747 [ThrusterHE](INFO): Paused
2010-08-18T11:13:29.160Z,1282130009.160 [ThrusterHE](INFO): Paused
2010-08-18T11:13:29.579Z,1282130009.579 [ThrusterHE](INFO): Paused
2010-08-18T11:13:29.582Z,1282130009.582 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2010-08-18T11:13:29.582Z,1282130009.582 [CTD_Seabird] No Fault, FailCount= 2
2010-08-18T11:13:29.762Z,1282130009.762 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2010-08-18T11:13:29.993Z,1282130009.993 [ThrusterHE](INFO): Paused
2010-08-18T11:13:30.378Z,1282130010.378 [ThrusterHE](INFO): Paused
2010-08-18T11:13:30.790Z,1282130010.790 [ThrusterHE](INFO): Paused
2010-08-18T11:13:31.187Z,1282130011.187 [ThrusterHE](INFO): Paused
2010-08-18T11:13:31.571Z,1282130011.571 [ThrusterHE](INFO): Paused
2010-08-18T11:13:31.985Z,1282130011.985 [ThrusterHE](INFO): Paused
2010-08-18T11:13:32.387Z,1282130012.387 [ThrusterHE](INFO): Paused
2010-08-18T11:13:32.784Z,1282130012.784 [ThrusterHE](INFO): Paused
2010-08-18T11:13:33.194Z,1282130013.194 [ThrusterHE](INFO): Paused
2010-08-18T11:13:33.598Z,1282130013.598 [ThrusterHE](INFO): Paused
2010-08-18T11:13:34.004Z,1282130014.004 [ThrusterHE](INFO): Paused
2010-08-18T11:13:34.415Z,1282130014.415 [ThrusterHE](INFO): Paused
2010-08-18T11:13:34.833Z,1282130014.833 [ThrusterHE](INFO): Paused
2010-08-18T11:13:35.248Z,1282130015.248 [ThrusterHE](INFO): Paused
2010-08-18T11:13:35.630Z,1282130015.630 [ThrusterHE](INFO): Paused
2010-08-18T11:13:36.034Z,1282130016.034 [ThrusterHE](INFO): Paused
2010-08-18T11:13:36.427Z,1282130016.427 [ThrusterHE](INFO): Paused
2010-08-18T11:13:36.830Z,1282130016.830 [ThrusterHE](INFO): Paused
2010-08-18T11:13:37.234Z,1282130017.234 [ThrusterHE](INFO): Paused
2010-08-18T11:13:37.643Z,1282130017.643 [ThrusterHE](INFO): Paused
2010-08-18T11:13:38.107Z,1282130018.107 [ThrusterHE](INFO): Paused
2010-08-18T11:13:38.448Z,1282130018.448 [ThrusterHE](INFO): Paused
2010-08-18T11:13:38.857Z,1282130018.857 [ThrusterHE](INFO): Paused
2010-08-18T11:13:39.267Z,1282130019.267 [ThrusterHE](INFO): Paused
2010-08-18T11:13:39.652Z,1282130019.652 [ThrusterHE](INFO): Paused
2010-08-18T11:13:40.086Z,1282130020.086 [ThrusterHE](INFO): Paused
2010-08-18T11:13:40.499Z,1282130020.499 [ThrusterHE](INFO): Paused
2010-08-18T11:13:40.882Z,1282130020.882 [ThrusterHE](INFO): Paused
2010-08-18T11:13:41.294Z,1282130021.294 [ThrusterHE](INFO): Paused
2010-08-18T11:13:41.678Z,1282130021.678 [ThrusterHE](INFO): Paused
2010-08-18T11:13:42.075Z,1282130022.075 [ThrusterHE](INFO): Paused
2010-08-18T11:13:42.482Z,1282130022.482 [ThrusterHE](INFO): Paused
2010-08-18T11:13:42.814Z,1282130022.814 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2010-08-18T11:13:42.814Z,1282130022.814 [CTD_Seabird] Communications Fault, FailCount= 3
2010-08-18T11:13:42.814Z,1282130022.814 [CTD_Seabird](ERROR): Communications Fault
2010-08-18T11:13:42.901Z,1282130022.901 [ThrusterHE](INFO): Paused
2010-08-18T11:13:42.905Z,1282130022.905 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2010-08-18T11:13:42.905Z,1282130022.905 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2010-08-18T11:13:43.218Z,1282130023.218 [CTD_Seabird](INFO): Powering down
2010-08-18T11:13:43.294Z,1282130023.294 [ThrusterHE](INFO): Paused
2010-08-18T11:13:43.692Z,1282130023.692 [ThrusterHE](INFO): Paused
2010-08-18T11:13:44.112Z,1282130024.112 [ThrusterHE](INFO): Paused
2010-08-18T11:13:44.524Z,1282130024.524 [ThrusterHE](INFO): Paused
2010-08-18T11:13:44.910Z,1282130024.910 [ThrusterHE](INFO): Paused
2010-08-18T11:13:45.357Z,1282130025.357 [ThrusterHE](INFO): Paused
2010-08-18T11:13:45.772Z,1282130025.772 [ThrusterHE](INFO): Paused
2010-08-18T11:13:46.150Z,1282130026.150 [ThrusterHE](INFO): Paused
2010-08-18T11:13:46.562Z,1282130026.562 [ThrusterHE](INFO): Paused
2010-08-18T11:13:46.965Z,1282130026.965 [ThrusterHE](INFO): Paused
2010-08-18T11:13:47.340Z,1282130027.340 [ThrusterHE](INFO): Paused
2010-08-18T11:13:47.771Z,1282130027.771 [ThrusterHE](INFO): Paused
2010-08-18T11:13:48.136Z,1282130028.136 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2010-08-18T11:13:48.136Z,1282130028.136 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2010-08-18T11:13:48.136Z,1282130028.136 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2010-08-18T11:13:48.166Z,1282130028.166 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2010-08-18T11:13:48.166Z,1282130028.166 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2010-08-18T11:13:48.166Z,1282130028.166 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2010-08-18T11:13:48.183Z,1282130028.183 [ThrusterHE](INFO): Paused
2010-08-18T11:13:48.187Z,1282130028.187 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2010-08-18T11:13:48.187Z,1282130028.187 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2010-08-18T11:13:48.576Z,1282130028.576 [ThrusterHE](INFO): Paused
2010-08-18T11:13:48.580Z,1282130028.580 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2010-08-18T11:13:48.580Z,1282130028.580 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2010-08-18T11:13:48.580Z,1282130028.580 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2010-08-18T11:13:48.580Z,1282130028.580 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2010-08-18T11:13:48.938Z,1282130028.938 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2010-08-18T11:13:48.945Z,1282130028.945 [ThrusterHE](INFO): Paused
2010-08-18T11:13:49.352Z,1282130029.352 [ThrusterHE](INFO): Paused
2010-08-18T11:13:49.773Z,1282130029.773 [ThrusterHE](INFO): Paused
2010-08-18T11:13:50.200Z,1282130030.200 [ThrusterHE](INFO): Paused
2010-08-18T11:13:50.586Z,1282130030.586 [ThrusterHE](INFO): Paused
2010-08-18T11:13:50.982Z,1282130030.982 [ThrusterHE](INFO): Paused
2010-08-18T11:13:51.387Z,1282130031.387 [ThrusterHE](INFO): Paused
2010-08-18T11:13:51.870Z,1282130031.870 [ThrusterHE](INFO): Paused
2010-08-18T11:13:52.194Z,1282130032.194 [ThrusterHE](INFO): Paused
2010-08-18T11:13:52.615Z,1282130032.615 [ThrusterHE](INFO): Paused
2010-08-18T11:13:52.997Z,1282130032.997 [ThrusterHE](INFO): Paused
2010-08-18T11:13:53.399Z,1282130033.399 [ThrusterHE](INFO): Paused
2010-08-18T11:13:53.803Z,1282130033.803 [ThrusterHE](INFO): Paused
2010-08-18T11:13:54.216Z,1282130034.216 [ThrusterHE](INFO): Paused
2010-08-18T11:13:54.602Z,1282130034.602 [ThrusterHE](INFO): Paused
2010-08-18T11:13:55.024Z,1282130035.024 [ThrusterHE](INFO): Paused
2010-08-18T11:13:55.443Z,1282130035.443 [ThrusterHE](INFO): Paused
2010-08-18T11:13:55.850Z,1282130035.850 [ThrusterHE](INFO): Paused
2010-08-18T11:13:56.264Z,1282130036.264 [ThrusterHE](INFO): Paused
2010-08-18T11:13:56.665Z,1282130036.665 [ThrusterHE](INFO): Paused
2010-08-18T11:13:57.075Z,1282130037.075 [ThrusterHE](INFO): Paused
2010-08-18T11:13:57.437Z,1282130037.437 [ThrusterHE](INFO): Paused
2010-08-18T11:13:57.852Z,1282130037.852 [ThrusterHE](INFO): Paused
2010-08-18T11:13:58.244Z,1282130038.244 [ThrusterHE](INFO): Paused
2010-08-18T11:13:58.649Z,1282130038.649 [ThrusterHE](INFO): Paused
2010-08-18T11:13:59.051Z,1282130039.051 [ThrusterHE](INFO): Paused
2010-08-18T11:13:59.331Z,1282130039.331 [CommandExec](IMPORTANT): got command restart application
2010-08-18T11:13:59.464Z,1282130039.464 [ThrusterHE](INFO): Paused
2010-08-18T11:13:59.858Z,1282130039.858 [ThrusterHE](INFO): Paused
2010-08-18T11:14:00.261Z,1282130040.261 [ThrusterHE](INFO): Paused
2010-08-18T11:14:00.334Z,1282130040.334 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2010-08-18T11:14:00.334Z,1282130040.334 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2010-08-18T11:14:00.334Z,1282130040.334 [CommandExec](INFO): Uninitializing the command executive.
2010-08-18T11:14:00.334Z,1282130040.334 [CommandExec](INFO): Uninitializing the command scheduler.
2010-08-18T11:14:00.334Z,1282130040.334 [CommandExec ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:14:00.422Z,1282130040.422 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2010-08-18T11:14:00.423Z,1282130040.423 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2010-08-18T11:14:00.423Z,1282130040.423 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:14:00.424Z,1282130040.424 [NavChartDb](INFO): Join timeout helper Thread ID is 7756
2010-08-18T11:14:00.622Z,1282130040.622 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2010-08-18T11:14:00.622Z,1282130040.622 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:14:00.630Z,1282130040.630 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2010-08-18T11:14:00.630Z,1282130040.630 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:14:00.630Z,1282130040.630 [Radio_Surface](INFO): Join timeout helper Thread ID is 7757
2010-08-18T11:14:00.699Z,1282130040.699 [ThrusterHE](INFO): Paused
2010-08-18T11:14:00.846Z,1282130040.846 [Radio_Surface](INFO): Powering down
2010-08-18T11:14:00.847Z,1282130040.847 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2010-08-18T11:14:00.847Z,1282130040.847 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:14:00.850Z,1282130040.850 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2010-08-18T11:14:00.850Z,1282130040.850 [Onboard ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:14:00.850Z,1282130040.850 [Onboard](INFO): Join timeout helper Thread ID is 7758
2010-08-18T11:14:01.082Z,1282130041.082 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2010-08-18T11:14:01.101Z,1282130041.101 [ThrusterHE](INFO): Paused
2010-08-18T11:14:01.504Z,1282130041.504 [ThrusterHE](INFO): Paused
2010-08-18T11:14:01.901Z,1282130041.901 [ThrusterHE](INFO): Paused
2010-08-18T11:14:02.294Z,1282130042.294 [ThrusterHE](INFO): Paused
2010-08-18T11:14:02.542Z,1282130042.542 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2010-08-18T11:14:02.542Z,1282130042.542 [Onboard ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:14:02.554Z,1282130042.554 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2010-08-18T11:14:02.554Z,1282130042.554 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:14:02.554Z,1282130042.554 [DataOverHttps](INFO): Join timeout helper Thread ID is 7759
2010-08-18T11:14:02.701Z,1282130042.701 [ThrusterHE](INFO): Paused
2010-08-18T11:14:03.090Z,1282130043.090 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2010-08-18T11:14:03.090Z,1282130043.090 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:14:03.094Z,1282130043.094 [ThrusterHE](INFO): Paused
2010-08-18T11:14:03.102Z,1282130043.102 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2010-08-18T11:14:03.102Z,1282130043.102 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:14:03.102Z,1282130043.102 [BackseatComponent](INFO): Join timeout helper Thread ID is 7760
2010-08-18T11:14:03.286Z,1282130043.286 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2010-08-18T11:14:03.286Z,1282130043.286 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:14:03.302Z,1282130043.302 [ComponentRegistry](INFO): Shutting down WetLabsSeaOWL_UV_A ThreadHandler
2010-08-18T11:14:03.303Z,1282130043.303 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:14:03.303Z,1282130043.303 [WetLabsSeaOWL_UV_A](INFO): Join timeout helper Thread ID is 7761
2010-08-18T11:14:03.394Z,1282130043.394 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Uninitializing protected caller thread.
2010-08-18T11:14:03.394Z,1282130043.394 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:14:03.410Z,1282130043.410 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2010-08-18T11:14:03.410Z,1282130043.410 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:14:03.411Z,1282130043.411 [CTD_Seabird](INFO): Join timeout helper Thread ID is 7762
2010-08-18T11:14:03.501Z,1282130043.501 [ThrusterHE](INFO): Paused
2010-08-18T11:14:03.578Z,1282130043.578 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2010-08-18T11:14:03.578Z,1282130043.578 [CTD_Seabird](INFO): Powering down
2010-08-18T11:14:03.589Z,1282130043.589 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:14:03.598Z,1282130043.598 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2010-08-18T11:14:03.598Z,1282130043.598 [logger ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:14:03.599Z,1282130043.599 [logger](INFO): Join timeout helper Thread ID is 7763
2010-08-18T11:14:03.622Z,1282130043.622 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2010-08-18T11:14:03.622Z,1282130043.622 [logger ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:14:03.638Z,1282130043.638 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2010-08-18T11:14:03.638Z,1282130043.638 [CommandLine ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:14:03.639Z,1282130043.639 [CommandLine](INFO): Join timeout helper Thread ID is 7764
2010-08-18T11:14:03.682Z,1282130043.682 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2010-08-18T11:14:03.682Z,1282130043.682 [CommandLine ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:14:03.698Z,1282130043.698 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2010-08-18T11:14:03.698Z,1282130043.698 [CommandExec ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:14:03.699Z,1282130043.699 [CommandExec](INFO): Join timeout helper Thread ID is 7765
2010-08-18T11:14:03.700Z,1282130043.700 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2010-08-18T11:14:03.700Z,1282130043.700 [controlThread ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:14:03.700Z,1282130043.700 [controlThread](INFO): Join timeout helper Thread ID is 7766
2010-08-18T11:14:03.870Z,1282130043.870 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2010-08-18T11:14:03.870Z,1282130043.870 [controlThread](DEBUG): Uninitializing ControlThread
2010-08-18T11:14:03.871Z,1282130043.871 [NAL9602](INFO): Powering down
2010-08-18T11:14:03.873Z,1282130043.873 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2010-08-18T11:14:03.874Z,1282130043.874 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2010-08-18T11:14:03.875Z,1282130043.875 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2010-08-18T11:14:03.876Z,1282130043.876 [MissionManager](INFO): Uninitializing Mission Default
2010-08-18T11:14:03.876Z,1282130043.876 [Default] Stopped
2010-08-18T11:14:03.876Z,1282130043.876 [Default](DEBUG): Aggregate::uninitialize Default
2010-08-18T11:14:03.876Z,1282130043.876 [Default:B.GoToSurface] Stopped
2010-08-18T11:14:03.876Z,1282130043.876 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2010-08-18T11:14:03.876Z,1282130043.876 [Default:CheckIn] Stopped
2010-08-18T11:14:03.876Z,1282130043.876 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2010-08-18T11:14:03.876Z,1282130043.876 [Default:CheckIn:Read_GPS] Stopped
2010-08-18T11:14:03.880Z,1282130043.880 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2010-08-18T11:14:03.880Z,1282130043.880 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2010-08-18T11:14:03.880Z,1282130043.880 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2010-08-18T11:14:03.880Z,1282130043.880 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2010-08-18T11:14:03.881Z,1282130043.881 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2010-08-18T11:14:03.881Z,1282130043.881 [BuoyancyServo](INFO): Powering down
2010-08-18T11:14:03.894Z,1282130043.894 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2010-08-18T11:14:03.894Z,1282130043.894 [ElevatorServo](INFO): Powering down
2010-08-18T11:14:03.895Z,1282130043.895 [MassServo](DEBUG): Uninitialize Mass Servo.
2010-08-18T11:14:03.895Z,1282130043.895 [MassServo](INFO): Powering down
2010-08-18T11:14:03.896Z,1282130043.896 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2010-08-18T11:14:03.896Z,1282130043.896 [RudderServo](INFO): Powering down
2010-08-18T11:14:03.897Z,1282130043.897 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2010-08-18T11:14:03.897Z,1282130043.897 [ThrusterHE](INFO): Powering down
2010-08-18T11:14:03.898Z,1282130043.898 [SBIT](DEBUG): Uninitialize SBIT Component.
2010-08-18T11:14:03.898Z,1282130043.898 [IBIT](DEBUG): Uninitialize IBIT Component.
2010-08-18T11:14:03.898Z,1282130043.898 [CBIT](DEBUG): Uninitialize CBIT Component.
2010-08-18T11:14:03.899Z,1282130043.899 [CBIT](DEBUG): Powering off loads.
2010-08-18T11:14:03.909Z,1282130043.909 [CBIT](DEBUG): Disabling WDT.
2010-08-18T11:14:03.921Z,1282130043.921 [CBIT](DEBUG): Opening all GF detection circuits.
2010-08-18T11:14:03.923Z,1282130043.923 [controlThread ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:14:03.963Z,1282130043.963 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:14:03.967Z,1282130043.967 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:14:04.013Z,1282130044.013 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:14:04.015Z,1282130044.015 [Onboard ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:14:04.022Z,1282130044.022 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:14:04.067Z,1282130044.067 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:14:04.104Z,1282130044.104 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2010-08-18T11:14:04.168Z,1282130044.168 [logger ThreadHandler](INFO): Thread cancelled.