2016-05-18T19:24:37.237Z,1463599477.237 [Supervisor](DEBUG): Initializing supervisor. 2016-05-18T19:24:37.240Z,1463599477.240 [SyncHandler](DEBUG): Created PCaller Thread at 4034C4E0 2016-05-18T19:24:37.241Z,1463599477.241 [SyncHandler](INFO): Protected caller Thread ID is 1052 2016-05-18T19:24:37.242Z,1463599477.242 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2016-05-18T19:24:37.243Z,1463599477.243 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4037C4E0 2016-05-18T19:24:37.244Z,1463599477.244 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1053 2016-05-18T19:24:37.247Z,1463599477.247 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2016-05-18T19:24:37.259Z,1463599477.259 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2016-05-18T19:24:37.260Z,1463599477.260 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 403AC4E0 2016-05-18T19:24:37.260Z,1463599477.260 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1054 2016-05-18T19:24:37.261Z,1463599477.261 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2016-05-18T19:24:37.262Z,1463599477.262 [logger ThreadHandler](DEBUG): Created PCaller Thread at 403DC4E0 2016-05-18T19:24:37.262Z,1463599477.262 [logger ThreadHandler](INFO): Protected caller Thread ID is 1055 2016-05-18T19:24:37.264Z,1463599477.264 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2016-05-18T19:24:37.265Z,1463599477.265 [Supervisor](INFO): Looking for Config files in directory: Config/ 2016-05-18T19:24:37.266Z,1463599477.266 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2016-05-18T19:24:37.601Z,1463599477.601 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2016-05-18T19:24:37.601Z,1463599477.601 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2016-05-18T19:24:37.765Z,1463599477.765 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2016-05-18T19:24:37.765Z,1463599477.765 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2016-05-18T19:24:37.889Z,1463599477.889 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2016-05-18T19:24:37.890Z,1463599477.890 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2016-05-18T19:24:38.019Z,1463599478.019 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2016-05-18T19:24:38.020Z,1463599478.020 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2016-05-18T19:24:38.105Z,1463599478.105 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2016-05-18T19:24:38.298Z,1463599478.298 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2016-05-18T19:24:38.299Z,1463599478.299 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2016-05-18T19:24:38.384Z,1463599478.384 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2016-05-18T19:24:38.385Z,1463599478.385 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2016-05-18T19:24:38.653Z,1463599478.653 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2016-05-18T19:24:38.654Z,1463599478.654 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2016-05-18T19:24:38.989Z,1463599478.989 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2016-05-18T19:24:38.989Z,1463599478.989 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2016-05-18T19:24:39.285Z,1463599479.285 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2016-05-18T19:24:39.286Z,1463599479.286 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2016-05-18T19:24:39.777Z,1463599479.777 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2016-05-18T19:24:39.778Z,1463599479.778 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2016-05-18T19:24:39.974Z,1463599479.974 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2016-05-18T19:24:39.975Z,1463599479.975 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2016-05-18T19:24:40.079Z,1463599480.079 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2016-05-18T19:24:40.079Z,1463599480.079 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2016-05-18T19:24:40.507Z,1463599480.507 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2016-05-18T19:24:40.507Z,1463599480.507 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2016-05-18T19:24:40.620Z,1463599480.620 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2016-05-18T19:24:40.621Z,1463599480.621 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/ 2016-05-18T19:24:40.622Z,1463599480.622 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg 2016-05-18T19:24:40.890Z,1463599480.890 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2016-05-18T19:24:40.891Z,1463599480.891 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg 2016-05-18T19:24:41.005Z,1463599481.005 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg 2016-05-18T19:24:41.101Z,1463599481.101 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg 2016-05-18T19:24:41.197Z,1463599481.197 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg 2016-05-18T19:24:41.285Z,1463599481.285 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg 2016-05-18T19:24:41.429Z,1463599481.429 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg 2016-05-18T19:24:41.586Z,1463599481.586 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg 2016-05-18T19:24:41.687Z,1463599481.687 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg 2016-05-18T19:24:41.769Z,1463599481.769 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg 2016-05-18T19:24:41.858Z,1463599481.858 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg 2016-05-18T19:24:42.032Z,1463599482.032 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/ 2016-05-18T19:24:42.033Z,1463599482.033 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2016-05-18T19:24:42.037Z,1463599482.037 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2016-05-18T19:24:42.151Z,1463599482.151 [SBIT](DEBUG): Construct Startup Built In Test. 2016-05-18T19:24:42.181Z,1463599482.181 [SBIT] Loaded 2016-05-18T19:24:42.181Z,1463599482.181 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2016-05-18T19:24:42.182Z,1463599482.182 [IBIT](DEBUG): Construct Initiated Built In Test. 2016-05-18T19:24:42.210Z,1463599482.210 [IBIT] Loaded 2016-05-18T19:24:42.210Z,1463599482.210 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2016-05-18T19:24:42.212Z,1463599482.212 [CBIT](DEBUG): Construct Continuous Built In Test. 2016-05-18T19:24:42.352Z,1463599482.352 [CBIT] Loaded 2016-05-18T19:24:42.352Z,1463599482.352 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2016-05-18T19:24:42.353Z,1463599482.353 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2016-05-18T19:24:42.353Z,1463599482.353 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2016-05-18T19:24:42.399Z,1463599482.399 [VerticalControl](DEBUG): Construct VerticalControl. 2016-05-18T19:24:42.499Z,1463599482.499 [VerticalControl] Loaded 2016-05-18T19:24:42.499Z,1463599482.499 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2016-05-18T19:24:42.500Z,1463599482.500 [HorizontalControl](DEBUG): Construct HorizontalControl. 2016-05-18T19:24:42.562Z,1463599482.562 [HorizontalControl] Loaded 2016-05-18T19:24:42.563Z,1463599482.563 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2016-05-18T19:24:42.563Z,1463599482.563 [SpeedControl](DEBUG): Construct SpeedControl. 2016-05-18T19:24:42.569Z,1463599482.569 [SpeedControl] Loaded 2016-05-18T19:24:42.569Z,1463599482.569 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2016-05-18T19:24:42.570Z,1463599482.570 [LoopControl](DEBUG): Construct LoopControl. 2016-05-18T19:24:42.570Z,1463599482.570 [LoopControl] Loaded 2016-05-18T19:24:42.570Z,1463599482.570 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2016-05-18T19:24:42.571Z,1463599482.571 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2016-05-18T19:24:42.571Z,1463599482.571 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2016-05-18T19:24:42.593Z,1463599482.593 [DepthRateCalculator] Loaded 2016-05-18T19:24:42.593Z,1463599482.593 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2016-05-18T19:24:42.599Z,1463599482.599 [PitchRateCalculator] Loaded 2016-05-18T19:24:42.599Z,1463599482.599 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2016-05-18T19:24:42.610Z,1463599482.610 [SpeedCalculator] Loaded 2016-05-18T19:24:42.610Z,1463599482.610 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2016-05-18T19:24:42.626Z,1463599482.626 [TempGradientCalculator] Loaded 2016-05-18T19:24:42.626Z,1463599482.626 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2016-05-18T19:24:42.643Z,1463599482.643 [VerticalTemperatureHomogeneityIndexCalculator] Loaded 2016-05-18T19:24:42.643Z,1463599482.643 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread. 2016-05-18T19:24:42.648Z,1463599482.648 [YawRateCalculator] Loaded 2016-05-18T19:24:42.648Z,1463599482.648 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2016-05-18T19:24:42.649Z,1463599482.649 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2016-05-18T19:24:42.649Z,1463599482.649 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2016-05-18T19:24:42.720Z,1463599482.720 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC 2016-05-18T19:24:42.720Z,1463599482.720 [StratificationFrontDetector](DEBUG): (re)initializing 2016-05-18T19:24:42.721Z,1463599482.721 [StratificationFrontDetector] Loaded 2016-05-18T19:24:42.721Z,1463599482.721 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread. 2016-05-18T19:24:42.721Z,1463599482.721 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2016-05-18T19:24:42.722Z,1463599482.722 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2016-05-18T19:24:42.932Z,1463599482.932 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2016-05-18T19:24:42.932Z,1463599482.932 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2016-05-18T19:24:43.027Z,1463599483.027 [DeadReckonUsingMultipleVelocitySources] Loaded 2016-05-18T19:24:43.027Z,1463599483.027 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2016-05-18T19:24:43.082Z,1463599483.082 [DeadReckonUsingSpeedCalculator] Loaded 2016-05-18T19:24:43.082Z,1463599483.082 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2016-05-18T19:24:43.099Z,1463599483.099 [NavChart] Loaded 2016-05-18T19:24:43.099Z,1463599483.099 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2016-05-18T19:24:43.103Z,1463599483.103 [UniversalFixResidualReporter] Loaded 2016-05-18T19:24:43.104Z,1463599483.104 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2016-05-18T19:24:43.104Z,1463599483.104 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2016-05-18T19:24:43.105Z,1463599483.105 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2016-05-18T19:24:43.110Z,1463599483.110 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2016-05-18T19:24:43.111Z,1463599483.111 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2016-05-18T19:24:43.286Z,1463599483.286 [Aanderaa_O2] Loaded 2016-05-18T19:24:43.286Z,1463599483.286 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread. 2016-05-18T19:24:43.362Z,1463599483.362 [CTD_NeilBrown] Loaded 2016-05-18T19:24:43.362Z,1463599483.362 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread. 2016-05-18T19:24:43.363Z,1463599483.363 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 4059E4E0 2016-05-18T19:24:43.364Z,1463599483.364 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 1134 2016-05-18T19:24:43.366Z,1463599483.366 [ESPComponent](CRITICAL): No configuration setting for: ESPComponent.espSimulator 2016-05-18T19:24:43.373Z,1463599483.373 [ESPComponent](CRITICAL): No configuration setting for: ESPComponent.stopCompleteTimeout 2016-05-18T19:24:43.384Z,1463599483.384 [ESPComponent] Loaded 2016-05-18T19:24:43.384Z,1463599483.384 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2016-05-18T19:24:43.398Z,1463599483.398 [PAR_Licor] Loaded 2016-05-18T19:24:43.399Z,1463599483.399 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2016-05-18T19:24:43.448Z,1463599483.448 [WetLabsBB2FL] Loaded 2016-05-18T19:24:43.448Z,1463599483.448 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2016-05-18T19:24:43.449Z,1463599483.449 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 405CE4E0 2016-05-18T19:24:43.450Z,1463599483.450 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1135 2016-05-18T19:24:43.450Z,1463599483.450 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2016-05-18T19:24:43.451Z,1463599483.451 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2016-05-18T19:24:43.694Z,1463599483.694 [AcousticModem_Benthos_ATM900] Loaded 2016-05-18T19:24:43.695Z,1463599483.695 [ComponentRegistry](DEBUG): SyncComponent "AcousticModem_Benthos_ATM900" handled in the control thread. 2016-05-18T19:24:43.767Z,1463599483.767 [DataOverHttps] Loaded 2016-05-18T19:24:43.768Z,1463599483.768 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread. 2016-05-18T19:24:43.781Z,1463599483.781 [Depth_Keller] Loaded 2016-05-18T19:24:43.781Z,1463599483.781 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2016-05-18T19:24:43.786Z,1463599483.786 [DropWeight] Loaded 2016-05-18T19:24:43.786Z,1463599483.786 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2016-05-18T19:24:43.878Z,1463599483.878 [NAL9602] Loaded 2016-05-18T19:24:43.878Z,1463599483.878 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2016-05-18T19:24:43.919Z,1463599483.919 [Onboard] Loaded 2016-05-18T19:24:43.920Z,1463599483.920 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2016-05-18T19:24:43.927Z,1463599483.927 [Radio_Surface] Loaded 2016-05-18T19:24:43.927Z,1463599483.927 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2016-05-18T19:24:43.928Z,1463599483.928 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409E64E0 2016-05-18T19:24:43.928Z,1463599483.928 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1136 2016-05-18T19:24:43.976Z,1463599483.976 [PNI_TCM] Loaded 2016-05-18T19:24:43.976Z,1463599483.976 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread. 2016-05-18T19:24:44.061Z,1463599484.061 [Rowe_600LCM] Loaded 2016-05-18T19:24:44.061Z,1463599484.061 [ComponentRegistry](DEBUG): Component "Rowe_600LCM" handled in its own thread. 2016-05-18T19:24:44.063Z,1463599484.063 [Rowe_600LCM ThreadHandler](DEBUG): Created PCaller Thread at 40A164E0 2016-05-18T19:24:44.063Z,1463599484.063 [Rowe_600LCM ThreadHandler](INFO): Protected caller Thread ID is 1137 2016-05-18T19:24:45.865Z,1463599485.865 [BPC1] Loaded 2016-05-18T19:24:45.866Z,1463599485.866 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2016-05-18T19:24:45.866Z,1463599485.866 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2016-05-18T19:24:45.867Z,1463599485.867 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2016-05-18T19:24:45.977Z,1463599485.977 [BuoyancyServo] Loaded 2016-05-18T19:24:45.977Z,1463599485.977 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2016-05-18T19:24:45.990Z,1463599485.990 [ElevatorServo] Loaded 2016-05-18T19:24:45.990Z,1463599485.990 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2016-05-18T19:24:46.001Z,1463599486.001 [MassServo] Loaded 2016-05-18T19:24:46.002Z,1463599486.002 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2016-05-18T19:24:46.013Z,1463599486.013 [RudderServo] Loaded 2016-05-18T19:24:46.013Z,1463599486.013 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2016-05-18T19:24:46.025Z,1463599486.025 [ThrusterServo] Loaded 2016-05-18T19:24:46.025Z,1463599486.025 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2016-05-18T19:24:46.025Z,1463599486.025 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2016-05-18T19:24:46.026Z,1463599486.026 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2016-05-18T19:24:46.122Z,1463599486.122 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2016-05-18T19:24:46.122Z,1463599486.122 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2016-05-18T19:24:46.145Z,1463599486.145 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2016-05-18T19:24:46.149Z,1463599486.149 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2016-05-18T19:24:46.150Z,1463599486.150 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2016-05-18T19:24:46.156Z,1463599486.156 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2016-05-18T19:24:46.158Z,1463599486.158 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AC44E0 2016-05-18T19:24:46.158Z,1463599486.158 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1138 2016-05-18T19:24:46.163Z,1463599486.163 [Supervisor](INFO): Main Thread ID is 912 2016-05-18T19:24:46.163Z,1463599486.163 [Supervisor](DEBUG): Running supervisor. 2016-05-18T19:24:46.163Z,1463599486.163 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1139 2016-05-18T19:24:46.166Z,1463599486.166 [controlThread ThreadHandler](INFO): Handler Thread ID is 1140 2016-05-18T19:24:46.167Z,1463599486.167 [controlThread](DEBUG): Initializing ControlThread 2016-05-18T19:24:46.168Z,1463599486.168 [SBIT](INFO): Initialize SBIT Component. 2016-05-18T19:24:46.168Z,1463599486.168 [SBIT](IMPORTANT): git: 2015-11-13-11-g036008f 2016-05-18T19:24:46.168Z,1463599486.168 [SBIT](INFO): git hash: 036008fb27dd1443c9c6898c567944386f491f02 2016-05-18T19:24:46.169Z,1463599486.169 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2016-05-18T19:24:46.169Z,1463599486.169 [SBIT](IMPORTANT): Kernel Version:#639 PREEMPT Wed Mar 12 12:53:33 PDT 2014 2016-05-18T19:24:46.170Z,1463599486.170 [SBIT](INFO): Beginning SBIT in 63.000000 seconds. 2016-05-18T19:24:46.170Z,1463599486.170 [IBIT](INFO): Initialize IBIT Component. 2016-05-18T19:24:46.171Z,1463599486.171 [CBIT](DEBUG): Initialize CBIT Component. 2016-05-18T19:24:46.172Z,1463599486.172 [CBIT](CRITICAL): LAST REBOOT DUE TO WATCHDOG TIMER RESET. 2016-05-18T19:24:46.173Z,1463599486.173 [logger ThreadHandler](INFO): Handler Thread ID is 1141 2016-05-18T19:24:46.192Z,1463599486.192 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 1142 2016-05-18T19:24:46.193Z,1463599486.193 [CTD_NeilBrown](INFO): Powering down 2016-05-18T19:24:46.196Z,1463599486.196 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2016-05-18T19:24:46.198Z,1463599486.198 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2016-05-18T19:24:46.199Z,1463599486.199 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2016-05-18T19:24:46.199Z,1463599486.199 [LoopControl](DEBUG): Initialize LoopControlComponent. 2016-05-18T19:24:46.200Z,1463599486.200 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2016-05-18T19:24:46.200Z,1463599486.200 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2016-05-18T19:24:46.200Z,1463599486.200 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2016-05-18T19:24:46.201Z,1463599486.201 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2016-05-18T19:24:46.201Z,1463599486.201 [VerticalTemperatureHomogeneityIndexCalculator](DEBUG): (re)initializing 2016-05-18T19:24:46.202Z,1463599486.202 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2016-05-18T19:24:46.202Z,1463599486.202 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2016-05-18T19:24:46.203Z,1463599486.203 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2016-05-18T19:24:46.203Z,1463599486.203 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2016-05-18T19:24:46.208Z,1463599486.208 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2016-05-18T19:24:46.208Z,1463599486.208 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2016-05-18T19:24:46.209Z,1463599486.209 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2016-05-18T19:24:46.209Z,1463599486.209 [NavChart](DEBUG): Initialize NavChart Navigation. 2016-05-18T19:24:46.209Z,1463599486.209 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2016-05-18T19:24:46.229Z,1463599486.229 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2016-05-18T19:24:46.248Z,1463599486.248 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1143 2016-05-18T19:24:46.250Z,1463599486.250 [WetLabsBB2FL](INFO): Powering down 2016-05-18T19:24:46.281Z,1463599486.281 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1144 2016-05-18T19:24:46.286Z,1463599486.286 [Radio_Surface](INFO): Powering up 2016-05-18T19:24:46.288Z,1463599486.288 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2016-05-18T19:24:46.297Z,1463599486.297 [Rowe_600LCM ThreadHandler](INFO): Handler Thread ID is 1145 2016-05-18T19:24:46.298Z,1463599486.298 [Rowe_600LCM](INFO): Initializing 2016-05-18T19:24:46.298Z,1463599486.298 [Rowe_600LCM](INFO): Checking LCM 2016-05-18T19:24:46.298Z,1463599486.298 [Rowe_600LCM](IMPORTANT): LCM not connected 2016-05-18T19:24:46.298Z,1463599486.298 [Rowe_600LCM](INFO): Powering up 2016-05-18T19:24:46.317Z,1463599486.317 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1146 2016-05-18T19:24:46.319Z,1463599486.319 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources/ElectronicNavigationCharts 2016-05-18T19:24:46.320Z,1463599486.320 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2016-05-18T19:24:46.320Z,1463599486.320 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2016-05-18T19:24:46.321Z,1463599486.321 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2016-05-18T19:24:46.321Z,1463599486.321 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2016-05-18T19:24:46.321Z,1463599486.321 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2016-05-18T19:24:46.321Z,1463599486.321 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2016-05-18T19:24:46.321Z,1463599486.321 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2016-05-18T19:24:46.322Z,1463599486.322 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2016-05-18T19:24:46.341Z,1463599486.341 [MissionManager](DEBUG): 2016-05-18T19:24:46.342Z,1463599486.342 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2016-05-18T19:24:46.395Z,1463599486.395 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2016-05-18T19:24:46.413Z,1463599486.413 [Default:A.Wait](DEBUG): Construct Wait. 2016-05-18T19:24:46.415Z,1463599486.415 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2016-05-18T19:24:46.440Z,1463599486.440 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2016-05-18T19:24:46.443Z,1463599486.443 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2016-05-18T19:24:46.469Z,1463599486.469 [Default:E.Execute](DEBUG): Construct Execute. 2016-05-18T19:24:46.488Z,1463599486.488 [MissionManager](DEBUG): 0 Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. 13 Burn 300 Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2016-05-18T19:24:46.494Z,1463599486.494 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,ESPComponent,PAR_Licor,AcousticModem_Benthos_ATM900,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,PNI_TCM,BPC1,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,VerticalTemperatureHomogeneityIndexCalculator,YawRateCalculator,StratificationFrontDetector,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2016-05-18T19:24:46.589Z,1463599486.589 [AcousticModem_Benthos_ATM900](INFO): Powering up 2016-05-18T19:24:46.589Z,1463599486.589 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900. 2016-05-18T19:24:47.074Z,1463599487.074 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:47.094Z,1463599487.094 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:47.214Z,1463599487.214 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2016-05-18T19:24:47.222Z,1463599487.222 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2016-05-18T19:24:47.228Z,1463599487.228 [ElevatorServo](DEBUG): Initializing EZServoServo. 2016-05-18T19:24:47.234Z,1463599487.234 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2016-05-18T19:24:47.255Z,1463599487.255 [MassServo](DEBUG): Initializing EZServoServo. 2016-05-18T19:24:47.262Z,1463599487.262 [MassServo](DEBUG): Initializing MassServo. 2016-05-18T19:24:47.283Z,1463599487.283 [RudderServo](DEBUG): Initializing EZServoServo. 2016-05-18T19:24:47.290Z,1463599487.290 [RudderServo](DEBUG): Initializing RudderServo. 2016-05-18T19:24:47.295Z,1463599487.295 [ThrusterServo](DEBUG): Initializing EZServoServo. 2016-05-18T19:24:47.302Z,1463599487.302 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2016-05-18T19:24:47.350Z,1463599487.350 [CommandLine](FAULT): Scheduling is paused 2016-05-18T19:24:47.531Z,1463599487.531 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:47.532Z,1463599487.532 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:47.836Z,1463599487.836 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:47.837Z,1463599487.837 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:48.179Z,1463599488.179 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2016-05-18T19:24:48.179Z,1463599488.179 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2016-05-18T19:24:48.179Z,1463599488.179 [BuoyancyServo] Communications Fault, FailCount= 1 2016-05-18T19:24:48.179Z,1463599488.179 [BuoyancyServo](ERROR): Communications Fault 2016-05-18T19:24:48.390Z,1463599488.390 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2016-05-18T19:24:48.497Z,1463599488.497 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:48.498Z,1463599488.498 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:48.521Z,1463599488.521 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2016-05-18T19:24:48.523Z,1463599488.523 [BuoyancyServo](INFO): Powering down 2016-05-18T19:24:48.872Z,1463599488.872 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:48.873Z,1463599488.873 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:49.206Z,1463599489.206 [NAL9602](INFO): Powering up NAL9602 2016-05-18T19:24:49.256Z,1463599489.256 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:49.265Z,1463599489.265 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:49.718Z,1463599489.718 [Aanderaa_O2](INFO): Powering down 2016-05-18T19:24:49.830Z,1463599489.830 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:49.831Z,1463599489.831 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:50.046Z,1463599490.046 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:50.047Z,1463599490.047 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:50.577Z,1463599490.577 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface 2016-05-18T19:24:50.619Z,1463599490.619 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:50.621Z,1463599490.621 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:50.722Z,1463599490.722 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:./bin/roweadcp -dev /dev/ttyA1 -b 115200 >& adcpLog.log & 2016-05-18T19:24:50.725Z,1463599490.725 [Rowe_600LCM](INFO): LCM subscribed to channel:rti.adcp_dvl.bottom_track 2016-05-18T19:24:50.884Z,1463599490.884 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:50.885Z,1463599490.885 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:50.986Z,1463599490.986 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2016-05-18T19:24:50.986Z,1463599490.986 [BuoyancyServo] No Fault, FailCount= 1 2016-05-18T19:24:51.236Z,1463599491.236 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:51.238Z,1463599491.238 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:51.261Z,1463599491.261 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2016-05-18T19:24:51.381Z,1463599491.381 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2016-05-18T19:24:51.685Z,1463599491.685 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:51.686Z,1463599491.686 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:52.049Z,1463599492.049 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:52.051Z,1463599492.051 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:52.442Z,1463599492.442 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:52.444Z,1463599492.444 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:53.037Z,1463599493.037 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:53.038Z,1463599493.038 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:53.256Z,1463599493.256 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:53.257Z,1463599493.257 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:53.653Z,1463599493.653 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:53.654Z,1463599493.654 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:54.001Z,1463599494.001 [AcousticModem_Benthos_ATM900](DEBUG): 2016-05-18T19:24:54.029Z,1463599494.029 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:54.030Z,1463599494.030 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:54.441Z,1463599494.441 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:54.442Z,1463599494.442 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:54.863Z,1463599494.863 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:54.864Z,1463599494.864 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:55.204Z,1463599495.204 [AcousticModem_Benthos_ATM900](DEBUG): Teledyne Benthos ATM-900 Series OEM w/burn wire 2016-05-18T19:24:55.205Z,1463599495.205 [AcousticModem_Benthos_ATM900](DEBUG): MF Frequency Band 2016-05-18T19:24:55.205Z,1463599495.205 [AcousticModem_Benthos_ATM900](DEBUG): Standard version 8.6.3 2016-05-18T19:24:55.418Z,1463599495.418 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:55.426Z,1463599495.426 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:55.604Z,1463599495.604 [AcousticModem_Benthos_ATM900](DEBUG): May 18 2016 19:16:19 2016-05-18T19:24:55.642Z,1463599495.642 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:55.651Z,1463599495.651 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:56.068Z,1463599496.068 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:56.069Z,1463599496.069 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:56.413Z,1463599496.413 [AcousticModem_Benthos_ATM900](INFO): entering command mode 2016-05-18T19:24:56.485Z,1463599496.485 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:56.486Z,1463599496.486 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:56.801Z,1463599496.801 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment 2016-05-18T19:24:56.852Z,1463599496.852 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:56.853Z,1463599496.853 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:57.202Z,1463599497.202 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment 2016-05-18T19:24:57.202Z,1463599497.202 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt 1: user:1> 2016-05-18T19:24:57.203Z,1463599497.203 [AcousticModem_Benthos_ATM900](INFO): command mode acknowledged 2016-05-18T19:24:57.250Z,1463599497.250 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:57.251Z,1463599497.251 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:57.603Z,1463599497.603 [AcousticModem_Benthos_ATM900](INFO): setting local address to 3 2016-05-18T19:24:57.738Z,1463599497.738 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:57.739Z,1463599497.739 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:58.003Z,1463599498.003 [AcousticModem_Benthos_ATM900](DEBUG): checking for local address setting acknowledgment 2016-05-18T19:24:58.004Z,1463599498.004 [AcousticModem_Benthos_ATM900](INFO): set local address to 3 2016-05-18T19:24:58.055Z,1463599498.055 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:58.056Z,1463599498.056 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:58.404Z,1463599498.404 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt 2: user:2> 2016-05-18T19:24:58.440Z,1463599498.440 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:58.441Z,1463599498.441 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:58.847Z,1463599498.847 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:58.848Z,1463599498.848 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:59.280Z,1463599499.280 [PNI_TCM](FAULT): Failed to set parameters during initialization. 2016-05-18T19:24:59.280Z,1463599499.280 [PNI_TCM] Data Fault, FailCount= 1 2016-05-18T19:24:59.280Z,1463599499.280 [PNI_TCM](ERROR): Data Fault 2016-05-18T19:24:59.295Z,1463599499.295 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:59.296Z,1463599499.296 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:59.348Z,1463599499.348 [CBIT](ERROR): Data Fault in component: PNI_TCM 2016-05-18T19:24:59.640Z,1463599499.640 [PNI_TCM](INFO): Powering down 2016-05-18T19:24:59.805Z,1463599499.805 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:24:59.806Z,1463599499.806 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:00.007Z,1463599500.007 [NAL9602](INFO): NAL9602 initialized 2016-05-18T19:25:00.034Z,1463599500.034 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:00.035Z,1463599500.035 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:00.507Z,1463599500.507 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:00.508Z,1463599500.508 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:00.872Z,1463599500.872 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:00.873Z,1463599500.873 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:00.999Z,1463599500.999 [CBIT](INFO): Clearing failed state for component PNI_TCM 2016-05-18T19:25:00.999Z,1463599500.999 [PNI_TCM] No Fault, FailCount= 1 2016-05-18T19:25:01.341Z,1463599501.341 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:01.343Z,1463599501.343 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:01.729Z,1463599501.729 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:01.730Z,1463599501.730 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:02.062Z,1463599502.062 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:02.063Z,1463599502.063 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:02.503Z,1463599502.503 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:02.504Z,1463599502.504 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:02.880Z,1463599502.880 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:02.882Z,1463599502.882 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:03.318Z,1463599503.318 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:03.319Z,1463599503.319 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:03.664Z,1463599503.664 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:03.665Z,1463599503.665 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:04.208Z,1463599504.208 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:04.209Z,1463599504.209 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:04.445Z,1463599504.445 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:04.446Z,1463599504.446 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:04.859Z,1463599504.859 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:04.860Z,1463599504.860 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:05.384Z,1463599505.384 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:05.386Z,1463599505.386 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:05.650Z,1463599505.650 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:05.651Z,1463599505.651 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:06.111Z,1463599506.111 [PNI_TCM](ERROR): No parameter response UART error: serial timeout 2016-05-18T19:25:06.111Z,1463599506.111 [PNI_TCM](ERROR): Received 0xFE 2016-05-18T19:25:06.131Z,1463599506.131 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:06.132Z,1463599506.132 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:06.463Z,1463599506.463 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:06.464Z,1463599506.464 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:06.826Z,1463599506.826 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:06.827Z,1463599506.827 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:07.272Z,1463599507.272 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:07.281Z,1463599507.281 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:07.676Z,1463599507.676 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:07.686Z,1463599507.686 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:08.298Z,1463599508.298 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:08.307Z,1463599508.307 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:08.477Z,1463599508.477 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:08.478Z,1463599508.478 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:09.115Z,1463599509.115 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:09.116Z,1463599509.116 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:09.263Z,1463599509.263 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:09.272Z,1463599509.272 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:09.675Z,1463599509.675 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:09.688Z,1463599509.688 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:10.048Z,1463599510.048 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:10.058Z,1463599510.058 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:10.454Z,1463599510.454 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:10.455Z,1463599510.455 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:10.861Z,1463599510.861 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:10.866Z,1463599510.866 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:11.273Z,1463599511.273 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:11.274Z,1463599511.274 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:11.663Z,1463599511.663 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:11.664Z,1463599511.664 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:12.062Z,1463599512.062 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:12.063Z,1463599512.063 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:12.457Z,1463599512.457 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:12.458Z,1463599512.458 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:12.866Z,1463599512.866 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:12.867Z,1463599512.867 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:13.269Z,1463599513.269 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:13.274Z,1463599513.274 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:13.666Z,1463599513.666 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:13.671Z,1463599513.671 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:14.059Z,1463599514.059 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:14.060Z,1463599514.060 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:14.455Z,1463599514.455 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:14.461Z,1463599514.461 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:14.849Z,1463599514.849 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:14.850Z,1463599514.850 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:15.259Z,1463599515.259 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:15.260Z,1463599515.260 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:15.660Z,1463599515.660 [BPC1](ERROR): Failed to parse bank B battery data 2016-05-18T19:25:15.660Z,1463599515.660 [BPC1] Data Fault, FailCount= 1 2016-05-18T19:25:15.660Z,1463599515.660 [BPC1](ERROR): Data Fault 2016-05-18T19:25:15.675Z,1463599515.675 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:15.676Z,1463599515.676 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:15.833Z,1463599515.833 [CBIT](ERROR): Data Fault in component: BPC1 2016-05-18T19:25:16.066Z,1463599516.066 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:16.067Z,1463599516.067 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:16.448Z,1463599516.448 [PNI_TCM](FAULT): Failed to acquire valid data within timeout. 2016-05-18T19:25:16.448Z,1463599516.448 [PNI_TCM] Data Fault, FailCount= 2 2016-05-18T19:25:16.448Z,1463599516.448 [PNI_TCM](ERROR): Data Fault 2016-05-18T19:25:16.458Z,1463599516.458 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:16.464Z,1463599516.464 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:16.478Z,1463599516.478 [CBIT](ERROR): Data Fault in component: PNI_TCM 2016-05-18T19:25:16.826Z,1463599516.826 [PNI_TCM](INFO): Powering down 2016-05-18T19:25:16.938Z,1463599516.938 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:16.939Z,1463599516.939 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:16.957Z,1463599516.957 [CBIT](INFO): Clearing failed state for component BPC1 2016-05-18T19:25:16.957Z,1463599516.957 [BPC1] No Fault, FailCount= 1 2016-05-18T19:25:17.325Z,1463599517.325 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:17.326Z,1463599517.326 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:17.672Z,1463599517.672 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:17.678Z,1463599517.678 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:18.073Z,1463599518.073 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:18.094Z,1463599518.094 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:18.112Z,1463599518.112 [CBIT](INFO): Clearing failed state for component PNI_TCM 2016-05-18T19:25:18.112Z,1463599518.112 [PNI_TCM] No Fault, FailCount= 2 2016-05-18T19:25:18.461Z,1463599518.461 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:18.474Z,1463599518.474 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:18.874Z,1463599518.874 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:18.895Z,1463599518.895 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:19.301Z,1463599519.301 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:19.302Z,1463599519.302 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:19.666Z,1463599519.666 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:19.667Z,1463599519.667 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:20.066Z,1463599520.066 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:20.067Z,1463599520.067 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:20.482Z,1463599520.482 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:20.483Z,1463599520.483 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:20.825Z,1463599520.825 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:20.826Z,1463599520.826 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:21.235Z,1463599521.235 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:21.236Z,1463599521.236 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:21.699Z,1463599521.699 [PNI_TCM](ERROR): No parameter response UART error: serial timeout 2016-05-18T19:25:21.699Z,1463599521.699 [PNI_TCM](ERROR): Received 0xDE00 2016-05-18T19:25:21.715Z,1463599521.715 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:21.716Z,1463599521.716 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:22.060Z,1463599522.060 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:22.061Z,1463599522.061 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:22.461Z,1463599522.461 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:22.462Z,1463599522.462 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:22.872Z,1463599522.872 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:22.873Z,1463599522.873 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:23.262Z,1463599523.262 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:23.263Z,1463599523.263 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:23.673Z,1463599523.673 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:23.674Z,1463599523.674 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:24.078Z,1463599524.078 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:24.095Z,1463599524.095 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:24.478Z,1463599524.478 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:24.484Z,1463599524.484 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:24.864Z,1463599524.864 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:24.865Z,1463599524.865 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:25.274Z,1463599525.274 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:25.275Z,1463599525.275 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:25.678Z,1463599525.678 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:25.679Z,1463599525.679 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:26.083Z,1463599526.083 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:26.084Z,1463599526.084 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:26.469Z,1463599526.469 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:26.470Z,1463599526.470 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:26.874Z,1463599526.874 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:26.879Z,1463599526.879 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:27.272Z,1463599527.272 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:27.273Z,1463599527.273 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:27.676Z,1463599527.676 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:27.681Z,1463599527.681 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:28.076Z,1463599528.076 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:28.081Z,1463599528.081 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:28.487Z,1463599528.487 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:28.488Z,1463599528.488 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:28.900Z,1463599528.900 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:28.901Z,1463599528.901 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:29.306Z,1463599529.306 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:29.311Z,1463599529.311 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:29.756Z,1463599529.756 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:29.757Z,1463599529.757 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:30.062Z,1463599530.062 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:30.063Z,1463599530.063 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:30.467Z,1463599530.467 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:30.468Z,1463599530.468 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:30.875Z,1463599530.875 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:30.876Z,1463599530.876 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:31.262Z,1463599531.262 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:31.263Z,1463599531.263 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:31.679Z,1463599531.679 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:31.680Z,1463599531.680 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:32.091Z,1463599532.091 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:32.092Z,1463599532.092 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:32.441Z,1463599532.441 [PNI_TCM](FAULT): Failed to acquire valid data within timeout. 2016-05-18T19:25:32.441Z,1463599532.441 [PNI_TCM] Data Fault, FailCount= 3 2016-05-18T19:25:32.441Z,1463599532.441 [PNI_TCM](ERROR): Data Fault 2016-05-18T19:25:32.478Z,1463599532.478 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:32.483Z,1463599532.483 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:32.519Z,1463599532.519 [CBIT](ERROR): Data Fault in component: PNI_TCM 2016-05-18T19:25:32.823Z,1463599532.823 [PNI_TCM](INFO): Powering down 2016-05-18T19:25:32.924Z,1463599532.924 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:32.932Z,1463599532.932 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:33.218Z,1463599533.218 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:33.219Z,1463599533.219 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:33.662Z,1463599533.662 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:33.663Z,1463599533.663 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:34.070Z,1463599534.070 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:34.075Z,1463599534.075 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:34.116Z,1463599534.116 [CBIT](INFO): Clearing failed state for component PNI_TCM 2016-05-18T19:25:34.116Z,1463599534.116 [PNI_TCM] No Fault, FailCount= 3 2016-05-18T19:25:34.462Z,1463599534.462 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:34.467Z,1463599534.467 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:34.859Z,1463599534.859 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:34.860Z,1463599534.860 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:35.120Z,1463599535.120 [CommandLine](IMPORTANT): got command quit 2016-05-18T19:25:35.293Z,1463599535.293 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:35.294Z,1463599535.294 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:35.622Z,1463599535.622 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:35.623Z,1463599535.623 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:36.038Z,1463599536.038 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:36.040Z,1463599536.040 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:36.128Z,1463599536.128 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2016-05-18T19:25:36.129Z,1463599536.129 [CommandLine ThreadHandler](INFO): Thread cancelled. 2016-05-18T19:25:36.265Z,1463599536.265 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2016-05-18T19:25:36.266Z,1463599536.266 [CommandLine ThreadHandler](INFO): Thread cancelled. 2016-05-18T19:25:36.266Z,1463599536.266 [CommandLine](INFO): Join timeout helper Thread ID is 1171 2016-05-18T19:25:36.273Z,1463599536.273 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2016-05-18T19:25:36.274Z,1463599536.274 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2016-05-18T19:25:36.274Z,1463599536.274 [NavChartDb](INFO): Join timeout helper Thread ID is 1172 2016-05-18T19:25:36.470Z,1463599536.470 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:36.471Z,1463599536.471 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:36.695Z,1463599536.695 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2016-05-18T19:25:36.696Z,1463599536.696 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2016-05-18T19:25:36.706Z,1463599536.706 [ComponentRegistry](INFO): Shutting down Rowe_600LCM ThreadHandler 2016-05-18T19:25:36.706Z,1463599536.706 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled. 2016-05-18T19:25:36.707Z,1463599536.707 [Rowe_600LCM](INFO): Join timeout helper Thread ID is 1173 2016-05-18T19:25:36.828Z,1463599536.828 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:36.829Z,1463599536.829 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:36.971Z,1463599536.971 [Rowe_600LCM ThreadHandler](INFO): Uninitializing protected caller thread. 2016-05-18T19:25:36.971Z,1463599536.971 [Rowe_600LCM](INFO): Powering down 2016-05-18T19:25:36.972Z,1463599536.972 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled. 2016-05-18T19:25:36.987Z,1463599536.987 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2016-05-18T19:25:36.987Z,1463599536.987 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2016-05-18T19:25:36.987Z,1463599536.987 [Radio_Surface](INFO): Join timeout helper Thread ID is 1174 2016-05-18T19:25:37.231Z,1463599537.231 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:37.233Z,1463599537.233 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-05-18T19:25:37.316Z,1463599537.316 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2016-05-18T19:25:37.317Z,1463599537.317 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2016-05-18T19:25:37.319Z,1463599537.319 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2016-05-18T19:25:37.319Z,1463599537.319 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2016-05-18T19:25:37.320Z,1463599537.320 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1175 2016-05-18T19:25:37.347Z,1463599537.347 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2016-05-18T19:25:37.348Z,1463599537.348 [WetLabsBB2FL](INFO): Powering down 2016-05-18T19:25:37.348Z,1463599537.348 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2016-05-18T19:25:37.360Z,1463599537.360 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler 2016-05-18T19:25:37.360Z,1463599537.360 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2016-05-18T19:25:37.361Z,1463599537.361 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 1176 2016-05-18T19:25:37.361Z,1463599537.361 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread. 2016-05-18T19:25:37.362Z,1463599537.362 [CTD_NeilBrown](INFO): Powering down 2016-05-18T19:25:37.362Z,1463599537.362 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2016-05-18T19:25:37.379Z,1463599537.379 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2016-05-18T19:25:37.379Z,1463599537.379 [logger ThreadHandler](INFO): Thread cancelled. 2016-05-18T19:25:37.380Z,1463599537.380 [logger](INFO): Join timeout helper Thread ID is 1177 2016-05-18T19:25:37.391Z,1463599537.391 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2016-05-18T19:25:37.392Z,1463599537.392 [logger ThreadHandler](INFO): Thread cancelled. 2016-05-18T19:25:37.408Z,1463599537.408 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2016-05-18T19:25:37.408Z,1463599537.408 [CommandLine ThreadHandler](INFO): Thread cancelled. 2016-05-18T19:25:37.408Z,1463599537.408 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2016-05-18T19:25:37.408Z,1463599537.408 [controlThread ThreadHandler](INFO): Thread cancelled. 2016-05-18T19:25:37.409Z,1463599537.409 [controlThread](INFO): Join timeout helper Thread ID is 1178 2016-05-18T19:25:37.596Z,1463599537.596 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2016-05-18T19:25:37.596Z,1463599537.596 [controlThread](DEBUG): Uninitializing ControlThread 2016-05-18T19:25:37.596Z,1463599537.596 [Aanderaa_O2](INFO): Powering down 2016-05-18T19:25:37.597Z,1463599537.597 [AcousticModem_Benthos_ATM900](INFO): Powering down 2016-05-18T19:25:37.717Z,1463599537.717 [NAL9602](INFO): Powering down 2016-05-18T19:25:37.718Z,1463599537.718 [PNI_TCM](INFO): Powering down 2016-05-18T19:25:37.805Z,1463599537.805 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2016-05-18T19:25:37.806Z,1463599537.806 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2016-05-18T19:25:37.810Z,1463599537.810 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2016-05-18T19:25:37.810Z,1463599537.810 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2016-05-18T19:25:37.811Z,1463599537.811 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2016-05-18T19:25:37.811Z,1463599537.811 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2016-05-18T19:25:37.811Z,1463599537.811 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2016-05-18T19:25:37.811Z,1463599537.811 [BuoyancyServo](INFO): Powering down 2016-05-18T19:25:37.824Z,1463599537.824 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2016-05-18T19:25:37.824Z,1463599537.824 [ElevatorServo](INFO): Powering down 2016-05-18T19:25:37.843Z,1463599537.843 [MassServo](DEBUG): Uninitialize Mass Servo. 2016-05-18T19:25:37.843Z,1463599537.843 [MassServo](INFO): Powering down 2016-05-18T19:25:37.844Z,1463599537.844 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2016-05-18T19:25:37.844Z,1463599537.844 [RudderServo](INFO): Powering down 2016-05-18T19:25:37.845Z,1463599537.845 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2016-05-18T19:25:37.845Z,1463599537.845 [ThrusterServo](INFO): Powering down 2016-05-18T19:25:37.846Z,1463599537.846 [SBIT](DEBUG): Uninitialize SBIT Component. 2016-05-18T19:25:37.846Z,1463599537.846 [IBIT](DEBUG): Uninitialize IBIT Component. 2016-05-18T19:25:37.847Z,1463599537.847 [CBIT](DEBUG): Uninitialize CBIT Component. 2016-05-18T19:25:37.877Z,1463599537.877 [controlThread ThreadHandler](INFO): Thread cancelled. 2016-05-18T19:25:37.933Z,1463599537.933 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2016-05-18T19:25:37.938Z,1463599537.938 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2016-05-18T19:25:38.001Z,1463599538.001 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled. 2016-05-18T19:25:38.005Z,1463599538.005 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2016-05-18T19:25:38.173Z,1463599538.173 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2016-05-18T19:25:38.229Z,1463599538.229 [logger ThreadHandler](INFO): Thread cancelled.