2016-09-01T03:25:15.724Z,1472700315.724 [Supervisor](DEBUG): Initializing supervisor. 2016-09-01T03:25:15.727Z,1472700315.727 [SyncHandler](DEBUG): Created PCaller Thread at 4051A4E0 2016-09-01T03:25:15.727Z,1472700315.727 [SyncHandler](INFO): Protected caller Thread ID is 768 2016-09-01T03:25:15.728Z,1472700315.728 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2016-09-01T03:25:15.729Z,1472700315.729 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4054A4E0 2016-09-01T03:25:15.729Z,1472700315.729 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 769 2016-09-01T03:25:15.732Z,1472700315.732 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2016-09-01T03:25:15.744Z,1472700315.744 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2016-09-01T03:25:15.745Z,1472700315.745 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 4057A4E0 2016-09-01T03:25:15.745Z,1472700315.745 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 770 2016-09-01T03:25:15.746Z,1472700315.746 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2016-09-01T03:25:15.747Z,1472700315.747 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405AA4E0 2016-09-01T03:25:15.748Z,1472700315.747 [logger ThreadHandler](INFO): Protected caller Thread ID is 771 2016-09-01T03:25:15.749Z,1472700315.750 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2016-09-01T03:25:15.750Z,1472700315.750 [Supervisor](INFO): Looking for Config files in directory: Config/ 2016-09-01T03:25:15.755Z,1472700315.755 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2016-09-01T03:25:15.841Z,1472700315.841 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2016-09-01T03:25:16.178Z,1472700316.178 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2016-09-01T03:25:16.179Z,1472700316.179 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2016-09-01T03:25:16.306Z,1472700316.306 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2016-09-01T03:25:16.306Z,1472700316.306 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2016-09-01T03:25:16.496Z,1472700316.497 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2016-09-01T03:25:16.499Z,1472700316.499 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2016-09-01T03:25:16.603Z,1472700316.603 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2016-09-01T03:25:16.604Z,1472700316.604 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2016-09-01T03:25:16.785Z,1472700316.786 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2016-09-01T03:25:16.788Z,1472700316.788 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2016-09-01T03:25:17.276Z,1472700317.276 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2016-09-01T03:25:17.277Z,1472700317.277 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2016-09-01T03:25:17.558Z,1472700317.558 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2016-09-01T03:25:17.559Z,1472700317.559 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2016-09-01T03:25:17.646Z,1472700317.646 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2016-09-01T03:25:17.648Z,1472700317.648 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2016-09-01T03:25:17.781Z,1472700317.781 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2016-09-01T03:25:17.782Z,1472700317.782 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2016-09-01T03:25:17.990Z,1472700317.990 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2016-09-01T03:25:17.991Z,1472700317.991 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2016-09-01T03:25:18.431Z,1472700318.431 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2016-09-01T03:25:18.431Z,1472700318.431 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2016-09-01T03:25:23.240Z,1472700323.240 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2016-09-01T03:25:23.240Z,1472700323.240 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2016-09-01T03:25:23.567Z,1472700323.568 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2016-09-01T03:25:23.568Z,1472700323.568 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2016-09-01T03:25:23.719Z,1472700323.719 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2016-09-01T03:25:23.721Z,1472700323.721 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/ 2016-09-01T03:25:23.725Z,1472700323.725 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Control.cfg 2016-09-01T03:25:23.826Z,1472700323.826 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Navigation.cfg 2016-09-01T03:25:23.923Z,1472700323.922 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/secure.cfg 2016-09-01T03:25:24.012Z,1472700324.012 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/BIT.cfg 2016-09-01T03:25:24.116Z,1472700324.115 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Simulator.cfg 2016-09-01T03:25:24.206Z,1472700324.206 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Science.cfg 2016-09-01T03:25:24.353Z,1472700324.353 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/logger.cfg 2016-09-01T03:25:24.454Z,1472700324.454 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/vehicle.cfg 2016-09-01T03:25:24.625Z,1472700324.625 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Battery.cfg 2016-09-01T03:25:24.858Z,1472700324.858 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2016-09-01T03:25:24.859Z,1472700324.859 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Sensor.cfg 2016-09-01T03:25:25.038Z,1472700325.038 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Servo.cfg 2016-09-01T03:25:25.146Z,1472700325.146 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2016-09-01T03:25:25.149Z,1472700325.149 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2016-09-01T03:25:25.191Z,1472700325.191 [DepthRateCalculator] Loaded 2016-09-01T03:25:25.191Z,1472700325.191 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2016-09-01T03:25:25.198Z,1472700325.197 [PitchRateCalculator] Loaded 2016-09-01T03:25:25.198Z,1472700325.198 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2016-09-01T03:25:25.209Z,1472700325.210 [SpeedCalculator] Loaded 2016-09-01T03:25:25.210Z,1472700325.210 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2016-09-01T03:25:25.226Z,1472700325.226 [TempGradientCalculator] Loaded 2016-09-01T03:25:25.226Z,1472700325.226 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2016-09-01T03:25:25.243Z,1472700325.243 [VerticalTemperatureHomogeneityIndexCalculator] Loaded 2016-09-01T03:25:25.243Z,1472700325.243 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread. 2016-09-01T03:25:25.249Z,1472700325.249 [YawRateCalculator] Loaded 2016-09-01T03:25:25.249Z,1472700325.249 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2016-09-01T03:25:25.250Z,1472700325.250 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2016-09-01T03:25:25.250Z,1472700325.250 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2016-09-01T03:25:25.374Z,1472700325.374 [DeadReckonUsingMultipleVelocitySources] Loaded 2016-09-01T03:25:25.374Z,1472700325.374 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2016-09-01T03:25:25.430Z,1472700325.430 [DeadReckonUsingSpeedCalculator] Loaded 2016-09-01T03:25:25.430Z,1472700325.430 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2016-09-01T03:25:25.447Z,1472700325.447 [NavChart] Loaded 2016-09-01T03:25:25.448Z,1472700325.448 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2016-09-01T03:25:25.452Z,1472700325.452 [UniversalFixResidualReporter] Loaded 2016-09-01T03:25:25.452Z,1472700325.453 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2016-09-01T03:25:25.453Z,1472700325.453 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2016-09-01T03:25:25.454Z,1472700325.454 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2016-09-01T03:25:25.595Z,1472700325.595 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2016-09-01T03:25:25.596Z,1472700325.596 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2016-09-01T03:25:25.637Z,1472700325.637 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2016-09-01T03:25:25.638Z,1472700325.638 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2016-09-01T03:25:25.647Z,1472700325.647 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2016-09-01T03:25:25.648Z,1472700325.648 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2016-09-01T03:25:25.925Z,1472700325.925 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2016-09-01T03:25:25.926Z,1472700325.926 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2016-09-01T03:25:26.075Z,1472700326.076 [SBIT](DEBUG): Construct Startup Built In Test. 2016-09-01T03:25:26.107Z,1472700326.107 [SBIT] Loaded 2016-09-01T03:25:26.108Z,1472700326.108 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2016-09-01T03:25:26.108Z,1472700326.109 [IBIT](DEBUG): Construct Initiated Built In Test. 2016-09-01T03:25:26.137Z,1472700326.137 [IBIT] Loaded 2016-09-01T03:25:26.137Z,1472700326.137 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2016-09-01T03:25:26.141Z,1472700326.141 [CBIT](DEBUG): Construct Continuous Built In Test. 2016-09-01T03:25:26.295Z,1472700326.295 [CBIT] Loaded 2016-09-01T03:25:26.295Z,1472700326.295 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2016-09-01T03:25:26.296Z,1472700326.296 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2016-09-01T03:25:26.296Z,1472700326.296 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2016-09-01T03:25:26.916Z,1472700326.916 [DataOverHttps] Loaded 2016-09-01T03:25:26.916Z,1472700326.916 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread. 2016-09-01T03:25:26.943Z,1472700326.943 [Depth_Keller] Loaded 2016-09-01T03:25:26.943Z,1472700326.943 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2016-09-01T03:25:27.037Z,1472700327.037 [NAL9602] Loaded 2016-09-01T03:25:27.038Z,1472700327.038 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2016-09-01T03:25:27.048Z,1472700327.048 [Onboard] Loaded 2016-09-01T03:25:27.048Z,1472700327.048 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2016-09-01T03:25:27.056Z,1472700327.056 [Radio_Surface] Loaded 2016-09-01T03:25:27.056Z,1472700327.056 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2016-09-01T03:25:27.057Z,1472700327.057 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409234E0 2016-09-01T03:25:27.058Z,1472700327.057 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 851 2016-09-01T03:25:27.252Z,1472700327.252 [PNI_TCM] Loaded 2016-09-01T03:25:27.252Z,1472700327.252 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread. 2016-09-01T03:25:27.611Z,1472700327.611 [Rowe_600LCM] Loaded 2016-09-01T03:25:27.611Z,1472700327.611 [ComponentRegistry](DEBUG): Component "Rowe_600LCM" handled in its own thread. 2016-09-01T03:25:27.613Z,1472700327.612 [Rowe_600LCM ThreadHandler](DEBUG): Created PCaller Thread at 409534E0 2016-09-01T03:25:27.613Z,1472700327.613 [Rowe_600LCM ThreadHandler](INFO): Protected caller Thread ID is 852 2016-09-01T03:25:29.469Z,1472700329.469 [BPC1] Loaded 2016-09-01T03:25:29.470Z,1472700329.470 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2016-09-01T03:25:29.470Z,1472700329.470 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2016-09-01T03:25:29.471Z,1472700329.471 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2016-09-01T03:25:31.408Z,1472700331.408 [BuoyancyServo] Loaded 2016-09-01T03:25:31.409Z,1472700331.409 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2016-09-01T03:25:31.425Z,1472700331.425 [ElevatorServo] Loaded 2016-09-01T03:25:31.425Z,1472700331.425 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2016-09-01T03:25:31.441Z,1472700331.441 [MassServo] Loaded 2016-09-01T03:25:31.441Z,1472700331.441 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2016-09-01T03:25:31.458Z,1472700331.458 [RudderServo] Loaded 2016-09-01T03:25:31.458Z,1472700331.458 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2016-09-01T03:25:31.473Z,1472700331.473 [ThrusterServo] Loaded 2016-09-01T03:25:31.474Z,1472700331.474 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2016-09-01T03:25:31.474Z,1472700331.474 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2016-09-01T03:25:31.475Z,1472700331.475 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2016-09-01T03:25:31.544Z,1472700331.544 [VerticalControl](DEBUG): Construct VerticalControl. 2016-09-01T03:25:31.638Z,1472700331.638 [VerticalControl] Loaded 2016-09-01T03:25:31.638Z,1472700331.638 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2016-09-01T03:25:31.639Z,1472700331.639 [HorizontalControl](DEBUG): Construct HorizontalControl. 2016-09-01T03:25:31.701Z,1472700331.701 [HorizontalControl] Loaded 2016-09-01T03:25:31.701Z,1472700331.701 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2016-09-01T03:25:31.702Z,1472700331.702 [SpeedControl](DEBUG): Construct SpeedControl. 2016-09-01T03:25:31.704Z,1472700331.704 [SpeedControl] Loaded 2016-09-01T03:25:31.704Z,1472700331.704 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2016-09-01T03:25:31.705Z,1472700331.705 [LoopControl](DEBUG): Construct LoopControl. 2016-09-01T03:25:31.705Z,1472700331.705 [LoopControl] Loaded 2016-09-01T03:25:31.705Z,1472700331.705 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2016-09-01T03:25:31.706Z,1472700331.706 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2016-09-01T03:25:31.707Z,1472700331.707 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2016-09-01T03:25:31.824Z,1472700331.824 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC 2016-09-01T03:25:31.824Z,1472700331.824 [StratificationFrontDetector](DEBUG): (re)initializing 2016-09-01T03:25:31.824Z,1472700331.824 [StratificationFrontDetector] Loaded 2016-09-01T03:25:31.825Z,1472700331.825 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread. 2016-09-01T03:25:31.825Z,1472700331.825 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2016-09-01T03:25:31.826Z,1472700331.826 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2016-09-01T03:25:31.959Z,1472700331.959 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2016-09-01T03:25:31.963Z,1472700331.963 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2016-09-01T03:25:31.964Z,1472700331.964 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2016-09-01T03:25:31.970Z,1472700331.970 [NavChartDb](CRITICAL): No configuration setting for: NavChartDb.charts 2016-09-01T03:25:31.972Z,1472700331.972 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2016-09-01T03:25:31.973Z,1472700331.973 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A5D4E0 2016-09-01T03:25:31.974Z,1472700331.974 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 853 2016-09-01T03:25:31.979Z,1472700331.979 [Supervisor](INFO): Main Thread ID is 763 2016-09-01T03:25:31.979Z,1472700331.979 [Supervisor](DEBUG): Running supervisor. 2016-09-01T03:25:31.980Z,1472700331.980 [CommandLine ThreadHandler](INFO): Handler Thread ID is 854 2016-09-01T03:25:31.983Z,1472700331.983 [controlThread ThreadHandler](INFO): Handler Thread ID is 855 2016-09-01T03:25:31.983Z,1472700331.983 [controlThread](DEBUG): Initializing ControlThread 2016-09-01T03:25:31.984Z,1472700331.984 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2016-09-01T03:25:31.984Z,1472700331.984 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2016-09-01T03:25:31.985Z,1472700331.985 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2016-09-01T03:25:31.985Z,1472700331.985 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2016-09-01T03:25:31.986Z,1472700331.986 [VerticalTemperatureHomogeneityIndexCalculator](DEBUG): (re)initializing 2016-09-01T03:25:31.986Z,1472700331.986 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2016-09-01T03:25:31.987Z,1472700331.987 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2016-09-01T03:25:31.988Z,1472700331.988 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2016-09-01T03:25:31.988Z,1472700331.988 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2016-09-01T03:25:31.989Z,1472700331.989 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2016-09-01T03:25:31.989Z,1472700331.989 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2016-09-01T03:25:31.989Z,1472700331.989 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2016-09-01T03:25:31.990Z,1472700331.990 [NavChart](DEBUG): Initialize NavChart Navigation. 2016-09-01T03:25:31.990Z,1472700331.990 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2016-09-01T03:25:31.990Z,1472700331.990 [SBIT](INFO): Initialize SBIT Component. 2016-09-01T03:25:31.991Z,1472700331.991 [SBIT](IMPORTANT): git: 2016-06-23-6-gc6c0fb7 2016-09-01T03:25:31.991Z,1472700331.991 [SBIT](INFO): git hash: c6c0fb75a403746acbf2d57d4f50ab749bc4e06e 2016-09-01T03:25:31.993Z,1472700331.993 [SBIT](INFO): Kernel Reporting Different Release From Configuration. Kernel Expected: 2.6.27.8 Kernel Reported: 2.6.27.8-00011-g2bc81df-dirty 2016-09-01T03:25:31.993Z,1472700331.993 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #639 PREEMPT Wed Mar 12 12:53:33 PDT 2014 Kernel Reported: #646 PREEMPT Thu Feb 11 17:01:12 PST 2016 2016-09-01T03:25:31.994Z,1472700331.994 [SBIT](INFO): Beginning SBIT in 20.000000 seconds. 2016-09-01T03:25:31.994Z,1472700331.994 [IBIT](INFO): Initialize IBIT Component. 2016-09-01T03:25:31.996Z,1472700331.996 [CBIT](DEBUG): Initialize CBIT Component. 2016-09-01T03:25:31.996Z,1472700331.996 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL. 2016-09-01T03:25:31.996Z,1472700331.996 [CBIT](CRITICAL): LAST REBOOT DUE TO WATCHDOG TIMER RESET. 2016-09-01T03:25:31.997Z,1472700331.997 [logger ThreadHandler](INFO): Handler Thread ID is 856 2016-09-01T03:25:32.023Z,1472700332.023 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 857 2016-09-01T03:25:32.030Z,1472700332.030 [Radio_Surface](INFO): Powering up 2016-09-01T03:25:32.047Z,1472700332.047 [Rowe_600LCM ThreadHandler](INFO): Handler Thread ID is 858 2016-09-01T03:25:32.048Z,1472700332.048 [Rowe_600LCM](INFO): Initializing 2016-09-01T03:25:32.049Z,1472700332.049 [Rowe_600LCM](INFO): Checking LCM 2016-09-01T03:25:32.049Z,1472700332.049 [Rowe_600LCM](INFO): LCM OK 2016-09-01T03:25:32.049Z,1472700332.049 [Rowe_600LCM](INFO): Powering up 2016-09-01T03:25:32.068Z,1472700332.068 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 859 2016-09-01T03:25:32.075Z,1472700332.075 [NavChartDb](FAULT): Change detected in ENC collection. Wiping NavChart Directory 2016-09-01T03:25:32.086Z,1472700332.086 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2016-09-01T03:25:32.088Z,1472700332.088 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2016-09-01T03:25:32.089Z,1472700332.089 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2016-09-01T03:25:32.090Z,1472700332.089 [LoopControl](DEBUG): Initialize LoopControlComponent. 2016-09-01T03:25:32.091Z,1472700332.091 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2016-09-01T03:25:32.094Z,1472700332.094 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/.000 2016-09-01T03:25:32.106Z,1472700332.106 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from .000 2016-09-01T03:25:32.129Z,1472700332.129 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2016-09-01T03:25:32.144Z,1472700332.144 [MissionManager](DEBUG): 2016-09-01T03:25:32.144Z,1472700332.144 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2016-09-01T03:25:32.194Z,1472700332.194 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2016-09-01T03:25:32.196Z,1472700332.196 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/.000 2016-09-01T03:25:32.196Z,1472700332.196 [Default:A.Wait](DEBUG): Construct Wait. 2016-09-01T03:25:32.198Z,1472700332.198 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2016-09-01T03:25:32.209Z,1472700332.209 [NavChartDb](FAULT): Error opening file: Resources/ElectronicNavigationCharts/.000 2016-09-01T03:25:32.209Z,1472700332.209 [NavChartDb](INFO): # of records loaded: 0 2016-09-01T03:25:32.211Z,1472700332.211 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from .000 2016-09-01T03:25:32.218Z,1472700332.218 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2016-09-01T03:25:32.221Z,1472700332.220 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2016-09-01T03:25:32.250Z,1472700332.250 [Default:E.Execute](DEBUG): Construct Execute. 2016-09-01T03:25:32.254Z,1472700332.254 [MissionManager](DEBUG): 0 Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. 13 Burn 300 Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2016-09-01T03:25:32.271Z,1472700332.271 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,NAL9602,Onboard,PNI_TCM,BPC1,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-09-01T03:25:32.376Z,1472700332.376 [NAL9602](INFO): Powering up NAL9602 2016-09-01T03:25:32.545Z,1472700332.546 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:32.662Z,1472700332.662 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:32.741Z,1472700332.741 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2016-09-01T03:25:32.748Z,1472700332.747 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2016-09-01T03:25:32.754Z,1472700332.754 [ElevatorServo](DEBUG): Initializing EZServoServo. 2016-09-01T03:25:32.760Z,1472700332.760 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2016-09-01T03:25:32.766Z,1472700332.766 [MassServo](DEBUG): Initializing EZServoServo. 2016-09-01T03:25:32.771Z,1472700332.772 [MassServo](DEBUG): Initializing MassServo. 2016-09-01T03:25:32.777Z,1472700332.777 [RudderServo](DEBUG): Initializing EZServoServo. 2016-09-01T03:25:32.784Z,1472700332.783 [RudderServo](DEBUG): Initializing RudderServo. 2016-09-01T03:25:32.789Z,1472700332.789 [ThrusterServo](DEBUG): Initializing EZServoServo. 2016-09-01T03:25:32.796Z,1472700332.796 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2016-09-01T03:25:32.825Z,1472700332.825 [CommandLine](FAULT): Scheduling is paused 2016-09-01T03:25:33.059Z,1472700333.059 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:33.060Z,1472700333.060 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:33.293Z,1472700333.293 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:33.294Z,1472700333.294 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:33.627Z,1472700333.627 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2016-09-01T03:25:33.627Z,1472700333.627 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2016-09-01T03:25:33.627Z,1472700333.628 [BuoyancyServo] Communications Fault, FailCount= 1 2016-09-01T03:25:33.628Z,1472700333.628 [BuoyancyServo](ERROR): Communications Fault 2016-09-01T03:25:33.839Z,1472700333.839 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2016-09-01T03:25:33.883Z,1472700333.883 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:33.884Z,1472700333.884 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:33.890Z,1472700333.890 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2016-09-01T03:25:33.891Z,1472700333.891 [BuoyancyServo](INFO): Powering down 2016-09-01T03:25:34.290Z,1472700334.290 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:34.291Z,1472700334.291 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:34.675Z,1472700334.675 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:34.676Z,1472700334.676 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:35.075Z,1472700335.075 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:35.076Z,1472700335.076 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:35.475Z,1472700335.474 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:35.476Z,1472700335.476 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:35.874Z,1472700335.875 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:35.876Z,1472700335.876 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:35.936Z,1472700335.936 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2016-09-01T03:25:35.936Z,1472700335.936 [BuoyancyServo] No Fault, FailCount= 1 2016-09-01T03:25:36.264Z,1472700336.264 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface 2016-09-01T03:25:36.308Z,1472700336.308 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:36.309Z,1472700336.309 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:36.333Z,1472700336.333 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2016-09-01T03:25:36.334Z,1472700336.334 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2016-09-01T03:25:36.392Z,1472700336.392 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:./bin/roweadcp -dev /dev/ttyB4 -b 38400 >& /dev/null & 2016-09-01T03:25:36.679Z,1472700336.679 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:36.680Z,1472700336.680 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:36.868Z,1472700336.868 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track 2016-09-01T03:25:36.869Z,1472700336.869 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity 2016-09-01T03:25:37.076Z,1472700337.076 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:37.077Z,1472700337.077 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:37.484Z,1472700337.484 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:37.485Z,1472700337.485 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:37.875Z,1472700337.875 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:37.876Z,1472700337.876 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:38.275Z,1472700338.275 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:38.276Z,1472700338.276 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:38.683Z,1472700338.683 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:38.684Z,1472700338.684 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:39.075Z,1472700339.076 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:39.077Z,1472700339.077 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:39.469Z,1472700339.469 [PNI_TCM](FAULT): Failed to set parameters during initialization. 2016-09-01T03:25:39.469Z,1472700339.469 [PNI_TCM] Data Fault, FailCount= 1 2016-09-01T03:25:39.469Z,1472700339.469 [PNI_TCM](ERROR): Data Fault 2016-09-01T03:25:39.475Z,1472700339.475 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:39.476Z,1472700339.476 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:39.516Z,1472700339.516 [BuoyancyServo](CRITICAL): Reading outside of valid range:10864.000000 2016-09-01T03:25:39.516Z,1472700339.516 [BuoyancyServo](FAULT): Buoyancy engine reporting null position 2016-09-01T03:25:39.516Z,1472700339.516 [BuoyancyServo] Hardware Fault, FailCount= 2 2016-09-01T03:25:39.516Z,1472700339.516 [BuoyancyServo](ERROR): Hardware Fault 2016-09-01T03:25:39.549Z,1472700339.549 [CBIT](ERROR): Data Fault in component: PNI_TCM 2016-09-01T03:25:39.549Z,1472700339.549 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo 2016-09-01T03:25:39.869Z,1472700339.869 [PNI_TCM](INFO): Powering down 2016-09-01T03:25:39.984Z,1472700339.984 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:39.985Z,1472700339.985 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:39.998Z,1472700339.998 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2016-09-01T03:25:39.998Z,1472700339.998 [BuoyancyServo](INFO): Powering down 2016-09-01T03:25:40.276Z,1472700340.276 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:40.277Z,1472700340.277 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:40.675Z,1472700340.675 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:40.677Z,1472700340.677 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:41.075Z,1472700341.075 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:41.076Z,1472700341.076 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:41.116Z,1472700341.116 [CBIT](INFO): Clearing failed state for component PNI_TCM 2016-09-01T03:25:41.116Z,1472700341.116 [PNI_TCM] No Fault, FailCount= 1 2016-09-01T03:25:41.496Z,1472700341.496 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:41.497Z,1472700341.497 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:41.875Z,1472700341.875 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:41.876Z,1472700341.876 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:41.932Z,1472700341.932 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2016-09-01T03:25:41.932Z,1472700341.932 [BuoyancyServo] No Fault, FailCount= 2 2016-09-01T03:25:42.306Z,1472700342.306 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:42.307Z,1472700342.307 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:42.327Z,1472700342.327 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2016-09-01T03:25:42.444Z,1472700342.444 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2016-09-01T03:25:42.681Z,1472700342.681 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:42.682Z,1472700342.682 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:43.089Z,1472700343.089 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:43.090Z,1472700343.090 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:43.453Z,1472700343.453 [NAL9602](INFO): NAL9602 initialized 2016-09-01T03:25:43.507Z,1472700343.507 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:43.508Z,1472700343.508 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:43.908Z,1472700343.908 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:43.909Z,1472700343.909 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:44.295Z,1472700344.295 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:44.296Z,1472700344.296 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:44.695Z,1472700344.695 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:44.696Z,1472700344.696 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:45.130Z,1472700345.130 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:45.131Z,1472700345.131 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:45.511Z,1472700345.511 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:45.512Z,1472700345.512 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:45.552Z,1472700345.552 [BuoyancyServo](CRITICAL): Reading outside of valid range:10864.000000 2016-09-01T03:25:45.552Z,1472700345.552 [BuoyancyServo](FAULT): Buoyancy engine reporting null position 2016-09-01T03:25:45.552Z,1472700345.552 [BuoyancyServo] Hardware Fault, FailCount= 3 2016-09-01T03:25:45.552Z,1472700345.552 [BuoyancyServo](ERROR): Hardware Fault 2016-09-01T03:25:45.593Z,1472700345.593 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo 2016-09-01T03:25:45.885Z,1472700345.885 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:45.886Z,1472700345.886 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:45.892Z,1472700345.892 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2016-09-01T03:25:45.893Z,1472700345.893 [BuoyancyServo](INFO): Powering down 2016-09-01T03:25:46.286Z,1472700346.286 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:46.288Z,1472700346.288 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:46.699Z,1472700346.699 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:46.700Z,1472700346.700 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:47.099Z,1472700347.099 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:47.100Z,1472700347.100 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:47.499Z,1472700347.499 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:47.500Z,1472700347.500 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:47.883Z,1472700347.883 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:47.884Z,1472700347.884 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:47.928Z,1472700347.928 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2016-09-01T03:25:47.928Z,1472700347.928 [BuoyancyServo] No Fault, FailCount= 3 2016-09-01T03:25:48.269Z,1472700348.269 [BPC1](ERROR): Failed to receive battery data 2016-09-01T03:25:48.269Z,1472700348.269 [BPC1] Communications Fault, FailCount= 1 2016-09-01T03:25:48.269Z,1472700348.269 [BPC1](ERROR): Communications Fault 2016-09-01T03:25:48.300Z,1472700348.300 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:48.301Z,1472700348.301 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:48.307Z,1472700348.307 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2016-09-01T03:25:48.428Z,1472700348.428 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2016-09-01T03:25:48.460Z,1472700348.460 [CBIT](ERROR): Communications Fault in component: BPC1 2016-09-01T03:25:48.694Z,1472700348.694 [PNI_TCM](FAULT): Failed to set parameters during initialization. 2016-09-01T03:25:48.694Z,1472700348.694 [PNI_TCM] Data Fault, FailCount= 2 2016-09-01T03:25:48.694Z,1472700348.694 [PNI_TCM](ERROR): Data Fault 2016-09-01T03:25:48.712Z,1472700348.712 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:48.713Z,1472700348.713 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:48.784Z,1472700348.784 [CBIT](ERROR): Data Fault in component: PNI_TCM 2016-09-01T03:25:49.069Z,1472700349.069 [PNI_TCM](INFO): Powering down 2016-09-01T03:25:49.163Z,1472700349.163 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:49.164Z,1472700349.164 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:49.478Z,1472700349.478 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:49.479Z,1472700349.479 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:49.541Z,1472700349.541 [CBIT](INFO): Clearing failed state for component BPC1 2016-09-01T03:25:49.541Z,1472700349.541 [BPC1] No Fault, FailCount= 1 2016-09-01T03:25:49.937Z,1472700349.937 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:49.938Z,1472700349.938 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:50.311Z,1472700350.311 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:50.312Z,1472700350.312 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:50.352Z,1472700350.352 [CBIT](INFO): Clearing failed state for component PNI_TCM 2016-09-01T03:25:50.352Z,1472700350.352 [PNI_TCM] No Fault, FailCount= 2 2016-09-01T03:25:50.675Z,1472700350.675 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:50.677Z,1472700350.677 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:51.098Z,1472700351.098 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:51.100Z,1472700351.100 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:51.519Z,1472700351.519 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:51.521Z,1472700351.520 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:51.552Z,1472700351.552 [BuoyancyServo](CRITICAL): Reading outside of valid range:10864.000000 2016-09-01T03:25:51.552Z,1472700351.552 [BuoyancyServo](FAULT): Buoyancy engine reporting null position 2016-09-01T03:25:51.552Z,1472700351.552 [BuoyancyServo] Hardware Fault, FailCount= 4 2016-09-01T03:25:51.552Z,1472700351.552 [BuoyancyServo](ERROR): Hardware Fault 2016-09-01T03:25:51.584Z,1472700351.584 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo 2016-09-01T03:25:51.905Z,1472700351.905 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:51.906Z,1472700351.906 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:51.912Z,1472700351.912 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2016-09-01T03:25:51.913Z,1472700351.913 [BuoyancyServo](INFO): Powering down 2016-09-01T03:25:52.306Z,1472700352.306 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:52.307Z,1472700352.307 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:52.712Z,1472700352.712 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:52.713Z,1472700352.713 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:52.749Z,1472700352.749 [SBIT](IMPORTANT): Beginning Startup BIT 2016-09-01T03:25:52.753Z,1472700352.753 [CBIT](IMPORTANT): Beginning GF scan 2016-09-01T03:25:53.079Z,1472700353.079 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:53.080Z,1472700353.080 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:53.272Z,1472700353.272 [CBIT](IMPORTANT): Open Volts:2.500727 Open Current:0.000882 2016-09-01T03:25:53.483Z,1472700353.483 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:53.484Z,1472700353.484 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:53.880Z,1472700353.880 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:53.881Z,1472700353.881 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:53.980Z,1472700353.980 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2016-09-01T03:25:53.980Z,1472700353.980 [BuoyancyServo] No Fault, FailCount= 4 2016-09-01T03:25:54.280Z,1472700354.280 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:54.281Z,1472700354.281 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:54.287Z,1472700354.287 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2016-09-01T03:25:54.404Z,1472700354.404 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2016-09-01T03:25:54.688Z,1472700354.688 [CBIT](IMPORTANT): A0 Volts:2.669094 A0 Current:0.107123 2016-09-01T03:25:54.739Z,1472700354.739 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:54.740Z,1472700354.740 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:55.131Z,1472700355.131 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:55.132Z,1472700355.132 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:55.531Z,1472700355.531 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:55.532Z,1472700355.532 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:55.931Z,1472700355.931 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:55.932Z,1472700355.932 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:56.240Z,1472700356.240 [CBIT](IMPORTANT): A1 Volts:1.999087 A1 Current:-0.319358 2016-09-01T03:25:56.331Z,1472700356.331 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:56.332Z,1472700356.332 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:56.761Z,1472700356.761 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:56.762Z,1472700356.762 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:57.161Z,1472700357.161 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:57.162Z,1472700357.162 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:57.543Z,1472700357.543 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:57.544Z,1472700357.544 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:57.596Z,1472700357.596 [BuoyancyServo](CRITICAL): Reading outside of valid range:10863.000000 2016-09-01T03:25:57.596Z,1472700357.596 [BuoyancyServo](FAULT): Buoyancy engine reporting null position 2016-09-01T03:25:57.596Z,1472700357.596 [BuoyancyServo] Hardware Fault, FailCount= 5 2016-09-01T03:25:57.596Z,1472700357.596 [BuoyancyServo](ERROR): Hardware Fault 2016-09-01T03:25:57.756Z,1472700357.756 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo 2016-09-01T03:25:57.756Z,1472700357.756 [CBIT](CRITICAL): Hardware Fault in component: BuoyancyServo 2016-09-01T03:25:57.920Z,1472700357.920 [CBIT](IMPORTANT): A2 Volts:2.669103 A2 Current:0.107428 2016-09-01T03:25:57.972Z,1472700357.972 [PNI_TCM](FAULT): Failed to set parameters during initialization. 2016-09-01T03:25:57.972Z,1472700357.972 [PNI_TCM] Data Fault, FailCount= 3 2016-09-01T03:25:57.972Z,1472700357.972 [PNI_TCM](ERROR): Data Fault 2016-09-01T03:25:57.983Z,1472700357.983 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:57.984Z,1472700357.984 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:57.992Z,1472700357.991 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2016-09-01T03:25:57.992Z,1472700357.992 [BuoyancyServo](INFO): Powering down 2016-09-01T03:25:58.045Z,1472700358.045 [CBIT](ERROR): Data Fault in component: PNI_TCM 2016-09-01T03:25:58.360Z,1472700358.360 [PNI_TCM](INFO): Powering down 2016-09-01T03:25:58.461Z,1472700358.461 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:58.462Z,1472700358.462 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:58.768Z,1472700358.768 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:58.769Z,1472700358.769 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:59.168Z,1472700359.168 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:59.169Z,1472700359.169 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:59.384Z,1472700359.384 [CBIT](IMPORTANT): A3 Volts:2.612739 A3 Current:0.071400 2016-09-01T03:25:59.567Z,1472700359.567 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:59.568Z,1472700359.568 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:59.612Z,1472700359.612 [CBIT](INFO): Clearing failed state for component PNI_TCM 2016-09-01T03:25:59.613Z,1472700359.612 [PNI_TCM] No Fault, FailCount= 3 2016-09-01T03:25:59.965Z,1472700359.965 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:25:59.966Z,1472700359.966 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:26:00.366Z,1472700360.365 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:26:00.366Z,1472700360.366 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:26:00.591Z,1472700360.592 [CBIT](IMPORTANT): B0 Volts:2.387755 B0 Current:-0.071042 2016-09-01T03:26:00.787Z,1472700360.787 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:26:00.788Z,1472700360.788 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:26:01.168Z,1472700361.168 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:26:01.169Z,1472700361.169 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:26:01.571Z,1472700361.571 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:26:01.572Z,1472700361.572 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:26:01.767Z,1472700361.767 [CBIT](IMPORTANT): B1 Volts:2.284591 B1 Current:-0.136830 2016-09-01T03:26:01.000Z,1472700362.000 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:26:02.001Z,1472700362.001 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:26:02.376Z,1472700362.376 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:26:02.377Z,1472700362.377 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2016-09-01T03:26:02.857Z,1472700362.856 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting