2015-07-15T22:34:27.250Z,1436999667.250 [Supervisor](DEBUG): Initializing supervisor.
2015-07-15T22:34:27.253Z,1436999667.253 [SyncHandler](DEBUG): Created PCaller Thread at 4034C4E0
2015-07-15T22:34:27.254Z,1436999667.254 [SyncHandler](INFO): Protected caller Thread ID is 8096
2015-07-15T22:34:27.254Z,1436999667.254 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2015-07-15T22:34:27.255Z,1436999667.255 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4037C4E0
2015-07-15T22:34:27.256Z,1436999667.256 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 8097
2015-07-15T22:34:27.260Z,1436999667.260 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2015-07-15T22:34:27.281Z,1436999667.281 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2015-07-15T22:34:27.282Z,1436999667.282 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 403AC4E0
2015-07-15T22:34:27.282Z,1436999667.282 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 8098
2015-07-15T22:34:27.283Z,1436999667.283 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2015-07-15T22:34:27.284Z,1436999667.284 [logger ThreadHandler](DEBUG): Created PCaller Thread at 403DC4E0
2015-07-15T22:34:27.285Z,1436999667.285 [logger ThreadHandler](INFO): Protected caller Thread ID is 8099
2015-07-15T22:34:27.287Z,1436999667.287 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2015-07-15T22:34:27.287Z,1436999667.287 [Supervisor](INFO): Looking for Config files in directory: Config/
2015-07-15T22:34:27.289Z,1436999667.289 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2015-07-15T22:34:27.817Z,1436999667.817 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2015-07-15T22:34:27.818Z,1436999667.818 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2015-07-15T22:34:27.999Z,1436999667.999 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2015-07-15T22:34:27.999Z,1436999667.999 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2015-07-15T22:34:28.114Z,1436999668.114 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2015-07-15T22:34:28.115Z,1436999668.115 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2015-07-15T22:34:28.244Z,1436999668.244 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2015-07-15T22:34:28.245Z,1436999668.245 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2015-07-15T22:34:28.336Z,1436999668.336 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2015-07-15T22:34:28.540Z,1436999668.540 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2015-07-15T22:34:28.540Z,1436999668.540 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2015-07-15T22:34:28.632Z,1436999668.632 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2015-07-15T22:34:28.632Z,1436999668.632 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2015-07-15T22:34:28.904Z,1436999668.904 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2015-07-15T22:34:28.904Z,1436999668.904 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2015-07-15T22:34:29.262Z,1436999669.262 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2015-07-15T22:34:29.263Z,1436999669.263 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2015-07-15T22:34:29.600Z,1436999669.600 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2015-07-15T22:34:29.601Z,1436999669.601 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2015-07-15T22:34:30.212Z,1436999670.212 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2015-07-15T22:34:30.213Z,1436999670.213 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2015-07-15T22:34:30.441Z,1436999670.441 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2015-07-15T22:34:30.442Z,1436999670.442 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2015-07-15T22:34:30.552Z,1436999670.552 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2015-07-15T22:34:30.553Z,1436999670.553 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2015-07-15T22:34:31.022Z,1436999671.022 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2015-07-15T22:34:31.022Z,1436999671.022 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2015-07-15T22:34:31.141Z,1436999671.141 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2015-07-15T22:34:31.143Z,1436999671.143 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2015-07-15T22:34:31.144Z,1436999671.144 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2015-07-15T22:34:31.416Z,1436999671.416 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2015-07-15T22:34:31.416Z,1436999671.416 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2015-07-15T22:34:31.543Z,1436999671.543 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2015-07-15T22:34:31.647Z,1436999671.647 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2015-07-15T22:34:31.752Z,1436999671.752 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2015-07-15T22:34:31.903Z,1436999671.903 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2015-07-15T22:34:32.054Z,1436999672.054 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2015-07-15T22:34:32.166Z,1436999672.166 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2015-07-15T22:34:32.263Z,1436999672.263 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2015-07-15T22:34:32.352Z,1436999672.352 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2015-07-15T22:34:32.455Z,1436999672.455 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2015-07-15T22:34:32.649Z,1436999672.649 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/LOGIN/
2015-07-15T22:34:32.649Z,1436999672.649 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2015-07-15T22:34:32.650Z,1436999672.650 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2015-07-15T22:34:32.721Z,1436999672.721 [VerticalControl](DEBUG): Construct VerticalControl.
2015-07-15T22:34:32.839Z,1436999672.839 [VerticalControl] Loaded
2015-07-15T22:34:32.839Z,1436999672.839 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2015-07-15T22:34:32.840Z,1436999672.840 [HorizontalControl](DEBUG): Construct HorizontalControl.
2015-07-15T22:34:32.911Z,1436999672.911 [HorizontalControl] Loaded
2015-07-15T22:34:32.911Z,1436999672.911 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2015-07-15T22:34:32.912Z,1436999672.912 [SpeedControl](DEBUG): Construct SpeedControl.
2015-07-15T22:34:32.918Z,1436999672.918 [SpeedControl] Loaded
2015-07-15T22:34:32.918Z,1436999672.918 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2015-07-15T22:34:32.919Z,1436999672.919 [LoopControl](DEBUG): Construct LoopControl.
2015-07-15T22:34:32.919Z,1436999672.919 [LoopControl] Loaded
2015-07-15T22:34:32.919Z,1436999672.919 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2015-07-15T22:34:32.920Z,1436999672.920 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2015-07-15T22:34:32.920Z,1436999672.920 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2015-07-15T22:34:33.066Z,1436999673.066 [SBIT](DEBUG): Construct Startup Built In Test.
2015-07-15T22:34:33.078Z,1436999673.078 [SBIT] Loaded
2015-07-15T22:34:33.078Z,1436999673.078 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2015-07-15T22:34:33.079Z,1436999673.079 [IBIT](DEBUG): Construct Initiated Built In Test.
2015-07-15T22:34:33.108Z,1436999673.108 [IBIT] Loaded
2015-07-15T22:34:33.108Z,1436999673.108 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2015-07-15T22:34:33.111Z,1436999673.111 [CBIT](DEBUG): Construct Continuous Built In Test.
2015-07-15T22:34:33.247Z,1436999673.247 [CBIT] Loaded
2015-07-15T22:34:33.247Z,1436999673.247 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2015-07-15T22:34:33.248Z,1436999673.248 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2015-07-15T22:34:33.248Z,1436999673.248 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2015-07-15T22:34:33.276Z,1436999673.276 [DepthRateCalculator] Loaded
2015-07-15T22:34:33.276Z,1436999673.276 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2015-07-15T22:34:33.281Z,1436999673.281 [PitchRateCalculator] Loaded
2015-07-15T22:34:33.282Z,1436999673.282 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2015-07-15T22:34:33.293Z,1436999673.293 [SpeedCalculator] Loaded
2015-07-15T22:34:33.293Z,1436999673.293 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2015-07-15T22:34:33.310Z,1436999673.310 [TempGradientCalculator] Loaded
2015-07-15T22:34:33.310Z,1436999673.310 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2015-07-15T22:34:33.315Z,1436999673.315 [YawRateCalculator] Loaded
2015-07-15T22:34:33.315Z,1436999673.315 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2015-07-15T22:34:33.316Z,1436999673.316 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2015-07-15T22:34:33.317Z,1436999673.317 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2015-07-15T22:34:33.401Z,1436999673.401 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2015-07-15T22:34:33.401Z,1436999673.401 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2015-07-15T22:34:33.667Z,1436999673.667 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2015-07-15T22:34:33.667Z,1436999673.667 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2015-07-15T22:34:33.782Z,1436999673.782 [DeadReckonUsingMultipleVelocitySources] Loaded
2015-07-15T22:34:33.783Z,1436999673.783 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2015-07-15T22:34:33.839Z,1436999673.839 [DeadReckonUsingSpeedCalculator] Loaded
2015-07-15T22:34:33.839Z,1436999673.839 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2015-07-15T22:34:33.856Z,1436999673.856 [NavChart] Loaded
2015-07-15T22:34:33.856Z,1436999673.856 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2015-07-15T22:34:33.861Z,1436999673.861 [UniversalFixResidualReporter] Loaded
2015-07-15T22:34:33.861Z,1436999673.861 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2015-07-15T22:34:33.861Z,1436999673.861 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2015-07-15T22:34:33.862Z,1436999673.862 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2015-07-15T22:34:33.870Z,1436999673.870 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2015-07-15T22:34:33.871Z,1436999673.871 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2015-07-15T22:34:34.093Z,1436999674.093 [Aanderaa_O2] Loaded
2015-07-15T22:34:34.094Z,1436999674.094 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2015-07-15T22:34:34.170Z,1436999674.170 [CTD_NeilBrown] Loaded
2015-07-15T22:34:34.171Z,1436999674.171 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2015-07-15T22:34:34.172Z,1436999674.172 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 4058D4E0
2015-07-15T22:34:34.172Z,1436999674.172 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 8180
2015-07-15T22:34:34.187Z,1436999674.187 [ESPComponent] Loaded
2015-07-15T22:34:34.187Z,1436999674.187 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2015-07-15T22:34:34.202Z,1436999674.202 [PAR_Licor] Loaded
2015-07-15T22:34:34.203Z,1436999674.203 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2015-07-15T22:34:34.253Z,1436999674.253 [WetLabsBB2FL] Loaded
2015-07-15T22:34:34.254Z,1436999674.254 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2015-07-15T22:34:34.255Z,1436999674.255 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 405BD4E0
2015-07-15T22:34:34.255Z,1436999674.255 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 8181
2015-07-15T22:34:34.256Z,1436999674.256 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2015-07-15T22:34:34.256Z,1436999674.256 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2015-07-15T22:34:34.746Z,1436999674.746 [AcousticModem_Benthos_ATM900] Loaded
2015-07-15T22:34:34.746Z,1436999674.746 [ComponentRegistry](DEBUG): SyncComponent "AcousticModem_Benthos_ATM900" handled in the control thread.
2015-07-15T22:34:34.854Z,1436999674.854 [DataOverHttps] Loaded
2015-07-15T22:34:34.855Z,1436999674.855 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2015-07-15T22:34:34.868Z,1436999674.868 [Depth_Keller] Loaded
2015-07-15T22:34:34.868Z,1436999674.868 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2015-07-15T22:34:34.873Z,1436999674.873 [DropWeight] Loaded
2015-07-15T22:34:34.874Z,1436999674.874 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2015-07-15T22:34:34.967Z,1436999674.967 [NAL9602] Loaded
2015-07-15T22:34:34.968Z,1436999674.968 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2015-07-15T22:34:35.009Z,1436999675.009 [Onboard] Loaded
2015-07-15T22:34:35.009Z,1436999675.009 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2015-07-15T22:34:35.016Z,1436999675.016 [Radio_Surface] Loaded
2015-07-15T22:34:35.017Z,1436999675.017 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2015-07-15T22:34:35.018Z,1436999675.018 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408014E0
2015-07-15T22:34:35.018Z,1436999675.018 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 8182
2015-07-15T22:34:35.316Z,1436999675.316 [PNI_TCM] Loaded
2015-07-15T22:34:35.316Z,1436999675.316 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread.
2015-07-15T22:34:35.500Z,1436999675.500 [Rowe_600] Loaded
2015-07-15T22:34:35.501Z,1436999675.501 [ComponentRegistry](DEBUG): Component "Rowe_600" handled in its own thread.
2015-07-15T22:34:35.502Z,1436999675.502 [Rowe_600 ThreadHandler](DEBUG): Created PCaller Thread at 408314E0
2015-07-15T22:34:35.502Z,1436999675.502 [Rowe_600 ThreadHandler](INFO): Protected caller Thread ID is 8185
2015-07-15T22:34:37.407Z,1436999677.407 [BPC1] Loaded
2015-07-15T22:34:37.407Z,1436999677.407 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2015-07-15T22:34:37.408Z,1436999677.408 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2015-07-15T22:34:37.408Z,1436999677.408 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2015-07-15T22:34:37.531Z,1436999677.531 [BuoyancyServo] Loaded
2015-07-15T22:34:37.531Z,1436999677.531 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2015-07-15T22:34:37.543Z,1436999677.543 [ElevatorServo] Loaded
2015-07-15T22:34:37.544Z,1436999677.544 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2015-07-15T22:34:37.555Z,1436999677.555 [MassServo] Loaded
2015-07-15T22:34:37.556Z,1436999677.556 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2015-07-15T22:34:37.570Z,1436999677.570 [RudderServo] Loaded
2015-07-15T22:34:37.570Z,1436999677.570 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2015-07-15T22:34:37.582Z,1436999677.582 [ThrusterServo] Loaded
2015-07-15T22:34:37.582Z,1436999677.582 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2015-07-15T22:34:37.583Z,1436999677.583 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2015-07-15T22:34:37.584Z,1436999677.584 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2015-07-15T22:34:37.789Z,1436999677.789 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2015-07-15T22:34:37.790Z,1436999677.790 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2015-07-15T22:34:37.828Z,1436999677.828 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2015-07-15T22:34:37.832Z,1436999677.832 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2015-07-15T22:34:37.834Z,1436999677.834 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2015-07-15T22:34:37.841Z,1436999677.841 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2015-07-15T22:34:37.842Z,1436999677.842 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 408DF4E0
2015-07-15T22:34:37.842Z,1436999677.842 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 8186
2015-07-15T22:34:37.848Z,1436999677.848 [Supervisor](INFO): Main Thread ID is 8095
2015-07-15T22:34:37.848Z,1436999677.848 [Supervisor](DEBUG): Running supervisor.
2015-07-15T22:34:37.848Z,1436999677.848 [CommandLine ThreadHandler](INFO): Handler Thread ID is 8187
2015-07-15T22:34:37.851Z,1436999677.851 [controlThread ThreadHandler](INFO): Handler Thread ID is 8188
2015-07-15T22:34:37.851Z,1436999677.851 [controlThread](DEBUG): Initializing ControlThread
2015-07-15T22:34:37.852Z,1436999677.852 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2015-07-15T22:34:37.854Z,1436999677.854 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2015-07-15T22:34:37.855Z,1436999677.855 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2015-07-15T22:34:37.855Z,1436999677.855 [LoopControl](DEBUG): Initialize LoopControlComponent.
2015-07-15T22:34:37.856Z,1436999677.856 [SBIT](INFO): Initialize SBIT Component.
2015-07-15T22:34:37.856Z,1436999677.856 [SBIT](IMPORTANT): Tethys CM Info: SVN revision:12443
2015-07-15T22:34:37.856Z,1436999677.856 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2015-07-15T22:34:37.857Z,1436999677.857 [SBIT](IMPORTANT): Kernel Version:#639 PREEMPT Wed Mar 12 12:53:33 PDT 2014
2015-07-15T22:34:37.858Z,1436999677.858 [SBIT](INFO): Beginning SBIT in 63.000000 seconds.
2015-07-15T22:34:37.858Z,1436999677.858 [IBIT](INFO): Initialize IBIT Component.
2015-07-15T22:34:37.859Z,1436999677.859 [CBIT](DEBUG): Initialize CBIT Component.
2015-07-15T22:34:37.859Z,1436999677.859 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL.
2015-07-15T22:34:37.859Z,1436999677.859 [CBIT](CRITICAL): Watchdog Timer failed to initialize.
2015-07-15T22:34:37.860Z,1436999677.860 [CBIT] Hardware Fault, FailCount= 1
2015-07-15T22:34:37.860Z,1436999677.860 [CBIT](ERROR): Hardware Fault
2015-07-15T22:34:37.861Z,1436999677.861 [logger ThreadHandler](INFO): Handler Thread ID is 8189
2015-07-15T22:34:37.880Z,1436999677.880 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 8190
2015-07-15T22:34:37.880Z,1436999677.880 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown.
2015-07-15T22:34:37.883Z,1436999677.883 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2015-07-15T22:34:37.884Z,1436999677.884 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2015-07-15T22:34:37.884Z,1436999677.884 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2015-07-15T22:34:37.884Z,1436999677.884 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2015-07-15T22:34:37.885Z,1436999677.885 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2015-07-15T22:34:37.885Z,1436999677.885 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2015-07-15T22:34:37.886Z,1436999677.886 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after this many seconds: 120.000000
2015-07-15T22:34:37.886Z,1436999677.886 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after this many seconds: 20.000000
2015-07-15T22:34:37.887Z,1436999677.887 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2015-07-15T22:34:37.887Z,1436999677.887 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after this many seconds: 120.000000
2015-07-15T22:34:37.887Z,1436999677.887 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after this many seconds: 20.000000
2015-07-15T22:34:37.888Z,1436999677.888 [NavChart](DEBUG): Initialize NavChart Navigation.
2015-07-15T22:34:37.888Z,1436999677.888 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2015-07-15T22:34:37.900Z,1436999677.900 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2015-07-15T22:34:37.909Z,1436999677.909 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 8192
2015-07-15T22:34:37.910Z,1436999677.910 [WetLabsBB2FL](INFO): Powering down
2015-07-15T22:34:37.934Z,1436999677.934 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2015-07-15T22:34:37.940Z,1436999677.940 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 8193
2015-07-15T22:34:37.946Z,1436999677.946 [Radio_Surface](INFO): Powering up
2015-07-15T22:34:37.960Z,1436999677.960 [Rowe_600 ThreadHandler](INFO): Handler Thread ID is 8194
2015-07-15T22:34:37.961Z,1436999677.961 [Rowe_600](INFO): Initializing
2015-07-15T22:34:37.981Z,1436999677.981 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2015-07-15T22:34:37.000Z,1436999678.000 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 8195
2015-07-15T22:34:38.005Z,1436999678.005 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources
2015-07-15T22:34:38.006Z,1436999678.006 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2015-07-15T22:34:38.006Z,1436999678.006 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2015-07-15T22:34:38.006Z,1436999678.006 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2015-07-15T22:34:38.007Z,1436999678.007 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2015-07-15T22:34:38.007Z,1436999678.007 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2015-07-15T22:34:38.007Z,1436999678.007 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2015-07-15T22:34:38.008Z,1436999678.008 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2015-07-15T22:34:38.008Z,1436999678.008 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2015-07-15T22:34:38.028Z,1436999678.028 [Rowe_600](INFO): Powering up
2015-07-15T22:34:38.037Z,1436999678.037 [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://aosn.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://aosn.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://aosn.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://aosn.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://aosn.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>


2015-07-15T22:34:38.037Z,1436999678.037 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2015-07-15T22:34:38.120Z,1436999678.120 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2015-07-15T22:34:38.121Z,1436999678.121 [Default:A.GoToSurface](DEBUG): Construct GoToSurface.
2015-07-15T22:34:38.176Z,1436999678.176 [Default:SplitLargeDefaultLogs:A.Execute](DEBUG): Construct Execute.
2015-07-15T22:34:38.180Z,1436999678.180 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2015-07-15T22:34:38.201Z,1436999678.201 [Default:CheckIn:WaitAnHour:A.Wait](DEBUG): Construct Wait.
2015-07-15T22:34:38.203Z,1436999678.203 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2015-07-15T22:34:38.207Z,1436999678.207 [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://aosn.mbari.org/tethys/Xml/Tethys.xsd
Tethys/Control http://aosn.mbari.org/tethys/Xml/Control.xsd
Tethys/Guidance http://aosn.mbari.org/tethys/Xml/Guidance.xsd
Tethys/Units http://aosn.mbari.org/tethys/Xml/Units.xsd
Tethys/Universal http://aosn.mbari.org/tethys/Xml/Universal.xsd"
Id="Default">

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

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

    <ReadDatum Id="Read_GPS">
        <Sequence/>
        <Timeout Duration="P5M"/>
<!-- NOTE: Original Default.xml didn't have a timeout on the GPS read, so theoretically could have hung indefinitely there... -->
        <Universal:time_fix/>
    </ReadDatum>

    <Aggregate Id="ReportMinutesSinceMissionStarted">

        <When>
            <Elapsed><Universal:mission_started/></Elapsed>
            <Gt><Units:minute/><Value>10</Value></Gt>
            <And><Elapsed><Universal:time_fix/></Elapsed><Lt><Units:millisecond/><Value>500</Value></Lt></And>
        </When>

        <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>

    <Aggregate Id="SplitLargeDefaultLogs">

        <When>
            <Arg Name="ElapsedSinceDefaultStarted"/>
            <Gt><Units:day/><Value>1</Value></Gt>
        </When>

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

    </Aggregate>

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

        <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>

        <Aggregate Id="WaitAnHour">

            <When>
                <Universal:platform_conversation/>
                <Eq><False/></Eq>
            </When>

            <Guidance:Wait>
                <Sequence/>
                <Setting><Guidance:Wait.duration/><Units:hour/><Value>1</Value></Setting>
            </Guidance:Wait>

        </Aggregate>

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

    </Aggregate>

</Mission>


2015-07-15T22:34:38.216Z,1436999678.216 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,ESPComponent,PAR_Licor,AcousticModem_Benthos_ATM900,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,PNI_TCM,BPC1,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2015-07-15T22:34:38.288Z,1436999678.288 [AcousticModem_Benthos_ATM900](INFO): Powering up
2015-07-15T22:34:38.288Z,1436999678.288 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2015-07-15T22:34:38.338Z,1436999678.338 [CTD_NeilBrown](DEBUG): CTD uart timeout: serial timeout
2015-07-15T22:34:38.338Z,1436999678.338 [CTD_NeilBrown](ERROR): Could not get real or simulated CTD data. startTime.elapsed() = 0.437679
2015-07-15T22:34:38.677Z,1436999678.677 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:38.821Z,1436999678.821 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:38.941Z,1436999678.941 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2015-07-15T22:34:38.949Z,1436999678.949 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2015-07-15T22:34:38.963Z,1436999678.963 [ElevatorServo](DEBUG): Initializing EZServoServo.
2015-07-15T22:34:38.970Z,1436999678.970 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2015-07-15T22:34:38.976Z,1436999678.976 [MassServo](DEBUG): Initializing EZServoServo.
2015-07-15T22:34:38.981Z,1436999678.981 [MassServo](DEBUG): Initializing MassServo.
2015-07-15T22:34:38.994Z,1436999678.994 [RudderServo](DEBUG): Initializing EZServoServo.
2015-07-15T22:34:39.001Z,1436999679.001 [RudderServo](DEBUG): Initializing RudderServo.
2015-07-15T22:34:39.014Z,1436999679.014 [ThrusterServo](DEBUG): Initializing EZServoServo.
2015-07-15T22:34:39.021Z,1436999679.021 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2015-07-15T22:34:39.069Z,1436999679.069 [CBIT](DEBUG): Uninitialize CBIT Component.
2015-07-15T22:34:39.150Z,1436999679.150 [ESPComponent](INFO): Powering down
2015-07-15T22:34:39.574Z,1436999679.574 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:39.575Z,1436999679.575 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:39.922Z,1436999679.922 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2015-07-15T22:34:39.923Z,1436999679.923 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2015-07-15T22:34:39.923Z,1436999679.923 [BuoyancyServo] Communications Fault, FailCount= 1
2015-07-15T22:34:39.923Z,1436999679.923 [BuoyancyServo](ERROR): Communications Fault
2015-07-15T22:34:40.243Z,1436999680.243 [ElevatorServo](ERROR): Elevator initialization uart error I:serial timeout
2015-07-15T22:34:40.243Z,1436999680.243 [ElevatorServo](FAULT): Elevator failed to initialize
2015-07-15T22:34:40.243Z,1436999680.243 [ElevatorServo] Communications Fault, FailCount= 1
2015-07-15T22:34:40.243Z,1436999680.243 [ElevatorServo](ERROR): Communications Fault
2015-07-15T22:34:40.575Z,1436999680.575 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2015-07-15T22:34:40.575Z,1436999680.575 [RudderServo](FAULT): Rudder failed to initialize
2015-07-15T22:34:40.575Z,1436999680.575 [RudderServo] Communications Fault, FailCount= 1
2015-07-15T22:34:40.576Z,1436999680.576 [RudderServo](ERROR): Communications Fault
2015-07-15T22:34:40.888Z,1436999680.888 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout
2015-07-15T22:34:41.200Z,1436999681.200 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout
2015-07-15T22:34:41.200Z,1436999681.200 [ThrusterServo](FAULT): Thruster failed to initialize
2015-07-15T22:34:41.200Z,1436999681.200 [ThrusterServo] Communications Fault, FailCount= 1
2015-07-15T22:34:41.200Z,1436999681.200 [ThrusterServo](ERROR): Communications Fault
2015-07-15T22:34:41.222Z,1436999681.222 [NAL9602](INFO): Powering up NAL9602
2015-07-15T22:34:41.291Z,1436999681.291 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:41.292Z,1436999681.292 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:41.310Z,1436999681.310 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2015-07-15T22:34:41.311Z,1436999681.311 [BuoyancyServo](INFO): Powering down
2015-07-15T22:34:41.381Z,1436999681.381 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2015-07-15T22:34:41.381Z,1436999681.381 [ElevatorServo](INFO): Powering down
2015-07-15T22:34:41.726Z,1436999681.726 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout
2015-07-15T22:34:41.726Z,1436999681.726 [MassServo] Communications Fault, FailCount= 1
2015-07-15T22:34:41.726Z,1436999681.726 [MassServo](ERROR): Communications Fault
2015-07-15T22:34:41.726Z,1436999681.726 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2015-07-15T22:34:41.727Z,1436999681.727 [RudderServo](INFO): Powering down
2015-07-15T22:34:41.759Z,1436999681.759 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2015-07-15T22:34:41.760Z,1436999681.760 [ThrusterServo](INFO): Powering down
2015-07-15T22:34:41.878Z,1436999681.878 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:41.879Z,1436999681.879 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:41.892Z,1436999681.892 [MassServo](DEBUG): Uninitialize Mass Servo.
2015-07-15T22:34:41.892Z,1436999681.892 [MassServo](INFO): Powering down
2015-07-15T22:34:42.293Z,1436999682.293 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:42.302Z,1436999682.302 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:42.317Z,1436999682.317 [ElevatorServo](DEBUG): Initializing EZServoServo.
2015-07-15T22:34:42.435Z,1436999682.435 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2015-07-15T22:34:42.437Z,1436999682.437 [RudderServo](DEBUG): Initializing EZServoServo.
2015-07-15T22:34:42.556Z,1436999682.556 [RudderServo](DEBUG): Initializing RudderServo.
2015-07-15T22:34:42.729Z,1436999682.729 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:42.743Z,1436999682.743 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:42.758Z,1436999682.758 [MassServo](DEBUG): Initializing EZServoServo.
2015-07-15T22:34:42.876Z,1436999682.876 [MassServo](DEBUG): Initializing MassServo.
2015-07-15T22:34:43.125Z,1436999683.125 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:43.126Z,1436999683.126 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:43.530Z,1436999683.530 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:43.531Z,1436999683.531 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:43.959Z,1436999683.959 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:43.960Z,1436999683.960 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:44.360Z,1436999684.360 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:44.361Z,1436999684.361 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:44.721Z,1436999684.721 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:44.726Z,1436999684.726 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:45.162Z,1436999685.162 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:45.171Z,1436999685.171 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:45.508Z,1436999685.508 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:45.509Z,1436999685.509 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:45.906Z,1436999685.906 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:45.908Z,1436999685.908 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:46.344Z,1436999686.344 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:46.353Z,1436999686.353 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:46.744Z,1436999686.744 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:46.753Z,1436999686.753 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:47.137Z,1436999687.137 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:47.139Z,1436999687.139 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:47.522Z,1436999687.522 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:47.531Z,1436999687.531 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:47.958Z,1436999687.958 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:47.959Z,1436999687.959 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:48.283Z,1436999688.283 [Aanderaa_O2](FAULT): Timed out starting
2015-07-15T22:34:48.284Z,1436999688.284 [Aanderaa_O2] Communications Fault, FailCount= 1
2015-07-15T22:34:48.284Z,1436999688.284 [Aanderaa_O2](ERROR): Communications Fault
2015-07-15T22:34:48.394Z,1436999688.394 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:48.395Z,1436999688.395 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:48.804Z,1436999688.804 [Aanderaa_O2](INFO): Powering down
2015-07-15T22:34:48.897Z,1436999688.897 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:48.898Z,1436999688.898 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:49.128Z,1436999689.128 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:49.137Z,1436999689.137 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:49.536Z,1436999689.536 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:49.545Z,1436999689.545 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:49.933Z,1436999689.933 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:49.934Z,1436999689.934 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:50.326Z,1436999690.326 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:50.331Z,1436999690.331 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:50.739Z,1436999690.739 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:50.740Z,1436999690.740 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:51.215Z,1436999691.215 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:51.216Z,1436999691.216 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:51.556Z,1436999691.556 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:51.569Z,1436999691.569 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:51.948Z,1436999691.948 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:51.958Z,1436999691.958 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:52.338Z,1436999692.338 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2015-07-15T22:34:52.338Z,1436999692.338 [PNI_TCM] Data Fault, FailCount= 1
2015-07-15T22:34:52.338Z,1436999692.338 [PNI_TCM](ERROR): Data Fault
2015-07-15T22:34:52.347Z,1436999692.347 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:52.348Z,1436999692.348 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:52.719Z,1436999692.719 [PNI_TCM](INFO): Powering down
2015-07-15T22:34:52.887Z,1436999692.887 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:52.888Z,1436999692.888 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:53.118Z,1436999693.118 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:53.119Z,1436999693.119 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:53.551Z,1436999693.551 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:53.556Z,1436999693.556 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:54.020Z,1436999694.020 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:54.026Z,1436999694.026 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:54.311Z,1436999694.311 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:54.313Z,1436999694.313 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:54.741Z,1436999694.741 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:54.750Z,1436999694.750 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:55.136Z,1436999695.136 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:55.137Z,1436999695.137 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:55.529Z,1436999695.529 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:55.531Z,1436999695.531 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:55.934Z,1436999695.934 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:55.948Z,1436999695.948 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:56.306Z,1436999696.306 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:56.307Z,1436999696.307 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:56.735Z,1436999696.735 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:56.736Z,1436999696.736 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:57.140Z,1436999697.140 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:57.150Z,1436999697.150 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:57.524Z,1436999697.524 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:57.525Z,1436999697.525 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:57.930Z,1436999697.930 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:57.932Z,1436999697.932 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:58.329Z,1436999698.329 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:58.330Z,1436999698.330 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:58.688Z,1436999698.688 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2015-07-15T22:34:58.688Z,1436999698.688 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 1
2015-07-15T22:34:58.688Z,1436999698.688 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2015-07-15T22:34:58.722Z,1436999698.722 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:58.723Z,1436999698.723 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:59.089Z,1436999699.089 [AcousticModem_Benthos_ATM900](INFO): Powering down
2015-07-15T22:34:59.394Z,1436999699.394 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:59.396Z,1436999699.396 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:59.512Z,1436999699.512 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:59.521Z,1436999699.521 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:59.936Z,1436999699.936 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:34:59.937Z,1436999699.937 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:35:00.366Z,1436999700.366 [CommandLine](IMPORTANT): got command quit
2015-07-15T22:35:00.396Z,1436999700.396 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:35:00.397Z,1436999700.397 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:35:00.735Z,1436999700.735 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:35:00.736Z,1436999700.736 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:35:01.227Z,1436999701.227 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:35:01.236Z,1436999701.236 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:35:01.371Z,1436999701.371 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2015-07-15T22:35:01.371Z,1436999701.371 [CommandLine ThreadHandler](INFO): Thread cancelled.
2015-07-15T22:35:01.468Z,1436999701.468 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2015-07-15T22:35:01.468Z,1436999701.468 [CommandLine ThreadHandler](INFO): Thread cancelled.
2015-07-15T22:35:01.469Z,1436999701.469 [CommandLine](INFO): Join timeout helper Thread ID is 8219
2015-07-15T22:35:01.512Z,1436999701.512 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2015-07-15T22:35:01.512Z,1436999701.512 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2015-07-15T22:35:01.512Z,1436999701.512 [NavChartDb](INFO): Join timeout helper Thread ID is 8220
2015-07-15T22:35:01.519Z,1436999701.519 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:35:01.545Z,1436999701.545 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:35:01.908Z,1436999701.908 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:35:01.913Z,1436999701.913 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:35:02.201Z,1436999702.201 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2015-07-15T22:35:02.201Z,1436999702.201 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2015-07-15T22:35:02.213Z,1436999702.213 [ComponentRegistry](INFO): Shutting down Rowe_600 ThreadHandler
2015-07-15T22:35:02.213Z,1436999702.213 [Rowe_600 ThreadHandler](INFO): Thread cancelled.
2015-07-15T22:35:02.213Z,1436999702.213 [Rowe_600](INFO): Join timeout helper Thread ID is 8221
2015-07-15T22:35:02.299Z,1436999702.299 [NAL9602](ERROR): NAL9602 initialization error.
2015-07-15T22:35:02.299Z,1436999702.299 [NAL9602] Communications Fault, FailCount= 1
2015-07-15T22:35:02.300Z,1436999702.300 [NAL9602](ERROR): Communications Fault
2015-07-15T22:35:02.309Z,1436999702.309 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:35:02.311Z,1436999702.311 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:35:02.383Z,1436999702.383 [Rowe_600 ThreadHandler](INFO): Uninitializing protected caller thread.
2015-07-15T22:35:02.383Z,1436999702.383 [Rowe_600](INFO): Powering down
2015-07-15T22:35:02.475Z,1436999702.475 [Rowe_600 ThreadHandler](INFO): Thread cancelled.
2015-07-15T22:35:02.477Z,1436999702.477 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2015-07-15T22:35:02.477Z,1436999702.477 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2015-07-15T22:35:02.478Z,1436999702.478 [Radio_Surface](INFO): Join timeout helper Thread ID is 8222
2015-07-15T22:35:02.646Z,1436999702.646 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2015-07-15T22:35:02.646Z,1436999702.646 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2015-07-15T22:35:02.658Z,1436999702.658 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2015-07-15T22:35:02.658Z,1436999702.658 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2015-07-15T22:35:02.658Z,1436999702.658 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 8223
2015-07-15T22:35:02.715Z,1436999702.715 [NAL9602](INFO): Powering down
2015-07-15T22:35:02.744Z,1436999702.744 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:35:02.745Z,1436999702.745 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:35:03.030Z,1436999703.030 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2015-07-15T22:35:03.031Z,1436999703.031 [WetLabsBB2FL](INFO): Powering down
2015-07-15T22:35:03.031Z,1436999703.031 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2015-07-15T22:35:03.043Z,1436999703.043 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2015-07-15T22:35:03.043Z,1436999703.043 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2015-07-15T22:35:03.044Z,1436999703.044 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 8224
2015-07-15T22:35:03.113Z,1436999703.113 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:35:03.114Z,1436999703.114 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:35:03.443Z,1436999703.443 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2015-07-15T22:35:03.443Z,1436999703.443 [CTD_NeilBrown](INFO): Powering down
2015-07-15T22:35:03.444Z,1436999703.444 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2015-07-15T22:35:03.456Z,1436999703.456 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2015-07-15T22:35:03.456Z,1436999703.456 [logger ThreadHandler](INFO): Thread cancelled.
2015-07-15T22:35:03.456Z,1436999703.456 [logger](INFO): Join timeout helper Thread ID is 8225
2015-07-15T22:35:03.475Z,1436999703.475 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2015-07-15T22:35:03.475Z,1436999703.475 [logger ThreadHandler](INFO): Thread cancelled.
2015-07-15T22:35:03.496Z,1436999703.496 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2015-07-15T22:35:03.496Z,1436999703.496 [CommandLine ThreadHandler](INFO): Thread cancelled.
2015-07-15T22:35:03.496Z,1436999703.496 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2015-07-15T22:35:03.496Z,1436999703.496 [controlThread ThreadHandler](INFO): Thread cancelled.
2015-07-15T22:35:03.497Z,1436999703.497 [controlThread](INFO): Join timeout helper Thread ID is 8226
2015-07-15T22:35:03.509Z,1436999703.509 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:35:03.511Z,1436999703.511 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2015-07-15T22:35:03.518Z,1436999703.518 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2015-07-15T22:35:03.518Z,1436999703.518 [controlThread](DEBUG): Uninitializing ControlThread
2015-07-15T22:35:03.519Z,1436999703.519 [Aanderaa_O2](INFO): Powering down
2015-07-15T22:35:03.520Z,1436999703.520 [AcousticModem_Benthos_ATM900](INFO): Powering down
2015-07-15T22:35:03.522Z,1436999703.522 [NAL9602](INFO): Powering down
2015-07-15T22:35:03.523Z,1436999703.523 [PNI_TCM](INFO): Powering down
2015-07-15T22:35:03.525Z,1436999703.525 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2015-07-15T22:35:03.526Z,1436999703.526 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2015-07-15T22:35:03.530Z,1436999703.530 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2015-07-15T22:35:03.530Z,1436999703.530 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2015-07-15T22:35:03.531Z,1436999703.531 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2015-07-15T22:35:03.531Z,1436999703.531 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2015-07-15T22:35:03.531Z,1436999703.531 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2015-07-15T22:35:03.532Z,1436999703.532 [BuoyancyServo](INFO): Powering down
2015-07-15T22:35:03.547Z,1436999703.547 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2015-07-15T22:35:03.547Z,1436999703.547 [ElevatorServo](INFO): Powering down
2015-07-15T22:35:03.548Z,1436999703.548 [MassServo](DEBUG): Uninitialize Mass Servo.
2015-07-15T22:35:03.548Z,1436999703.548 [MassServo](INFO): Powering down
2015-07-15T22:35:03.549Z,1436999703.549 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2015-07-15T22:35:03.549Z,1436999703.549 [RudderServo](INFO): Powering down
2015-07-15T22:35:03.550Z,1436999703.550 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2015-07-15T22:35:03.550Z,1436999703.550 [ThrusterServo](INFO): Powering down
2015-07-15T22:35:03.550Z,1436999703.550 [SBIT](DEBUG): Uninitialize SBIT Component.
2015-07-15T22:35:03.551Z,1436999703.551 [IBIT](DEBUG): Uninitialize IBIT Component.
2015-07-15T22:35:03.551Z,1436999703.551 [CBIT](DEBUG): Uninitialize CBIT Component.
2015-07-15T22:35:03.587Z,1436999703.587 [CBIT](CRITICAL): run-time exception #7
2015-07-15T22:35:03.587Z,1436999703.587 [CBIT](CRITICAL): Bad address: 0x40319004
2015-07-15T22:35:03.587Z,1436999703.587 [CBIT](CRITICAL): Backtrace: 
./bin/LRAUV(_ZN7PCaller20DefaultSignalHandlerEiP7siginfoPv+0x20) [0x1749e4]
/lib/libc.so.6(__default_rt_sa_restorer+0) [0x40212510]

2015-07-15T22:35:03.587Z,1436999703.587 [CBIT] Software Fault, FailCount= 1
2015-07-15T22:35:03.588Z,1436999703.588 [CBIT](ERROR): Software Fault
2015-07-15T22:35:03.589Z,1436999703.589 [SyncHandler](DEBUG): Created PCaller Thread at 4034C4E0
2015-07-15T22:35:03.590Z,1436999703.590 [SyncHandler](INFO): Protected caller Thread ID is 8227
2015-07-15T22:35:03.591Z,1436999703.591 [controlThread ThreadHandler](INFO): Thread cancelled.
2015-07-15T22:35:03.650Z,1436999703.650 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2015-07-15T22:35:03.654Z,1436999703.654 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2015-07-15T22:35:03.715Z,1436999703.715 [Rowe_600 ThreadHandler](INFO): Thread cancelled.
2015-07-15T22:35:03.722Z,1436999703.722 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2015-07-15T22:35:04.239Z,1436999704.239 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2015-07-15T22:35:04.289Z,1436999704.289 [logger ThreadHandler](INFO): Thread cancelled.