2010-02-04T22:41:16.600Z,1265323276.600 [Supervisor](DEBUG): Initializing supervisor.
2010-02-04T22:41:16.605Z,1265323276.605 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2010-02-04T22:41:16.606Z,1265323276.606 [SyncHandler](INFO): Protected caller Thread ID is 1723
2010-02-04T22:41:16.606Z,1265323276.606 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2010-02-04T22:41:16.608Z,1265323276.608 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2010-02-04T22:41:16.608Z,1265323276.608 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1724
2010-02-04T22:41:16.613Z,1265323276.613 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2010-02-04T22:41:16.630Z,1265323276.630 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2010-02-04T22:41:16.631Z,1265323276.631 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2010-02-04T22:41:16.631Z,1265323276.631 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 1725
2010-02-04T22:41:16.635Z,1265323276.635 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2010-02-04T22:41:16.636Z,1265323276.636 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2010-02-04T22:41:16.637Z,1265323276.637 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1726
2010-02-04T22:41:16.639Z,1265323276.639 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2010-02-04T22:41:16.640Z,1265323276.639 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2010-02-04T22:41:16.640Z,1265323276.640 [logger ThreadHandler](INFO): Protected caller Thread ID is 1727
2010-02-04T22:41:16.643Z,1265323276.643 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2010-02-04T22:41:16.644Z,1265323276.644 [Supervisor](INFO): Looking for Config files in directory: Config/
2010-02-04T22:41:16.645Z,1265323276.645 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2010-02-04T22:41:16.740Z,1265323276.740 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2010-02-04T22:41:16.740Z,1265323276.740 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2010-02-04T22:41:16.949Z,1265323276.949 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2010-02-04T22:41:16.949Z,1265323276.949 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2010-02-04T22:41:17.194Z,1265323277.194 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2010-02-04T22:41:17.195Z,1265323277.195 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2010-02-04T22:41:17.300Z,1265323277.300 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2010-02-04T22:41:17.301Z,1265323277.301 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2010-02-04T22:41:17.953Z,1265323277.953 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2010-02-04T22:41:17.953Z,1265323277.953 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2010-02-04T22:41:18.413Z,1265323278.413 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2010-02-04T22:41:18.414Z,1265323278.414 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2010-02-04T22:41:18.880Z,1265323278.880 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2010-02-04T22:41:18.881Z,1265323278.881 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2010-02-04T22:41:19.264Z,1265323279.264 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2010-02-04T22:41:19.265Z,1265323279.265 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2010-02-04T22:41:19.578Z,1265323279.578 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2010-02-04T22:41:19.578Z,1265323279.578 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2010-02-04T22:41:19.934Z,1265323279.934 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2010-02-04T22:41:19.935Z,1265323279.935 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2010-02-04T22:41:20.152Z,1265323280.152 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2010-02-04T22:41:20.153Z,1265323280.153 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2010-02-04T22:41:20.288Z,1265323280.288 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2010-02-04T22:41:20.289Z,1265323280.289 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2010-02-04T22:41:20.369Z,1265323280.369 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2010-02-04T22:41:20.447Z,1265323280.447 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2010-02-04T22:41:20.630Z,1265323280.630 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2010-02-04T22:41:20.631Z,1265323280.631 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2010-02-04T22:41:20.900Z,1265323280.900 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2010-02-04T22:41:20.902Z,1265323280.902 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2010-02-04T22:41:20.903Z,1265323280.903 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2010-02-04T22:41:21.102Z,1265323281.102 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2010-02-04T22:41:21.674Z,1265323281.674 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2010-02-04T22:41:21.674Z,1265323281.674 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2010-02-04T22:41:21.950Z,1265323281.950 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2010-02-04T22:41:22.108Z,1265323282.108 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2010-02-04T22:41:22.279Z,1265323282.279 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2010-02-04T22:41:22.362Z,1265323282.362 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2010-02-04T22:41:22.469Z,1265323282.469 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2010-02-04T22:41:22.570Z,1265323282.570 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2010-02-04T22:41:22.720Z,1265323282.720 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2010-02-04T22:41:22.813Z,1265323282.813 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2010-02-04T22:41:22.910Z,1265323282.910 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/
2010-02-04T22:41:22.910Z,1265323282.910 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2010-02-04T22:41:22.927Z,1265323282.927 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2010-02-04T22:41:23.074Z,1265323283.074 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2010-02-04T22:41:23.075Z,1265323283.075 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2010-02-04T22:41:23.230Z,1265323283.230 [BuoyancyServo] Loaded
2010-02-04T22:41:23.230Z,1265323283.230 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2010-02-04T22:41:23.251Z,1265323283.251 [ElevatorServo] Loaded
2010-02-04T22:41:23.251Z,1265323283.251 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2010-02-04T22:41:23.271Z,1265323283.271 [MassServo] Loaded
2010-02-04T22:41:23.271Z,1265323283.271 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2010-02-04T22:41:23.291Z,1265323283.291 [RudderServo] Loaded
2010-02-04T22:41:23.291Z,1265323283.291 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2010-02-04T22:41:23.306Z,1265323283.306 [ThrusterHE] Loaded
2010-02-04T22:41:23.307Z,1265323283.307 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2010-02-04T22:41:23.307Z,1265323283.307 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2010-02-04T22:41:23.307Z,1265323283.307 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2010-02-04T22:41:23.448Z,1265323283.448 [SBIT](DEBUG): Construct Startup Built In Test.
2010-02-04T22:41:23.463Z,1265323283.463 [SBIT] Loaded
2010-02-04T22:41:23.463Z,1265323283.463 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2010-02-04T22:41:23.466Z,1265323283.466 [IBIT](DEBUG): Construct Initiated Built In Test.
2010-02-04T22:41:23.486Z,1265323283.486 [IBIT] Loaded
2010-02-04T22:41:23.486Z,1265323283.486 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2010-02-04T22:41:23.492Z,1265323283.492 [CBIT](DEBUG): Construct Continuous Built In Test.
2010-02-04T22:41:23.705Z,1265323283.705 [CBIT] Loaded
2010-02-04T22:41:23.705Z,1265323283.705 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2010-02-04T22:41:23.706Z,1265323283.706 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2010-02-04T22:41:23.706Z,1265323283.706 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2010-02-04T22:41:23.845Z,1265323283.845 [ESPComponent] Loaded
2010-02-04T22:41:23.845Z,1265323283.845 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2010-02-04T22:41:23.865Z,1265323283.865 [PAR_Licor] Loaded
2010-02-04T22:41:23.865Z,1265323283.865 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2010-02-04T22:41:23.866Z,1265323283.866 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2010-02-04T22:41:23.866Z,1265323283.866 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2010-02-04T22:41:23.915Z,1265323283.915 [DepthRateCalculator] Loaded
2010-02-04T22:41:23.915Z,1265323283.915 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2010-02-04T22:41:23.921Z,1265323283.921 [PitchRateCalculator] Loaded
2010-02-04T22:41:23.921Z,1265323283.921 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2010-02-04T22:41:23.931Z,1265323283.931 [SpeedCalculator] Loaded
2010-02-04T22:41:23.931Z,1265323283.931 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2010-02-04T22:41:23.946Z,1265323283.946 [VerticalHomogeneityIndexCalculator] Loaded
2010-02-04T22:41:23.946Z,1265323283.946 [ComponentRegistry](DEBUG): SyncComponent "VerticalHomogeneityIndexCalculator" handled in the control thread.
2010-02-04T22:41:23.951Z,1265323283.951 [YawRateCalculator] Loaded
2010-02-04T22:41:23.951Z,1265323283.951 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2010-02-04T22:41:23.970Z,1265323283.970 [ElevatorOffsetCalculator] Loaded
2010-02-04T22:41:23.970Z,1265323283.970 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2010-02-04T22:41:23.971Z,1265323283.971 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2010-02-04T22:41:23.971Z,1265323283.971 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2010-02-04T22:41:24.069Z,1265323284.069 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2010-02-04T22:41:24.070Z,1265323284.070 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2010-02-04T22:41:24.096Z,1265323284.096 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2010-02-04T22:41:24.097Z,1265323284.097 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2010-02-04T22:41:24.207Z,1265323284.207 [DeadReckonUsingMultipleVelocitySources] Loaded
2010-02-04T22:41:24.207Z,1265323284.207 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2010-02-04T22:41:24.221Z,1265323284.221 [NavChart] Loaded
2010-02-04T22:41:24.221Z,1265323284.221 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2010-02-04T22:41:24.227Z,1265323284.227 [UniversalFixResidualReporter] Loaded
2010-02-04T22:41:24.227Z,1265323284.227 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2010-02-04T22:41:24.227Z,1265323284.227 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2010-02-04T22:41:24.228Z,1265323284.228 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2010-02-04T22:41:24.621Z,1265323284.621 [BackseatComponent] Loaded
2010-02-04T22:41:24.622Z,1265323284.622 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2010-02-04T22:41:24.623Z,1265323284.623 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409C44E0
2010-02-04T22:41:24.623Z,1265323284.623 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 1809
2010-02-04T22:41:24.626Z,1265323284.626 [LcmUniversalReporter] Loaded
2010-02-04T22:41:24.626Z,1265323284.626 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2010-02-04T22:41:25.350Z,1265323285.350 [BPC1] Loaded
2010-02-04T22:41:25.350Z,1265323285.350 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2010-02-04T22:41:25.425Z,1265323285.425 [DataOverHttps] Loaded
2010-02-04T22:41:25.425Z,1265323285.425 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2010-02-04T22:41:25.426Z,1265323285.426 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409F44E0
2010-02-04T22:41:25.426Z,1265323285.426 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1810
2010-02-04T22:41:25.447Z,1265323285.447 [Depth_Keller] Loaded
2010-02-04T22:41:25.447Z,1265323285.447 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2010-02-04T22:41:25.452Z,1265323285.452 [DropWeight] Loaded
2010-02-04T22:41:25.452Z,1265323285.452 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2010-02-04T22:41:25.490Z,1265323285.490 [DVL_micro] Loaded
2010-02-04T22:41:25.491Z,1265323285.491 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread.
2010-02-04T22:41:25.550Z,1265323285.550 [NAL9602] Loaded
2010-02-04T22:41:25.550Z,1265323285.550 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2010-02-04T22:41:25.575Z,1265323285.575 [Onboard] Loaded
2010-02-04T22:41:25.576Z,1265323285.576 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2010-02-04T22:41:25.577Z,1265323285.577 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A244E0
2010-02-04T22:41:25.577Z,1265323285.577 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 1811
2010-02-04T22:41:25.589Z,1265323285.589 [Power24vConverter] Loaded
2010-02-04T22:41:25.589Z,1265323285.589 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2010-02-04T22:41:25.602Z,1265323285.602 [Radio_Surface] Loaded
2010-02-04T22:41:25.603Z,1265323285.603 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2010-02-04T22:41:25.604Z,1265323285.604 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A544E0
2010-02-04T22:41:25.604Z,1265323285.604 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1812
2010-02-04T22:41:25.696Z,1265323285.696 [DAT] Loaded
2010-02-04T22:41:25.696Z,1265323285.696 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2010-02-04T22:41:25.697Z,1265323285.697 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40A844E0
2010-02-04T22:41:25.698Z,1265323285.698 [DAT ThreadHandler](INFO): Protected caller Thread ID is 1813
2010-02-04T22:41:25.698Z,1265323285.698 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2010-02-04T22:41:25.699Z,1265323285.699 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2010-02-04T22:41:25.768Z,1265323285.768 [StratificationFrontDetector](IMPORTANT): thresholdVTHI set to: 0.050012 degC
2010-02-04T22:41:25.768Z,1265323285.768 [StratificationFrontDetector](INFO): (re)initializing
2010-02-04T22:41:25.768Z,1265323285.768 [StratificationFrontDetector] Loaded
2010-02-04T22:41:25.769Z,1265323285.769 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread.
2010-02-04T22:41:25.769Z,1265323285.769 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2010-02-04T22:41:25.770Z,1265323285.770 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2010-02-04T22:41:25.819Z,1265323285.819 [VerticalControl](DEBUG): Construct VerticalControl.
2010-02-04T22:41:25.869Z,1265323285.869 [VerticalControl] Loaded
2010-02-04T22:41:25.870Z,1265323285.870 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2010-02-04T22:41:25.873Z,1265323285.873 [HorizontalControl](DEBUG): Construct HorizontalControl.
2010-02-04T22:41:25.909Z,1265323285.909 [HorizontalControl] Loaded
2010-02-04T22:41:25.910Z,1265323285.910 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2010-02-04T22:41:25.912Z,1265323285.912 [SpeedControl](DEBUG): Construct SpeedControl.
2010-02-04T22:41:25.914Z,1265323285.914 [SpeedControl] Loaded
2010-02-04T22:41:25.914Z,1265323285.914 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2010-02-04T22:41:25.917Z,1265323285.917 [LoopControl](DEBUG): Construct LoopControl.
2010-02-04T22:41:25.917Z,1265323285.917 [LoopControl] Loaded
2010-02-04T22:41:25.917Z,1265323285.917 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2010-02-04T22:41:25.918Z,1265323285.918 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2010-02-04T22:41:25.918Z,1265323285.918 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2010-02-04T22:41:25.937Z,1265323285.937 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2010-02-04T22:41:25.939Z,1265323285.939 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2010-02-04T22:41:26.425Z,1265323286.425 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2010-02-04T22:41:26.432Z,1265323286.432 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2010-02-04T22:41:26.434Z,1265323286.434 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2010-02-04T22:41:26.445Z,1265323286.445 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2010-02-04T22:41:26.446Z,1265323286.446 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B7E4E0
2010-02-04T22:41:26.447Z,1265323286.447 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1814
2010-02-04T22:41:26.451Z,1265323286.451 [Supervisor](INFO): Main Thread ID is 1442
2010-02-04T22:41:26.451Z,1265323286.451 [Supervisor](DEBUG): Running supervisor.
2010-02-04T22:41:26.452Z,1265323286.452 [CommandExec ThreadHandler](INFO): Handler Thread ID is 1815
2010-02-04T22:41:26.452Z,1265323286.452 [CommandExec](INFO): Initializing the command executive.
2010-02-04T22:41:26.454Z,1265323286.454 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1816
2010-02-04T22:41:26.456Z,1265323286.456 [controlThread ThreadHandler](INFO): Handler Thread ID is 1817
2010-02-04T22:41:26.456Z,1265323286.456 [controlThread](DEBUG): Initializing ControlThread
2010-02-04T22:41:26.458Z,1265323286.458 [SBIT](INFO): Initialize SBIT Component.
2010-02-04T22:41:26.459Z,1265323286.459 [SBIT](IMPORTANT): git: 2023-04-04
2010-02-04T22:41:26.459Z,1265323286.459 [SBIT](INFO): git hash: b8e3dc7784c205eaa6d34dbcc6cfad52b0792170
2010-02-04T22:41:26.459Z,1265323286.459 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2010-02-04T22:41:26.460Z,1265323286.460 [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-02-04T22:41:26.461Z,1265323286.461 [SBIT](INFO): Beginning SBIT in 145.000000 seconds.
2010-02-04T22:41:26.462Z,1265323286.462 [IBIT](INFO): Initialize IBIT Component.
2010-02-04T22:41:26.463Z,1265323286.463 [CBIT](DEBUG): Initialize CBIT Component.
2010-02-04T22:41:26.464Z,1265323286.464 [logger ThreadHandler](INFO): Handler Thread ID is 1818
2010-02-04T22:41:26.476Z,1265323286.476 [CBIT](DEBUG): Initialized mux pins.
2010-02-04T22:41:26.477Z,1265323286.477 [CBIT](DEBUG): Initializing the watchdog timer.
2010-02-04T22:41:26.489Z,1265323286.489 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 1819
2010-02-04T22:41:26.500Z,1265323286.500 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2010-02-04T22:41:26.501Z,1265323286.501 [CBIT](DEBUG): Initializing heartbeat.
2010-02-04T22:41:26.502Z,1265323286.502 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1820
2010-02-04T22:41:26.503Z,1265323286.503 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2010-02-04T22:41:26.513Z,1265323286.513 [Onboard ThreadHandler](INFO): Handler Thread ID is 1821
2010-02-04T22:41:26.537Z,1265323286.537 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1822
2010-02-04T22:41:26.553Z,1265323286.553 [DAT ThreadHandler](INFO): Handler Thread ID is 1823
2010-02-04T22:41:26.554Z,1265323286.554 [DAT](INFO): Powering up
2010-02-04T22:41:26.554Z,1265323286.554 [DAT](DEBUG): Initializing DAT.
2010-02-04T22:41:26.558Z,1265323286.558 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1825
2010-02-04T22:41:26.561Z,1265323286.561 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2010-02-04T22:41:26.561Z,1265323286.561 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2010-02-04T22:41:26.561Z,1265323286.561 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2010-02-04T22:41:26.561Z,1265323286.561 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2010-02-04T22:41:26.562Z,1265323286.562 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2010-02-04T22:41:26.562Z,1265323286.562 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2010-02-04T22:41:26.562Z,1265323286.562 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2010-02-04T22:41:26.562Z,1265323286.562 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2010-02-04T22:41:26.562Z,1265323286.562 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA69M.000
2010-02-04T22:41:26.562Z,1265323286.562 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA69M.000
2010-02-04T22:41:26.573Z,1265323286.573 [CBIT](DEBUG): Deactivating GF circuits.
2010-02-04T22:41:26.573Z,1265323286.573 [CBIT](DEBUG): Deactivating emergency mode.
2010-02-04T22:41:26.612Z,1265323286.612 [CBIT](DEBUG): Backplane powered.
2010-02-04T22:41:26.617Z,1265323286.617 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2010-02-04T22:41:26.617Z,1265323286.617 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2010-02-04T22:41:26.618Z,1265323286.618 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2010-02-04T22:41:26.618Z,1265323286.618 [VerticalHomogeneityIndexCalculator](DEBUG): (re)initializing
2010-02-04T22:41:26.619Z,1265323286.619 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2010-02-04T22:41:26.619Z,1265323286.619 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2010-02-04T22:41:26.620Z,1265323286.620 [NavChart](DEBUG): Initialize NavChart Navigation.
2010-02-04T22:41:26.621Z,1265323286.621 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2010-02-04T22:41:26.631Z,1265323286.631 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2010-02-04T22:41:26.633Z,1265323286.633 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2010-02-04T22:41:26.634Z,1265323286.634 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2010-02-04T22:41:26.634Z,1265323286.634 [LoopControl](DEBUG): Initialize LoopControlComponent.
2010-02-04T22:41:26.635Z,1265323286.635 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2010-02-04T22:41:26.672Z,1265323286.672 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2010-02-04T22:41:26.708Z,1265323286.708 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

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

    <Aggregate Id="StartupSatComms">

        <Sequence/>

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

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

    </Aggregate>

</Mission>


2010-02-04T22:41:26.719Z,1265323286.719 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2010-02-04T22:41:26.808Z,1265323286.808 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2010-02-04T22:41:26.810Z,1265323286.810 [Default:A.Wait](DEBUG): Construct Wait.
2010-02-04T22:41:26.812Z,1265323286.812 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2010-02-04T22:41:26.855Z,1265323286.855 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2010-02-04T22:41:26.858Z,1265323286.858 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2010-02-04T22:41:26.879Z,1265323286.879 [Default:E.Execute](DEBUG): Construct Execute.
2010-02-04T22:41:26.883Z,1265323286.883 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="Default">

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

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

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

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

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

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

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

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

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

    </Aggregate>

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

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

</Mission>


2010-02-04T22:41:26.909Z,1265323286.909 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,BPC1,Depth_Keller,DropWeight,DVL_micro,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,VerticalHomogeneityIndexCalculator,YawRateCalculator,ElevatorOffsetCalculator,StratificationFrontDetector,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2010-02-04T22:41:26.941Z,1265323286.941 [Radio_Surface](INFO): Powering up
2010-02-04T22:41:26.961Z,1265323286.961 [Depth_Keller](ERROR): Pressure or depth reading out of range: 1895.444336 decibar, 0.000000 m
2010-02-04T22:41:26.970Z,1265323286.970 [Power24vConverter](INFO): Powering up.
2010-02-04T22:41:27.013Z,1265323287.013 [DepthRateCalculator](ERROR): Depth measurement is not active
2010-02-04T22:41:27.040Z,1265323287.040 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2010-02-04T22:41:27.049Z,1265323287.049 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2010-02-04T22:41:27.050Z,1265323287.050 [ElevatorServo](DEBUG): Initializing EZServoServo.
2010-02-04T22:41:27.058Z,1265323287.058 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2010-02-04T22:41:27.058Z,1265323287.058 [MassServo](DEBUG): Initializing EZServoServo.
2010-02-04T22:41:27.065Z,1265323287.065 [MassServo](DEBUG): Initializing MassServo.
2010-02-04T22:41:27.066Z,1265323287.066 [RudderServo](DEBUG): Initializing EZServoServo.
2010-02-04T22:41:27.081Z,1265323287.081 [RudderServo](DEBUG): Initializing RudderServo.
2010-02-04T22:41:27.082Z,1265323287.082 [ThrusterHE](DEBUG): Initializing EZServoServo.
2010-02-04T22:41:27.089Z,1265323287.089 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2010-02-04T22:41:27.352Z,1265323287.352 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2010-02-04T22:41:27.352Z,1265323287.352 [DropWeight] Hardware Fault, FailCount= 1
2010-02-04T22:41:27.352Z,1265323287.352 [DropWeight](ERROR): Hardware Fault
2010-02-04T22:41:27.401Z,1265323287.401 [CommandExec](FAULT): Scheduling is paused
2010-02-04T22:41:27.401Z,1265323287.401 [CBIT](INFO): Critical error at 20100204T224127
2010-02-04T22:41:27.402Z,1265323287.402 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2010-02-04T22:41:27.413Z,1265323287.413 [CBIT](ERROR): Hardware Fault in component: DropWeight
2010-02-04T22:41:27.413Z,1265323287.413 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2010-02-04T22:41:27.747Z,1265323287.747 [CBIT](INFO): Critical error at 20100204T224127
2010-02-04T22:41:32.766Z,1265323292.766 [ThrusterHE](ERROR): Zero Speed Commanded.
2010-02-04T22:41:36.673Z,1265323296.673 [CBIT](CRITICAL): Environmental Failure. Press:14.775030 PSI. Humidity:28%. Temp:25 C. ABORTING MISSION
2010-02-04T22:41:37.071Z,1265323297.071 [CBIT](INFO): Critical error at 20100204T224136
2010-02-04T22:41:38.149Z,1265323298.149 [DAT](INFO): DAT read: 

2010-02-04T22:41:38.151Z,1265323298.151 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series

2010-02-04T22:41:39.914Z,1265323299.914 [DAT](INFO): DAT read: MF Frequency Band

2010-02-04T22:41:39.915Z,1265323299.915 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0

2010-02-04T22:41:39.915Z,1265323299.915 [DAT](INFO): DAT read: Feb  4 2010 22:41:34 

2010-02-04T22:41:40.922Z,1265323300.922 [DAT](INFO): DAT read: Features enabled [Bearing]

2010-02-04T22:41:40.923Z,1265323300.923 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC

2010-02-04T22:41:40.923Z,1265323300.923 [DAT](INFO): commRate: 1200
2010-02-04T22:41:42.988Z,1265323302.988 [DAT](INFO): entering command mode
2010-02-04T22:41:43.189Z,1265323303.189 [DAT](INFO): DAT read: 

2010-02-04T22:41:43.190Z,1265323303.190 [DAT](INFO): DAT read: user:1>

2010-02-04T22:41:43.190Z,1265323303.190 [DAT](INFO): setting verbose to 3
2010-02-04T22:41:43.441Z,1265323303.441 [DAT](INFO): DAT read: user:1>

2010-02-04T22:41:43.442Z,1265323303.442 [DAT](INFO): DAT read: Verbose         | 3           

2010-02-04T22:41:43.443Z,1265323303.443 [DAT](INFO): set verbose to 3
2010-02-04T22:41:43.443Z,1265323303.443 [DAT](INFO): setting DatVerbose to 27440
2010-02-04T22:41:43.693Z,1265323303.693 [DAT](INFO): DAT read: user:2>

2010-02-04T22:41:43.694Z,1265323303.694 [DAT](INFO): DAT read: DatVerbose      | 27440       

2010-02-04T22:41:43.695Z,1265323303.695 [DAT](INFO): set DatVerbose to 27440
2010-02-04T22:41:43.695Z,1265323303.695 [DAT](INFO): setting transmit power to 8
2010-02-04T22:41:43.945Z,1265323303.945 [DAT](INFO): DAT read: user:3>

2010-02-04T22:41:43.946Z,1265323303.946 [DAT](INFO): DAT read: TxPower         | 8 (Max)     

2010-02-04T22:41:43.947Z,1265323303.947 [DAT](INFO): set transmit power to 8
2010-02-04T22:41:43.947Z,1265323303.947 [DAT](INFO): setting local address to 4
2010-02-04T22:41:44.197Z,1265323304.197 [DAT](INFO): DAT read: user:4>

2010-02-04T22:41:44.198Z,1265323304.198 [DAT](INFO): DAT read: LocalAddr       | 4           

2010-02-04T22:41:44.198Z,1265323304.198 [DAT](INFO): set local address to 4
2010-02-04T22:41:44.200Z,1265323304.200 [DAT](INFO): Setting time to: 22:41:44 And date to:2/4/2010
2010-02-04T22:41:44.449Z,1265323304.449 [DAT](INFO): DAT read: user:5>

2010-02-04T22:41:44.450Z,1265323304.450 [DAT](INFO): DAT read: Thu Feb 4, 2010  22:41:44  

2010-02-04T22:41:44.451Z,1265323304.451 [DAT](INFO): Local DAT time set to Thu Feb 4, 2010  22:41:44  

2010-02-04T22:41:55.614Z,1265323315.614 [NAL9602](INFO): Powering up NAL9602
2010-02-04T22:42:00.100Z,1265323320.100 [CBIT](FAULT): WATER ALARM STERN.
2010-02-04T22:42:00.101Z,1265323320.101 [CBIT](ERROR): WATER DETECTED IN PRESSURE HULL. Alarm Count: 1
2010-02-04T22:42:00.499Z,1265323320.499 [CBIT](FAULT): WATER ALARM STERN.
2010-02-04T22:42:00.500Z,1265323320.500 [CBIT](ERROR): WATER DETECTED IN PRESSURE HULL. Alarm Count: 2
2010-02-04T22:42:00.906Z,1265323320.906 [CBIT](FAULT): WATER ALARM STERN.
2010-02-04T22:42:00.907Z,1265323320.907 [CBIT](ERROR): WATER DETECTED IN PRESSURE HULL. Alarm Count: 3
2010-02-04T22:42:01.304Z,1265323321.304 [CBIT](FAULT): WATER ALARM STERN.
2010-02-04T22:42:01.328Z,1265323321.328 [CBIT](CRITICAL): WATER DETECTED IN PRESSURE HULL. BURNWIRE ACTIVATED
2010-02-04T22:42:01.328Z,1265323321.328 [CBIT](IMPORTANT): Powered off ESP with command: ! echo 0 > /dev/loadA6
2010-02-04T22:42:01.350Z,1265323321.350 [CommandExec](IMPORTANT): got command ! echo 0 > /dev/loadA6
2010-02-04T22:42:01.723Z,1265323321.723 [CBIT](INFO): Critical error at 20100204T224201
2010-02-04T22:42:06.516Z,1265323326.516 [NAL9602](INFO): NAL9602 initialized
2010-02-04T22:42:44.130Z,1265323364.130 [CommandExec](IMPORTANT): got command restart application
2010-02-04T22:42:45.133Z,1265323365.133 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2010-02-04T22:42:45.133Z,1265323365.133 [CommandExec](INFO): Uninitializing the command executive.
2010-02-04T22:42:45.133Z,1265323365.133 [CommandExec](INFO): Uninitializing the command scheduler.
2010-02-04T22:42:45.133Z,1265323365.133 [CommandExec ThreadHandler](INFO): Thread cancelled.
2010-02-04T22:42:45.232Z,1265323365.232 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2010-02-04T22:42:45.233Z,1265323365.233 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2010-02-04T22:42:45.233Z,1265323365.233 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2010-02-04T22:42:45.233Z,1265323365.233 [NavChartDb](INFO): Join timeout helper Thread ID is 1833
2010-02-04T22:42:45.533Z,1265323365.533 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2010-02-04T22:42:45.533Z,1265323365.533 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2010-02-04T22:42:45.552Z,1265323365.552 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2010-02-04T22:42:45.553Z,1265323365.553 [DAT ThreadHandler](INFO): Thread cancelled.
2010-02-04T22:42:45.553Z,1265323365.553 [DAT](INFO): Join timeout helper Thread ID is 1834
2010-02-04T22:42:45.741Z,1265323365.741 [DAT](INFO): Powering down
2010-02-04T22:42:45.813Z,1265323365.813 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2010-02-04T22:42:45.813Z,1265323365.813 [DAT](INFO): Powering down
2010-02-04T22:42:45.814Z,1265323365.814 [DAT ThreadHandler](INFO): Thread cancelled.
2010-02-04T22:42:45.821Z,1265323365.821 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2010-02-04T22:42:45.821Z,1265323365.821 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2010-02-04T22:42:45.821Z,1265323365.821 [Radio_Surface](INFO): Join timeout helper Thread ID is 1835
2010-02-04T22:42:46.177Z,1265323366.177 [Radio_Surface](INFO): Powering down
2010-02-04T22:42:46.177Z,1265323366.177 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2010-02-04T22:42:46.178Z,1265323366.178 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2010-02-04T22:42:46.184Z,1265323366.184 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2010-02-04T22:42:46.185Z,1265323366.185 [Onboard ThreadHandler](INFO): Thread cancelled.
2010-02-04T22:42:46.185Z,1265323366.185 [Onboard](INFO): Join timeout helper Thread ID is 1836
2010-02-04T22:42:46.577Z,1265323366.577 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2010-02-04T22:42:46.577Z,1265323366.577 [Onboard ThreadHandler](INFO): Thread cancelled.
2010-02-04T22:42:46.593Z,1265323366.593 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2010-02-04T22:42:46.593Z,1265323366.593 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2010-02-04T22:42:46.593Z,1265323366.593 [DataOverHttps](INFO): Join timeout helper Thread ID is 1837
2010-02-04T22:42:46.825Z,1265323366.825 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2010-02-04T22:42:46.825Z,1265323366.825 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2010-02-04T22:42:46.837Z,1265323366.837 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2010-02-04T22:42:46.838Z,1265323366.838 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2010-02-04T22:42:46.838Z,1265323366.838 [BackseatComponent](INFO): Join timeout helper Thread ID is 1838
2010-02-04T22:42:47.017Z,1265323367.017 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2010-02-04T22:42:47.018Z,1265323367.018 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2010-02-04T22:42:47.037Z,1265323367.037 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2010-02-04T22:42:47.037Z,1265323367.037 [logger ThreadHandler](INFO): Thread cancelled.
2010-02-04T22:42:47.038Z,1265323367.038 [logger](INFO): Join timeout helper Thread ID is 1839
2010-02-04T22:42:47.041Z,1265323367.041 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2010-02-04T22:42:47.041Z,1265323367.041 [logger ThreadHandler](INFO): Thread cancelled.
2010-02-04T22:42:47.057Z,1265323367.057 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2010-02-04T22:42:47.057Z,1265323367.057 [CommandLine ThreadHandler](INFO): Thread cancelled.
2010-02-04T22:42:47.058Z,1265323367.058 [CommandLine](INFO): Join timeout helper Thread ID is 1840
2010-02-04T22:42:47.093Z,1265323367.093 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2010-02-04T22:42:47.093Z,1265323367.093 [CommandLine ThreadHandler](INFO): Thread cancelled.
2010-02-04T22:42:47.097Z,1265323367.097 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2010-02-04T22:42:47.097Z,1265323367.097 [CommandExec ThreadHandler](INFO): Thread cancelled.
2010-02-04T22:42:47.098Z,1265323367.098 [CommandExec](INFO): Join timeout helper Thread ID is 1841
2010-02-04T22:42:47.099Z,1265323367.099 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2010-02-04T22:42:47.099Z,1265323367.099 [controlThread ThreadHandler](INFO): Thread cancelled.
2010-02-04T22:42:47.099Z,1265323367.099 [controlThread](INFO): Join timeout helper Thread ID is 1842
2010-02-04T22:42:47.305Z,1265323367.305 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2010-02-04T22:42:47.305Z,1265323367.305 [controlThread](DEBUG): Uninitializing ControlThread
2010-02-04T22:42:47.377Z,1265323367.377 [DVL_micro](INFO): Powering down
2010-02-04T22:42:47.378Z,1265323367.378 [NAL9602](INFO): Powering down
2010-02-04T22:42:47.379Z,1265323367.379 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2010-02-04T22:42:47.380Z,1265323367.380 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2010-02-04T22:42:47.381Z,1265323367.381 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2010-02-04T22:42:47.381Z,1265323367.381 [MissionManager](INFO): Uninitializing Mission Default
2010-02-04T22:42:47.384Z,1265323367.384 [MissionManager](INFO): Uninitializing Mission Startup
2010-02-04T22:42:47.386Z,1265323367.386 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2010-02-04T22:42:47.386Z,1265323367.386 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2010-02-04T22:42:47.386Z,1265323367.386 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2010-02-04T22:42:47.387Z,1265323367.387 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2010-02-04T22:42:47.387Z,1265323367.387 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2010-02-04T22:42:47.387Z,1265323367.387 [BuoyancyServo](INFO): Powering down
2010-02-04T22:42:47.401Z,1265323367.401 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2010-02-04T22:42:47.401Z,1265323367.401 [ElevatorServo](INFO): Powering down
2010-02-04T22:42:47.402Z,1265323367.402 [MassServo](DEBUG): Uninitialize Mass Servo.
2010-02-04T22:42:47.402Z,1265323367.402 [MassServo](INFO): Powering down
2010-02-04T22:42:47.403Z,1265323367.403 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2010-02-04T22:42:47.403Z,1265323367.403 [RudderServo](INFO): Powering down
2010-02-04T22:42:47.404Z,1265323367.404 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2010-02-04T22:42:47.404Z,1265323367.404 [ThrusterHE](INFO): Powering down
2010-02-04T22:42:47.405Z,1265323367.405 [SBIT](DEBUG): Uninitialize SBIT Component.
2010-02-04T22:42:47.405Z,1265323367.405 [IBIT](DEBUG): Uninitialize IBIT Component.
2010-02-04T22:42:47.405Z,1265323367.405 [CBIT](DEBUG): Uninitialize CBIT Component.
2010-02-04T22:42:47.405Z,1265323367.405 [CBIT](DEBUG): Powering off loads.
2010-02-04T22:42:47.416Z,1265323367.416 [CBIT](DEBUG): Disabling WDT.
2010-02-04T22:42:47.428Z,1265323367.428 [CBIT](DEBUG): Opening all GF detection circuits.
2010-02-04T22:42:47.429Z,1265323367.429 [controlThread ThreadHandler](INFO): Thread cancelled.
2010-02-04T22:42:47.736Z,1265323367.736 [DAT ThreadHandler](INFO): Thread cancelled.
2010-02-04T22:42:47.741Z,1265323367.741 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2010-02-04T22:42:47.743Z,1265323367.743 [Onboard ThreadHandler](INFO): Thread cancelled.
2010-02-04T22:42:47.750Z,1265323367.750 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2010-02-04T22:42:47.793Z,1265323367.793 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2010-02-04T22:42:47.842Z,1265323367.842 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2010-02-04T22:42:47.901Z,1265323367.901 [logger ThreadHandler](INFO): Thread cancelled.