2016-05-20T19:12:17.723Z,1463771537.723 [Supervisor](DEBUG): Initializing supervisor.
2016-05-20T19:12:17.726Z,1463771537.726 [SyncHandler](DEBUG): Created PCaller Thread at 4034C4E0
2016-05-20T19:12:17.726Z,1463771537.726 [SyncHandler](INFO): Protected caller Thread ID is 1305
2016-05-20T19:12:17.727Z,1463771537.727 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2016-05-20T19:12:17.728Z,1463771537.728 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4037C4E0
2016-05-20T19:12:17.728Z,1463771537.728 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1306
2016-05-20T19:12:17.732Z,1463771537.732 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2016-05-20T19:12:17.745Z,1463771537.745 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2016-05-20T19:12:17.746Z,1463771537.746 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 403AC4E0
2016-05-20T19:12:17.746Z,1463771537.746 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1307
2016-05-20T19:12:17.747Z,1463771537.747 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2016-05-20T19:12:17.748Z,1463771537.748 [logger ThreadHandler](DEBUG): Created PCaller Thread at 403DC4E0
2016-05-20T19:12:17.748Z,1463771537.748 [logger ThreadHandler](INFO): Protected caller Thread ID is 1308
2016-05-20T19:12:17.750Z,1463771537.750 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2016-05-20T19:12:17.751Z,1463771537.751 [Supervisor](INFO): Looking for Config files in directory: Config/
2016-05-20T19:12:17.753Z,1463771537.753 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2016-05-20T19:12:18.245Z,1463771538.245 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2016-05-20T19:12:18.246Z,1463771538.246 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2016-05-20T19:12:18.412Z,1463771538.412 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2016-05-20T19:12:18.412Z,1463771538.412 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2016-05-20T19:12:18.538Z,1463771538.538 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2016-05-20T19:12:18.539Z,1463771538.539 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2016-05-20T19:12:18.672Z,1463771538.672 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2016-05-20T19:12:18.673Z,1463771538.673 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2016-05-20T19:12:18.758Z,1463771538.758 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2016-05-20T19:12:18.948Z,1463771538.948 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2016-05-20T19:12:18.948Z,1463771538.948 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2016-05-20T19:12:19.034Z,1463771539.034 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2016-05-20T19:12:19.035Z,1463771539.035 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2016-05-20T19:12:19.309Z,1463771539.309 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2016-05-20T19:12:19.310Z,1463771539.310 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2016-05-20T19:12:19.661Z,1463771539.661 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2016-05-20T19:12:19.662Z,1463771539.662 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2016-05-20T19:12:19.981Z,1463771539.981 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2016-05-20T19:12:19.981Z,1463771539.981 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2016-05-20T19:12:20.487Z,1463771540.487 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2016-05-20T19:12:20.488Z,1463771540.488 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2016-05-20T19:12:20.689Z,1463771540.689 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2016-05-20T19:12:20.689Z,1463771540.689 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2016-05-20T19:12:20.793Z,1463771540.793 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2016-05-20T19:12:20.794Z,1463771540.794 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2016-05-20T19:12:21.231Z,1463771541.231 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2016-05-20T19:12:21.231Z,1463771541.231 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2016-05-20T19:12:21.342Z,1463771541.342 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2016-05-20T19:12:21.344Z,1463771541.344 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2016-05-20T19:12:21.345Z,1463771541.345 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2016-05-20T19:12:21.590Z,1463771541.590 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2016-05-20T19:12:21.591Z,1463771541.591 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2016-05-20T19:12:21.707Z,1463771541.707 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2016-05-20T19:12:21.804Z,1463771541.804 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2016-05-20T19:12:21.900Z,1463771541.900 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2016-05-20T19:12:21.990Z,1463771541.990 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2016-05-20T19:12:22.135Z,1463771542.135 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2016-05-20T19:12:22.289Z,1463771542.289 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2016-05-20T19:12:22.391Z,1463771542.391 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2016-05-20T19:12:22.474Z,1463771542.474 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2016-05-20T19:12:22.564Z,1463771542.564 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2016-05-20T19:12:22.747Z,1463771542.747 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/
2016-05-20T19:12:22.748Z,1463771542.748 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2016-05-20T19:12:22.754Z,1463771542.754 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2016-05-20T19:12:22.891Z,1463771542.891 [SBIT](DEBUG): Construct Startup Built In Test.
2016-05-20T19:12:22.924Z,1463771542.924 [SBIT] Loaded
2016-05-20T19:12:22.924Z,1463771542.924 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2016-05-20T19:12:22.925Z,1463771542.925 [IBIT](DEBUG): Construct Initiated Built In Test.
2016-05-20T19:12:22.955Z,1463771542.955 [IBIT] Loaded
2016-05-20T19:12:22.955Z,1463771542.955 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2016-05-20T19:12:22.957Z,1463771542.957 [CBIT](DEBUG): Construct Continuous Built In Test.
2016-05-20T19:12:23.105Z,1463771543.105 [CBIT] Loaded
2016-05-20T19:12:23.106Z,1463771543.106 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2016-05-20T19:12:23.106Z,1463771543.106 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2016-05-20T19:12:23.107Z,1463771543.107 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2016-05-20T19:12:23.159Z,1463771543.159 [VerticalControl](DEBUG): Construct VerticalControl.
2016-05-20T19:12:23.267Z,1463771543.267 [VerticalControl] Loaded
2016-05-20T19:12:23.267Z,1463771543.267 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2016-05-20T19:12:23.268Z,1463771543.268 [HorizontalControl](DEBUG): Construct HorizontalControl.
2016-05-20T19:12:23.334Z,1463771543.334 [HorizontalControl] Loaded
2016-05-20T19:12:23.334Z,1463771543.334 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2016-05-20T19:12:23.334Z,1463771543.334 [SpeedControl](DEBUG): Construct SpeedControl.
2016-05-20T19:12:23.341Z,1463771543.341 [SpeedControl] Loaded
2016-05-20T19:12:23.341Z,1463771543.341 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2016-05-20T19:12:23.341Z,1463771543.341 [LoopControl](DEBUG): Construct LoopControl.
2016-05-20T19:12:23.342Z,1463771543.342 [LoopControl] Loaded
2016-05-20T19:12:23.342Z,1463771543.342 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2016-05-20T19:12:23.343Z,1463771543.343 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2016-05-20T19:12:23.343Z,1463771543.343 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2016-05-20T19:12:23.368Z,1463771543.368 [DepthRateCalculator] Loaded
2016-05-20T19:12:23.368Z,1463771543.368 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2016-05-20T19:12:23.374Z,1463771543.374 [PitchRateCalculator] Loaded
2016-05-20T19:12:23.374Z,1463771543.374 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2016-05-20T19:12:23.385Z,1463771543.385 [SpeedCalculator] Loaded
2016-05-20T19:12:23.386Z,1463771543.386 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2016-05-20T19:12:23.403Z,1463771543.403 [TempGradientCalculator] Loaded
2016-05-20T19:12:23.403Z,1463771543.403 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2016-05-20T19:12:23.421Z,1463771543.421 [VerticalTemperatureHomogeneityIndexCalculator] Loaded
2016-05-20T19:12:23.422Z,1463771543.422 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread.
2016-05-20T19:12:23.427Z,1463771543.427 [YawRateCalculator] Loaded
2016-05-20T19:12:23.427Z,1463771543.427 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2016-05-20T19:12:23.428Z,1463771543.428 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2016-05-20T19:12:23.428Z,1463771543.428 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2016-05-20T19:12:23.510Z,1463771543.510 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC
2016-05-20T19:12:23.510Z,1463771543.510 [StratificationFrontDetector](DEBUG): (re)initializing
2016-05-20T19:12:23.510Z,1463771543.510 [StratificationFrontDetector] Loaded
2016-05-20T19:12:23.511Z,1463771543.511 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread.
2016-05-20T19:12:23.511Z,1463771543.511 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2016-05-20T19:12:23.512Z,1463771543.512 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2016-05-20T19:12:23.767Z,1463771543.767 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2016-05-20T19:12:23.768Z,1463771543.768 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2016-05-20T19:12:23.871Z,1463771543.871 [DeadReckonUsingMultipleVelocitySources] Loaded
2016-05-20T19:12:23.872Z,1463771543.872 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2016-05-20T19:12:23.931Z,1463771543.931 [DeadReckonUsingSpeedCalculator] Loaded
2016-05-20T19:12:23.931Z,1463771543.931 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2016-05-20T19:12:23.949Z,1463771543.949 [NavChart] Loaded
2016-05-20T19:12:23.949Z,1463771543.949 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2016-05-20T19:12:23.953Z,1463771543.953 [UniversalFixResidualReporter] Loaded
2016-05-20T19:12:23.953Z,1463771543.953 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2016-05-20T19:12:23.954Z,1463771543.954 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2016-05-20T19:12:23.954Z,1463771543.954 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2016-05-20T19:12:23.960Z,1463771543.960 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2016-05-20T19:12:23.961Z,1463771543.961 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2016-05-20T19:12:24.154Z,1463771544.154 [Aanderaa_O2] Loaded
2016-05-20T19:12:24.154Z,1463771544.154 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2016-05-20T19:12:24.235Z,1463771544.235 [CTD_NeilBrown] Loaded
2016-05-20T19:12:24.235Z,1463771544.235 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2016-05-20T19:12:24.236Z,1463771544.236 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 4059E4E0
2016-05-20T19:12:24.237Z,1463771544.237 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 1387
2016-05-20T19:12:24.253Z,1463771544.253 [PAR_Licor] Loaded
2016-05-20T19:12:24.253Z,1463771544.253 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2016-05-20T19:12:24.306Z,1463771544.306 [WetLabsBB2FL] Loaded
2016-05-20T19:12:24.306Z,1463771544.306 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2016-05-20T19:12:24.307Z,1463771544.307 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 405CE4E0
2016-05-20T19:12:24.307Z,1463771544.307 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1388
2016-05-20T19:12:24.308Z,1463771544.308 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2016-05-20T19:12:24.309Z,1463771544.309 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2016-05-20T19:12:25.375Z,1463771545.375 [AcousticModem_Benthos_ATM900] Loaded
2016-05-20T19:12:25.375Z,1463771545.375 [ComponentRegistry](DEBUG): SyncComponent "AcousticModem_Benthos_ATM900" handled in the control thread.
2016-05-20T19:12:25.477Z,1463771545.477 [DataOverHttps] Loaded
2016-05-20T19:12:25.477Z,1463771545.477 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2016-05-20T19:12:25.491Z,1463771545.491 [Depth_Keller] Loaded
2016-05-20T19:12:25.491Z,1463771545.491 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2016-05-20T19:12:25.497Z,1463771545.497 [DropWeight] Loaded
2016-05-20T19:12:25.497Z,1463771545.497 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2016-05-20T19:12:25.595Z,1463771545.595 [NAL9602] Loaded
2016-05-20T19:12:25.596Z,1463771545.596 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2016-05-20T19:12:25.640Z,1463771545.640 [Onboard] Loaded
2016-05-20T19:12:25.640Z,1463771545.640 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2016-05-20T19:12:25.648Z,1463771545.648 [Radio_Surface] Loaded
2016-05-20T19:12:25.648Z,1463771545.648 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2016-05-20T19:12:25.649Z,1463771545.649 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409E84E0
2016-05-20T19:12:25.650Z,1463771545.650 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1389
2016-05-20T19:12:25.878Z,1463771545.878 [PNI_TCM] Loaded
2016-05-20T19:12:25.878Z,1463771545.878 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread.
2016-05-20T19:12:26.216Z,1463771546.216 [Rowe_600LCM] Loaded
2016-05-20T19:12:26.216Z,1463771546.216 [ComponentRegistry](DEBUG): Component "Rowe_600LCM" handled in its own thread.
2016-05-20T19:12:26.218Z,1463771546.218 [Rowe_600LCM ThreadHandler](DEBUG): Created PCaller Thread at 40A184E0
2016-05-20T19:12:26.218Z,1463771546.218 [Rowe_600LCM ThreadHandler](INFO): Protected caller Thread ID is 1390
2016-05-20T19:12:28.216Z,1463771548.216 [BPC1] Loaded
2016-05-20T19:12:28.216Z,1463771548.216 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2016-05-20T19:12:28.217Z,1463771548.217 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2016-05-20T19:12:28.217Z,1463771548.217 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2016-05-20T19:12:28.324Z,1463771548.324 [BuoyancyServo] Loaded
2016-05-20T19:12:28.324Z,1463771548.324 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2016-05-20T19:12:28.337Z,1463771548.337 [ElevatorServo] Loaded
2016-05-20T19:12:28.337Z,1463771548.337 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2016-05-20T19:12:28.350Z,1463771548.350 [MassServo] Loaded
2016-05-20T19:12:28.350Z,1463771548.350 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2016-05-20T19:12:28.362Z,1463771548.362 [RudderServo] Loaded
2016-05-20T19:12:28.362Z,1463771548.362 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2016-05-20T19:12:28.374Z,1463771548.374 [ThrusterServo] Loaded
2016-05-20T19:12:28.374Z,1463771548.374 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2016-05-20T19:12:28.374Z,1463771548.374 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2016-05-20T19:12:28.375Z,1463771548.375 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2016-05-20T19:12:28.491Z,1463771548.491 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2016-05-20T19:12:28.491Z,1463771548.491 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2016-05-20T19:12:28.518Z,1463771548.518 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2016-05-20T19:12:28.522Z,1463771548.522 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2016-05-20T19:12:28.523Z,1463771548.523 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2016-05-20T19:12:28.530Z,1463771548.530 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2016-05-20T19:12:28.531Z,1463771548.531 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AC64E0
2016-05-20T19:12:28.532Z,1463771548.532 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1391
2016-05-20T19:12:28.538Z,1463771548.538 [Supervisor](INFO): Main Thread ID is 1303
2016-05-20T19:12:28.538Z,1463771548.538 [Supervisor](DEBUG): Running supervisor.
2016-05-20T19:12:28.538Z,1463771548.538 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1392
2016-05-20T19:12:28.542Z,1463771548.542 [controlThread ThreadHandler](INFO): Handler Thread ID is 1393
2016-05-20T19:12:28.542Z,1463771548.542 [controlThread](DEBUG): Initializing ControlThread
2016-05-20T19:12:28.543Z,1463771548.543 [SBIT](INFO): Initialize SBIT Component.
2016-05-20T19:12:28.544Z,1463771548.544 [SBIT](IMPORTANT): git: 2015-11-13-11-g036008f
2016-05-20T19:12:28.544Z,1463771548.544 [SBIT](INFO): git hash: 036008fb27dd1443c9c6898c567944386f491f02
2016-05-20T19:12:28.544Z,1463771548.544 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2016-05-20T19:12:28.544Z,1463771548.544 [SBIT](IMPORTANT): Kernel Version:#639 PREEMPT Wed Mar 12 12:53:33 PDT 2014
2016-05-20T19:12:28.565Z,1463771548.565 [SBIT](INFO): Beginning SBIT in 63.000000 seconds.
2016-05-20T19:12:28.565Z,1463771548.565 [IBIT](INFO): Initialize IBIT Component.
2016-05-20T19:12:28.566Z,1463771548.566 [CBIT](DEBUG): Initialize CBIT Component.
2016-05-20T19:12:28.566Z,1463771548.566 [CBIT](CRITICAL): LAST REBOOT DUE TO WATCHDOG TIMER RESET.
2016-05-20T19:12:28.567Z,1463771548.567 [logger ThreadHandler](INFO): Handler Thread ID is 1394
2016-05-20T19:12:28.593Z,1463771548.593 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2016-05-20T19:12:28.595Z,1463771548.595 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2016-05-20T19:12:28.595Z,1463771548.595 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2016-05-20T19:12:28.596Z,1463771548.596 [LoopControl](DEBUG): Initialize LoopControlComponent.
2016-05-20T19:12:28.596Z,1463771548.596 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2016-05-20T19:12:28.597Z,1463771548.597 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2016-05-20T19:12:28.598Z,1463771548.598 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2016-05-20T19:12:28.598Z,1463771548.598 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2016-05-20T19:12:28.599Z,1463771548.599 [VerticalTemperatureHomogeneityIndexCalculator](DEBUG): (re)initializing
2016-05-20T19:12:28.599Z,1463771548.599 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2016-05-20T19:12:28.600Z,1463771548.600 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-05-20T19:12:28.601Z,1463771548.601 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-05-20T19:12:28.601Z,1463771548.601 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-05-20T19:12:28.601Z,1463771548.601 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2016-05-20T19:12:28.602Z,1463771548.602 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2016-05-20T19:12:28.602Z,1463771548.602 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2016-05-20T19:12:28.603Z,1463771548.603 [NavChart](DEBUG): Initialize NavChart Navigation.
2016-05-20T19:12:28.603Z,1463771548.603 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2016-05-20T19:12:28.605Z,1463771548.605 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 1395
2016-05-20T19:12:28.606Z,1463771548.606 [CTD_NeilBrown](INFO): Powering down
2016-05-20T19:12:28.642Z,1463771548.642 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2016-05-20T19:12:28.649Z,1463771548.649 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1396
2016-05-20T19:12:28.651Z,1463771548.651 [WetLabsBB2FL](INFO): Powering down
2016-05-20T19:12:28.680Z,1463771548.680 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2016-05-20T19:12:28.685Z,1463771548.685 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1397
2016-05-20T19:12:28.691Z,1463771548.691 [Radio_Surface](INFO): Powering up
2016-05-20T19:12:28.697Z,1463771548.697 [Rowe_600LCM ThreadHandler](INFO): Handler Thread ID is 1398
2016-05-20T19:12:28.698Z,1463771548.698 [Rowe_600LCM](INFO): Initializing
2016-05-20T19:12:28.699Z,1463771548.699 [Rowe_600LCM](INFO): Checking LCM
2016-05-20T19:12:28.699Z,1463771548.699 [Rowe_600LCM](INFO): LCM OK
2016-05-20T19:12:28.699Z,1463771548.699 [Rowe_600LCM](INFO): Powering up
2016-05-20T19:12:28.715Z,1463771548.715 [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>


2016-05-20T19:12:28.715Z,1463771548.715 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2016-05-20T19:12:28.722Z,1463771548.722 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1399
2016-05-20T19:12:28.727Z,1463771548.727 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources/ElectronicNavigationCharts
2016-05-20T19:12:28.731Z,1463771548.731 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2016-05-20T19:12:28.731Z,1463771548.731 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2016-05-20T19:12:28.731Z,1463771548.731 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2016-05-20T19:12:28.731Z,1463771548.731 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2016-05-20T19:12:28.732Z,1463771548.732 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2016-05-20T19:12:28.732Z,1463771548.732 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2016-05-20T19:12:28.732Z,1463771548.732 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2016-05-20T19:12:28.732Z,1463771548.732 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2016-05-20T19:12:28.805Z,1463771548.805 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2016-05-20T19:12:28.806Z,1463771548.806 [Default:A.Wait](DEBUG): Construct Wait.
2016-05-20T19:12:28.808Z,1463771548.808 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2016-05-20T19:12:28.866Z,1463771548.866 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2016-05-20T19:12:28.869Z,1463771548.869 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2016-05-20T19:12:28.891Z,1463771548.891 [Default:E.Execute](DEBUG): Construct Execute.
2016-05-20T19:12:28.894Z,1463771548.894 [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>


2016-05-20T19:12:28.906Z,1463771548.906 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,PAR_Licor,AcousticModem_Benthos_ATM900,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,PNI_TCM,BPC1,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,VerticalTemperatureHomogeneityIndexCalculator,YawRateCalculator,StratificationFrontDetector,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2016-05-20T19:12:28.958Z,1463771548.958 [AcousticModem_Benthos_ATM900](INFO): Powering up
2016-05-20T19:12:28.958Z,1463771548.958 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2016-05-20T19:12:29.483Z,1463771549.483 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-20T19:12:29.630Z,1463771549.630 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-20T19:12:29.727Z,1463771549.727 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2016-05-20T19:12:29.735Z,1463771549.735 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2016-05-20T19:12:29.759Z,1463771549.759 [ElevatorServo](DEBUG): Initializing EZServoServo.
2016-05-20T19:12:29.763Z,1463771549.763 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2016-05-20T19:12:29.769Z,1463771549.769 [MassServo](DEBUG): Initializing EZServoServo.
2016-05-20T19:12:29.775Z,1463771549.775 [MassServo](DEBUG): Initializing MassServo.
2016-05-20T19:12:29.793Z,1463771549.793 [RudderServo](DEBUG): Initializing EZServoServo.
2016-05-20T19:12:29.799Z,1463771549.799 [RudderServo](DEBUG): Initializing RudderServo.
2016-05-20T19:12:29.811Z,1463771549.811 [ThrusterServo](DEBUG): Initializing EZServoServo.
2016-05-20T19:12:29.823Z,1463771549.823 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2016-05-20T19:12:29.867Z,1463771549.867 [CommandLine](FAULT): Scheduling is paused
2016-05-20T19:12:30.186Z,1463771550.186 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-20T19:12:30.192Z,1463771550.192 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-20T19:12:30.345Z,1463771550.345 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-20T19:12:30.346Z,1463771550.346 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-20T19:12:30.696Z,1463771550.696 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2016-05-20T19:12:30.697Z,1463771550.697 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2016-05-20T19:12:30.697Z,1463771550.697 [BuoyancyServo] Communications Fault, FailCount= 1
2016-05-20T19:12:30.697Z,1463771550.697 [BuoyancyServo](ERROR): Communications Fault
2016-05-20T19:12:30.894Z,1463771550.894 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2016-05-20T19:12:30.918Z,1463771550.918 [NAL9602](INFO): Powering up NAL9602
2016-05-20T19:12:30.976Z,1463771550.976 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-20T19:12:30.993Z,1463771550.993 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-20T19:12:30.999Z,1463771550.999 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2016-05-20T19:12:30.000Z,1463771551.000 [BuoyancyServo](INFO): Powering down
2016-05-20T19:12:31.373Z,1463771551.373 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-20T19:12:31.375Z,1463771551.375 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-20T19:12:31.737Z,1463771551.737 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-20T19:12:31.739Z,1463771551.739 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-20T19:12:32.222Z,1463771552.222 [Aanderaa_O2](INFO): Powering down
2016-05-20T19:12:32.517Z,1463771552.517 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-20T19:12:32.519Z,1463771552.519 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-20T19:12:32.708Z,1463771552.708 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-20T19:12:32.709Z,1463771552.709 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-20T19:12:32.974Z,1463771552.974 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2016-05-20T19:12:33.099Z,1463771553.099 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:./bin/roweadcp -dev /dev/ttyA1 -b 38400 >& adcplog.log &
2016-05-20T19:12:33.321Z,1463771553.321 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2016-05-20T19:12:33.321Z,1463771553.321 [BuoyancyServo] No Fault, FailCount= 1
2016-05-20T19:12:33.567Z,1463771553.567 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2016-05-20T19:12:33.568Z,1463771553.568 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2016-05-20T19:12:33.963Z,1463771553.963 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2016-05-20T19:12:33.964Z,1463771553.964 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2016-05-20T19:12:36.690Z,1463771556.690 [AcousticModem_Benthos_ATM900](DEBUG): 
2016-05-20T19:12:37.897Z,1463771557.897 [AcousticModem_Benthos_ATM900](DEBUG): Teledyne Benthos ATM-900 Series OEM w/burn wire
2016-05-20T19:12:37.898Z,1463771557.898 [AcousticModem_Benthos_ATM900](DEBUG): MF Frequency Band
2016-05-20T19:12:37.898Z,1463771557.898 [AcousticModem_Benthos_ATM900](DEBUG): Standard version 8.6.3
2016-05-20T19:12:38.299Z,1463771558.299 [AcousticModem_Benthos_ATM900](DEBUG): May 20 2016 19:03:52 
2016-05-20T19:12:39.112Z,1463771559.112 [AcousticModem_Benthos_ATM900](INFO): entering command mode
2016-05-20T19:12:39.496Z,1463771559.496 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2016-05-20T19:12:39.891Z,1463771559.891 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2016-05-20T19:12:39.892Z,1463771559.892 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt 1: user:1>
2016-05-20T19:12:39.892Z,1463771559.892 [AcousticModem_Benthos_ATM900](INFO): command mode acknowledged
2016-05-20T19:12:40.312Z,1463771560.312 [AcousticModem_Benthos_ATM900](INFO): setting local address to 3
2016-05-20T19:12:40.801Z,1463771560.801 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:12:40.808Z,1463771560.808 [AcousticModem_Benthos_ATM900](DEBUG): checking for local address setting acknowledgment
2016-05-20T19:12:40.810Z,1463771560.810 [AcousticModem_Benthos_ATM900](INFO): set local address to 3
2016-05-20T19:12:41.278Z,1463771561.278 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt 2: user:2>
2016-05-20T19:12:41.610Z,1463771561.611 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:12:42.083Z,1463771562.083 [NAL9602](INFO): NAL9602 initialized
2016-05-20T19:12:42.419Z,1463771562.419 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:12:43.240Z,1463771563.240 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:12:44.097Z,1463771564.097 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:12:44.906Z,1463771564.906 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:12:45.713Z,1463771565.713 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:12:46.521Z,1463771566.521 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:12:47.327Z,1463771567.327 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:12:48.184Z,1463771568.184 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:12:48.993Z,1463771568.993 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:12:49.799Z,1463771569.799 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:12:50.608Z,1463771570.608 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:12:51.416Z,1463771571.416 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:12:52.274Z,1463771572.274 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:12:53.083Z,1463771573.083 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:12:53.893Z,1463771573.893 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:12:54.702Z,1463771574.702 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:12:55.513Z,1463771575.513 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:12:56.320Z,1463771576.320 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:12:57.130Z,1463771577.130 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:12:57.987Z,1463771577.987 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:12:58.796Z,1463771578.796 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:12:59.367Z,1463771579.367 [BPC1](ERROR): Failed to receive battery data
2016-05-20T19:12:59.368Z,1463771579.368 [BPC1] Communications Fault, FailCount= 1
2016-05-20T19:12:59.368Z,1463771579.368 [BPC1](ERROR): Communications Fault
2016-05-20T19:12:59.450Z,1463771579.450 [CBIT](ERROR): Communications Fault in component: BPC1
2016-05-20T19:12:59.606Z,1463771579.606 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:00.418Z,1463771580.418 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:01.037Z,1463771581.037 [CBIT](INFO): Clearing failed state for component BPC1
2016-05-20T19:13:01.037Z,1463771581.037 [BPC1] No Fault, FailCount= 1
2016-05-20T19:13:01.228Z,1463771581.228 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:02.085Z,1463771582.085 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:02.894Z,1463771582.894 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:03.701Z,1463771583.701 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:04.557Z,1463771584.557 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:05.366Z,1463771585.366 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:06.172Z,1463771586.172 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:06.981Z,1463771586.981 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:07.791Z,1463771587.791 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:08.599Z,1463771588.599 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:09.406Z,1463771589.406 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:10.214Z,1463771590.214 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:11.023Z,1463771591.023 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:11.881Z,1463771591.881 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:12.689Z,1463771592.689 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:13.496Z,1463771593.496 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:14.306Z,1463771594.306 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:15.127Z,1463771595.127 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:15.991Z,1463771595.991 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:16.802Z,1463771596.802 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:17.610Z,1463771597.610 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:18.467Z,1463771598.467 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:19.275Z,1463771599.275 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:20.082Z,1463771600.082 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:20.914Z,1463771600.914 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:21.721Z,1463771601.721 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:22.529Z,1463771602.529 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:23.335Z,1463771603.335 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:24.193Z,1463771604.193 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:25.001Z,1463771605.001 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:25.807Z,1463771605.807 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:26.615Z,1463771606.615 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:27.421Z,1463771607.421 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:28.279Z,1463771608.279 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:29.144Z,1463771609.144 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:30.000Z,1463771610.000 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:30.809Z,1463771610.809 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:31.616Z,1463771611.616 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:32.278Z,1463771612.278 [SBIT](IMPORTANT): Beginning Startup BIT
2016-05-20T19:13:32.285Z,1463771612.285 [CBIT](IMPORTANT): Beginning GF scan
2016-05-20T19:13:32.472Z,1463771612.472 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:33.283Z,1463771613.283 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:34.092Z,1463771614.092 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:34.905Z,1463771614.905 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:35.710Z,1463771615.710 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:36.519Z,1463771616.519 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:37.325Z,1463771617.325 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:38.183Z,1463771618.183 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:38.990Z,1463771618.990 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:39.796Z,1463771619.796 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:40.605Z,1463771620.605 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:41.411Z,1463771621.411 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:42.246Z,1463771622.246 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:43.056Z,1463771623.056 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:43.930Z,1463771623.930 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:44.739Z,1463771624.739 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:45.545Z,1463771625.545 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:46.402Z,1463771626.402 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:47.211Z,1463771627.211 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:48.018Z,1463771628.018 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:48.826Z,1463771628.826 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:49.635Z,1463771629.635 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:50.444Z,1463771630.444 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:51.253Z,1463771631.253 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:52.111Z,1463771632.111 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:52.922Z,1463771632.922 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:53.730Z,1463771633.730 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:54.541Z,1463771634.541 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:55.357Z,1463771635.357 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:56.215Z,1463771636.215 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:57.023Z,1463771637.023 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:57.828Z,1463771637.828 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:58.637Z,1463771638.637 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:13:58.923Z,1463771638.923 [CBIT](IMPORTANT): No ground fault detected
2016-05-20T19:13:59.443Z,1463771639.443 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:00.299Z,1463771640.299 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:01.109Z,1463771641.109 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:01.916Z,1463771641.916 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:02.723Z,1463771642.723 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:03.533Z,1463771643.533 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:04.342Z,1463771644.342 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:05.152Z,1463771645.152 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:06.008Z,1463771646.008 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:06.817Z,1463771646.817 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:07.624Z,1463771647.624 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:08.432Z,1463771648.432 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:09.241Z,1463771649.241 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:10.099Z,1463771650.099 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:10.908Z,1463771650.908 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:11.714Z,1463771651.714 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:12.522Z,1463771652.522 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:13.329Z,1463771653.329 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:14.185Z,1463771654.185 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:14.995Z,1463771654.995 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:15.852Z,1463771655.852 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:16.710Z,1463771656.710 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:17.568Z,1463771657.568 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:18.376Z,1463771658.376 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:19.185Z,1463771659.185 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:20.042Z,1463771660.042 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:20.852Z,1463771660.852 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:21.658Z,1463771661.658 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:22.467Z,1463771662.467 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:23.276Z,1463771663.276 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:24.132Z,1463771664.132 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:24.941Z,1463771664.941 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:25.386Z,1463771665.386 [SBIT](IMPORTANT): SBIT PASSED
2016-05-20T19:14:25.748Z,1463771665.748 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:25.803Z,1463771665.803 [MissionManager](IMPORTANT): Started mission Startup
2016-05-20T19:14:25.803Z,1463771665.803 [Startup] Running Loop=1
2016-05-20T19:14:25.803Z,1463771665.803 [Startup](DEBUG): Aggregate::initialize Startup
2016-05-20T19:14:25.803Z,1463771665.803 [Startup:A.GoToSurface] Running Loop=1
2016-05-20T19:14:25.803Z,1463771665.803 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2016-05-20T19:14:25.804Z,1463771665.804 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2016-05-20T19:14:25.805Z,1463771665.805 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2016-05-20T19:14:25.805Z,1463771665.805 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2016-05-20T19:14:25.805Z,1463771665.805 [Startup:A.GoToSurface](DEBUG): No pitch timeout specified. Using default value of 20.000000 seconds.
2016-05-20T19:14:25.806Z,1463771665.806 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2016-05-20T19:14:25.820Z,1463771665.820 [Startup:StartupSatComms] Running Loop=1
2016-05-20T19:14:25.820Z,1463771665.820 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2016-05-20T19:14:25.820Z,1463771665.820 [Startup:StartupSatComms:A] Running Loop=1
2016-05-20T19:14:26.188Z,1463771666.188 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2016-05-20T19:14:26.565Z,1463771666.565 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:27.379Z,1463771667.379 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:28.235Z,1463771668.235 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:29.044Z,1463771669.044 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:29.850Z,1463771669.850 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:30.658Z,1463771670.658 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:31.475Z,1463771671.475 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:32.294Z,1463771672.294 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:33.108Z,1463771673.108 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:33.968Z,1463771673.968 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:34.777Z,1463771674.777 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:35.583Z,1463771675.583 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:36.392Z,1463771676.392 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:36.602Z,1463771676.602 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=false, 1
2016-05-20T19:14:36.604Z,1463771676.604 [DataOverHttps](DEBUG): ParseDataRead( data = busy=false, key = 6, value = makai
2016-05-20T19:14:36.605Z,1463771676.605 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 0, value = false
2016-05-20T19:14:36.614Z,1463771676.614 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.012118
2016-05-20T19:14:37.205Z,1463771677.205 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:38.062Z,1463771678.062 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:38.871Z,1463771678.871 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:39.677Z,1463771679.677 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:40.486Z,1463771680.486 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:41.295Z,1463771681.295 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:42.152Z,1463771682.152 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:42.963Z,1463771682.963 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:43.780Z,1463771683.780 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:44.638Z,1463771684.638 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:45.451Z,1463771685.451 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:46.258Z,1463771686.258 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:47.068Z,1463771687.068 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:47.926Z,1463771687.926 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:48.784Z,1463771688.784 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:49.644Z,1463771689.644 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:50.454Z,1463771690.454 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:51.274Z,1463771691.274 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:52.132Z,1463771692.132 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:52.941Z,1463771692.941 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:53.747Z,1463771693.747 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:54.561Z,1463771694.561 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:55.378Z,1463771695.378 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:56.234Z,1463771696.234 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:57.043Z,1463771697.043 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:57.850Z,1463771697.850 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:58.658Z,1463771698.658 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:14:59.467Z,1463771699.467 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:00.276Z,1463771700.276 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:01.086Z,1463771701.086 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:01.943Z,1463771701.943 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:02.753Z,1463771702.753 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:03.559Z,1463771703.559 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:04.366Z,1463771704.366 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:05.176Z,1463771705.176 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:06.033Z,1463771706.033 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:06.846Z,1463771706.846 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:07.653Z,1463771707.653 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:08.462Z,1463771708.462 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:09.278Z,1463771709.278 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:10.136Z,1463771710.136 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:10.947Z,1463771710.947 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:11.756Z,1463771711.756 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:12.613Z,1463771712.613 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:13.441Z,1463771713.441 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:14.250Z,1463771714.250 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:15.060Z,1463771715.060 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:15.866Z,1463771715.866 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:16.674Z,1463771716.674 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:17.481Z,1463771717.481 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:18.289Z,1463771718.289 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:19.104Z,1463771719.104 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:19.981Z,1463771719.981 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:20.788Z,1463771720.788 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:21.599Z,1463771721.599 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:22.406Z,1463771722.406 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:23.265Z,1463771723.265 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:24.121Z,1463771724.121 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:24.989Z,1463771724.989 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:25.826Z,1463771725.826 [Startup:StartupSatComms:A](INFO): Timed out from 2016-05-20T19:14:25.8Z
2016-05-20T19:15:25.827Z,1463771725.827 [Startup:StartupSatComms:A] Stopped
2016-05-20T19:15:25.827Z,1463771725.827 [Startup:StartupSatComms:B] Running Loop=1
2016-05-20T19:15:25.856Z,1463771725.856 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:26.225Z,1463771726.225 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2016-05-20T19:15:26.666Z,1463771726.666 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:27.475Z,1463771727.475 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:28.284Z,1463771728.284 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:29.094Z,1463771729.094 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:29.954Z,1463771729.954 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:30.770Z,1463771730.770 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:31.578Z,1463771731.578 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:32.387Z,1463771732.387 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:32.799Z,1463771732.799 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-20T19:15:32.799Z,1463771732.799 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2016-05-20T19:15:32.800Z,1463771732.800 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-05-20T19:15:32.805Z,1463771732.805 [DeadReckonUsingSpeedCalculator](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-20T19:15:32.815Z,1463771732.815 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2016-05-20T19:15:32.815Z,1463771732.815 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2016-05-20T19:15:32.856Z,1463771732.856 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-05-20T19:15:32.857Z,1463771732.857 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2016-05-20T19:15:32.929Z,1463771732.929 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20160519T224637/Courier0008.lzma
2016-05-20T19:15:33.198Z,1463771733.198 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:33.202Z,1463771733.202 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-05-20T19:15:33.202Z,1463771733.202 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2016-05-20T19:15:33.212Z,1463771733.212 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2016-05-20T19:15:33.212Z,1463771733.212 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2016-05-20T19:15:33.369Z,1463771733.369 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-05-20T19:15:33.370Z,1463771733.370 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-05-20T19:15:33.370Z,1463771733.370 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-05-20T19:15:33.370Z,1463771733.370 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2016-05-20T19:15:33.371Z,1463771733.371 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2016-05-20T19:15:33.375Z,1463771733.375 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2016-05-20T19:15:33.693Z,1463771733.693 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=true&momsn=4115135&filename=Logs%2F20160519T224637%2FCourier0008.lzma, 1
2016-05-20T19:15:33.693Z,1463771733.693 [DataOverHttps](DEBUG): ParseDataRead( data = busy=true&momsn=4115135&filename=Logs%2F20160519T224637%2FCourier0008.lzma, key = 6, value = makai
2016-05-20T19:15:33.694Z,1463771733.694 [DataOverHttps](DEBUG): ParseDataRead( data = momsn=4115135&filename=Logs%2F20160519T224637%2FCourier0008.lzma, key = 0, value = true
2016-05-20T19:15:33.694Z,1463771733.694 [DataOverHttps](DEBUG): ParseDataRead( data = filename=Logs%2F20160519T224637%2FCourier0008.lzma, key = 4, value = 4115135
2016-05-20T19:15:33.695Z,1463771733.695 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 2, value = Logs%2F20160519T224637%2FCourier0008.lzma
2016-05-20T19:15:33.696Z,1463771733.696 [DataOverHttps](INFO): Moved sent file to Logs/20160519T224637/Courier0008.lzma.bak
2016-05-20T19:15:33.696Z,1463771733.696 [DataOverHttps](INFO): SBD MOMSN=4115135
2016-05-20T19:15:33.778Z,1463771733.778 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.0 s old, using for 20.0 s.
2016-05-20T19:15:34.057Z,1463771734.057 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:34.146Z,1463771734.146 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.3 s old, using for 20.0 s.
2016-05-20T19:15:34.607Z,1463771734.607 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.8 s old, using for 20.0 s.
2016-05-20T19:15:34.866Z,1463771734.866 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:35.704Z,1463771735.704 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:36.514Z,1463771736.514 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:37.321Z,1463771737.321 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:38.179Z,1463771738.179 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:38.988Z,1463771738.988 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:39.608Z,1463771739.608 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.8 s old, using for 20.0 s.
2016-05-20T19:15:39.746Z,1463771739.746 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.9 s old, using for 20.0 s.
2016-05-20T19:15:39.795Z,1463771739.795 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:40.140Z,1463771740.140 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.3 s old, using for 20.0 s.
2016-05-20T19:15:40.481Z,1463771740.481 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=false, 1
2016-05-20T19:15:40.481Z,1463771740.481 [DataOverHttps](DEBUG): ParseDataRead( data = busy=false, key = 6, value = makai
2016-05-20T19:15:40.482Z,1463771740.482 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 0, value = false
2016-05-20T19:15:40.561Z,1463771740.561 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.8 s old, using for 20.0 s.
2016-05-20T19:15:40.650Z,1463771740.650 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:41.016Z,1463771741.016 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.2 s old, using for 20.0 s.
2016-05-20T19:15:41.429Z,1463771741.429 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.6 s old, using for 20.0 s.
2016-05-20T19:15:41.460Z,1463771741.460 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:42.269Z,1463771742.269 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:43.080Z,1463771743.080 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:43.940Z,1463771743.940 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:44.751Z,1463771744.751 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:45.555Z,1463771745.555 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:46.370Z,1463771746.370 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:47.181Z,1463771747.181 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:47.321Z,1463771747.321 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.5 s old, using for 20.0 s.
2016-05-20T19:15:47.398Z,1463771747.398 [DataOverHttps](INFO): Sending 99 bytes from file Logs/20160520T191217/Courier0000.lzma
2016-05-20T19:15:47.456Z,1463771747.456 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.7 s old, using for 20.0 s.
2016-05-20T19:15:47.799Z,1463771747.799 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.0 s old, using for 20.0 s.
2016-05-20T19:15:48.038Z,1463771748.038 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:48.145Z,1463771748.145 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=true&momsn=4115137&filename=Logs%2F20160520T191217%2FCourier0000.lzma, 1
2016-05-20T19:15:48.145Z,1463771748.145 [DataOverHttps](DEBUG): ParseDataRead( data = busy=true&momsn=4115137&filename=Logs%2F20160520T191217%2FCourier0000.lzma, key = 6, value = makai
2016-05-20T19:15:48.146Z,1463771748.146 [DataOverHttps](DEBUG): ParseDataRead( data = momsn=4115137&filename=Logs%2F20160520T191217%2FCourier0000.lzma, key = 0, value = true
2016-05-20T19:15:48.146Z,1463771748.146 [DataOverHttps](DEBUG): ParseDataRead( data = filename=Logs%2F20160520T191217%2FCourier0000.lzma, key = 4, value = 4115137
2016-05-20T19:15:48.147Z,1463771748.147 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 2, value = Logs%2F20160520T191217%2FCourier0000.lzma
2016-05-20T19:15:48.148Z,1463771748.148 [DataOverHttps](INFO): Moved sent file to Logs/20160520T191217/Courier0000.lzma.bak
2016-05-20T19:15:48.148Z,1463771748.148 [DataOverHttps](INFO): SBD MOMSN=4115137
2016-05-20T19:15:48.354Z,1463771748.354 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.6 s old, using for 20.0 s.
2016-05-20T19:15:48.714Z,1463771748.714 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.9 s old, using for 20.0 s.
2016-05-20T19:15:48.848Z,1463771748.848 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:49.194Z,1463771749.194 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.4 s old, using for 20.0 s.
2016-05-20T19:15:49.658Z,1463771749.658 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:50.471Z,1463771750.471 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:51.281Z,1463771751.281 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:52.137Z,1463771752.137 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:52.950Z,1463771752.950 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:53.756Z,1463771753.756 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:54.614Z,1463771754.614 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:54.669Z,1463771754.669 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=false, 1
2016-05-20T19:15:54.671Z,1463771754.671 [DataOverHttps](DEBUG): ParseDataRead( data = busy=false, key = 6, value = makai
2016-05-20T19:15:54.672Z,1463771754.672 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 0, value = false
2016-05-20T19:15:55.438Z,1463771755.438 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:56.248Z,1463771756.248 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:57.058Z,1463771757.058 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:57.867Z,1463771757.867 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:58.675Z,1463771758.675 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:15:59.481Z,1463771759.481 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:00.295Z,1463771760.295 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:01.110Z,1463771761.110 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:01.968Z,1463771761.968 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:02.003Z,1463771762.003 [DataOverHttps](INFO): Sending 200 bytes from file Logs/20160519T224637/Express0009.lzma
2016-05-20T19:16:02.772Z,1463771762.772 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=true&momsn=4115141&filename=Logs%2F20160519T224637%2FExpress0009.lzma, 1
2016-05-20T19:16:02.778Z,1463771762.778 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:02.782Z,1463771762.782 [DataOverHttps](DEBUG): ParseDataRead( data = busy=true&momsn=4115141&filename=Logs%2F20160519T224637%2FExpress0009.lzma, key = 6, value = makai
2016-05-20T19:16:02.783Z,1463771762.783 [DataOverHttps](DEBUG): ParseDataRead( data = momsn=4115141&filename=Logs%2F20160519T224637%2FExpress0009.lzma, key = 0, value = true
2016-05-20T19:16:02.784Z,1463771762.784 [DataOverHttps](DEBUG): ParseDataRead( data = filename=Logs%2F20160519T224637%2FExpress0009.lzma, key = 4, value = 4115141
2016-05-20T19:16:02.786Z,1463771762.786 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 2, value = Logs%2F20160519T224637%2FExpress0009.lzma
2016-05-20T19:16:02.787Z,1463771762.787 [DataOverHttps](INFO): Moved sent file to Logs/20160519T224637/Express0009.lzma.bak
2016-05-20T19:16:02.788Z,1463771762.788 [DataOverHttps](INFO): SBD MOMSN=4115141
2016-05-20T19:16:03.584Z,1463771763.584 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:04.392Z,1463771764.392 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:05.201Z,1463771765.201 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:06.058Z,1463771766.058 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:06.867Z,1463771766.867 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:07.676Z,1463771767.676 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:08.534Z,1463771768.534 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:09.326Z,1463771769.326 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=false, 1
2016-05-20T19:16:09.328Z,1463771769.328 [DataOverHttps](DEBUG): ParseDataRead( data = busy=false, key = 6, value = makai
2016-05-20T19:16:09.329Z,1463771769.329 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 0, value = false
2016-05-20T19:16:09.345Z,1463771769.345 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:10.150Z,1463771770.150 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:10.968Z,1463771770.968 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:11.776Z,1463771771.776 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:12.586Z,1463771772.586 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:13.395Z,1463771773.395 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:14.245Z,1463771774.245 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:15.056Z,1463771775.056 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:15.679Z,1463771775.679 [DataOverHttps](INFO): Sending 1106 bytes from file Logs/20160520T191217/Express0001.lzma
2016-05-20T19:16:15.914Z,1463771775.914 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:16.445Z,1463771776.445 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=true&momsn=4115147&filename=Logs%2F20160520T191217%2FExpress0001.lzma, 1
2016-05-20T19:16:16.447Z,1463771776.447 [DataOverHttps](DEBUG): ParseDataRead( data = busy=true&momsn=4115147&filename=Logs%2F20160520T191217%2FExpress0001.lzma, key = 6, value = makai
2016-05-20T19:16:16.448Z,1463771776.448 [DataOverHttps](DEBUG): ParseDataRead( data = momsn=4115147&filename=Logs%2F20160520T191217%2FExpress0001.lzma, key = 0, value = true
2016-05-20T19:16:16.450Z,1463771776.450 [DataOverHttps](DEBUG): ParseDataRead( data = filename=Logs%2F20160520T191217%2FExpress0001.lzma, key = 4, value = 4115147
2016-05-20T19:16:16.451Z,1463771776.451 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 2, value = Logs%2F20160520T191217%2FExpress0001.lzma
2016-05-20T19:16:16.453Z,1463771776.453 [DataOverHttps](INFO): Moved sent file to Logs/20160520T191217/Express0001.lzma.bak
2016-05-20T19:16:16.453Z,1463771776.453 [DataOverHttps](INFO): SBD MOMSN=4115147
2016-05-20T19:16:16.724Z,1463771776.724 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:17.232Z,1463771777.232 [Startup:StartupSatComms:B] Stopped
2016-05-20T19:16:17.232Z,1463771777.232 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2016-05-20T19:16:17.232Z,1463771777.232 [Startup:StartupSatComms] Stopped
2016-05-20T19:16:17.233Z,1463771777.233 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2016-05-20T19:16:17.235Z,1463771777.235 [Startup](INFO): Completed Startup
2016-05-20T19:16:17.235Z,1463771777.235 [Startup] Stopped
2016-05-20T19:16:17.244Z,1463771777.244 [Startup](DEBUG): Aggregate::uninitialize Startup
2016-05-20T19:16:17.244Z,1463771777.244 [Startup:A.GoToSurface] Stopped
2016-05-20T19:16:17.244Z,1463771777.244 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2016-05-20T19:16:17.375Z,1463771777.375 [MissionManager](IMPORTANT): Started mission Default
2016-05-20T19:16:17.376Z,1463771777.376 [Default] Running Loop=1
2016-05-20T19:16:17.376Z,1463771777.376 [Default](DEBUG): Aggregate::initialize Default
2016-05-20T19:16:17.376Z,1463771777.376 [Default:B.GoToSurface] Running Loop=1
2016-05-20T19:16:17.376Z,1463771777.376 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2016-05-20T19:16:17.376Z,1463771777.376 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2016-05-20T19:16:17.377Z,1463771777.377 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2016-05-20T19:16:17.377Z,1463771777.377 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2016-05-20T19:16:17.377Z,1463771777.377 [Default:B.GoToSurface](DEBUG): No pitch timeout specified. Using default value of 20.000000 seconds.
2016-05-20T19:16:17.378Z,1463771777.378 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2016-05-20T19:16:17.378Z,1463771777.378 [Default:A.Wait] Running Loop=1
2016-05-20T19:16:17.378Z,1463771777.378 [Default:A.Wait](DEBUG): Initialize Wait Component.
2016-05-20T19:16:17.533Z,1463771777.533 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:18.341Z,1463771778.341 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:19.151Z,1463771779.151 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:20.008Z,1463771780.008 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:20.826Z,1463771780.826 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:21.634Z,1463771781.634 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:22.492Z,1463771782.492 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:23.115Z,1463771783.115 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=false, 1
2016-05-20T19:16:23.118Z,1463771783.118 [DataOverHttps](DEBUG): ParseDataRead( data = busy=false, key = 6, value = makai
2016-05-20T19:16:23.119Z,1463771783.119 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 0, value = false
2016-05-20T19:16:23.301Z,1463771783.301 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:24.107Z,1463771784.107 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:24.915Z,1463771784.915 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:25.722Z,1463771785.722 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:26.530Z,1463771786.530 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:27.336Z,1463771787.336 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:28.194Z,1463771788.194 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:29.003Z,1463771789.003 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:29.812Z,1463771789.812 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:30.442Z,1463771790.442 [Default:A.Wait](INFO): Done Waiting.
2016-05-20T19:16:30.443Z,1463771790.443 [Default:A.Wait] Stopped
2016-05-20T19:16:30.443Z,1463771790.443 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2016-05-20T19:16:30.621Z,1463771790.621 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:30.854Z,1463771790.854 [Default:CheckIn] Running Loop=1
2016-05-20T19:16:30.854Z,1463771790.854 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2016-05-20T19:16:30.854Z,1463771790.854 [Default:CheckIn:Read_GPS] Running Loop=1
2016-05-20T19:16:31.236Z,1463771791.236 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2016-05-20T19:16:31.427Z,1463771791.427 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:32.281Z,1463771792.281 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:33.110Z,1463771793.110 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:33.970Z,1463771793.970 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:34.779Z,1463771794.779 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:35.588Z,1463771795.588 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:36.445Z,1463771796.445 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:37.130Z,1463771797.130 [CommandLine](IMPORTANT): got command quit
2016-05-20T19:16:37.259Z,1463771797.259 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:38.065Z,1463771798.065 [Rowe_600LCM](IMPORTANT): Valid WT Data.
X:88.888000
Y:88.888000
Z:88.888000
2016-05-20T19:16:38.167Z,1463771798.167 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2016-05-20T19:16:38.167Z,1463771798.167 [CommandLine ThreadHandler](INFO): Thread cancelled.
2016-05-20T19:16:38.296Z,1463771798.296 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2016-05-20T19:16:38.296Z,1463771798.296 [CommandLine ThreadHandler](INFO): Thread cancelled.
2016-05-20T19:16:38.298Z,1463771798.298 [CommandLine](INFO): Join timeout helper Thread ID is 1447
2016-05-20T19:16:38.310Z,1463771798.310 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2016-05-20T19:16:38.310Z,1463771798.310 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2016-05-20T19:16:38.324Z,1463771798.324 [NavChartDb](INFO): Join timeout helper Thread ID is 1448
2016-05-20T19:16:38.561Z,1463771798.561 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2016-05-20T19:16:38.562Z,1463771798.562 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2016-05-20T19:16:38.569Z,1463771798.569 [ComponentRegistry](INFO): Shutting down Rowe_600LCM ThreadHandler
2016-05-20T19:16:38.569Z,1463771798.569 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled.
2016-05-20T19:16:38.570Z,1463771798.570 [Rowe_600LCM](INFO): Join timeout helper Thread ID is 1449
2016-05-20T19:16:38.870Z,1463771798.870 [Rowe_600LCM ThreadHandler](INFO): Uninitializing protected caller thread.
2016-05-20T19:16:38.870Z,1463771798.870 [Rowe_600LCM](INFO): Powering down
2016-05-20T19:16:38.872Z,1463771798.872 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled.
2016-05-20T19:16:38.885Z,1463771798.885 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2016-05-20T19:16:38.886Z,1463771798.886 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2016-05-20T19:16:38.887Z,1463771798.887 [Radio_Surface](INFO): Join timeout helper Thread ID is 1450
2016-05-20T19:16:38.906Z,1463771798.906 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2016-05-20T19:16:38.906Z,1463771798.906 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2016-05-20T19:16:38.918Z,1463771798.918 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2016-05-20T19:16:38.918Z,1463771798.918 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2016-05-20T19:16:38.919Z,1463771798.919 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1451
2016-05-20T19:16:39.041Z,1463771799.041 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2016-05-20T19:16:39.041Z,1463771799.041 [WetLabsBB2FL](INFO): Powering down
2016-05-20T19:16:39.042Z,1463771799.042 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2016-05-20T19:16:39.050Z,1463771799.050 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2016-05-20T19:16:39.050Z,1463771799.050 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2016-05-20T19:16:39.050Z,1463771799.050 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 1452
2016-05-20T19:16:39.354Z,1463771799.354 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2016-05-20T19:16:39.354Z,1463771799.354 [CTD_NeilBrown](INFO): Powering down
2016-05-20T19:16:39.355Z,1463771799.355 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2016-05-20T19:16:39.370Z,1463771799.370 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2016-05-20T19:16:39.370Z,1463771799.370 [logger ThreadHandler](INFO): Thread cancelled.
2016-05-20T19:16:39.371Z,1463771799.371 [logger](INFO): Join timeout helper Thread ID is 1453
2016-05-20T19:16:39.386Z,1463771799.386 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2016-05-20T19:16:39.386Z,1463771799.386 [logger ThreadHandler](INFO): Thread cancelled.
2016-05-20T19:16:39.390Z,1463771799.390 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2016-05-20T19:16:39.390Z,1463771799.390 [CommandLine ThreadHandler](INFO): Thread cancelled.
2016-05-20T19:16:39.391Z,1463771799.391 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2016-05-20T19:16:39.391Z,1463771799.391 [controlThread ThreadHandler](INFO): Thread cancelled.
2016-05-20T19:16:39.391Z,1463771799.391 [controlThread](INFO): Join timeout helper Thread ID is 1454
2016-05-20T19:16:39.495Z,1463771799.495 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2016-05-20T19:16:39.495Z,1463771799.495 [controlThread](DEBUG): Uninitializing ControlThread
2016-05-20T19:16:39.496Z,1463771799.496 [Aanderaa_O2](INFO): Powering down
2016-05-20T19:16:39.497Z,1463771799.497 [AcousticModem_Benthos_ATM900](INFO): Powering down
2016-05-20T19:16:39.499Z,1463771799.499 [NAL9602](INFO): Powering down
2016-05-20T19:16:39.500Z,1463771799.500 [PNI_TCM](INFO): Powering down
2016-05-20T19:16:39.501Z,1463771799.501 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2016-05-20T19:16:39.502Z,1463771799.502 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2016-05-20T19:16:39.502Z,1463771799.502 [Default] Stopped
2016-05-20T19:16:39.502Z,1463771799.502 [Default](DEBUG): Aggregate::uninitialize Default
2016-05-20T19:16:39.502Z,1463771799.502 [Default:B.GoToSurface] Stopped
2016-05-20T19:16:39.503Z,1463771799.503 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2016-05-20T19:16:39.503Z,1463771799.503 [Default:CheckIn] Stopped
2016-05-20T19:16:39.503Z,1463771799.503 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2016-05-20T19:16:39.503Z,1463771799.503 [Default:CheckIn:Read_GPS] Stopped
2016-05-20T19:16:39.505Z,1463771799.505 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2016-05-20T19:16:39.505Z,1463771799.505 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2016-05-20T19:16:39.506Z,1463771799.506 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2016-05-20T19:16:39.506Z,1463771799.506 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2016-05-20T19:16:39.506Z,1463771799.506 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2016-05-20T19:16:39.506Z,1463771799.506 [BuoyancyServo](INFO): Powering down
2016-05-20T19:16:39.518Z,1463771799.518 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2016-05-20T19:16:39.518Z,1463771799.518 [ElevatorServo](INFO): Powering down
2016-05-20T19:16:39.519Z,1463771799.519 [MassServo](DEBUG): Uninitialize Mass Servo.
2016-05-20T19:16:39.519Z,1463771799.519 [MassServo](INFO): Powering down
2016-05-20T19:16:39.519Z,1463771799.519 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2016-05-20T19:16:39.519Z,1463771799.519 [RudderServo](INFO): Powering down
2016-05-20T19:16:39.520Z,1463771799.520 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2016-05-20T19:16:39.520Z,1463771799.520 [ThrusterServo](INFO): Powering down
2016-05-20T19:16:39.521Z,1463771799.521 [SBIT](DEBUG): Uninitialize SBIT Component.
2016-05-20T19:16:39.521Z,1463771799.521 [IBIT](DEBUG): Uninitialize IBIT Component.
2016-05-20T19:16:39.522Z,1463771799.522 [CBIT](DEBUG): Uninitialize CBIT Component.
2016-05-20T19:16:39.554Z,1463771799.554 [controlThread ThreadHandler](INFO): Thread cancelled.
2016-05-20T19:16:39.616Z,1463771799.616 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2016-05-20T19:16:39.620Z,1463771799.620 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2016-05-20T19:16:39.682Z,1463771799.682 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled.
2016-05-20T19:16:39.709Z,1463771799.709 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2016-05-20T19:16:39.760Z,1463771799.760 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2016-05-20T19:16:39.810Z,1463771799.810 [logger ThreadHandler](INFO): Thread cancelled.