2010-08-18T11:51:04.085Z,1282132264.085 [Supervisor](DEBUG): Initializing supervisor.
2010-08-18T11:51:04.090Z,1282132264.090 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2010-08-18T11:51:04.090Z,1282132264.090 [SyncHandler](INFO): Protected caller Thread ID is 8912
2010-08-18T11:51:04.091Z,1282132264.091 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2010-08-18T11:51:04.092Z,1282132264.092 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2010-08-18T11:51:04.093Z,1282132264.093 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 8913
2010-08-18T11:51:04.097Z,1282132264.097 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2010-08-18T11:51:04.115Z,1282132264.115 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2010-08-18T11:51:04.116Z,1282132264.116 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2010-08-18T11:51:04.116Z,1282132264.116 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 8914
2010-08-18T11:51:04.121Z,1282132264.121 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2010-08-18T11:51:04.122Z,1282132264.122 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2010-08-18T11:51:04.122Z,1282132264.122 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 8915
2010-08-18T11:51:04.124Z,1282132264.124 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2010-08-18T11:51:04.125Z,1282132264.125 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2010-08-18T11:51:04.126Z,1282132264.126 [logger ThreadHandler](INFO): Protected caller Thread ID is 8916
2010-08-18T11:51:04.129Z,1282132264.129 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2010-08-18T11:51:04.130Z,1282132264.130 [Supervisor](INFO): Looking for Config files in directory: Config/
2010-08-18T11:51:04.131Z,1282132264.131 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2010-08-18T11:51:04.545Z,1282132264.545 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2010-08-18T11:51:04.546Z,1282132264.546 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2010-08-18T11:51:04.754Z,1282132264.754 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2010-08-18T11:51:04.755Z,1282132264.755 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2010-08-18T11:51:04.939Z,1282132264.939 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2010-08-18T11:51:04.939Z,1282132264.939 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2010-08-18T11:51:05.046Z,1282132265.046 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2010-08-18T11:51:05.047Z,1282132265.047 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2010-08-18T11:51:05.397Z,1282132265.397 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2010-08-18T11:51:05.397Z,1282132265.397 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2010-08-18T11:51:05.716Z,1282132265.716 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2010-08-18T11:51:05.716Z,1282132265.716 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2010-08-18T11:51:05.813Z,1282132265.813 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2010-08-18T11:51:05.813Z,1282132265.813 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2010-08-18T11:51:05.962Z,1282132265.962 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2010-08-18T11:51:05.963Z,1282132265.963 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2010-08-18T11:51:06.480Z,1282132266.480 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2010-08-18T11:51:06.481Z,1282132266.481 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2010-08-18T11:51:06.830Z,1282132266.830 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2010-08-18T11:51:06.831Z,1282132266.831 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2010-08-18T11:51:06.913Z,1282132266.913 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2010-08-18T11:51:07.113Z,1282132267.113 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2010-08-18T11:51:07.114Z,1282132267.114 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2010-08-18T11:51:07.240Z,1282132267.240 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2010-08-18T11:51:07.241Z,1282132267.241 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2010-08-18T11:51:07.884Z,1282132267.884 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2010-08-18T11:51:07.884Z,1282132267.884 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2010-08-18T11:51:07.965Z,1282132267.965 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2010-08-18T11:51:08.287Z,1282132268.287 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2010-08-18T11:51:08.289Z,1282132268.289 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/
2010-08-18T11:51:08.290Z,1282132268.290 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg
2010-08-18T11:51:08.586Z,1282132268.586 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg
2010-08-18T11:51:08.712Z,1282132268.712 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg
2010-08-18T11:51:08.822Z,1282132268.822 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg
2010-08-18T11:51:08.922Z,1282132268.922 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg
2010-08-18T11:51:09.006Z,1282132269.006 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg
2010-08-18T11:51:09.126Z,1282132269.126 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg
2010-08-18T11:51:09.240Z,1282132269.240 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg
2010-08-18T11:51:09.338Z,1282132269.338 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg
2010-08-18T11:51:09.477Z,1282132269.477 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg
2010-08-18T11:51:09.734Z,1282132269.734 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2010-08-18T11:51:09.735Z,1282132269.735 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg
2010-08-18T11:51:09.830Z,1282132269.830 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/root/
2010-08-18T11:51:09.830Z,1282132269.830 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2010-08-18T11:51:09.846Z,1282132269.846 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2010-08-18T11:51:10.172Z,1282132270.172 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2010-08-18T11:51:10.173Z,1282132270.173 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2010-08-18T11:51:10.253Z,1282132270.253 [DeadReckonUsingMultipleVelocitySources] Loaded
2010-08-18T11:51:10.254Z,1282132270.254 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2010-08-18T11:51:10.287Z,1282132270.287 [DeadReckonUsingSpeedCalculator] Loaded
2010-08-18T11:51:10.287Z,1282132270.287 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2010-08-18T11:51:10.300Z,1282132270.300 [NavChart] Loaded
2010-08-18T11:51:10.300Z,1282132270.300 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2010-08-18T11:51:10.305Z,1282132270.305 [UniversalFixResidualReporter] Loaded
2010-08-18T11:51:10.306Z,1282132270.306 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2010-08-18T11:51:10.306Z,1282132270.306 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2010-08-18T11:51:10.307Z,1282132270.307 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2010-08-18T11:51:10.317Z,1282132270.317 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2010-08-18T11:51:10.318Z,1282132270.318 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2010-08-18T11:51:10.511Z,1282132270.511 [CTD_Seabird] Loaded
2010-08-18T11:51:10.512Z,1282132270.512 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2010-08-18T11:51:10.513Z,1282132270.513 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406514E0
2010-08-18T11:51:10.513Z,1282132270.513 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 8998
2010-08-18T11:51:10.532Z,1282132270.532 [PAR_Licor] Loaded
2010-08-18T11:51:10.533Z,1282132270.533 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2010-08-18T11:51:10.564Z,1282132270.564 [WetLabsSeaOWL_UV_A] Loaded
2010-08-18T11:51:10.564Z,1282132270.564 [ComponentRegistry](DEBUG): Component "WetLabsSeaOWL_UV_A" handled in its own thread.
2010-08-18T11:51:10.565Z,1282132270.565 [WetLabsSeaOWL_UV_A ThreadHandler](DEBUG): Created PCaller Thread at 406814E0
2010-08-18T11:51:10.566Z,1282132270.566 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Protected caller Thread ID is 8999
2010-08-18T11:51:10.566Z,1282132270.566 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2010-08-18T11:51:10.567Z,1282132270.567 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2010-08-18T11:51:10.621Z,1282132270.621 [VerticalControl](DEBUG): Construct VerticalControl.
2010-08-18T11:51:10.681Z,1282132270.681 [VerticalControl] Loaded
2010-08-18T11:51:10.682Z,1282132270.682 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2010-08-18T11:51:10.684Z,1282132270.684 [HorizontalControl](DEBUG): Construct HorizontalControl.
2010-08-18T11:51:10.722Z,1282132270.722 [HorizontalControl] Loaded
2010-08-18T11:51:10.723Z,1282132270.723 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2010-08-18T11:51:10.725Z,1282132270.725 [SpeedControl](DEBUG): Construct SpeedControl.
2010-08-18T11:51:10.728Z,1282132270.728 [SpeedControl] Loaded
2010-08-18T11:51:10.728Z,1282132270.728 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2010-08-18T11:51:10.731Z,1282132270.731 [LoopControl](DEBUG): Construct LoopControl.
2010-08-18T11:51:10.731Z,1282132270.731 [LoopControl] Loaded
2010-08-18T11:51:10.732Z,1282132270.732 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2010-08-18T11:51:10.732Z,1282132270.732 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2010-08-18T11:51:10.733Z,1282132270.733 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2010-08-18T11:51:10.775Z,1282132270.775 [DepthRateCalculator] Loaded
2010-08-18T11:51:10.775Z,1282132270.775 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2010-08-18T11:51:10.780Z,1282132270.780 [PitchRateCalculator] Loaded
2010-08-18T11:51:10.780Z,1282132270.780 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2010-08-18T11:51:10.790Z,1282132270.790 [SpeedCalculator] Loaded
2010-08-18T11:51:10.790Z,1282132270.790 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2010-08-18T11:51:10.803Z,1282132270.803 [TempGradientCalculator] Loaded
2010-08-18T11:51:10.803Z,1282132270.803 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2010-08-18T11:51:10.807Z,1282132270.807 [YawRateCalculator] Loaded
2010-08-18T11:51:10.808Z,1282132270.808 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2010-08-18T11:51:10.825Z,1282132270.825 [ElevatorOffsetCalculator] Loaded
2010-08-18T11:51:10.825Z,1282132270.825 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2010-08-18T11:51:10.825Z,1282132270.825 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2010-08-18T11:51:10.826Z,1282132270.826 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2010-08-18T11:51:10.919Z,1282132270.919 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2010-08-18T11:51:10.920Z,1282132270.920 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2010-08-18T11:51:10.978Z,1282132270.978 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2010-08-18T11:51:10.978Z,1282132270.978 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2010-08-18T11:51:11.109Z,1282132271.109 [BuoyancyServo] Loaded
2010-08-18T11:51:11.110Z,1282132271.110 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2010-08-18T11:51:11.129Z,1282132271.129 [ElevatorServo] Loaded
2010-08-18T11:51:11.129Z,1282132271.129 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2010-08-18T11:51:11.148Z,1282132271.148 [MassServo] Loaded
2010-08-18T11:51:11.148Z,1282132271.148 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2010-08-18T11:51:11.166Z,1282132271.166 [RudderServo] Loaded
2010-08-18T11:51:11.166Z,1282132271.166 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2010-08-18T11:51:11.181Z,1282132271.181 [ThrusterHE] Loaded
2010-08-18T11:51:11.181Z,1282132271.181 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2010-08-18T11:51:11.182Z,1282132271.182 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2010-08-18T11:51:11.182Z,1282132271.182 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2010-08-18T11:51:11.288Z,1282132271.288 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2010-08-18T11:51:11.289Z,1282132271.289 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2010-08-18T11:51:11.651Z,1282132271.651 [BackseatComponent] Loaded
2010-08-18T11:51:11.652Z,1282132271.652 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2010-08-18T11:51:11.653Z,1282132271.653 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 40A494E0
2010-08-18T11:51:11.653Z,1282132271.653 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 9000
2010-08-18T11:51:11.656Z,1282132271.656 [LcmUniversalReporter] Loaded
2010-08-18T11:51:11.656Z,1282132271.656 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2010-08-18T11:51:12.464Z,1282132272.464 [BPC1] Loaded
2010-08-18T11:51:12.464Z,1282132272.464 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2010-08-18T11:51:12.534Z,1282132272.534 [DataOverHttps] Loaded
2010-08-18T11:51:12.535Z,1282132272.535 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2010-08-18T11:51:12.536Z,1282132272.536 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40A794E0
2010-08-18T11:51:12.536Z,1282132272.536 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 9001
2010-08-18T11:51:12.555Z,1282132272.555 [Depth_Keller] Loaded
2010-08-18T11:51:12.556Z,1282132272.556 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2010-08-18T11:51:12.615Z,1282132272.615 [NAL9602] Loaded
2010-08-18T11:51:12.615Z,1282132272.615 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2010-08-18T11:51:12.645Z,1282132272.645 [Onboard] Loaded
2010-08-18T11:51:12.645Z,1282132272.645 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2010-08-18T11:51:12.646Z,1282132272.646 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40AA94E0
2010-08-18T11:51:12.646Z,1282132272.646 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 9002
2010-08-18T11:51:12.659Z,1282132272.659 [Power24vConverter] Loaded
2010-08-18T11:51:12.659Z,1282132272.659 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2010-08-18T11:51:12.672Z,1282132272.672 [Radio_Surface] Loaded
2010-08-18T11:51:12.672Z,1282132272.672 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2010-08-18T11:51:12.673Z,1282132272.673 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40AD94E0
2010-08-18T11:51:12.674Z,1282132272.674 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 9003
2010-08-18T11:51:12.675Z,1282132272.675 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2010-08-18T11:51:12.675Z,1282132272.675 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2010-08-18T11:51:12.820Z,1282132272.820 [SBIT](DEBUG): Construct Startup Built In Test.
2010-08-18T11:51:12.829Z,1282132272.829 [SBIT] Loaded
2010-08-18T11:51:12.829Z,1282132272.829 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2010-08-18T11:51:12.832Z,1282132272.832 [IBIT](DEBUG): Construct Initiated Built In Test.
2010-08-18T11:51:12.845Z,1282132272.845 [IBIT] Loaded
2010-08-18T11:51:12.845Z,1282132272.845 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2010-08-18T11:51:12.851Z,1282132272.851 [CBIT](DEBUG): Construct Continuous Built In Test.
2010-08-18T11:51:12.951Z,1282132272.951 [CBIT] Loaded
2010-08-18T11:51:12.952Z,1282132272.952 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2010-08-18T11:51:12.952Z,1282132272.952 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2010-08-18T11:51:12.953Z,1282132272.953 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2010-08-18T11:51:12.981Z,1282132272.981 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2010-08-18T11:51:12.987Z,1282132272.987 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2010-08-18T11:51:12.990Z,1282132272.990 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2010-08-18T11:51:13.001Z,1282132273.001 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2010-08-18T11:51:13.002Z,1282132273.002 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B644E0
2010-08-18T11:51:13.002Z,1282132273.002 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 9004
2010-08-18T11:51:13.007Z,1282132273.007 [Supervisor](INFO): Main Thread ID is 6436
2010-08-18T11:51:13.007Z,1282132273.007 [Supervisor](DEBUG): Running supervisor.
2010-08-18T11:51:13.007Z,1282132273.007 [CommandExec ThreadHandler](INFO): Handler Thread ID is 9005
2010-08-18T11:51:13.008Z,1282132273.008 [CommandExec](INFO): Initializing the command executive.
2010-08-18T11:51:13.009Z,1282132273.009 [CommandLine ThreadHandler](INFO): Handler Thread ID is 9006
2010-08-18T11:51:13.011Z,1282132273.011 [controlThread ThreadHandler](INFO): Handler Thread ID is 9007
2010-08-18T11:51:13.012Z,1282132273.012 [controlThread](DEBUG): Initializing ControlThread
2010-08-18T11:51:13.013Z,1282132273.013 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2010-08-18T11:51:13.014Z,1282132273.014 [NavChart](DEBUG): Initialize NavChart Navigation.
2010-08-18T11:51:13.014Z,1282132273.014 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2010-08-18T11:51:13.018Z,1282132273.018 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2010-08-18T11:51:13.020Z,1282132273.020 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2010-08-18T11:51:13.020Z,1282132273.020 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2010-08-18T11:51:13.021Z,1282132273.021 [LoopControl](DEBUG): Initialize LoopControlComponent.
2010-08-18T11:51:13.021Z,1282132273.021 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2010-08-18T11:51:13.022Z,1282132273.022 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2010-08-18T11:51:13.022Z,1282132273.022 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2010-08-18T11:51:13.022Z,1282132273.022 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2010-08-18T11:51:13.023Z,1282132273.023 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2010-08-18T11:51:13.023Z,1282132273.023 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2010-08-18T11:51:13.027Z,1282132273.027 [SBIT](INFO): Initialize SBIT Component.
2010-08-18T11:51:13.027Z,1282132273.027 [SBIT](IMPORTANT): git: 2021-10-11a
2010-08-18T11:51:13.027Z,1282132273.027 [SBIT](INFO): git hash: 36f3a97de7a122c995f034a375e3cefac6406048
2010-08-18T11:51:13.028Z,1282132273.028 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2010-08-18T11:51:13.029Z,1282132273.029 [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:51:13.030Z,1282132273.030 [SBIT](INFO): Beginning SBIT in 20.000000 seconds.
2010-08-18T11:51:13.031Z,1282132273.031 [IBIT](INFO): Initialize IBIT Component.
2010-08-18T11:51:13.032Z,1282132273.032 [CBIT](DEBUG): Initialize CBIT Component.
2010-08-18T11:51:13.032Z,1282132273.032 [logger ThreadHandler](INFO): Handler Thread ID is 9008
2010-08-18T11:51:13.046Z,1282132273.046 [CBIT](DEBUG): Initialized mux pins.
2010-08-18T11:51:13.046Z,1282132273.046 [CBIT](DEBUG): Initializing the watchdog timer.
2010-08-18T11:51:13.050Z,1282132273.050 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 9009
2010-08-18T11:51:13.051Z,1282132273.051 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2010-08-18T11:51:13.055Z,1282132273.055 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Handler Thread ID is 9011
2010-08-18T11:51:13.066Z,1282132273.066 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 9012
2010-08-18T11:51:13.070Z,1282132273.070 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2010-08-18T11:51:13.070Z,1282132273.070 [CBIT](DEBUG): Initializing heartbeat.
2010-08-18T11:51:13.078Z,1282132273.078 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 9013
2010-08-18T11:51:13.079Z,1282132273.079 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2010-08-18T11:51:13.090Z,1282132273.090 [Onboard ThreadHandler](INFO): Handler Thread ID is 9014
2010-08-18T11:51:13.108Z,1282132273.108 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 9015
2010-08-18T11:51:13.126Z,1282132273.126 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 9016
2010-08-18T11:51:13.130Z,1282132273.130 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2010-08-18T11:51:13.130Z,1282132273.130 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2010-08-18T11:51:13.130Z,1282132273.130 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2010-08-18T11:51:13.130Z,1282132273.130 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2010-08-18T11:51:13.130Z,1282132273.130 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2010-08-18T11:51:13.131Z,1282132273.131 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2010-08-18T11:51:13.131Z,1282132273.131 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2010-08-18T11:51:13.131Z,1282132273.131 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2010-08-18T11:51:13.131Z,1282132273.131 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2010-08-18T11:51:13.131Z,1282132273.131 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2010-08-18T11:51:13.131Z,1282132273.131 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2010-08-18T11:51:13.132Z,1282132273.132 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2010-08-18T11:51:13.132Z,1282132273.132 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2010-08-18T11:51:13.132Z,1282132273.132 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2010-08-18T11:51:13.132Z,1282132273.132 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2010-08-18T11:51:13.132Z,1282132273.132 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2010-08-18T11:51:13.141Z,1282132273.141 [CBIT](DEBUG): Deactivating GF circuits.
2010-08-18T11:51:13.142Z,1282132273.142 [CBIT](DEBUG): Deactivating emergency mode.
2010-08-18T11:51:13.177Z,1282132273.177 [CBIT](DEBUG): Backplane powered.
2010-08-18T11:51:13.179Z,1282132273.179 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2010-08-18T11:51:13.191Z,1282132273.191 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2010-08-18T11:51:13.216Z,1282132273.216 [MissionManager](DEBUG):
2010-08-18T11:51:13.216Z,1282132273.216 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2010-08-18T11:51:13.293Z,1282132273.293 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2010-08-18T11:51:13.310Z,1282132273.310 [Default:A.Wait](DEBUG): Construct Wait.
2010-08-18T11:51:13.313Z,1282132273.313 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2010-08-18T11:51:13.340Z,1282132273.340 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2010-08-18T11:51:13.367Z,1282132273.367 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2010-08-18T11:51:13.378Z,1282132273.378 [Default:E.Execute](DEBUG): Construct Execute.
2010-08-18T11:51:13.381Z,1282132273.381 [MissionManager](DEBUG):
0
Wait a moment to see if the scheduler starts a new mission before
starting to actually run Default.
13
Burn on
Dropped weight due to communications timeout.
5
Default mission has been running for
Restarting logs and Default mission.
restart logs
2010-08-18T11:51:13.407Z,1282132273.407 [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:51:13.476Z,1282132273.476 [Power24vConverter](INFO): Powering up.
2010-08-18T11:51:13.514Z,1282132273.514 [Radio_Surface](INFO): Powering up
2010-08-18T11:51:13.600Z,1282132273.600 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2010-08-18T11:51:13.608Z,1282132273.608 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2010-08-18T11:51:13.610Z,1282132273.610 [ElevatorServo](DEBUG): Initializing EZServoServo.
2010-08-18T11:51:13.629Z,1282132273.629 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2010-08-18T11:51:13.638Z,1282132273.638 [MassServo](DEBUG): Initializing EZServoServo.
2010-08-18T11:51:13.646Z,1282132273.646 [MassServo](DEBUG): Initializing MassServo.
2010-08-18T11:51:13.647Z,1282132273.647 [RudderServo](DEBUG): Initializing EZServoServo.
2010-08-18T11:51:13.654Z,1282132273.654 [RudderServo](DEBUG): Initializing RudderServo.
2010-08-18T11:51:13.655Z,1282132273.655 [ThrusterHE](INFO): Start
2010-08-18T11:51:13.655Z,1282132273.655 [ThrusterHE](DEBUG): Initializing EZServoServo.
2010-08-18T11:51:13.679Z,1282132273.679 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2010-08-18T11:51:13.879Z,1282132273.879 [ThrusterHE](INFO): Starting
2010-08-18T11:51:14.554Z,1282132274.554 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2010-08-18T11:51:14.554Z,1282132274.554 [RudderServo](FAULT): Rudder failed to initialize
2010-08-18T11:51:14.554Z,1282132274.554 [RudderServo] Communications Fault, FailCount= 1
2010-08-18T11:51:14.554Z,1282132274.554 [RudderServo](ERROR): Communications Fault
2010-08-18T11:51:14.554Z,1282132274.554 [ThrusterHE](INFO): Starting
2010-08-18T11:51:14.558Z,1282132274.558 [CBIT](ERROR): Communications Fault in component: RudderServo
2010-08-18T11:51:14.795Z,1282132274.795 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2010-08-18T11:51:14.795Z,1282132274.795 [RudderServo](INFO): Powering down
2010-08-18T11:51:14.796Z,1282132274.796 [ThrusterHE](INFO): Starting
2010-08-18T11:51:15.051Z,1282132275.051 [ThrusterHE](INFO): Starting
2010-08-18T11:51:15.456Z,1282132275.456 [RudderServo](DEBUG): Initializing EZServoServo.
2010-08-18T11:51:15.575Z,1282132275.575 [RudderServo](DEBUG): Initializing RudderServo.
2010-08-18T11:51:15.576Z,1282132275.576 [ThrusterHE](INFO): Starting
2010-08-18T11:51:15.580Z,1282132275.580 [CBIT](INFO): Clearing failed state for component RudderServo
2010-08-18T11:51:15.580Z,1282132275.580 [RudderServo] No Fault, FailCount= 1
2010-08-18T11:51:15.859Z,1282132275.859 [ThrusterHE](INFO): Starting
2010-08-18T11:51:15.860Z,1282132275.860 [ThrusterHE](INFO): Normal Promp. Good Init
2010-08-18T11:51:16.414Z,1282132276.414 [ThrusterHE](INFO): Starting
2010-08-18T11:51:16.667Z,1282132276.667 [ThrusterHE](INFO): Starting
2010-08-18T11:51:17.183Z,1282132277.183 [ThrusterHE](INFO): Starting
2010-08-18T11:51:17.646Z,1282132277.646 [ThrusterHE](INFO): Starting
2010-08-18T11:51:17.902Z,1282132277.902 [ThrusterHE](INFO): Starting
2010-08-18T11:51:18.283Z,1282132278.283 [ThrusterHE](INFO): Starting
2010-08-18T11:51:18.758Z,1282132278.758 [ThrusterHE](INFO): Starting
2010-08-18T11:51:19.338Z,1282132279.338 [ThrusterHE](INFO): Runnable
2010-08-18T11:51:19.338Z,1282132279.338 [ThrusterHE](INFO): Unexpected data on serial port:ZSpeedng
2010-08-18T11:51:19.339Z,1282132279.339 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-08-18T11:51:19.339Z,1282132279.339 [ThrusterHE](INFO): Fault detected
2010-08-18T11:51:19.339Z,1282132279.339 [ThrusterHE](INFO): Send speed command forward:0000
2010-08-18T11:51:19.495Z,1282132279.495 [ThrusterHE](INFO): Pause
2010-08-18T11:51:26.118Z,1282132286.118 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2010-08-18T11:51:26.118Z,1282132286.118 [CTD_Seabird] Communications Fault, FailCount= 1
2010-08-18T11:51:26.118Z,1282132286.118 [CTD_Seabird](ERROR): Communications Fault
2010-08-18T11:51:26.371Z,1282132286.371 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2010-08-18T11:51:26.523Z,1282132286.523 [CTD_Seabird](INFO): Powering down
2010-08-18T11:51:27.587Z,1282132287.587 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2010-08-18T11:51:27.587Z,1282132287.587 [CTD_Seabird] No Fault, FailCount= 1
2010-08-18T11:51:27.866Z,1282132287.866 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2010-08-18T11:51:33.649Z,1282132293.649 [SBIT](IMPORTANT): Beginning Startup BIT
2010-08-18T11:51:33.653Z,1282132293.653 [CBIT](IMPORTANT): Beginning ground fault scan
2010-08-18T11:51:40.918Z,1282132300.918 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2010-08-18T11:51:40.918Z,1282132300.918 [CTD_Seabird] Communications Fault, FailCount= 2
2010-08-18T11:51:40.918Z,1282132300.918 [CTD_Seabird](ERROR): Communications Fault
2010-08-18T11:51:41.011Z,1282132301.011 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2010-08-18T11:51:41.323Z,1282132301.323 [CTD_Seabird](INFO): Powering down
2010-08-18T11:51:42.578Z,1282132302.578 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2010-08-18T11:51:42.579Z,1282132302.579 [CTD_Seabird] No Fault, FailCount= 2
2010-08-18T11:51:42.674Z,1282132302.674 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2010-08-18T11:51:42.911Z,1282132302.911 [NAL9602](INFO): Powering up NAL9602
2010-08-18T11:51:44.603Z,1282132304.603 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.028412
CHAN A1 (24V): 0.000504
CHAN A2 (12V): -0.005499
CHAN A3 (5V): -0.003016
CHAN B0 (3.3V): -0.001813
CHAN B1 (3.15aV): -0.001215
CHAN B2 (3.15bV): -0.001744
CHAN B3 (GND): -0.000280
OPEN: 0.004915
Full Scale: +/- 1 mA
2010-08-18T11:51:48.640Z,1282132308.640 [CommandExec](IMPORTANT): got command maintain control SpeedControl.propOmegaAction 300.000000 revolution_per_minute
2010-08-18T11:51:48.644Z,1282132308.644 [ComponentRegistry](DEBUG): SyncComponent "Maintain_SpeedControl.propOmegaAction" handled in the control thread.
2010-08-18T11:51:49.155Z,1282132309.155 [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:51:49.511Z,1282132309.511 [ThrusterHE](INFO): Resume
2010-08-18T11:51:49.882Z,1282132309.882 [ThrusterHE](INFO): Resuming
2010-08-18T11:51:50.286Z,1282132310.286 [ThrusterHE](INFO): Resuming
2010-08-18T11:51:50.695Z,1282132310.695 [ThrusterHE](INFO): Resuming
2010-08-18T11:51:51.111Z,1282132311.111 [ThrusterHE](INFO): Resuming
2010-08-18T11:51:51.526Z,1282132311.526 [ThrusterHE](INFO): Resuming
2010-08-18T11:51:51.527Z,1282132311.527 [ThrusterHE](INFO): Normal Promp. Good Init
2010-08-18T11:51:51.927Z,1282132311.927 [ThrusterHE](INFO): Runnable
2010-08-18T11:51:51.927Z,1282132311.927 [ThrusterHE](INFO): Unexpected data on serial port:WU
eedng
2010-08-18T11:51:51.927Z,1282132311.927 [ThrusterHE](INFO): Send speed command forward:00FF
2010-08-18T11:51:52.307Z,1282132312.307 [ThrusterHE](INFO): Runnable
2010-08-18T11:51:52.307Z,1282132312.307 [ThrusterHE](INFO): Unexpected data on serial port:FW,00FF
2010-08-18T11:51:52.710Z,1282132312.710 [ThrusterHE](INFO): Runnable
2010-08-18T11:51:53.131Z,1282132313.131 [ThrusterHE](INFO): Runnable
2010-08-18T11:51:53.131Z,1282132313.131 [ThrusterHE](INFO): Unexpected data on serial port:
>
>F
2010-08-18T11:51:53.546Z,1282132313.546 [ThrusterHE](INFO): Runnable
2010-08-18T11:51:53.570Z,1282132313.570 [ThrusterHE](INFO): Speed Good:8.741482
2010-08-18T11:51:53.819Z,1282132313.819 [NAL9602](INFO): NAL9602 initialized
2010-08-18T11:51:53.939Z,1282132313.939 [ThrusterHE](INFO): Runnable
2010-08-18T11:51:53.939Z,1282132313.939 [ThrusterHE](INFO): Unexpected data on serial port:
>,78
0015
2010-08-18T11:51:53.958Z,1282132313.958 [ThrusterHE](INFO): Speed Good:20.396790
2010-08-18T11:51:54.382Z,1282132314.382 [ThrusterHE](INFO): Runnable
2010-08-18T11:51:54.383Z,1282132314.383 [ThrusterHE](INFO): Unexpected data on serial port:
>,78
0031
2010-08-18T11:51:54.406Z,1282132314.406 [ThrusterHE](INFO): Speed Good:22.894356
2010-08-18T11:51:54.938Z,1282132314.938 [ThrusterHE](INFO): Runnable
2010-08-18T11:51:54.938Z,1282132314.938 [ThrusterHE](INFO): Unexpected data on serial port:
>,78
0037
2010-08-18T11:51:54.962Z,1282132314.962 [ThrusterHE](INFO): Speed Good:24.975662
2010-08-18T11:51:55.111Z,1282132315.111 [ThrusterHE](INFO): Runnable
2010-08-18T11:51:55.111Z,1282132315.111 [ThrusterHE](INFO): Unexpected data on serial port:
>,78
003C
2010-08-18T11:51:55.131Z,1282132315.131 [ThrusterHE](INFO): Speed Good:25.808184
2010-08-18T11:51:55.511Z,1282132315.511 [ThrusterHE](INFO): Runnable
2010-08-18T11:51:55.511Z,1282132315.511 [ThrusterHE](INFO): Unexpected data on serial port:
>,78
003E
2010-08-18T11:51:55.558Z,1282132315.558 [ThrusterHE](INFO): Speed Good:26.640705
2010-08-18T11:51:55.911Z,1282132315.911 [ThrusterHE](INFO): Runnable
2010-08-18T11:51:55.911Z,1282132315.911 [ThrusterHE](INFO): Unexpected data on serial port:
>,78
0040
2010-08-18T11:51:55.938Z,1282132315.938 [ThrusterHE](INFO): Speed Good:27.473228
2010-08-18T11:51:56.307Z,1282132316.307 [ThrusterHE](INFO): Runnable
2010-08-18T11:51:56.307Z,1282132316.307 [ThrusterHE](INFO): Unexpected data on serial port:
>,78
0042
2010-08-18T11:51:56.326Z,1282132316.326 [ThrusterHE](INFO): Speed Good:27.889488
2010-08-18T11:51:56.687Z,1282132316.687 [ThrusterHE](INFO): Runnable
2010-08-18T11:51:56.687Z,1282132316.687 [ThrusterHE](INFO): Unexpected data on serial port:
>,78
0043
2010-08-18T11:51:56.714Z,1282132316.714 [ThrusterHE](INFO): Speed Good:28.722012
2010-08-18T11:51:56.738Z,1282132316.738 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2010-08-18T11:51:56.738Z,1282132316.738 [CTD_Seabird] Communications Fault, FailCount= 3
2010-08-18T11:51:56.738Z,1282132316.738 [CTD_Seabird](ERROR): Communications Fault
2010-08-18T11:51:57.122Z,1282132317.122 [ThrusterHE](INFO): Runnable
2010-08-18T11:51:57.123Z,1282132317.123 [ThrusterHE](INFO): Unexpected data on serial port:
>,78
0045
2010-08-18T11:51:57.142Z,1282132317.142 [CTD_Seabird](INFO): Powering down
2010-08-18T11:51:57.146Z,1282132317.146 [ThrusterHE](INFO): Speed Good:29.138271
2010-08-18T11:51:57.150Z,1282132317.150 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2010-08-18T11:51:57.151Z,1282132317.151 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2010-08-18T11:51:57.531Z,1282132317.531 [ThrusterHE](INFO): Runnable
2010-08-18T11:51:57.531Z,1282132317.531 [ThrusterHE](INFO): Unexpected data on serial port:
>,78
0046
2010-08-18T11:51:57.559Z,1282132317.559 [ThrusterHE](INFO): Speed Good:29.554533
2010-08-18T11:51:57.923Z,1282132317.923 [ThrusterHE](INFO): Runnable
2010-08-18T11:51:57.923Z,1282132317.923 [ThrusterHE](INFO): Unexpected data on serial port:
>,78
0047
2010-08-18T11:51:57.950Z,1282132317.950 [ThrusterHE](INFO): Speed Good:29.554533
2010-08-18T11:51:58.339Z,1282132318.339 [ThrusterHE](INFO): Runnable
2010-08-18T11:51:58.339Z,1282132318.339 [ThrusterHE](INFO): Unexpected data on serial port:
>,78
0047
2010-08-18T11:51:58.366Z,1282132318.366 [ThrusterHE](INFO): Speed Good:29.970795
2010-08-18T11:51:58.714Z,1282132318.714 [ThrusterHE](INFO): Runnable
2010-08-18T11:51:58.715Z,1282132318.715 [ThrusterHE](INFO): Unexpected data on serial port:
>,78
0048
2010-08-18T11:51:58.731Z,1282132318.731 [ThrusterHE](INFO): Speed Good:29.970795
2010-08-18T11:51:59.128Z,1282132319.128 [ThrusterHE](INFO): Runnable
2010-08-18T11:51:59.128Z,1282132319.128 [ThrusterHE](INFO): Unexpected data on serial port:
>,78
0048
2010-08-18T11:51:59.154Z,1282132319.154 [ThrusterHE](INFO): Speed Good:30.387054
2010-08-18T11:51:59.527Z,1282132319.527 [ThrusterHE](INFO): Runnable
2010-08-18T11:51:59.527Z,1282132319.527 [ThrusterHE](INFO): Unexpected data on serial port:
>,78
0049
2010-08-18T11:51:59.546Z,1282132319.546 [ThrusterHE](INFO): Speed Good:30.387054
2010-08-18T11:51:59.696Z,1282132319.696 [CommandExec](IMPORTANT): got command maintain clear
2010-08-18T11:51:59.959Z,1282132319.959 [ThrusterHE](INFO): Runnable
2010-08-18T11:51:59.959Z,1282132319.959 [ThrusterHE](INFO): Unexpected data on serial port:
>,78
0049
2010-08-18T11:51:59.990Z,1282132319.990 [ThrusterHE](INFO): Speed Good:30.387054
2010-08-18T11:52:00.007Z,1282132320.007 [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:52:00.327Z,1282132320.327 [ThrusterHE](INFO): Runnable
2010-08-18T11:52:00.327Z,1282132320.327 [ThrusterHE](INFO): Unexpected data on serial port:
>,78
0049
2010-08-18T11:52:00.747Z,1282132320.747 [ThrusterHE](INFO): Pause
2010-08-18T11:52:27.777Z,1282132347.777 [SBIT](IMPORTANT): SBIT PASSED
2010-08-18T11:52:27.777Z,1282132347.777 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2010-08-18T11:52:27.779Z,1282132347.779 [SBIT](IMPORTANT): AHRS_M2.loadAtStartup=0 bool;
2010-08-18T11:52:27.779Z,1282132347.779 [SBIT](IMPORTANT): BackseatComponent.loadAtStartup=1 bool;
2010-08-18T11:52:27.781Z,1282132347.781 [SBIT](IMPORTANT): CBIT.gf24Offset=149 microampere;
2010-08-18T11:52:27.781Z,1282132347.781 [SBIT](IMPORTANT): CTD_NeilBrown.loadAtStartup=0 bool;
2010-08-18T11:52:27.782Z,1282132347.782 [SBIT](IMPORTANT): CTD_Seabird.loadAtStartup=1 bool;
2010-08-18T11:52:27.782Z,1282132347.782 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool;
2010-08-18T11:52:27.782Z,1282132347.782 [SBIT](IMPORTANT): IBIT.batteryCapacityThreshold=5 ampere_hour;
2010-08-18T11:52:27.782Z,1282132347.782 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=11 volt;
2010-08-18T11:52:27.782Z,1282132347.782 [SBIT](IMPORTANT): NAL9602.fastGPSFix=1 bool;
2010-08-18T11:52:27.782Z,1282132347.782 [SBIT](IMPORTANT): PAR_Licor.adcCal=8.76539e-06 microampere_per_count;
2010-08-18T11:52:27.782Z,1282132347.782 [SBIT](IMPORTANT): PAR_Licor.darkCount=4 count;
2010-08-18T11:52:27.782Z,1282132347.782 [SBIT](IMPORTANT): PAR_Licor.loadAtStartup=1 bool;
2010-08-18T11:52:27.783Z,1282132347.783 [SBIT](IMPORTANT): PAR_Licor.multiplier=269.34 micromole_per_second_per_square_meter_per_microampere;
2010-08-18T11:52:27.783Z,1282132347.783 [SBIT](IMPORTANT): PAR_Licor.parCal=1.221 none;
2010-08-18T11:52:27.784Z,1282132347.784 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=235 cubic_centimeter;
2010-08-18T11:52:27.785Z,1282132347.785 [SBIT](IMPORTANT): VerticalControl.massDefault=0 centimeter;
2010-08-18T11:52:27.786Z,1282132347.786 [SBIT](IMPORTANT): VerticalControl.massPositionLimitAft=-27 millimeter;
2010-08-18T11:52:27.786Z,1282132347.786 [SBIT](IMPORTANT): VerticalControl.massPositionLimitFwd=37 millimeter;
2010-08-18T11:52:28.193Z,1282132348.193 [MissionManager](IMPORTANT): Started mission Startup
2010-08-18T11:52:28.194Z,1282132348.194 [Startup] Running Loop=1
2010-08-18T11:52:28.194Z,1282132348.194 [Startup](DEBUG): Aggregate::initialize Startup
2010-08-18T11:52:28.194Z,1282132348.194 [Startup:A.GoToSurface] Running Loop=1
2010-08-18T11:52:28.194Z,1282132348.194 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2010-08-18T11:52:28.195Z,1282132348.195 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2010-08-18T11:52:28.195Z,1282132348.195 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2010-08-18T11:52:28.195Z,1282132348.195 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2010-08-18T11:52:28.196Z,1282132348.196 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2010-08-18T11:52:28.196Z,1282132348.196 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2010-08-18T11:52:28.198Z,1282132348.198 [Startup:StartupSatComms] Running Loop=1
2010-08-18T11:52:28.199Z,1282132348.199 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2010-08-18T11:52:28.199Z,1282132348.199 [Startup:StartupSatComms:A] Running Loop=1
2010-08-18T11:52:28.585Z,1282132348.585 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2010-08-18T11:53:13.413Z,1282132393.413 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2010-08-18T11:53:13.414Z,1282132393.414 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2010-08-18T11:53:13.414Z,1282132393.414 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2010-08-18T11:53:13.415Z,1282132393.415 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2010-08-18T11:53:13.415Z,1282132393.415 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2010-08-18T11:53:13.415Z,1282132393.415 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2010-08-18T11:53:13.426Z,1282132393.426 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2010-08-18T11:53:13.427Z,1282132393.427 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2010-08-18T11:53:13.826Z,1282132393.826 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2010-08-18T11:53:13.826Z,1282132393.826 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2010-08-18T11:53:13.827Z,1282132393.827 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2010-08-18T11:53:13.827Z,1282132393.827 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2010-08-18T11:53:14.228Z,1282132394.228 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2010-08-18T11:53:28.358Z,1282132408.358 [Startup:StartupSatComms:A](INFO): Timed out from 2010-08-18T11:52:28.2Z
2010-08-18T11:53:28.358Z,1282132408.358 [Startup:StartupSatComms:A] Stopped
2010-08-18T11:53:28.358Z,1282132408.358 [Startup:StartupSatComms:B] Running Loop=1
2010-08-18T11:53:28.763Z,1282132408.763 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2010-08-18T11:53:40.784Z,1282132420.784 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005215
2010-08-18T11:53:47.848Z,1282132427.848 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20100818T114707/Courier0004.lzma
2010-08-18T11:53:48.848Z,1282132428.848 [DataOverHttps](INFO): Moved sent file to Logs/20100818T114707/Courier0004.lzma.bak
2010-08-18T11:53:48.848Z,1282132428.848 [DataOverHttps](INFO): SBD MOMSN=16171783
2010-08-18T11:54:04.110Z,1282132444.110 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20100818T115104/Courier0000.lzma
2010-08-18T11:54:05.111Z,1282132445.111 [DataOverHttps](INFO): Moved sent file to Logs/20100818T115104/Courier0000.lzma.bak
2010-08-18T11:54:05.112Z,1282132445.112 [DataOverHttps](INFO): SBD MOMSN=16171785
2010-08-18T11:54:20.006Z,1282132460.006 [DataOverHttps](INFO): Sending 173 bytes from file Logs/20100818T114318/Express0005.lzma
2010-08-18T11:54:21.007Z,1282132461.007 [DataOverHttps](INFO): Moved sent file to Logs/20100818T114318/Express0005.lzma.bak
2010-08-18T11:54:21.007Z,1282132461.007 [DataOverHttps](INFO): SBD MOMSN=16171788
2010-08-18T11:54:26.968Z,1282132466.968 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2010-08-18T11:54:26.968Z,1282132466.968 [CTD_Seabird] No Fault, FailCount= 3
2010-08-18T11:54:27.158Z,1282132467.158 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2010-08-18T11:54:28.572Z,1282132468.572 [Startup:StartupSatComms:B](INFO): Timed out from 2010-08-18T11:53:28.4Z
2010-08-18T11:54:28.572Z,1282132468.572 [Startup:StartupSatComms:B] Stopped
2010-08-18T11:54:28.572Z,1282132468.572 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2010-08-18T11:54:28.572Z,1282132468.572 [Startup:StartupSatComms] Stopped
2010-08-18T11:54:28.572Z,1282132468.572 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2010-08-18T11:54:28.573Z,1282132468.573 [Startup](INFO): Completed Startup
2010-08-18T11:54:28.578Z,1282132468.578 [MissionManager](INFO): Startup is completed.
2010-08-18T11:54:28.578Z,1282132468.578 [MissionManager](INFO): Uninitializing Mission Startup
2010-08-18T11:54:28.578Z,1282132468.578 [Startup] Stopped
2010-08-18T11:54:28.578Z,1282132468.578 [Startup](DEBUG): Aggregate::uninitialize Startup
2010-08-18T11:54:28.578Z,1282132468.578 [Startup:A.GoToSurface] Stopped
2010-08-18T11:54:28.578Z,1282132468.578 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2010-08-18T11:54:28.971Z,1282132468.971 [MissionManager](IMPORTANT): Started mission Default
2010-08-18T11:54:28.971Z,1282132468.971 [Default] Running Loop=1
2010-08-18T11:54:28.971Z,1282132468.971 [Default](DEBUG): Aggregate::initialize Default
2010-08-18T11:54:28.971Z,1282132468.971 [Default:B.GoToSurface] Running Loop=1
2010-08-18T11:54:28.971Z,1282132468.971 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2010-08-18T11:54:28.972Z,1282132468.972 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2010-08-18T11:54:28.972Z,1282132468.972 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2010-08-18T11:54:28.972Z,1282132468.972 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2010-08-18T11:54:28.973Z,1282132468.973 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2010-08-18T11:54:28.973Z,1282132468.973 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2010-08-18T11:54:28.973Z,1282132468.973 [Default:A.Wait] Running Loop=1
2010-08-18T11:54:28.973Z,1282132468.973 [Default:A.Wait](DEBUG): Initialize Wait Component.
2010-08-18T11:54:37.935Z,1282132477.935 [DataOverHttps](INFO): Sending 1307 bytes from file Logs/20100818T114707/Express0001.lzma
2010-08-18T11:54:38.935Z,1282132478.935 [DataOverHttps](INFO): Moved sent file to Logs/20100818T114707/Express0001.lzma.bak
2010-08-18T11:54:38.935Z,1282132478.935 [DataOverHttps](INFO): SBD MOMSN=16171794
2010-08-18T11:54:40.210Z,1282132480.210 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2010-08-18T11:54:40.210Z,1282132480.210 [CTD_Seabird] Communications Fault, FailCount= 1
2010-08-18T11:54:40.210Z,1282132480.210 [CTD_Seabird](ERROR): Communications Fault
2010-08-18T11:54:40.319Z,1282132480.319 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2010-08-18T11:54:40.614Z,1282132480.614 [CTD_Seabird](INFO): Powering down
2010-08-18T11:54:41.902Z,1282132481.902 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2010-08-18T11:54:41.902Z,1282132481.902 [CTD_Seabird] No Fault, FailCount= 1
2010-08-18T11:54:41.954Z,1282132481.954 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2010-08-18T11:54:42.298Z,1282132482.298 [Default:A.Wait](INFO): Done Waiting.
2010-08-18T11:54:42.298Z,1282132482.298 [Default:A.Wait] Stopped
2010-08-18T11:54:42.298Z,1282132482.298 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2010-08-18T11:54:42.708Z,1282132482.708 [Default:CheckIn] Running Loop=1
2010-08-18T11:54:42.708Z,1282132482.708 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2010-08-18T11:54:42.708Z,1282132482.708 [Default:CheckIn:Read_GPS] Running Loop=1
2010-08-18T11:54:43.104Z,1282132483.104 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2010-08-18T11:54:55.006Z,1282132495.006 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2010-08-18T11:54:55.006Z,1282132495.006 [CTD_Seabird] Communications Fault, FailCount= 2
2010-08-18T11:54:55.006Z,1282132495.006 [CTD_Seabird](ERROR): Communications Fault
2010-08-18T11:54:55.261Z,1282132495.261 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2010-08-18T11:54:55.410Z,1282132495.410 [CTD_Seabird](INFO): Powering down
2010-08-18T11:54:56.466Z,1282132496.466 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2010-08-18T11:54:56.466Z,1282132496.466 [CTD_Seabird] No Fault, FailCount= 2
2010-08-18T11:54:56.754Z,1282132496.754 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2010-08-18T11:54:59.307Z,1282132499.307 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2010-08-18T11:55:09.806Z,1282132509.806 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2010-08-18T11:55:09.806Z,1282132509.806 [CTD_Seabird] Communications Fault, FailCount= 3
2010-08-18T11:55:09.806Z,1282132509.806 [CTD_Seabird](ERROR): Communications Fault
2010-08-18T11:55:10.208Z,1282132510.208 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2010-08-18T11:55:10.208Z,1282132510.208 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2010-08-18T11:55:10.210Z,1282132510.210 [CTD_Seabird](INFO): Powering down
2010-08-18T11:55:14.622Z,1282132514.622 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2010-08-18T11:55:14.622Z,1282132514.622 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2010-08-18T11:55:14.622Z,1282132514.622 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2010-08-18T11:55:14.624Z,1282132514.624 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2010-08-18T11:55:14.624Z,1282132514.624 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2010-08-18T11:55:14.624Z,1282132514.624 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2010-08-18T11:55:14.635Z,1282132514.635 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2010-08-18T11:55:14.635Z,1282132514.635 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2010-08-18T11:55:15.026Z,1282132515.026 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2010-08-18T11:55:15.026Z,1282132515.026 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2010-08-18T11:55:15.027Z,1282132515.027 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2010-08-18T11:55:15.027Z,1282132515.027 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2010-08-18T11:55:15.423Z,1282132515.423 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2010-08-18T11:56:57.655Z,1282132617.655 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2010-08-18T11:57:15.434Z,1282132635.434 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2010-08-18T11:57:15.434Z,1282132635.434 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2010-08-18T11:57:15.434Z,1282132635.434 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2010-08-18T11:57:15.436Z,1282132635.436 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2010-08-18T11:57:15.436Z,1282132635.436 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2010-08-18T11:57:15.436Z,1282132635.436 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2010-08-18T11:57:15.447Z,1282132635.447 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2010-08-18T11:57:15.447Z,1282132635.447 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2010-08-18T11:57:15.864Z,1282132635.864 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2010-08-18T11:57:15.864Z,1282132635.864 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2010-08-18T11:57:15.865Z,1282132635.865 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2010-08-18T11:57:15.865Z,1282132635.865 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2010-08-18T11:57:16.258Z,1282132636.258 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2010-08-18T11:57:25.991Z,1282132645.991 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2010-08-18T11:57:40.107Z,1282132660.107 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2010-08-18T11:57:40.107Z,1282132660.107 [CTD_Seabird] No Fault, FailCount= 3
2010-08-18T11:57:40.226Z,1282132660.226 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2010-08-18T11:57:53.278Z,1282132673.278 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2010-08-18T11:57:53.278Z,1282132673.278 [CTD_Seabird] Communications Fault, FailCount= 1
2010-08-18T11:57:53.278Z,1282132673.278 [CTD_Seabird](ERROR): Communications Fault
2010-08-18T11:57:53.469Z,1282132673.469 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2010-08-18T11:57:53.682Z,1282132673.682 [CTD_Seabird](INFO): Powering down
2010-08-18T11:57:54.661Z,1282132674.661 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2010-08-18T11:57:54.662Z,1282132674.662 [CTD_Seabird] No Fault, FailCount= 1
2010-08-18T11:57:55.030Z,1282132675.030 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2010-08-18T11:58:08.086Z,1282132688.086 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2010-08-18T11:58:08.086Z,1282132688.086 [CTD_Seabird] Communications Fault, FailCount= 2
2010-08-18T11:58:08.086Z,1282132688.086 [CTD_Seabird](ERROR): Communications Fault
2010-08-18T11:58:08.397Z,1282132688.397 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2010-08-18T11:58:08.490Z,1282132688.490 [CTD_Seabird](INFO): Powering down
2010-08-18T11:58:09.594Z,1282132689.594 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2010-08-18T11:58:09.594Z,1282132689.594 [CTD_Seabird] No Fault, FailCount= 2
2010-08-18T11:58:09.834Z,1282132689.834 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2010-08-18T11:58:22.886Z,1282132702.886 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2010-08-18T11:58:22.886Z,1282132702.886 [CTD_Seabird] Communications Fault, FailCount= 3
2010-08-18T11:58:22.886Z,1282132702.886 [CTD_Seabird](ERROR): Communications Fault
2010-08-18T11:58:22.945Z,1282132702.945 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2010-08-18T11:58:22.946Z,1282132702.946 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2010-08-18T11:58:23.290Z,1282132703.290 [CTD_Seabird](INFO): Powering down
2010-08-18T11:58:34.265Z,1282132714.265 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2010-08-18T11:59:16.645Z,1282132756.645 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2010-08-18T11:59:16.646Z,1282132756.646 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2010-08-18T11:59:16.646Z,1282132756.646 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2010-08-18T11:59:16.648Z,1282132756.648 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2010-08-18T11:59:16.648Z,1282132756.648 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4
2010-08-18T11:59:16.648Z,1282132756.648 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2010-08-18T11:59:16.659Z,1282132756.659 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2010-08-18T11:59:16.659Z,1282132756.659 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2010-08-18T11:59:17.084Z,1282132757.084 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2010-08-18T11:59:17.084Z,1282132757.084 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2010-08-18T11:59:17.085Z,1282132757.085 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2010-08-18T11:59:17.085Z,1282132757.085 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4
2010-08-18T11:59:17.457Z,1282132757.457 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2010-08-18T11:59:42.911Z,1282132782.911 [Default:CheckIn:Read_GPS](INFO): Timed out from 2010-08-18T11:54:42.7Z
2010-08-18T11:59:42.911Z,1282132782.911 [Default:CheckIn:Read_GPS] Stopped
2010-08-18T11:59:42.911Z,1282132782.911 [Default:CheckIn:Read_Iridium] Running Loop=1
2010-08-18T11:59:43.300Z,1282132783.300 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2010-08-18T11:59:50.213Z,1282132790.213 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20100818T115104/Courier0004.lzma
2010-08-18T11:59:51.215Z,1282132791.215 [DataOverHttps](INFO): Moved sent file to Logs/20100818T115104/Courier0004.lzma.bak
2010-08-18T11:59:51.215Z,1282132791.215 [DataOverHttps](INFO): SBD MOMSN=16171881
2010-08-18T12:00:10.490Z,1282132810.490 [DataOverHttps](INFO): Sending 162 bytes from file Logs/20100818T114707/Express0005.lzma
2010-08-18T12:00:11.492Z,1282132811.492 [DataOverHttps](INFO): Moved sent file to Logs/20100818T114707/Express0005.lzma.bak
2010-08-18T12:00:11.492Z,1282132811.492 [DataOverHttps](INFO): SBD MOMSN=16171883
2010-08-18T12:00:33.240Z,1282132833.240 [DataOverHttps](INFO): Sending 1266 bytes from file Logs/20100818T115104/Express0001.lzma
2010-08-18T12:00:34.239Z,1282132834.239 [DataOverHttps](INFO): Moved sent file to Logs/20100818T115104/Express0001.lzma.bak
2010-08-18T12:00:34.240Z,1282132834.240 [DataOverHttps](INFO): SBD MOMSN=16171891
2010-08-18T12:00:51.319Z,1282132851.319 [DataOverHttps](INFO): Sending 383 bytes from file Logs/20100818T115104/Express0005.lzma
2010-08-18T12:00:52.319Z,1282132852.319 [DataOverHttps](INFO): Moved sent file to Logs/20100818T115104/Express0005.lzma.bak
2010-08-18T12:00:52.320Z,1282132852.320 [DataOverHttps](INFO): SBD MOMSN=16171932
2010-08-18T12:00:53.239Z,1282132853.239 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2010-08-18T12:00:53.239Z,1282132853.239 [CTD_Seabird] No Fault, FailCount= 3
2010-08-18T12:00:53.362Z,1282132853.362 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2010-08-18T12:00:56.917Z,1282132856.917 [Default:CheckIn:Read_Iridium] Stopped
2010-08-18T12:00:56.917Z,1282132856.917 [Default:CheckIn:C.Wait] Running Loop=1
2010-08-18T12:00:56.917Z,1282132856.917 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2010-08-18T12:01:06.414Z,1282132866.414 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2010-08-18T12:01:06.414Z,1282132866.414 [CTD_Seabird] Communications Fault, FailCount= 1
2010-08-18T12:01:06.414Z,1282132866.414 [CTD_Seabird](ERROR): Communications Fault
2010-08-18T12:01:06.595Z,1282132866.595 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2010-08-18T12:01:06.818Z,1282132866.818 [CTD_Seabird](INFO): Powering down
2010-08-18T12:01:07.796Z,1282132867.796 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2010-08-18T12:01:07.797Z,1282132867.797 [CTD_Seabird] No Fault, FailCount= 1
2010-08-18T12:01:08.166Z,1282132868.166 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2010-08-18T12:01:14.650Z,1282132874.650 [Power24vConverter](INFO): Powering down.
2010-08-18T12:01:17.489Z,1282132877.489 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2010-08-18T12:01:17.489Z,1282132877.489 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2010-08-18T12:01:17.489Z,1282132877.489 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2010-08-18T12:01:17.491Z,1282132877.491 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2010-08-18T12:01:17.491Z,1282132877.491 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5
2010-08-18T12:01:17.491Z,1282132877.491 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2010-08-18T12:01:17.503Z,1282132877.503 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2010-08-18T12:01:17.503Z,1282132877.503 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2010-08-18T12:01:17.914Z,1282132877.914 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2010-08-18T12:01:17.914Z,1282132877.914 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2010-08-18T12:01:17.914Z,1282132877.914 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2010-08-18T12:01:17.914Z,1282132877.914 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5
2010-08-18T12:01:18.287Z,1282132878.287 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2010-08-18T12:01:21.218Z,1282132881.218 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2010-08-18T12:01:21.218Z,1282132881.218 [CTD_Seabird] Communications Fault, FailCount= 2
2010-08-18T12:01:21.218Z,1282132881.218 [CTD_Seabird](ERROR): Communications Fault
2010-08-18T12:01:21.533Z,1282132881.533 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2010-08-18T12:01:21.622Z,1282132881.622 [CTD_Seabird](INFO): Powering down
2010-08-18T12:01:22.732Z,1282132882.732 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2010-08-18T12:01:22.733Z,1282132882.733 [CTD_Seabird] No Fault, FailCount= 2
2010-08-18T12:01:22.962Z,1282132882.962 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2010-08-18T12:01:36.014Z,1282132896.014 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2010-08-18T12:01:36.014Z,1282132896.014 [CTD_Seabird] Communications Fault, FailCount= 3
2010-08-18T12:01:36.014Z,1282132896.014 [CTD_Seabird](ERROR): Communications Fault
2010-08-18T12:01:36.081Z,1282132896.081 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2010-08-18T12:01:36.103Z,1282132896.103 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2010-08-18T12:01:36.418Z,1282132896.418 [CTD_Seabird](INFO): Powering down
2010-08-18T12:01:54.634Z,1282132914.634 [NAL9602](FAULT): GPS failed to acquire within timeout.
2010-08-18T12:01:54.634Z,1282132914.634 [NAL9602] Data Fault, FailCount= 1
2010-08-18T12:01:54.634Z,1282132914.634 [NAL9602](ERROR): Data Fault
2010-08-18T12:01:54.650Z,1282132914.650 [CBIT](ERROR): Data Fault in component: NAL9602
2010-08-18T12:01:55.043Z,1282132915.043 [NAL9602](INFO): Powering down
2010-08-18T12:01:55.857Z,1282132915.857 [CBIT](INFO): Clearing failed state for component NAL9602
2010-08-18T12:01:55.857Z,1282132915.857 [NAL9602] No Fault, FailCount= 1
2010-08-18T12:02:25.352Z,1282132945.352 [NAL9602](INFO): Powering up NAL9602
2010-08-18T12:02:36.246Z,1282132956.246 [NAL9602](INFO): NAL9602 initialized
2010-08-18T12:03:18.757Z,1282132998.757 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2010-08-18T12:03:18.758Z,1282132998.758 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2010-08-18T12:03:18.758Z,1282132998.758 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2010-08-18T12:03:18.759Z,1282132998.759 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2010-08-18T12:03:18.759Z,1282132998.759 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6
2010-08-18T12:03:18.759Z,1282132998.759 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2010-08-18T12:03:18.772Z,1282132998.772 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2010-08-18T12:03:18.772Z,1282132998.772 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2010-08-18T12:03:19.087Z,1282132999.087 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2010-08-18T12:03:19.088Z,1282132999.088 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2010-08-18T12:03:19.088Z,1282132999.088 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2010-08-18T12:03:19.088Z,1282132999.088 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6
2010-08-18T12:03:19.489Z,1282132999.489 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2010-08-18T12:03:44.984Z,1282133024.984 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2010-08-18T12:03:56.687Z,1282133036.687 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2010-08-18T12:04:06.382Z,1282133046.382 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2010-08-18T12:04:06.382Z,1282133046.382 [CTD_Seabird] No Fault, FailCount= 3
2010-08-18T12:04:06.442Z,1282133046.442 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2010-08-18T12:04:19.494Z,1282133059.494 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2010-08-18T12:04:19.494Z,1282133059.494 [CTD_Seabird] Communications Fault, FailCount= 1
2010-08-18T12:04:19.494Z,1282133059.494 [CTD_Seabird](ERROR): Communications Fault
2010-08-18T12:04:19.689Z,1282133059.689 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2010-08-18T12:04:19.898Z,1282133059.898 [CTD_Seabird](INFO): Powering down
2010-08-18T12:04:20.994Z,1282133060.994 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2010-08-18T12:04:20.994Z,1282133060.994 [CTD_Seabird] No Fault, FailCount= 1
2010-08-18T12:04:21.242Z,1282133061.242 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2010-08-18T12:04:26.298Z,1282133066.298 [CommandExec](IMPORTANT): got command maintain control SpeedControl.propOmegaAction 300.000000 revolution_per_minute
2010-08-18T12:04:26.300Z,1282133066.300 [ComponentRegistry](DEBUG): SyncComponent "Maintain_SpeedControl.propOmegaAction" handled in the control thread.
2010-08-18T12:04:26.573Z,1282133066.573 [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-18T12:04:26.981Z,1282133066.981 [ThrusterHE](INFO): Resume
2010-08-18T12:04:27.370Z,1282133067.370 [ThrusterHE](INFO): Resuming
2010-08-18T12:04:27.775Z,1282133067.775 [ThrusterHE](INFO): Resuming
2010-08-18T12:04:28.176Z,1282133068.176 [ThrusterHE](INFO): Resuming
2010-08-18T12:04:28.569Z,1282133068.569 [ThrusterHE](INFO): Resuming
2010-08-18T12:04:28.986Z,1282133068.986 [ThrusterHE](INFO): Resuming
2010-08-18T12:04:28.987Z,1282133068.987 [ThrusterHE](INFO): Normal Promp. Good Init
2010-08-18T12:04:29.402Z,1282133069.402 [ThrusterHE](INFO): Runnable
2010-08-18T12:04:29.402Z,1282133069.402 [ThrusterHE](INFO): Unexpected data on serial port:WU
78
004A
2010-08-18T12:04:29.404Z,1282133069.404 [ThrusterHE](INFO): Send speed command forward:00FF
2010-08-18T12:04:29.799Z,1282133069.799 [ThrusterHE](INFO): Runnable
2010-08-18T12:04:29.799Z,1282133069.799 [ThrusterHE](INFO): Unexpected data on serial port:FW,00FF
004A
2010-08-18T12:04:30.188Z,1282133070.188 [ThrusterHE](INFO): Runnable
2010-08-18T12:04:30.590Z,1282133070.590 [ThrusterHE](INFO): Runnable
2010-08-18T12:04:30.591Z,1282133070.591 [ThrusterHE](INFO): Unexpected data on serial port:
>
>F
004A
2010-08-18T12:04:31.001Z,1282133071.001 [ThrusterHE](INFO): Runnable
2010-08-18T12:04:31.409Z,1282133071.409 [ThrusterHE](INFO): Runnable
2010-08-18T12:04:31.434Z,1282133071.434 [ThrusterHE](INFO): Speed Good:20.396790
2010-08-18T12:04:31.802Z,1282133071.802 [ThrusterHE](INFO): Runnable
2010-08-18T12:04:31.802Z,1282133071.802 [ThrusterHE](INFO): Unexpected data on serial port:
>,78
0031
2010-08-18T12:04:31.822Z,1282133071.822 [ThrusterHE](INFO): Speed Good:22.478096
2010-08-18T12:04:32.230Z,1282133072.230 [ThrusterHE](INFO): Runnable
2010-08-18T12:04:32.230Z,1282133072.230 [ThrusterHE](INFO): Unexpected data on serial port:
>,78
0036
2010-08-18T12:04:32.254Z,1282133072.254 [ThrusterHE](INFO): Speed Good:24.143139
2010-08-18T12:04:32.634Z,1282133072.634 [ThrusterHE](INFO): Runnable
2010-08-18T12:04:32.634Z,1282133072.634 [ThrusterHE](INFO): Unexpected data on serial port:
>,78
003A
2010-08-18T12:04:32.650Z,1282133072.650 [ThrusterHE](INFO): Speed Good:25.391922
2010-08-18T12:04:33.046Z,1282133073.046 [ThrusterHE](INFO): Runnable
2010-08-18T12:04:33.046Z,1282133073.046 [ThrusterHE](INFO): Unexpected data on serial port:
>,78
003D
2010-08-18T12:04:33.070Z,1282133073.070 [ThrusterHE](INFO): Speed Good:26.224445
2010-08-18T12:04:33.478Z,1282133073.478 [ThrusterHE](INFO): Runnable
2010-08-18T12:04:33.478Z,1282133073.478 [ThrusterHE](INFO): Unexpected data on serial port:
>,78
003F
2010-08-18T12:04:33.502Z,1282133073.502 [ThrusterHE](INFO): Speed Good:27.473228
2010-08-18T12:04:33.856Z,1282133073.856 [ThrusterHE](INFO): Runnable
2010-08-18T12:04:33.857Z,1282133073.857 [ThrusterHE](INFO): Unexpected data on serial port:
>,78
0042
2010-08-18T12:04:33.886Z,1282133073.886 [ThrusterHE](INFO): Speed Good:27.889488
2010-08-18T12:04:34.252Z,1282133074.252 [ThrusterHE](INFO): Runnable
2010-08-18T12:04:34.253Z,1282133074.253 [ThrusterHE](INFO): Unexpected data on serial port:
>,78
0043
2010-08-18T12:04:34.278Z,1282133074.278 [ThrusterHE](INFO): Speed Good:28.305750
2010-08-18T12:04:34.294Z,1282133074.294 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2010-08-18T12:04:34.294Z,1282133074.294 [CTD_Seabird] Communications Fault, FailCount= 2
2010-08-18T12:04:34.294Z,1282133074.294 [CTD_Seabird](ERROR): Communications Fault
2010-08-18T12:04:34.644Z,1282133074.644 [ThrusterHE](INFO): Runnable
2010-08-18T12:04:34.644Z,1282133074.644 [ThrusterHE](INFO): Unexpected data on serial port:
>,78
0044
2010-08-18T12:04:34.667Z,1282133074.667 [ThrusterHE](INFO): Speed Good:29.138271
2010-08-18T12:04:34.676Z,1282133074.676 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2010-08-18T12:04:34.698Z,1282133074.698 [CTD_Seabird](INFO): Powering down
2010-08-18T12:04:35.072Z,1282133075.072 [ThrusterHE](INFO): Runnable
2010-08-18T12:04:35.072Z,1282133075.072 [ThrusterHE](INFO): Unexpected data on serial port:
>,78
0046
2010-08-18T12:04:35.098Z,1282133075.098 [ThrusterHE](INFO): Speed Good:29.554533
2010-08-18T12:04:35.448Z,1282133075.448 [CommandExec](IMPORTANT): got command maintain clear
2010-08-18T12:04:35.459Z,1282133075.459 [ThrusterHE](INFO): Runnable
2010-08-18T12:04:35.459Z,1282133075.459 [ThrusterHE](INFO): Unexpected data on serial port:
>,78
0047
2010-08-18T12:04:35.478Z,1282133075.478 [ThrusterHE](INFO): Speed Good:29.554533
2010-08-18T12:04:35.487Z,1282133075.487 [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-18T12:04:35.858Z,1282133075.858 [ThrusterHE](INFO): Runnable
2010-08-18T12:04:35.858Z,1282133075.858 [ThrusterHE](INFO): Unexpected data on serial port:
>,78
0047
2010-08-18T12:04:35.878Z,1282133075.878 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2010-08-18T12:04:35.878Z,1282133075.878 [CTD_Seabird] No Fault, FailCount= 2
2010-08-18T12:04:36.042Z,1282133076.042 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2010-08-18T12:04:36.262Z,1282133076.262 [ThrusterHE](INFO): Pause
2010-08-18T12:04:49.094Z,1282133089.094 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2010-08-18T12:04:49.094Z,1282133089.094 [CTD_Seabird] Communications Fault, FailCount= 3
2010-08-18T12:04:49.094Z,1282133089.094 [CTD_Seabird](ERROR): Communications Fault
2010-08-18T12:04:49.193Z,1282133089.193 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2010-08-18T12:04:49.194Z,1282133089.194 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2010-08-18T12:04:49.498Z,1282133089.498 [CTD_Seabird](INFO): Powering down
2010-08-18T12:05:19.874Z,1282133119.874 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2010-08-18T12:05:19.875Z,1282133119.875 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2010-08-18T12:05:19.875Z,1282133119.875 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2010-08-18T12:05:19.876Z,1282133119.876 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2010-08-18T12:05:19.876Z,1282133119.876 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7
2010-08-18T12:05:19.876Z,1282133119.876 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2010-08-18T12:05:19.888Z,1282133119.888 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2010-08-18T12:05:19.888Z,1282133119.888 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2010-08-18T12:05:20.301Z,1282133120.301 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2010-08-18T12:05:20.301Z,1282133120.301 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2010-08-18T12:05:20.301Z,1282133120.301 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2010-08-18T12:05:20.301Z,1282133120.301 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7
2010-08-18T12:05:20.680Z,1282133120.680 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2010-08-18T12:05:57.443Z,1282133157.443 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2010-08-18T12:05:57.443Z,1282133157.443 [Default:CheckIn:C.Wait] Stopped
2010-08-18T12:05:57.443Z,1282133157.443 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2010-08-18T12:05:57.444Z,1282133157.444 [Default:CheckIn:D] Running Loop=1
2010-08-18T12:05:57.849Z,1282133157.849 [Default:CheckIn:D] Stopped
2010-08-18T12:05:57.849Z,1282133157.849 [Default:CheckIn:E] Running Loop=1
2010-08-18T12:05:58.254Z,1282133158.254 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 11.481301 min
2010-08-18T12:05:58.255Z,1282133158.255 [Default:CheckIn:E] Stopped
2010-08-18T12:05:58.255Z,1282133158.255 [Default:CheckIn](INFO): Completed Default:CheckIn
2010-08-18T12:05:58.255Z,1282133158.255 [Default:CheckIn] Stopped
2010-08-18T12:05:58.255Z,1282133158.255 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2010-08-18T12:05:58.255Z,1282133158.255 [Default:CheckIn](INFO): Running loop #2
2010-08-18T12:05:58.255Z,1282133158.255 [Default:CheckIn] Running Loop=2
2010-08-18T12:05:58.255Z,1282133158.255 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2010-08-18T12:05:58.255Z,1282133158.255 [Default:CheckIn:Read_GPS] Running Loop=1
2010-08-18T12:07:07.382Z,1282133227.382 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2010-08-18T12:07:19.493Z,1282133239.493 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2010-08-18T12:07:19.493Z,1282133239.493 [CTD_Seabird] No Fault, FailCount= 3
2010-08-18T12:07:19.538Z,1282133239.538 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2010-08-18T12:07:20.727Z,1282133240.727 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2010-08-18T12:07:20.728Z,1282133240.728 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2010-08-18T12:07:20.728Z,1282133240.728 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2010-08-18T12:07:20.729Z,1282133240.729 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2010-08-18T12:07:20.730Z,1282133240.730 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 8
2010-08-18T12:07:20.730Z,1282133240.730 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2010-08-18T12:07:20.741Z,1282133240.741 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2010-08-18T12:07:20.741Z,1282133240.741 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2010-08-18T12:07:21.116Z,1282133241.116 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2010-08-18T12:07:21.116Z,1282133241.116 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2010-08-18T12:07:21.116Z,1282133241.116 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2010-08-18T12:07:21.116Z,1282133241.116 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 8
2010-08-18T12:07:21.482Z,1282133241.482 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2010-08-18T12:07:32.590Z,1282133252.590 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2010-08-18T12:07:32.590Z,1282133252.590 [CTD_Seabird] Communications Fault, FailCount= 1
2010-08-18T12:07:32.590Z,1282133252.590 [CTD_Seabird](ERROR): Communications Fault
2010-08-18T12:07:32.808Z,1282133252.808 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2010-08-18T12:07:32.994Z,1282133252.994 [CTD_Seabird](INFO): Powering down
2010-08-18T12:07:34.030Z,1282133254.030 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2010-08-18T12:07:34.030Z,1282133254.030 [CTD_Seabird] No Fault, FailCount= 1
2010-08-18T12:07:34.338Z,1282133254.338 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2010-08-18T12:07:47.390Z,1282133267.390 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2010-08-18T12:07:47.390Z,1282133267.390 [CTD_Seabird] Communications Fault, FailCount= 2
2010-08-18T12:07:47.390Z,1282133267.390 [CTD_Seabird](ERROR): Communications Fault
2010-08-18T12:07:47.757Z,1282133267.757 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2010-08-18T12:07:47.794Z,1282133267.794 [CTD_Seabird](INFO): Powering down
2010-08-18T12:07:48.977Z,1282133268.977 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2010-08-18T12:07:48.978Z,1282133268.978 [CTD_Seabird] No Fault, FailCount= 2
2010-08-18T12:07:49.138Z,1282133269.138 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2010-08-18T12:08:01.924Z,1282133281.924 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2010-08-18T12:08:02.190Z,1282133282.190 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2010-08-18T12:08:02.190Z,1282133282.190 [CTD_Seabird] Communications Fault, FailCount= 3
2010-08-18T12:08:02.190Z,1282133282.190 [CTD_Seabird](ERROR): Communications Fault
2010-08-18T12:08:02.296Z,1282133282.296 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2010-08-18T12:08:02.297Z,1282133282.297 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2010-08-18T12:08:02.594Z,1282133282.594 [CTD_Seabird](INFO): Powering down
2010-08-18T12:08:03.515Z,1282133283.515 [CommandExec](IMPORTANT): got command restart application
2010-08-18T12:08:04.517Z,1282133284.517 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2010-08-18T12:08:04.518Z,1282133284.518 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2010-08-18T12:08:04.518Z,1282133284.518 [CommandExec](INFO): Uninitializing the command executive.
2010-08-18T12:08:04.518Z,1282133284.518 [CommandExec](INFO): Uninitializing the command scheduler.
2010-08-18T12:08:04.518Z,1282133284.518 [CommandExec ThreadHandler](INFO): Thread cancelled.
2010-08-18T12:08:04.657Z,1282133284.657 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2010-08-18T12:08:04.658Z,1282133284.658 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2010-08-18T12:08:04.658Z,1282133284.658 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2010-08-18T12:08:04.658Z,1282133284.658 [NavChartDb](INFO): Join timeout helper Thread ID is 9061
2010-08-18T12:08:04.818Z,1282133284.818 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2010-08-18T12:08:04.818Z,1282133284.818 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2010-08-18T12:08:04.826Z,1282133284.826 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2010-08-18T12:08:04.826Z,1282133284.826 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2010-08-18T12:08:04.826Z,1282133284.826 [Radio_Surface](INFO): Join timeout helper Thread ID is 9062
2010-08-18T12:08:04.858Z,1282133284.858 [Radio_Surface](INFO): Powering down
2010-08-18T12:08:04.858Z,1282133284.858 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2010-08-18T12:08:04.859Z,1282133284.859 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2010-08-18T12:08:04.869Z,1282133284.869 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2010-08-18T12:08:04.869Z,1282133284.869 [Onboard ThreadHandler](INFO): Thread cancelled.
2010-08-18T12:08:04.869Z,1282133284.869 [Onboard](INFO): Join timeout helper Thread ID is 9063
2010-08-18T12:08:05.002Z,1282133285.002 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2010-08-18T12:08:08.918Z,1282133288.918 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2010-08-18T12:08:08.918Z,1282133288.918 [Onboard ThreadHandler](INFO): Thread cancelled.
2010-08-18T12:08:08.940Z,1282133288.940 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2010-08-18T12:08:08.940Z,1282133288.940 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2010-08-18T12:08:08.941Z,1282133288.941 [DataOverHttps](INFO): Join timeout helper Thread ID is 9064
2010-08-18T12:08:09.018Z,1282133289.018 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2010-08-18T12:08:09.018Z,1282133289.018 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2010-08-18T12:08:09.038Z,1282133289.038 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2010-08-18T12:08:09.038Z,1282133289.038 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2010-08-18T12:08:09.038Z,1282133289.038 [BackseatComponent](INFO): Join timeout helper Thread ID is 9065
2010-08-18T12:08:09.202Z,1282133289.202 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2010-08-18T12:08:09.202Z,1282133289.202 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2010-08-18T12:08:09.207Z,1282133289.207 [ComponentRegistry](INFO): Shutting down WetLabsSeaOWL_UV_A ThreadHandler
2010-08-18T12:08:09.207Z,1282133289.207 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2010-08-18T12:08:09.207Z,1282133289.207 [WetLabsSeaOWL_UV_A](INFO): Join timeout helper Thread ID is 9066
2010-08-18T12:08:09.310Z,1282133289.310 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Uninitializing protected caller thread.
2010-08-18T12:08:09.310Z,1282133289.310 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2010-08-18T12:08:09.330Z,1282133289.330 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2010-08-18T12:08:09.330Z,1282133289.330 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2010-08-18T12:08:09.331Z,1282133289.331 [CTD_Seabird](INFO): Join timeout helper Thread ID is 9067
2010-08-18T12:08:09.610Z,1282133289.610 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2010-08-18T12:08:09.610Z,1282133289.610 [CTD_Seabird](INFO): Powering down
2010-08-18T12:08:09.621Z,1282133289.621 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2010-08-18T12:08:09.626Z,1282133289.626 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2010-08-18T12:08:09.626Z,1282133289.626 [logger ThreadHandler](INFO): Thread cancelled.
2010-08-18T12:08:09.627Z,1282133289.627 [logger](INFO): Join timeout helper Thread ID is 9068
2010-08-18T12:08:09.658Z,1282133289.658 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2010-08-18T12:08:09.658Z,1282133289.658 [logger ThreadHandler](INFO): Thread cancelled.
2010-08-18T12:08:09.666Z,1282133289.666 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2010-08-18T12:08:09.666Z,1282133289.666 [CommandLine ThreadHandler](INFO): Thread cancelled.
2010-08-18T12:08:09.667Z,1282133289.667 [CommandLine](INFO): Join timeout helper Thread ID is 9069
2010-08-18T12:08:09.686Z,1282133289.686 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2010-08-18T12:08:09.686Z,1282133289.686 [CommandLine ThreadHandler](INFO): Thread cancelled.
2010-08-18T12:08:09.706Z,1282133289.706 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2010-08-18T12:08:09.707Z,1282133289.707 [CommandExec ThreadHandler](INFO): Thread cancelled.
2010-08-18T12:08:09.707Z,1282133289.707 [CommandExec](INFO): Join timeout helper Thread ID is 9070
2010-08-18T12:08:09.708Z,1282133289.708 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2010-08-18T12:08:09.708Z,1282133289.708 [controlThread ThreadHandler](INFO): Thread cancelled.
2010-08-18T12:08:09.709Z,1282133289.709 [controlThread](INFO): Join timeout helper Thread ID is 9071
2010-08-18T12:08:09.934Z,1282133289.934 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2010-08-18T12:08:09.934Z,1282133289.934 [controlThread](DEBUG): Uninitializing ControlThread
2010-08-18T12:08:09.935Z,1282133289.935 [NAL9602](INFO): Powering down
2010-08-18T12:08:09.937Z,1282133289.937 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2010-08-18T12:08:09.938Z,1282133289.938 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2010-08-18T12:08:09.939Z,1282133289.939 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2010-08-18T12:08:09.940Z,1282133289.940 [MissionManager](INFO): Uninitializing Mission Default
2010-08-18T12:08:09.940Z,1282133289.940 [Default] Stopped
2010-08-18T12:08:09.940Z,1282133289.940 [Default](DEBUG): Aggregate::uninitialize Default
2010-08-18T12:08:09.940Z,1282133289.940 [Default:B.GoToSurface] Stopped
2010-08-18T12:08:09.940Z,1282133289.940 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2010-08-18T12:08:09.940Z,1282133289.940 [Default:CheckIn] Stopped
2010-08-18T12:08:09.940Z,1282133289.940 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2010-08-18T12:08:09.940Z,1282133289.940 [Default:CheckIn:Read_GPS] Stopped
2010-08-18T12:08:09.944Z,1282133289.944 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2010-08-18T12:08:09.944Z,1282133289.944 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2010-08-18T12:08:09.944Z,1282133289.944 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2010-08-18T12:08:09.944Z,1282133289.944 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2010-08-18T12:08:09.945Z,1282133289.945 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2010-08-18T12:08:09.945Z,1282133289.945 [BuoyancyServo](INFO): Powering down
2010-08-18T12:08:09.958Z,1282133289.958 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2010-08-18T12:08:09.958Z,1282133289.958 [ElevatorServo](INFO): Powering down
2010-08-18T12:08:09.959Z,1282133289.959 [MassServo](DEBUG): Uninitialize Mass Servo.
2010-08-18T12:08:09.959Z,1282133289.959 [MassServo](INFO): Powering down
2010-08-18T12:08:09.960Z,1282133289.960 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2010-08-18T12:08:09.960Z,1282133289.960 [RudderServo](INFO): Powering down
2010-08-18T12:08:09.961Z,1282133289.961 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2010-08-18T12:08:09.961Z,1282133289.961 [ThrusterHE](INFO): Powering down
2010-08-18T12:08:09.962Z,1282133289.962 [SBIT](DEBUG): Uninitialize SBIT Component.
2010-08-18T12:08:09.962Z,1282133289.962 [IBIT](DEBUG): Uninitialize IBIT Component.
2010-08-18T12:08:09.962Z,1282133289.962 [CBIT](DEBUG): Uninitialize CBIT Component.
2010-08-18T12:08:09.963Z,1282133289.963 [CBIT](DEBUG): Powering off loads.
2010-08-18T12:08:09.973Z,1282133289.973 [CBIT](DEBUG): Disabling WDT.
2010-08-18T12:08:09.985Z,1282133289.985 [CBIT](DEBUG): Opening all GF detection circuits.
2010-08-18T12:08:09.986Z,1282133289.986 [controlThread ThreadHandler](INFO): Thread cancelled.
2010-08-18T12:08:10.011Z,1282133290.011 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2010-08-18T12:08:10.015Z,1282133290.015 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2010-08-18T12:08:10.060Z,1282133290.060 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2010-08-18T12:08:10.063Z,1282133290.063 [Onboard ThreadHandler](INFO): Thread cancelled.
2010-08-18T12:08:10.068Z,1282133290.068 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2010-08-18T12:08:10.112Z,1282133290.112 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2010-08-18T12:08:10.149Z,1282133290.149 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2010-08-18T12:08:10.212Z,1282133290.212 [logger ThreadHandler](INFO): Thread cancelled.