2013-05-05T09:35:08.846Z,1367746508.846 [Supervisor](DEBUG): Initializing supervisor.
2013-05-05T09:35:08.849Z,1367746508.849 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2013-05-05T09:35:08.849Z,1367746508.849 [SyncHandler](INFO): Protected caller Thread ID is 827
2013-05-05T09:35:08.849Z,1367746508.849 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2013-05-05T09:35:08.850Z,1367746508.850 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2013-05-05T09:35:08.851Z,1367746508.851 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 828
2013-05-05T09:35:08.854Z,1367746508.854 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2013-05-05T09:35:08.871Z,1367746508.871 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2013-05-05T09:35:08.872Z,1367746508.872 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2013-05-05T09:35:08.873Z,1367746508.873 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 829
2013-05-05T09:35:08.873Z,1367746508.873 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2013-05-05T09:35:08.874Z,1367746508.874 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2013-05-05T09:35:08.875Z,1367746508.875 [logger ThreadHandler](INFO): Protected caller Thread ID is 830
2013-05-05T09:35:08.877Z,1367746508.877 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2013-05-05T09:35:08.877Z,1367746508.877 [Supervisor](INFO): Looking for Config files in directory: Config/
2013-05-05T09:35:08.881Z,1367746508.881 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2013-05-05T09:35:08.975Z,1367746508.975 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2013-05-05T09:35:08.977Z,1367746508.977 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2013-05-05T09:35:09.160Z,1367746509.160 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2013-05-05T09:35:09.161Z,1367746509.161 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2013-05-05T09:35:09.357Z,1367746509.357 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2013-05-05T09:35:09.359Z,1367746509.359 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2013-05-05T09:35:09.495Z,1367746509.495 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2013-05-05T09:35:09.496Z,1367746509.496 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2013-05-05T09:35:10.078Z,1367746510.078 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2013-05-05T09:35:10.079Z,1367746510.079 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2013-05-05T09:35:10.535Z,1367746510.535 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2013-05-05T09:35:10.536Z,1367746510.536 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2013-05-05T09:35:11.032Z,1367746511.032 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2013-05-05T09:35:11.033Z,1367746511.033 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2013-05-05T09:35:11.323Z,1367746511.323 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2013-05-05T09:35:11.324Z,1367746511.324 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2013-05-05T09:35:11.632Z,1367746511.632 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2013-05-05T09:35:11.633Z,1367746511.633 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2013-05-05T09:35:12.262Z,1367746512.262 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2013-05-05T09:35:12.263Z,1367746512.263 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2013-05-05T09:35:12.407Z,1367746512.407 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2013-05-05T09:35:12.407Z,1367746512.407 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2013-05-05T09:35:12.513Z,1367746512.513 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2013-05-05T09:35:12.515Z,1367746512.515 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2013-05-05T09:35:12.595Z,1367746512.595 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2013-05-05T09:35:12.695Z,1367746512.695 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2013-05-05T09:35:12.696Z,1367746512.696 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2013-05-05T09:35:12.885Z,1367746512.885 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2013-05-05T09:35:12.885Z,1367746512.885 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2013-05-05T09:35:13.090Z,1367746513.090 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2013-05-05T09:35:13.092Z,1367746513.092 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2013-05-05T09:35:13.094Z,1367746513.094 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2013-05-05T09:35:13.177Z,1367746513.177 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2013-05-05T09:35:13.423Z,1367746513.423 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2013-05-05T09:35:13.424Z,1367746513.424 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2013-05-05T09:35:13.517Z,1367746513.517 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2013-05-05T09:35:13.679Z,1367746513.679 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2013-05-05T09:35:13.879Z,1367746513.879 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2013-05-05T09:35:13.962Z,1367746513.962 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2013-05-05T09:35:14.090Z,1367746514.090 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2013-05-05T09:35:14.238Z,1367746514.238 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2013-05-05T09:35:14.395Z,1367746514.395 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2013-05-05T09:35:14.497Z,1367746514.497 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2013-05-05T09:35:14.593Z,1367746514.593 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2013-05-05T09:35:14.610Z,1367746514.610 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2013-05-05T09:35:14.735Z,1367746514.735 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2013-05-05T09:35:14.736Z,1367746514.736 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2013-05-05T09:35:14.893Z,1367746514.893 [BuoyancyServo] Loaded
2013-05-05T09:35:14.893Z,1367746514.893 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2013-05-05T09:35:14.911Z,1367746514.911 [ElevatorServo] Loaded
2013-05-05T09:35:14.911Z,1367746514.911 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2013-05-05T09:35:14.927Z,1367746514.927 [MassServo] Loaded
2013-05-05T09:35:14.928Z,1367746514.928 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2013-05-05T09:35:14.944Z,1367746514.944 [RudderServo] Loaded
2013-05-05T09:35:14.945Z,1367746514.945 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2013-05-05T09:35:14.960Z,1367746514.960 [ThrusterServo] Loaded
2013-05-05T09:35:14.961Z,1367746514.961 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2013-05-05T09:35:14.961Z,1367746514.961 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2013-05-05T09:35:14.963Z,1367746514.963 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2013-05-05T09:35:15.122Z,1367746515.122 [SBIT](DEBUG): Construct Startup Built In Test.
2013-05-05T09:35:15.136Z,1367746515.136 [SBIT] Loaded
2013-05-05T09:35:15.136Z,1367746515.136 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2013-05-05T09:35:15.137Z,1367746515.137 [IBIT](DEBUG): Construct Initiated Built In Test.
2013-05-05T09:35:15.156Z,1367746515.156 [IBIT] Loaded
2013-05-05T09:35:15.156Z,1367746515.156 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2013-05-05T09:35:15.159Z,1367746515.159 [CBIT](DEBUG): Construct Continuous Built In Test.
2013-05-05T09:35:15.356Z,1367746515.356 [CBIT] Loaded
2013-05-05T09:35:15.357Z,1367746515.357 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2013-05-05T09:35:15.357Z,1367746515.357 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2013-05-05T09:35:15.359Z,1367746515.359 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2013-05-05T09:35:15.628Z,1367746515.628 [CANONSampler] Loaded
2013-05-05T09:35:15.628Z,1367746515.628 [ComponentRegistry](DEBUG): SyncComponent "CANONSampler" handled in the control thread.
2013-05-05T09:35:15.646Z,1367746515.646 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density
2013-05-05T09:35:15.649Z,1367746515.649 [CTD_Seabird](INFO): created writer for : sea_water_density
2013-05-05T09:35:15.650Z,1367746515.650 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth
2013-05-05T09:35:15.653Z,1367746515.653 [CTD_Seabird](INFO): created writer for : depth
2013-05-05T09:35:15.653Z,1367746515.653 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure
2013-05-05T09:35:15.656Z,1367746515.656 [CTD_Seabird](INFO): created writer for : sea_water_pressure
2013-05-05T09:35:15.657Z,1367746515.657 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity
2013-05-05T09:35:15.659Z,1367746515.659 [CTD_Seabird](INFO): created writer for : sea_water_salinity
2013-05-05T09:35:15.660Z,1367746515.660 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature
2013-05-05T09:35:15.663Z,1367746515.663 [CTD_Seabird](INFO): created writer for : sea_water_temperature
2013-05-05T09:35:15.663Z,1367746515.663 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity
2013-05-05T09:35:15.666Z,1367746515.666 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity
2013-05-05T09:35:15.667Z,1367746515.667 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water
2013-05-05T09:35:15.670Z,1367746515.670 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water
2013-05-05T09:35:15.670Z,1367746515.670 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): mass_concentration_of_oxygen_in_sea_water
2013-05-05T09:35:15.673Z,1367746515.673 [CTD_Seabird](INFO): created writer for : mass_concentration_of_oxygen_in_sea_water
2013-05-05T09:35:15.673Z,1367746515.673 [CTD_Seabird](DEBUG): LcmSlateWriter::add(DAtaURI): CTD_Seabird.sea_water_dissolved_oxygen_freq
2013-05-05T09:35:15.674Z,1367746515.674 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): dataName: sea_water_dissolved_oxygen_freq
2013-05-05T09:35:15.689Z,1367746515.689 [CTD_Seabird] Loaded
2013-05-05T09:35:15.689Z,1367746515.689 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2013-05-05T09:35:15.690Z,1367746515.690 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406784E0
2013-05-05T09:35:15.690Z,1367746515.690 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 913
2013-05-05T09:35:15.718Z,1367746515.718 [ESPComponent] Loaded
2013-05-05T09:35:15.718Z,1367746515.718 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2013-05-05T09:35:15.734Z,1367746515.734 [PAR_Licor] Loaded
2013-05-05T09:35:15.735Z,1367746515.735 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2013-05-05T09:35:15.747Z,1367746515.747 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output470
2013-05-05T09:35:15.747Z,1367746515.747 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output470
2013-05-05T09:35:15.749Z,1367746515.749 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output650
2013-05-05T09:35:15.749Z,1367746515.749 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output650
2013-05-05T09:35:15.751Z,1367746515.751 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.OutputChl
2013-05-05T09:35:15.751Z,1367746515.751 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: OutputChl
2013-05-05T09:35:15.753Z,1367746515.753 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg470nm
2013-05-05T09:35:15.753Z,1367746515.753 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg470nm
2013-05-05T09:35:15.755Z,1367746515.755 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg650nm
2013-05-05T09:35:15.755Z,1367746515.755 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg650nm
2013-05-05T09:35:15.757Z,1367746515.757 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff470nm
2013-05-05T09:35:15.757Z,1367746515.757 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff470nm
2013-05-05T09:35:15.759Z,1367746515.759 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff650nm
2013-05-05T09:35:15.759Z,1367746515.759 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff650nm
2013-05-05T09:35:15.761Z,1367746515.761 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): mass_concentration_of_chlorophyll_in_sea_water
2013-05-05T09:35:15.763Z,1367746515.763 [WetLabsBB2FL](INFO): created writer for : mass_concentration_of_chlorophyll_in_sea_water
2013-05-05T09:35:15.764Z,1367746515.764 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water
2013-05-05T09:35:15.764Z,1367746515.764 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_median_mass_concentration_of_chlorophyll_in_sea_water
2013-05-05T09:35:15.766Z,1367746515.766 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2013-05-05T09:35:15.766Z,1367746515.766 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2013-05-05T09:35:15.768Z,1367746515.768 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2013-05-05T09:35:15.768Z,1367746515.768 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2013-05-05T09:35:15.770Z,1367746515.770 [WetLabsBB2FL] Loaded
2013-05-05T09:35:15.770Z,1367746515.770 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2013-05-05T09:35:15.771Z,1367746515.771 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406A84E0
2013-05-05T09:35:15.771Z,1367746515.771 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 914
2013-05-05T09:35:15.772Z,1367746515.772 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2013-05-05T09:35:15.774Z,1367746515.774 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2013-05-05T09:35:15.824Z,1367746515.824 [DepthRateCalculator] Loaded
2013-05-05T09:35:15.824Z,1367746515.824 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2013-05-05T09:35:15.827Z,1367746515.827 [PitchRateCalculator] Loaded
2013-05-05T09:35:15.828Z,1367746515.828 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2013-05-05T09:35:15.836Z,1367746515.836 [SpeedCalculator] Loaded
2013-05-05T09:35:15.836Z,1367746515.836 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2013-05-05T09:35:15.847Z,1367746515.847 [TempGradientCalculator] Loaded
2013-05-05T09:35:15.847Z,1367746515.847 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2013-05-05T09:35:15.850Z,1367746515.850 [YawRateCalculator] Loaded
2013-05-05T09:35:15.851Z,1367746515.851 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2013-05-05T09:35:15.866Z,1367746515.866 [ElevatorOffsetCalculator] Loaded
2013-05-05T09:35:15.866Z,1367746515.866 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2013-05-05T09:35:15.867Z,1367746515.867 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2013-05-05T09:35:15.867Z,1367746515.867 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2013-05-05T09:35:15.962Z,1367746515.962 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2013-05-05T09:35:15.964Z,1367746515.964 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2013-05-05T09:35:16.003Z,1367746516.003 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2013-05-05T09:35:16.004Z,1367746516.004 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2013-05-05T09:35:16.100Z,1367746516.100 [DeadReckonUsingMultipleVelocitySources] Loaded
2013-05-05T09:35:16.101Z,1367746516.101 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2013-05-05T09:35:16.111Z,1367746516.111 [NavChart] Loaded
2013-05-05T09:35:16.112Z,1367746516.112 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2013-05-05T09:35:16.116Z,1367746516.116 [UniversalFixResidualReporter] Loaded
2013-05-05T09:35:16.116Z,1367746516.116 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2013-05-05T09:35:16.116Z,1367746516.116 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2013-05-05T09:35:16.118Z,1367746516.118 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2013-05-05T09:35:16.648Z,1367746516.648 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_orientation
2013-05-05T09:35:16.651Z,1367746516.651 [AHRS_M2](INFO): created writer for : platform_orientation
2013-05-05T09:35:16.651Z,1367746516.651 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_magnetic_orientation
2013-05-05T09:35:16.655Z,1367746516.655 [AHRS_M2](INFO): created writer for : platform_magnetic_orientation
2013-05-05T09:35:16.655Z,1367746516.655 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_pitch_angle
2013-05-05T09:35:16.658Z,1367746516.658 [AHRS_M2](INFO): created writer for : platform_pitch_angle
2013-05-05T09:35:16.658Z,1367746516.658 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_roll_angle
2013-05-05T09:35:16.661Z,1367746516.661 [AHRS_M2](INFO): created writer for : platform_roll_angle
2013-05-05T09:35:16.805Z,1367746516.805 [AHRS_M2] Loaded
2013-05-05T09:35:16.805Z,1367746516.805 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2013-05-05T09:35:16.946Z,1367746516.946 [DataOverHttps] Loaded
2013-05-05T09:35:16.946Z,1367746516.946 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2013-05-05T09:35:16.947Z,1367746516.947 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409CC4E0
2013-05-05T09:35:16.948Z,1367746516.948 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 915
2013-05-05T09:35:16.964Z,1367746516.964 [Depth_Keller] Loaded
2013-05-05T09:35:16.964Z,1367746516.964 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2013-05-05T09:35:16.967Z,1367746516.967 [DropWeight] Loaded
2013-05-05T09:35:16.967Z,1367746516.967 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2013-05-05T09:35:17.018Z,1367746517.018 [NAL9602] Loaded
2013-05-05T09:35:17.018Z,1367746517.018 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2013-05-05T09:35:17.040Z,1367746517.040 [Onboard] Loaded
2013-05-05T09:35:17.040Z,1367746517.040 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2013-05-05T09:35:17.041Z,1367746517.041 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409FC4E0
2013-05-05T09:35:17.042Z,1367746517.042 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 916
2013-05-05T09:35:17.052Z,1367746517.052 [Radio_Surface] Loaded
2013-05-05T09:35:17.052Z,1367746517.052 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2013-05-05T09:35:17.053Z,1367746517.053 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A2C4E0
2013-05-05T09:35:17.053Z,1367746517.053 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 917
2013-05-05T09:35:17.125Z,1367746517.125 [DAT] Loaded
2013-05-05T09:35:17.126Z,1367746517.126 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2013-05-05T09:35:17.813Z,1367746517.813 [BPC1] Loaded
2013-05-05T09:35:17.814Z,1367746517.814 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2013-05-05T09:35:17.831Z,1367746517.831 [AMEcho] Loaded
2013-05-05T09:35:17.832Z,1367746517.832 [ComponentRegistry](DEBUG): SyncComponent "AMEcho" handled in the control thread.
2013-05-05T09:35:17.832Z,1367746517.832 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2013-05-05T09:35:17.833Z,1367746517.833 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2013-05-05T09:35:18.167Z,1367746518.167 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2013-05-05T09:35:18.167Z,1367746518.167 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2013-05-05T09:35:18.485Z,1367746518.485 [VerticalControl](DEBUG): Construct VerticalControl.
2013-05-05T09:35:18.536Z,1367746518.536 [VerticalControl] Loaded
2013-05-05T09:35:18.536Z,1367746518.536 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2013-05-05T09:35:18.537Z,1367746518.537 [HorizontalControl](DEBUG): Construct HorizontalControl.
2013-05-05T09:35:18.570Z,1367746518.570 [HorizontalControl] Loaded
2013-05-05T09:35:18.571Z,1367746518.571 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2013-05-05T09:35:18.571Z,1367746518.571 [SpeedControl](DEBUG): Construct SpeedControl.
2013-05-05T09:35:18.573Z,1367746518.573 [SpeedControl] Loaded
2013-05-05T09:35:18.573Z,1367746518.573 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2013-05-05T09:35:18.574Z,1367746518.574 [LoopControl](DEBUG): Construct LoopControl.
2013-05-05T09:35:18.574Z,1367746518.574 [LoopControl] Loaded
2013-05-05T09:35:18.575Z,1367746518.575 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2013-05-05T09:35:18.575Z,1367746518.575 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2013-05-05T09:35:18.576Z,1367746518.576 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2013-05-05T09:35:18.605Z,1367746518.605 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2013-05-05T09:35:18.605Z,1367746518.605 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2013-05-05T09:35:18.931Z,1367746518.931 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2013-05-05T09:35:18.935Z,1367746518.935 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2013-05-05T09:35:18.936Z,1367746518.936 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2013-05-05T09:35:18.944Z,1367746518.944 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2013-05-05T09:35:18.945Z,1367746518.945 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B664E0
2013-05-05T09:35:18.946Z,1367746518.946 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 918
2013-05-05T09:35:18.950Z,1367746518.950 [Supervisor](INFO): Main Thread ID is 823
2013-05-05T09:35:18.950Z,1367746518.950 [Supervisor](DEBUG): Running supervisor.
2013-05-05T09:35:18.951Z,1367746518.951 [CommandLine ThreadHandler](INFO): Handler Thread ID is 919
2013-05-05T09:35:18.953Z,1367746518.953 [controlThread ThreadHandler](INFO): Handler Thread ID is 920
2013-05-05T09:35:18.954Z,1367746518.954 [controlThread](DEBUG): Initializing ControlThread
2013-05-05T09:35:18.955Z,1367746518.955 [SBIT](INFO): Initialize SBIT Component.
2013-05-05T09:35:18.956Z,1367746518.956 [SBIT](IMPORTANT): git: 2020-10-07_A
2013-05-05T09:35:18.956Z,1367746518.956 [SBIT](INFO): git hash: c52f40a9277e8d17c6912ac1d266a8bed1742f02
2013-05-05T09:35:18.957Z,1367746518.957 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2013-05-05T09:35:18.958Z,1367746518.958 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Fri Mar 5 08:17:40 PST 2021
2013-05-05T09:35:18.959Z,1367746518.959 [SBIT](INFO): Beginning SBIT in 76.000000 seconds.
2013-05-05T09:35:18.959Z,1367746518.959 [IBIT](INFO): Initialize IBIT Component.
2013-05-05T09:35:18.960Z,1367746518.960 [CBIT](DEBUG): Initialize CBIT Component.
2013-05-05T09:35:18.961Z,1367746518.961 [logger ThreadHandler](INFO): Handler Thread ID is 921
2013-05-05T09:35:18.972Z,1367746518.972 [CBIT](DEBUG): Initialized mux pins.
2013-05-05T09:35:18.972Z,1367746518.972 [CBIT](DEBUG): Initializing the watchdog timer.
2013-05-05T09:35:18.980Z,1367746518.980 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 922
2013-05-05T09:35:18.981Z,1367746518.981 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2013-05-05T09:35:18.985Z,1367746518.985 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 924
2013-05-05T09:35:18.986Z,1367746518.986 [WetLabsBB2FL](INFO): Powering down
2013-05-05T09:35:18.996Z,1367746518.996 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2013-05-05T09:35:18.996Z,1367746518.996 [CBIT](DEBUG): Initializing heartbeat.
2013-05-05T09:35:19.068Z,1367746519.068 [CBIT](DEBUG): Deactivating GF circuits.
2013-05-05T09:35:19.068Z,1367746519.068 [CBIT](DEBUG): Deactivating emergency mode.
2013-05-05T09:35:19.104Z,1367746519.104 [CBIT](DEBUG): Backplane powered.
2013-05-05T09:35:19.108Z,1367746519.108 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2013-05-05T09:35:19.109Z,1367746519.109 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2013-05-05T09:35:19.109Z,1367746519.109 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2013-05-05T09:35:19.109Z,1367746519.109 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2013-05-05T09:35:19.110Z,1367746519.110 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2013-05-05T09:35:19.110Z,1367746519.110 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2013-05-05T09:35:19.111Z,1367746519.111 [NavChart](DEBUG): Initialize NavChart Navigation.
2013-05-05T09:35:19.112Z,1367746519.112 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2013-05-05T09:35:19.132Z,1367746519.132 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 925
2013-05-05T09:35:19.133Z,1367746519.133 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2013-05-05T09:35:19.135Z,1367746519.135 [Onboard ThreadHandler](INFO): Handler Thread ID is 926
2013-05-05T09:35:19.139Z,1367746519.139 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2013-05-05T09:35:19.229Z,1367746519.229 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2013-05-05T09:35:19.230Z,1367746519.230 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2013-05-05T09:35:19.230Z,1367746519.230 [LoopControl](DEBUG): Initialize LoopControlComponent.
2013-05-05T09:35:19.231Z,1367746519.231 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2013-05-05T09:35:19.246Z,1367746519.246 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 927
2013-05-05T09:35:19.251Z,1367746519.251 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 928
2013-05-05T09:35:19.260Z,1367746519.260 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2013-05-05T09:35:19.261Z,1367746519.261 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2013-05-05T09:35:19.261Z,1367746519.261 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2013-05-05T09:35:19.261Z,1367746519.261 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2013-05-05T09:35:19.261Z,1367746519.261 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2013-05-05T09:35:19.261Z,1367746519.261 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2013-05-05T09:35:19.261Z,1367746519.261 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2013-05-05T09:35:19.261Z,1367746519.261 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2013-05-05T09:35:19.262Z,1367746519.262 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2013-05-05T09:35:19.262Z,1367746519.262 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2013-05-05T09:35:19.262Z,1367746519.262 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2013-05-05T09:35:19.262Z,1367746519.262 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2013-05-05T09:35:19.262Z,1367746519.262 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2013-05-05T09:35:19.262Z,1367746519.262 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2013-05-05T09:35:19.263Z,1367746519.263 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2013-05-05T09:35:19.263Z,1367746519.263 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2013-05-05T09:35:19.285Z,1367746519.285 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2013-05-05T09:35:19.359Z,1367746519.359 [MissionManager](DEBUG):
2013-05-05T09:35:19.360Z,1367746519.360 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2013-05-05T09:35:19.470Z,1367746519.470 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2013-05-05T09:35:19.471Z,1367746519.471 [Default:A.Wait](DEBUG): Construct Wait.
2013-05-05T09:35:19.490Z,1367746519.490 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2013-05-05T09:35:19.521Z,1367746519.521 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2013-05-05T09:35:19.523Z,1367746519.523 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2013-05-05T09:35:19.552Z,1367746519.552 [Default:E.Execute](DEBUG): Construct Execute.
2013-05-05T09:35:19.556Z,1367746519.556 [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
2013-05-05T09:35:19.579Z,1367746519.579 [controlThread](DEBUG): Component order: CycleStarter,CANONSampler,ESPComponent,PAR_Licor,AHRS_M2,Depth_Keller,DropWeight,NAL9602,DAT,BPC1,AMEcho,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2013-05-05T09:35:19.600Z,1367746519.600 [CANONSampler](INFO): Powering down
2013-05-05T09:35:19.603Z,1367746519.603 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2013-05-05T09:35:19.652Z,1367746519.652 [Radio_Surface](INFO): Powering up
2013-05-05T09:35:19.716Z,1367746519.716 [Depth_Keller](ERROR): Pressure reading out of range: 1895.684326 decibar
2013-05-05T09:35:19.719Z,1367746519.719 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2013-05-05T09:35:19.720Z,1367746519.720 [DAT](INFO): Powering up
2013-05-05T09:35:19.720Z,1367746519.720 [DAT](DEBUG): Initializing DAT.
2013-05-05T09:35:19.752Z,1367746519.752 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2013-05-05T09:35:19.773Z,1367746519.773 [AMEcho](INFO): Powering up
2013-05-05T09:35:19.775Z,1367746519.775 [AMEcho](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2013-05-05T09:35:19.808Z,1367746519.808 [DepthRateCalculator](ERROR): Depth measurement is not active
2013-05-05T09:35:19.897Z,1367746519.897 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2013-05-05T09:35:19.904Z,1367746519.904 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2013-05-05T09:35:19.905Z,1367746519.905 [ElevatorServo](DEBUG): Initializing EZServoServo.
2013-05-05T09:35:19.912Z,1367746519.912 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2013-05-05T09:35:19.913Z,1367746519.913 [MassServo](DEBUG): Initializing EZServoServo.
2013-05-05T09:35:19.920Z,1367746519.920 [MassServo](DEBUG): Initializing MassServo.
2013-05-05T09:35:19.921Z,1367746519.921 [RudderServo](DEBUG): Initializing EZServoServo.
2013-05-05T09:35:19.928Z,1367746519.928 [RudderServo](DEBUG): Initializing RudderServo.
2013-05-05T09:35:19.929Z,1367746519.929 [ThrusterServo](DEBUG): Initializing EZServoServo.
2013-05-05T09:35:19.936Z,1367746519.936 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2013-05-05T09:35:20.126Z,1367746520.126 [DropWeight](CRITICAL): DROP WEIGHT MISSING.
2013-05-05T09:35:20.126Z,1367746520.126 [DropWeight] Hardware Fault, FailCount= 1
2013-05-05T09:35:20.126Z,1367746520.126 [DropWeight](ERROR): Hardware Fault
2013-05-05T09:35:20.296Z,1367746520.296 [AMEcho](INFO): Powering down
2013-05-05T09:35:20.331Z,1367746520.331 [CommandLine](FAULT): Scheduling is paused
2013-05-05T09:35:20.331Z,1367746520.331 [CBIT](INFO): Critical error at 20130505T093520
2013-05-05T09:35:20.332Z,1367746520.332 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2013-05-05T09:35:20.334Z,1367746520.334 [CBIT](ERROR): Hardware Fault in component: DropWeight
2013-05-05T09:35:20.335Z,1367746520.335 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2013-05-05T09:35:20.784Z,1367746520.784 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2013-05-05T09:35:20.784Z,1367746520.784 [RudderServo](FAULT): Rudder failed to initialize
2013-05-05T09:35:20.784Z,1367746520.784 [RudderServo] Communications Fault, FailCount= 1
2013-05-05T09:35:20.784Z,1367746520.784 [RudderServo](ERROR): Communications Fault
2013-05-05T09:35:20.990Z,1367746520.990 [CBIT](INFO): Critical error at 20130505T093520
2013-05-05T09:35:20.992Z,1367746520.992 [CBIT](ERROR): Communications Fault in component: RudderServo
2013-05-05T09:35:21.010Z,1367746521.010 [AMEcho](IMPORTANT): Setting 'enabled' to 0
2013-05-05T09:35:21.153Z,1367746521.153 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2013-05-05T09:35:21.153Z,1367746521.153 [RudderServo](INFO): Powering down
2013-05-05T09:35:21.823Z,1367746521.823 [RudderServo](DEBUG): Initializing EZServoServo.
2013-05-05T09:35:21.941Z,1367746521.941 [RudderServo](DEBUG): Initializing RudderServo.
2013-05-05T09:35:21.945Z,1367746521.945 [CBIT](INFO): Clearing failed state for component RudderServo
2013-05-05T09:35:21.945Z,1367746521.945 [RudderServo] No Fault, FailCount= 1
2013-05-05T09:35:23.344Z,1367746523.344 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2013-05-05T09:35:23.776Z,1367746523.776 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2013-05-05T09:35:24.272Z,1367746524.272 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2013-05-05T09:35:24.860Z,1367746524.860 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2013-05-05T09:35:25.304Z,1367746525.304 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2013-05-05T09:35:25.804Z,1367746525.804 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2013-05-05T09:35:26.372Z,1367746526.372 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2013-05-05T09:35:26.828Z,1367746526.828 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2013-05-05T09:35:27.236Z,1367746527.236 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2013-05-05T09:35:27.676Z,1367746527.676 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2013-05-05T09:35:28.120Z,1367746528.120 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2013-05-05T09:35:28.596Z,1367746528.596 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2013-05-05T09:35:29.072Z,1367746529.072 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2013-05-05T09:35:29.175Z,1367746529.175 [CBIT](CRITICAL): Environmental Failure. Press:14.886235 PSI. Humidity:30%. Temp:20 C. ABORTING MISSION
2013-05-05T09:35:29.544Z,1367746529.544 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2013-05-05T09:35:29.606Z,1367746529.606 [CBIT](INFO): Critical error at 20130505T093529
2013-05-05T09:35:29.976Z,1367746529.976 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2013-05-05T09:35:30.424Z,1367746530.424 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2013-05-05T09:35:30.852Z,1367746530.852 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2013-05-05T09:35:32.040Z,1367746532.040 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2013-05-05T09:35:32.040Z,1367746532.040 [CTD_Seabird] Communications Fault, FailCount= 1
2013-05-05T09:35:32.040Z,1367746532.040 [CTD_Seabird](ERROR): Communications Fault
2013-05-05T09:35:32.408Z,1367746532.408 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2013-05-05T09:35:32.444Z,1367746532.444 [CTD_Seabird](INFO): Powering down
2013-05-05T09:35:32.724Z,1367746532.724 [AHRS_M2](FAULT): Failed to initialize within timeout.
2013-05-05T09:35:32.724Z,1367746532.724 [AHRS_M2] Communications Fault, FailCount= 1
2013-05-05T09:35:32.725Z,1367746532.725 [AHRS_M2](ERROR): Communications Fault
2013-05-05T09:35:32.828Z,1367746532.828 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2013-05-05T09:35:33.092Z,1367746533.092 [AHRS_M2](INFO): Powering down
2013-05-05T09:35:33.540Z,1367746533.540 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2013-05-05T09:35:33.540Z,1367746533.540 [CTD_Seabird] No Fault, FailCount= 1
2013-05-05T09:35:33.788Z,1367746533.788 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2013-05-05T09:35:33.907Z,1367746533.907 [DAT](INFO): commRate: 800
2013-05-05T09:35:34.004Z,1367746534.004 [CBIT](INFO): Clearing failed state for component AHRS_M2
2013-05-05T09:35:34.004Z,1367746534.004 [AHRS_M2] No Fault, FailCount= 1
2013-05-05T09:35:34.304Z,1367746534.304 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2013-05-05T09:35:35.925Z,1367746535.925 [DAT](INFO): entering command mode
2013-05-05T09:35:36.334Z,1367746536.334 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:36.733Z,1367746536.733 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:37.133Z,1367746537.133 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:37.565Z,1367746537.565 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:37.971Z,1367746537.971 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:38.374Z,1367746538.374 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:38.785Z,1367746538.785 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:39.185Z,1367746539.185 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:39.585Z,1367746539.585 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:39.989Z,1367746539.989 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:40.393Z,1367746540.393 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:40.853Z,1367746540.853 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:41.273Z,1367746541.273 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:41.593Z,1367746541.593 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:42.001Z,1367746542.001 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:42.473Z,1367746542.473 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:42.877Z,1367746542.877 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:43.274Z,1367746543.274 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:43.677Z,1367746543.677 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:44.089Z,1367746544.089 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:44.625Z,1367746544.625 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:44.898Z,1367746544.898 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:45.293Z,1367746545.293 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:45.873Z,1367746545.873 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:46.109Z,1367746546.109 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:46.514Z,1367746546.514 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:46.844Z,1367746546.844 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2013-05-05T09:35:46.844Z,1367746546.844 [CTD_Seabird] Communications Fault, FailCount= 2
2013-05-05T09:35:46.844Z,1367746546.844 [CTD_Seabird](ERROR): Communications Fault
2013-05-05T09:35:46.846Z,1367746546.846 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:46.917Z,1367746546.917 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2013-05-05T09:35:47.248Z,1367746547.248 [CTD_Seabird](INFO): Powering down
2013-05-05T09:35:47.322Z,1367746547.322 [NAL9602](INFO): Powering up NAL9602
2013-05-05T09:35:47.323Z,1367746547.323 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:47.725Z,1367746547.725 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:48.057Z,1367746548.057 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:48.533Z,1367746548.533 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:48.591Z,1367746548.591 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2013-05-05T09:35:48.606Z,1367746548.606 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2013-05-05T09:35:48.608Z,1367746548.608 [CTD_Seabird] No Fault, FailCount= 2
2013-05-05T09:35:48.865Z,1367746548.865 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:49.293Z,1367746549.293 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:49.745Z,1367746549.745 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:50.149Z,1367746550.149 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:50.728Z,1367746550.728 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2013-05-05T09:35:50.728Z,1367746550.728 [AHRS_M2] Data Fault, FailCount= 2
2013-05-05T09:35:50.728Z,1367746550.728 [AHRS_M2](ERROR): Data Fault
2013-05-05T09:35:50.733Z,1367746550.733 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:50.816Z,1367746550.816 [CBIT](ERROR): Data Fault in component: AHRS_M2
2013-05-05T09:35:50.872Z,1367746550.872 [AHRS_M2](INFO): Powering down
2013-05-05T09:35:50.949Z,1367746550.949 [DAT](DEBUG): checking for command mode acknowledgment
2013-05-05T09:35:50.950Z,1367746550.950 [DAT](FAULT): failed to enter command mode
2013-05-05T09:35:51.277Z,1367746551.277 [DAT](INFO): entering command mode
2013-05-05T09:35:51.682Z,1367746551.682 [DAT](INFO): setting verbose to 3
2013-05-05T09:35:51.753Z,1367746551.753 [CBIT](INFO): Clearing failed state for component AHRS_M2
2013-05-05T09:35:51.753Z,1367746551.753 [AHRS_M2] No Fault, FailCount= 2
2013-05-05T09:35:52.080Z,1367746552.080 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2013-05-05T09:35:52.095Z,1367746552.095 [DAT](INFO): set verbose to 3
2013-05-05T09:35:52.095Z,1367746552.095 [DAT](INFO): setting DatVerbose to 27440
2013-05-05T09:35:52.490Z,1367746552.490 [DAT](INFO): set DatVerbose to 27440
2013-05-05T09:35:52.491Z,1367746552.491 [DAT](INFO): setting transmit power to 8
2013-05-05T09:35:52.891Z,1367746552.891 [DAT](INFO): set transmit power to 8
2013-05-05T09:35:52.891Z,1367746552.891 [DAT](INFO): setting local address to 4
2013-05-05T09:35:53.314Z,1367746553.314 [DAT](INFO): set local address to 4
2013-05-05T09:35:55.641Z,1367746555.641 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2013-05-05T09:35:56.064Z,1367746556.064 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2013-05-05T09:35:56.484Z,1367746556.484 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2013-05-05T09:35:56.892Z,1367746556.892 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2013-05-05T09:35:57.308Z,1367746557.308 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2013-05-05T09:35:57.386Z,1367746557.386 [CommandLine](IMPORTANT): got command configSet AHRS_M2.loadAtStartup 0.000000 bool persist
2013-05-05T09:35:57.387Z,1367746557.387 [CommandLine](IMPORTANT): configSet AHRS_M2.loadAtStartup requires a restart to take effect.
2013-05-05T09:35:57.716Z,1367746557.716 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2013-05-05T09:35:58.128Z,1367746558.128 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2013-05-05T09:35:58.564Z,1367746558.564 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2013-05-05T09:35:58.569Z,1367746558.569 [NAL9602](INFO): NAL9602 initialized
2013-05-05T09:35:58.980Z,1367746558.980 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2013-05-05T09:35:59.396Z,1367746559.396 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2013-05-05T09:35:59.832Z,1367746559.832 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2013-05-05T09:36:00.264Z,1367746560.264 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2013-05-05T09:36:00.696Z,1367746560.696 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2013-05-05T09:36:01.124Z,1367746561.124 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2013-05-05T09:36:01.568Z,1367746561.568 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2013-05-05T09:36:01.656Z,1367746561.656 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2013-05-05T09:36:01.656Z,1367746561.656 [CTD_Seabird] Communications Fault, FailCount= 3
2013-05-05T09:36:01.656Z,1367746561.656 [CTD_Seabird](ERROR): Communications Fault
2013-05-05T09:36:01.996Z,1367746561.996 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2013-05-05T09:36:02.060Z,1367746562.060 [CTD_Seabird](INFO): Powering down
2013-05-05T09:36:02.062Z,1367746562.062 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2013-05-05T09:36:02.063Z,1367746562.063 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2013-05-05T09:36:02.436Z,1367746562.436 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2013-05-05T09:36:02.864Z,1367746562.864 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2013-05-05T09:36:03.280Z,1367746563.280 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2013-05-05T09:36:03.704Z,1367746563.704 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2013-05-05T09:36:04.136Z,1367746564.136 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2013-05-05T09:36:04.482Z,1367746564.482 [CommandLine](IMPORTANT): got command restart application
2013-05-05T09:36:04.564Z,1367746564.564 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2013-05-05T09:36:04.976Z,1367746564.976 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2013-05-05T09:36:04.976Z,1367746564.976 [AHRS_M2](FAULT): Failed to initialize within timeout.
2013-05-05T09:36:04.976Z,1367746564.976 [AHRS_M2] Communications Fault, FailCount= 3
2013-05-05T09:36:04.976Z,1367746564.976 [AHRS_M2](ERROR): Communications Fault
2013-05-05T09:36:04.998Z,1367746564.998 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2013-05-05T09:36:05.068Z,1367746565.068 [AHRS_M2](INFO): Powering down
2013-05-05T09:36:05.488Z,1367746565.488 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2013-05-05T09:36:05.488Z,1367746565.488 [CommandLine ThreadHandler](INFO): Thread cancelled.
2013-05-05T09:36:05.584Z,1367746565.584 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2013-05-05T09:36:05.584Z,1367746565.584 [CommandLine ThreadHandler](INFO): Thread cancelled.
2013-05-05T09:36:05.585Z,1367746565.585 [CommandLine](INFO): Join timeout helper Thread ID is 945
2013-05-05T09:36:05.585Z,1367746565.585 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2013-05-05T09:36:05.585Z,1367746565.585 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2013-05-05T09:36:05.586Z,1367746565.586 [NavChartDb](INFO): Join timeout helper Thread ID is 946
2013-05-05T09:36:05.872Z,1367746565.872 [CBIT](INFO): Clearing failed state for component AHRS_M2
2013-05-05T09:36:05.872Z,1367746565.872 [AHRS_M2] No Fault, FailCount= 3
2013-05-05T09:36:05.980Z,1367746565.980 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2013-05-05T09:36:05.980Z,1367746565.980 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2013-05-05T09:36:05.988Z,1367746565.988 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2013-05-05T09:36:05.988Z,1367746565.988 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2013-05-05T09:36:05.988Z,1367746565.988 [Radio_Surface](INFO): Join timeout helper Thread ID is 947
2013-05-05T09:36:06.112Z,1367746566.112 [Radio_Surface](INFO): Powering down
2013-05-05T09:36:06.113Z,1367746566.113 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2013-05-05T09:36:06.113Z,1367746566.113 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2013-05-05T09:36:06.128Z,1367746566.128 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2013-05-05T09:36:06.128Z,1367746566.128 [Onboard ThreadHandler](INFO): Thread cancelled.
2013-05-05T09:36:06.128Z,1367746566.128 [Onboard](INFO): Join timeout helper Thread ID is 948
2013-05-05T09:36:06.240Z,1367746566.240 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2013-05-05T09:36:09.172Z,1367746569.172 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2013-05-05T09:36:09.172Z,1367746569.172 [Onboard ThreadHandler](INFO): Thread cancelled.
2013-05-05T09:36:09.176Z,1367746569.176 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2013-05-05T09:36:09.176Z,1367746569.176 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2013-05-05T09:36:09.176Z,1367746569.176 [DataOverHttps](INFO): Join timeout helper Thread ID is 950
2013-05-05T09:36:09.332Z,1367746569.332 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2013-05-05T09:36:09.332Z,1367746569.332 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2013-05-05T09:36:09.337Z,1367746569.337 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2013-05-05T09:36:09.337Z,1367746569.337 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2013-05-05T09:36:09.337Z,1367746569.337 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 951
2013-05-05T09:36:09.428Z,1367746569.428 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2013-05-05T09:36:09.428Z,1367746569.428 [WetLabsBB2FL](INFO): Powering down
2013-05-05T09:36:09.429Z,1367746569.429 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2013-05-05T09:36:09.436Z,1367746569.436 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2013-05-05T09:36:09.437Z,1367746569.437 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2013-05-05T09:36:09.437Z,1367746569.437 [CTD_Seabird](INFO): Join timeout helper Thread ID is 952
2013-05-05T09:36:09.472Z,1367746569.472 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2013-05-05T09:36:09.472Z,1367746569.472 [CTD_Seabird](INFO): Powering down
2013-05-05T09:36:09.484Z,1367746569.484 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2013-05-05T09:36:09.497Z,1367746569.497 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2013-05-05T09:36:09.497Z,1367746569.497 [logger ThreadHandler](INFO): Thread cancelled.
2013-05-05T09:36:09.497Z,1367746569.497 [logger](INFO): Join timeout helper Thread ID is 953
2013-05-05T09:36:09.500Z,1367746569.500 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2013-05-05T09:36:09.500Z,1367746569.500 [logger ThreadHandler](INFO): Thread cancelled.
2013-05-05T09:36:09.516Z,1367746569.516 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2013-05-05T09:36:09.517Z,1367746569.517 [CommandLine ThreadHandler](INFO): Thread cancelled.
2013-05-05T09:36:09.517Z,1367746569.517 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2013-05-05T09:36:09.517Z,1367746569.517 [controlThread ThreadHandler](INFO): Thread cancelled.
2013-05-05T09:36:09.517Z,1367746569.517 [controlThread](INFO): Join timeout helper Thread ID is 954
2013-05-05T09:36:09.800Z,1367746569.800 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2013-05-05T09:36:09.824Z,1367746569.824 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2013-05-05T09:36:09.824Z,1367746569.824 [controlThread](DEBUG): Uninitializing ControlThread
2013-05-05T09:36:09.827Z,1367746569.827 [AHRS_M2](INFO): Powering down
2013-05-05T09:36:09.896Z,1367746569.896 [NAL9602](INFO): Powering down
2013-05-05T09:36:09.898Z,1367746569.898 [DAT](INFO): Powering down
2013-05-05T09:36:10.017Z,1367746570.017 [AMEcho](INFO): Powering down
2013-05-05T09:36:10.018Z,1367746570.018 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2013-05-05T09:36:10.019Z,1367746570.019 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2013-05-05T09:36:10.019Z,1367746570.019 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2013-05-05T09:36:10.020Z,1367746570.020 [MissionManager](INFO): Uninitializing Mission Default
2013-05-05T09:36:10.022Z,1367746570.022 [MissionManager](INFO): Uninitializing Mission Startup
2013-05-05T09:36:10.023Z,1367746570.023 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2013-05-05T09:36:10.024Z,1367746570.024 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2013-05-05T09:36:10.024Z,1367746570.024 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2013-05-05T09:36:10.024Z,1367746570.024 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2013-05-05T09:36:10.024Z,1367746570.024 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2013-05-05T09:36:10.025Z,1367746570.025 [BuoyancyServo](INFO): Powering down
2013-05-05T09:36:10.036Z,1367746570.036 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2013-05-05T09:36:10.036Z,1367746570.036 [ElevatorServo](INFO): Powering down
2013-05-05T09:36:10.037Z,1367746570.037 [MassServo](DEBUG): Uninitialize Mass Servo.
2013-05-05T09:36:10.037Z,1367746570.037 [MassServo](INFO): Powering down
2013-05-05T09:36:10.038Z,1367746570.038 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2013-05-05T09:36:10.038Z,1367746570.038 [RudderServo](INFO): Powering down
2013-05-05T09:36:10.038Z,1367746570.038 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2013-05-05T09:36:10.039Z,1367746570.039 [ThrusterServo](INFO): Powering down
2013-05-05T09:36:10.039Z,1367746570.039 [SBIT](DEBUG): Uninitialize SBIT Component.
2013-05-05T09:36:10.040Z,1367746570.040 [IBIT](DEBUG): Uninitialize IBIT Component.
2013-05-05T09:36:10.040Z,1367746570.040 [CBIT](DEBUG): Uninitialize CBIT Component.
2013-05-05T09:36:10.040Z,1367746570.040 [CBIT](DEBUG): Powering off loads.
2013-05-05T09:36:10.052Z,1367746570.052 [CBIT](DEBUG): Disabling WDT.
2013-05-05T09:36:10.064Z,1367746570.064 [CBIT](DEBUG): Opening all GF detection circuits.
2013-05-05T09:36:10.064Z,1367746570.064 [controlThread ThreadHandler](INFO): Thread cancelled.
2013-05-05T09:36:10.223Z,1367746570.223 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2013-05-05T09:36:10.229Z,1367746570.229 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2013-05-05T09:36:10.297Z,1367746570.297 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2013-05-05T09:36:10.299Z,1367746570.299 [Onboard ThreadHandler](INFO): Thread cancelled.
2013-05-05T09:36:10.303Z,1367746570.303 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2013-05-05T09:36:10.354Z,1367746570.354 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2013-05-05T09:36:10.413Z,1367746570.413 [logger ThreadHandler](INFO): Thread cancelled.