2017-10-06T22:36:06.183Z,1507329366.183 [Supervisor](DEBUG): Initializing supervisor.
2017-10-06T22:36:06.186Z,1507329366.186 [SyncHandler](DEBUG): Created PCaller Thread at 4051A4E0
2017-10-06T22:36:06.187Z,1507329366.187 [SyncHandler](INFO): Protected caller Thread ID is 657
2017-10-06T22:36:06.187Z,1507329366.187 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2017-10-06T22:36:06.189Z,1507329366.189 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4054A4E0
2017-10-06T22:36:06.189Z,1507329366.189 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 658
2017-10-06T22:36:06.193Z,1507329366.193 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2017-10-06T22:36:06.207Z,1507329366.207 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2017-10-06T22:36:06.208Z,1507329366.208 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 4057A4E0
2017-10-06T22:36:06.209Z,1507329366.209 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 659
2017-10-06T22:36:06.209Z,1507329366.209 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2017-10-06T22:36:06.210Z,1507329366.210 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405AA4E0
2017-10-06T22:36:06.211Z,1507329366.211 [logger ThreadHandler](INFO): Protected caller Thread ID is 660
2017-10-06T22:36:06.213Z,1507329366.213 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2017-10-06T22:36:06.214Z,1507329366.214 [Supervisor](INFO): Looking for Config files in directory: Config/
2017-10-06T22:36:06.215Z,1507329366.215 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2017-10-06T22:36:06.364Z,1507329366.364 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2017-10-06T22:36:06.365Z,1507329366.365 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2017-10-06T22:36:06.523Z,1507329366.523 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2017-10-06T22:36:06.524Z,1507329366.524 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2017-10-06T22:36:06.733Z,1507329366.733 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2017-10-06T22:36:06.734Z,1507329366.734 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2017-10-06T22:36:07.054Z,1507329367.054 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2017-10-06T22:36:07.055Z,1507329367.055 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2017-10-06T22:36:07.525Z,1507329367.525 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2017-10-06T22:36:07.525Z,1507329367.525 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2017-10-06T22:36:08.118Z,1507329368.118 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2017-10-06T22:36:08.119Z,1507329368.119 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2017-10-06T22:36:08.529Z,1507329368.529 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2017-10-06T22:36:08.530Z,1507329368.530 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2017-10-06T22:36:09.089Z,1507329369.089 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2017-10-06T22:36:09.090Z,1507329369.090 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2017-10-06T22:36:09.189Z,1507329369.189 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2017-10-06T22:36:09.575Z,1507329369.575 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2017-10-06T22:36:09.575Z,1507329369.575 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2017-10-06T22:36:09.775Z,1507329369.775 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2017-10-06T22:36:09.776Z,1507329369.776 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2017-10-06T22:36:10.060Z,1507329370.060 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2017-10-06T22:36:10.060Z,1507329370.060 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2017-10-06T22:36:10.308Z,1507329370.308 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2017-10-06T22:36:10.309Z,1507329370.309 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2017-10-06T22:36:10.433Z,1507329370.433 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2017-10-06T22:36:10.434Z,1507329370.434 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2017-10-06T22:36:10.643Z,1507329370.643 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2017-10-06T22:36:10.645Z,1507329370.645 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2017-10-06T22:36:10.646Z,1507329370.646 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2017-10-06T22:36:10.986Z,1507329370.986 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2017-10-06T22:36:10.987Z,1507329370.987 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2017-10-06T22:36:11.118Z,1507329371.118 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2017-10-06T22:36:11.345Z,1507329371.345 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2017-10-06T22:36:11.463Z,1507329371.463 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2017-10-06T22:36:11.603Z,1507329371.603 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2017-10-06T22:36:11.807Z,1507329371.807 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2017-10-06T22:36:12.012Z,1507329372.012 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2017-10-06T22:36:12.129Z,1507329372.129 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2017-10-06T22:36:12.280Z,1507329372.280 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2017-10-06T22:36:12.397Z,1507329372.397 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2017-10-06T22:36:12.536Z,1507329372.536 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/
2017-10-06T22:36:12.537Z,1507329372.537 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2017-10-06T22:36:12.539Z,1507329372.539 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2017-10-06T22:36:12.634Z,1507329372.634 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2017-10-06T22:36:12.635Z,1507329372.635 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2017-10-06T22:36:12.664Z,1507329372.664 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2017-10-06T22:36:12.664Z,1507329372.664 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2017-10-06T22:36:12.705Z,1507329372.705 [DepthRateCalculator] Loaded
2017-10-06T22:36:12.706Z,1507329372.706 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2017-10-06T22:36:12.712Z,1507329372.712 [PitchRateCalculator] Loaded
2017-10-06T22:36:12.713Z,1507329372.713 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2017-10-06T22:36:12.731Z,1507329372.731 [SpeedCalculator] Loaded
2017-10-06T22:36:12.731Z,1507329372.731 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2017-10-06T22:36:12.755Z,1507329372.755 [TempGradientCalculator] Loaded
2017-10-06T22:36:12.755Z,1507329372.755 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2017-10-06T22:36:12.772Z,1507329372.772 [VerticalTemperatureHomogeneityIndexCalculator] Loaded
2017-10-06T22:36:12.772Z,1507329372.772 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread.
2017-10-06T22:36:12.779Z,1507329372.779 [YawRateCalculator] Loaded
2017-10-06T22:36:12.779Z,1507329372.779 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2017-10-06T22:36:12.779Z,1507329372.779 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2017-10-06T22:36:12.780Z,1507329372.780 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2017-10-06T22:36:12.804Z,1507329372.804 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2017-10-06T22:36:12.805Z,1507329372.805 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2017-10-06T22:36:13.295Z,1507329373.295 [AcousticModem_Benthos_ATM900] Loaded
2017-10-06T22:36:13.296Z,1507329373.296 [ComponentRegistry](DEBUG): SyncComponent "AcousticModem_Benthos_ATM900" handled in the control thread.
2017-10-06T22:36:13.389Z,1507329373.389 [DataOverHttps] Loaded
2017-10-06T22:36:13.389Z,1507329373.389 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2017-10-06T22:36:13.405Z,1507329373.405 [Depth_Keller] Loaded
2017-10-06T22:36:13.405Z,1507329373.405 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2017-10-06T22:36:13.411Z,1507329373.411 [DropWeight] Loaded
2017-10-06T22:36:13.411Z,1507329373.411 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2017-10-06T22:36:13.524Z,1507329373.524 [NAL9602] Loaded
2017-10-06T22:36:13.524Z,1507329373.524 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2017-10-06T22:36:13.542Z,1507329373.542 [Onboard] Loaded
2017-10-06T22:36:13.542Z,1507329373.542 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2017-10-06T22:36:13.553Z,1507329373.553 [Radio_Surface] Loaded
2017-10-06T22:36:13.554Z,1507329373.554 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2017-10-06T22:36:13.555Z,1507329373.555 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408D54E0
2017-10-06T22:36:13.555Z,1507329373.555 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 740
2017-10-06T22:36:13.743Z,1507329373.743 [PNI_TCM] Loaded
2017-10-06T22:36:13.743Z,1507329373.743 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread.
2017-10-06T22:36:13.814Z,1507329373.814 [Rowe_600LCM] Loaded
2017-10-06T22:36:13.814Z,1507329373.814 [ComponentRegistry](DEBUG): Component "Rowe_600LCM" handled in its own thread.
2017-10-06T22:36:13.815Z,1507329373.815 [Rowe_600LCM ThreadHandler](DEBUG): Created PCaller Thread at 409054E0
2017-10-06T22:36:13.816Z,1507329373.816 [Rowe_600LCM ThreadHandler](INFO): Protected caller Thread ID is 741
2017-10-06T22:36:15.978Z,1507329375.978 [BPC1] Loaded
2017-10-06T22:36:15.978Z,1507329375.978 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2017-10-06T22:36:15.978Z,1507329375.978 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2017-10-06T22:36:15.979Z,1507329375.979 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2017-10-06T22:36:16.130Z,1507329376.130 [SBIT](DEBUG): Construct Startup Built In Test.
2017-10-06T22:36:16.161Z,1507329376.161 [SBIT] Loaded
2017-10-06T22:36:16.161Z,1507329376.161 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2017-10-06T22:36:16.162Z,1507329376.162 [IBIT](DEBUG): Construct Initiated Built In Test.
2017-10-06T22:36:16.177Z,1507329376.177 [IBIT] Loaded
2017-10-06T22:36:16.177Z,1507329376.177 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2017-10-06T22:36:16.181Z,1507329376.181 [CBIT](DEBUG): Construct Continuous Built In Test.
2017-10-06T22:36:16.364Z,1507329376.364 [CBIT] Loaded
2017-10-06T22:36:16.365Z,1507329376.365 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2017-10-06T22:36:16.365Z,1507329376.365 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2017-10-06T22:36:16.366Z,1507329376.366 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2017-10-06T22:36:16.561Z,1507329376.561 [Aanderaa_O2] Loaded
2017-10-06T22:36:16.562Z,1507329376.562 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2017-10-06T22:36:16.659Z,1507329376.659 [CTD_NeilBrown] Loaded
2017-10-06T22:36:16.659Z,1507329376.659 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2017-10-06T22:36:16.660Z,1507329376.660 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 409F84E0
2017-10-06T22:36:16.661Z,1507329376.661 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 742
2017-10-06T22:36:16.681Z,1507329376.681 [ESPComponent] Loaded
2017-10-06T22:36:16.681Z,1507329376.681 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2017-10-06T22:36:16.697Z,1507329376.697 [PAR_Licor] Loaded
2017-10-06T22:36:16.698Z,1507329376.698 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2017-10-06T22:36:16.751Z,1507329376.751 [WetLabsBB2FL] Loaded
2017-10-06T22:36:16.752Z,1507329376.752 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2017-10-06T22:36:16.753Z,1507329376.753 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A284E0
2017-10-06T22:36:16.753Z,1507329376.753 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 743
2017-10-06T22:36:16.754Z,1507329376.754 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2017-10-06T22:36:16.754Z,1507329376.754 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2017-10-06T22:36:17.026Z,1507329377.026 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2017-10-06T22:36:17.027Z,1507329377.027 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2017-10-06T22:36:17.118Z,1507329377.118 [VerticalControl](DEBUG): Construct VerticalControl.
2017-10-06T22:36:17.230Z,1507329377.230 [VerticalControl] Loaded
2017-10-06T22:36:17.231Z,1507329377.231 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2017-10-06T22:36:17.232Z,1507329377.232 [HorizontalControl](DEBUG): Construct HorizontalControl.
2017-10-06T22:36:17.304Z,1507329377.304 [HorizontalControl] Loaded
2017-10-06T22:36:17.304Z,1507329377.304 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2017-10-06T22:36:17.305Z,1507329377.305 [SpeedControl](DEBUG): Construct SpeedControl.
2017-10-06T22:36:17.311Z,1507329377.311 [SpeedControl] Loaded
2017-10-06T22:36:17.311Z,1507329377.311 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2017-10-06T22:36:17.312Z,1507329377.312 [LoopControl](DEBUG): Construct LoopControl.
2017-10-06T22:36:17.313Z,1507329377.313 [LoopControl] Loaded
2017-10-06T22:36:17.313Z,1507329377.313 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2017-10-06T22:36:17.313Z,1507329377.313 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2017-10-06T22:36:17.314Z,1507329377.314 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2017-10-06T22:36:17.445Z,1507329377.445 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC
2017-10-06T22:36:17.445Z,1507329377.445 [StratificationFrontDetector](DEBUG): (re)initializing
2017-10-06T22:36:17.445Z,1507329377.445 [StratificationFrontDetector] Loaded
2017-10-06T22:36:17.445Z,1507329377.445 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread.
2017-10-06T22:36:17.446Z,1507329377.446 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2017-10-06T22:36:17.447Z,1507329377.447 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2017-10-06T22:36:17.566Z,1507329377.566 [BuoyancyServo] Loaded
2017-10-06T22:36:17.567Z,1507329377.567 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2017-10-06T22:36:17.581Z,1507329377.581 [ElevatorServo] Loaded
2017-10-06T22:36:17.581Z,1507329377.581 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2017-10-06T22:36:17.594Z,1507329377.594 [MassServo] Loaded
2017-10-06T22:36:17.594Z,1507329377.594 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2017-10-06T22:36:17.608Z,1507329377.608 [RudderServo] Loaded
2017-10-06T22:36:17.608Z,1507329377.608 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2017-10-06T22:36:17.621Z,1507329377.621 [ThrusterServo] Loaded
2017-10-06T22:36:17.622Z,1507329377.622 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2017-10-06T22:36:17.622Z,1507329377.622 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2017-10-06T22:36:17.623Z,1507329377.623 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2017-10-06T22:36:17.758Z,1507329377.758 [DeadReckonUsingMultipleVelocitySources] Loaded
2017-10-06T22:36:17.758Z,1507329377.758 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2017-10-06T22:36:17.822Z,1507329377.822 [DeadReckonUsingSpeedCalculator] Loaded
2017-10-06T22:36:17.823Z,1507329377.823 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2017-10-06T22:36:17.842Z,1507329377.842 [NavChart] Loaded
2017-10-06T22:36:17.842Z,1507329377.842 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2017-10-06T22:36:17.847Z,1507329377.847 [UniversalFixResidualReporter] Loaded
2017-10-06T22:36:17.847Z,1507329377.847 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2017-10-06T22:36:17.848Z,1507329377.848 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2017-10-06T22:36:17.852Z,1507329377.852 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2017-10-06T22:36:17.854Z,1507329377.854 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2017-10-06T22:36:17.863Z,1507329377.863 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2017-10-06T22:36:17.865Z,1507329377.865 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BCF4E0
2017-10-06T22:36:17.865Z,1507329377.865 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 745
2017-10-06T22:36:17.879Z,1507329377.879 [Supervisor](INFO): Main Thread ID is 656
2017-10-06T22:36:17.879Z,1507329377.879 [Supervisor](DEBUG): Running supervisor.
2017-10-06T22:36:17.879Z,1507329377.879 [CommandLine ThreadHandler](INFO): Handler Thread ID is 746
2017-10-06T22:36:17.880Z,1507329377.880 [controlThread ThreadHandler](INFO): Handler Thread ID is 747
2017-10-06T22:36:17.881Z,1507329377.881 [controlThread](DEBUG): Initializing ControlThread
2017-10-06T22:36:17.882Z,1507329377.882 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2017-10-06T22:36:17.882Z,1507329377.882 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2017-10-06T22:36:17.882Z,1507329377.882 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2017-10-06T22:36:17.883Z,1507329377.883 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2017-10-06T22:36:17.883Z,1507329377.883 [VerticalTemperatureHomogeneityIndexCalculator](DEBUG): (re)initializing
2017-10-06T22:36:17.884Z,1507329377.884 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2017-10-06T22:36:17.891Z,1507329377.891 [SBIT](INFO): Initialize SBIT Component.
2017-10-06T22:36:17.892Z,1507329377.892 [SBIT](IMPORTANT): git: 2017-09-28
2017-10-06T22:36:17.892Z,1507329377.892 [SBIT](INFO): git hash: 24ca05b165c0d131bc4566abd5c70f54463494da
2017-10-06T22:36:17.892Z,1507329377.892 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2017-10-06T22:36:17.894Z,1507329377.894 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #639 PREEMPT Wed Mar 12 12:53:33 PDT 2014
Kernel Reported: #2 PREEMPT Tue Oct 3 09:53:58 PDT 2017
2017-10-06T22:36:17.895Z,1507329377.895 [SBIT](INFO): Beginning SBIT in 63.000000 seconds.
2017-10-06T22:36:17.895Z,1507329377.895 [IBIT](INFO): Initialize IBIT Component.
2017-10-06T22:36:17.896Z,1507329377.896 [CBIT](DEBUG): Initialize CBIT Component.
2017-10-06T22:36:17.897Z,1507329377.897 [CBIT](CRITICAL): LAST REBOOT DUE TO WATCHDOG TIMER RESET.
2017-10-06T22:36:17.900Z,1507329377.900 [logger ThreadHandler](INFO): Handler Thread ID is 748
2017-10-06T22:36:17.905Z,1507329377.905 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 749
2017-10-06T22:36:17.933Z,1507329377.933 [Radio_Surface](INFO): Powering up
2017-10-06T22:36:17.933Z,1507329377.933 [Rowe_600LCM ThreadHandler](INFO): Handler Thread ID is 750
2017-10-06T22:36:17.934Z,1507329377.934 [Rowe_600LCM](INFO): Initializing
2017-10-06T22:36:17.935Z,1507329377.935 [Rowe_600LCM](INFO): Checking LCM
2017-10-06T22:36:17.966Z,1507329377.966 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 751
2017-10-06T22:36:17.968Z,1507329377.968 [CTD_NeilBrown](INFO): Powering down
2017-10-06T22:36:17.984Z,1507329377.984 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2017-10-06T22:36:17.986Z,1507329377.986 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2017-10-06T22:36:17.987Z,1507329377.987 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2017-10-06T22:36:17.988Z,1507329377.988 [LoopControl](DEBUG): Initialize LoopControlComponent.
2017-10-06T22:36:17.990Z,1507329377.990 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2017-10-06T22:36:17.991Z,1507329377.991 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2017-10-06T22:36:17.991Z,1507329377.991 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2017-10-06T22:36:17.992Z,1507329377.992 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2017-10-06T22:36:17.992Z,1507329377.992 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2017-10-06T22:36:17.993Z,1507329377.993 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2017-10-06T22:36:17.993Z,1507329377.993 [NavChart](DEBUG): Initialize NavChart Navigation.
2017-10-06T22:36:17.994Z,1507329377.994 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2017-10-06T22:36:17.995Z,1507329377.995 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2017-10-06T22:36:18.029Z,1507329378.029 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 752
2017-10-06T22:36:18.033Z,1507329378.033 [WetLabsBB2FL](INFO): Powering down
2017-10-06T22:36:18.056Z,1507329378.056 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 753
2017-10-06T22:36:18.068Z,1507329378.068 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2017-10-06T22:36:18.131Z,1507329378.131 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2017-10-06T22:36:18.191Z,1507329378.191 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US1WC07M.000
2017-10-06T22:36:18.191Z,1507329378.191 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2017-10-06T22:36:18.220Z,1507329378.220 [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>


2017-10-06T22:36:18.250Z,1507329378.250 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2017-10-06T22:36:18.257Z,1507329378.257 [Rowe_600LCM](INFO): LCM OK
2017-10-06T22:36:18.257Z,1507329378.257 [Rowe_600LCM](INFO): Powering up
2017-10-06T22:36:18.325Z,1507329378.325 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2017-10-06T22:36:18.326Z,1507329378.326 [Default:A.Wait](DEBUG): Construct Wait.
2017-10-06T22:36:18.329Z,1507329378.329 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2017-10-06T22:36:18.356Z,1507329378.356 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US2WC11M.000
2017-10-06T22:36:18.356Z,1507329378.356 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2017-10-06T22:36:18.358Z,1507329378.358 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2017-10-06T22:36:18.377Z,1507329378.377 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US3CA52M.000
2017-10-06T22:36:18.377Z,1507329378.377 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2017-10-06T22:36:18.378Z,1507329378.378 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2017-10-06T22:36:18.397Z,1507329378.397 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US4CA60M.000
2017-10-06T22:36:18.397Z,1507329378.397 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2017-10-06T22:36:18.416Z,1507329378.416 [Default:E.Execute](DEBUG): Construct Execute.
2017-10-06T22:36:18.424Z,1507329378.424 [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>


2017-10-06T22:36:18.430Z,1507329378.430 [controlThread](DEBUG): Component order: CycleStarter,AcousticModem_Benthos_ATM900,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,PNI_TCM,BPC1,Aanderaa_O2,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,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,
2017-10-06T22:36:18.436Z,1507329378.436 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US5CA50M.000
2017-10-06T22:36:18.436Z,1507329378.436 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2017-10-06T22:36:18.471Z,1507329378.471 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US5CA61M.000
2017-10-06T22:36:18.472Z,1507329378.472 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2017-10-06T22:36:18.475Z,1507329378.475 [AcousticModem_Benthos_ATM900](INFO): Powering up
2017-10-06T22:36:18.481Z,1507329378.481 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2017-10-06T22:36:18.498Z,1507329378.498 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US5CA62M.000
2017-10-06T22:36:18.498Z,1507329378.498 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2017-10-06T22:36:18.532Z,1507329378.532 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2017-10-06T22:36:18.540Z,1507329378.540 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US5CA83M.000
2017-10-06T22:36:18.593Z,1507329378.593 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US5CA83M.000
2017-10-06T22:36:18.932Z,1507329378.932 [ESPComponent](INFO): powering down ESP
2017-10-06T22:36:19.559Z,1507329379.559 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:19.668Z,1507329379.668 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:19.812Z,1507329379.812 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2017-10-06T22:36:19.820Z,1507329379.820 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2017-10-06T22:36:19.836Z,1507329379.836 [ElevatorServo](DEBUG): Initializing EZServoServo.
2017-10-06T22:36:19.844Z,1507329379.844 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2017-10-06T22:36:19.881Z,1507329379.881 [MassServo](DEBUG): Initializing EZServoServo.
2017-10-06T22:36:19.888Z,1507329379.888 [MassServo](DEBUG): Initializing MassServo.
2017-10-06T22:36:19.894Z,1507329379.894 [RudderServo](DEBUG): Initializing EZServoServo.
2017-10-06T22:36:19.920Z,1507329379.920 [RudderServo](DEBUG): Initializing RudderServo.
2017-10-06T22:36:19.926Z,1507329379.926 [ThrusterServo](DEBUG): Initializing EZServoServo.
2017-10-06T22:36:19.932Z,1507329379.932 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2017-10-06T22:36:19.985Z,1507329379.985 [CommandLine](FAULT): Scheduling is paused
2017-10-06T22:36:19.985Z,1507329379.985 [CBIT](INFO): Critical error at 20171006T223617
2017-10-06T22:36:19.986Z,1507329379.986 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2017-10-06T22:36:20.426Z,1507329380.426 [Depth_Keller](INFO): A/D timeout, 10 tries over 144 ms

2017-10-06T22:36:20.426Z,1507329380.426 [Depth_Keller] Data Fault, FailCount= 1
2017-10-06T22:36:20.426Z,1507329380.426 [Depth_Keller](ERROR): Data Fault
2017-10-06T22:36:20.436Z,1507329380.436 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2017-10-06T22:36:20.436Z,1507329380.436 [DropWeight] Hardware Fault, FailCount= 1
2017-10-06T22:36:20.436Z,1507329380.436 [DropWeight](ERROR): Hardware Fault
2017-10-06T22:36:20.481Z,1507329380.481 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:20.483Z,1507329380.483 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:20.526Z,1507329380.526 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown.
2017-10-06T22:36:20.537Z,1507329380.537 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2017-10-06T22:36:20.832Z,1507329380.832 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2017-10-06T22:36:20.832Z,1507329380.832 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2017-10-06T22:36:20.832Z,1507329380.832 [BuoyancyServo] Communications Fault, FailCount= 1
2017-10-06T22:36:20.832Z,1507329380.832 [BuoyancyServo](ERROR): Communications Fault
2017-10-06T22:36:21.248Z,1507329381.248 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout
2017-10-06T22:36:21.572Z,1507329381.572 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout
2017-10-06T22:36:21.572Z,1507329381.572 [ThrusterServo](FAULT): Thruster failed to initialize
2017-10-06T22:36:21.572Z,1507329381.572 [ThrusterServo] Communications Fault, FailCount= 1
2017-10-06T22:36:21.572Z,1507329381.572 [ThrusterServo](ERROR): Communications Fault
2017-10-06T22:36:21.574Z,1507329381.574 [CBIT](INFO): Critical error at 20171006T223620
2017-10-06T22:36:21.576Z,1507329381.576 [CBIT](ERROR): Data Fault in component: Depth_Keller
2017-10-06T22:36:21.577Z,1507329381.577 [CBIT](INFO): Clearing failed state for component Depth_Keller
2017-10-06T22:36:21.577Z,1507329381.577 [Depth_Keller] No Fault, FailCount= 1
2017-10-06T22:36:21.577Z,1507329381.577 [CBIT](ERROR): Hardware Fault in component: DropWeight
2017-10-06T22:36:21.578Z,1507329381.578 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2017-10-06T22:36:21.578Z,1507329381.578 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2017-10-06T22:36:21.578Z,1507329381.578 [CBIT](ERROR): Communications Fault in component: ThrusterServo
2017-10-06T22:36:22.558Z,1507329382.558 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2017-10-06T22:36:22.670Z,1507329382.670 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyA1 -b 38400 >& /dev/null &
2017-10-06T22:36:22.902Z,1507329382.902 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2017-10-06T22:36:22.903Z,1507329382.903 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2017-10-06T22:36:22.908Z,1507329382.908 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2017-10-06T22:36:30.391Z,1507329390.391 [Aanderaa_O2](FAULT): Timed out starting
2017-10-06T22:36:30.391Z,1507329390.391 [Aanderaa_O2] Communications Fault, FailCount= 1
2017-10-06T22:36:30.391Z,1507329390.391 [Aanderaa_O2](ERROR): Communications Fault
2017-10-06T22:36:30.432Z,1507329390.432 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:30.434Z,1507329390.434 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:30.453Z,1507329390.453 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2017-10-06T22:36:30.461Z,1507329390.461 [BuoyancyServo](INFO): Powering down
2017-10-06T22:36:30.570Z,1507329390.570 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2017-10-06T22:36:30.570Z,1507329390.570 [ThrusterServo](INFO): Powering down
2017-10-06T22:36:30.629Z,1507329390.629 [CBIT](INFO): Critical error at 20171006T223621
2017-10-06T22:36:30.632Z,1507329390.632 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2017-10-06T22:36:30.746Z,1507329390.746 [Aanderaa_O2](INFO): Powering down
2017-10-06T22:36:30.854Z,1507329390.854 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:30.855Z,1507329390.855 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:31.176Z,1507329391.176 [ElevatorServo](FAULT): Elevator initialization uart error:serial timeout
2017-10-06T22:36:31.176Z,1507329391.176 [ElevatorServo] Communications Fault, FailCount= 1
2017-10-06T22:36:31.176Z,1507329391.176 [ElevatorServo](ERROR): Communications Fault
2017-10-06T22:36:31.436Z,1507329391.436 [MassServo](FAULT): Mass initialization uart error:serial timeout
2017-10-06T22:36:31.436Z,1507329391.436 [MassServo] Communications Fault, FailCount= 1
2017-10-06T22:36:31.436Z,1507329391.436 [MassServo](ERROR): Communications Fault
2017-10-06T22:36:31.740Z,1507329391.740 [RudderServo](FAULT): Rudder initialization uart error:serial timeout
2017-10-06T22:36:31.740Z,1507329391.740 [RudderServo] Communications Fault, FailCount= 1
2017-10-06T22:36:31.740Z,1507329391.740 [RudderServo](ERROR): Communications Fault
2017-10-06T22:36:31.745Z,1507329391.745 [CBIT](ERROR): Communications Fault in component: ElevatorServo
2017-10-06T22:36:31.745Z,1507329391.745 [CBIT](ERROR): Communications Fault in component: MassServo
2017-10-06T22:36:31.745Z,1507329391.745 [CBIT](ERROR): Communications Fault in component: RudderServo
2017-10-06T22:36:31.884Z,1507329391.884 [Depth_Keller](INFO): A/D timeout, 7 tries over 126 ms

2017-10-06T22:36:31.884Z,1507329391.884 [Depth_Keller] Data Fault, FailCount= 1
2017-10-06T22:36:31.884Z,1507329391.884 [Depth_Keller](ERROR): Data Fault
2017-10-06T22:36:31.945Z,1507329391.945 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:31.946Z,1507329391.946 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:31.953Z,1507329391.953 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2017-10-06T22:36:31.954Z,1507329391.954 [ElevatorServo](INFO): Powering down
2017-10-06T22:36:32.021Z,1507329392.021 [MassServo](DEBUG): Uninitialize Mass Servo.
2017-10-06T22:36:32.021Z,1507329392.021 [MassServo](INFO): Powering down
2017-10-06T22:36:32.079Z,1507329392.079 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2017-10-06T22:36:32.083Z,1507329392.083 [RudderServo](INFO): Powering down
2017-10-06T22:36:32.133Z,1507329392.133 [Radio_Surface](INFO): Powering down
2017-10-06T22:36:32.149Z,1507329392.149 [CBIT](ERROR): Data Fault in component: Depth_Keller
2017-10-06T22:36:32.149Z,1507329392.149 [CBIT](INFO): Clearing failed state for component Depth_Keller
2017-10-06T22:36:32.149Z,1507329392.149 [Depth_Keller] No Fault, FailCount= 1
2017-10-06T22:36:32.150Z,1507329392.150 [CBIT](INFO): Clearing failed state for component ThrusterServo
2017-10-06T22:36:32.150Z,1507329392.150 [ThrusterServo] No Fault, FailCount= 1
2017-10-06T22:36:32.239Z,1507329392.239 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.077063
2017-10-06T22:36:32.293Z,1507329392.293 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:32.294Z,1507329392.294 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:32.332Z,1507329392.332 [ThrusterServo](DEBUG): Initializing EZServoServo.
2017-10-06T22:36:32.332Z,1507329392.332 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2017-10-06T22:36:32.345Z,1507329392.345 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2017-10-06T22:36:32.345Z,1507329392.345 [Aanderaa_O2] No Fault, FailCount= 1
2017-10-06T22:36:32.593Z,1507329392.593 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:32.594Z,1507329392.594 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:32.634Z,1507329392.634 [ElevatorServo](DEBUG): Initializing EZServoServo.
2017-10-06T22:36:32.635Z,1507329392.635 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2017-10-06T22:36:32.636Z,1507329392.636 [MassServo](DEBUG): Initializing EZServoServo.
2017-10-06T22:36:32.637Z,1507329392.637 [MassServo](DEBUG): Initializing MassServo.
2017-10-06T22:36:32.638Z,1507329392.638 [RudderServo](DEBUG): Initializing EZServoServo.
2017-10-06T22:36:32.638Z,1507329392.638 [RudderServo](DEBUG): Initializing RudderServo.
2017-10-06T22:36:32.647Z,1507329392.647 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2017-10-06T22:36:32.647Z,1507329392.647 [BuoyancyServo] No Fault, FailCount= 1
2017-10-06T22:36:32.653Z,1507329392.653 [CBIT](INFO): Clearing failed state for component ElevatorServo
2017-10-06T22:36:32.653Z,1507329392.653 [ElevatorServo] No Fault, FailCount= 1
2017-10-06T22:36:32.653Z,1507329392.653 [CBIT](INFO): Clearing failed state for component MassServo
2017-10-06T22:36:32.653Z,1507329392.653 [MassServo] No Fault, FailCount= 1
2017-10-06T22:36:32.653Z,1507329392.653 [CBIT](INFO): Clearing failed state for component RudderServo
2017-10-06T22:36:32.653Z,1507329392.653 [RudderServo] No Fault, FailCount= 1
2017-10-06T22:36:33.040Z,1507329393.040 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:33.042Z,1507329393.042 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:33.053Z,1507329393.053 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2017-10-06T22:36:33.054Z,1507329393.054 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2017-10-06T22:36:33.388Z,1507329393.388 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout
2017-10-06T22:36:33.708Z,1507329393.708 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout
2017-10-06T22:36:33.708Z,1507329393.708 [ThrusterServo](FAULT): Thruster failed to initialize
2017-10-06T22:36:33.708Z,1507329393.708 [ThrusterServo] Communications Fault, FailCount= 2
2017-10-06T22:36:33.708Z,1507329393.708 [ThrusterServo](ERROR): Communications Fault
2017-10-06T22:36:33.712Z,1507329393.712 [CBIT](ERROR): Communications Fault in component: ThrusterServo
2017-10-06T22:36:33.852Z,1507329393.852 [Depth_Keller](INFO): A/D timeout, 7 tries over 129 ms

2017-10-06T22:36:33.853Z,1507329393.853 [Depth_Keller] Data Fault, FailCount= 1
2017-10-06T22:36:33.853Z,1507329393.853 [Depth_Keller](ERROR): Data Fault
2017-10-06T22:36:33.871Z,1507329393.871 [BPC1](FAULT): Failed to initialize
2017-10-06T22:36:33.871Z,1507329393.871 [BPC1] Communications Fault, FailCount= 1
2017-10-06T22:36:33.871Z,1507329393.871 [BPC1](ERROR): Communications Fault
2017-10-06T22:36:33.921Z,1507329393.921 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:33.922Z,1507329393.922 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:34.217Z,1507329394.217 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US5CA83M.000
2017-10-06T22:36:34.252Z,1507329394.252 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2017-10-06T22:36:34.252Z,1507329394.252 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2017-10-06T22:36:34.252Z,1507329394.252 [BuoyancyServo] Communications Fault, FailCount= 2
2017-10-06T22:36:34.252Z,1507329394.252 [BuoyancyServo](ERROR): Communications Fault
2017-10-06T22:36:34.530Z,1507329394.530 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2017-10-06T22:36:34.530Z,1507329394.530 [ThrusterServo](INFO): Powering down
2017-10-06T22:36:34.570Z,1507329394.570 [CBIT](ERROR): Data Fault in component: Depth_Keller
2017-10-06T22:36:34.570Z,1507329394.570 [CBIT](INFO): Clearing failed state for component Depth_Keller
2017-10-06T22:36:34.570Z,1507329394.570 [Depth_Keller] No Fault, FailCount= 1
2017-10-06T22:36:34.571Z,1507329394.571 [CBIT](ERROR): Communications Fault in component: BPC1
2017-10-06T22:36:34.576Z,1507329394.576 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2017-10-06T22:36:34.689Z,1507329394.689 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:34.691Z,1507329394.691 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:34.722Z,1507329394.722 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2017-10-06T22:36:34.731Z,1507329394.731 [BuoyancyServo](INFO): Powering down
2017-10-06T22:36:35.136Z,1507329395.136 [Depth_Keller](INFO): A/D timeout, 13 tries over 147 ms

2017-10-06T22:36:35.136Z,1507329395.136 [Depth_Keller] Data Fault, FailCount= 2
2017-10-06T22:36:35.136Z,1507329395.136 [Depth_Keller](ERROR): Data Fault
2017-10-06T22:36:35.176Z,1507329395.176 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:35.178Z,1507329395.178 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:35.214Z,1507329395.214 [CBIT](ERROR): Data Fault in component: Depth_Keller
2017-10-06T22:36:35.214Z,1507329395.214 [CBIT](INFO): Clearing failed state for component Depth_Keller
2017-10-06T22:36:35.214Z,1507329395.214 [Depth_Keller] No Fault, FailCount= 2
2017-10-06T22:36:35.215Z,1507329395.215 [CBIT](INFO): Clearing failed state for component ThrusterServo
2017-10-06T22:36:35.215Z,1507329395.215 [ThrusterServo] No Fault, FailCount= 2
2017-10-06T22:36:35.453Z,1507329395.453 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:35.454Z,1507329395.454 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:35.463Z,1507329395.463 [ThrusterServo](DEBUG): Initializing EZServoServo.
2017-10-06T22:36:35.463Z,1507329395.463 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2017-10-06T22:36:35.483Z,1507329395.483 [CBIT](INFO): Clearing failed state for component BPC1
2017-10-06T22:36:35.484Z,1507329395.484 [BPC1] No Fault, FailCount= 1
2017-10-06T22:36:35.928Z,1507329395.928 [Depth_Keller](INFO): A/D timeout, 9 tries over 139 ms

2017-10-06T22:36:35.928Z,1507329395.928 [Depth_Keller] Data Fault, FailCount= 3
2017-10-06T22:36:35.928Z,1507329395.928 [Depth_Keller](ERROR): Data Fault
2017-10-06T22:36:36.031Z,1507329396.031 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:36.032Z,1507329396.032 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:36.380Z,1507329396.380 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout
2017-10-06T22:36:36.708Z,1507329396.708 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout
2017-10-06T22:36:36.708Z,1507329396.708 [ThrusterServo](FAULT): Thruster failed to initialize
2017-10-06T22:36:36.708Z,1507329396.708 [ThrusterServo] Communications Fault, FailCount= 3
2017-10-06T22:36:36.708Z,1507329396.708 [ThrusterServo](ERROR): Communications Fault
2017-10-06T22:36:36.712Z,1507329396.712 [CBIT](ERROR): Data Fault in component: Depth_Keller
2017-10-06T22:36:36.712Z,1507329396.712 [CBIT](CRITICAL): Data Fault in component: Depth_Keller
2017-10-06T22:36:36.713Z,1507329396.713 [CBIT](ERROR): Communications Fault in component: ThrusterServo
2017-10-06T22:36:36.777Z,1507329396.777 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:36.778Z,1507329396.778 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:37.120Z,1507329397.120 [ElevatorServo](FAULT): Elevator initialization uart error:serial timeout
2017-10-06T22:36:37.120Z,1507329397.120 [ElevatorServo] Communications Fault, FailCount= 2
2017-10-06T22:36:37.120Z,1507329397.120 [ElevatorServo](ERROR): Communications Fault
2017-10-06T22:36:37.376Z,1507329397.376 [MassServo](FAULT): Mass initialization uart error:serial timeout
2017-10-06T22:36:37.376Z,1507329397.376 [MassServo] Communications Fault, FailCount= 2
2017-10-06T22:36:37.376Z,1507329397.376 [MassServo](ERROR): Communications Fault
2017-10-06T22:36:37.379Z,1507329397.379 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2017-10-06T22:36:37.380Z,1507329397.380 [ThrusterServo](INFO): Powering down
2017-10-06T22:36:37.388Z,1507329397.388 [CBIT](INFO): Critical error at 20171006T223636
2017-10-06T22:36:37.391Z,1507329397.391 [CBIT](ERROR): Communications Fault in component: ElevatorServo
2017-10-06T22:36:37.391Z,1507329397.391 [CBIT](ERROR): Communications Fault in component: MassServo
2017-10-06T22:36:37.528Z,1507329397.528 [PNI_TCM](ERROR): No parameter response UART error: serial timeout
2017-10-06T22:36:37.528Z,1507329397.528 [PNI_TCM](ERROR): Received 0xFF
2017-10-06T22:36:37.528Z,1507329397.528 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2017-10-06T22:36:37.528Z,1507329397.528 [PNI_TCM] Data Fault, FailCount= 1
2017-10-06T22:36:37.528Z,1507329397.528 [PNI_TCM](ERROR): Data Fault
2017-10-06T22:36:37.539Z,1507329397.539 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:37.544Z,1507329397.544 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:37.576Z,1507329397.576 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2017-10-06T22:36:37.576Z,1507329397.576 [ElevatorServo](INFO): Powering down
2017-10-06T22:36:37.577Z,1507329397.577 [MassServo](DEBUG): Uninitialize Mass Servo.
2017-10-06T22:36:37.578Z,1507329397.578 [MassServo](INFO): Powering down
2017-10-06T22:36:37.584Z,1507329397.584 [CBIT](ERROR): Data Fault in component: PNI_TCM
2017-10-06T22:36:37.584Z,1507329397.584 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2017-10-06T22:36:37.584Z,1507329397.584 [BuoyancyServo] No Fault, FailCount= 2
2017-10-06T22:36:37.819Z,1507329397.819 [PNI_TCM](INFO): Powering down
2017-10-06T22:36:37.889Z,1507329397.889 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:37.890Z,1507329397.890 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:37.925Z,1507329397.925 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2017-10-06T22:36:37.925Z,1507329397.925 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2017-10-06T22:36:37.964Z,1507329397.964 [RudderServo](ERROR): Rudder reporting null position
2017-10-06T22:36:37.982Z,1507329397.982 [CBIT](INFO): Clearing failed state for component ThrusterServo
2017-10-06T22:36:37.982Z,1507329397.982 [ThrusterServo] No Fault, FailCount= 3
2017-10-06T22:36:38.221Z,1507329398.221 [PNI_TCM](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Software Overcurrent. Current Limiter Activated.
2017-10-06T22:36:38.221Z,1507329398.221 [PNI_TCM] Hardware Fault, FailCount= 1
2017-10-06T22:36:38.221Z,1507329398.221 [PNI_TCM](ERROR): Hardware Fault
2017-10-06T22:36:38.251Z,1507329398.251 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:38.268Z,1507329398.268 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:38.278Z,1507329398.278 [ElevatorServo](DEBUG): Initializing EZServoServo.
2017-10-06T22:36:38.279Z,1507329398.279 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2017-10-06T22:36:38.300Z,1507329398.300 [MassServo](DEBUG): Initializing EZServoServo.
2017-10-06T22:36:38.300Z,1507329398.300 [MassServo](DEBUG): Initializing MassServo.
2017-10-06T22:36:38.368Z,1507329398.368 [RudderServo](ERROR): getPosition uart error serial timeout
2017-10-06T22:36:38.368Z,1507329398.368 [RudderServo](FAULT): Rudder uart error - getPosition..serial timeout
2017-10-06T22:36:38.368Z,1507329398.368 [RudderServo] Communications Fault, FailCount= 2
2017-10-06T22:36:38.368Z,1507329398.368 [RudderServo](ERROR): Communications Fault
2017-10-06T22:36:38.369Z,1507329398.369 [ThrusterServo](DEBUG): Initializing EZServoServo.
2017-10-06T22:36:38.369Z,1507329398.369 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2017-10-06T22:36:38.374Z,1507329398.374 [CBIT](INFO): Clearing failed state for component ElevatorServo
2017-10-06T22:36:38.374Z,1507329398.374 [ElevatorServo] No Fault, FailCount= 2
2017-10-06T22:36:38.374Z,1507329398.374 [CBIT](INFO): Clearing failed state for component MassServo
2017-10-06T22:36:38.374Z,1507329398.374 [MassServo] No Fault, FailCount= 2
2017-10-06T22:36:38.374Z,1507329398.374 [CBIT](ERROR): Communications Fault in component: RudderServo
2017-10-06T22:36:38.600Z,1507329398.600 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2017-10-06T22:36:38.601Z,1507329398.601 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 1
2017-10-06T22:36:38.601Z,1507329398.601 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2017-10-06T22:36:38.670Z,1507329398.670 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:38.674Z,1507329398.674 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:39.076Z,1507329399.076 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2017-10-06T22:36:39.076Z,1507329399.076 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2017-10-06T22:36:39.076Z,1507329399.076 [BuoyancyServo] Communications Fault, FailCount= 3
2017-10-06T22:36:39.076Z,1507329399.076 [BuoyancyServo](ERROR): Communications Fault
2017-10-06T22:36:39.388Z,1507329399.388 [ElevatorServo](ERROR): Elevator initialization uart error I:serial timeout
2017-10-06T22:36:39.388Z,1507329399.388 [ElevatorServo](FAULT): Elevator failed to initialize
2017-10-06T22:36:39.388Z,1507329399.388 [ElevatorServo] Communications Fault, FailCount= 3
2017-10-06T22:36:39.388Z,1507329399.388 [ElevatorServo](ERROR): Communications Fault
2017-10-06T22:36:39.389Z,1507329399.389 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2017-10-06T22:36:39.390Z,1507329399.390 [RudderServo](INFO): Powering down
2017-10-06T22:36:39.732Z,1507329399.732 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout
2017-10-06T22:36:39.788Z,1507329399.788 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-06T22:36:39.788Z,1507329399.788 [CTD_NeilBrown](FAULT): No CTD communication! Re-initializing
2017-10-06T22:36:39.788Z,1507329399.788 [CTD_NeilBrown] Communications Fault, FailCount= 1
2017-10-06T22:36:39.788Z,1507329399.788 [CTD_NeilBrown](ERROR): Communications Fault
2017-10-06T22:36:40.056Z,1507329400.056 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout
2017-10-06T22:36:40.056Z,1507329400.056 [ThrusterServo](FAULT): Thruster failed to initialize
2017-10-06T22:36:40.056Z,1507329400.056 [ThrusterServo] Communications Fault, FailCount= 4
2017-10-06T22:36:40.056Z,1507329400.056 [ThrusterServo](ERROR): Communications Fault
2017-10-06T22:36:40.060Z,1507329400.060 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2017-10-06T22:36:40.061Z,1507329400.061 [CBIT](ERROR): Communications Fault in component: CTD_NeilBrown
2017-10-06T22:36:40.061Z,1507329400.061 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2017-10-06T22:36:40.061Z,1507329400.061 [CBIT](ERROR): Communications Fault in component: ElevatorServo
2017-10-06T22:36:40.062Z,1507329400.062 [CBIT](CRITICAL): Communications Fault in component: ElevatorServo
2017-10-06T22:36:40.062Z,1507329400.062 [CBIT](ERROR): Communications Fault in component: ThrusterServo
2017-10-06T22:36:40.068Z,1507329400.068 [AcousticModem_Benthos_ATM900](INFO): Powering down
2017-10-06T22:36:40.193Z,1507329400.193 [CTD_NeilBrown](INFO): Powering down
2017-10-06T22:36:40.224Z,1507329400.224 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:40.228Z,1507329400.228 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:40.257Z,1507329400.257 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2017-10-06T22:36:40.269Z,1507329400.269 [BuoyancyServo](INFO): Powering down
2017-10-06T22:36:40.292Z,1507329400.292 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2017-10-06T22:36:40.292Z,1507329400.292 [ElevatorServo](INFO): Powering down
2017-10-06T22:36:40.294Z,1507329400.294 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2017-10-06T22:36:40.294Z,1507329400.294 [ThrusterServo](INFO): Powering down
2017-10-06T22:36:40.297Z,1507329400.297 [CBIT](INFO): Critical error at 20171006T223640
2017-10-06T22:36:40.305Z,1507329400.305 [CBIT](INFO): Clearing failed state for component PNI_TCM
2017-10-06T22:36:40.305Z,1507329400.305 [PNI_TCM] No Fault, FailCount= 1
2017-10-06T22:36:40.504Z,1507329400.504 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:40.505Z,1507329400.505 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:40.522Z,1507329400.522 [RudderServo](DEBUG): Initializing EZServoServo.
2017-10-06T22:36:40.522Z,1507329400.522 [RudderServo](DEBUG): Initializing RudderServo.
2017-10-06T22:36:40.528Z,1507329400.528 [CBIT](INFO): Clearing failed state for component RudderServo
2017-10-06T22:36:40.528Z,1507329400.528 [RudderServo] No Fault, FailCount= 2
2017-10-06T22:36:40.912Z,1507329400.912 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:40.914Z,1507329400.914 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:40.934Z,1507329400.934 [ElevatorServo](DEBUG): Initializing EZServoServo.
2017-10-06T22:36:40.935Z,1507329400.935 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2017-10-06T22:36:41.212Z,1507329401.212 [MassServo](FAULT): Mass initialization uart error:serial timeout
2017-10-06T22:36:41.212Z,1507329401.212 [MassServo] Communications Fault, FailCount= 3
2017-10-06T22:36:41.212Z,1507329401.212 [MassServo](ERROR): Communications Fault
2017-10-06T22:36:41.528Z,1507329401.528 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2017-10-06T22:36:41.528Z,1507329401.528 [RudderServo](FAULT): Rudder failed to initialize
2017-10-06T22:36:41.528Z,1507329401.528 [RudderServo] Communications Fault, FailCount= 3
2017-10-06T22:36:41.528Z,1507329401.528 [RudderServo](ERROR): Communications Fault
2017-10-06T22:36:41.533Z,1507329401.533 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2017-10-06T22:36:41.533Z,1507329401.533 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 1
2017-10-06T22:36:41.534Z,1507329401.534 [CBIT](INFO): Clearing failed state for component CTD_NeilBrown
2017-10-06T22:36:41.534Z,1507329401.534 [CTD_NeilBrown] No Fault, FailCount= 1
2017-10-06T22:36:41.535Z,1507329401.535 [CBIT](ERROR): Communications Fault in component: MassServo
2017-10-06T22:36:41.535Z,1507329401.535 [CBIT](ERROR): Communications Fault in component: RudderServo
2017-10-06T22:36:41.536Z,1507329401.536 [CBIT](CRITICAL): Communications Fault in component: RudderServo
2017-10-06T22:36:41.538Z,1507329401.538 [CBIT](INFO): Clearing failed state for component ThrusterServo
2017-10-06T22:36:41.538Z,1507329401.538 [ThrusterServo] No Fault, FailCount= 4
2017-10-06T22:36:41.838Z,1507329401.838 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown.
2017-10-06T22:36:41.839Z,1507329401.839 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2017-10-06T22:36:41.864Z,1507329401.864 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:41.866Z,1507329401.866 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:41.880Z,1507329401.880 [MassServo](DEBUG): Uninitialize Mass Servo.
2017-10-06T22:36:41.880Z,1507329401.880 [MassServo](INFO): Powering down
2017-10-06T22:36:41.882Z,1507329401.882 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2017-10-06T22:36:41.882Z,1507329401.882 [RudderServo](INFO): Powering down
2017-10-06T22:36:41.883Z,1507329401.883 [ThrusterServo](DEBUG): Initializing EZServoServo.
2017-10-06T22:36:41.883Z,1507329401.883 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2017-10-06T22:36:41.895Z,1507329401.895 [CBIT](INFO): Critical error at 20171006T223641
2017-10-06T22:36:42.019Z,1507329402.019 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:42.038Z,1507329402.038 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:42.092Z,1507329402.092 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2017-10-06T22:36:42.092Z,1507329402.092 [BuoyancyServo] No Fault, FailCount= 3
2017-10-06T22:36:42.418Z,1507329402.418 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:42.428Z,1507329402.428 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:42.464Z,1507329402.464 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2017-10-06T22:36:42.464Z,1507329402.464 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2017-10-06T22:36:42.465Z,1507329402.465 [MassServo](DEBUG): Initializing EZServoServo.
2017-10-06T22:36:42.466Z,1507329402.466 [MassServo](DEBUG): Initializing MassServo.
2017-10-06T22:36:42.467Z,1507329402.467 [RudderServo](DEBUG): Initializing EZServoServo.
2017-10-06T22:36:42.467Z,1507329402.467 [RudderServo](DEBUG): Initializing RudderServo.
2017-10-06T22:36:42.792Z,1507329402.792 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout
2017-10-06T22:36:43.112Z,1507329403.112 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout
2017-10-06T22:36:43.112Z,1507329403.112 [ThrusterServo](FAULT): Thruster failed to initialize
2017-10-06T22:36:43.112Z,1507329403.112 [ThrusterServo] Communications Fault, FailCount= 5
2017-10-06T22:36:43.112Z,1507329403.112 [ThrusterServo](ERROR): Communications Fault
2017-10-06T22:36:43.116Z,1507329403.116 [CBIT](INFO): Clearing failed state for component MassServo
2017-10-06T22:36:43.116Z,1507329403.116 [MassServo] No Fault, FailCount= 3
2017-10-06T22:36:43.117Z,1507329403.117 [CBIT](ERROR): Communications Fault in component: ThrusterServo
2017-10-06T22:36:43.117Z,1507329403.117 [CBIT](CRITICAL): Communications Fault in component: ThrusterServo
2017-10-06T22:36:43.185Z,1507329403.185 [Aanderaa_O2](FAULT): Timed out starting
2017-10-06T22:36:43.185Z,1507329403.185 [Aanderaa_O2] Communications Fault, FailCount= 2
2017-10-06T22:36:43.185Z,1507329403.185 [Aanderaa_O2](ERROR): Communications Fault
2017-10-06T22:36:43.246Z,1507329403.246 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:43.253Z,1507329403.253 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:43.604Z,1507329403.604 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2017-10-06T22:36:43.604Z,1507329403.604 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2017-10-06T22:36:43.604Z,1507329403.604 [BuoyancyServo] Communications Fault, FailCount= 4
2017-10-06T22:36:43.604Z,1507329403.604 [BuoyancyServo](ERROR): Communications Fault
2017-10-06T22:36:43.607Z,1507329403.607 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2017-10-06T22:36:43.641Z,1507329403.641 [ThrusterServo](INFO): Powering down
2017-10-06T22:36:43.645Z,1507329403.645 [CBIT](INFO): Critical error at 20171006T223643
2017-10-06T22:36:43.668Z,1507329403.668 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2017-10-06T22:36:43.669Z,1507329403.669 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2017-10-06T22:36:43.684Z,1507329403.684 [AcousticModem_Benthos_ATM900](INFO): Powering up
2017-10-06T22:36:43.686Z,1507329403.686 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2017-10-06T22:36:43.701Z,1507329403.701 [NAL9602](INFO): Powering up NAL9602
2017-10-06T22:36:43.722Z,1507329403.722 [Aanderaa_O2](INFO): Powering down
2017-10-06T22:36:43.731Z,1507329403.731 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:43.747Z,1507329403.747 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:43.760Z,1507329403.760 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2017-10-06T22:36:43.767Z,1507329403.767 [BuoyancyServo](INFO): Powering down
2017-10-06T22:36:44.117Z,1507329404.117 [Aanderaa_O2](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Software Overcurrent. Current Limiter Activated.
2017-10-06T22:36:44.118Z,1507329404.118 [Aanderaa_O2] Hardware Fault, FailCount= 2
2017-10-06T22:36:44.118Z,1507329404.118 [Aanderaa_O2](ERROR): Hardware Fault
2017-10-06T22:36:44.150Z,1507329404.150 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:44.164Z,1507329404.164 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:44.618Z,1507329404.618 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:44.625Z,1507329404.625 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:44.667Z,1507329404.667 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2017-10-06T22:36:44.667Z,1507329404.667 [Aanderaa_O2] No Fault, FailCount= 2
2017-10-06T22:36:44.937Z,1507329404.937 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:44.939Z,1507329404.939 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:45.300Z,1507329405.300 [MassServo](FAULT): Mass initialization uart error:serial timeout
2017-10-06T22:36:45.300Z,1507329405.300 [MassServo] Communications Fault, FailCount= 4
2017-10-06T22:36:45.300Z,1507329405.300 [MassServo](ERROR): Communications Fault
2017-10-06T22:36:45.305Z,1507329405.305 [CBIT](ERROR): Communications Fault in component: MassServo
2017-10-06T22:36:45.406Z,1507329405.406 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:45.413Z,1507329405.413 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:45.440Z,1507329405.440 [MassServo](DEBUG): Uninitialize Mass Servo.
2017-10-06T22:36:45.442Z,1507329405.442 [MassServo](INFO): Powering down
2017-10-06T22:36:45.764Z,1507329405.764 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:45.766Z,1507329405.766 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:45.822Z,1507329405.822 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2017-10-06T22:36:45.822Z,1507329405.822 [BuoyancyServo] No Fault, FailCount= 4
2017-10-06T22:36:46.183Z,1507329406.183 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:46.193Z,1507329406.193 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:46.209Z,1507329406.209 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2017-10-06T22:36:46.209Z,1507329406.209 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2017-10-06T22:36:46.210Z,1507329406.210 [MassServo](DEBUG): Initializing EZServoServo.
2017-10-06T22:36:46.211Z,1507329406.211 [MassServo](DEBUG): Initializing MassServo.
2017-10-06T22:36:46.217Z,1507329406.217 [CBIT](INFO): Clearing failed state for component MassServo
2017-10-06T22:36:46.217Z,1507329406.217 [MassServo] No Fault, FailCount= 4
2017-10-06T22:36:46.565Z,1507329406.565 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:46.566Z,1507329406.566 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:46.973Z,1507329406.973 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:46.974Z,1507329406.974 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:47.316Z,1507329407.316 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2017-10-06T22:36:47.316Z,1507329407.316 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2017-10-06T22:36:47.316Z,1507329407.316 [BuoyancyServo] Communications Fault, FailCount= 5
2017-10-06T22:36:47.316Z,1507329407.316 [BuoyancyServo](ERROR): Communications Fault
2017-10-06T22:36:47.373Z,1507329407.373 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2017-10-06T22:36:47.373Z,1507329407.373 [CBIT](CRITICAL): Communications Fault in component: BuoyancyServo
2017-10-06T22:36:47.495Z,1507329407.495 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:47.504Z,1507329407.504 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:47.528Z,1507329407.528 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2017-10-06T22:36:47.546Z,1507329407.546 [BuoyancyServo](INFO): Powering down
2017-10-06T22:36:47.574Z,1507329407.574 [CBIT](INFO): Critical error at 20171006T223647
2017-10-06T22:36:47.862Z,1507329407.862 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:47.866Z,1507329407.866 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:48.236Z,1507329408.236 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:48.237Z,1507329408.237 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:48.652Z,1507329408.652 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:48.654Z,1507329408.654 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:49.042Z,1507329409.042 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:49.050Z,1507329409.050 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:49.424Z,1507329409.424 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2017-10-06T22:36:49.424Z,1507329409.424 [PNI_TCM] Data Fault, FailCount= 2
2017-10-06T22:36:49.424Z,1507329409.424 [PNI_TCM](ERROR): Data Fault
2017-10-06T22:36:49.435Z,1507329409.435 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:49.437Z,1507329409.437 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:49.495Z,1507329409.495 [CBIT](ERROR): Data Fault in component: PNI_TCM
2017-10-06T22:36:49.803Z,1507329409.803 [PNI_TCM](INFO): Powering down
2017-10-06T22:36:49.850Z,1507329409.850 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:49.851Z,1507329409.851 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:49.901Z,1507329409.901 [MassServo](FAULT): Mass Shifter error waiting for homing. Uart error: no error
2017-10-06T22:36:49.902Z,1507329409.902 [MassServo] Hardware Fault, FailCount= 5
2017-10-06T22:36:49.902Z,1507329409.902 [MassServo](ERROR): Hardware Fault
2017-10-06T22:36:49.936Z,1507329409.936 [MassServo](FAULT): Bad Operand Error
2017-10-06T22:36:49.941Z,1507329409.941 [CBIT](ERROR): Hardware Fault in component: MassServo
2017-10-06T22:36:49.941Z,1507329409.941 [CBIT](CRITICAL): Hardware Fault in component: MassServo
2017-10-06T22:36:50.209Z,1507329410.209 [PNI_TCM](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Software Overcurrent. Current Limiter Activated.
2017-10-06T22:36:50.209Z,1507329410.209 [PNI_TCM] Hardware Fault, FailCount= 2
2017-10-06T22:36:50.209Z,1507329410.209 [PNI_TCM](ERROR): Hardware Fault
2017-10-06T22:36:50.243Z,1507329410.243 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:50.244Z,1507329410.244 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:50.256Z,1507329410.256 [MassServo](DEBUG): Uninitialize Mass Servo.
2017-10-06T22:36:50.256Z,1507329410.256 [MassServo](INFO): Powering down
2017-10-06T22:36:50.268Z,1507329410.268 [CBIT](INFO): Critical error at 20171006T223649
2017-10-06T22:36:50.614Z,1507329410.614 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:50.616Z,1507329410.616 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:51.014Z,1507329411.014 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:51.015Z,1507329411.015 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:51.049Z,1507329411.049 [MassServo](DEBUG): Initializing EZServoServo.
2017-10-06T22:36:51.050Z,1507329411.050 [MassServo](DEBUG): Initializing MassServo.
2017-10-06T22:36:51.054Z,1507329411.054 [CBIT](INFO): Clearing failed state for component PNI_TCM
2017-10-06T22:36:51.055Z,1507329411.055 [PNI_TCM] No Fault, FailCount= 2
2017-10-06T22:36:51.405Z,1507329411.405 [BPC1](FAULT): Failed to initialize
2017-10-06T22:36:51.405Z,1507329411.405 [BPC1] Communications Fault, FailCount= 2
2017-10-06T22:36:51.405Z,1507329411.405 [BPC1](ERROR): Communications Fault
2017-10-06T22:36:51.439Z,1507329411.439 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:51.443Z,1507329411.443 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:51.482Z,1507329411.482 [CBIT](ERROR): Communications Fault in component: BPC1
2017-10-06T22:36:51.828Z,1507329411.828 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:51.829Z,1507329411.829 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:52.246Z,1507329412.246 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:52.248Z,1507329412.248 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:52.618Z,1507329412.618 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:52.619Z,1507329412.619 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:52.650Z,1507329412.650 [CBIT](INFO): Clearing failed state for component BPC1
2017-10-06T22:36:52.651Z,1507329412.651 [BPC1] No Fault, FailCount= 2
2017-10-06T22:36:53.104Z,1507329413.104 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:53.105Z,1507329413.105 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:53.433Z,1507329413.433 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:53.434Z,1507329413.434 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:53.833Z,1507329413.833 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:53.834Z,1507329413.834 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:54.246Z,1507329414.246 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:54.250Z,1507329414.250 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:54.623Z,1507329414.623 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:54.626Z,1507329414.626 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:55.020Z,1507329415.020 [Aanderaa_O2](FAULT): Timed out starting
2017-10-06T22:36:55.020Z,1507329415.020 [Aanderaa_O2] Communications Fault, FailCount= 3
2017-10-06T22:36:55.021Z,1507329415.021 [Aanderaa_O2](ERROR): Communications Fault
2017-10-06T22:36:55.040Z,1507329415.040 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:55.041Z,1507329415.041 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:36:55.058Z,1507329415.058 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2017-10-06T22:36:55.059Z,1507329415.059 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2017-10-06T22:36:56.957Z,1507329416.957 [CommandLine](IMPORTANT): got command failComponent
2017-10-06T22:36:56.958Z,1507329416.958 [CommandLine](IMPORTANT): Failed components:
2017-10-06T22:36:56.958Z,1507329416.958 [CommandLine](IMPORTANT): Depth_Keller: Data Fault
2017-10-06T22:36:56.958Z,1507329416.958 [CommandLine](IMPORTANT): DropWeight: Hardware Fault
2017-10-06T22:36:56.959Z,1507329416.959 [CommandLine](IMPORTANT): Aanderaa_O2: Communications Fault
2017-10-06T22:36:56.959Z,1507329416.959 [CommandLine](IMPORTANT): BuoyancyServo: Communications Fault
2017-10-06T22:36:56.959Z,1507329416.959 [CommandLine](IMPORTANT): ElevatorServo: Communications Fault
2017-10-06T22:36:56.959Z,1507329416.959 [CommandLine](IMPORTANT): MassServo: Hardware Fault
2017-10-06T22:36:56.960Z,1507329416.960 [CommandLine](IMPORTANT): RudderServo: Communications Fault
2017-10-06T22:36:56.960Z,1507329416.960 [CommandLine](IMPORTANT): ThrusterServo: Communications Fault
2017-10-06T22:37:01.040Z,1507329421.040 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-06T22:37:01.040Z,1507329421.040 [CTD_NeilBrown](FAULT): No CTD communication! Re-initializing
2017-10-06T22:37:01.040Z,1507329421.040 [CTD_NeilBrown] Communications Fault, FailCount= 2
2017-10-06T22:37:01.040Z,1507329421.040 [CTD_NeilBrown](ERROR): Communications Fault
2017-10-06T22:37:01.444Z,1507329421.444 [CTD_NeilBrown](INFO): Powering down
2017-10-06T22:37:08.270Z,1507329428.270 [CommandLine](IMPORTANT): got command restart application
2017-10-06T22:37:09.313Z,1507329429.313 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2017-10-06T22:37:09.313Z,1507329429.313 [CommandLine ThreadHandler](INFO): Thread cancelled.
2017-10-06T22:37:09.392Z,1507329429.392 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2017-10-06T22:37:09.392Z,1507329429.392 [CommandLine ThreadHandler](INFO): Thread cancelled.
2017-10-06T22:37:09.392Z,1507329429.392 [CommandLine](INFO): Join timeout helper Thread ID is 769
2017-10-06T22:37:09.393Z,1507329429.393 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2017-10-06T22:37:09.393Z,1507329429.393 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2017-10-06T22:37:09.394Z,1507329429.394 [NavChartDb](INFO): Join timeout helper Thread ID is 772
2017-10-06T22:37:10.147Z,1507329430.147 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2017-10-06T22:37:10.148Z,1507329430.148 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2017-10-06T22:37:10.156Z,1507329430.156 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2017-10-06T22:37:10.156Z,1507329430.156 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2017-10-06T22:37:10.156Z,1507329430.156 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 773
2017-10-06T22:37:10.248Z,1507329430.248 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2017-10-06T22:37:10.248Z,1507329430.248 [WetLabsBB2FL](INFO): Powering down
2017-10-06T22:37:10.249Z,1507329430.249 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2017-10-06T22:37:10.256Z,1507329430.256 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2017-10-06T22:37:10.256Z,1507329430.256 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2017-10-06T22:37:10.256Z,1507329430.256 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 775
2017-10-06T22:37:10.331Z,1507329430.331 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2017-10-06T22:37:10.332Z,1507329430.332 [CTD_NeilBrown](INFO): Powering down
2017-10-06T22:37:10.333Z,1507329430.333 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2017-10-06T22:37:10.336Z,1507329430.336 [ComponentRegistry](INFO): Shutting down Rowe_600LCM ThreadHandler
2017-10-06T22:37:10.336Z,1507329430.336 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled.
2017-10-06T22:37:10.336Z,1507329430.336 [Rowe_600LCM](INFO): Join timeout helper Thread ID is 776
2017-10-06T22:37:10.520Z,1507329430.520 [Rowe_600LCM ThreadHandler](INFO): Uninitializing protected caller thread.
2017-10-06T22:37:10.520Z,1507329430.520 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2017-10-06T22:37:10.609Z,1507329430.609 [Rowe_600LCM](INFO): Powering down
2017-10-06T22:37:10.610Z,1507329430.610 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled.
2017-10-06T22:37:10.611Z,1507329430.611 [Aanderaa_O2](INFO): Powering down
2017-10-06T22:37:10.617Z,1507329430.617 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2017-10-06T22:37:10.617Z,1507329430.617 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2017-10-06T22:37:10.617Z,1507329430.617 [Radio_Surface](INFO): Join timeout helper Thread ID is 778
2017-10-06T22:37:10.624Z,1507329430.624 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:37:10.626Z,1507329430.626 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:37:10.665Z,1507329430.665 [CBIT](ERROR): Communications Fault in component: CTD_NeilBrown
2017-10-06T22:37:10.665Z,1507329430.665 [CBIT](INFO): Clearing failed state for component CTD_NeilBrown
2017-10-06T22:37:10.665Z,1507329430.665 [CTD_NeilBrown] No Fault, FailCount= 2
2017-10-06T22:37:10.674Z,1507329430.674 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2017-10-06T22:37:10.674Z,1507329430.674 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 2
2017-10-06T22:37:10.674Z,1507329430.674 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2017-10-06T22:37:10.730Z,1507329430.730 [NAL9602](ERROR): NAL9602 initialization error.
2017-10-06T22:37:10.730Z,1507329430.730 [NAL9602] Communications Fault, FailCount= 1
2017-10-06T22:37:10.730Z,1507329430.730 [NAL9602](ERROR): Communications Fault
2017-10-06T22:37:10.761Z,1507329430.761 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2017-10-06T22:37:10.761Z,1507329430.761 [PNI_TCM] Data Fault, FailCount= 3
2017-10-06T22:37:10.762Z,1507329430.762 [PNI_TCM](ERROR): Data Fault
2017-10-06T22:37:10.763Z,1507329430.763 [BPC1](FAULT): Failed to initialize
2017-10-06T22:37:10.763Z,1507329430.763 [BPC1] Communications Fault, FailCount= 3
2017-10-06T22:37:10.763Z,1507329430.763 [BPC1](ERROR): Communications Fault
2017-10-06T22:37:10.769Z,1507329430.769 [Aanderaa_O2](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Software Overcurrent. Current Limiter Activated.
2017-10-06T22:37:10.769Z,1507329430.769 [Aanderaa_O2] Hardware Fault, FailCount= 3
2017-10-06T22:37:10.769Z,1507329430.769 [Aanderaa_O2](ERROR): Hardware Fault
2017-10-06T22:37:10.775Z,1507329430.775 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:37:10.777Z,1507329430.777 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:37:10.811Z,1507329430.811 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2017-10-06T22:37:10.812Z,1507329430.812 [CBIT](ERROR): Communications Fault in component: NAL9602
2017-10-06T22:37:10.812Z,1507329430.812 [CBIT](ERROR): Data Fault in component: PNI_TCM
2017-10-06T22:37:10.812Z,1507329430.812 [CBIT](ERROR): Communications Fault in component: BPC1
2017-10-06T22:37:10.976Z,1507329430.976 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2017-10-06T22:37:10.976Z,1507329430.976 [Radio_Surface ThreadHandler](INFO): Thread cancelled.