2016-05-18T21:20:04.646Z,1463606404.646 [Supervisor](DEBUG): Initializing supervisor.
2016-05-18T21:20:04.648Z,1463606404.648 [SyncHandler](DEBUG): Created PCaller Thread at 4034C4E0
2016-05-18T21:20:04.649Z,1463606404.649 [SyncHandler](INFO): Protected caller Thread ID is 1565
2016-05-18T21:20:04.649Z,1463606404.649 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2016-05-18T21:20:04.650Z,1463606404.650 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4037C4E0
2016-05-18T21:20:04.650Z,1463606404.650 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1566
2016-05-18T21:20:04.653Z,1463606404.653 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2016-05-18T21:20:04.665Z,1463606404.665 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2016-05-18T21:20:04.666Z,1463606404.666 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 403AC4E0
2016-05-18T21:20:04.667Z,1463606404.667 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1567
2016-05-18T21:20:04.668Z,1463606404.668 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2016-05-18T21:20:04.668Z,1463606404.668 [logger ThreadHandler](DEBUG): Created PCaller Thread at 403DC4E0
2016-05-18T21:20:04.669Z,1463606404.669 [logger ThreadHandler](INFO): Protected caller Thread ID is 1568
2016-05-18T21:20:04.671Z,1463606404.671 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2016-05-18T21:20:04.671Z,1463606404.671 [Supervisor](INFO): Looking for Config files in directory: Config/
2016-05-18T21:20:04.673Z,1463606404.673 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2016-05-18T21:20:05.033Z,1463606405.033 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2016-05-18T21:20:05.034Z,1463606405.034 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2016-05-18T21:20:05.198Z,1463606405.198 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2016-05-18T21:20:05.199Z,1463606405.199 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2016-05-18T21:20:05.324Z,1463606405.324 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2016-05-18T21:20:05.324Z,1463606405.324 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2016-05-18T21:20:05.455Z,1463606405.455 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2016-05-18T21:20:05.455Z,1463606405.455 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2016-05-18T21:20:05.540Z,1463606405.540 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2016-05-18T21:20:05.728Z,1463606405.728 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2016-05-18T21:20:05.729Z,1463606405.729 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2016-05-18T21:20:05.814Z,1463606405.814 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2016-05-18T21:20:05.815Z,1463606405.815 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2016-05-18T21:20:06.084Z,1463606406.084 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2016-05-18T21:20:06.085Z,1463606406.085 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2016-05-18T21:20:06.421Z,1463606406.421 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2016-05-18T21:20:06.422Z,1463606406.422 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2016-05-18T21:20:06.718Z,1463606406.718 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2016-05-18T21:20:06.719Z,1463606406.719 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2016-05-18T21:20:07.210Z,1463606407.210 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2016-05-18T21:20:07.210Z,1463606407.210 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2016-05-18T21:20:07.407Z,1463606407.407 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2016-05-18T21:20:07.408Z,1463606407.408 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2016-05-18T21:20:07.511Z,1463606407.511 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2016-05-18T21:20:07.512Z,1463606407.512 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2016-05-18T21:20:07.939Z,1463606407.939 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2016-05-18T21:20:07.940Z,1463606407.940 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2016-05-18T21:20:08.050Z,1463606408.050 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2016-05-18T21:20:08.052Z,1463606408.052 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2016-05-18T21:20:08.053Z,1463606408.053 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2016-05-18T21:20:08.291Z,1463606408.291 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2016-05-18T21:20:08.292Z,1463606408.292 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2016-05-18T21:20:08.419Z,1463606408.419 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2016-05-18T21:20:08.533Z,1463606408.533 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2016-05-18T21:20:08.629Z,1463606408.629 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2016-05-18T21:20:08.718Z,1463606408.718 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2016-05-18T21:20:08.862Z,1463606408.862 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2016-05-18T21:20:09.021Z,1463606409.021 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2016-05-18T21:20:09.123Z,1463606409.123 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2016-05-18T21:20:09.206Z,1463606409.206 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2016-05-18T21:20:09.295Z,1463606409.295 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2016-05-18T21:20:09.471Z,1463606409.471 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/
2016-05-18T21:20:09.471Z,1463606409.471 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2016-05-18T21:20:09.475Z,1463606409.475 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2016-05-18T21:20:09.588Z,1463606409.588 [SBIT](DEBUG): Construct Startup Built In Test.
2016-05-18T21:20:09.619Z,1463606409.619 [SBIT] Loaded
2016-05-18T21:20:09.620Z,1463606409.620 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2016-05-18T21:20:09.620Z,1463606409.620 [IBIT](DEBUG): Construct Initiated Built In Test.
2016-05-18T21:20:09.649Z,1463606409.649 [IBIT] Loaded
2016-05-18T21:20:09.649Z,1463606409.649 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2016-05-18T21:20:09.651Z,1463606409.651 [CBIT](DEBUG): Construct Continuous Built In Test.
2016-05-18T21:20:09.790Z,1463606409.790 [CBIT] Loaded
2016-05-18T21:20:09.791Z,1463606409.791 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2016-05-18T21:20:09.791Z,1463606409.791 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2016-05-18T21:20:09.792Z,1463606409.792 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2016-05-18T21:20:09.837Z,1463606409.837 [VerticalControl](DEBUG): Construct VerticalControl.
2016-05-18T21:20:09.938Z,1463606409.938 [VerticalControl] Loaded
2016-05-18T21:20:09.939Z,1463606409.939 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2016-05-18T21:20:09.939Z,1463606409.939 [HorizontalControl](DEBUG): Construct HorizontalControl.
2016-05-18T21:20:10.001Z,1463606410.001 [HorizontalControl] Loaded
2016-05-18T21:20:10.002Z,1463606410.002 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2016-05-18T21:20:10.002Z,1463606410.002 [SpeedControl](DEBUG): Construct SpeedControl.
2016-05-18T21:20:10.008Z,1463606410.008 [SpeedControl] Loaded
2016-05-18T21:20:10.008Z,1463606410.008 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2016-05-18T21:20:10.009Z,1463606410.009 [LoopControl](DEBUG): Construct LoopControl.
2016-05-18T21:20:10.009Z,1463606410.009 [LoopControl] Loaded
2016-05-18T21:20:10.010Z,1463606410.010 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2016-05-18T21:20:10.010Z,1463606410.010 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2016-05-18T21:20:10.011Z,1463606410.011 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2016-05-18T21:20:10.032Z,1463606410.032 [DepthRateCalculator] Loaded
2016-05-18T21:20:10.033Z,1463606410.033 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2016-05-18T21:20:10.038Z,1463606410.038 [PitchRateCalculator] Loaded
2016-05-18T21:20:10.038Z,1463606410.038 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2016-05-18T21:20:10.049Z,1463606410.049 [SpeedCalculator] Loaded
2016-05-18T21:20:10.050Z,1463606410.050 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2016-05-18T21:20:10.066Z,1463606410.066 [TempGradientCalculator] Loaded
2016-05-18T21:20:10.066Z,1463606410.066 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2016-05-18T21:20:10.083Z,1463606410.083 [VerticalTemperatureHomogeneityIndexCalculator] Loaded
2016-05-18T21:20:10.083Z,1463606410.083 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread.
2016-05-18T21:20:10.088Z,1463606410.088 [YawRateCalculator] Loaded
2016-05-18T21:20:10.088Z,1463606410.088 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2016-05-18T21:20:10.089Z,1463606410.089 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2016-05-18T21:20:10.089Z,1463606410.089 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2016-05-18T21:20:10.161Z,1463606410.161 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC
2016-05-18T21:20:10.161Z,1463606410.161 [StratificationFrontDetector](DEBUG): (re)initializing
2016-05-18T21:20:10.161Z,1463606410.161 [StratificationFrontDetector] Loaded
2016-05-18T21:20:10.161Z,1463606410.161 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread.
2016-05-18T21:20:10.162Z,1463606410.162 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2016-05-18T21:20:10.162Z,1463606410.162 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2016-05-18T21:20:10.373Z,1463606410.373 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2016-05-18T21:20:10.374Z,1463606410.374 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2016-05-18T21:20:10.468Z,1463606410.468 [DeadReckonUsingMultipleVelocitySources] Loaded
2016-05-18T21:20:10.469Z,1463606410.469 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2016-05-18T21:20:10.524Z,1463606410.524 [DeadReckonUsingSpeedCalculator] Loaded
2016-05-18T21:20:10.524Z,1463606410.524 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2016-05-18T21:20:10.541Z,1463606410.541 [NavChart] Loaded
2016-05-18T21:20:10.541Z,1463606410.541 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2016-05-18T21:20:10.545Z,1463606410.545 [UniversalFixResidualReporter] Loaded
2016-05-18T21:20:10.546Z,1463606410.546 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2016-05-18T21:20:10.546Z,1463606410.546 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2016-05-18T21:20:10.547Z,1463606410.547 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2016-05-18T21:20:10.552Z,1463606410.552 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2016-05-18T21:20:10.553Z,1463606410.553 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2016-05-18T21:20:10.730Z,1463606410.730 [Aanderaa_O2] Loaded
2016-05-18T21:20:10.730Z,1463606410.730 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2016-05-18T21:20:10.805Z,1463606410.805 [CTD_NeilBrown] Loaded
2016-05-18T21:20:10.805Z,1463606410.805 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2016-05-18T21:20:10.807Z,1463606410.807 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 4059E4E0
2016-05-18T21:20:10.807Z,1463606410.807 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 1647
2016-05-18T21:20:10.809Z,1463606410.809 [ESPComponent](CRITICAL): No configuration setting for: ESPComponent.espSimulator
2016-05-18T21:20:10.816Z,1463606410.816 [ESPComponent](CRITICAL): No configuration setting for: ESPComponent.stopCompleteTimeout
2016-05-18T21:20:10.827Z,1463606410.827 [ESPComponent] Loaded
2016-05-18T21:20:10.827Z,1463606410.827 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2016-05-18T21:20:10.842Z,1463606410.842 [PAR_Licor] Loaded
2016-05-18T21:20:10.842Z,1463606410.842 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2016-05-18T21:20:10.892Z,1463606410.892 [WetLabsBB2FL] Loaded
2016-05-18T21:20:10.892Z,1463606410.892 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2016-05-18T21:20:10.893Z,1463606410.893 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 405CE4E0
2016-05-18T21:20:10.893Z,1463606410.893 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1648
2016-05-18T21:20:10.894Z,1463606410.894 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2016-05-18T21:20:10.894Z,1463606410.894 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2016-05-18T21:20:11.149Z,1463606411.149 [AcousticModem_Benthos_ATM900] Loaded
2016-05-18T21:20:11.149Z,1463606411.149 [ComponentRegistry](DEBUG): SyncComponent "AcousticModem_Benthos_ATM900" handled in the control thread.
2016-05-18T21:20:11.232Z,1463606411.232 [DataOverHttps] Loaded
2016-05-18T21:20:11.232Z,1463606411.232 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2016-05-18T21:20:11.246Z,1463606411.246 [Depth_Keller] Loaded
2016-05-18T21:20:11.246Z,1463606411.246 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2016-05-18T21:20:11.251Z,1463606411.251 [DropWeight] Loaded
2016-05-18T21:20:11.251Z,1463606411.251 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2016-05-18T21:20:11.343Z,1463606411.343 [NAL9602] Loaded
2016-05-18T21:20:11.343Z,1463606411.343 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2016-05-18T21:20:11.385Z,1463606411.385 [Onboard] Loaded
2016-05-18T21:20:11.385Z,1463606411.385 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2016-05-18T21:20:11.392Z,1463606411.392 [Radio_Surface] Loaded
2016-05-18T21:20:11.392Z,1463606411.392 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2016-05-18T21:20:11.394Z,1463606411.394 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409E64E0
2016-05-18T21:20:11.394Z,1463606411.394 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1649
2016-05-18T21:20:11.441Z,1463606411.441 [PNI_TCM] Loaded
2016-05-18T21:20:11.442Z,1463606411.442 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread.
2016-05-18T21:20:11.511Z,1463606411.511 [Rowe_600LCM] Loaded
2016-05-18T21:20:11.511Z,1463606411.511 [ComponentRegistry](DEBUG): Component "Rowe_600LCM" handled in its own thread.
2016-05-18T21:20:11.513Z,1463606411.513 [Rowe_600LCM ThreadHandler](DEBUG): Created PCaller Thread at 40A164E0
2016-05-18T21:20:11.513Z,1463606411.513 [Rowe_600LCM ThreadHandler](INFO): Protected caller Thread ID is 1650
2016-05-18T21:20:13.314Z,1463606413.314 [BPC1] Loaded
2016-05-18T21:20:13.314Z,1463606413.314 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2016-05-18T21:20:13.315Z,1463606413.315 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2016-05-18T21:20:13.315Z,1463606413.315 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2016-05-18T21:20:13.410Z,1463606413.410 [BuoyancyServo] Loaded
2016-05-18T21:20:13.410Z,1463606413.410 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2016-05-18T21:20:13.422Z,1463606413.422 [ElevatorServo] Loaded
2016-05-18T21:20:13.422Z,1463606413.422 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2016-05-18T21:20:13.434Z,1463606413.434 [MassServo] Loaded
2016-05-18T21:20:13.434Z,1463606413.434 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2016-05-18T21:20:13.446Z,1463606413.446 [RudderServo] Loaded
2016-05-18T21:20:13.446Z,1463606413.446 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2016-05-18T21:20:13.458Z,1463606413.458 [ThrusterServo] Loaded
2016-05-18T21:20:13.458Z,1463606413.458 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2016-05-18T21:20:13.459Z,1463606413.459 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2016-05-18T21:20:13.459Z,1463606413.459 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2016-05-18T21:20:13.569Z,1463606413.569 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2016-05-18T21:20:13.569Z,1463606413.569 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2016-05-18T21:20:13.592Z,1463606413.592 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2016-05-18T21:20:13.596Z,1463606413.596 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2016-05-18T21:20:13.597Z,1463606413.597 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2016-05-18T21:20:13.604Z,1463606413.604 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2016-05-18T21:20:13.605Z,1463606413.605 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AC44E0
2016-05-18T21:20:13.605Z,1463606413.605 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1651
2016-05-18T21:20:13.610Z,1463606413.610 [Supervisor](INFO): Main Thread ID is 1564
2016-05-18T21:20:13.610Z,1463606413.610 [Supervisor](DEBUG): Running supervisor.
2016-05-18T21:20:13.611Z,1463606413.611 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1652
2016-05-18T21:20:13.614Z,1463606413.614 [controlThread ThreadHandler](INFO): Handler Thread ID is 1653
2016-05-18T21:20:13.614Z,1463606413.614 [controlThread](DEBUG): Initializing ControlThread
2016-05-18T21:20:13.615Z,1463606413.615 [SBIT](INFO): Initialize SBIT Component.
2016-05-18T21:20:13.616Z,1463606413.616 [SBIT](IMPORTANT): git: 2015-11-13-11-g036008f
2016-05-18T21:20:13.616Z,1463606413.616 [SBIT](INFO): git hash: 036008fb27dd1443c9c6898c567944386f491f02
2016-05-18T21:20:13.616Z,1463606413.616 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2016-05-18T21:20:13.616Z,1463606413.616 [SBIT](IMPORTANT): Kernel Version:#639 PREEMPT Wed Mar 12 12:53:33 PDT 2014
2016-05-18T21:20:13.617Z,1463606413.617 [SBIT](INFO): Beginning SBIT in 63.000000 seconds.
2016-05-18T21:20:13.618Z,1463606413.618 [IBIT](INFO): Initialize IBIT Component.
2016-05-18T21:20:13.619Z,1463606413.619 [CBIT](DEBUG): Initialize CBIT Component.
2016-05-18T21:20:13.619Z,1463606413.619 [CBIT](CRITICAL): LAST REBOOT DUE TO WATCHDOG TIMER RESET.
2016-05-18T21:20:13.620Z,1463606413.620 [logger ThreadHandler](INFO): Handler Thread ID is 1654
2016-05-18T21:20:13.640Z,1463606413.640 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 1655
2016-05-18T21:20:13.640Z,1463606413.640 [CTD_NeilBrown](INFO): Powering down
2016-05-18T21:20:13.643Z,1463606413.643 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2016-05-18T21:20:13.645Z,1463606413.645 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2016-05-18T21:20:13.646Z,1463606413.646 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2016-05-18T21:20:13.647Z,1463606413.647 [LoopControl](DEBUG): Initialize LoopControlComponent.
2016-05-18T21:20:13.647Z,1463606413.647 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2016-05-18T21:20:13.651Z,1463606413.651 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2016-05-18T21:20:13.652Z,1463606413.652 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2016-05-18T21:20:13.652Z,1463606413.652 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2016-05-18T21:20:13.653Z,1463606413.653 [VerticalTemperatureHomogeneityIndexCalculator](DEBUG): (re)initializing
2016-05-18T21:20:13.653Z,1463606413.653 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2016-05-18T21:20:13.654Z,1463606413.654 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-05-18T21:20:13.655Z,1463606413.655 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-05-18T21:20:13.655Z,1463606413.655 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-05-18T21:20:13.656Z,1463606413.656 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2016-05-18T21:20:13.656Z,1463606413.656 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2016-05-18T21:20:13.656Z,1463606413.656 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2016-05-18T21:20:13.657Z,1463606413.657 [NavChart](DEBUG): Initialize NavChart Navigation.
2016-05-18T21:20:13.657Z,1463606413.657 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2016-05-18T21:20:13.676Z,1463606413.676 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2016-05-18T21:20:13.706Z,1463606413.706 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2016-05-18T21:20:13.699Z,1463606413.699 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1656
2016-05-18T21:20:13.708Z,1463606413.708 [WetLabsBB2FL](INFO): Powering down
2016-05-18T21:20:13.732Z,1463606413.732 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1657
2016-05-18T21:20:13.738Z,1463606413.738 [Radio_Surface](INFO): Powering up
2016-05-18T21:20:13.744Z,1463606413.744 [Rowe_600LCM ThreadHandler](INFO): Handler Thread ID is 1658
2016-05-18T21:20:13.744Z,1463606413.744 [Rowe_600LCM](INFO): start
2016-05-18T21:20:13.745Z,1463606413.745 [Rowe_600LCM](INFO): Initializing
2016-05-18T21:20:13.745Z,1463606413.745 [Rowe_600LCM](INFO): Checking LCM
2016-05-18T21:20:13.745Z,1463606413.745 [Rowe_600LCM](INFO): LCM OK
2016-05-18T21:20:13.745Z,1463606413.745 [Rowe_600LCM](INFO): Powering up
2016-05-18T21:20:13.761Z,1463606413.761 [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-18T21:20:13.762Z,1463606413.762 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2016-05-18T21:20:13.768Z,1463606413.768 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1659
2016-05-18T21:20:13.770Z,1463606413.770 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources/ElectronicNavigationCharts
2016-05-18T21:20:13.771Z,1463606413.771 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2016-05-18T21:20:13.772Z,1463606413.772 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2016-05-18T21:20:13.772Z,1463606413.772 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2016-05-18T21:20:13.772Z,1463606413.772 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2016-05-18T21:20:13.772Z,1463606413.772 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2016-05-18T21:20:13.773Z,1463606413.773 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2016-05-18T21:20:13.773Z,1463606413.773 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2016-05-18T21:20:13.773Z,1463606413.773 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2016-05-18T21:20:13.847Z,1463606413.847 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2016-05-18T21:20:13.849Z,1463606413.849 [Default:A.Wait](DEBUG): Construct Wait.
2016-05-18T21:20:13.850Z,1463606413.850 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2016-05-18T21:20:13.892Z,1463606413.892 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2016-05-18T21:20:13.895Z,1463606413.895 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2016-05-18T21:20:13.913Z,1463606413.913 [Default:E.Execute](DEBUG): Construct Execute.
2016-05-18T21:20:13.916Z,1463606413.916 [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-18T21:20:13.936Z,1463606413.936 [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-18T21:20:14.032Z,1463606414.032 [AcousticModem_Benthos_ATM900](INFO): Powering up
2016-05-18T21:20:14.032Z,1463606414.032 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2016-05-18T21:20:14.442Z,1463606414.442 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:14.465Z,1463606414.465 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:14.555Z,1463606414.555 [Rowe_600LCM](INFO): starting
2016-05-18T21:20:14.597Z,1463606414.597 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2016-05-18T21:20:14.605Z,1463606414.605 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2016-05-18T21:20:14.611Z,1463606414.611 [ElevatorServo](DEBUG): Initializing EZServoServo.
2016-05-18T21:20:14.617Z,1463606414.617 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2016-05-18T21:20:14.623Z,1463606414.623 [MassServo](DEBUG): Initializing EZServoServo.
2016-05-18T21:20:14.629Z,1463606414.629 [MassServo](DEBUG): Initializing MassServo.
2016-05-18T21:20:14.634Z,1463606414.634 [RudderServo](DEBUG): Initializing EZServoServo.
2016-05-18T21:20:14.641Z,1463606414.641 [RudderServo](DEBUG): Initializing RudderServo.
2016-05-18T21:20:14.651Z,1463606414.651 [ThrusterServo](DEBUG): Initializing EZServoServo.
2016-05-18T21:20:14.657Z,1463606414.657 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2016-05-18T21:20:14.701Z,1463606414.701 [CommandLine](FAULT): Scheduling is paused
2016-05-18T21:20:14.985Z,1463606414.985 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:14.986Z,1463606414.986 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:15.204Z,1463606415.204 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:15.206Z,1463606415.206 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:15.358Z,1463606415.358 [Rowe_600LCM](INFO): starting
2016-05-18T21:20:15.550Z,1463606415.550 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2016-05-18T21:20:15.550Z,1463606415.550 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2016-05-18T21:20:15.550Z,1463606415.550 [BuoyancyServo] Communications Fault, FailCount= 1
2016-05-18T21:20:15.551Z,1463606415.551 [BuoyancyServo](ERROR): Communications Fault
2016-05-18T21:20:15.757Z,1463606415.757 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2016-05-18T21:20:15.898Z,1463606415.898 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:15.899Z,1463606415.899 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:15.917Z,1463606415.917 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2016-05-18T21:20:15.918Z,1463606415.918 [BuoyancyServo](INFO): Powering down
2016-05-18T21:20:16.175Z,1463606416.175 [Rowe_600LCM](INFO): starting
2016-05-18T21:20:16.263Z,1463606416.263 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:16.264Z,1463606416.264 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:16.578Z,1463606416.578 [NAL9602](INFO): Powering up NAL9602
2016-05-18T21:20:16.844Z,1463606416.844 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:16.845Z,1463606416.845 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:16.977Z,1463606416.977 [Rowe_600LCM](INFO): starting
2016-05-18T21:20:17.085Z,1463606417.085 [Aanderaa_O2](INFO): Powering down
2016-05-18T21:20:17.228Z,1463606417.228 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:17.245Z,1463606417.245 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:17.429Z,1463606417.429 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:17.445Z,1463606417.445 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:17.778Z,1463606417.778 [Rowe_600LCM](INFO): starting
2016-05-18T21:20:17.866Z,1463606417.866 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:17.868Z,1463606417.868 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:18.082Z,1463606418.082 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2016-05-18T21:20:18.174Z,1463606418.174 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:./bin/roweadcp -dev /dev/ttyA1 -b 115200 >& adcpLog.log &
2016-05-18T21:20:18.287Z,1463606418.287 [Rowe_600LCM](INFO): LCM subscribed to channel:rti.adcp_dvl.bottom_track
2016-05-18T21:20:18.287Z,1463606418.287 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:18.289Z,1463606418.289 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:18.456Z,1463606418.456 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2016-05-18T21:20:18.457Z,1463606418.457 [BuoyancyServo] No Fault, FailCount= 1
2016-05-18T21:20:18.678Z,1463606418.678 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:18.684Z,1463606418.684 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:18.697Z,1463606418.697 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2016-05-18T21:20:18.697Z,1463606418.697 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2016-05-18T21:20:19.088Z,1463606419.088 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:20:19.223Z,1463606419.223 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:19.233Z,1463606419.233 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:19.572Z,1463606419.572 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2016-05-18T21:20:19.573Z,1463606419.573 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2016-05-18T21:20:19.573Z,1463606419.573 [BuoyancyServo] Communications Fault, FailCount= 2
2016-05-18T21:20:19.573Z,1463606419.573 [BuoyancyServo](ERROR): Communications Fault
2016-05-18T21:20:19.605Z,1463606419.605 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2016-05-18T21:20:19.933Z,1463606419.933 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:19.934Z,1463606419.934 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:19.955Z,1463606419.955 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2016-05-18T21:20:19.955Z,1463606419.955 [BuoyancyServo](INFO): Powering down
2016-05-18T21:20:20.070Z,1463606420.070 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:20.071Z,1463606420.071 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:20.486Z,1463606420.486 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:20.487Z,1463606420.487 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:20.674Z,1463606420.674 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:20:20.876Z,1463606420.876 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:20.877Z,1463606420.877 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:21.366Z,1463606421.366 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:21.376Z,1463606421.376 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:21.616Z,1463606421.616 [AcousticModem_Benthos_ATM900](DEBUG): 
2016-05-18T21:20:21.657Z,1463606421.657 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:21.658Z,1463606421.658 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:22.224Z,1463606422.224 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:22.238Z,1463606422.238 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:22.269Z,1463606422.269 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:20:22.292Z,1463606422.292 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2016-05-18T21:20:22.292Z,1463606422.292 [BuoyancyServo] No Fault, FailCount= 2
2016-05-18T21:20:22.475Z,1463606422.475 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:22.476Z,1463606422.476 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:22.498Z,1463606422.498 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2016-05-18T21:20:22.499Z,1463606422.499 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2016-05-18T21:20:22.820Z,1463606422.820 [AcousticModem_Benthos_ATM900](DEBUG): Teledyne Benthos ATM-900 Series OEM w/burn wire
2016-05-18T21:20:22.820Z,1463606422.820 [AcousticModem_Benthos_ATM900](DEBUG): MF Frequency Band
2016-05-18T21:20:22.821Z,1463606422.821 [AcousticModem_Benthos_ATM900](DEBUG): Standard version 8.6.3
2016-05-18T21:20:22.862Z,1463606422.862 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:22.863Z,1463606422.863 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:23.220Z,1463606423.220 [AcousticModem_Benthos_ATM900](DEBUG): May 18 2016 21:11:46 
2016-05-18T21:20:23.298Z,1463606423.298 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:23.299Z,1463606423.299 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:23.706Z,1463606423.706 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:23.715Z,1463606423.715 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:23.855Z,1463606423.855 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:20:24.016Z,1463606424.016 [AcousticModem_Benthos_ATM900](INFO): entering command mode
2016-05-18T21:20:24.071Z,1463606424.071 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:24.073Z,1463606424.073 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:24.417Z,1463606424.417 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2016-05-18T21:20:24.512Z,1463606424.512 [PNI_TCM](ERROR): No parameter response UART error: serial timeout
2016-05-18T21:20:24.512Z,1463606424.512 [PNI_TCM](ERROR): Received 0x4815
2016-05-18T21:20:24.813Z,1463606424.813 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:24.820Z,1463606424.820 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:25.063Z,1463606425.063 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2016-05-18T21:20:25.067Z,1463606425.067 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt 1: user:1>
2016-05-18T21:20:25.068Z,1463606425.068 [AcousticModem_Benthos_ATM900](INFO): command mode acknowledged
2016-05-18T21:20:25.382Z,1463606425.382 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:25.396Z,1463606425.396 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:25.468Z,1463606425.468 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:20:25.780Z,1463606425.780 [AcousticModem_Benthos_ATM900](INFO): setting local address to 3
2016-05-18T21:20:26.174Z,1463606426.174 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:26.213Z,1463606426.213 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:26.643Z,1463606426.643 [AcousticModem_Benthos_ATM900](DEBUG): checking for local address setting acknowledgment
2016-05-18T21:20:26.657Z,1463606426.657 [AcousticModem_Benthos_ATM900](INFO): set local address to 3
2016-05-18T21:20:27.059Z,1463606427.059 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:20:27.860Z,1463606427.860 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:27.883Z,1463606427.883 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:20:27.898Z,1463606427.898 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:28.266Z,1463606428.266 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt 2: user:2>
2016-05-18T21:20:28.407Z,1463606428.407 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:28.408Z,1463606428.408 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:28.531Z,1463606428.531 [NAL9602](INFO): NAL9602 initialized
2016-05-18T21:20:28.615Z,1463606428.615 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:28.616Z,1463606428.616 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:28.695Z,1463606428.695 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:20:29.304Z,1463606429.304 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:29.305Z,1463606429.305 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:29.841Z,1463606429.841 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:29.873Z,1463606429.873 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:30.198Z,1463606430.198 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:20:31.410Z,1463606431.410 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:31.441Z,1463606431.441 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:31.808Z,1463606431.808 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:20:31.909Z,1463606431.909 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:31.910Z,1463606431.910 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:32.568Z,1463606432.568 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:32.570Z,1463606432.570 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:32.791Z,1463606432.791 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:32.792Z,1463606432.792 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:33.397Z,1463606433.397 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:20:33.617Z,1463606433.617 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:33.636Z,1463606433.636 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:34.239Z,1463606434.239 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:20:34.745Z,1463606434.745 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:34.746Z,1463606434.746 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:35.240Z,1463606435.240 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:35.253Z,1463606435.253 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:35.398Z,1463606435.398 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-05-18T21:20:35.398Z,1463606435.398 [PNI_TCM] Data Fault, FailCount= 1
2016-05-18T21:20:35.398Z,1463606435.398 [PNI_TCM](ERROR): Data Fault
2016-05-18T21:20:35.429Z,1463606435.429 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:35.430Z,1463606435.430 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:35.509Z,1463606435.509 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-05-18T21:20:35.828Z,1463606435.828 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:20:35.939Z,1463606435.939 [PNI_TCM](INFO): Powering down
2016-05-18T21:20:35.945Z,1463606435.945 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:35.959Z,1463606435.959 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:36.183Z,1463606436.183 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:36.184Z,1463606436.184 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:36.635Z,1463606436.635 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:20:36.778Z,1463606436.778 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:36.797Z,1463606436.797 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:37.357Z,1463606437.357 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:37.363Z,1463606437.363 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:37.596Z,1463606437.596 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-05-18T21:20:37.596Z,1463606437.596 [PNI_TCM] No Fault, FailCount= 1
2016-05-18T21:20:38.040Z,1463606438.040 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:38.063Z,1463606438.063 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:38.228Z,1463606438.228 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:20:38.681Z,1463606438.681 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:38.884Z,1463606438.884 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:39.765Z,1463606439.765 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:39.779Z,1463606439.779 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:39.827Z,1463606439.827 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:20:40.781Z,1463606440.781 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:40.803Z,1463606440.803 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:41.315Z,1463606441.315 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:41.337Z,1463606441.337 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:41.425Z,1463606441.425 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:20:42.140Z,1463606442.140 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:42.159Z,1463606442.159 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:42.711Z,1463606442.711 [BPC1](ERROR): Failed to parse bank A battery data
2016-05-18T21:20:42.711Z,1463606442.711 [BPC1] Data Fault, FailCount= 1
2016-05-18T21:20:42.711Z,1463606442.711 [BPC1](ERROR): Data Fault
2016-05-18T21:20:42.889Z,1463606442.889 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:42.907Z,1463606442.907 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:43.015Z,1463606443.015 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:20:43.244Z,1463606443.244 [CBIT](ERROR): Data Fault in component: BPC1
2016-05-18T21:20:43.715Z,1463606443.715 [PNI_TCM](ERROR): No parameter response UART error: serial timeout
2016-05-18T21:20:43.716Z,1463606443.716 [PNI_TCM](ERROR): Received 0xFF00
2016-05-18T21:20:43.787Z,1463606443.787 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:43.810Z,1463606443.810 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:44.398Z,1463606444.398 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:44.437Z,1463606444.437 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:44.609Z,1463606444.609 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:20:45.383Z,1463606445.383 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:45.398Z,1463606445.398 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:45.616Z,1463606445.616 [CBIT](INFO): Clearing failed state for component BPC1
2016-05-18T21:20:45.633Z,1463606445.633 [BPC1] No Fault, FailCount= 1
2016-05-18T21:20:46.210Z,1463606446.210 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:20:46.898Z,1463606446.898 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:46.916Z,1463606446.916 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:47.799Z,1463606447.799 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:20:47.818Z,1463606447.818 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:47.849Z,1463606447.849 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:48.728Z,1463606448.728 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:48.758Z,1463606448.758 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:49.385Z,1463606449.385 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:20:49.653Z,1463606449.653 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:49.704Z,1463606449.704 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:50.531Z,1463606450.531 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:50.567Z,1463606450.567 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:50.000Z,1463606451.000 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:20:51.348Z,1463606451.348 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:51.529Z,1463606451.529 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:52.377Z,1463606452.377 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:52.391Z,1463606452.391 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:52.596Z,1463606452.596 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:20:53.419Z,1463606453.419 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:53.470Z,1463606453.470 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:54.180Z,1463606454.180 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:54.189Z,1463606454.189 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:20:54.217Z,1463606454.217 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:54.873Z,1463606454.873 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-05-18T21:20:54.873Z,1463606454.873 [PNI_TCM] Data Fault, FailCount= 2
2016-05-18T21:20:54.874Z,1463606454.874 [PNI_TCM](ERROR): Data Fault
2016-05-18T21:20:55.076Z,1463606455.076 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:55.090Z,1463606455.090 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:55.277Z,1463606455.277 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-05-18T21:20:55.688Z,1463606455.688 [PNI_TCM](INFO): Powering down
2016-05-18T21:20:55.788Z,1463606455.788 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:20:55.855Z,1463606455.855 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:55.871Z,1463606455.871 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:56.401Z,1463606456.401 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:56.403Z,1463606456.403 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:57.259Z,1463606457.259 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:57.278Z,1463606457.278 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:57.382Z,1463606457.382 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:20:57.531Z,1463606457.531 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-05-18T21:20:57.531Z,1463606457.531 [PNI_TCM] No Fault, FailCount= 2
2016-05-18T21:20:58.185Z,1463606458.185 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:58.199Z,1463606458.199 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:58.855Z,1463606458.855 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:58.873Z,1463606458.873 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:58.978Z,1463606458.978 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:20:59.800Z,1463606459.800 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:20:59.934Z,1463606459.934 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:20:59.953Z,1463606459.953 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:00.598Z,1463606460.598 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:00.670Z,1463606460.670 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:01.388Z,1463606461.388 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:01.459Z,1463606461.459 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:01.499Z,1463606461.499 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:02.260Z,1463606462.260 [PNI_TCM](ERROR): No parameter response UART error: serial timeout
2016-05-18T21:21:02.261Z,1463606462.261 [PNI_TCM](ERROR): Received 0xFD00
2016-05-18T21:21:02.393Z,1463606462.393 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:02.428Z,1463606462.428 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:02.984Z,1463606462.984 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:03.623Z,1463606463.623 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:03.657Z,1463606463.657 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:04.580Z,1463606464.580 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:04.699Z,1463606464.699 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:04.721Z,1463606464.721 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:05.587Z,1463606465.587 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:05.629Z,1463606465.629 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:06.178Z,1463606466.178 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:06.348Z,1463606466.348 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:06.383Z,1463606466.383 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:07.315Z,1463606467.315 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:07.329Z,1463606467.329 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:07.766Z,1463606467.766 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:08.180Z,1463606468.180 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:08.181Z,1463606468.181 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:09.069Z,1463606469.069 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:09.088Z,1463606469.088 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:09.356Z,1463606469.356 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:10.169Z,1463606470.169 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:10.209Z,1463606470.209 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:10.952Z,1463606470.952 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:11.133Z,1463606471.133 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:11.147Z,1463606471.147 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:11.762Z,1463606471.762 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:11.798Z,1463606471.798 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:12.545Z,1463606472.545 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:12.972Z,1463606472.972 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:13.005Z,1463606473.005 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:13.710Z,1463606473.710 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-05-18T21:21:13.711Z,1463606473.711 [PNI_TCM] Data Fault, FailCount= 3
2016-05-18T21:21:13.711Z,1463606473.711 [PNI_TCM](ERROR): Data Fault
2016-05-18T21:21:13.956Z,1463606473.956 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:14.007Z,1463606474.007 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:14.136Z,1463606474.136 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:14.577Z,1463606474.577 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-05-18T21:21:15.014Z,1463606475.014 [PNI_TCM](INFO): Powering down
2016-05-18T21:21:15.178Z,1463606475.178 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:15.208Z,1463606475.208 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:15.730Z,1463606475.730 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:16.215Z,1463606476.216 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:16.259Z,1463606476.259 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:17.329Z,1463606477.329 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:18.292Z,1463606478.292 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:18.315Z,1463606478.315 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:18.813Z,1463606478.813 [SBIT](IMPORTANT): Beginning Startup BIT
2016-05-18T21:21:18.815Z,1463606478.815 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-05-18T21:21:18.815Z,1463606478.815 [PNI_TCM] No Fault, FailCount= 3
2016-05-18T21:21:18.844Z,1463606478.844 [CBIT](IMPORTANT): Beginning GF scan
2016-05-18T21:21:18.949Z,1463606478.949 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:19.741Z,1463606479.741 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:19.796Z,1463606479.796 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:20.538Z,1463606480.538 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:21.109Z,1463606481.109 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:21.167Z,1463606481.167 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:22.128Z,1463606482.128 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:22.580Z,1463606482.580 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:22.611Z,1463606482.611 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:23.719Z,1463606483.719 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:24.028Z,1463606484.028 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:24.051Z,1463606484.051 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:25.322Z,1463606485.322 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:25.673Z,1463606485.673 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:25.696Z,1463606485.696 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:26.791Z,1463606486.791 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:26.807Z,1463606486.807 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:26.911Z,1463606486.911 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:27.845Z,1463606487.845 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:27.868Z,1463606487.868 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:28.503Z,1463606488.503 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:28.748Z,1463606488.748 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:28.771Z,1463606488.771 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:29.752Z,1463606489.752 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:29.771Z,1463606489.771 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:30.100Z,1463606490.100 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:30.635Z,1463606490.635 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:30.668Z,1463606490.668 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:31.703Z,1463606491.703 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:31.718Z,1463606491.718 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:31.733Z,1463606491.733 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:31.979Z,1463606491.979 [SBIT](FAULT): Mass: EXPECTED:0.017000 ACTUAL:0.016441
2016-05-18T21:21:32.494Z,1463606492.494 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:32.495Z,1463606492.495 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:33.265Z,1463606493.265 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:33.284Z,1463606493.284 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:33.294Z,1463606493.294 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:34.396Z,1463606494.396 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:34.401Z,1463606494.401 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:34.884Z,1463606494.884 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:35.167Z,1463606495.167 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:35.199Z,1463606495.199 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:35.762Z,1463606495.762 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2016-05-18T21:21:35.771Z,1463606495.771 [PNI_TCM] Data Fault, FailCount= 4
2016-05-18T21:21:35.771Z,1463606495.771 [PNI_TCM](ERROR): Data Fault
2016-05-18T21:21:35.921Z,1463606495.921 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:35.922Z,1463606495.922 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:36.461Z,1463606496.461 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-05-18T21:21:36.474Z,1463606496.474 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:36.961Z,1463606496.961 [PNI_TCM](INFO): Powering down
2016-05-18T21:21:37.058Z,1463606497.058 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:37.060Z,1463606497.060 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:38.076Z,1463606498.076 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:38.580Z,1463606498.580 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:38.581Z,1463606498.581 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:39.342Z,1463606499.342 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:39.343Z,1463606499.343 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:39.664Z,1463606499.664 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:39.810Z,1463606499.810 [CBIT](INFO): Clearing failed state for component PNI_TCM
2016-05-18T21:21:39.811Z,1463606499.811 [PNI_TCM] No Fault, FailCount= 4
2016-05-18T21:21:40.454Z,1463606500.454 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:40.468Z,1463606500.468 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:41.241Z,1463606501.241 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:41.242Z,1463606501.242 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:41.256Z,1463606501.256 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:42.384Z,1463606502.384 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:42.412Z,1463606502.412 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:42.844Z,1463606502.844 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:43.368Z,1463606503.368 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:43.390Z,1463606503.390 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:44.272Z,1463606504.272 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:44.273Z,1463606504.273 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:44.446Z,1463606504.446 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:45.031Z,1463606505.031 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:45.046Z,1463606505.046 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:45.793Z,1463606505.793 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:45.802Z,1463606505.802 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:46.118Z,1463606506.118 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:46.460Z,1463606506.460 [PNI_TCM](ERROR): No parameter response UART error: serial timeout
2016-05-18T21:21:46.461Z,1463606506.461 [PNI_TCM](ERROR): Received 0x6D01FF00
2016-05-18T21:21:46.558Z,1463606506.558 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:46.640Z,1463606506.640 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:47.406Z,1463606507.406 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:47.435Z,1463606507.435 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:47.705Z,1463606507.705 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:47.737Z,1463606507.737 [CBIT](IMPORTANT): No ground fault detected
2016-05-18T21:21:48.183Z,1463606508.183 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:48.184Z,1463606508.184 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:48.373Z,1463606508.373 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:48.386Z,1463606508.386 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:48.956Z,1463606508.956 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:48.957Z,1463606508.957 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:49.153Z,1463606509.153 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:49.154Z,1463606509.154 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:49.309Z,1463606509.309 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:49.965Z,1463606509.965 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:49.966Z,1463606509.966 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:50.901Z,1463606510.901 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:50.947Z,1463606510.947 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:50.980Z,1463606510.980 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:51.979Z,1463606511.979 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:52.005Z,1463606512.005 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:52.495Z,1463606512.495 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:52.939Z,1463606512.939 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:52.954Z,1463606512.954 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:53.937Z,1463606513.937 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:53.950Z,1463606513.950 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:54.085Z,1463606514.085 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:54.910Z,1463606514.910 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:54.911Z,1463606514.911 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:55.670Z,1463606515.670 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:56.369Z,1463606516.369 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:56.413Z,1463606516.413 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:57.259Z,1463606517.259 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:21:57.567Z,1463606517.567 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2016-05-18T21:21:57.567Z,1463606517.567 [PNI_TCM] Data Fault, FailCount= 5
2016-05-18T21:21:57.567Z,1463606517.567 [PNI_TCM](ERROR): Data Fault
2016-05-18T21:21:57.623Z,1463606517.623 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:57.683Z,1463606517.683 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:57.946Z,1463606517.946 [CBIT](ERROR): Data Fault in component: PNI_TCM
2016-05-18T21:21:57.947Z,1463606517.947 [CBIT](CRITICAL): Data Fault in component: PNI_TCM
2016-05-18T21:21:58.436Z,1463606518.436 [PNI_TCM](INFO): Powering down
2016-05-18T21:21:58.709Z,1463606518.709 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:58.731Z,1463606518.731 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:21:58.853Z,1463606518.853 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:22:00.031Z,1463606520.031 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:22:00.162Z,1463606520.162 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:22:00.443Z,1463606520.443 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:22:00.989Z,1463606520.989 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:22:01.013Z,1463606521.013 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:22:02.034Z,1463606522.034 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:22:02.169Z,1463606522.169 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:22:02.170Z,1463606522.170 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:22:02.629Z,1463606522.629 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:22:02.630Z,1463606522.630 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:22:03.293Z,1463606523.293 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:22:03.310Z,1463606523.310 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:22:03.622Z,1463606523.622 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:22:03.636Z,1463606523.636 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:22:03.637Z,1463606523.637 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:22:05.077Z,1463606525.077 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:22:05.090Z,1463606525.090 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:22:05.211Z,1463606525.211 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:22:06.025Z,1463606526.025 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:22:06.027Z,1463606526.027 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:22:06.546Z,1463606526.546 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:22:06.605Z,1463606526.605 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:22:06.799Z,1463606526.799 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:22:06.883Z,1463606526.883 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:22:06.884Z,1463606526.884 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:22:07.690Z,1463606527.690 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:22:07.742Z,1463606527.742 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:22:08.390Z,1463606528.390 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:22:09.248Z,1463606529.248 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:22:09.249Z,1463606529.249 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:22:09.993Z,1463606529.993 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:22:10.553Z,1463606530.553 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:22:10.580Z,1463606530.580 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:22:11.596Z,1463606531.596 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:22:11.606Z,1463606531.606 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:22:11.748Z,1463606531.748 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:22:13.205Z,1463606533.205 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:22:13.220Z,1463606533.220 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:22:13.252Z,1463606533.252 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:22:14.812Z,1463606534.812 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:22:16.328Z,1463606536.328 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2016-05-18T21:22:16.328Z,1463606536.328 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2016-05-18T21:22:16.329Z,1463606536.329 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-05-18T21:22:16.408Z,1463606536.408 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:22:16.412Z,1463606536.412 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2016-05-18T21:22:16.413Z,1463606536.413 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2016-05-18T21:22:16.434Z,1463606536.434 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2016-05-18T21:22:17.089Z,1463606537.089 [SBIT](CRITICAL): SBIT FAILED
2016-05-18T21:22:17.447Z,1463606537.447 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-05-18T21:22:17.473Z,1463606537.473 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2016-05-18T21:22:18.015Z,1463606538.015 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:22:18.034Z,1463606538.034 [MissionManager](IMPORTANT): Started mission Startup
2016-05-18T21:22:18.036Z,1463606538.036 [Startup] Running Loop=1
2016-05-18T21:22:18.053Z,1463606538.053 [Startup](DEBUG): Aggregate::initialize Startup
2016-05-18T21:22:18.054Z,1463606538.054 [Startup:A.GoToSurface] Running Loop=1
2016-05-18T21:22:18.054Z,1463606538.054 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2016-05-18T21:22:18.086Z,1463606538.086 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2016-05-18T21:22:18.112Z,1463606538.112 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2016-05-18T21:22:18.114Z,1463606538.114 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2016-05-18T21:22:18.126Z,1463606538.126 [Startup:A.GoToSurface](DEBUG): No pitch timeout specified. Using default value of 20.000000 seconds.
2016-05-18T21:22:18.149Z,1463606538.149 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2016-05-18T21:22:18.362Z,1463606538.362 [Startup:StartupSatComms] Running Loop=1
2016-05-18T21:22:18.362Z,1463606538.362 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2016-05-18T21:22:18.362Z,1463606538.362 [Startup:StartupSatComms:A] Running Loop=1
2016-05-18T21:22:18.463Z,1463606538.463 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-05-18T21:22:18.464Z,1463606538.464 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2016-05-18T21:22:18.483Z,1463606538.483 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2016-05-18T21:22:18.484Z,1463606538.484 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2016-05-18T21:22:19.615Z,1463606539.615 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:22:20.037Z,1463606540.037 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-05-18T21:22:20.057Z,1463606540.057 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-05-18T21:22:20.058Z,1463606540.058 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-05-18T21:22:20.085Z,1463606540.085 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2016-05-18T21:22:20.109Z,1463606540.109 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2016-05-18T21:22:20.111Z,1463606540.111 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2016-05-18T21:22:20.249Z,1463606540.249 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2016-05-18T21:22:21.203Z,1463606541.203 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:22:22.817Z,1463606542.817 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:22:24.424Z,1463606544.424 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:22:26.021Z,1463606546.021 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:22:27.653Z,1463606547.653 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:22:29.271Z,1463606549.271 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:22:30.867Z,1463606550.867 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:22:32.039Z,1463606552.039 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:22:33.631Z,1463606553.631 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:22:34.835Z,1463606554.835 [CommandLine](IMPORTANT): got command quit
2016-05-18T21:22:35.246Z,1463606555.246 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:22:35.856Z,1463606555.856 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2016-05-18T21:22:35.857Z,1463606555.857 [CommandLine ThreadHandler](INFO): Thread cancelled.
2016-05-18T21:22:35.861Z,1463606555.861 [CommandLine](INFO): Join timeout helper Thread ID is 1677
2016-05-18T21:22:35.863Z,1463606555.863 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2016-05-18T21:22:35.865Z,1463606555.865 [CommandLine ThreadHandler](INFO): Thread cancelled.
2016-05-18T21:22:35.953Z,1463606555.953 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2016-05-18T21:22:35.954Z,1463606555.954 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2016-05-18T21:22:35.965Z,1463606555.965 [NavChartDb](INFO): Join timeout helper Thread ID is 1678
2016-05-18T21:22:36.859Z,1463606556.859 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:22:38.456Z,1463606558.456 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:22:39.913Z,1463606559.913 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:22:41.503Z,1463606561.503 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:22:43.089Z,1463606563.089 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:22:43.920Z,1463606563.920 [Rowe_600LCM](INFO): Runnable
2016-05-18T21:22:45.119Z,1463606565.119 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2016-05-18T21:22:45.120Z,1463606565.120 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2016-05-18T21:22:45.126Z,1463606565.126 [ComponentRegistry](INFO): Shutting down Rowe_600LCM ThreadHandler
2016-05-18T21:22:45.126Z,1463606565.126 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled.
2016-05-18T21:22:45.127Z,1463606565.127 [Rowe_600LCM](INFO): Join timeout helper Thread ID is 1679
2016-05-18T21:22:45.537Z,1463606565.537 [Rowe_600LCM ThreadHandler](INFO): Uninitializing protected caller thread.
2016-05-18T21:22:45.538Z,1463606565.538 [Rowe_600LCM](INFO): uninitialize
2016-05-18T21:22:45.544Z,1463606565.544 [Rowe_600LCM](INFO): Powering down
2016-05-18T21:22:45.554Z,1463606565.554 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled.
2016-05-18T21:22:45.557Z,1463606565.557 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2016-05-18T21:22:45.557Z,1463606565.557 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2016-05-18T21:22:45.559Z,1463606565.559 [Radio_Surface](INFO): Join timeout helper Thread ID is 1680
2016-05-18T21:22:45.948Z,1463606565.948 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2016-05-18T21:22:45.948Z,1463606565.948 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2016-05-18T21:22:45.955Z,1463606565.955 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2016-05-18T21:22:45.956Z,1463606565.956 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2016-05-18T21:22:45.956Z,1463606565.956 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1681
2016-05-18T21:22:46.357Z,1463606566.357 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2016-05-18T21:22:46.358Z,1463606566.358 [WetLabsBB2FL](INFO): Powering down
2016-05-18T21:22:46.358Z,1463606566.358 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2016-05-18T21:22:46.365Z,1463606566.365 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2016-05-18T21:22:46.365Z,1463606566.365 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2016-05-18T21:22:46.366Z,1463606566.366 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 1682
2016-05-18T21:22:46.465Z,1463606566.465 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2016-05-18T21:22:46.465Z,1463606566.465 [CTD_NeilBrown](INFO): Powering down
2016-05-18T21:22:46.466Z,1463606566.466 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2016-05-18T21:22:46.467Z,1463606566.467 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2016-05-18T21:22:46.467Z,1463606566.467 [logger ThreadHandler](INFO): Thread cancelled.
2016-05-18T21:22:46.468Z,1463606566.468 [logger](INFO): Join timeout helper Thread ID is 1683
2016-05-18T21:22:46.484Z,1463606566.484 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2016-05-18T21:22:46.485Z,1463606566.485 [logger ThreadHandler](INFO): Thread cancelled.
2016-05-18T21:22:46.489Z,1463606566.489 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2016-05-18T21:22:46.489Z,1463606566.489 [CommandLine ThreadHandler](INFO): Thread cancelled.
2016-05-18T21:22:46.489Z,1463606566.489 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2016-05-18T21:22:46.489Z,1463606566.489 [controlThread ThreadHandler](INFO): Thread cancelled.
2016-05-18T21:22:46.490Z,1463606566.490 [controlThread](INFO): Join timeout helper Thread ID is 1684
2016-05-18T21:22:49.989Z,1463606569.989 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:22:49.995Z,1463606569.995 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-18T21:22:50.025Z,1463606570.025 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2016-05-18T21:22:50.025Z,1463606570.025 [controlThread](DEBUG): Uninitializing ControlThread
2016-05-18T21:22:50.034Z,1463606570.034 [Aanderaa_O2](INFO): Powering down
2016-05-18T21:22:50.035Z,1463606570.035 [AcousticModem_Benthos_ATM900](INFO): Powering down
2016-05-18T21:22:50.037Z,1463606570.037 [NAL9602](INFO): Powering down
2016-05-18T21:22:50.042Z,1463606570.042 [PNI_TCM](INFO): Powering down
2016-05-18T21:22:50.044Z,1463606570.044 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2016-05-18T21:22:50.045Z,1463606570.045 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2016-05-18T21:22:50.052Z,1463606570.052 [Startup] Stopped
2016-05-18T21:22:50.052Z,1463606570.052 [Startup](DEBUG): Aggregate::uninitialize Startup
2016-05-18T21:22:50.052Z,1463606570.052 [Startup:A.GoToSurface] Stopped
2016-05-18T21:22:50.052Z,1463606570.052 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2016-05-18T21:22:50.052Z,1463606570.052 [Startup:StartupSatComms] Stopped
2016-05-18T21:22:50.052Z,1463606570.052 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2016-05-18T21:22:50.052Z,1463606570.052 [Startup:StartupSatComms:A] Stopped
2016-05-18T21:22:50.058Z,1463606570.058 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2016-05-18T21:22:50.058Z,1463606570.058 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2016-05-18T21:22:50.059Z,1463606570.059 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2016-05-18T21:22:50.059Z,1463606570.059 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2016-05-18T21:22:50.059Z,1463606570.059 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2016-05-18T21:22:50.060Z,1463606570.060 [BuoyancyServo](INFO): Powering down
2016-05-18T21:22:50.078Z,1463606570.078 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2016-05-18T21:22:50.079Z,1463606570.079 [ElevatorServo](INFO): Powering down
2016-05-18T21:22:50.080Z,1463606570.080 [MassServo](DEBUG): Uninitialize Mass Servo.
2016-05-18T21:22:50.080Z,1463606570.080 [MassServo](INFO): Powering down
2016-05-18T21:22:50.080Z,1463606570.080 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2016-05-18T21:22:50.081Z,1463606570.081 [RudderServo](INFO): Powering down
2016-05-18T21:22:50.081Z,1463606570.081 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2016-05-18T21:22:50.082Z,1463606570.082 [ThrusterServo](INFO): Powering down
2016-05-18T21:22:50.082Z,1463606570.082 [SBIT](DEBUG): Uninitialize SBIT Component.
2016-05-18T21:22:50.083Z,1463606570.083 [IBIT](DEBUG): Uninitialize IBIT Component.
2016-05-18T21:22:50.083Z,1463606570.083 [CBIT](DEBUG): Uninitialize CBIT Component.
2016-05-18T21:22:50.115Z,1463606570.115 [controlThread ThreadHandler](INFO): Thread cancelled.
2016-05-18T21:22:50.208Z,1463606570.208 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2016-05-18T21:22:50.213Z,1463606570.213 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2016-05-18T21:22:50.357Z,1463606570.357 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled.
2016-05-18T21:22:50.417Z,1463606570.417 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2016-05-18T21:22:50.567Z,1463606570.567 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2016-05-18T21:22:50.697Z,1463606570.697 [logger ThreadHandler](INFO): Thread cancelled.