2017-10-24T01:00:58.435Z,1508806858.435 [Supervisor](DEBUG): Initializing supervisor.
2017-10-24T01:00:58.438Z,1508806858.438 [SyncHandler](DEBUG): Created PCaller Thread at 4051A4E0
2017-10-24T01:00:58.439Z,1508806858.439 [SyncHandler](INFO): Protected caller Thread ID is 770
2017-10-24T01:00:58.439Z,1508806858.439 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2017-10-24T01:00:58.440Z,1508806858.440 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4054A4E0
2017-10-24T01:00:58.441Z,1508806858.441 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 771
2017-10-24T01:00:58.443Z,1508806858.443 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2017-10-24T01:00:58.456Z,1508806858.456 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2017-10-24T01:00:58.457Z,1508806858.457 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 4057A4E0
2017-10-24T01:00:58.457Z,1508806858.457 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 772
2017-10-24T01:00:58.458Z,1508806858.458 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2017-10-24T01:00:58.459Z,1508806858.459 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405AA4E0
2017-10-24T01:00:58.459Z,1508806858.459 [logger ThreadHandler](INFO): Protected caller Thread ID is 773
2017-10-24T01:00:58.461Z,1508806858.461 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2017-10-24T01:00:58.462Z,1508806858.462 [Supervisor](INFO): Looking for Config files in directory: Config/
2017-10-24T01:00:58.465Z,1508806858.465 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2017-10-24T01:00:58.655Z,1508806858.655 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2017-10-24T01:00:58.656Z,1508806858.656 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2017-10-24T01:00:58.790Z,1508806858.790 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2017-10-24T01:00:58.791Z,1508806858.791 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2017-10-24T01:00:59.150Z,1508806859.150 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2017-10-24T01:00:59.151Z,1508806859.151 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2017-10-24T01:00:59.293Z,1508806859.293 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2017-10-24T01:00:59.294Z,1508806859.294 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2017-10-24T01:00:59.382Z,1508806859.382 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2017-10-24T01:00:59.584Z,1508806859.584 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2017-10-24T01:00:59.584Z,1508806859.584 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2017-10-24T01:00:59.688Z,1508806859.688 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2017-10-24T01:00:59.690Z,1508806859.690 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2017-10-24T01:00:59.984Z,1508806859.984 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2017-10-24T01:00:59.985Z,1508806859.985 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2017-10-24T01:01:00.358Z,1508806860.358 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2017-10-24T01:01:00.359Z,1508806860.359 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2017-10-24T01:01:00.671Z,1508806860.671 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2017-10-24T01:01:00.672Z,1508806860.672 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2017-10-24T01:01:01.211Z,1508806861.211 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2017-10-24T01:01:05.526Z,1508806865.526 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2017-10-24T01:01:05.895Z,1508806865.895 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2017-10-24T01:01:05.896Z,1508806865.896 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2017-10-24T01:01:06.000Z,1508806866.000 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2017-10-24T01:01:06.001Z,1508806866.001 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2017-10-24T01:01:06.477Z,1508806866.477 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2017-10-24T01:01:06.478Z,1508806866.478 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2017-10-24T01:01:09.509Z,1508806869.509 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2017-10-24T01:01:09.511Z,1508806869.511 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2017-10-24T01:01:09.513Z,1508806869.513 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Battery.cfg
2017-10-24T01:01:09.757Z,1508806869.757 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2017-10-24T01:01:09.758Z,1508806869.758 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2017-10-24T01:01:09.865Z,1508806869.865 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg
2017-10-24T01:01:09.962Z,1508806869.962 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2017-10-24T01:01:10.073Z,1508806870.073 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2017-10-24T01:01:10.165Z,1508806870.165 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2017-10-24T01:01:10.301Z,1508806870.301 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2017-10-24T01:01:10.465Z,1508806870.465 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2017-10-24T01:01:10.566Z,1508806870.566 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2017-10-24T01:01:10.665Z,1508806870.665 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg
2017-10-24T01:01:10.756Z,1508806870.756 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2017-10-24T01:01:10.948Z,1508806870.948 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/workSite.cfg
2017-10-24T01:01:11.030Z,1508806871.030 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2017-10-24T01:01:11.045Z,1508806871.045 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2017-10-24T01:01:11.210Z,1508806871.210 [SBIT](DEBUG): Construct Startup Built In Test.
2017-10-24T01:01:11.242Z,1508806871.242 [SBIT] Loaded
2017-10-24T01:01:11.242Z,1508806871.242 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2017-10-24T01:01:11.243Z,1508806871.243 [IBIT](DEBUG): Construct Initiated Built In Test.
2017-10-24T01:01:11.272Z,1508806871.272 [IBIT] Loaded
2017-10-24T01:01:11.272Z,1508806871.272 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2017-10-24T01:01:11.276Z,1508806871.276 [CBIT](DEBUG): Construct Continuous Built In Test.
2017-10-24T01:01:11.436Z,1508806871.436 [CBIT] Loaded
2017-10-24T01:01:11.436Z,1508806871.436 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2017-10-24T01:01:11.437Z,1508806871.437 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2017-10-24T01:01:11.437Z,1508806871.437 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2017-10-24T01:01:11.532Z,1508806871.532 [VerticalControl](DEBUG): Construct VerticalControl.
2017-10-24T01:01:11.637Z,1508806871.637 [VerticalControl] Loaded
2017-10-24T01:01:11.637Z,1508806871.637 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2017-10-24T01:01:11.638Z,1508806871.638 [HorizontalControl](DEBUG): Construct HorizontalControl.
2017-10-24T01:01:11.703Z,1508806871.703 [HorizontalControl] Loaded
2017-10-24T01:01:11.703Z,1508806871.703 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2017-10-24T01:01:11.704Z,1508806871.704 [SpeedControl](DEBUG): Construct SpeedControl.
2017-10-24T01:01:11.710Z,1508806871.710 [SpeedControl] Loaded
2017-10-24T01:01:11.710Z,1508806871.710 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2017-10-24T01:01:11.711Z,1508806871.711 [LoopControl](DEBUG): Construct LoopControl.
2017-10-24T01:01:11.712Z,1508806871.712 [LoopControl] Loaded
2017-10-24T01:01:11.712Z,1508806871.712 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2017-10-24T01:01:11.712Z,1508806871.712 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2017-10-24T01:01:11.713Z,1508806871.713 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2017-10-24T01:01:15.078Z,1508806875.078 [DepthRateCalculator] Loaded
2017-10-24T01:01:15.078Z,1508806875.078 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2017-10-24T01:01:15.089Z,1508806875.089 [PitchRateCalculator] Loaded
2017-10-24T01:01:15.089Z,1508806875.089 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2017-10-24T01:01:15.112Z,1508806875.112 [SpeedCalculator] Loaded
2017-10-24T01:01:15.113Z,1508806875.113 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2017-10-24T01:01:15.135Z,1508806875.135 [TempGradientCalculator] Loaded
2017-10-24T01:01:15.135Z,1508806875.135 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2017-10-24T01:01:15.152Z,1508806875.152 [VerticalTemperatureHomogeneityIndexCalculator] Loaded
2017-10-24T01:01:15.152Z,1508806875.152 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread.
2017-10-24T01:01:15.158Z,1508806875.158 [YawRateCalculator] Loaded
2017-10-24T01:01:15.158Z,1508806875.158 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2017-10-24T01:01:15.158Z,1508806875.158 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2017-10-24T01:01:15.159Z,1508806875.159 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2017-10-24T01:01:15.284Z,1508806875.284 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC
2017-10-24T01:01:15.284Z,1508806875.284 [StratificationFrontDetector](DEBUG): (re)initializing
2017-10-24T01:01:15.284Z,1508806875.284 [StratificationFrontDetector] Loaded
2017-10-24T01:01:15.284Z,1508806875.284 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread.
2017-10-24T01:01:15.285Z,1508806875.285 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2017-10-24T01:01:15.286Z,1508806875.286 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2017-10-24T01:01:15.574Z,1508806875.574 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2017-10-24T01:01:15.575Z,1508806875.575 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2017-10-24T01:01:15.690Z,1508806875.690 [DeadReckonUsingSpeedCalculator] Loaded
2017-10-24T01:01:15.691Z,1508806875.691 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2017-10-24T01:01:15.748Z,1508806875.748 [DeadReckonWithRespectToSeafloor] Loaded
2017-10-24T01:01:15.749Z,1508806875.749 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2017-10-24T01:01:15.767Z,1508806875.767 [NavChart] Loaded
2017-10-24T01:01:15.767Z,1508806875.767 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2017-10-24T01:01:15.772Z,1508806875.772 [UniversalFixResidualReporter] Loaded
2017-10-24T01:01:15.772Z,1508806875.772 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2017-10-24T01:01:15.773Z,1508806875.773 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2017-10-24T01:01:15.773Z,1508806875.773 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2017-10-24T01:01:15.803Z,1508806875.803 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2017-10-24T01:01:15.803Z,1508806875.803 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2017-10-24T01:01:16.001Z,1508806876.001 [Aanderaa_O2] Loaded
2017-10-24T01:01:16.001Z,1508806876.001 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2017-10-24T01:01:16.014Z,1508806876.014 [CANONSampler] Loaded
2017-10-24T01:01:16.014Z,1508806876.014 [ComponentRegistry](DEBUG): SyncComponent "CANONSampler" handled in the control thread.
2017-10-24T01:01:16.098Z,1508806876.098 [CTD_NeilBrown] Loaded
2017-10-24T01:01:16.098Z,1508806876.098 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2017-10-24T01:01:16.100Z,1508806876.100 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 407864E0
2017-10-24T01:01:16.100Z,1508806876.100 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 855
2017-10-24T01:01:16.136Z,1508806876.136 [CTD_Seabird] Loaded
2017-10-24T01:01:16.136Z,1508806876.136 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2017-10-24T01:01:16.137Z,1508806876.137 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 407B64E0
2017-10-24T01:01:16.137Z,1508806876.137 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 856
2017-10-24T01:01:16.153Z,1508806876.153 [PAR_Licor] Loaded
2017-10-24T01:01:16.153Z,1508806876.153 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2017-10-24T01:01:16.205Z,1508806876.205 [WetLabsBB2FL] Loaded
2017-10-24T01:01:16.206Z,1508806876.206 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2017-10-24T01:01:16.207Z,1508806876.207 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 407E64E0
2017-10-24T01:01:16.207Z,1508806876.207 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 857
2017-10-24T01:01:16.207Z,1508806876.207 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2017-10-24T01:01:16.208Z,1508806876.208 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2017-10-24T01:01:16.834Z,1508806876.834 [DataOverHttps] Loaded
2017-10-24T01:01:16.834Z,1508806876.834 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2017-10-24T01:01:16.848Z,1508806876.848 [Depth_Keller] Loaded
2017-10-24T01:01:16.849Z,1508806876.849 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2017-10-24T01:01:16.945Z,1508806876.945 [NAL9602] Loaded
2017-10-24T01:01:16.945Z,1508806876.945 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2017-10-24T01:01:16.955Z,1508806876.955 [Onboard] Loaded
2017-10-24T01:01:16.955Z,1508806876.955 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2017-10-24T01:01:16.963Z,1508806876.963 [Radio_Surface] Loaded
2017-10-24T01:01:16.963Z,1508806876.963 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2017-10-24T01:01:16.964Z,1508806876.964 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A314E0
2017-10-24T01:01:16.965Z,1508806876.965 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 858
2017-10-24T01:01:17.161Z,1508806877.161 [PNI_TCM] Loaded
2017-10-24T01:01:17.161Z,1508806877.161 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread.
2017-10-24T01:01:19.065Z,1508806879.065 [BPC1] Loaded
2017-10-24T01:01:19.066Z,1508806879.066 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2017-10-24T01:01:19.066Z,1508806879.066 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2017-10-24T01:01:19.067Z,1508806879.067 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2017-10-24T01:01:19.191Z,1508806879.191 [BuoyancyServo] Loaded
2017-10-24T01:01:19.192Z,1508806879.192 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2017-10-24T01:01:19.204Z,1508806879.204 [ElevatorServo] Loaded
2017-10-24T01:01:19.204Z,1508806879.204 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2017-10-24T01:01:19.217Z,1508806879.217 [MassServo] Loaded
2017-10-24T01:01:19.217Z,1508806879.217 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2017-10-24T01:01:19.229Z,1508806879.229 [RudderServo] Loaded
2017-10-24T01:01:19.230Z,1508806879.230 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2017-10-24T01:01:19.242Z,1508806879.242 [ThrusterServo] Loaded
2017-10-24T01:01:19.242Z,1508806879.242 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2017-10-24T01:01:19.242Z,1508806879.242 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2017-10-24T01:01:19.243Z,1508806879.243 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2017-10-24T01:01:19.381Z,1508806879.381 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2017-10-24T01:01:19.381Z,1508806879.381 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2017-10-24T01:01:19.423Z,1508806879.423 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2017-10-24T01:01:19.426Z,1508806879.426 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2017-10-24T01:01:19.427Z,1508806879.427 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2017-10-24T01:01:19.435Z,1508806879.435 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2017-10-24T01:01:19.436Z,1508806879.436 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AE24E0
2017-10-24T01:01:19.436Z,1508806879.436 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 859
2017-10-24T01:01:19.440Z,1508806879.440 [Supervisor](INFO): Main Thread ID is 765
2017-10-24T01:01:19.441Z,1508806879.441 [Supervisor](DEBUG): Running supervisor.
2017-10-24T01:01:19.441Z,1508806879.441 [CommandLine ThreadHandler](INFO): Handler Thread ID is 860
2017-10-24T01:01:19.444Z,1508806879.444 [controlThread ThreadHandler](INFO): Handler Thread ID is 861
2017-10-24T01:01:19.445Z,1508806879.445 [controlThread](DEBUG): Initializing ControlThread
2017-10-24T01:01:19.446Z,1508806879.446 [SBIT](INFO): Initialize SBIT Component.
2017-10-24T01:01:19.446Z,1508806879.446 [SBIT](IMPORTANT): git: 2017-10-16
2017-10-24T01:01:19.446Z,1508806879.446 [SBIT](INFO): git hash: 5e637d88ea6653172d5095372d78c21c0064ca6c
2017-10-24T01:01:19.448Z,1508806879.448 [SBIT](INFO): Kernel Reporting Different Release From Configuration.
Kernel Expected: 2.6.27.8
Kernel Reported: 2.6.27.8-00011-g2bc81df-dirty
2017-10-24T01:01:19.448Z,1508806879.448 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #639 PREEMPT Wed Mar 12 12:53:33 PDT 2014
Kernel Reported: #646 PREEMPT Thu Feb 11 17:01:12 PST 2016
2017-10-24T01:01:19.449Z,1508806879.449 [SBIT](INFO): Beginning SBIT in 160.000000 seconds.
2017-10-24T01:01:19.450Z,1508806879.450 [IBIT](INFO): Initialize IBIT Component.
2017-10-24T01:01:19.451Z,1508806879.451 [CBIT](DEBUG): Initialize CBIT Component.
2017-10-24T01:01:19.451Z,1508806879.451 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2017-10-24T01:01:19.452Z,1508806879.452 [logger ThreadHandler](INFO): Handler Thread ID is 862
2017-10-24T01:01:19.479Z,1508806879.479 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 863
2017-10-24T01:01:19.480Z,1508806879.480 [CTD_NeilBrown](INFO): Powering down
2017-10-24T01:01:19.514Z,1508806879.514 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 864
2017-10-24T01:01:19.514Z,1508806879.514 [CTD_Seabird](INFO): Initializing
2017-10-24T01:01:19.543Z,1508806879.543 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2017-10-24T01:01:19.545Z,1508806879.545 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2017-10-24T01:01:19.546Z,1508806879.546 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2017-10-24T01:01:19.547Z,1508806879.547 [LoopControl](DEBUG): Initialize LoopControlComponent.
2017-10-24T01:01:19.547Z,1508806879.547 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2017-10-24T01:01:19.548Z,1508806879.548 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2017-10-24T01:01:19.548Z,1508806879.548 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2017-10-24T01:01:19.548Z,1508806879.548 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2017-10-24T01:01:19.549Z,1508806879.549 [VerticalTemperatureHomogeneityIndexCalculator](DEBUG): (re)initializing
2017-10-24T01:01:19.550Z,1508806879.550 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2017-10-24T01:01:19.551Z,1508806879.551 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2017-10-24T01:01:19.552Z,1508806879.552 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2017-10-24T01:01:19.552Z,1508806879.552 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2017-10-24T01:01:19.553Z,1508806879.553 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component.
2017-10-24T01:01:19.553Z,1508806879.553 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s.
2017-10-24T01:01:19.554Z,1508806879.554 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s.
2017-10-24T01:01:19.554Z,1508806879.554 [NavChart](DEBUG): Initialize NavChart Navigation.
2017-10-24T01:01:19.555Z,1508806879.555 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2017-10-24T01:01:19.565Z,1508806879.565 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2017-10-24T01:01:19.577Z,1508806879.577 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 866
2017-10-24T01:01:19.580Z,1508806879.580 [WetLabsBB2FL](INFO): Powering down
2017-10-24T01:01:19.623Z,1508806879.623 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 867
2017-10-24T01:01:19.630Z,1508806879.630 [Radio_Surface](INFO): Powering up
2017-10-24T01:01:19.641Z,1508806879.641 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2017-10-24T01:01:19.643Z,1508806879.643 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 868
2017-10-24T01:01:19.651Z,1508806879.651 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2017-10-24T01:01:19.651Z,1508806879.651 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2017-10-24T01:01:19.652Z,1508806879.652 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2017-10-24T01:01:19.652Z,1508806879.652 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2017-10-24T01:01:19.652Z,1508806879.652 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2017-10-24T01:01:19.652Z,1508806879.652 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2017-10-24T01:01:19.652Z,1508806879.652 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2017-10-24T01:01:19.653Z,1508806879.653 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2017-10-24T01:01:19.653Z,1508806879.653 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2017-10-24T01:01:19.653Z,1508806879.653 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2017-10-24T01:01:19.653Z,1508806879.653 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2017-10-24T01:01:19.654Z,1508806879.654 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2017-10-24T01:01:19.654Z,1508806879.654 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2017-10-24T01:01:19.654Z,1508806879.654 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2017-10-24T01:01:19.654Z,1508806879.654 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2017-10-24T01:01:19.655Z,1508806879.655 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2017-10-24T01:01:19.688Z,1508806879.688 [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>


2017-10-24T01:01:19.689Z,1508806879.689 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2017-10-24T01:01:19.786Z,1508806879.786 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2017-10-24T01:01:19.815Z,1508806879.815 [Default:A.Wait](DEBUG): Construct Wait.
2017-10-24T01:01:19.817Z,1508806879.817 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2017-10-24T01:01:19.836Z,1508806879.836 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface
2017-10-24T01:01:19.836Z,1508806879.836 [CTD_Seabird](INFO): Powering down
2017-10-24T01:01:19.866Z,1508806879.866 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2017-10-24T01:01:19.897Z,1508806879.897 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2017-10-24T01:01:19.921Z,1508806879.921 [Default:E.Execute](DEBUG): Construct Execute.
2017-10-24T01:01:19.925Z,1508806879.925 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
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/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="Default">

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

    <Guidance:Wait>
        <Sequence/>
        <Description>
            Wait a moment to see if the scheduler starts a new mission before
            starting to actually run Default.
        </Description>
        <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">
            <Sequence/>
            <Timeout Duration="P5M"/>
            <Universal:time_fix/>
        </ReadDatum>

        <ReadDatum Id="Read_Iridium">
            <Sequence/>
            <Timeout Duration="P2H">
                <Guidance:Execute>
                    <Sequence/>
                    <Setting><Guidance:Execute.command/><String>Burn 300</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>


2017-10-24T01:01:19.939Z,1508806879.939 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,CANONSampler,PAR_Licor,DataOverHttps,Depth_Keller,NAL9602,Onboard,PNI_TCM,BPC1,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,VerticalTemperatureHomogeneityIndexCalculator,YawRateCalculator,StratificationFrontDetector,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2017-10-24T01:01:19.983Z,1508806879.983 [CANONSampler](INFO): Powering down
2017-10-24T01:01:20.174Z,1508806880.174 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2017-10-24T01:01:20.198Z,1508806880.198 [Depth_Keller](ERROR): Pressure reading out of range: 1831.023193 decibar
2017-10-24T01:01:20.463Z,1508806880.463 [DepthRateCalculator](ERROR): Depth measurement is not active
2017-10-24T01:01:20.558Z,1508806880.558 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-24T01:01:20.784Z,1508806880.784 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2017-10-24T01:01:20.901Z,1508806880.901 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2017-10-24T01:01:20.905Z,1508806880.905 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2017-10-24T01:01:20.927Z,1508806880.927 [ElevatorServo](DEBUG): Initializing EZServoServo.
2017-10-24T01:01:20.933Z,1508806880.933 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2017-10-24T01:01:20.939Z,1508806880.939 [MassServo](DEBUG): Initializing EZServoServo.
2017-10-24T01:01:20.945Z,1508806880.945 [MassServo](DEBUG): Initializing MassServo.
2017-10-24T01:01:20.951Z,1508806880.951 [RudderServo](DEBUG): Initializing EZServoServo.
2017-10-24T01:01:20.957Z,1508806880.957 [RudderServo](DEBUG): Initializing RudderServo.
2017-10-24T01:01:20.979Z,1508806880.979 [ThrusterServo](DEBUG): Initializing EZServoServo.
2017-10-24T01:01:20.985Z,1508806880.985 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2017-10-24T01:01:21.326Z,1508806881.326 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-24T01:01:21.326Z,1508806881.326 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2017-10-24T01:01:21.526Z,1508806881.526 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-24T01:01:21.527Z,1508806881.527 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2017-10-24T01:01:21.874Z,1508806881.874 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2017-10-24T01:01:21.874Z,1508806881.874 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2017-10-24T01:01:21.874Z,1508806881.874 [BuoyancyServo] Communications Fault, FailCount= 1
2017-10-24T01:01:21.874Z,1508806881.874 [BuoyancyServo](ERROR): Communications Fault
2017-10-24T01:01:22.086Z,1508806882.086 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2017-10-24T01:01:22.167Z,1508806882.167 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-24T01:01:22.168Z,1508806882.168 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2017-10-24T01:01:22.174Z,1508806882.174 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2017-10-24T01:01:22.190Z,1508806882.190 [BuoyancyServo](INFO): Powering down
2017-10-24T01:01:22.552Z,1508806882.552 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-24T01:01:22.553Z,1508806882.553 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2017-10-24T01:01:22.947Z,1508806882.947 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-24T01:01:22.952Z,1508806882.952 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2017-10-24T01:01:23.412Z,1508806883.412 [Aanderaa_O2](INFO): Powering down
2017-10-24T01:01:23.528Z,1508806883.528 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-24T01:01:23.533Z,1508806883.533 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2017-10-24T01:01:23.731Z,1508806883.731 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-24T01:01:23.732Z,1508806883.732 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2017-10-24T01:01:24.823Z,1508806884.823 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2017-10-24T01:01:24.823Z,1508806884.823 [BuoyancyServo] No Fault, FailCount= 1
2017-10-24T01:01:25.030Z,1508806885.030 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2017-10-24T01:01:25.148Z,1508806885.148 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2017-10-24T01:01:26.977Z,1508806886.977 [PNI_TCM](ERROR): CRC does not match. Expected:0x47848 got:0x13337
2017-10-24T01:01:28.580Z,1508806888.580 [PNI_TCM](ERROR): CRC does not match. Expected:0x13764 got:0x10501
2017-10-24T01:01:37.802Z,1508806897.802 [PNI_TCM](ERROR): CRC does not match. Expected:0x64639 got:0x41
2017-10-24T01:01:39.783Z,1508806899.783 [PNI_TCM](ERROR): CRC does not match. Expected:0x32278 got:0x28184
2017-10-24T01:01:44.575Z,1508806904.575 [PNI_TCM](ERROR): CRC does not match. Expected:0x25900 got:0x1347
2017-10-24T01:01:46.951Z,1508806906.951 [NAL9602](INFO): Powering up NAL9602
2017-10-24T01:01:47.788Z,1508806907.788 [PNI_TCM](ERROR): CRC does not match. Expected:0x33706 got:0x0
2017-10-24T01:01:55.368Z,1508806915.368 [CommandLine](IMPORTANT): got command quit
2017-10-24T01:01:56.373Z,1508806916.373 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2017-10-24T01:01:56.376Z,1508806916.376 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2017-10-24T01:01:56.377Z,1508806916.377 [CommandLine ThreadHandler](INFO): Thread cancelled.
2017-10-24T01:01:56.396Z,1508806916.396 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2017-10-24T01:01:56.397Z,1508806916.397 [CommandLine ThreadHandler](INFO): Thread cancelled.
2017-10-24T01:01:56.397Z,1508806916.397 [CommandLine](INFO): Join timeout helper Thread ID is 880
2017-10-24T01:01:56.426Z,1508806916.426 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2017-10-24T01:01:56.426Z,1508806916.426 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2017-10-24T01:01:56.426Z,1508806916.426 [NavChartDb](INFO): Join timeout helper Thread ID is 881
2017-10-24T01:01:56.650Z,1508806916.650 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2017-10-24T01:01:56.650Z,1508806916.650 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2017-10-24T01:01:56.657Z,1508806916.657 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2017-10-24T01:01:56.657Z,1508806916.657 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2017-10-24T01:01:56.658Z,1508806916.658 [Radio_Surface](INFO): Join timeout helper Thread ID is 882
2017-10-24T01:01:56.793Z,1508806916.793 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2017-10-24T01:01:56.794Z,1508806916.794 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2017-10-24T01:01:56.801Z,1508806916.801 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2017-10-24T01:01:56.801Z,1508806916.801 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2017-10-24T01:01:56.802Z,1508806916.802 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 883
2017-10-24T01:01:56.890Z,1508806916.890 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2017-10-24T01:01:56.890Z,1508806916.890 [WetLabsBB2FL](INFO): Powering down
2017-10-24T01:01:56.891Z,1508806916.891 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2017-10-24T01:01:56.901Z,1508806916.901 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2017-10-24T01:01:56.901Z,1508806916.901 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2017-10-24T01:01:56.902Z,1508806916.902 [CTD_Seabird](INFO): Join timeout helper Thread ID is 884
2017-10-24T01:01:56.998Z,1508806916.998 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.371389 seconds old.
2017-10-24T01:01:56.999Z,1508806916.999 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 0.371789 seconds old.
2017-10-24T01:01:57.174Z,1508806917.174 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2017-10-24T01:01:57.257Z,1508806917.257 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface
2017-10-24T01:01:57.258Z,1508806917.258 [CTD_Seabird](INFO): Powering down
2017-10-24T01:01:57.259Z,1508806917.259 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2017-10-24T01:01:57.275Z,1508806917.275 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2017-10-24T01:01:57.275Z,1508806917.275 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2017-10-24T01:01:57.276Z,1508806917.276 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 886
2017-10-24T01:01:57.286Z,1508806917.286 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2017-10-24T01:01:57.287Z,1508806917.287 [CTD_NeilBrown](INFO): Powering down
2017-10-24T01:01:57.287Z,1508806917.287 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2017-10-24T01:01:57.295Z,1508806917.295 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2017-10-24T01:01:57.295Z,1508806917.295 [logger ThreadHandler](INFO): Thread cancelled.
2017-10-24T01:01:57.295Z,1508806917.295 [logger](INFO): Join timeout helper Thread ID is 887
2017-10-24T01:01:57.310Z,1508806917.310 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2017-10-24T01:01:57.310Z,1508806917.310 [logger ThreadHandler](INFO): Thread cancelled.
2017-10-24T01:01:57.315Z,1508806917.315 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2017-10-24T01:01:57.315Z,1508806917.315 [CommandLine ThreadHandler](INFO): Thread cancelled.
2017-10-24T01:01:57.315Z,1508806917.315 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2017-10-24T01:01:57.315Z,1508806917.315 [controlThread ThreadHandler](INFO): Thread cancelled.
2017-10-24T01:01:57.316Z,1508806917.316 [controlThread](INFO): Join timeout helper Thread ID is 888
2017-10-24T01:01:57.334Z,1508806917.334 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2017-10-24T01:01:57.335Z,1508806917.335 [controlThread](DEBUG): Uninitializing ControlThread
2017-10-24T01:01:57.335Z,1508806917.335 [Aanderaa_O2](INFO): Powering down
2017-10-24T01:01:57.338Z,1508806917.338 [NAL9602](INFO): Powering down
2017-10-24T01:01:57.361Z,1508806917.361 [PNI_TCM](INFO): Powering down
2017-10-24T01:01:57.448Z,1508806917.448 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2017-10-24T01:01:57.449Z,1508806917.449 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2017-10-24T01:01:57.450Z,1508806917.450 [MissionManager](INFO): Uninitializing Mission Default
2017-10-24T01:01:57.452Z,1508806917.452 [MissionManager](INFO): Uninitializing Mission Startup
2017-10-24T01:01:57.454Z,1508806917.454 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2017-10-24T01:01:57.454Z,1508806917.454 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2017-10-24T01:01:57.454Z,1508806917.454 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2017-10-24T01:01:57.455Z,1508806917.455 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2017-10-24T01:01:57.455Z,1508806917.455 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2017-10-24T01:01:57.455Z,1508806917.455 [BuoyancyServo](INFO): Powering down
2017-10-24T01:01:57.466Z,1508806917.466 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2017-10-24T01:01:57.466Z,1508806917.466 [ElevatorServo](INFO): Powering down
2017-10-24T01:01:57.486Z,1508806917.486 [MassServo](DEBUG): Uninitialize Mass Servo.
2017-10-24T01:01:57.486Z,1508806917.486 [MassServo](INFO): Powering down
2017-10-24T01:01:57.506Z,1508806917.506 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2017-10-24T01:01:57.506Z,1508806917.506 [RudderServo](INFO): Powering down
2017-10-24T01:01:57.507Z,1508806917.507 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2017-10-24T01:01:57.507Z,1508806917.507 [ThrusterServo](INFO): Powering down
2017-10-24T01:01:57.508Z,1508806917.508 [SBIT](DEBUG): Uninitialize SBIT Component.
2017-10-24T01:01:57.508Z,1508806917.508 [IBIT](DEBUG): Uninitialize IBIT Component.
2017-10-24T01:01:57.508Z,1508806917.508 [CBIT](DEBUG): Uninitialize CBIT Component.
2017-10-24T01:01:57.509Z,1508806917.509 [controlThread ThreadHandler](INFO): Thread cancelled.
2017-10-24T01:01:57.565Z,1508806917.565 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2017-10-24T01:01:57.570Z,1508806917.570 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2017-10-24T01:01:57.572Z,1508806917.572 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2017-10-24T01:01:57.642Z,1508806917.642 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2017-10-24T01:01:57.920Z,1508806917.920 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2017-10-24T01:01:57.976Z,1508806917.976 [logger ThreadHandler](INFO): Thread cancelled.