2017-10-11T20:53:40.627Z,1507755220.627 [Supervisor](DEBUG): Initializing supervisor.
2017-10-11T20:53:40.630Z,1507755220.630 [SyncHandler](DEBUG): Created PCaller Thread at 4051A4E0
2017-10-11T20:53:40.631Z,1507755220.631 [SyncHandler](INFO): Protected caller Thread ID is 807
2017-10-11T20:53:40.631Z,1507755220.631 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2017-10-11T20:53:40.632Z,1507755220.632 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4054A4E0
2017-10-11T20:53:40.632Z,1507755220.632 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 808
2017-10-11T20:53:40.635Z,1507755220.635 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2017-10-11T20:53:40.647Z,1507755220.647 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2017-10-11T20:53:40.648Z,1507755220.648 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 4057A4E0
2017-10-11T20:53:40.648Z,1507755220.648 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 809
2017-10-11T20:53:40.649Z,1507755220.649 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2017-10-11T20:53:40.650Z,1507755220.650 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405AA4E0
2017-10-11T20:53:40.650Z,1507755220.650 [logger ThreadHandler](INFO): Protected caller Thread ID is 810
2017-10-11T20:53:40.652Z,1507755220.652 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2017-10-11T20:53:40.653Z,1507755220.653 [Supervisor](INFO): Looking for Config files in directory: Config/
2017-10-11T20:53:40.656Z,1507755220.656 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2017-10-11T20:53:40.763Z,1507755220.763 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2017-10-11T20:53:40.765Z,1507755220.765 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2017-10-11T20:53:40.884Z,1507755220.884 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2017-10-11T20:53:40.886Z,1507755220.886 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2017-10-11T20:53:41.094Z,1507755221.094 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2017-10-11T20:53:41.096Z,1507755221.096 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2017-10-11T20:53:41.385Z,1507755221.385 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2017-10-11T20:53:41.387Z,1507755221.387 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2017-10-11T20:53:41.884Z,1507755221.884 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2017-10-11T20:53:41.885Z,1507755221.885 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2017-10-11T20:53:42.404Z,1507755222.404 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2017-10-11T20:53:42.405Z,1507755222.405 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2017-10-11T20:53:42.800Z,1507755222.800 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2017-10-11T20:53:42.801Z,1507755222.801 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2017-10-11T20:53:43.383Z,1507755223.383 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2017-10-11T20:53:43.385Z,1507755223.385 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2017-10-11T20:53:43.483Z,1507755223.483 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2017-10-11T20:53:43.820Z,1507755223.820 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2017-10-11T20:53:43.821Z,1507755223.821 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2017-10-11T20:53:43.972Z,1507755223.972 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2017-10-11T20:53:43.972Z,1507755223.972 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2017-10-11T20:53:44.212Z,1507755224.212 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2017-10-11T20:53:44.212Z,1507755224.212 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2017-10-11T20:53:44.447Z,1507755224.447 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2017-10-11T20:53:44.447Z,1507755224.447 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2017-10-11T20:53:44.577Z,1507755224.577 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2017-10-11T20:53:44.578Z,1507755224.578 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2017-10-11T20:53:44.743Z,1507755224.743 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2017-10-11T20:53:44.745Z,1507755224.745 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2017-10-11T20:53:44.746Z,1507755224.746 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2017-10-11T20:53:45.042Z,1507755225.042 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2017-10-11T20:53:45.043Z,1507755225.043 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2017-10-11T20:53:45.142Z,1507755225.142 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2017-10-11T20:53:45.303Z,1507755225.303 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2017-10-11T20:53:45.415Z,1507755225.415 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2017-10-11T20:53:45.515Z,1507755225.515 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2017-10-11T20:53:45.669Z,1507755225.669 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2017-10-11T20:53:45.853Z,1507755225.853 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2017-10-11T20:53:45.965Z,1507755225.965 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2017-10-11T20:53:46.073Z,1507755226.073 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2017-10-11T20:53:46.185Z,1507755226.185 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2017-10-11T20:53:46.343Z,1507755226.343 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/
2017-10-11T20:53:46.344Z,1507755226.344 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2017-10-11T20:53:46.347Z,1507755226.347 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2017-10-11T20:53:46.475Z,1507755226.475 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2017-10-11T20:53:46.476Z,1507755226.476 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2017-10-11T20:53:46.484Z,1507755226.484 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2017-10-11T20:53:46.485Z,1507755226.485 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2017-10-11T20:53:46.524Z,1507755226.524 [DepthRateCalculator] Loaded
2017-10-11T20:53:46.525Z,1507755226.525 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2017-10-11T20:53:46.531Z,1507755226.531 [PitchRateCalculator] Loaded
2017-10-11T20:53:46.531Z,1507755226.531 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2017-10-11T20:53:46.547Z,1507755226.547 [SpeedCalculator] Loaded
2017-10-11T20:53:46.548Z,1507755226.548 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2017-10-11T20:53:46.569Z,1507755226.569 [TempGradientCalculator] Loaded
2017-10-11T20:53:46.570Z,1507755226.570 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2017-10-11T20:53:46.585Z,1507755226.585 [VerticalTemperatureHomogeneityIndexCalculator] Loaded
2017-10-11T20:53:46.586Z,1507755226.586 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread.
2017-10-11T20:53:46.591Z,1507755226.591 [YawRateCalculator] Loaded
2017-10-11T20:53:46.592Z,1507755226.592 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2017-10-11T20:53:46.592Z,1507755226.592 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2017-10-11T20:53:46.593Z,1507755226.593 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2017-10-11T20:53:46.630Z,1507755226.630 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2017-10-11T20:53:46.631Z,1507755226.631 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2017-10-11T20:53:47.076Z,1507755227.076 [AcousticModem_Benthos_ATM900] Loaded
2017-10-11T20:53:47.076Z,1507755227.076 [ComponentRegistry](DEBUG): SyncComponent "AcousticModem_Benthos_ATM900" handled in the control thread.
2017-10-11T20:53:47.215Z,1507755227.215 [DataOverHttps] Loaded
2017-10-11T20:53:47.216Z,1507755227.216 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2017-10-11T20:53:47.230Z,1507755227.230 [Depth_Keller] Loaded
2017-10-11T20:53:47.230Z,1507755227.230 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2017-10-11T20:53:47.236Z,1507755227.236 [DropWeight] Loaded
2017-10-11T20:53:47.236Z,1507755227.236 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2017-10-11T20:53:47.341Z,1507755227.341 [NAL9602] Loaded
2017-10-11T20:53:47.341Z,1507755227.341 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2017-10-11T20:53:47.358Z,1507755227.358 [Onboard] Loaded
2017-10-11T20:53:47.359Z,1507755227.359 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2017-10-11T20:53:47.369Z,1507755227.369 [Radio_Surface] Loaded
2017-10-11T20:53:47.370Z,1507755227.370 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2017-10-11T20:53:47.371Z,1507755227.371 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4087F4E0
2017-10-11T20:53:47.371Z,1507755227.371 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 890
2017-10-11T20:53:47.526Z,1507755227.526 [PNI_TCM] Loaded
2017-10-11T20:53:47.527Z,1507755227.527 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread.
2017-10-11T20:53:47.590Z,1507755227.590 [Rowe_600LCM] Loaded
2017-10-11T20:53:47.590Z,1507755227.590 [ComponentRegistry](DEBUG): Component "Rowe_600LCM" handled in its own thread.
2017-10-11T20:53:47.591Z,1507755227.591 [Rowe_600LCM ThreadHandler](DEBUG): Created PCaller Thread at 408AF4E0
2017-10-11T20:53:47.592Z,1507755227.592 [Rowe_600LCM ThreadHandler](INFO): Protected caller Thread ID is 891
2017-10-11T20:53:49.650Z,1507755229.650 [BPC1] Loaded
2017-10-11T20:53:49.650Z,1507755229.650 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2017-10-11T20:53:49.651Z,1507755229.651 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2017-10-11T20:53:49.653Z,1507755229.653 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2017-10-11T20:53:49.791Z,1507755229.791 [SBIT](DEBUG): Construct Startup Built In Test.
2017-10-11T20:53:49.820Z,1507755229.820 [SBIT] Loaded
2017-10-11T20:53:49.820Z,1507755229.820 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2017-10-11T20:53:49.821Z,1507755229.821 [IBIT](DEBUG): Construct Initiated Built In Test.
2017-10-11T20:53:49.834Z,1507755229.834 [IBIT] Loaded
2017-10-11T20:53:49.834Z,1507755229.834 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2017-10-11T20:53:49.838Z,1507755229.838 [CBIT](DEBUG): Construct Continuous Built In Test.
2017-10-11T20:53:50.011Z,1507755230.011 [CBIT] Loaded
2017-10-11T20:53:50.011Z,1507755230.011 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2017-10-11T20:53:50.012Z,1507755230.012 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2017-10-11T20:53:50.012Z,1507755230.012 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2017-10-11T20:53:50.180Z,1507755230.180 [Aanderaa_O2] Loaded
2017-10-11T20:53:50.180Z,1507755230.180 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2017-10-11T20:53:50.270Z,1507755230.270 [CTD_NeilBrown] Loaded
2017-10-11T20:53:50.270Z,1507755230.270 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2017-10-11T20:53:50.271Z,1507755230.271 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 4096B4E0
2017-10-11T20:53:50.272Z,1507755230.272 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 892
2017-10-11T20:53:50.274Z,1507755230.274 [ESPComponent](CRITICAL): Could not find element ESPComponent.secLoadControl
2017-10-11T20:53:50.274Z,1507755230.274 [ESPComponent](ERROR): Could not open device '/dev/invalid' at ESPComponent.secLoadControl
2017-10-11T20:53:50.291Z,1507755230.291 [ESPComponent] Loaded
2017-10-11T20:53:50.291Z,1507755230.291 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2017-10-11T20:53:50.306Z,1507755230.306 [PAR_Licor] Loaded
2017-10-11T20:53:50.307Z,1507755230.307 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2017-10-11T20:53:50.357Z,1507755230.357 [WetLabsBB2FL] Loaded
2017-10-11T20:53:50.357Z,1507755230.357 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2017-10-11T20:53:50.358Z,1507755230.358 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 4099B4E0
2017-10-11T20:53:50.358Z,1507755230.358 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 893
2017-10-11T20:53:50.359Z,1507755230.359 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2017-10-11T20:53:50.359Z,1507755230.359 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2017-10-11T20:53:50.609Z,1507755230.609 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2017-10-11T20:53:50.610Z,1507755230.610 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2017-10-11T20:53:50.692Z,1507755230.692 [VerticalControl](DEBUG): Construct VerticalControl.
2017-10-11T20:53:50.795Z,1507755230.795 [VerticalControl] Loaded
2017-10-11T20:53:50.795Z,1507755230.795 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2017-10-11T20:53:50.796Z,1507755230.796 [HorizontalControl](DEBUG): Construct HorizontalControl.
2017-10-11T20:53:50.864Z,1507755230.864 [HorizontalControl] Loaded
2017-10-11T20:53:50.864Z,1507755230.864 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2017-10-11T20:53:50.865Z,1507755230.865 [SpeedControl](DEBUG): Construct SpeedControl.
2017-10-11T20:53:50.870Z,1507755230.870 [SpeedControl] Loaded
2017-10-11T20:53:50.871Z,1507755230.871 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2017-10-11T20:53:50.872Z,1507755230.872 [BackSeatDriver](DEBUG): Construct BackSeatDriver.
2017-10-11T20:53:50.874Z,1507755230.874 [BackSeatDriver] Loaded
2017-10-11T20:53:50.874Z,1507755230.874 [ComponentRegistry](DEBUG): SyncComponent "BackSeatDriver" handled in the control thread.
2017-10-11T20:53:50.875Z,1507755230.875 [LoopControl](DEBUG): Construct LoopControl.
2017-10-11T20:53:50.875Z,1507755230.875 [LoopControl] Loaded
2017-10-11T20:53:50.876Z,1507755230.876 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2017-10-11T20:53:50.876Z,1507755230.876 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2017-10-11T20:53:50.877Z,1507755230.877 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2017-10-11T20:53:50.991Z,1507755230.991 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC
2017-10-11T20:53:50.992Z,1507755230.992 [StratificationFrontDetector](DEBUG): (re)initializing
2017-10-11T20:53:50.992Z,1507755230.992 [StratificationFrontDetector] Loaded
2017-10-11T20:53:50.992Z,1507755230.992 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread.
2017-10-11T20:53:50.993Z,1507755230.993 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2017-10-11T20:53:50.993Z,1507755230.993 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2017-10-11T20:53:51.105Z,1507755231.105 [BuoyancyServo] Loaded
2017-10-11T20:53:51.105Z,1507755231.105 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2017-10-11T20:53:51.118Z,1507755231.118 [ElevatorServo] Loaded
2017-10-11T20:53:51.118Z,1507755231.118 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2017-10-11T20:53:51.130Z,1507755231.130 [MassServo] Loaded
2017-10-11T20:53:51.130Z,1507755231.130 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2017-10-11T20:53:51.142Z,1507755231.142 [RudderServo] Loaded
2017-10-11T20:53:51.142Z,1507755231.142 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2017-10-11T20:53:51.154Z,1507755231.154 [ThrusterServo] Loaded
2017-10-11T20:53:51.154Z,1507755231.154 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2017-10-11T20:53:51.155Z,1507755231.155 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2017-10-11T20:53:51.155Z,1507755231.155 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2017-10-11T20:53:51.276Z,1507755231.276 [DeadReckonUsingMultipleVelocitySources] Loaded
2017-10-11T20:53:51.277Z,1507755231.277 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2017-10-11T20:53:51.338Z,1507755231.338 [DeadReckonUsingSpeedCalculator] Loaded
2017-10-11T20:53:51.338Z,1507755231.338 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2017-10-11T20:53:51.355Z,1507755231.355 [NavChart] Loaded
2017-10-11T20:53:51.356Z,1507755231.356 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2017-10-11T20:53:51.360Z,1507755231.360 [UniversalFixResidualReporter] Loaded
2017-10-11T20:53:51.360Z,1507755231.360 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2017-10-11T20:53:51.361Z,1507755231.361 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2017-10-11T20:53:51.369Z,1507755231.369 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2017-10-11T20:53:51.370Z,1507755231.370 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2017-10-11T20:53:51.378Z,1507755231.378 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2017-10-11T20:53:51.379Z,1507755231.379 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AE24E0
2017-10-11T20:53:51.380Z,1507755231.380 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 894
2017-10-11T20:53:51.392Z,1507755231.392 [Supervisor](INFO): Main Thread ID is 806
2017-10-11T20:53:51.392Z,1507755231.392 [Supervisor](DEBUG): Running supervisor.
2017-10-11T20:53:51.393Z,1507755231.393 [CommandLine ThreadHandler](INFO): Handler Thread ID is 895
2017-10-11T20:53:51.396Z,1507755231.396 [controlThread ThreadHandler](INFO): Handler Thread ID is 896
2017-10-11T20:53:51.396Z,1507755231.396 [controlThread](DEBUG): Initializing ControlThread
2017-10-11T20:53:51.397Z,1507755231.397 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2017-10-11T20:53:51.397Z,1507755231.397 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2017-10-11T20:53:51.398Z,1507755231.398 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2017-10-11T20:53:51.398Z,1507755231.398 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2017-10-11T20:53:51.399Z,1507755231.399 [VerticalTemperatureHomogeneityIndexCalculator](DEBUG): (re)initializing
2017-10-11T20:53:51.400Z,1507755231.400 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2017-10-11T20:53:51.406Z,1507755231.406 [SBIT](INFO): Initialize SBIT Component.
2017-10-11T20:53:51.406Z,1507755231.406 [SBIT](IMPORTANT): git: 2017-08-02
2017-10-11T20:53:51.407Z,1507755231.407 [SBIT](INFO): git hash: b8bd19726fcc84d3133bb9e1cbad184cc93bb52c
2017-10-11T20:53:51.407Z,1507755231.407 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2017-10-11T20:53:51.408Z,1507755231.408 [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-11T20:53:51.409Z,1507755231.409 [SBIT](INFO): Beginning SBIT in 63.000000 seconds.
2017-10-11T20:53:51.410Z,1507755231.410 [IBIT](INFO): Initialize IBIT Component.
2017-10-11T20:53:51.411Z,1507755231.411 [CBIT](DEBUG): Initialize CBIT Component.
2017-10-11T20:53:51.411Z,1507755231.411 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL.
2017-10-11T20:53:51.411Z,1507755231.411 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2017-10-11T20:53:51.412Z,1507755231.412 [logger ThreadHandler](INFO): Handler Thread ID is 897
2017-10-11T20:53:51.414Z,1507755231.414 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 898
2017-10-11T20:53:51.439Z,1507755231.439 [Radio_Surface](INFO): Powering up
2017-10-11T20:53:51.440Z,1507755231.440 [Rowe_600LCM ThreadHandler](INFO): Handler Thread ID is 899
2017-10-11T20:53:51.440Z,1507755231.440 [Rowe_600LCM](INFO): Initializing
2017-10-11T20:53:51.441Z,1507755231.441 [Rowe_600LCM](INFO): Checking LCM
2017-10-11T20:53:51.499Z,1507755231.499 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2017-10-11T20:53:51.501Z,1507755231.501 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2017-10-11T20:53:51.502Z,1507755231.502 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2017-10-11T20:53:51.502Z,1507755231.502 [BackSeatDriver](DEBUG): Initialize BackSeatDriver Component.
2017-10-11T20:53:51.508Z,1507755231.508 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 900
2017-10-11T20:53:51.509Z,1507755231.509 [CTD_NeilBrown](INFO): Powering down
2017-10-11T20:53:51.587Z,1507755231.587 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 901
2017-10-11T20:53:51.588Z,1507755231.588 [WetLabsBB2FL](INFO): Powering down
2017-10-11T20:53:51.652Z,1507755231.652 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 902
2017-10-11T20:53:51.704Z,1507755231.704 [Rowe_600LCM](INFO): LCM OK
2017-10-11T20:53:51.705Z,1507755231.705 [Rowe_600LCM](INFO): Powering up
2017-10-11T20:53:51.763Z,1507755231.763 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2017-10-11T20:53:51.764Z,1507755231.764 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2017-10-11T20:53:51.764Z,1507755231.764 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2017-10-11T20:53:51.764Z,1507755231.764 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2017-10-11T20:53:51.764Z,1507755231.764 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2017-10-11T20:53:51.764Z,1507755231.764 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2017-10-11T20:53:51.764Z,1507755231.764 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2017-10-11T20:53:51.765Z,1507755231.765 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2017-10-11T20:53:51.765Z,1507755231.765 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2017-10-11T20:53:51.765Z,1507755231.765 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2017-10-11T20:53:51.765Z,1507755231.765 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2017-10-11T20:53:51.765Z,1507755231.765 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2017-10-11T20:53:51.765Z,1507755231.765 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2017-10-11T20:53:51.766Z,1507755231.766 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2017-10-11T20:53:51.766Z,1507755231.766 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2017-10-11T20:53:51.766Z,1507755231.766 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2017-10-11T20:53:51.948Z,1507755231.948 [LoopControl](DEBUG): Initialize LoopControlComponent.
2017-10-11T20:53:51.950Z,1507755231.950 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2017-10-11T20:53:51.950Z,1507755231.950 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2017-10-11T20:53:51.951Z,1507755231.951 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2017-10-11T20:53:51.964Z,1507755231.964 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2017-10-11T20:53:51.964Z,1507755231.964 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2017-10-11T20:53:51.965Z,1507755231.965 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2017-10-11T20:53:51.965Z,1507755231.965 [NavChart](DEBUG): Initialize NavChart Navigation.
2017-10-11T20:53:51.976Z,1507755231.976 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2017-10-11T20:53:51.977Z,1507755231.977 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2017-10-11T20:53:52.019Z,1507755232.019 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2017-10-11T20:53:52.057Z,1507755232.057 [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-11T20:53:52.063Z,1507755232.063 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2017-10-11T20:53:52.146Z,1507755232.146 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2017-10-11T20:53:52.147Z,1507755232.147 [Default:A.Wait](DEBUG): Construct Wait.
2017-10-11T20:53:52.149Z,1507755232.149 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2017-10-11T20:53:52.185Z,1507755232.185 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2017-10-11T20:53:52.187Z,1507755232.187 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2017-10-11T20:53:52.210Z,1507755232.210 [Default:E.Execute](DEBUG): Construct Execute.
2017-10-11T20:53:52.230Z,1507755232.230 [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-11T20:53:52.236Z,1507755232.236 [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,BackSeatDriver,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2017-10-11T20:53:52.280Z,1507755232.280 [AcousticModem_Benthos_ATM900](INFO): Powering up
2017-10-11T20:53:52.280Z,1507755232.280 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2017-10-11T20:53:52.320Z,1507755232.320 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2017-10-11T20:53:52.464Z,1507755232.464 [NAL9602](INFO): Powering up NAL9602
2017-10-11T20:53:52.695Z,1507755232.695 [ESPComponent](INFO): powering down ESP
2017-10-11T20:53:53.261Z,1507755233.261 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:53:53.430Z,1507755233.430 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:53:53.648Z,1507755233.648 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2017-10-11T20:53:53.655Z,1507755233.655 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2017-10-11T20:53:53.679Z,1507755233.679 [ElevatorServo](DEBUG): Initializing EZServoServo.
2017-10-11T20:53:53.687Z,1507755233.687 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2017-10-11T20:53:53.710Z,1507755233.710 [MassServo](DEBUG): Initializing EZServoServo.
2017-10-11T20:53:53.715Z,1507755233.715 [MassServo](DEBUG): Initializing MassServo.
2017-10-11T20:53:53.745Z,1507755233.745 [RudderServo](DEBUG): Initializing EZServoServo.
2017-10-11T20:53:53.751Z,1507755233.751 [RudderServo](DEBUG): Initializing RudderServo.
2017-10-11T20:53:53.757Z,1507755233.757 [ThrusterServo](DEBUG): Initializing EZServoServo.
2017-10-11T20:53:53.763Z,1507755233.763 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2017-10-11T20:53:53.803Z,1507755233.803 [CommandLine](FAULT): Scheduling is paused
2017-10-11T20:53:53.804Z,1507755233.804 [CBIT](INFO): Critical error at 20171011T205350
2017-10-11T20:53:53.804Z,1507755233.804 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2017-10-11T20:53:54.110Z,1507755234.110 [Depth_Keller](INFO): A/D timeout, 9 tries over 131 ms

2017-10-11T20:53:54.110Z,1507755234.110 [Depth_Keller] Data Fault, FailCount= 1
2017-10-11T20:53:54.110Z,1507755234.110 [Depth_Keller](ERROR): Data Fault
2017-10-11T20:53:54.111Z,1507755234.111 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2017-10-11T20:53:54.111Z,1507755234.111 [DropWeight] Hardware Fault, FailCount= 1
2017-10-11T20:53:54.112Z,1507755234.112 [DropWeight](ERROR): Hardware Fault
2017-10-11T20:53:54.198Z,1507755234.198 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:53:54.199Z,1507755234.199 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:53:54.439Z,1507755234.439 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown.
2017-10-11T20:53:54.447Z,1507755234.447 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2017-10-11T20:53:54.643Z,1507755234.643 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2017-10-11T20:53:54.643Z,1507755234.643 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2017-10-11T20:53:54.643Z,1507755234.643 [BuoyancyServo] Communications Fault, FailCount= 1
2017-10-11T20:53:54.643Z,1507755234.643 [BuoyancyServo](ERROR): Communications Fault
2017-10-11T20:53:54.851Z,1507755234.851 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:53:55.063Z,1507755235.063 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout
2017-10-11T20:53:55.259Z,1507755235.259 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:53:55.387Z,1507755235.387 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout
2017-10-11T20:53:55.387Z,1507755235.387 [ThrusterServo](FAULT): Thruster failed to initialize
2017-10-11T20:53:55.387Z,1507755235.387 [ThrusterServo] Communications Fault, FailCount= 1
2017-10-11T20:53:55.387Z,1507755235.387 [ThrusterServo](ERROR): Communications Fault
2017-10-11T20:53:55.389Z,1507755235.389 [CBIT](INFO): Critical error at 20171011T205354
2017-10-11T20:53:55.391Z,1507755235.391 [CBIT](ERROR): Data Fault in component: Depth_Keller
2017-10-11T20:53:55.391Z,1507755235.391 [CBIT](INFO): Clearing failed state for component Depth_Keller
2017-10-11T20:53:55.392Z,1507755235.392 [Depth_Keller] No Fault, FailCount= 1
2017-10-11T20:53:55.392Z,1507755235.392 [CBIT](ERROR): Hardware Fault in component: DropWeight
2017-10-11T20:53:55.392Z,1507755235.392 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2017-10-11T20:53:55.393Z,1507755235.393 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2017-10-11T20:53:55.393Z,1507755235.393 [CBIT](ERROR): Communications Fault in component: ThrusterServo
2017-10-11T20:53:55.667Z,1507755235.667 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:53:56.081Z,1507755236.081 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2017-10-11T20:53:56.232Z,1507755236.232 [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-11T20:53:56.235Z,1507755236.235 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2017-10-11T20:53:56.236Z,1507755236.236 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2017-10-11T20:53:56.238Z,1507755236.238 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2017-10-11T20:54:04.663Z,1507755244.663 [Aanderaa_O2](FAULT): Timed out starting
2017-10-11T20:54:04.663Z,1507755244.663 [Aanderaa_O2] Communications Fault, FailCount= 1
2017-10-11T20:54:04.663Z,1507755244.663 [Aanderaa_O2](ERROR): Communications Fault
2017-10-11T20:54:04.686Z,1507755244.686 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:04.695Z,1507755244.695 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:04.820Z,1507755244.820 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2017-10-11T20:54:04.820Z,1507755244.820 [BuoyancyServo](INFO): Powering down
2017-10-11T20:54:04.957Z,1507755244.957 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2017-10-11T20:54:04.958Z,1507755244.958 [ThrusterServo](INFO): Powering down
2017-10-11T20:54:05.023Z,1507755245.023 [CBIT](INFO): Critical error at 20171011T205355
2017-10-11T20:54:05.025Z,1507755245.025 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2017-10-11T20:54:05.087Z,1507755245.087 [Aanderaa_O2](INFO): Powering down
2017-10-11T20:54:05.189Z,1507755245.189 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:05.190Z,1507755245.190 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:05.623Z,1507755245.623 [ElevatorServo](FAULT): Elevator initialization uart error:serial timeout
2017-10-11T20:54:05.623Z,1507755245.623 [ElevatorServo] Communications Fault, FailCount= 1
2017-10-11T20:54:05.623Z,1507755245.623 [ElevatorServo](ERROR): Communications Fault
2017-10-11T20:54:05.883Z,1507755245.883 [MassServo](FAULT): Mass initialization uart error:serial timeout
2017-10-11T20:54:05.883Z,1507755245.883 [MassServo] Communications Fault, FailCount= 1
2017-10-11T20:54:05.883Z,1507755245.883 [MassServo](ERROR): Communications Fault
2017-10-11T20:54:06.195Z,1507755246.195 [RudderServo](FAULT): Rudder initialization uart error:serial timeout
2017-10-11T20:54:06.195Z,1507755246.195 [RudderServo] Communications Fault, FailCount= 1
2017-10-11T20:54:06.195Z,1507755246.195 [RudderServo](ERROR): Communications Fault
2017-10-11T20:54:06.199Z,1507755246.199 [CBIT](ERROR): Communications Fault in component: ElevatorServo
2017-10-11T20:54:06.200Z,1507755246.200 [CBIT](ERROR): Communications Fault in component: MassServo
2017-10-11T20:54:06.200Z,1507755246.200 [CBIT](ERROR): Communications Fault in component: RudderServo
2017-10-11T20:54:06.328Z,1507755246.328 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:06.330Z,1507755246.330 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:06.452Z,1507755246.452 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2017-10-11T20:54:06.452Z,1507755246.452 [ElevatorServo](INFO): Powering down
2017-10-11T20:54:06.497Z,1507755246.497 [MassServo](DEBUG): Uninitialize Mass Servo.
2017-10-11T20:54:06.498Z,1507755246.498 [MassServo](INFO): Powering down
2017-10-11T20:54:06.551Z,1507755246.551 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2017-10-11T20:54:06.551Z,1507755246.551 [RudderServo](INFO): Powering down
2017-10-11T20:54:06.614Z,1507755246.614 [CBIT](INFO): Clearing failed state for component ThrusterServo
2017-10-11T20:54:06.614Z,1507755246.614 [ThrusterServo] No Fault, FailCount= 1
2017-10-11T20:54:06.669Z,1507755246.669 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.030578
2017-10-11T20:54:06.724Z,1507755246.724 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:06.726Z,1507755246.726 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:06.849Z,1507755246.849 [ThrusterServo](DEBUG): Initializing EZServoServo.
2017-10-11T20:54:06.850Z,1507755246.850 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2017-10-11T20:54:06.854Z,1507755246.854 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2017-10-11T20:54:06.854Z,1507755246.854 [Aanderaa_O2] No Fault, FailCount= 1
2017-10-11T20:54:07.120Z,1507755247.120 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:07.122Z,1507755247.122 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:07.245Z,1507755247.245 [ElevatorServo](DEBUG): Initializing EZServoServo.
2017-10-11T20:54:07.245Z,1507755247.245 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2017-10-11T20:54:07.246Z,1507755247.246 [MassServo](DEBUG): Initializing EZServoServo.
2017-10-11T20:54:07.246Z,1507755247.246 [MassServo](DEBUG): Initializing MassServo.
2017-10-11T20:54:07.247Z,1507755247.247 [RudderServo](DEBUG): Initializing EZServoServo.
2017-10-11T20:54:07.248Z,1507755247.248 [RudderServo](DEBUG): Initializing RudderServo.
2017-10-11T20:54:07.252Z,1507755247.252 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2017-10-11T20:54:07.252Z,1507755247.252 [BuoyancyServo] No Fault, FailCount= 1
2017-10-11T20:54:07.252Z,1507755247.252 [CBIT](INFO): Clearing failed state for component ElevatorServo
2017-10-11T20:54:07.252Z,1507755247.252 [ElevatorServo] No Fault, FailCount= 1
2017-10-11T20:54:07.252Z,1507755247.252 [CBIT](INFO): Clearing failed state for component MassServo
2017-10-11T20:54:07.252Z,1507755247.252 [MassServo] No Fault, FailCount= 1
2017-10-11T20:54:07.253Z,1507755247.253 [CBIT](INFO): Clearing failed state for component RudderServo
2017-10-11T20:54:07.253Z,1507755247.253 [RudderServo] No Fault, FailCount= 1
2017-10-11T20:54:07.601Z,1507755247.601 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:07.616Z,1507755247.616 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:07.780Z,1507755247.780 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2017-10-11T20:54:07.780Z,1507755247.780 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2017-10-11T20:54:08.091Z,1507755248.091 [ElevatorServo](ERROR): Elevator initialization uart error I:serial timeout
2017-10-11T20:54:08.091Z,1507755248.091 [ElevatorServo](FAULT): Elevator failed to initialize
2017-10-11T20:54:08.091Z,1507755248.091 [ElevatorServo] Communications Fault, FailCount= 2
2017-10-11T20:54:08.091Z,1507755248.091 [ElevatorServo](ERROR): Communications Fault
2017-10-11T20:54:08.419Z,1507755248.419 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout
2017-10-11T20:54:08.743Z,1507755248.743 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout
2017-10-11T20:54:08.743Z,1507755248.743 [ThrusterServo](FAULT): Thruster failed to initialize
2017-10-11T20:54:08.743Z,1507755248.743 [ThrusterServo] Communications Fault, FailCount= 2
2017-10-11T20:54:08.743Z,1507755248.743 [ThrusterServo](ERROR): Communications Fault
2017-10-11T20:54:08.747Z,1507755248.747 [CBIT](ERROR): Communications Fault in component: ElevatorServo
2017-10-11T20:54:08.747Z,1507755248.747 [CBIT](ERROR): Communications Fault in component: ThrusterServo
2017-10-11T20:54:08.895Z,1507755248.895 [Depth_Keller](INFO): A/D timeout, 7 tries over 138 ms

2017-10-11T20:54:08.895Z,1507755248.895 [Depth_Keller] Data Fault, FailCount= 1
2017-10-11T20:54:08.895Z,1507755248.895 [Depth_Keller](ERROR): Data Fault
2017-10-11T20:54:08.914Z,1507755248.914 [BPC1](FAULT): Failed to initialize
2017-10-11T20:54:08.914Z,1507755248.914 [BPC1] Communications Fault, FailCount= 1
2017-10-11T20:54:08.914Z,1507755248.914 [BPC1](ERROR): Communications Fault
2017-10-11T20:54:08.940Z,1507755248.940 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:08.941Z,1507755248.941 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:09.127Z,1507755249.127 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2017-10-11T20:54:09.252Z,1507755249.252 [Radio_Surface](INFO): Powering down
2017-10-11T20:54:09.375Z,1507755249.375 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2017-10-11T20:54:09.375Z,1507755249.375 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2017-10-11T20:54:09.375Z,1507755249.375 [BuoyancyServo] Communications Fault, FailCount= 2
2017-10-11T20:54:09.375Z,1507755249.375 [BuoyancyServo](ERROR): Communications Fault
2017-10-11T20:54:09.376Z,1507755249.376 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2017-10-11T20:54:09.376Z,1507755249.376 [ElevatorServo](INFO): Powering down
2017-10-11T20:54:09.378Z,1507755249.378 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2017-10-11T20:54:09.378Z,1507755249.378 [ThrusterServo](INFO): Powering down
2017-10-11T20:54:09.382Z,1507755249.382 [CBIT](ERROR): Data Fault in component: Depth_Keller
2017-10-11T20:54:09.382Z,1507755249.382 [CBIT](INFO): Clearing failed state for component Depth_Keller
2017-10-11T20:54:09.383Z,1507755249.383 [Depth_Keller] No Fault, FailCount= 1
2017-10-11T20:54:09.384Z,1507755249.384 [CBIT](ERROR): Communications Fault in component: BPC1
2017-10-11T20:54:09.384Z,1507755249.384 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2017-10-11T20:54:09.472Z,1507755249.472 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:09.473Z,1507755249.473 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:09.531Z,1507755249.531 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:54:09.600Z,1507755249.600 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2017-10-11T20:54:09.600Z,1507755249.600 [BuoyancyServo](INFO): Powering down
2017-10-11T20:54:09.871Z,1507755249.871 [MassServo](FAULT): Mass initialization uart error:serial timeout
2017-10-11T20:54:09.871Z,1507755249.871 [MassServo] Communications Fault, FailCount= 2
2017-10-11T20:54:09.871Z,1507755249.871 [MassServo](ERROR): Communications Fault
2017-10-11T20:54:09.881Z,1507755249.881 [CBIT](ERROR): Communications Fault in component: MassServo
2017-10-11T20:54:10.024Z,1507755250.024 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:10.025Z,1507755250.025 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:10.148Z,1507755250.148 [ElevatorServo](DEBUG): Initializing EZServoServo.
2017-10-11T20:54:10.149Z,1507755250.149 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2017-10-11T20:54:10.149Z,1507755250.149 [MassServo](DEBUG): Uninitialize Mass Servo.
2017-10-11T20:54:10.149Z,1507755250.149 [MassServo](INFO): Powering down
2017-10-11T20:54:10.155Z,1507755250.155 [CBIT](INFO): Clearing failed state for component ElevatorServo
2017-10-11T20:54:10.155Z,1507755250.155 [ElevatorServo] No Fault, FailCount= 2
2017-10-11T20:54:10.155Z,1507755250.155 [CBIT](INFO): Clearing failed state for component ThrusterServo
2017-10-11T20:54:10.155Z,1507755250.155 [ThrusterServo] No Fault, FailCount= 2
2017-10-11T20:54:10.355Z,1507755250.355 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:10.356Z,1507755250.356 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:10.496Z,1507755250.496 [RudderServo](FAULT): Bad Operand Error
2017-10-11T20:54:10.496Z,1507755250.496 [RudderServo] Hardware Fault, FailCount= 2
2017-10-11T20:54:10.497Z,1507755250.497 [RudderServo](ERROR): Hardware Fault
2017-10-11T20:54:10.498Z,1507755250.498 [RudderServo](ERROR): Rudder reporting null position
2017-10-11T20:54:10.656Z,1507755250.656 [ThrusterServo](DEBUG): Initializing EZServoServo.
2017-10-11T20:54:10.663Z,1507755250.663 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2017-10-11T20:54:10.687Z,1507755250.687 [CBIT](INFO): Clearing failed state for component BPC1
2017-10-11T20:54:10.687Z,1507755250.687 [BPC1] No Fault, FailCount= 1
2017-10-11T20:54:10.689Z,1507755250.689 [CBIT](ERROR): Hardware Fault in component: RudderServo
2017-10-11T20:54:10.756Z,1507755250.756 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.757Z,1507755250.757 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.758Z,1507755250.758 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.758Z,1507755250.758 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.758Z,1507755250.758 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.767Z,1507755250.767 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.767Z,1507755250.767 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.768Z,1507755250.768 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.768Z,1507755250.768 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.769Z,1507755250.769 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.769Z,1507755250.769 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.769Z,1507755250.769 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.770Z,1507755250.770 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.770Z,1507755250.770 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.770Z,1507755250.770 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.783Z,1507755250.783 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.783Z,1507755250.783 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.784Z,1507755250.784 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.784Z,1507755250.784 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.785Z,1507755250.785 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.785Z,1507755250.785 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.785Z,1507755250.785 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.786Z,1507755250.786 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.786Z,1507755250.786 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.786Z,1507755250.786 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.795Z,1507755250.795 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.795Z,1507755250.795 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.796Z,1507755250.796 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.796Z,1507755250.796 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.797Z,1507755250.797 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.797Z,1507755250.797 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.797Z,1507755250.797 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.798Z,1507755250.798 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.798Z,1507755250.798 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.798Z,1507755250.798 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.805Z,1507755250.805 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.807Z,1507755250.807 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.808Z,1507755250.808 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.808Z,1507755250.808 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.809Z,1507755250.809 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.810Z,1507755250.810 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.810Z,1507755250.810 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.810Z,1507755250.810 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.816Z,1507755250.816 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.827Z,1507755250.827 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.827Z,1507755250.827 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.828Z,1507755250.828 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.828Z,1507755250.828 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.828Z,1507755250.828 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.829Z,1507755250.829 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.830Z,1507755250.830 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.830Z,1507755250.830 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.830Z,1507755250.830 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.831Z,1507755250.831 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.831Z,1507755250.831 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.831Z,1507755250.831 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.832Z,1507755250.832 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.832Z,1507755250.832 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.833Z,1507755250.833 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.833Z,1507755250.833 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.833Z,1507755250.833 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.834Z,1507755250.834 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.834Z,1507755250.834 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.834Z,1507755250.834 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.851Z,1507755250.851 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.851Z,1507755250.851 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.852Z,1507755250.852 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.852Z,1507755250.852 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.852Z,1507755250.852 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.853Z,1507755250.853 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.853Z,1507755250.853 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.853Z,1507755250.853 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.854Z,1507755250.854 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.854Z,1507755250.854 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.854Z,1507755250.854 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.855Z,1507755250.855 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:10.855Z,1507755250.855 [PNI_TCM](ERROR): CRC does not match. Expected:0x44135 got:0x32084
2017-10-11T20:54:10.855Z,1507755250.855 [PNI_TCM](ERROR): CRC does not match. Expected:0x19946 got:0x0
2017-10-11T20:54:10.964Z,1507755250.964 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:10.965Z,1507755250.965 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:11.208Z,1507755251.208 [MassServo](DEBUG): Initializing EZServoServo.
2017-10-11T20:54:11.208Z,1507755251.208 [MassServo](DEBUG): Initializing MassServo.
2017-10-11T20:54:11.209Z,1507755251.209 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2017-10-11T20:54:11.209Z,1507755251.209 [RudderServo](INFO): Powering down
2017-10-11T20:54:11.531Z,1507755251.531 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout
2017-10-11T20:54:11.855Z,1507755251.855 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout
2017-10-11T20:54:11.855Z,1507755251.855 [ThrusterServo](FAULT): Thruster failed to initialize
2017-10-11T20:54:11.855Z,1507755251.855 [ThrusterServo] Communications Fault, FailCount= 3
2017-10-11T20:54:11.855Z,1507755251.855 [ThrusterServo](ERROR): Communications Fault
2017-10-11T20:54:11.859Z,1507755251.859 [CBIT](INFO): Clearing failed state for component MassServo
2017-10-11T20:54:11.860Z,1507755251.860 [MassServo] No Fault, FailCount= 2
2017-10-11T20:54:11.860Z,1507755251.860 [CBIT](ERROR): Communications Fault in component: ThrusterServo
2017-10-11T20:54:11.999Z,1507755251.999 [Depth_Keller](INFO): A/D timeout, 9 tries over 127 ms

2017-10-11T20:54:11.999Z,1507755251.999 [Depth_Keller] Data Fault, FailCount= 1
2017-10-11T20:54:11.999Z,1507755251.999 [Depth_Keller](ERROR): Data Fault
2017-10-11T20:54:12.035Z,1507755252.035 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.036Z,1507755252.036 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.036Z,1507755252.036 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.036Z,1507755252.036 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.037Z,1507755252.037 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.037Z,1507755252.037 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.037Z,1507755252.037 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.038Z,1507755252.038 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.038Z,1507755252.038 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.047Z,1507755252.047 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.047Z,1507755252.047 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.048Z,1507755252.048 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.048Z,1507755252.048 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.048Z,1507755252.048 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.049Z,1507755252.049 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.049Z,1507755252.049 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.049Z,1507755252.049 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.050Z,1507755252.050 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.050Z,1507755252.050 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.050Z,1507755252.050 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.056Z,1507755252.056 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.083Z,1507755252.083 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.084Z,1507755252.084 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.084Z,1507755252.084 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.084Z,1507755252.084 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.085Z,1507755252.085 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.085Z,1507755252.085 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.085Z,1507755252.085 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.086Z,1507755252.086 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.086Z,1507755252.086 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.086Z,1507755252.086 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.091Z,1507755252.091 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2017-10-11T20:54:12.095Z,1507755252.095 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.096Z,1507755252.096 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.096Z,1507755252.096 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.096Z,1507755252.096 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.097Z,1507755252.097 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.097Z,1507755252.097 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.097Z,1507755252.097 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.098Z,1507755252.098 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:12.098Z,1507755252.098 [PNI_TCM](ERROR): CRC does not match. Expected:0x13332 got:0x65114
2017-10-11T20:54:12.098Z,1507755252.098 [PNI_TCM](ERROR): CRC does not match. Expected:0x19805 got:0x0
2017-10-11T20:54:12.160Z,1507755252.160 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:12.162Z,1507755252.162 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:12.294Z,1507755252.294 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2017-10-11T20:54:12.294Z,1507755252.294 [ThrusterServo](INFO): Powering down
2017-10-11T20:54:12.333Z,1507755252.333 [CBIT](ERROR): Data Fault in component: Depth_Keller
2017-10-11T20:54:12.333Z,1507755252.333 [CBIT](INFO): Clearing failed state for component Depth_Keller
2017-10-11T20:54:12.333Z,1507755252.333 [Depth_Keller] No Fault, FailCount= 1
2017-10-11T20:54:12.363Z,1507755252.363 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2017-10-11T20:54:12.363Z,1507755252.363 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 1
2017-10-11T20:54:12.363Z,1507755252.363 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2017-10-11T20:54:12.433Z,1507755252.433 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:12.447Z,1507755252.447 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:12.499Z,1507755252.499 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:54:12.879Z,1507755252.879 [ElevatorServo](FAULT): Elevator initialization uart error:serial timeout
2017-10-11T20:54:12.879Z,1507755252.879 [ElevatorServo] Communications Fault, FailCount= 3
2017-10-11T20:54:12.879Z,1507755252.879 [ElevatorServo](ERROR): Communications Fault
2017-10-11T20:54:12.880Z,1507755252.880 [RudderServo](DEBUG): Initializing EZServoServo.
2017-10-11T20:54:12.881Z,1507755252.881 [RudderServo](DEBUG): Initializing RudderServo.
2017-10-11T20:54:12.885Z,1507755252.885 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2017-10-11T20:54:12.885Z,1507755252.885 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2017-10-11T20:54:12.885Z,1507755252.885 [BuoyancyServo] No Fault, FailCount= 2
2017-10-11T20:54:12.886Z,1507755252.886 [CBIT](ERROR): Communications Fault in component: ElevatorServo
2017-10-11T20:54:12.886Z,1507755252.886 [CBIT](CRITICAL): Communications Fault in component: ElevatorServo
2017-10-11T20:54:12.886Z,1507755252.886 [CBIT](INFO): Clearing failed state for component RudderServo
2017-10-11T20:54:12.886Z,1507755252.886 [RudderServo] No Fault, FailCount= 2
2017-10-11T20:54:12.892Z,1507755252.892 [AcousticModem_Benthos_ATM900](INFO): Powering down
2017-10-11T20:54:13.116Z,1507755253.116 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:13.117Z,1507755253.117 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:13.232Z,1507755253.232 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2017-10-11T20:54:13.232Z,1507755253.232 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2017-10-11T20:54:13.233Z,1507755253.233 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2017-10-11T20:54:13.233Z,1507755253.233 [ElevatorServo](INFO): Powering down
2017-10-11T20:54:13.237Z,1507755253.237 [CBIT](INFO): Critical error at 20171011T205412
2017-10-11T20:54:13.240Z,1507755253.240 [CBIT](INFO): Clearing failed state for component ThrusterServo
2017-10-11T20:54:13.240Z,1507755253.240 [ThrusterServo] No Fault, FailCount= 3
2017-10-11T20:54:13.358Z,1507755253.358 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:13.380Z,1507755253.380 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:13.807Z,1507755253.807 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2017-10-11T20:54:13.807Z,1507755253.807 [RudderServo](FAULT): Rudder failed to initialize
2017-10-11T20:54:13.807Z,1507755253.807 [RudderServo] Communications Fault, FailCount= 3
2017-10-11T20:54:13.807Z,1507755253.807 [RudderServo](ERROR): Communications Fault
2017-10-11T20:54:13.808Z,1507755253.808 [ThrusterServo](DEBUG): Initializing EZServoServo.
2017-10-11T20:54:13.808Z,1507755253.808 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2017-10-11T20:54:13.813Z,1507755253.813 [CBIT](ERROR): Communications Fault in component: RudderServo
2017-10-11T20:54:13.813Z,1507755253.813 [CBIT](CRITICAL): Communications Fault in component: RudderServo
2017-10-11T20:54:13.911Z,1507755253.911 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:13.912Z,1507755253.912 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:14.343Z,1507755254.343 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2017-10-11T20:54:14.343Z,1507755254.343 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2017-10-11T20:54:14.343Z,1507755254.343 [BuoyancyServo] Communications Fault, FailCount= 3
2017-10-11T20:54:14.343Z,1507755254.343 [BuoyancyServo](ERROR): Communications Fault
2017-10-11T20:54:14.344Z,1507755254.344 [ElevatorServo](DEBUG): Initializing EZServoServo.
2017-10-11T20:54:14.345Z,1507755254.345 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2017-10-11T20:54:14.607Z,1507755254.607 [MassServo](FAULT): Mass initialization uart error:serial timeout
2017-10-11T20:54:14.607Z,1507755254.607 [MassServo] Communications Fault, FailCount= 3
2017-10-11T20:54:14.607Z,1507755254.607 [MassServo](ERROR): Communications Fault
2017-10-11T20:54:14.608Z,1507755254.608 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2017-10-11T20:54:14.608Z,1507755254.608 [RudderServo](INFO): Powering down
2017-10-11T20:54:14.935Z,1507755254.935 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout
2017-10-11T20:54:15.259Z,1507755255.259 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout
2017-10-11T20:54:15.259Z,1507755255.259 [ThrusterServo](FAULT): Thruster failed to initialize
2017-10-11T20:54:15.259Z,1507755255.259 [ThrusterServo] Communications Fault, FailCount= 4
2017-10-11T20:54:15.259Z,1507755255.259 [ThrusterServo](ERROR): Communications Fault
2017-10-11T20:54:15.261Z,1507755255.261 [CBIT](INFO): Critical error at 20171011T205413
2017-10-11T20:54:15.263Z,1507755255.263 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2017-10-11T20:54:15.263Z,1507755255.263 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 1
2017-10-11T20:54:15.264Z,1507755255.264 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2017-10-11T20:54:15.264Z,1507755255.264 [CBIT](ERROR): Communications Fault in component: MassServo
2017-10-11T20:54:15.264Z,1507755255.264 [CBIT](ERROR): Communications Fault in component: ThrusterServo
2017-10-11T20:54:15.315Z,1507755255.315 [Radio_Surface](INFO): Powering up
2017-10-11T20:54:15.410Z,1507755255.410 [Depth_Keller](INFO): A/D timeout, 8 tries over 136 ms

2017-10-11T20:54:15.410Z,1507755255.410 [Depth_Keller] Data Fault, FailCount= 1
2017-10-11T20:54:15.410Z,1507755255.410 [Depth_Keller](ERROR): Data Fault
2017-10-11T20:54:15.411Z,1507755255.411 [NAL9602](ERROR): NAL9602 initialization error.
2017-10-11T20:54:15.411Z,1507755255.411 [NAL9602] Communications Fault, FailCount= 1
2017-10-11T20:54:15.411Z,1507755255.411 [NAL9602](ERROR): Communications Fault
2017-10-11T20:54:15.459Z,1507755255.459 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2017-10-11T20:54:15.469Z,1507755255.469 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:15.469Z,1507755255.469 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:15.470Z,1507755255.470 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:15.483Z,1507755255.483 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2017-10-11T20:54:15.483Z,1507755255.483 [PNI_TCM] Data Fault, FailCount= 1
2017-10-11T20:54:15.483Z,1507755255.483 [PNI_TCM](ERROR): Data Fault
2017-10-11T20:54:15.499Z,1507755255.499 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:15.501Z,1507755255.501 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:15.612Z,1507755255.612 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2017-10-11T20:54:15.612Z,1507755255.612 [BuoyancyServo](INFO): Powering down
2017-10-11T20:54:15.627Z,1507755255.627 [MassServo](DEBUG): Uninitialize Mass Servo.
2017-10-11T20:54:15.627Z,1507755255.627 [MassServo](INFO): Powering down
2017-10-11T20:54:15.629Z,1507755255.629 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2017-10-11T20:54:15.629Z,1507755255.629 [ThrusterServo](INFO): Powering down
2017-10-11T20:54:15.633Z,1507755255.633 [CBIT](ERROR): Data Fault in component: Depth_Keller
2017-10-11T20:54:15.633Z,1507755255.633 [CBIT](INFO): Clearing failed state for component Depth_Keller
2017-10-11T20:54:15.633Z,1507755255.633 [Depth_Keller] No Fault, FailCount= 1
2017-10-11T20:54:15.634Z,1507755255.634 [CBIT](ERROR): Communications Fault in component: NAL9602
2017-10-11T20:54:15.634Z,1507755255.634 [CBIT](ERROR): Data Fault in component: PNI_TCM
2017-10-11T20:54:15.676Z,1507755255.676 [NAL9602](INFO): Powering down
2017-10-11T20:54:15.693Z,1507755255.693 [PNI_TCM](INFO): Powering down
2017-10-11T20:54:15.764Z,1507755255.764 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:15.766Z,1507755255.766 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:15.867Z,1507755255.867 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:54:15.881Z,1507755255.881 [RudderServo](DEBUG): Initializing EZServoServo.
2017-10-11T20:54:15.881Z,1507755255.881 [RudderServo](DEBUG): Initializing RudderServo.
2017-10-11T20:54:16.070Z,1507755256.070 [AcousticModem_Benthos_ATM900](INFO): Powering up
2017-10-11T20:54:16.070Z,1507755256.070 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2017-10-11T20:54:16.105Z,1507755256.105 [PNI_TCM](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Software Overcurrent. Current Limiter Activated.
2017-10-11T20:54:16.105Z,1507755256.105 [PNI_TCM] Hardware Fault, FailCount= 1
2017-10-11T20:54:16.105Z,1507755256.105 [PNI_TCM](ERROR): Hardware Fault
2017-10-11T20:54:16.114Z,1507755256.114 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:16.125Z,1507755256.125 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:16.240Z,1507755256.240 [MassServo](DEBUG): Initializing EZServoServo.
2017-10-11T20:54:16.241Z,1507755256.241 [MassServo](DEBUG): Initializing MassServo.
2017-10-11T20:54:16.245Z,1507755256.245 [CBIT](INFO): Clearing failed state for component MassServo
2017-10-11T20:54:16.245Z,1507755256.245 [MassServo] No Fault, FailCount= 3
2017-10-11T20:54:16.245Z,1507755256.245 [CBIT](INFO): Clearing failed state for component ThrusterServo
2017-10-11T20:54:16.245Z,1507755256.245 [ThrusterServo] No Fault, FailCount= 4
2017-10-11T20:54:16.610Z,1507755256.610 [Depth_Keller](INFO): A/D timeout, 9 tries over 134 ms

2017-10-11T20:54:16.610Z,1507755256.610 [Depth_Keller] Data Fault, FailCount= 1
2017-10-11T20:54:16.610Z,1507755256.610 [Depth_Keller](ERROR): Data Fault
2017-10-11T20:54:16.654Z,1507755256.654 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:16.669Z,1507755256.669 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:16.795Z,1507755256.795 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2017-10-11T20:54:16.806Z,1507755256.806 [ThrusterServo](DEBUG): Initializing EZServoServo.
2017-10-11T20:54:16.808Z,1507755256.808 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2017-10-11T20:54:16.843Z,1507755256.843 [CBIT](ERROR): Data Fault in component: Depth_Keller
2017-10-11T20:54:16.843Z,1507755256.843 [CBIT](INFO): Clearing failed state for component Depth_Keller
2017-10-11T20:54:16.843Z,1507755256.843 [Depth_Keller] No Fault, FailCount= 1
2017-10-11T20:54:16.844Z,1507755256.844 [CBIT](INFO): Clearing failed state for component NAL9602
2017-10-11T20:54:16.844Z,1507755256.844 [NAL9602] No Fault, FailCount= 1
2017-10-11T20:54:16.913Z,1507755256.913 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:16.914Z,1507755256.914 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:17.032Z,1507755257.032 [CBIT](INFO): Clearing failed state for component PNI_TCM
2017-10-11T20:54:17.032Z,1507755257.032 [PNI_TCM] No Fault, FailCount= 1
2017-10-11T20:54:17.199Z,1507755257.199 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:54:17.420Z,1507755257.420 [Aanderaa_O2](FAULT): Timed out starting
2017-10-11T20:54:17.420Z,1507755257.420 [Aanderaa_O2] Communications Fault, FailCount= 2
2017-10-11T20:54:17.420Z,1507755257.420 [Aanderaa_O2](ERROR): Communications Fault
2017-10-11T20:54:17.441Z,1507755257.441 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:17.442Z,1507755257.442 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:17.907Z,1507755257.907 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout
2017-10-11T20:54:18.231Z,1507755258.231 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout
2017-10-11T20:54:18.231Z,1507755258.231 [ThrusterServo](FAULT): Thruster failed to initialize
2017-10-11T20:54:18.231Z,1507755258.231 [ThrusterServo] Communications Fault, FailCount= 5
2017-10-11T20:54:18.231Z,1507755258.231 [ThrusterServo](ERROR): Communications Fault
2017-10-11T20:54:18.235Z,1507755258.235 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2017-10-11T20:54:18.236Z,1507755258.236 [CBIT](ERROR): Communications Fault in component: ThrusterServo
2017-10-11T20:54:18.236Z,1507755258.236 [CBIT](CRITICAL): Communications Fault in component: ThrusterServo
2017-10-11T20:54:18.379Z,1507755258.379 [Depth_Keller](INFO): A/D timeout, 11 tries over 132 ms

2017-10-11T20:54:18.379Z,1507755258.379 [Depth_Keller] Data Fault, FailCount= 1
2017-10-11T20:54:18.379Z,1507755258.379 [Depth_Keller](ERROR): Data Fault
2017-10-11T20:54:18.412Z,1507755258.412 [Aanderaa_O2](INFO): Powering down
2017-10-11T20:54:18.423Z,1507755258.423 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2017-10-11T20:54:18.430Z,1507755258.430 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:18.435Z,1507755258.435 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:18.835Z,1507755258.835 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:54:18.855Z,1507755258.855 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout
2017-10-11T20:54:18.855Z,1507755258.855 [MassServo] Communications Fault, FailCount= 4
2017-10-11T20:54:18.855Z,1507755258.855 [MassServo](ERROR): Communications Fault
2017-10-11T20:54:18.856Z,1507755258.856 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2017-10-11T20:54:18.856Z,1507755258.856 [ThrusterServo](INFO): Powering down
2017-10-11T20:54:18.859Z,1507755258.859 [CBIT](INFO): Critical error at 20171011T205418
2017-10-11T20:54:18.861Z,1507755258.861 [CBIT](ERROR): Data Fault in component: Depth_Keller
2017-10-11T20:54:18.861Z,1507755258.861 [CBIT](INFO): Clearing failed state for component Depth_Keller
2017-10-11T20:54:18.862Z,1507755258.862 [Depth_Keller] No Fault, FailCount= 1
2017-10-11T20:54:18.862Z,1507755258.862 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2017-10-11T20:54:18.862Z,1507755258.862 [BuoyancyServo] No Fault, FailCount= 3
2017-10-11T20:54:18.863Z,1507755258.863 [CBIT](ERROR): Communications Fault in component: MassServo
2017-10-11T20:54:18.898Z,1507755258.898 [Aanderaa_O2](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Software Overcurrent. Current Limiter Activated.
2017-10-11T20:54:18.898Z,1507755258.898 [Aanderaa_O2] Hardware Fault, FailCount= 2
2017-10-11T20:54:18.899Z,1507755258.899 [Aanderaa_O2](ERROR): Hardware Fault
2017-10-11T20:54:18.916Z,1507755258.916 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:18.917Z,1507755258.917 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:19.028Z,1507755259.028 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2017-10-11T20:54:19.028Z,1507755259.028 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2017-10-11T20:54:19.029Z,1507755259.029 [MassServo](DEBUG): Uninitialize Mass Servo.
2017-10-11T20:54:19.029Z,1507755259.029 [MassServo](INFO): Powering down
2017-10-11T20:54:19.243Z,1507755259.243 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:54:19.359Z,1507755259.359 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:19.360Z,1507755259.360 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:19.505Z,1507755259.505 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2017-10-11T20:54:19.505Z,1507755259.505 [Aanderaa_O2] No Fault, FailCount= 2
2017-10-11T20:54:19.865Z,1507755259.865 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:19.866Z,1507755259.866 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:20.491Z,1507755260.491 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2017-10-11T20:54:20.491Z,1507755260.491 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2017-10-11T20:54:20.491Z,1507755260.491 [BuoyancyServo] Communications Fault, FailCount= 4
2017-10-11T20:54:20.491Z,1507755260.491 [BuoyancyServo](ERROR): Communications Fault
2017-10-11T20:54:20.492Z,1507755260.492 [MassServo](DEBUG): Initializing EZServoServo.
2017-10-11T20:54:20.492Z,1507755260.492 [MassServo](DEBUG): Initializing MassServo.
2017-10-11T20:54:20.496Z,1507755260.496 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2017-10-11T20:54:20.497Z,1507755260.497 [CBIT](INFO): Clearing failed state for component MassServo
2017-10-11T20:54:20.497Z,1507755260.497 [MassServo] No Fault, FailCount= 4
2017-10-11T20:54:20.594Z,1507755260.594 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:20.595Z,1507755260.595 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:20.716Z,1507755260.716 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2017-10-11T20:54:20.716Z,1507755260.716 [BuoyancyServo](INFO): Powering down
2017-10-11T20:54:20.932Z,1507755260.932 [NAL9602](INFO): Powering up NAL9602
2017-10-11T20:54:21.004Z,1507755261.004 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:21.005Z,1507755261.005 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:21.335Z,1507755261.335 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:21.336Z,1507755261.336 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:21.336Z,1507755261.336 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:21.336Z,1507755261.336 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65280
2017-10-11T20:54:21.374Z,1507755261.374 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:21.387Z,1507755261.387 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:21.826Z,1507755261.826 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:21.836Z,1507755261.836 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:22.304Z,1507755262.304 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:22.305Z,1507755262.305 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:22.735Z,1507755262.735 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout
2017-10-11T20:54:22.735Z,1507755262.735 [MassServo] Communications Fault, FailCount= 5
2017-10-11T20:54:22.735Z,1507755262.735 [MassServo](ERROR): Communications Fault
2017-10-11T20:54:22.740Z,1507755262.740 [CBIT](ERROR): Communications Fault in component: MassServo
2017-10-11T20:54:22.740Z,1507755262.740 [CBIT](CRITICAL): Communications Fault in component: MassServo
2017-10-11T20:54:22.875Z,1507755262.875 [Depth_Keller](INFO): A/D timeout, 7 tries over 125 ms

2017-10-11T20:54:22.875Z,1507755262.875 [Depth_Keller] Data Fault, FailCount= 1
2017-10-11T20:54:22.875Z,1507755262.875 [Depth_Keller](ERROR): Data Fault
2017-10-11T20:54:22.901Z,1507755262.901 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2017-10-11T20:54:22.939Z,1507755262.939 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:22.941Z,1507755262.941 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:23.072Z,1507755263.072 [MassServo](DEBUG): Uninitialize Mass Servo.
2017-10-11T20:54:23.072Z,1507755263.072 [MassServo](INFO): Powering down
2017-10-11T20:54:23.076Z,1507755263.076 [Radio_Surface](INFO): Powering down
2017-10-11T20:54:23.077Z,1507755263.077 [CBIT](INFO): Critical error at 20171011T205422
2017-10-11T20:54:23.079Z,1507755263.079 [CBIT](ERROR): Data Fault in component: Depth_Keller
2017-10-11T20:54:23.079Z,1507755263.079 [CBIT](INFO): Clearing failed state for component Depth_Keller
2017-10-11T20:54:23.079Z,1507755263.079 [Depth_Keller] No Fault, FailCount= 1
2017-10-11T20:54:23.080Z,1507755263.080 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2017-10-11T20:54:23.080Z,1507755263.080 [BuoyancyServo] No Fault, FailCount= 4
2017-10-11T20:54:23.211Z,1507755263.211 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:23.213Z,1507755263.213 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:23.307Z,1507755263.307 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:54:23.328Z,1507755263.328 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2017-10-11T20:54:23.329Z,1507755263.329 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2017-10-11T20:54:23.679Z,1507755263.679 [Depth_Keller](INFO): A/D timeout, 9 tries over 127 ms

2017-10-11T20:54:23.679Z,1507755263.679 [Depth_Keller] Data Fault, FailCount= 2
2017-10-11T20:54:23.679Z,1507755263.679 [Depth_Keller](ERROR): Data Fault
2017-10-11T20:54:23.751Z,1507755263.751 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:23.752Z,1507755263.752 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:23.989Z,1507755263.989 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2017-10-11T20:54:24.179Z,1507755264.179 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2017-10-11T20:54:24.179Z,1507755264.179 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2017-10-11T20:54:24.179Z,1507755264.179 [BuoyancyServo] Communications Fault, FailCount= 5
2017-10-11T20:54:24.179Z,1507755264.179 [BuoyancyServo](ERROR): Communications Fault
2017-10-11T20:54:24.180Z,1507755264.180 [MassServo](DEBUG): Initializing EZServoServo.
2017-10-11T20:54:24.180Z,1507755264.180 [MassServo](DEBUG): Initializing MassServo.
2017-10-11T20:54:24.184Z,1507755264.184 [CBIT](ERROR): Data Fault in component: Depth_Keller
2017-10-11T20:54:24.184Z,1507755264.184 [CBIT](INFO): Clearing failed state for component Depth_Keller
2017-10-11T20:54:24.184Z,1507755264.184 [Depth_Keller] No Fault, FailCount= 2
2017-10-11T20:54:24.185Z,1507755264.185 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2017-10-11T20:54:24.185Z,1507755264.185 [CBIT](CRITICAL): Communications Fault in component: BuoyancyServo
2017-10-11T20:54:24.266Z,1507755264.266 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:24.283Z,1507755264.283 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:24.403Z,1507755264.403 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:54:24.408Z,1507755264.408 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2017-10-11T20:54:24.408Z,1507755264.408 [BuoyancyServo](INFO): Powering down
2017-10-11T20:54:24.424Z,1507755264.424 [CBIT](INFO): Critical error at 20171011T205424
2017-10-11T20:54:24.661Z,1507755264.661 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:24.662Z,1507755264.662 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:25.121Z,1507755265.121 [Depth_Keller](INFO): A/D timeout, 11 tries over 122 ms

2017-10-11T20:54:25.121Z,1507755265.121 [Depth_Keller] Data Fault, FailCount= 1
2017-10-11T20:54:25.121Z,1507755265.121 [Depth_Keller](ERROR): Data Fault
2017-10-11T20:54:25.193Z,1507755265.193 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:25.194Z,1507755265.194 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:25.319Z,1507755265.319 [CBIT](ERROR): Data Fault in component: Depth_Keller
2017-10-11T20:54:25.319Z,1507755265.319 [CBIT](INFO): Clearing failed state for component Depth_Keller
2017-10-11T20:54:25.319Z,1507755265.319 [Depth_Keller] No Fault, FailCount= 1
2017-10-11T20:54:25.455Z,1507755265.455 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:25.456Z,1507755265.456 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:25.824Z,1507755265.824 [PNI_TCM](ERROR): CRC does not match. Expected:0x42396 got:0x65535
2017-10-11T20:54:25.871Z,1507755265.871 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:25.872Z,1507755265.872 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:26.335Z,1507755266.335 [Depth_Keller](INFO): A/D timeout, 12 tries over 136 ms

2017-10-11T20:54:26.335Z,1507755266.335 [Depth_Keller] Data Fault, FailCount= 1
2017-10-11T20:54:26.335Z,1507755266.335 [Depth_Keller](ERROR): Data Fault
2017-10-11T20:54:26.396Z,1507755266.396 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2017-10-11T20:54:26.396Z,1507755266.396 [PNI_TCM] Data Fault, FailCount= 2
2017-10-11T20:54:26.396Z,1507755266.396 [PNI_TCM](ERROR): Data Fault
2017-10-11T20:54:26.397Z,1507755266.397 [BPC1](FAULT): Failed to initialize
2017-10-11T20:54:26.397Z,1507755266.397 [BPC1] Communications Fault, FailCount= 2
2017-10-11T20:54:26.397Z,1507755266.397 [BPC1](ERROR): Communications Fault
2017-10-11T20:54:26.404Z,1507755266.404 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:26.405Z,1507755266.405 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:26.531Z,1507755266.531 [CBIT](ERROR): Data Fault in component: Depth_Keller
2017-10-11T20:54:26.531Z,1507755266.531 [CBIT](INFO): Clearing failed state for component Depth_Keller
2017-10-11T20:54:26.531Z,1507755266.531 [Depth_Keller] No Fault, FailCount= 1
2017-10-11T20:54:26.532Z,1507755266.532 [CBIT](ERROR): Data Fault in component: PNI_TCM
2017-10-11T20:54:26.532Z,1507755266.532 [CBIT](ERROR): Communications Fault in component: BPC1
2017-10-11T20:54:26.614Z,1507755266.614 [PNI_TCM](INFO): Powering down
2017-10-11T20:54:26.655Z,1507755266.655 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:26.656Z,1507755266.656 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:27.030Z,1507755267.030 [PNI_TCM](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Software Overcurrent. Current Limiter Activated.
2017-10-11T20:54:27.030Z,1507755267.030 [PNI_TCM] Hardware Fault, FailCount= 2
2017-10-11T20:54:27.030Z,1507755267.030 [PNI_TCM](ERROR): Hardware Fault
2017-10-11T20:54:27.081Z,1507755267.081 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:27.082Z,1507755267.082 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:27.436Z,1507755267.436 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:27.437Z,1507755267.437 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:27.583Z,1507755267.583 [CBIT](INFO): Clearing failed state for component BPC1
2017-10-11T20:54:27.583Z,1507755267.583 [BPC1] No Fault, FailCount= 2
2017-10-11T20:54:27.924Z,1507755267.924 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:27.925Z,1507755267.925 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:28.047Z,1507755268.047 [CBIT](INFO): Clearing failed state for component PNI_TCM
2017-10-11T20:54:28.047Z,1507755268.047 [PNI_TCM] No Fault, FailCount= 2
2017-10-11T20:54:28.331Z,1507755268.331 [Depth_Keller](INFO): A/D timeout, 12 tries over 131 ms

2017-10-11T20:54:28.331Z,1507755268.331 [Depth_Keller] Data Fault, FailCount= 1
2017-10-11T20:54:28.331Z,1507755268.331 [Depth_Keller](ERROR): Data Fault
2017-10-11T20:54:28.383Z,1507755268.383 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:28.388Z,1507755268.388 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:28.514Z,1507755268.514 [CBIT](ERROR): Data Fault in component: Depth_Keller
2017-10-11T20:54:28.515Z,1507755268.515 [CBIT](INFO): Clearing failed state for component Depth_Keller
2017-10-11T20:54:28.515Z,1507755268.515 [Depth_Keller] No Fault, FailCount= 1
2017-10-11T20:54:28.630Z,1507755268.630 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:28.632Z,1507755268.632 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:29.127Z,1507755269.127 [Depth_Keller](INFO): A/D timeout, 9 tries over 127 ms

2017-10-11T20:54:29.127Z,1507755269.127 [Depth_Keller] Data Fault, FailCount= 2
2017-10-11T20:54:29.127Z,1507755269.127 [Depth_Keller](ERROR): Data Fault
2017-10-11T20:54:29.350Z,1507755269.350 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:29.363Z,1507755269.363 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:29.379Z,1507755269.379 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2017-10-11T20:54:29.474Z,1507755269.474 [CBIT](ERROR): Data Fault in component: Depth_Keller
2017-10-11T20:54:29.475Z,1507755269.475 [CBIT](INFO): Clearing failed state for component Depth_Keller
2017-10-11T20:54:29.475Z,1507755269.475 [Depth_Keller] No Fault, FailCount= 2
2017-10-11T20:54:29.539Z,1507755269.539 [Radio_Surface](INFO): Powering up
2017-10-11T20:54:29.534Z,1507755269.534 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:29.541Z,1507755269.541 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:29.791Z,1507755269.791 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:54:29.981Z,1507755269.981 [Aanderaa_O2](FAULT): Timed out starting
2017-10-11T20:54:29.981Z,1507755269.981 [Aanderaa_O2] Communications Fault, FailCount= 3
2017-10-11T20:54:29.981Z,1507755269.981 [Aanderaa_O2](ERROR): Communications Fault
2017-10-11T20:54:30.008Z,1507755270.008 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:30.010Z,1507755270.010 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:30.118Z,1507755270.118 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2017-10-11T20:54:30.119Z,1507755270.119 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2017-10-11T20:54:30.436Z,1507755270.436 [Aanderaa_O2](INFO): Powering down
2017-10-11T20:54:30.455Z,1507755270.455 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:30.456Z,1507755270.456 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:30.825Z,1507755270.825 [Depth_Keller](INFO): A/D timeout, 10 tries over 137 ms

2017-10-11T20:54:30.825Z,1507755270.825 [Depth_Keller] Data Fault, FailCount= 1
2017-10-11T20:54:30.825Z,1507755270.825 [Depth_Keller](ERROR): Data Fault
2017-10-11T20:54:30.841Z,1507755270.841 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2017-10-11T20:54:30.935Z,1507755270.935 [PNI_TCM](ERROR): No parameter response UART error: serial timeout
2017-10-11T20:54:30.935Z,1507755270.935 [PNI_TCM](ERROR): Received 0xFF
2017-10-11T20:54:30.937Z,1507755270.937 [Aanderaa_O2](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Software Overcurrent. Current Limiter Activated.
2017-10-11T20:54:30.937Z,1507755270.937 [Aanderaa_O2] Hardware Fault, FailCount= 3
2017-10-11T20:54:30.937Z,1507755270.937 [Aanderaa_O2](ERROR): Hardware Fault
2017-10-11T20:54:30.946Z,1507755270.946 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:30.955Z,1507755270.955 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:31.080Z,1507755271.080 [CBIT](ERROR): Data Fault in component: Depth_Keller
2017-10-11T20:54:31.080Z,1507755271.080 [CBIT](INFO): Clearing failed state for component Depth_Keller
2017-10-11T20:54:31.080Z,1507755271.080 [Depth_Keller] No Fault, FailCount= 1
2017-10-11T20:54:31.153Z,1507755271.153 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:31.163Z,1507755271.163 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:31.247Z,1507755271.247 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:54:31.639Z,1507755271.639 [Depth_Keller](INFO): A/D timeout, 8 tries over 128 ms

2017-10-11T20:54:31.639Z,1507755271.639 [Depth_Keller] Data Fault, FailCount= 2
2017-10-11T20:54:31.639Z,1507755271.639 [Depth_Keller](ERROR): Data Fault
2017-10-11T20:54:31.732Z,1507755271.732 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:31.733Z,1507755271.733 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:31.775Z,1507755271.775 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2017-10-11T20:54:31.839Z,1507755271.839 [CBIT](ERROR): Data Fault in component: Depth_Keller
2017-10-11T20:54:31.839Z,1507755271.839 [CBIT](INFO): Clearing failed state for component Depth_Keller
2017-10-11T20:54:31.839Z,1507755271.839 [Depth_Keller] No Fault, FailCount= 2
2017-10-11T20:54:31.973Z,1507755271.973 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:31.979Z,1507755271.979 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:32.191Z,1507755272.191 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:54:32.439Z,1507755272.439 [Depth_Keller](INFO): A/D timeout, 9 tries over 127 ms

2017-10-11T20:54:32.439Z,1507755272.439 [Depth_Keller] Data Fault, FailCount= 3
2017-10-11T20:54:32.439Z,1507755272.439 [Depth_Keller](ERROR): Data Fault
2017-10-11T20:54:32.524Z,1507755272.524 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:32.526Z,1507755272.526 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:32.635Z,1507755272.635 [CBIT](ERROR): Data Fault in component: Depth_Keller
2017-10-11T20:54:32.635Z,1507755272.635 [CBIT](CRITICAL): Data Fault in component: Depth_Keller
2017-10-11T20:54:32.768Z,1507755272.768 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:32.769Z,1507755272.769 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:32.881Z,1507755272.881 [CBIT](INFO): Critical error at 20171011T205432
2017-10-11T20:54:33.178Z,1507755273.178 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:33.179Z,1507755273.179 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:33.571Z,1507755273.571 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:33.573Z,1507755273.573 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:33.971Z,1507755273.971 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:33.972Z,1507755273.972 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:34.366Z,1507755274.366 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:34.378Z,1507755274.378 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:34.766Z,1507755274.766 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:34.768Z,1507755274.768 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:35.168Z,1507755275.168 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:35.169Z,1507755275.169 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:35.196Z,1507755275.196 [Radio_Surface](INFO): Powering down
2017-10-11T20:54:35.567Z,1507755275.567 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:35.568Z,1507755275.568 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:35.972Z,1507755275.972 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:35.973Z,1507755275.973 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:36.307Z,1507755276.307 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2017-10-11T20:54:36.307Z,1507755276.307 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 2
2017-10-11T20:54:36.307Z,1507755276.307 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2017-10-11T20:54:36.347Z,1507755276.347 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2017-10-11T20:54:36.347Z,1507755276.347 [PNI_TCM] Data Fault, FailCount= 3
2017-10-11T20:54:36.347Z,1507755276.347 [PNI_TCM](ERROR): Data Fault
2017-10-11T20:54:36.361Z,1507755276.361 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:36.362Z,1507755276.362 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:54:36.471Z,1507755276.471 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2017-10-11T20:54:36.471Z,1507755276.471 [CBIT](ERROR): Data Fault in component: PNI_TCM
2017-10-11T20:54:36.707Z,1507755276.707 [AcousticModem_Benthos_ATM900](INFO): Powering down
2017-10-11T20:54:36.849Z,1507755276.849 [PNI_TCM](INFO): Powering down
2017-10-11T20:55:02.313Z,1507755302.313 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2017-10-11T20:55:02.723Z,1507755302.723 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:03.131Z,1507755303.131 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:03.543Z,1507755303.543 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:03.951Z,1507755303.951 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:04.359Z,1507755304.359 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:04.767Z,1507755304.767 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:05.175Z,1507755305.175 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:05.583Z,1507755305.583 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:05.995Z,1507755305.995 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:06.403Z,1507755306.403 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:06.811Z,1507755306.811 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:06.936Z,1507755306.936 [BPC1](FAULT): Failed to initialize
2017-10-11T20:55:06.936Z,1507755306.936 [BPC1] Communications Fault, FailCount= 3
2017-10-11T20:55:06.936Z,1507755306.936 [BPC1](ERROR): Communications Fault
2017-10-11T20:55:06.947Z,1507755306.947 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:55:06.948Z,1507755306.948 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:55:07.055Z,1507755307.055 [CBIT](ERROR): Communications Fault in component: BPC1
2017-10-11T20:55:07.056Z,1507755307.056 [CBIT](INFO): Clearing failed state for component ThrusterServo
2017-10-11T20:55:07.056Z,1507755307.056 [ThrusterServo] No Fault, FailCount= 5
2017-10-11T20:55:07.064Z,1507755307.064 [NAL9602](ERROR): NAL9602 initialization error.
2017-10-11T20:55:07.064Z,1507755307.064 [NAL9602] Communications Fault, FailCount= 2
2017-10-11T20:55:07.064Z,1507755307.064 [NAL9602](ERROR): Communications Fault
2017-10-11T20:55:07.105Z,1507755307.105 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:55:07.106Z,1507755307.106 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:55:07.219Z,1507755307.219 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:07.224Z,1507755307.224 [ThrusterServo](DEBUG): Initializing EZServoServo.
2017-10-11T20:55:07.225Z,1507755307.225 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2017-10-11T20:55:07.226Z,1507755307.226 [SBIT](IMPORTANT): Beginning Startup BIT
2017-10-11T20:55:07.232Z,1507755307.232 [CBIT](ERROR): Communications Fault in component: NAL9602
2017-10-11T20:55:07.233Z,1507755307.233 [CBIT](IMPORTANT): Beginning ground fault scan
2017-10-11T20:55:07.467Z,1507755307.467 [NAL9602](INFO): Powering down
2017-10-11T20:55:07.510Z,1507755307.510 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:55:07.511Z,1507755307.511 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:55:07.619Z,1507755307.619 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2017-10-11T20:55:07.619Z,1507755307.619 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 2
2017-10-11T20:55:07.623Z,1507755307.623 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:07.863Z,1507755307.863 [AcousticModem_Benthos_ATM900](INFO): Powering up
2017-10-11T20:55:07.863Z,1507755307.863 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2017-10-11T20:55:08.027Z,1507755308.027 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:08.435Z,1507755308.435 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:08.843Z,1507755308.843 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:09.251Z,1507755309.251 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:09.663Z,1507755309.663 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:09.663Z,1507755309.663 [CTD_NeilBrown](FAULT): No CTD communication! Re-initializing
2017-10-11T20:55:09.663Z,1507755309.663 [CTD_NeilBrown] Communications Fault, FailCount= 1
2017-10-11T20:55:09.663Z,1507755309.663 [CTD_NeilBrown](ERROR): Communications Fault
2017-10-11T20:55:10.797Z,1507755310.797 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:55:10.798Z,1507755310.798 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:55:11.219Z,1507755311.219 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout
2017-10-11T20:55:11.543Z,1507755311.543 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout
2017-10-11T20:55:11.543Z,1507755311.543 [ThrusterServo](FAULT): Thruster failed to initialize
2017-10-11T20:55:11.543Z,1507755311.543 [ThrusterServo] Communications Fault, FailCount= 1
2017-10-11T20:55:11.543Z,1507755311.543 [ThrusterServo](ERROR): Communications Fault
2017-10-11T20:55:11.547Z,1507755311.547 [CBIT](INFO): Clearing failed state for component PNI_TCM
2017-10-11T20:55:11.547Z,1507755311.547 [PNI_TCM] No Fault, FailCount= 3
2017-10-11T20:55:11.548Z,1507755311.548 [CBIT](INFO): Clearing failed state for component BPC1
2017-10-11T20:55:11.548Z,1507755311.548 [BPC1] No Fault, FailCount= 3
2017-10-11T20:55:11.549Z,1507755311.549 [CBIT](ERROR): Communications Fault in component: CTD_NeilBrown
2017-10-11T20:55:11.550Z,1507755311.550 [CBIT](ERROR): Communications Fault in component: ThrusterServo
2017-10-11T20:55:11.763Z,1507755311.763 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:55:11.764Z,1507755311.764 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:55:11.868Z,1507755311.868 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2017-10-11T20:55:11.868Z,1507755311.868 [ThrusterServo](INFO): Powering down
2017-10-11T20:55:11.873Z,1507755311.873 [CBIT](INFO): Clearing failed state for component NAL9602
2017-10-11T20:55:11.873Z,1507755311.873 [NAL9602] No Fault, FailCount= 2
2017-10-11T20:55:12.080Z,1507755312.080 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:55:12.082Z,1507755312.082 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:55:12.494Z,1507755312.494 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:55:12.495Z,1507755312.495 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:55:12.603Z,1507755312.603 [CTD_NeilBrown](INFO): Powering down
2017-10-11T20:55:42.720Z,1507755342.720 [SBIT](ERROR): Could not read elevatorAngleReader_.
2017-10-11T20:55:42.720Z,1507755342.720 [SBIT](ERROR): Could not read rudderAngleReader_.
2017-10-11T20:55:42.720Z,1507755342.720 [SBIT](ERROR): Could not read massPosReader_.
2017-10-11T20:55:42.724Z,1507755342.724 [CBIT](INFO): Clearing failed state for component CTD_NeilBrown
2017-10-11T20:55:42.724Z,1507755342.724 [CTD_NeilBrown] No Fault, FailCount= 1
2017-10-11T20:55:42.725Z,1507755342.725 [CBIT](INFO): Clearing failed state for component ThrusterServo
2017-10-11T20:55:42.726Z,1507755342.726 [ThrusterServo] No Fault, FailCount= 1
2017-10-11T20:55:42.814Z,1507755342.814 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2017-10-11T20:55:42.814Z,1507755342.814 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 3
2017-10-11T20:55:42.814Z,1507755342.814 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2017-10-11T20:55:42.815Z,1507755342.815 [NAL9602](INFO): Powering up NAL9602
2017-10-11T20:55:42.834Z,1507755342.834 [BPC1](FAULT): Failed to initialize
2017-10-11T20:55:42.834Z,1507755342.834 [BPC1] Communications Fault, FailCount= 4
2017-10-11T20:55:42.834Z,1507755342.834 [BPC1](ERROR): Communications Fault
2017-10-11T20:55:42.847Z,1507755342.847 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:55:42.849Z,1507755342.849 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:55:42.903Z,1507755342.903 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown.
2017-10-11T20:55:42.907Z,1507755342.907 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2017-10-11T20:55:42.952Z,1507755342.952 [ThrusterServo](DEBUG): Initializing EZServoServo.
2017-10-11T20:55:42.954Z,1507755342.954 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2017-10-11T20:55:42.958Z,1507755342.958 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2017-10-11T20:55:42.961Z,1507755342.961 [CBIT](ERROR): Communications Fault in component: BPC1
2017-10-11T20:55:43.214Z,1507755343.214 [AcousticModem_Benthos_ATM900](INFO): Powering down
2017-10-11T20:55:43.315Z,1507755343.315 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:43.354Z,1507755343.354 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:55:43.355Z,1507755343.355 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:55:43.727Z,1507755343.727 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:43.799Z,1507755343.799 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout
2017-10-11T20:55:44.127Z,1507755344.127 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout
2017-10-11T20:55:44.127Z,1507755344.127 [ThrusterServo](FAULT): Thruster failed to initialize
2017-10-11T20:55:44.127Z,1507755344.127 [ThrusterServo] Communications Fault, FailCount= 2
2017-10-11T20:55:44.127Z,1507755344.127 [ThrusterServo](ERROR): Communications Fault
2017-10-11T20:55:44.132Z,1507755344.132 [CBIT](ERROR): Communications Fault in component: ThrusterServo
2017-10-11T20:55:44.139Z,1507755344.139 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:44.274Z,1507755344.274 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:55:44.276Z,1507755344.276 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:55:44.384Z,1507755344.384 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2017-10-11T20:55:44.384Z,1507755344.384 [ThrusterServo](INFO): Powering down
2017-10-11T20:55:44.547Z,1507755344.547 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:44.646Z,1507755344.646 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:55:44.648Z,1507755344.648 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:55:44.755Z,1507755344.755 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2017-10-11T20:55:44.755Z,1507755344.755 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 3
2017-10-11T20:55:44.756Z,1507755344.756 [CBIT](INFO): Clearing failed state for component BPC1
2017-10-11T20:55:44.756Z,1507755344.756 [BPC1] No Fault, FailCount= 4
2017-10-11T20:55:44.951Z,1507755344.951 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:45.115Z,1507755345.115 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:55:45.116Z,1507755345.116 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:55:45.360Z,1507755345.360 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:45.771Z,1507755345.771 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:46.179Z,1507755346.179 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:46.587Z,1507755346.587 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:46.995Z,1507755346.995 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:47.407Z,1507755347.407 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:47.815Z,1507755347.815 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:48.223Z,1507755348.223 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:48.635Z,1507755348.635 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:49.043Z,1507755349.043 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:49.451Z,1507755349.451 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:49.859Z,1507755349.859 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:50.271Z,1507755350.271 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:55:50.271Z,1507755350.271 [CTD_NeilBrown](FAULT): No CTD communication! Re-initializing
2017-10-11T20:55:50.271Z,1507755350.271 [CTD_NeilBrown] Communications Fault, FailCount= 2
2017-10-11T20:55:50.271Z,1507755350.271 [CTD_NeilBrown](ERROR): Communications Fault
2017-10-11T20:55:51.783Z,1507755351.783 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2017-10-11T20:55:51.783Z,1507755351.783 [Rowe_600LCM] Communications Fault, FailCount= 1
2017-10-11T20:55:51.783Z,1507755351.783 [Rowe_600LCM](ERROR): Communications Fault
2017-10-11T20:55:52.187Z,1507755352.187 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2017-10-11T20:55:52.286Z,1507755352.286 [Rowe_600LCM](INFO): Powering down
2017-10-11T20:55:52.293Z,1507755352.293 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2017-10-11T20:55:52.294Z,1507755352.294 [CBIT](ERROR): Communications Fault in component: CTD_NeilBrown
2017-10-11T20:55:52.294Z,1507755352.294 [CBIT](INFO): Clearing failed state for component ThrusterServo
2017-10-11T20:55:52.294Z,1507755352.294 [ThrusterServo] No Fault, FailCount= 2
2017-10-11T20:55:52.381Z,1507755352.381 [AcousticModem_Benthos_ATM900](INFO): Powering up
2017-10-11T20:55:52.381Z,1507755352.381 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2017-10-11T20:55:52.424Z,1507755352.424 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2017-10-11T20:55:52.424Z,1507755352.424 [PNI_TCM] Data Fault, FailCount= 4
2017-10-11T20:55:52.424Z,1507755352.424 [PNI_TCM](ERROR): Data Fault
2017-10-11T20:55:52.440Z,1507755352.440 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2017-10-11T20:55:52.440Z,1507755352.440 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2017-10-11T20:55:52.440Z,1507755352.440 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2017-10-11T20:55:52.442Z,1507755352.442 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2017-10-11T20:55:52.442Z,1507755352.442 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2017-10-11T20:55:52.442Z,1507755352.442 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2017-10-11T20:55:52.548Z,1507755352.548 [ThrusterServo](DEBUG): Initializing EZServoServo.
2017-10-11T20:55:52.549Z,1507755352.549 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2017-10-11T20:55:52.554Z,1507755352.554 [CBIT](ERROR): Data Fault in component: PNI_TCM
2017-10-11T20:55:52.555Z,1507755352.555 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2017-10-11T20:55:52.555Z,1507755352.555 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2017-10-11T20:55:52.800Z,1507755352.800 [PNI_TCM](INFO): Powering down
2017-10-11T20:56:15.343Z,1507755375.343 [CommandLine](IMPORTANT): got command show stack
2017-10-11T20:56:15.344Z,1507755375.344 [CommandLine](IMPORTANT): Behavior Stack:

2017-10-11T20:56:15.344Z,1507755375.344 [MissionManager](IMPORTANT): Mission loaded, but not running.
2017-10-11T20:56:20.795Z,1507755380.795 [CTD_NeilBrown](INFO): Powering down
2017-10-11T20:56:22.887Z,1507755382.887 [BPC1](FAULT): Failed to initialize
2017-10-11T20:56:22.888Z,1507755382.888 [BPC1] Communications Fault, FailCount= 5
2017-10-11T20:56:22.888Z,1507755382.888 [BPC1](ERROR): Communications Fault
2017-10-11T20:56:23.327Z,1507755383.327 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout
2017-10-11T20:56:23.643Z,1507755383.643 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout
2017-10-11T20:56:23.643Z,1507755383.643 [ThrusterServo](FAULT): Thruster failed to initialize
2017-10-11T20:56:23.643Z,1507755383.643 [ThrusterServo] Communications Fault, FailCount= 3
2017-10-11T20:56:23.643Z,1507755383.643 [ThrusterServo](ERROR): Communications Fault
2017-10-11T20:56:23.644Z,1507755383.644 [SBIT](ERROR): Could not read elevatorAngleReader_.
2017-10-11T20:56:23.645Z,1507755383.645 [SBIT](ERROR): Could not read rudderAngleReader_.
2017-10-11T20:56:23.645Z,1507755383.645 [SBIT](ERROR): Could not read massPosReader_.
2017-10-11T20:56:23.645Z,1507755383.645 [SBIT](FAULT): Control surface position failure.
2017-10-11T20:56:23.648Z,1507755383.648 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2017-10-11T20:56:23.648Z,1507755383.648 [Rowe_600LCM] No Fault, FailCount= 1
2017-10-11T20:56:23.649Z,1507755383.649 [CBIT](ERROR): Communications Fault in component: BPC1
2017-10-11T20:56:23.649Z,1507755383.649 [CBIT](INFO): Clearing failed state for component CTD_NeilBrown
2017-10-11T20:56:23.649Z,1507755383.649 [CTD_NeilBrown] No Fault, FailCount= 2
2017-10-11T20:56:23.650Z,1507755383.650 [CBIT](ERROR): Communications Fault in component: ThrusterServo
2017-10-11T20:56:23.650Z,1507755383.650 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2017-10-11T20:56:23.651Z,1507755383.651 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2017-10-11T20:56:23.651Z,1507755383.651 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2017-10-11T20:56:23.651Z,1507755383.651 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2017-10-11T20:56:23.754Z,1507755383.754 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2017-10-11T20:56:23.754Z,1507755383.754 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 4
2017-10-11T20:56:23.754Z,1507755383.754 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2017-10-11T20:56:23.799Z,1507755383.799 [Rowe_600LCM](INFO): Initializing
2017-10-11T20:56:23.800Z,1507755383.800 [Rowe_600LCM](INFO): Checking LCM
2017-10-11T20:56:23.800Z,1507755383.800 [Rowe_600LCM](INFO): LCM OK
2017-10-11T20:56:23.800Z,1507755383.800 [Rowe_600LCM](INFO): Powering up
2017-10-11T20:56:23.801Z,1507755383.801 [PNI_TCM](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Software Overcurrent. Current Limiter Activated.
2017-10-11T20:56:23.801Z,1507755383.801 [PNI_TCM] Hardware Fault, FailCount= 4
2017-10-11T20:56:23.801Z,1507755383.801 [PNI_TCM](ERROR): Hardware Fault
2017-10-11T20:56:23.812Z,1507755383.812 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2017-10-11T20:56:23.813Z,1507755383.813 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2017-10-11T20:56:23.813Z,1507755383.813 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2017-10-11T20:56:23.814Z,1507755383.814 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2017-10-11T20:56:23.814Z,1507755383.814 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2017-10-11T20:56:23.814Z,1507755383.814 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2017-10-11T20:56:23.944Z,1507755383.944 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2017-10-11T20:56:23.944Z,1507755383.944 [ThrusterServo](INFO): Powering down
2017-10-11T20:56:23.949Z,1507755383.949 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2017-10-11T20:56:24.027Z,1507755384.027 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown.
2017-10-11T20:56:24.029Z,1507755384.029 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2017-10-11T20:56:24.159Z,1507755384.159 [AcousticModem_Benthos_ATM900](INFO): Powering down
2017-10-11T20:56:24.323Z,1507755384.323 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:56:24.324Z,1507755384.324 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:56:24.436Z,1507755384.436 [CBIT](INFO): Clearing failed state for component PNI_TCM
2017-10-11T20:56:24.436Z,1507755384.436 [PNI_TCM] No Fault, FailCount= 4
2017-10-11T20:56:24.436Z,1507755384.436 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2017-10-11T20:56:24.436Z,1507755384.436 [BuoyancyServo] No Fault, FailCount= 5
2017-10-11T20:56:24.439Z,1507755384.439 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:56:24.847Z,1507755384.847 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:56:25.255Z,1507755385.255 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:56:25.667Z,1507755385.667 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:56:26.079Z,1507755386.079 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:56:26.487Z,1507755386.487 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:56:26.896Z,1507755386.896 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:56:27.307Z,1507755387.307 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:56:27.472Z,1507755387.472 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:56:27.473Z,1507755387.473 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:56:27.580Z,1507755387.580 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2017-10-11T20:56:27.581Z,1507755387.581 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2017-10-11T20:56:27.711Z,1507755387.711 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:56:27.938Z,1507755387.938 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2017-10-11T20:56:27.983Z,1507755387.983 [CBIT](INFO): Clearing failed state for component BPC1
2017-10-11T20:56:27.984Z,1507755387.984 [BPC1] No Fault, FailCount= 5
2017-10-11T20:56:28.005Z,1507755388.005 [CBIT](INFO): Clearing failed state for component ThrusterServo
2017-10-11T20:56:28.005Z,1507755388.005 [ThrusterServo] No Fault, FailCount= 3
2017-10-11T20:56:28.065Z,1507755388.065 [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-11T20:56:28.067Z,1507755388.067 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2017-10-11T20:56:28.069Z,1507755388.069 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2017-10-11T20:56:28.070Z,1507755388.070 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2017-10-11T20:56:28.113Z,1507755388.113 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:56:28.264Z,1507755388.264 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:56:28.266Z,1507755388.266 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:56:28.523Z,1507755388.523 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:56:28.727Z,1507755388.727 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2017-10-11T20:56:28.728Z,1507755388.728 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2017-10-11T20:56:28.728Z,1507755388.728 [BuoyancyServo] Communications Fault, FailCount= 1
2017-10-11T20:56:28.728Z,1507755388.728 [BuoyancyServo](ERROR): Communications Fault
2017-10-11T20:56:28.729Z,1507755388.729 [ThrusterServo](DEBUG): Initializing EZServoServo.
2017-10-11T20:56:28.730Z,1507755388.730 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2017-10-11T20:56:28.735Z,1507755388.735 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2017-10-11T20:56:28.735Z,1507755388.735 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 4
2017-10-11T20:56:28.736Z,1507755388.736 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2017-10-11T20:56:28.743Z,1507755388.743 [AcousticModem_Benthos_ATM900](INFO): Powering up
2017-10-11T20:56:28.743Z,1507755388.743 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2017-10-11T20:56:28.805Z,1507755388.805 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:56:28.807Z,1507755388.807 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:56:28.920Z,1507755388.920 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2017-10-11T20:56:28.933Z,1507755388.933 [BuoyancyServo](INFO): Powering down
2017-10-11T20:56:28.933Z,1507755388.933 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:56:29.183Z,1507755389.183 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:56:29.184Z,1507755389.184 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:56:29.347Z,1507755389.347 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:56:29.603Z,1507755389.603 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout
2017-10-11T20:56:29.755Z,1507755389.755 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:56:29.927Z,1507755389.927 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout
2017-10-11T20:56:29.927Z,1507755389.927 [ThrusterServo](FAULT): Thruster failed to initialize
2017-10-11T20:56:29.927Z,1507755389.927 [ThrusterServo] Communications Fault, FailCount= 4
2017-10-11T20:56:29.927Z,1507755389.927 [ThrusterServo](ERROR): Communications Fault
2017-10-11T20:56:29.932Z,1507755389.932 [CBIT](ERROR): Communications Fault in component: ThrusterServo
2017-10-11T20:56:30.061Z,1507755390.061 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:56:30.062Z,1507755390.062 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:56:30.163Z,1507755390.163 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:56:30.180Z,1507755390.180 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2017-10-11T20:56:30.180Z,1507755390.180 [ThrusterServo](INFO): Powering down
2017-10-11T20:56:30.451Z,1507755390.451 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:56:30.452Z,1507755390.452 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:56:30.567Z,1507755390.567 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:56:30.851Z,1507755390.851 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:56:30.852Z,1507755390.852 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:56:30.983Z,1507755390.983 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:56:31.391Z,1507755391.391 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-11T20:56:31.391Z,1507755391.391 [CTD_NeilBrown](FAULT): No CTD communication! Re-initializing
2017-10-11T20:56:31.391Z,1507755391.391 [CTD_NeilBrown] Communications Fault, FailCount= 3
2017-10-11T20:56:31.391Z,1507755391.391 [CTD_NeilBrown](ERROR): Communications Fault
2017-10-11T20:56:31.795Z,1507755391.795 [CTD_NeilBrown](INFO): Powering down
2017-10-11T20:56:46.472Z,1507755406.472 [CommandLine](IMPORTANT): got command show stack
2017-10-11T20:56:46.472Z,1507755406.472 [CommandLine](IMPORTANT): Behavior Stack:

2017-10-11T20:56:46.472Z,1507755406.472 [MissionManager](IMPORTANT): Mission loaded, but not running.
2017-10-11T20:57:01.076Z,1507755421.076 [SBIT](ERROR): Could not read elevatorAngleReader_.
2017-10-11T20:57:01.076Z,1507755421.076 [SBIT](ERROR): Could not read rudderAngleReader_.
2017-10-11T20:57:01.076Z,1507755421.076 [SBIT](ERROR): Could not read massPosReader_.
2017-10-11T20:57:01.076Z,1507755421.076 [SBIT](FAULT): Control surface position failure.
2017-10-11T20:57:01.080Z,1507755421.080 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2017-10-11T20:57:01.080Z,1507755421.080 [Aanderaa_O2] No Fault, FailCount= 3
2017-10-11T20:57:01.081Z,1507755421.081 [CBIT](ERROR): Communications Fault in component: CTD_NeilBrown
2017-10-11T20:57:01.081Z,1507755421.081 [CBIT](FAULT): Communications Fault in component: CTD_NeilBrown
2017-10-11T20:57:01.081Z,1507755421.081 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2017-10-11T20:57:01.081Z,1507755421.081 [BuoyancyServo] No Fault, FailCount= 1
2017-10-11T20:57:01.082Z,1507755421.082 [CBIT](INFO): Clearing failed state for component ThrusterServo
2017-10-11T20:57:01.082Z,1507755421.082 [ThrusterServo] No Fault, FailCount= 4
2017-10-11T20:57:01.180Z,1507755421.180 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2017-10-11T20:57:01.180Z,1507755421.180 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 5
2017-10-11T20:57:01.181Z,1507755421.181 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2017-10-11T20:57:01.182Z,1507755421.182 [NAL9602](ERROR): NAL9602 initialization error.
2017-10-11T20:57:01.182Z,1507755421.182 [NAL9602] Communications Fault, FailCount= 3
2017-10-11T20:57:01.182Z,1507755421.182 [NAL9602](ERROR): Communications Fault
2017-10-11T20:57:01.213Z,1507755421.213 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2017-10-11T20:57:01.214Z,1507755421.214 [PNI_TCM] Data Fault, FailCount= 5
2017-10-11T20:57:01.214Z,1507755421.214 [PNI_TCM](ERROR): Data Fault
2017-10-11T20:57:01.214Z,1507755421.214 [BPC1](FAULT): Failed to initialize
2017-10-11T20:57:01.215Z,1507755421.215 [BPC1] Communications Fault, FailCount= 6
2017-10-11T20:57:01.215Z,1507755421.215 [BPC1](ERROR): Communications Fault
2017-10-11T20:57:01.259Z,1507755421.259 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:57:01.260Z,1507755421.260 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:57:01.376Z,1507755421.376 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2017-10-11T20:57:01.377Z,1507755421.377 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2017-10-11T20:57:01.378Z,1507755421.378 [ThrusterServo](DEBUG): Initializing EZServoServo.
2017-10-11T20:57:01.379Z,1507755421.379 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2017-10-11T20:57:01.380Z,1507755421.380 [SBIT](CRITICAL): SBIT FAILED
2017-10-11T20:57:01.382Z,1507755421.382 [CBIT](INFO): Critical error at 20171011T205701
2017-10-11T20:57:01.384Z,1507755421.384 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2017-10-11T20:57:01.385Z,1507755421.385 [CBIT](ERROR): Communications Fault in component: NAL9602
2017-10-11T20:57:01.385Z,1507755421.385 [CBIT](ERROR): Data Fault in component: PNI_TCM
2017-10-11T20:57:01.385Z,1507755421.385 [CBIT](CRITICAL): Data Fault in component: PNI_TCM
2017-10-11T20:57:01.385Z,1507755421.385 [CBIT](ERROR): Communications Fault in component: BPC1
2017-10-11T20:57:01.406Z,1507755421.406 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.000717
CHAN A1 (24V): 0.007407
CHAN A2 (12V): -0.004732
CHAN A3 (5V): -0.001769
CHAN B0 (3.3V): -0.001026
CHAN B1 (3.15aV): -0.001721
CHAN B2 (3.15bV): -0.001412
CHAN B3 (GND): -0.000410
OPEN: 0.004108
Full Scale Calc: 4.765 mA, -1.589 mA
2017-10-11T20:57:01.579Z,1507755421.579 [AcousticModem_Benthos_ATM900](INFO): Powering down
2017-10-11T20:57:01.700Z,1507755421.700 [NAL9602](INFO): Powering down
2017-10-11T20:57:01.719Z,1507755421.719 [PNI_TCM](INFO): Powering down
2017-10-11T20:57:31.808Z,1507755451.808 [Aanderaa_O2](FAULT): Timed out starting
2017-10-11T20:57:31.808Z,1507755451.808 [Aanderaa_O2] Communications Fault, FailCount= 1
2017-10-11T20:57:31.808Z,1507755451.808 [Aanderaa_O2](ERROR): Communications Fault
2017-10-11T20:57:31.819Z,1507755451.819 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:57:31.820Z,1507755451.820 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:57:31.822Z,1507755451.822 [MissionManager](IMPORTANT): Started mission Startup
2017-10-11T20:57:31.822Z,1507755451.822 [Startup] Running Loop=1
2017-10-11T20:57:31.822Z,1507755451.822 [Startup](DEBUG): Aggregate::initialize Startup
2017-10-11T20:57:31.822Z,1507755451.822 [Startup:A.GoToSurface] Running Loop=1
2017-10-11T20:57:31.822Z,1507755451.822 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2017-10-11T20:57:31.823Z,1507755451.823 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2017-10-11T20:57:31.823Z,1507755451.823 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2017-10-11T20:57:31.824Z,1507755451.824 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2017-10-11T20:57:31.824Z,1507755451.824 [Startup:A.GoToSurface](DEBUG): No pitch timeout specified. Using default value of 20.000000 seconds.
2017-10-11T20:57:31.824Z,1507755451.824 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2017-10-11T20:57:32.148Z,1507755452.148 [Radio_Surface](INFO): Powering up
2017-10-11T20:57:32.256Z,1507755452.256 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2017-10-11T20:57:32.256Z,1507755452.256 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2017-10-11T20:57:32.256Z,1507755452.256 [BuoyancyServo] Communications Fault, FailCount= 2
2017-10-11T20:57:32.256Z,1507755452.256 [BuoyancyServo](ERROR): Communications Fault
2017-10-11T20:57:32.579Z,1507755452.579 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout
2017-10-11T20:57:32.895Z,1507755452.895 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout
2017-10-11T20:57:32.895Z,1507755452.895 [ThrusterServo](FAULT): Thruster failed to initialize
2017-10-11T20:57:32.895Z,1507755452.895 [ThrusterServo] Communications Fault, FailCount= 5
2017-10-11T20:57:32.895Z,1507755452.895 [ThrusterServo](ERROR): Communications Fault
2017-10-11T20:57:32.897Z,1507755452.897 [CBIT](INFO): Critical error at 20171011T205701
2017-10-11T20:57:32.899Z,1507755452.899 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2017-10-11T20:57:32.900Z,1507755452.900 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2017-10-11T20:57:32.900Z,1507755452.900 [CBIT](ERROR): Communications Fault in component: ThrusterServo
2017-10-11T20:57:32.901Z,1507755452.901 [CBIT](CRITICAL): Communications Fault in component: ThrusterServo
2017-10-11T20:57:33.065Z,1507755453.065 [Aanderaa_O2](INFO): Powering down
2017-10-11T20:57:33.080Z,1507755453.080 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:57:33.081Z,1507755453.081 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:57:33.188Z,1507755453.188 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2017-10-11T20:57:33.189Z,1507755453.189 [BuoyancyServo](INFO): Powering down
2017-10-11T20:57:33.203Z,1507755453.203 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2017-10-11T20:57:33.203Z,1507755453.203 [ThrusterServo](INFO): Powering down
2017-10-11T20:57:33.206Z,1507755453.206 [CBIT](INFO): Critical error at 20171011T205732
2017-10-11T20:57:33.330Z,1507755453.330 [Aanderaa_O2](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Software Overcurrent. Current Limiter Activated.
2017-10-11T20:57:33.330Z,1507755453.330 [Aanderaa_O2] Hardware Fault, FailCount= 1
2017-10-11T20:57:33.330Z,1507755453.330 [Aanderaa_O2](ERROR): Hardware Fault
2017-10-11T20:57:33.337Z,1507755453.337 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:57:33.338Z,1507755453.338 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-11T20:57:33.447Z,1507755453.447 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2017-10-11T20:57:33.447Z,1507755453.447 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 5
2017-10-11T20:57:33.448Z,1507755453.448 [CBIT](INFO): Clearing failed state for component NAL9602
2017-10-11T20:57:33.448Z,1507755453.448 [NAL9602] No Fault, FailCount= 3
2017-10-11T20:57:33.448Z,1507755453.448 [CBIT](INFO): Clearing failed state for component BPC1
2017-10-11T20:57:33.448Z,1507755453.448 [BPC1] No Fault, FailCount= 6
2017-10-11T20:57:33.706Z,1507755453.706 [AcousticModem_Benthos_ATM900](INFO): Powering up
2017-10-11T20:57:33.707Z,1507755453.707 [AcousticModem_Benthos_ATM900](DEBU