2018-10-19T17:12:06.361Z,1539969126.361 [Supervisor](DEBUG): Initializing supervisor. 2018-10-19T17:12:06.365Z,1539969126.365 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2018-10-19T17:12:06.366Z,1539969126.366 [SyncHandler](INFO): Protected caller Thread ID is 7877 2018-10-19T17:12:06.366Z,1539969126.366 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2018-10-19T17:12:06.367Z,1539969126.367 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2018-10-19T17:12:06.367Z,1539969126.367 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 7878 2018-10-19T17:12:06.371Z,1539969126.371 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2018-10-19T17:12:06.383Z,1539969126.383 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2018-10-19T17:12:06.384Z,1539969126.384 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2018-10-19T17:12:06.384Z,1539969126.384 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 7879 2018-10-19T17:12:06.385Z,1539969126.385 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2018-10-19T17:12:06.386Z,1539969126.386 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2018-10-19T17:12:06.386Z,1539969126.386 [logger ThreadHandler](INFO): Protected caller Thread ID is 7880 2018-10-19T17:12:06.388Z,1539969126.388 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2018-10-19T17:12:06.389Z,1539969126.389 [Supervisor](INFO): Looking for Config files in directory: Config/ 2018-10-19T17:12:06.390Z,1539969126.390 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2018-10-19T17:12:06.829Z,1539969126.829 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2018-10-19T17:12:06.830Z,1539969126.830 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2018-10-19T17:12:07.276Z,1539969127.276 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2018-10-19T17:12:07.277Z,1539969127.277 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2018-10-19T17:12:07.470Z,1539969127.470 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2018-10-19T17:12:07.471Z,1539969127.471 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2018-10-19T17:12:07.615Z,1539969127.615 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2018-10-19T17:12:07.616Z,1539969127.616 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2018-10-19T17:12:08.056Z,1539969128.056 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2018-10-19T17:12:08.057Z,1539969128.057 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2018-10-19T17:12:08.152Z,1539969128.152 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2018-10-19T17:12:08.153Z,1539969128.153 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2018-10-19T17:12:08.294Z,1539969128.294 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2018-10-19T17:12:08.295Z,1539969128.295 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2018-10-19T17:12:08.396Z,1539969128.396 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2018-10-19T17:12:08.396Z,1539969128.396 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2018-10-19T17:12:08.499Z,1539969128.499 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2018-10-19T17:12:08.500Z,1539969128.500 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2018-10-19T17:12:08.845Z,1539969128.845 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2018-10-19T17:12:08.845Z,1539969128.845 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2018-10-19T17:12:09.049Z,1539969129.049 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2018-10-19T17:12:09.050Z,1539969129.050 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2018-10-19T17:12:09.263Z,1539969129.263 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2018-10-19T17:12:09.263Z,1539969129.263 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2018-10-19T17:12:09.344Z,1539969129.344 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2018-10-19T17:12:09.697Z,1539969129.697 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2018-10-19T17:12:09.698Z,1539969129.698 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2018-10-19T17:12:10.020Z,1539969130.020 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2018-10-19T17:12:10.022Z,1539969130.022 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/ 2018-10-19T17:12:10.023Z,1539969130.023 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg 2018-10-19T17:12:10.108Z,1539969130.108 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg 2018-10-19T17:12:10.269Z,1539969130.269 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg 2018-10-19T17:12:10.775Z,1539969130.775 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg 2018-10-19T17:12:10.947Z,1539969130.947 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg 2018-10-19T17:12:11.030Z,1539969131.030 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg 2018-10-19T17:12:11.254Z,1539969131.254 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2018-10-19T17:12:11.255Z,1539969131.255 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg 2018-10-19T17:12:11.369Z,1539969131.369 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg 2018-10-19T17:12:11.471Z,1539969131.471 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg 2018-10-19T17:12:11.569Z,1539969131.569 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg 2018-10-19T17:12:11.672Z,1539969131.672 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg 2018-10-19T17:12:11.784Z,1539969131.784 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2018-10-19T17:12:11.786Z,1539969131.786 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2018-10-19T17:12:11.831Z,1539969131.831 [DepthRateCalculator] Loaded 2018-10-19T17:12:11.832Z,1539969131.832 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2018-10-19T17:12:11.838Z,1539969131.838 [PitchRateCalculator] Loaded 2018-10-19T17:12:11.838Z,1539969131.838 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2018-10-19T17:12:11.854Z,1539969131.854 [SpeedCalculator] Loaded 2018-10-19T17:12:11.854Z,1539969131.854 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2018-10-19T17:12:11.875Z,1539969131.875 [TempGradientCalculator] Loaded 2018-10-19T17:12:11.875Z,1539969131.875 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2018-10-19T17:12:11.881Z,1539969131.881 [YawRateCalculator] Loaded 2018-10-19T17:12:11.881Z,1539969131.881 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2018-10-19T17:12:11.921Z,1539969131.921 [ElevatorOffsetCalculator] Loaded 2018-10-19T17:12:11.921Z,1539969131.921 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2018-10-19T17:12:11.921Z,1539969131.921 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2018-10-19T17:12:11.922Z,1539969131.922 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2018-10-19T17:12:12.168Z,1539969132.168 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2018-10-19T17:12:12.169Z,1539969132.169 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2018-10-19T17:12:12.634Z,1539969132.634 [AHRS_M2] Loaded 2018-10-19T17:12:12.634Z,1539969132.634 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2018-10-19T17:12:12.725Z,1539969132.725 [DataOverHttps] Loaded 2018-10-19T17:12:12.726Z,1539969132.726 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread. 2018-10-19T17:12:12.739Z,1539969132.739 [Depth_Keller] Loaded 2018-10-19T17:12:12.739Z,1539969132.739 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2018-10-19T17:12:12.744Z,1539969132.744 [DropWeight] Loaded 2018-10-19T17:12:12.744Z,1539969132.744 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2018-10-19T17:12:12.874Z,1539969132.874 [DVL_micro] Loaded 2018-10-19T17:12:12.874Z,1539969132.874 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread. 2018-10-19T17:12:12.972Z,1539969132.972 [NAL9602] Loaded 2018-10-19T17:12:12.972Z,1539969132.972 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2018-10-19T17:12:12.988Z,1539969132.988 [Onboard] Loaded 2018-10-19T17:12:12.989Z,1539969132.989 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2018-10-19T17:12:12.999Z,1539969132.999 [Radio_Surface] Loaded 2018-10-19T17:12:12.999Z,1539969132.999 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2018-10-19T17:12:13.001Z,1539969133.001 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 407C34E0 2018-10-19T17:12:13.001Z,1539969133.001 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 7960 2018-10-19T17:12:13.008Z,1539969133.008 [SCPI] Loaded 2018-10-19T17:12:13.008Z,1539969133.008 [ComponentRegistry](DEBUG): SyncComponent "SCPI" handled in the control thread. 2018-10-19T17:12:13.053Z,1539969133.053 [PNI_TCM] Loaded 2018-10-19T17:12:13.053Z,1539969133.053 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread. 2018-10-19T17:12:14.819Z,1539969134.819 [BPC1] Loaded 2018-10-19T17:12:14.819Z,1539969134.819 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2018-10-19T17:12:14.820Z,1539969134.820 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2018-10-19T17:12:14.820Z,1539969134.820 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2018-10-19T17:12:14.890Z,1539969134.890 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2018-10-19T17:12:14.890Z,1539969134.890 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2018-10-19T17:12:14.988Z,1539969134.988 [DeadReckonUsingMultipleVelocitySources] Loaded 2018-10-19T17:12:14.989Z,1539969134.989 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2018-10-19T17:12:15.042Z,1539969135.042 [DeadReckonUsingSpeedCalculator] Loaded 2018-10-19T17:12:15.043Z,1539969135.043 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2018-10-19T17:12:15.059Z,1539969135.059 [NavChart] Loaded 2018-10-19T17:12:15.059Z,1539969135.059 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2018-10-19T17:12:15.063Z,1539969135.063 [UniversalFixResidualReporter] Loaded 2018-10-19T17:12:15.063Z,1539969135.063 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2018-10-19T17:12:15.064Z,1539969135.064 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2018-10-19T17:12:15.064Z,1539969135.064 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2018-10-19T17:12:15.229Z,1539969135.229 [Aanderaa_O2] Loaded 2018-10-19T17:12:15.229Z,1539969135.229 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread. 2018-10-19T17:12:15.314Z,1539969135.314 [CTD_NeilBrown] Loaded 2018-10-19T17:12:15.314Z,1539969135.314 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread. 2018-10-19T17:12:15.315Z,1539969135.315 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 408CE4E0 2018-10-19T17:12:15.316Z,1539969135.316 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 7961 2018-10-19T17:12:15.371Z,1539969135.371 [CTD_Seabird] Loaded 2018-10-19T17:12:15.371Z,1539969135.371 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2018-10-19T17:12:15.372Z,1539969135.372 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 408FE4E0 2018-10-19T17:12:15.373Z,1539969135.373 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 7962 2018-10-19T17:12:15.656Z,1539969135.656 [WetLabsBB2FL] Loaded 2018-10-19T17:12:15.656Z,1539969135.656 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2018-10-19T17:12:15.665Z,1539969135.665 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 4092E4E0 2018-10-19T17:12:15.665Z,1539969135.665 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 7963 2018-10-19T17:12:15.666Z,1539969135.666 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2018-10-19T17:12:15.667Z,1539969135.667 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2018-10-19T17:12:15.987Z,1539969135.987 [VerticalControl](DEBUG): Construct VerticalControl. 2018-10-19T17:12:16.086Z,1539969136.086 [VerticalControl] Loaded 2018-10-19T17:12:16.086Z,1539969136.086 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2018-10-19T17:12:16.087Z,1539969136.087 [HorizontalControl](DEBUG): Construct HorizontalControl. 2018-10-19T17:12:16.155Z,1539969136.155 [HorizontalControl] Loaded 2018-10-19T17:12:16.155Z,1539969136.155 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2018-10-19T17:12:16.156Z,1539969136.156 [SpeedControl](DEBUG): Construct SpeedControl. 2018-10-19T17:12:16.161Z,1539969136.161 [SpeedControl] Loaded 2018-10-19T17:12:16.162Z,1539969136.162 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2018-10-19T17:12:16.162Z,1539969136.162 [LoopControl](DEBUG): Construct LoopControl. 2018-10-19T17:12:16.163Z,1539969136.163 [LoopControl] Loaded 2018-10-19T17:12:16.163Z,1539969136.163 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2018-10-19T17:12:16.163Z,1539969136.163 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2018-10-19T17:12:16.164Z,1539969136.164 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2018-10-19T17:12:16.187Z,1539969136.187 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2018-10-19T17:12:16.188Z,1539969136.188 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2018-10-19T17:12:16.346Z,1539969136.346 [SBIT](DEBUG): Construct Startup Built In Test. 2018-10-19T17:12:16.358Z,1539969136.358 [SBIT] Loaded 2018-10-19T17:12:16.358Z,1539969136.358 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2018-10-19T17:12:16.358Z,1539969136.358 [IBIT](DEBUG): Construct Initiated Built In Test. 2018-10-19T17:12:16.370Z,1539969136.370 [IBIT] Loaded 2018-10-19T17:12:16.370Z,1539969136.370 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2018-10-19T17:12:16.373Z,1539969136.373 [CBIT](DEBUG): Construct Continuous Built In Test. 2018-10-19T17:12:16.523Z,1539969136.523 [CBIT] Loaded 2018-10-19T17:12:16.523Z,1539969136.523 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2018-10-19T17:12:16.524Z,1539969136.524 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2018-10-19T17:12:16.524Z,1539969136.524 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2018-10-19T17:12:16.654Z,1539969136.654 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2018-10-19T17:12:16.654Z,1539969136.654 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2018-10-19T17:12:16.691Z,1539969136.691 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2018-10-19T17:12:16.692Z,1539969136.692 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2018-10-19T17:12:16.814Z,1539969136.814 [BuoyancyServo] Loaded 2018-10-19T17:12:16.814Z,1539969136.814 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2018-10-19T17:12:16.826Z,1539969136.826 [ElevatorServo] Loaded 2018-10-19T17:12:16.826Z,1539969136.826 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2018-10-19T17:12:16.837Z,1539969136.837 [MassServo] Loaded 2018-10-19T17:12:16.837Z,1539969136.837 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2018-10-19T17:12:16.848Z,1539969136.848 [RudderServo] Loaded 2018-10-19T17:12:16.849Z,1539969136.849 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2018-10-19T17:12:16.859Z,1539969136.859 [ThrusterServo] Loaded 2018-10-19T17:12:16.860Z,1539969136.860 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2018-10-19T17:12:16.860Z,1539969136.860 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2018-10-19T17:12:16.864Z,1539969136.864 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2018-10-19T17:12:16.865Z,1539969136.865 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2018-10-19T17:12:16.872Z,1539969136.872 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2018-10-19T17:12:16.873Z,1539969136.873 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A464E0 2018-10-19T17:12:16.873Z,1539969136.873 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 7964 2018-10-19T17:12:16.878Z,1539969136.878 [Supervisor](INFO): Main Thread ID is 7876 2018-10-19T17:12:16.878Z,1539969136.878 [Supervisor](DEBUG): Running supervisor. 2018-10-19T17:12:16.879Z,1539969136.879 [CommandLine ThreadHandler](INFO): Handler Thread ID is 7965 2018-10-19T17:12:16.881Z,1539969136.881 [controlThread ThreadHandler](INFO): Handler Thread ID is 7966 2018-10-19T17:12:16.882Z,1539969136.882 [controlThread](DEBUG): Initializing ControlThread 2018-10-19T17:12:16.883Z,1539969136.883 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2018-10-19T17:12:16.883Z,1539969136.883 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2018-10-19T17:12:16.883Z,1539969136.883 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2018-10-19T17:12:16.884Z,1539969136.884 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2018-10-19T17:12:16.884Z,1539969136.884 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2018-10-19T17:12:16.885Z,1539969136.885 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2018-10-19T17:12:16.892Z,1539969136.892 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-10-19T17:12:16.893Z,1539969136.893 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-10-19T17:12:16.893Z,1539969136.893 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-10-19T17:12:16.894Z,1539969136.894 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-10-19T17:12:16.894Z,1539969136.894 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-10-19T17:12:16.894Z,1539969136.894 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-10-19T17:12:16.895Z,1539969136.895 [NavChart](DEBUG): Initialize NavChart Navigation. 2018-10-19T17:12:16.895Z,1539969136.895 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2018-10-19T17:12:16.895Z,1539969136.895 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2018-10-19T17:12:16.898Z,1539969136.898 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2018-10-19T17:12:16.898Z,1539969136.898 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2018-10-19T17:12:16.899Z,1539969136.899 [LoopControl](DEBUG): Initialize LoopControlComponent. 2018-10-19T17:12:16.899Z,1539969136.899 [SBIT](INFO): Initialize SBIT Component. 2018-10-19T17:12:16.900Z,1539969136.900 [SBIT](IMPORTANT): git: 2018-10-09-31-g8f1ca26 2018-10-19T17:12:16.900Z,1539969136.900 [SBIT](INFO): git hash: 8f1ca2616133f591d84f59109522710795260801 2018-10-19T17:12:16.900Z,1539969136.900 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2018-10-19T17:12:16.901Z,1539969136.901 [SBIT](IMPORTANT): Kernel Version:#2 PREEMPT Thu Jan 11 20:13:48 PST 2018 2018-10-19T17:12:16.901Z,1539969136.901 [SBIT](INFO): Beginning SBIT in 28.000000 seconds. 2018-10-19T17:12:16.902Z,1539969136.902 [IBIT](INFO): Initialize IBIT Component. 2018-10-19T17:12:16.903Z,1539969136.903 [CBIT](DEBUG): Initialize CBIT Component. 2018-10-19T17:12:16.903Z,1539969136.903 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2018-10-19T17:12:16.904Z,1539969136.904 [logger ThreadHandler](INFO): Handler Thread ID is 7967 2018-10-19T17:12:16.921Z,1539969136.921 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 7968 2018-10-19T17:12:16.927Z,1539969136.927 [Radio_Surface](INFO): Powering up 2018-10-19T17:12:16.933Z,1539969136.933 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 7969 2018-10-19T17:12:16.945Z,1539969136.945 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 7970 2018-10-19T17:12:16.946Z,1539969136.946 [CTD_Seabird](INFO): Initializing 2018-10-19T17:12:16.946Z,1539969136.946 [CTD_Seabird](INFO): Checking LCM 2018-10-19T17:12:17.011Z,1539969137.011 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2018-10-19T17:12:17.066Z,1539969137.066 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 7971 2018-10-19T17:12:17.070Z,1539969137.070 [WetLabsBB2FL](INFO): Powering down 2018-10-19T17:12:17.187Z,1539969137.187 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 7972 2018-10-19T17:12:17.189Z,1539969137.189 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2018-10-19T17:12:17.191Z,1539969137.191 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US1WC07M.000 2018-10-19T17:12:17.191Z,1539969137.191 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2018-10-19T17:12:17.193Z,1539969137.193 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US2WC11M.000 2018-10-19T17:12:17.193Z,1539969137.193 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2018-10-19T17:12:17.194Z,1539969137.194 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US3CA52M.000 2018-10-19T17:12:17.195Z,1539969137.195 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2018-10-19T17:12:17.196Z,1539969137.196 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US4CA60M.000 2018-10-19T17:12:17.196Z,1539969137.196 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2018-10-19T17:12:17.198Z,1539969137.198 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US5CA50M.000 2018-10-19T17:12:17.198Z,1539969137.198 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2018-10-19T17:12:17.199Z,1539969137.199 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US5CA61M.000 2018-10-19T17:12:17.200Z,1539969137.200 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2018-10-19T17:12:17.201Z,1539969137.201 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US5CA62M.000 2018-10-19T17:12:17.202Z,1539969137.202 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2018-10-19T17:12:17.203Z,1539969137.203 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US5CA83M.000 2018-10-19T17:12:17.206Z,1539969137.206 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US5CA83M.000 2018-10-19T17:12:17.220Z,1539969137.220 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2018-10-19T17:12:17.244Z,1539969137.244 [MissionManager](DEBUG): 2018-10-19T17:12:17.275Z,1539969137.275 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2018-10-19T17:12:17.431Z,1539969137.431 [CTD_Seabird](INFO): LCM OK 2018-10-19T17:12:17.431Z,1539969137.431 [CTD_Seabird](INFO): Powering up 2018-10-19T17:12:17.460Z,1539969137.460 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2018-10-19T17:12:17.470Z,1539969137.470 [Default:A.Wait](DEBUG): Construct Wait. 2018-10-19T17:12:17.471Z,1539969137.471 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2018-10-19T17:12:17.499Z,1539969137.499 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2018-10-19T17:12:17.506Z,1539969137.506 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2018-10-19T17:12:17.540Z,1539969137.540 [Default:E.Execute](DEBUG): Construct Execute. 2018-10-19T17:12:17.544Z,1539969137.544 [MissionManager](DEBUG): 0 Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2018-10-19T17:12:17.566Z,1539969137.566 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,DataOverHttps,Depth_Keller,DropWeight,DVL_micro,NAL9602,Onboard,SCPI,PNI_TCM,BPC1,Aanderaa_O2,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2018-10-19T17:12:17.594Z,1539969137.594 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2018-10-19T17:12:18.041Z,1539969138.041 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2018-10-19T17:12:18.066Z,1539969138.066 [Depth_Keller](ERROR): Pressure reading out of range: 1827.005127 decibar 2018-10-19T17:12:18.094Z,1539969138.094 [DVL_micro](INFO): Initializing 2018-10-19T17:12:18.168Z,1539969138.168 [Onboard](ERROR): I2C read error. Can't read 1 bytes. 2018-10-19T17:12:18.168Z,1539969138.168 [Onboard](FAULT): Can't read temperature LSB. 2018-10-19T17:12:18.168Z,1539969138.168 [Onboard] Hardware Fault, FailCount= 1 2018-10-19T17:12:18.168Z,1539969138.168 [Onboard](ERROR): Hardware Fault 2018-10-19T17:12:18.169Z,1539969138.169 [Onboard](ERROR): I2C read error. Can't read 1 bytes. 2018-10-19T17:12:18.169Z,1539969138.169 [Onboard](FAULT): Can't read temperature MSB. 2018-10-19T17:12:18.169Z,1539969138.169 [Onboard](ERROR): I2C read error. Can't read 1 bytes. 2018-10-19T17:12:18.170Z,1539969138.170 [Onboard](FAULT): Can't read pressure LSB. 2018-10-19T17:12:18.170Z,1539969138.170 [Onboard](ERROR): I2C read error. Can't read 1 bytes. 2018-10-19T17:12:18.170Z,1539969138.170 [Onboard](FAULT): Can't read pressure MSB. 2018-10-19T17:12:18.257Z,1539969138.257 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-10-19T17:12:18.565Z,1539969138.565 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:12:18.569Z,1539969138.569 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-19T17:12:18.579Z,1539969138.579 [ElevatorServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:12:18.593Z,1539969138.593 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2018-10-19T17:12:18.599Z,1539969138.599 [MassServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:12:18.605Z,1539969138.605 [MassServo](DEBUG): Initializing MassServo. 2018-10-19T17:12:18.623Z,1539969138.623 [RudderServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:12:18.633Z,1539969138.633 [RudderServo](DEBUG): Initializing RudderServo. 2018-10-19T17:12:18.639Z,1539969138.639 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:12:18.646Z,1539969138.646 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-10-19T17:12:18.666Z,1539969138.666 [CBIT](ERROR): Hardware Fault in component: Onboard 2018-10-19T17:12:18.666Z,1539969138.666 [CBIT](CRITICAL): Hardware Fault in component: Onboard 2018-10-19T17:12:18.946Z,1539969138.946 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2018-10-19T17:12:18.946Z,1539969138.946 [DropWeight] Hardware Fault, FailCount= 1 2018-10-19T17:12:18.946Z,1539969138.946 [DropWeight](ERROR): Hardware Fault 2018-10-19T17:12:18.977Z,1539969138.977 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-10-19T17:12:19.002Z,1539969139.002 [CommandLine](FAULT): Scheduling is paused 2018-10-19T17:12:19.002Z,1539969139.002 [CBIT](INFO): Critical error at 20181019T171218 2018-10-19T17:12:19.002Z,1539969139.002 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2018-10-19T17:12:19.005Z,1539969139.005 [CBIT](ERROR): Hardware Fault in component: DropWeight 2018-10-19T17:12:19.005Z,1539969139.005 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2018-10-19T17:12:22.559Z,1539969142.559 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-10-19T17:12:22.688Z,1539969142.688 [CTD_Seabird](INFO): Started Seabird LCM interface with command:nohup ./lrauv-framework/onboard/bin/gpctd -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyC6 -b 9600 >& /dev/null & 2018-10-19T17:12:22.838Z,1539969142.838 [CTD_Seabird](INFO): LCM subscribed to channel:seabird_gpctd_t.seabird-gpctd 2018-10-19T17:12:27.857Z,1539969147.857 [Radio_Surface](INFO): Powering down 2018-10-19T17:12:28.009Z,1539969148.009 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-10-19T17:12:28.009Z,1539969148.009 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-10-19T17:12:28.009Z,1539969148.009 [BuoyancyServo] Communications Fault, FailCount= 1 2018-10-19T17:12:28.009Z,1539969148.009 [BuoyancyServo](ERROR): Communications Fault 2018-10-19T17:12:28.329Z,1539969148.329 [ElevatorServo](ERROR): Elevator initialization uart error I:serial timeout 2018-10-19T17:12:28.329Z,1539969148.329 [ElevatorServo](FAULT): Elevator failed to initialize 2018-10-19T17:12:28.329Z,1539969148.329 [ElevatorServo] Communications Fault, FailCount= 1 2018-10-19T17:12:28.329Z,1539969148.329 [ElevatorServo](ERROR): Communications Fault 2018-10-19T17:12:28.641Z,1539969148.641 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2018-10-19T17:12:28.641Z,1539969148.641 [RudderServo](FAULT): Rudder failed to initialize 2018-10-19T17:12:28.641Z,1539969148.641 [RudderServo] Communications Fault, FailCount= 1 2018-10-19T17:12:28.641Z,1539969148.641 [RudderServo](ERROR): Communications Fault 2018-10-19T17:12:28.965Z,1539969148.965 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2018-10-19T17:12:28.990Z,1539969148.990 [ThrusterServo](FAULT): Thruster failed to initialize 2018-10-19T17:12:28.991Z,1539969148.991 [ThrusterServo] Communications Fault, FailCount= 1 2018-10-19T17:12:28.991Z,1539969148.991 [ThrusterServo](ERROR): Communications Fault 2018-10-19T17:12:29.002Z,1539969149.002 [CBIT](INFO): Critical error at 20181019T171219 2018-10-19T17:12:29.033Z,1539969149.033 [CBIT](CRITICAL): Environmental Failure. Press:0.000000 PSI. Humidity:2139112%. Temp:5004296 C. ABORTING MISSION 2018-10-19T17:12:29.034Z,1539969149.034 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-19T17:12:29.034Z,1539969149.034 [CBIT](ERROR): Communications Fault in component: ElevatorServo 2018-10-19T17:12:29.034Z,1539969149.034 [CBIT](ERROR): Communications Fault in component: RudderServo 2018-10-19T17:12:29.035Z,1539969149.035 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-10-19T17:12:29.373Z,1539969149.373 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:12:29.373Z,1539969149.373 [AHRS_M2](FAULT): Failed to initialize within timeout. 2018-10-19T17:12:29.373Z,1539969149.373 [AHRS_M2] Communications Fault, FailCount= 1 2018-10-19T17:12:29.373Z,1539969149.373 [AHRS_M2](ERROR): Communications Fault 2018-10-19T17:12:29.463Z,1539969149.463 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-10-19T17:12:29.464Z,1539969149.464 [Aanderaa_O2] Communications Fault, FailCount= 1 2018-10-19T17:12:29.464Z,1539969149.464 [Aanderaa_O2](ERROR): Communications Fault 2018-10-19T17:12:29.491Z,1539969149.491 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-19T17:12:29.491Z,1539969149.491 [BuoyancyServo](INFO): Powering down 2018-10-19T17:12:29.585Z,1539969149.585 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2018-10-19T17:12:29.585Z,1539969149.585 [ElevatorServo](INFO): Powering down 2018-10-19T17:12:29.646Z,1539969149.646 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2018-10-19T17:12:29.646Z,1539969149.646 [RudderServo](INFO): Powering down 2018-10-19T17:12:29.687Z,1539969149.687 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-10-19T17:12:29.687Z,1539969149.687 [ThrusterServo](INFO): Powering down 2018-10-19T17:12:29.748Z,1539969149.748 [CBIT](INFO): Critical error at 20181019T171229 2018-10-19T17:12:29.758Z,1539969149.758 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2018-10-19T17:12:29.759Z,1539969149.759 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-10-19T17:12:29.769Z,1539969149.769 [AHRS_M2](INFO): Powering down 2018-10-19T17:12:31.624Z,1539969151.624 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US5CA83M.000 2018-10-19T17:12:48.181Z,1539969168.181 [CommandLine](IMPORTANT): got command failComponent 2018-10-19T17:12:48.182Z,1539969168.182 [CommandLine](IMPORTANT): Failed components: 2018-10-19T17:12:48.182Z,1539969168.182 [CommandLine](IMPORTANT): AHRS_M2: Communications Fault 2018-10-19T17:12:48.182Z,1539969168.182 [CommandLine](IMPORTANT): DropWeight: Hardware Fault 2018-10-19T17:12:48.183Z,1539969168.183 [CommandLine](IMPORTANT): Onboard: Hardware Fault 2018-10-19T17:12:48.183Z,1539969168.183 [CommandLine](IMPORTANT): Aanderaa_O2: Communications Fault 2018-10-19T17:12:48.183Z,1539969168.183 [CommandLine](IMPORTANT): BuoyancyServo: Communications Fault 2018-10-19T17:12:48.183Z,1539969168.183 [CommandLine](IMPORTANT): ElevatorServo: Communications Fault 2018-10-19T17:12:48.183Z,1539969168.183 [CommandLine](IMPORTANT): RudderServo: Communications Fault 2018-10-19T17:12:48.184Z,1539969168.184 [CommandLine](IMPORTANT): ThrusterServo: Communications Fault 2018-10-19T17:12:51.756Z,1539969171.756 [NavChartDb](INFO): # of records loaded: 5000 2018-10-19T17:12:53.137Z,1539969173.137 [CTD_Seabird](FAULT): Did not receive valid device response within the specified allowable sample time. 2018-10-19T17:12:53.138Z,1539969173.138 [CTD_Seabird] Communications Fault, FailCount= 1 2018-10-19T17:12:53.138Z,1539969173.138 [CTD_Seabird](ERROR): Communications Fault 2018-10-19T17:12:53.673Z,1539969173.673 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-10-19T17:12:53.674Z,1539969173.674 [CTD_Seabird](INFO): Powering down 2018-10-19T17:12:53.675Z,1539969173.675 [Aanderaa_O2](INFO): Powering down 2018-10-19T17:12:53.824Z,1539969173.824 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2018-10-19T17:12:53.832Z,1539969173.832 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting. 2018-10-19T17:12:53.902Z,1539969173.902 [NAL9602](INFO): Powering up NAL9602 2018-10-19T17:12:53.927Z,1539969173.927 [PNI_TCM](FAULT): Failed to acquire valid data within timeout. 2018-10-19T17:12:53.927Z,1539969173.927 [PNI_TCM] Data Fault, FailCount= 1 2018-10-19T17:12:53.927Z,1539969173.927 [PNI_TCM](ERROR): Data Fault 2018-10-19T17:12:53.968Z,1539969173.968 [ElevatorServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:12:54.086Z,1539969174.086 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2018-10-19T17:12:54.087Z,1539969174.087 [RudderServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:12:54.206Z,1539969174.206 [RudderServo](DEBUG): Initializing RudderServo. 2018-10-19T17:12:54.322Z,1539969174.322 [SBIT](IMPORTANT): Beginning Startup BIT 2018-10-19T17:12:54.326Z,1539969174.326 [CBIT](ERROR): Data Fault in component: PNI_TCM 2018-10-19T17:12:54.327Z,1539969174.327 [CBIT](CRITICAL): Data Fault in component: PNI_TCM 2018-10-19T17:12:54.327Z,1539969174.327 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-19T17:12:54.327Z,1539969174.327 [BuoyancyServo] No Fault, FailCount= 1 2018-10-19T17:12:54.327Z,1539969174.327 [CBIT](INFO): Clearing failed state for component ElevatorServo 2018-10-19T17:12:54.327Z,1539969174.327 [ElevatorServo] No Fault, FailCount= 1 2018-10-19T17:12:54.328Z,1539969174.328 [CBIT](INFO): Clearing failed state for component RudderServo 2018-10-19T17:12:54.328Z,1539969174.328 [RudderServo] No Fault, FailCount= 1 2018-10-19T17:12:54.328Z,1539969174.328 [CBIT](INFO): Clearing failed state for component ThrusterServo 2018-10-19T17:12:54.328Z,1539969174.328 [ThrusterServo] No Fault, FailCount= 1 2018-10-19T17:12:54.329Z,1539969174.329 [CBIT](IMPORTANT): Beginning ground fault scan 2018-10-19T17:12:54.471Z,1539969174.471 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:12:54.586Z,1539969174.586 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-19T17:12:54.893Z,1539969174.893 [ElevatorServo](ERROR): Elevator initialization uart error I:serial timeout 2018-10-19T17:12:54.893Z,1539969174.893 [ElevatorServo](FAULT): Elevator failed to initialize 2018-10-19T17:12:54.893Z,1539969174.893 [ElevatorServo] Communications Fault, FailCount= 2 2018-10-19T17:12:54.893Z,1539969174.893 [ElevatorServo](ERROR): Communications Fault 2018-10-19T17:12:54.997Z,1539969174.997 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:12:54.998Z,1539969174.998 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-10-19T17:12:55.001Z,1539969175.001 [CBIT](INFO): Critical error at 20181019T171254 2018-10-19T17:12:55.004Z,1539969175.004 [CBIT](INFO): Clearing failed state for component AHRS_M2 2018-10-19T17:12:55.004Z,1539969175.004 [AHRS_M2] No Fault, FailCount= 1 2018-10-19T17:12:55.005Z,1539969175.005 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-10-19T17:12:55.005Z,1539969175.005 [Aanderaa_O2] No Fault, FailCount= 1 2018-10-19T17:12:55.005Z,1539969175.005 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2018-10-19T17:12:55.005Z,1539969175.005 [CTD_Seabird] No Fault, FailCount= 1 2018-10-19T17:12:55.006Z,1539969175.006 [CBIT](ERROR): Communications Fault in component: ElevatorServo 2018-10-19T17:12:55.013Z,1539969175.013 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2018-10-19T17:12:55.249Z,1539969175.249 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2018-10-19T17:12:55.249Z,1539969175.249 [ElevatorServo](INFO): Powering down 2018-10-19T17:12:55.289Z,1539969175.289 [CTD_Seabird](INFO): Initializing 2018-10-19T17:12:55.289Z,1539969175.289 [CTD_Seabird](INFO): Checking LCM 2018-10-19T17:12:55.289Z,1539969175.289 [CTD_Seabird](INFO): LCM OK 2018-10-19T17:12:55.290Z,1539969175.290 [CTD_Seabird](INFO): Powering up 2018-10-19T17:12:55.801Z,1539969175.801 [MassServo](ERROR): isCommunicating uart error serial timeout 2018-10-19T17:12:55.801Z,1539969175.801 [MassServo](FAULT): Invalid EZ Servo response:"" 2018-10-19T17:12:55.801Z,1539969175.801 [MassServo] Communications Fault, FailCount= 1 2018-10-19T17:12:55.801Z,1539969175.801 [MassServo](ERROR): Communications Fault 2018-10-19T17:12:55.802Z,1539969175.802 [MassServo](FAULT): Mass Shifter error waiting for homing. Uart error: serial timeout 2018-10-19T17:12:55.802Z,1539969175.802 [MassServo] Hardware Fault, FailCount= 1 2018-10-19T17:12:55.802Z,1539969175.802 [MassServo](ERROR): Hardware Fault 2018-10-19T17:12:56.133Z,1539969176.133 [MassServo](FAULT): Invalid EZ Servo response:"88\r" 2018-10-19T17:12:56.133Z,1539969176.133 [MassServo] Communications Fault, FailCount= 1 2018-10-19T17:12:56.133Z,1539969176.133 [MassServo](ERROR): Communications Fault 2018-10-19T17:12:56.461Z,1539969176.461 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2018-10-19T17:12:56.490Z,1539969176.490 [ThrusterServo](FAULT): Thruster failed to initialize 2018-10-19T17:12:56.491Z,1539969176.491 [ThrusterServo] Communications Fault, FailCount= 2 2018-10-19T17:12:56.492Z,1539969176.492 [ThrusterServo](ERROR): Communications Fault 2018-10-19T17:12:56.539Z,1539969176.539 [CBIT](ERROR): Communications Fault in component: MassServo 2018-10-19T17:12:56.539Z,1539969176.539 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-10-19T17:12:56.693Z,1539969176.693 [ElevatorServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:12:56.814Z,1539969176.814 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2018-10-19T17:12:56.815Z,1539969176.815 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-10-19T17:12:56.815Z,1539969176.815 [MassServo](INFO): Powering down 2018-10-19T17:12:57.149Z,1539969177.149 [RudderServo](FAULT): Rudder initialization uart error:serial timeout 2018-10-19T17:12:57.149Z,1539969177.149 [RudderServo] Communications Fault, FailCount= 2 2018-10-19T17:12:57.149Z,1539969177.149 [RudderServo](ERROR): Communications Fault 2018-10-19T17:12:57.149Z,1539969177.149 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-10-19T17:12:57.150Z,1539969177.150 [ThrusterServo](INFO): Powering down 2018-10-19T17:12:57.155Z,1539969177.155 [CBIT](INFO): Clearing failed state for component ElevatorServo 2018-10-19T17:12:57.155Z,1539969177.155 [ElevatorServo] No Fault, FailCount= 2 2018-10-19T17:12:57.155Z,1539969177.155 [CBIT](ERROR): Communications Fault in component: RudderServo 2018-10-19T17:12:57.549Z,1539969177.549 [BuoyancyServo](FAULT): Buoyancy initialization uart error:serial timeout 2018-10-19T17:12:57.549Z,1539969177.549 [BuoyancyServo] Communications Fault, FailCount= 2 2018-10-19T17:12:57.549Z,1539969177.549 [BuoyancyServo](ERROR): Communications Fault 2018-10-19T17:12:57.861Z,1539969177.861 [ElevatorServo](ERROR): Elevator initialization uart error I:serial timeout 2018-10-19T17:12:57.861Z,1539969177.861 [ElevatorServo](FAULT): Elevator failed to initialize 2018-10-19T17:12:57.861Z,1539969177.861 [ElevatorServo] Communications Fault, FailCount= 3 2018-10-19T17:12:57.861Z,1539969177.861 [ElevatorServo](ERROR): Communications Fault 2018-10-19T17:12:57.862Z,1539969177.862 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2018-10-19T17:12:57.862Z,1539969177.862 [RudderServo](INFO): Powering down 2018-10-19T17:12:57.923Z,1539969177.923 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-19T17:12:57.924Z,1539969177.924 [CBIT](ERROR): Communications Fault in component: ElevatorServo 2018-10-19T17:12:57.924Z,1539969177.924 [CBIT](CRITICAL): Communications Fault in component: ElevatorServo 2018-10-19T17:12:58.044Z,1539969178.044 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-19T17:12:58.045Z,1539969178.045 [BuoyancyServo](INFO): Powering down 2018-10-19T17:12:58.061Z,1539969178.061 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2018-10-19T17:12:58.061Z,1539969178.061 [ElevatorServo](INFO): Powering down 2018-10-19T17:12:58.062Z,1539969178.062 [MassServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:12:58.201Z,1539969178.201 [MassServo](DEBUG): Initializing MassServo. 2018-10-19T17:12:58.331Z,1539969178.331 [CBIT](INFO): Critical error at 20181019T171257 2018-10-19T17:12:58.334Z,1539969178.334 [CBIT](INFO): Clearing failed state for component MassServo 2018-10-19T17:12:58.334Z,1539969178.334 [MassServo] No Fault, FailCount= 1 2018-10-19T17:12:58.334Z,1539969178.334 [CBIT](INFO): Clearing failed state for component ThrusterServo 2018-10-19T17:12:58.334Z,1539969178.334 [ThrusterServo] No Fault, FailCount= 2 2018-10-19T17:12:58.737Z,1539969178.737 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:12:58.758Z,1539969178.758 [RudderServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:12:58.873Z,1539969178.873 [RudderServo](DEBUG): Initializing RudderServo. 2018-10-19T17:12:58.875Z,1539969178.875 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:12:58.875Z,1539969178.875 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-10-19T17:12:58.892Z,1539969178.892 [CBIT](INFO): Clearing failed state for component RudderServo 2018-10-19T17:12:58.892Z,1539969178.892 [RudderServo] No Fault, FailCount= 2 2018-10-19T17:12:59.253Z,1539969179.253 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:12:59.268Z,1539969179.268 [ElevatorServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:12:59.393Z,1539969179.393 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2018-10-19T17:12:59.697Z,1539969179.697 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2018-10-19T17:12:59.697Z,1539969179.697 [RudderServo](FAULT): Rudder failed to initialize 2018-10-19T17:12:59.697Z,1539969179.697 [RudderServo] Communications Fault, FailCount= 3 2018-10-19T17:12:59.697Z,1539969179.697 [RudderServo](ERROR): Communications Fault 2018-10-19T17:13:00.021Z,1539969180.021 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2018-10-19T17:13:00.046Z,1539969180.046 [ThrusterServo](FAULT): Thruster failed to initialize 2018-10-19T17:13:00.046Z,1539969180.046 [ThrusterServo] Communications Fault, FailCount= 3 2018-10-19T17:13:00.046Z,1539969180.046 [ThrusterServo](ERROR): Communications Fault 2018-10-19T17:13:00.065Z,1539969180.065 [CBIT](ERROR): Communications Fault in component: RudderServo 2018-10-19T17:13:00.067Z,1539969180.067 [CBIT](CRITICAL): Communications Fault in component: RudderServo 2018-10-19T17:13:00.068Z,1539969180.068 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-10-19T17:13:00.501Z,1539969180.501 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:13:00.665Z,1539969180.665 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2018-10-19T17:13:00.665Z,1539969180.665 [RudderServo](INFO): Powering down 2018-10-19T17:13:00.666Z,1539969180.666 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-10-19T17:13:00.667Z,1539969180.667 [ThrusterServo](INFO): Powering down 2018-10-19T17:13:00.719Z,1539969180.719 [CBIT](INFO): Critical error at 20181019T171300 2018-10-19T17:13:00.853Z,1539969180.853 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-10-19T17:13:00.928Z,1539969180.928 [CTD_Seabird](INFO): Started Seabird LCM interface with command:nohup ./lrauv-framework/onboard/bin/gpctd -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyC6 -b 9600 >& /dev/null & 2018-10-19T17:13:00.929Z,1539969180.929 [CTD_Seabird](INFO): LCM subscribed to channel:seabird_gpctd_t.seabird-gpctd 2018-10-19T17:13:01.121Z,1539969181.121 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:13:01.425Z,1539969181.425 [MassServo](FAULT): Mass initialization uart error:serial timeout 2018-10-19T17:13:01.425Z,1539969181.425 [MassServo] Communications Fault, FailCount= 2 2018-10-19T17:13:01.425Z,1539969181.425 [MassServo](ERROR): Communications Fault 2018-10-19T17:13:01.431Z,1539969181.431 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-19T17:13:01.431Z,1539969181.431 [BuoyancyServo] No Fault, FailCount= 2 2018-10-19T17:13:01.432Z,1539969181.432 [CBIT](ERROR): Communications Fault in component: MassServo 2018-10-19T17:13:01.877Z,1539969181.877 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:13:01.922Z,1539969181.922 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:13:02.042Z,1539969182.042 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-19T17:13:02.043Z,1539969182.043 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-10-19T17:13:02.043Z,1539969182.043 [MassServo](INFO): Powering down 2018-10-19T17:13:02.045Z,1539969182.045 [RudderServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:13:02.166Z,1539969182.166 [RudderServo](DEBUG): Initializing RudderServo. 2018-10-19T17:13:02.286Z,1539969182.286 [CBIT](INFO): Clearing failed state for component ThrusterServo 2018-10-19T17:13:02.286Z,1539969182.286 [ThrusterServo] No Fault, FailCount= 3 2018-10-19T17:13:02.629Z,1539969182.629 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:13:02.990Z,1539969182.990 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-10-19T17:13:02.991Z,1539969182.991 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-10-19T17:13:02.991Z,1539969182.991 [BuoyancyServo] Communications Fault, FailCount= 3 2018-10-19T17:13:02.991Z,1539969182.991 [BuoyancyServo](ERROR): Communications Fault 2018-10-19T17:13:02.992Z,1539969182.992 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:13:02.994Z,1539969182.994 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-10-19T17:13:02.999Z,1539969182.999 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-19T17:13:03.321Z,1539969183.321 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:13:03.336Z,1539969183.336 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-19T17:13:03.337Z,1539969183.337 [BuoyancyServo](INFO): Powering down 2018-10-19T17:13:03.377Z,1539969183.377 [MassServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:13:03.494Z,1539969183.494 [MassServo](DEBUG): Initializing MassServo. 2018-10-19T17:13:03.817Z,1539969183.817 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2018-10-19T17:13:04.141Z,1539969184.141 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout 2018-10-19T17:13:04.141Z,1539969184.141 [ThrusterServo](FAULT): Thruster failed to initialize 2018-10-19T17:13:04.141Z,1539969184.141 [ThrusterServo] Communications Fault, FailCount= 4 2018-10-19T17:13:04.141Z,1539969184.141 [ThrusterServo](ERROR): Communications Fault 2018-10-19T17:13:04.181Z,1539969184.181 [CBIT](INFO): Clearing failed state for component MassServo 2018-10-19T17:13:04.181Z,1539969184.181 [MassServo] No Fault, FailCount= 2 2018-10-19T17:13:04.182Z,1539969184.182 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-10-19T17:13:04.602Z,1539969184.602 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:13:04.631Z,1539969184.631 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-10-19T17:13:04.631Z,1539969184.631 [ThrusterServo](INFO): Powering down 2018-10-19T17:13:05.041Z,1539969185.041 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:13:05.457Z,1539969185.457 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:13:05.457Z,1539969185.457 [AHRS_M2](FAULT): Failed to initialize within timeout. 2018-10-19T17:13:05.457Z,1539969185.457 [AHRS_M2] Communications Fault, FailCount= 2 2018-10-19T17:13:05.457Z,1539969185.457 [AHRS_M2](ERROR): Communications Fault 2018-10-19T17:13:05.477Z,1539969185.477 [NAL9602](INFO): NAL9602 initialized 2018-10-19T17:13:05.486Z,1539969185.486 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-10-19T17:13:05.487Z,1539969185.487 [Aanderaa_O2] Communications Fault, FailCount= 2 2018-10-19T17:13:05.487Z,1539969185.487 [Aanderaa_O2](ERROR): Communications Fault 2018-10-19T17:13:05.637Z,1539969185.637 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2018-10-19T17:13:05.638Z,1539969185.638 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-10-19T17:13:05.638Z,1539969185.638 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-19T17:13:05.638Z,1539969185.638 [BuoyancyServo] No Fault, FailCount= 3 2018-10-19T17:13:05.639Z,1539969185.639 [CBIT](INFO): Clearing failed state for component ThrusterServo 2018-10-19T17:13:05.639Z,1539969185.639 [ThrusterServo] No Fault, FailCount= 4 2018-10-19T17:13:05.731Z,1539969185.731 [AHRS_M2](INFO): Powering down 2018-10-19T17:13:21.441Z,1539969201.441 [CommandLine](IMPORTANT): got command failComponent 2018-10-19T17:13:21.442Z,1539969201.442 [CommandLine](IMPORTANT): Failed components: 2018-10-19T17:13:21.442Z,1539969201.442 [CommandLine](IMPORTANT): AHRS_M2: Communications Fault 2018-10-19T17:13:21.442Z,1539969201.442 [CommandLine](IMPORTANT): DropWeight: Hardware Fault 2018-10-19T17:13:21.442Z,1539969201.442 [CommandLine](IMPORTANT): Onboard: Hardware Fault 2018-10-19T17:13:21.443Z,1539969201.443 [CommandLine](IMPORTANT): PNI_TCM: Data Fault 2018-10-19T17:13:21.443Z,1539969201.443 [CommandLine](IMPORTANT): Aanderaa_O2: Communications Fault 2018-10-19T17:13:21.443Z,1539969201.443 [CommandLine](IMPORTANT): ElevatorServo: Communications Fault 2018-10-19T17:13:21.443Z,1539969201.443 [CommandLine](IMPORTANT): RudderServo: Communications Fault 2018-10-19T17:13:24.661Z,1539969204.661 [NavChartDb](INFO): # of records loaded: 10000 2018-10-19T17:13:29.606Z,1539969209.606 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US5CA83M.000 2018-10-19T17:13:30.397Z,1539969210.397 [CTD_Seabird](FAULT): Did not receive valid device response within the specified allowable sample time. 2018-10-19T17:13:30.397Z,1539969210.397 [CTD_Seabird] Communications Fault, FailCount= 2 2018-10-19T17:13:30.397Z,1539969210.397 [CTD_Seabird](ERROR): Communications Fault 2018-10-19T17:13:30.936Z,1539969210.936 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-10-19T17:13:30.936Z,1539969210.936 [CTD_Seabird](INFO): Powering down 2018-10-19T17:13:30.938Z,1539969210.938 [Aanderaa_O2](INFO): Powering down 2018-10-19T17:13:30.954Z,1539969210.954 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:13:31.075Z,1539969211.075 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-19T17:13:31.078Z,1539969211.078 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:13:31.085Z,1539969211.085 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-10-19T17:13:31.087Z,1539969211.087 [SBIT](ERROR): Could not read elevatorAngleReader_. 2018-10-19T17:13:31.087Z,1539969211.087 [SBIT](ERROR): Could not read rudderAngleReader_. 2018-10-19T17:13:31.087Z,1539969211.087 [SBIT](ERROR): Could not read massPosReader_. 2018-10-19T17:13:31.092Z,1539969211.092 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2018-10-19T17:13:31.196Z,1539969211.196 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2018-10-19T17:13:31.861Z,1539969211.861 [CBIT](INFO): Clearing failed state for component AHRS_M2 2018-10-19T17:13:31.861Z,1539969211.861 [AHRS_M2] No Fault, FailCount= 2 2018-10-19T17:13:31.862Z,1539969211.862 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-10-19T17:13:31.862Z,1539969211.862 [Aanderaa_O2] No Fault, FailCount= 2 2018-10-19T17:13:31.998Z,1539969211.998 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2018-10-19T17:13:32.170Z,1539969212.170 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2018-10-19T17:13:32.170Z,1539969212.170 [CTD_Seabird] No Fault, FailCount= 2 2018-10-19T17:13:32.553Z,1539969212.553 [CTD_Seabird](INFO): Initializing 2018-10-19T17:13:32.553Z,1539969212.553 [CTD_Seabird](INFO): Checking LCM 2018-10-19T17:13:32.554Z,1539969212.554 [CTD_Seabird](INFO): LCM OK 2018-10-19T17:13:32.554Z,1539969212.554 [CTD_Seabird](INFO): Powering up 2018-10-19T17:13:32.793Z,1539969212.793 [MassServo](ERROR): isCommunicating uart error serial timeout 2018-10-19T17:13:32.793Z,1539969212.793 [MassServo](FAULT): Invalid EZ Servo response:"" 2018-10-19T17:13:32.793Z,1539969212.793 [MassServo] Communications Fault, FailCount= 3 2018-10-19T17:13:32.793Z,1539969212.793 [MassServo](ERROR): Communications Fault 2018-10-19T17:13:32.794Z,1539969212.794 [MassServo](FAULT): Mass Shifter error waiting for homing. Uart error: serial timeout 2018-10-19T17:13:32.794Z,1539969212.794 [MassServo] Hardware Fault, FailCount= 3 2018-10-19T17:13:32.794Z,1539969212.794 [MassServo](ERROR): Hardware Fault 2018-10-19T17:13:32.999Z,1539969212.999 [NavChartDb](INFO): # of records loaded: 15000 2018-10-19T17:13:33.114Z,1539969213.114 [MassServo](FAULT): Bad Operand Error 2018-10-19T17:13:33.125Z,1539969213.125 [CBIT](ERROR): Hardware Fault in component: MassServo 2018-10-19T17:13:33.229Z,1539969213.229 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-10-19T17:13:33.229Z,1539969213.229 [MassServo](INFO): Powering down 2018-10-19T17:13:33.533Z,1539969213.533 [ThrusterServo](FAULT): Thruster initialization uart error:serial timeout 2018-10-19T17:13:33.533Z,1539969213.533 [ThrusterServo] Communications Fault, FailCount= 5 2018-10-19T17:13:33.533Z,1539969213.533 [ThrusterServo](ERROR): Communications Fault 2018-10-19T17:13:33.538Z,1539969213.538 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-10-19T17:13:33.539Z,1539969213.539 [CBIT](CRITICAL): Communications Fault in component: ThrusterServo 2018-10-19T17:13:33.542Z,1539969213.542 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.007038 CHAN A1 (24V): 0.001342 CHAN A2 (12V): -0.005738 CHAN A3 (5V): -0.002743 CHAN B0 (3.3V): -0.001204 CHAN B1 (3.15aV): -0.001267 CHAN B2 (3.15bV): -0.001584 CHAN B3 (GND): -0.000238 OPEN: -0.001377 Full Scale Calc: 4.765 mA, -1.589 mA 2018-10-19T17:13:34.009Z,1539969214.009 [BuoyancyServo](FAULT): Buoyancy initialization uart error:serial timeout 2018-10-19T17:13:34.009Z,1539969214.009 [BuoyancyServo] Communications Fault, FailCount= 4 2018-10-19T17:13:34.009Z,1539969214.009 [BuoyancyServo](ERROR): Communications Fault 2018-10-19T17:13:34.010Z,1539969214.010 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-10-19T17:13:34.010Z,1539969214.010 [ThrusterServo](INFO): Powering down 2018-10-19T17:13:34.014Z,1539969214.014 [CBIT](INFO): Critical error at 20181019T171333 2018-10-19T17:13:34.037Z,1539969214.037 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-19T17:13:34.130Z,1539969214.130 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-19T17:13:34.131Z,1539969214.131 [BuoyancyServo](INFO): Powering down 2018-10-19T17:13:34.145Z,1539969214.145 [MassServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:13:34.262Z,1539969214.262 [MassServo](DEBUG): Initializing MassServo. 2018-10-19T17:13:34.269Z,1539969214.269 [CBIT](INFO): Clearing failed state for component MassServo 2018-10-19T17:13:34.269Z,1539969214.269 [MassServo] No Fault, FailCount= 3 2018-10-19T17:13:35.368Z,1539969215.368 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US5CA83M.000 2018-10-19T17:13:35.561Z,1539969215.561 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:13:35.981Z,1539969215.981 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:13:36.385Z,1539969216.385 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:13:36.690Z,1539969216.690 [CommandLine](IMPORTANT): got command failComponent 2018-10-19T17:13:36.691Z,1539969216.691 [CommandLine](IMPORTANT): Failed components: 2018-10-19T17:13:36.691Z,1539969216.691 [CommandLine](IMPORTANT): DropWeight: Hardware Fault 2018-10-19T17:13:36.691Z,1539969216.691 [CommandLine](IMPORTANT): Onboard: Hardware Fault 2018-10-19T17:13:36.691Z,1539969216.691 [CommandLine](IMPORTANT): PNI_TCM: Data Fault 2018-10-19T17:13:36.692Z,1539969216.692 [CommandLine](IMPORTANT): BuoyancyServo: Communications Fault 2018-10-19T17:13:36.692Z,1539969216.692 [CommandLine](IMPORTANT): ElevatorServo: Communications Fault 2018-10-19T17:13:36.692Z,1539969216.692 [CommandLine](IMPORTANT): RudderServo: Communications Fault 2018-10-19T17:13:36.692Z,1539969216.692 [CommandLine](IMPORTANT): ThrusterServo: Communications Fault 2018-10-19T17:13:36.781Z,1539969216.781 [MassServo](FAULT): Mass initialization uart error:serial timeout 2018-10-19T17:13:36.781Z,1539969216.781 [MassServo] Communications Fault, FailCount= 4 2018-10-19T17:13:36.781Z,1539969216.781 [MassServo](ERROR): Communications Fault 2018-10-19T17:13:36.786Z,1539969216.786 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-19T17:13:36.786Z,1539969216.786 [BuoyancyServo] No Fault, FailCount= 4 2018-10-19T17:13:36.786Z,1539969216.786 [CBIT](ERROR): Communications Fault in component: MassServo 2018-10-19T17:13:37.121Z,1539969217.121 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:13:37.155Z,1539969217.155 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:13:37.274Z,1539969217.274 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-19T17:13:37.275Z,1539969217.275 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-10-19T17:13:37.275Z,1539969217.275 [MassServo](INFO): Powering down 2018-10-19T17:13:37.613Z,1539969217.613 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:13:37.966Z,1539969217.966 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-10-19T17:13:38.029Z,1539969218.029 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:13:38.063Z,1539969218.063 [CTD_Seabird](INFO): Started Seabird LCM interface with command:nohup ./lrauv-framework/onboard/bin/gpctd -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyC6 -b 9600 >& /dev/null & 2018-10-19T17:13:38.065Z,1539969218.065 [CTD_Seabird](INFO): LCM subscribed to channel:seabird_gpctd_t.seabird-gpctd 2018-10-19T17:13:38.549Z,1539969218.549 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-10-19T17:13:38.549Z,1539969218.549 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-10-19T17:13:38.549Z,1539969218.549 [BuoyancyServo] Communications Fault, FailCount= 5 2018-10-19T17:13:38.549Z,1539969218.549 [BuoyancyServo](ERROR): Communications Fault 2018-10-19T17:13:38.550Z,1539969218.550 [MassServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:13:38.677Z,1539969218.677 [MassServo](DEBUG): Initializing MassServo. 2018-10-19T17:13:38.684Z,1539969218.684 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-19T17:13:38.684Z,1539969218.684 [CBIT](INFO): Clearing failed state for component MassServo 2018-10-19T17:13:38.684Z,1539969218.684 [MassServo] No Fault, FailCount= 4 2018-10-19T17:13:39.009Z,1539969219.009 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:13:39.032Z,1539969219.032 [BPC1](ERROR): BPC1A: No match for serial number 0226 in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2018-10-19T17:13:39.034Z,1539969219.034 [BPC1](ERROR): BPC1B: No match for serial number 0273 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2018-10-19T17:13:39.034Z,1539969219.034 [BPC1](FAULT): Failed to parse data from all battery packs. 2018-10-19T17:13:39.034Z,1539969219.034 [BPC1] Data Fault, FailCount= 1 2018-10-19T17:13:39.034Z,1539969219.034 [BPC1](ERROR): Data Fault 2018-10-19T17:13:39.051Z,1539969219.051 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-19T17:13:39.052Z,1539969219.052 [BuoyancyServo](INFO): Powering down 2018-10-19T17:13:39.110Z,1539969219.110 [CBIT](ERROR): Data Fault in component: BPC1 2018-10-19T17:13:39.453Z,1539969219.453 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:13:39.893Z,1539969219.893 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:13:40.305Z,1539969220.305 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:13:40.714Z,1539969220.714 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:13:41.097Z,1539969221.097 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:13:41.405Z,1539969221.405 [MassServo](FAULT): Mass initialization uart error:serial timeout 2018-10-19T17:13:41.405Z,1539969221.405 [MassServo] Communications Fault, FailCount= 5 2018-10-19T17:13:41.405Z,1539969221.405 [MassServo](ERROR): Communications Fault 2018-10-19T17:13:41.410Z,1539969221.410 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-19T17:13:41.410Z,1539969221.410 [BuoyancyServo] No Fault, FailCount= 5 2018-10-19T17:13:41.411Z,1539969221.411 [CBIT](ERROR): Communications Fault in component: MassServo 2018-10-19T17:13:41.411Z,1539969221.411 [CBIT](CRITICAL): Communications Fault in component: MassServo 2018-10-19T17:13:41.741Z,1539969221.741 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:13:41.757Z,1539969221.757 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:13:41.885Z,1539969221.885 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-19T17:13:41.886Z,1539969221.886 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-10-19T17:13:41.886Z,1539969221.886 [MassServo](INFO): Powering down 2018-10-19T17:13:41.895Z,1539969221.895 [CBIT](INFO): Critical error at 20181019T171341 2018-10-19T17:13:42.249Z,1539969222.249 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:13:42.249Z,1539969222.249 [AHRS_M2](FAULT): Failed to initialize within timeout. 2018-10-19T17:13:42.249Z,1539969222.249 [AHRS_M2] Communications Fault, FailCount= 3 2018-10-19T17:13:42.249Z,1539969222.249 [AHRS_M2](ERROR): Communications Fault 2018-10-19T17:13:42.256Z,1539969222.256 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-10-19T17:13:42.256Z,1539969222.256 [Aanderaa_O2] Communications Fault, FailCount= 3 2018-10-19T17:13:42.256Z,1539969222.256 [Aanderaa_O2](ERROR): Communications Fault 2018-10-19T17:13:42.285Z,1539969222.285 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2018-10-19T17:13:42.286Z,1539969222.286 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-10-19T17:13:42.286Z,1539969222.286 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2018-10-19T17:13:42.346Z,1539969222.346 [AHRS_M2](INFO): Powering down 2018-10-19T17:14:07.638Z,1539969247.638 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US5CA83M.000 2018-10-19T17:14:07.651Z,1539969247.651 [NavChartDb](INFO): # of records loaded: 19732 2018-10-19T17:14:07.677Z,1539969247.677 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US5CA83M.000 2018-10-19T17:14:07.725Z,1539969247.725 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US5CA62M.000 2018-10-19T17:14:08.349Z,1539969248.349 [CTD_Seabird](FAULT): Did not receive valid device response within the specified allowable sample time. 2018-10-19T17:14:08.349Z,1539969248.349 [CTD_Seabird] Communications Fault, FailCount= 3 2018-10-19T17:14:08.349Z,1539969248.349 [CTD_Seabird](ERROR): Communications Fault 2018-10-19T17:14:08.879Z,1539969248.879 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-10-19T17:14:08.879Z,1539969248.879 [CTD_Seabird](INFO): Powering down 2018-10-19T17:14:08.881Z,1539969248.881 [Aanderaa_O2](INFO): Powering down 2018-10-19T17:14:08.982Z,1539969248.982 [MassServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:14:09.098Z,1539969249.098 [MassServo](DEBUG): Initializing MassServo. 2018-10-19T17:14:09.100Z,1539969249.100 [SBIT](ERROR): Could not read elevatorAngleReader_. 2018-10-19T17:14:09.100Z,1539969249.100 [SBIT](ERROR): Could not read rudderAngleReader_. 2018-10-19T17:14:09.100Z,1539969249.100 [SBIT](ERROR): Could not read massPosReader_. 2018-10-19T17:14:09.100Z,1539969249.100 [SBIT](FAULT): Control surface position failure. 2018-10-19T17:14:09.105Z,1539969249.105 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2018-10-19T17:14:09.106Z,1539969249.106 [CBIT](INFO): Clearing failed state for component ThrusterServo 2018-10-19T17:14:09.106Z,1539969249.106 [ThrusterServo] No Fault, FailCount= 5 2018-10-19T17:14:09.114Z,1539969249.114 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2018-10-19T17:14:09.194Z,1539969249.194 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:14:09.201Z,1539969249.201 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-10-19T17:14:09.577Z,1539969249.577 [CBIT](INFO): Clearing failed state for component AHRS_M2 2018-10-19T17:14:09.577Z,1539969249.577 [AHRS_M2] No Fault, FailCount= 3 2018-10-19T17:14:09.917Z,1539969249.917 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2018-10-19T17:14:10.141Z,1539969250.141 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2018-10-19T17:14:10.142Z,1539969250.142 [CTD_Seabird] No Fault, FailCount= 3 2018-10-19T17:14:10.493Z,1539969250.493 [CTD_Seabird](INFO): Initializing 2018-10-19T17:14:10.493Z,1539969250.493 [CTD_Seabird](INFO): Checking LCM 2018-10-19T17:14:10.493Z,1539969250.493 [CTD_Seabird](INFO): LCM OK 2018-10-19T17:14:10.493Z,1539969250.493 [CTD_Seabird](INFO): Powering up 2018-10-19T17:14:13.437Z,1539969253.437 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:14:13.861Z,1539969253.861 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:14:14.273Z,1539969254.273 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:14:14.697Z,1539969254.697 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:14:15.131Z,1539969255.131 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US5CA62M.000 2018-10-19T17:14:15.157Z,1539969255.157 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:14:15.583Z,1539969255.583 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:14:15.885Z,1539969255.885 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-10-19T17:14:15.979Z,1539969255.979 [CTD_Seabird](INFO): Started Seabird LCM interface with command:nohup ./lrauv-framework/onboard/bin/gpctd -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyC6 -b 9600 >& /dev/null & 2018-10-19T17:14:15.990Z,1539969255.990 [CTD_Seabird](INFO): LCM subscribed to channel:seabird_gpctd_t.seabird-gpctd 2018-10-19T17:14:16.013Z,1539969256.013 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:14:16.482Z,1539969256.482 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:14:16.897Z,1539969256.897 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:14:16.907Z,1539969256.907 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-10-19T17:14:16.907Z,1539969256.907 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2018-10-19T17:14:16.907Z,1539969256.907 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-10-19T17:14:16.909Z,1539969256.909 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-10-19T17:14:16.909Z,1539969256.909 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1 2018-10-19T17:14:16.909Z,1539969256.909 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-10-19T17:14:16.966Z,1539969256.966 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-10-19T17:14:16.966Z,1539969256.966 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-10-19T17:14:17.305Z,1539969257.305 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:14:17.403Z,1539969257.403 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-10-19T17:14:17.403Z,1539969257.403 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2018-10-19T17:14:17.403Z,1539969257.403 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-10-19T17:14:17.403Z,1539969257.403 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1 2018-10-19T17:14:17.762Z,1539969257.762 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:14:17.779Z,1539969257.779 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-10-19T17:14:17.780Z,1539969257.780 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-10-19T17:14:17.780Z,1539969257.780 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-10-19T17:14:17.780Z,1539969257.780 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-10-19T17:14:17.781Z,1539969257.781 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-10-19T17:14:17.781Z,1539969257.781 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-10-19T17:14:18.173Z,1539969258.173 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:14:18.589Z,1539969258.589 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:14:19.005Z,1539969259.005 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:14:19.405Z,1539969259.405 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:14:19.825Z,1539969259.825 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:14:20.245Z,1539969260.245 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:14:20.245Z,1539969260.245 [AHRS_M2](FAULT): Failed to initialize within timeout. 2018-10-19T17:14:20.245Z,1539969260.245 [AHRS_M2] Communications Fault, FailCount= 4 2018-10-19T17:14:20.245Z,1539969260.245 [AHRS_M2](ERROR): Communications Fault 2018-10-19T17:14:20.342Z,1539969260.342 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2018-10-19T17:14:20.349Z,1539969260.349 [AHRS_M2](INFO): Powering down 2018-10-19T17:14:22.407Z,1539969262.407 [SBIT](ERROR): Could not read elevatorAngleReader_. 2018-10-19T17:14:22.407Z,1539969262.407 [SBIT](ERROR): Could not read rudderAngleReader_. 2018-10-19T17:14:22.407Z,1539969262.407 [SBIT](ERROR): Could not read massPosReader_. 2018-10-19T17:14:22.407Z,1539969262.407 [SBIT](FAULT): Control surface position failure. 2018-10-19T17:14:22.822Z,1539969262.822 [SBIT](CRITICAL): SBIT FAILED 2018-10-19T17:14:22.867Z,1539969262.867 [CBIT](INFO): Critical error at 20181019T171422 2018-10-19T17:14:22.905Z,1539969262.905 [CommandLine](IMPORTANT): got command configSet list 2018-10-19T17:14:22.905Z,1539969262.905 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2018-10-19T17:14:22.906Z,1539969262.906 [CommandLine](IMPORTANT): No configSet variables persisted 2018-10-19T17:14:23.163Z,1539969263.163 [MissionManager](IMPORTANT): Started mission Startup 2018-10-19T17:14:23.163Z,1539969263.163 [Startup] Running Loop=1 2018-10-19T17:14:23.163Z,1539969263.163 [Startup](DEBUG): Aggregate::initialize Startup 2018-10-19T17:14:23.163Z,1539969263.163 [Startup:A.GoToSurface] Running Loop=1 2018-10-19T17:14:23.163Z,1539969263.163 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2018-10-19T17:14:23.164Z,1539969263.164 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2018-10-19T17:14:23.165Z,1539969263.165 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2018-10-19T17:14:23.165Z,1539969263.165 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2018-10-19T17:14:23.165Z,1539969263.165 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2018-10-19T17:14:23.166Z,1539969263.166 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2018-10-19T17:14:23.537Z,1539969263.537 [Radio_Surface](INFO): Powering up 2018-10-19T17:14:24.025Z,1539969264.025 [CBIT](INFO): Clearing failed state for component AHRS_M2 2018-10-19T17:14:24.025Z,1539969264.025 [AHRS_M2] No Fault, FailCount= 4 2018-10-19T17:14:24.350Z,1539969264.350 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2018-10-19T17:14:27.865Z,1539969267.865 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:14:28.293Z,1539969268.293 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:14:28.709Z,1539969268.709 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:14:29.145Z,1539969269.145 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:14:29.554Z,1539969269.554 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:14:29.963Z,1539969269.963 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:14:30.405Z,1539969270.405 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:14:30.754Z,1539969270.754 [NavChartDb](INFO): # of records loaded: 5000 2018-10-19T17:14:30.817Z,1539969270.817 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:14:31.241Z,1539969271.241 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:14:31.677Z,1539969271.677 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:14:32.121Z,1539969272.121 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:14:32.537Z,1539969272.537 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:14:32.949Z,1539969272.949 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:14:33.349Z,1539969273.349 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:14:33.765Z,1539969273.765 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:14:34.198Z,1539969274.198 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:14:34.610Z,1539969274.610 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:14:34.610Z,1539969274.610 [AHRS_M2](FAULT): Failed to initialize within timeout. 2018-10-19T17:14:34.610Z,1539969274.610 [AHRS_M2] Communications Fault, FailCount= 5 2018-10-19T17:14:34.610Z,1539969274.610 [AHRS_M2](ERROR): Communications Fault 2018-10-19T17:14:34.689Z,1539969274.689 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2018-10-19T17:14:34.689Z,1539969274.689 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2 2018-10-19T17:14:34.710Z,1539969274.710 [AHRS_M2](INFO): Powering down 2018-10-19T17:14:34.852Z,1539969274.852 [CBIT](INFO): Critical error at 20181019T171434 2018-10-19T17:14:39.906Z,1539969279.906 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2018-10-19T17:14:44.290Z,1539969284.290 [NavChartDb](INFO): # of records loaded: 10000 2018-10-19T17:14:45.533Z,1539969285.533 [CTD_Seabird](FAULT): Did not receive valid device response within the specified allowable sample time. 2018-10-19T17:14:45.533Z,1539969285.533 [CTD_Seabird] Communications Fault, FailCount= 4 2018-10-19T17:14:45.533Z,1539969285.533 [CTD_Seabird](ERROR): Communications Fault 2018-10-19T17:14:45.590Z,1539969285.590 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2018-10-19T17:14:46.139Z,1539969286.139 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-10-19T17:14:46.140Z,1539969286.140 [CTD_Seabird](INFO): Powering down 2018-10-19T17:14:47.586Z,1539969287.586 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2018-10-19T17:14:47.586Z,1539969287.586 [CTD_Seabird] No Fault, FailCount= 4 2018-10-19T17:14:47.753Z,1539969287.753 [CTD_Seabird](INFO): Initializing 2018-10-19T17:14:47.753Z,1539969287.753 [CTD_Seabird](INFO): Checking LCM 2018-10-19T17:14:47.753Z,1539969287.753 [CTD_Seabird](INFO): LCM OK 2018-10-19T17:14:47.754Z,1539969287.754 [CTD_Seabird](INFO): Powering up 2018-10-19T17:14:53.244Z,1539969293.244 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-10-19T17:14:53.316Z,1539969293.316 [CTD_Seabird](INFO): Started Seabird LCM interface with command:nohup ./lrauv-framework/onboard/bin/gpctd -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyC6 -b 9600 >& /dev/null & 2018-10-19T17:14:53.317Z,1539969293.317 [CTD_Seabird](INFO): LCM subscribed to channel:seabird_gpctd_t.seabird-gpctd 2018-10-19T17:14:56.696Z,1539969296.696 [NavChartDb](INFO): # of records loaded: 15000 2018-10-19T17:15:09.449Z,1539969309.449 [NavChartDb](INFO): # of records loaded: 20000 2018-10-19T17:15:15.106Z,1539969315.106 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2018-10-19T17:15:22.769Z,1539969322.769 [CTD_Seabird](FAULT): Did not receive valid device response within the specified allowable sample time. 2018-10-19T17:15:22.769Z,1539969322.769 [CTD_Seabird] Communications Fault, FailCount= 5 2018-10-19T17:15:22.769Z,1539969322.769 [CTD_Seabird](ERROR): Communications Fault 2018-10-19T17:15:22.790Z,1539969322.790 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2018-10-19T17:15:22.790Z,1539969322.790 [CBIT](CRITICAL): Communications Fault in component: CTD_Seabird 2018-10-19T17:15:23.213Z,1539969323.213 [CBIT](INFO): Critical error at 20181019T171522 2018-10-19T17:15:23.371Z,1539969323.371 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-10-19T17:15:23.371Z,1539969323.371 [CTD_Seabird](INFO): Powering down 2018-10-19T17:15:25.754Z,1539969325.754 [NavChartDb](INFO): # of records loaded: 25000 2018-10-19T17:15:29.910Z,1539969329.910 [DVL_micro](FAULT): DVL failed to acquire valid data within timeout. 2018-10-19T17:15:29.910Z,1539969329.910 [DVL_micro] Data Fault, FailCount= 1 2018-10-19T17:15:29.910Z,1539969329.910 [DVL_micro](ERROR): Data Fault 2018-10-19T17:15:29.982Z,1539969329.982 [CBIT](ERROR): Data Fault in component: DVL_micro 2018-10-19T17:15:29.982Z,1539969329.982 [CBIT](CRITICAL): Data Fault in component: DVL_micro 2018-10-19T17:15:30.312Z,1539969330.312 [DVL_micro](INFO): uninitialize:Powering down 2018-10-19T17:15:30.371Z,1539969330.371 [CBIT](INFO): Critical error at 20181019T171529 2018-10-19T17:15:33.936Z,1539969333.936 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US5CA62M.000 2018-10-19T17:15:39.545Z,1539969339.545 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US5CA62M.000 2018-10-19T17:15:39.810Z,1539969339.810 [NavChartDb](INFO): # of records loaded: 30000 2018-10-19T17:15:41.861Z,1539969341.861 [CommandLine](IMPORTANT): got command failComponent 2018-10-19T17:15:41.862Z,1539969341.862 [CommandLine](IMPORTANT): Failed components: 2018-10-19T17:15:41.862Z,1539969341.862 [CommandLine](IMPORTANT): AHRS_M2: Communications Fault 2018-10-19T17:15:41.862Z,1539969341.862 [CommandLine](IMPORTANT): DropWeight: Hardware Fault 2018-10-19T17:15:41.862Z,1539969341.862 [CommandLine](IMPORTANT): DVL_micro: Data Fault 2018-10-19T17:15:41.863Z,1539969341.863 [CommandLine](IMPORTANT): Onboard: Hardware Fault 2018-10-19T17:15:41.863Z,1539969341.863 [CommandLine](IMPORTANT): PNI_TCM: Data Fault 2018-10-19T17:15:41.863Z,1539969341.863 [CommandLine](IMPORTANT): BPC1: Data Fault 2018-10-19T17:15:41.863Z,1539969341.863 [CommandLine](IMPORTANT): Aanderaa_O2: Communications Fault 2018-10-19T17:15:41.863Z,1539969341.863 [CommandLine](IMPORTANT): CTD_Seabird: Communications Fault 2018-10-19T17:15:41.864Z,1539969341.864 [CommandLine](IMPORTANT): ElevatorServo: Communications Fault 2018-10-19T17:15:41.864Z,1539969341.864 [CommandLine](IMPORTANT): MassServo: Communications Fault 2018-10-19T17:15:41.864Z,1539969341.864 [CommandLine](IMPORTANT): RudderServo: Communications Fault 2018-10-19T17:15:50.313Z,1539969350.313 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2018-10-19T17:15:59.829Z,1539969359.829 [NavChartDb](INFO): # of records loaded: 35000 2018-10-19T17:16:12.388Z,1539969372.388 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-10-19T17:16:12.388Z,1539969372.388 [Aanderaa_O2] No Fault, FailCount= 3 2018-10-19T17:16:13.473Z,1539969373.473 [BuoyancyServo](ERROR): getPosition uart error serial timeout 2018-10-19T17:16:13.473Z,1539969373.473 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout 2018-10-19T17:16:13.473Z,1539969373.473 [BuoyancyServo] Communications Fault, FailCount= 6 2018-10-19T17:16:13.473Z,1539969373.473 [BuoyancyServo](ERROR): Communications Fault 2018-10-19T17:16:13.478Z,1539969373.478 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-19T17:16:13.590Z,1539969373.590 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-19T17:16:13.592Z,1539969373.592 [BuoyancyServo](INFO): Powering down 2018-10-19T17:16:14.127Z,1539969374.127 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US5CA62M.000 2018-10-19T17:16:14.164Z,1539969374.164 [NavChartDb](INFO): # of records loaded: 37376 2018-10-19T17:16:14.178Z,1539969374.178 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US5CA62M.000 2018-10-19T17:16:14.201Z,1539969374.201 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US5CA61M.000 2018-10-19T17:16:15.558Z,1539969375.558 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-19T17:16:15.558Z,1539969375.558 [BuoyancyServo] No Fault, FailCount= 6 2018-10-19T17:16:15.933Z,1539969375.933 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:16:16.054Z,1539969376.054 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-19T17:16:17.929Z,1539969377.929 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-10-19T17:16:17.929Z,1539969377.929 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2018-10-19T17:16:17.929Z,1539969377.929 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-10-19T17:16:17.931Z,1539969377.931 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-10-19T17:16:17.931Z,1539969377.931 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2 2018-10-19T17:16:17.931Z,1539969377.931 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-10-19T17:16:17.970Z,1539969377.970 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-10-19T17:16:17.970Z,1539969377.970 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-10-19T17:16:18.649Z,1539969378.649 [BuoyancyServo](FAULT): Buoyancy initialization uart error:serial timeout 2018-10-19T17:16:18.649Z,1539969378.649 [BuoyancyServo] Communications Fault, FailCount= 7 2018-10-19T17:16:18.649Z,1539969378.649 [BuoyancyServo](ERROR): Communications Fault 2018-10-19T17:16:18.653Z,1539969378.653 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-10-19T17:16:18.653Z,1539969378.653 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2018-10-19T17:16:18.654Z,1539969378.654 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-10-19T17:16:18.654Z,1539969378.654 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2 2018-10-19T17:16:18.655Z,1539969378.655 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-19T17:16:18.724Z,1539969378.724 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-10-19T17:16:18.725Z,1539969378.725 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-10-19T17:16:18.725Z,1539969378.725 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-10-19T17:16:18.736Z,1539969378.736 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-10-19T17:16:18.736Z,1539969378.736 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-10-19T17:16:18.736Z,1539969378.736 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-10-19T17:16:18.762Z,1539969378.762 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-19T17:16:18.763Z,1539969378.763 [BuoyancyServo](INFO): Powering down 2018-10-19T17:16:20.332Z,1539969380.332 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US5CA61M.000 2018-10-19T17:16:20.774Z,1539969380.774 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-19T17:16:20.774Z,1539969380.774 [BuoyancyServo] No Fault, FailCount= 7 2018-10-19T17:16:21.133Z,1539969381.133 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:16:21.257Z,1539969381.257 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-19T17:16:22.297Z,1539969382.297 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-10-19T17:16:22.297Z,1539969382.297 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-10-19T17:16:22.297Z,1539969382.297 [BuoyancyServo] Communications Fault, FailCount= 8 2018-10-19T17:16:22.297Z,1539969382.297 [BuoyancyServo](ERROR): Communications Fault 2018-10-19T17:16:22.314Z,1539969382.314 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-19T17:16:22.395Z,1539969382.395 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-19T17:16:22.396Z,1539969382.396 [BuoyancyServo](INFO): Powering down 2018-10-19T17:16:22.727Z,1539969382.727 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-10-19T17:16:22.727Z,1539969382.727 [Aanderaa_O2] Communications Fault, FailCount= 1 2018-10-19T17:16:22.728Z,1539969382.728 [Aanderaa_O2](ERROR): Communications Fault 2018-10-19T17:16:22.808Z,1539969382.808 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-10-19T17:16:34.300Z,1539969394.300 [NavChartDb](INFO): # of records loaded: 5000 2018-10-19T17:16:42.405Z,1539969402.405 [NavChartDb](INFO): # of records loaded: 10000 2018-10-19T17:16:50.198Z,1539969410.198 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US5CA61M.000 2018-10-19T17:16:51.625Z,1539969411.625 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US5CA61M.000 2018-10-19T17:16:52.891Z,1539969412.891 [NavChartDb](INFO): # of records loaded: 15000 2018-10-19T17:16:53.245Z,1539969413.245 [Aanderaa_O2](INFO): Powering down 2018-10-19T17:16:53.329Z,1539969413.329 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2018-10-19T17:16:53.410Z,1539969413.410 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-19T17:16:53.410Z,1539969413.410 [BuoyancyServo] No Fault, FailCount= 8 2018-10-19T17:16:53.754Z,1539969413.754 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:16:53.874Z,1539969413.874 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-19T17:16:53.879Z,1539969413.879 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-10-19T17:16:53.879Z,1539969413.879 [Aanderaa_O2] No Fault, FailCount= 1 2018-10-19T17:16:54.562Z,1539969414.562 [CommandLine](IMPORTANT): got command failComponent 2018-10-19T17:16:54.562Z,1539969414.562 [CommandLine](IMPORTANT): Failed components: 2018-10-19T17:16:54.563Z,1539969414.563 [CommandLine](IMPORTANT): AHRS_M2: Communications Fault 2018-10-19T17:16:54.563Z,1539969414.563 [CommandLine](IMPORTANT): DropWeight: Hardware Fault 2018-10-19T17:16:54.563Z,1539969414.563 [CommandLine](IMPORTANT): DVL_micro: Data Fault 2018-10-19T17:16:54.563Z,1539969414.563 [CommandLine](IMPORTANT): Onboard: Hardware Fault 2018-10-19T17:16:54.564Z,1539969414.564 [CommandLine](IMPORTANT): PNI_TCM: Data Fault 2018-10-19T17:16:54.564Z,1539969414.564 [CommandLine](IMPORTANT): BPC1: Data Fault 2018-10-19T17:16:54.564Z,1539969414.564 [CommandLine](IMPORTANT): CTD_Seabird: Communications Fault 2018-10-19T17:16:54.564Z,1539969414.564 [CommandLine](IMPORTANT): ElevatorServo: Communications Fault 2018-10-19T17:16:54.565Z,1539969414.565 [CommandLine](IMPORTANT): MassServo: Communications Fault 2018-10-19T17:16:54.565Z,1539969414.565 [CommandLine](IMPORTANT): RudderServo: Communications Fault 2018-10-19T17:16:59.477Z,1539969419.477 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-10-19T17:16:59.477Z,1539969419.477 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-10-19T17:16:59.477Z,1539969419.477 [BuoyancyServo] Communications Fault, FailCount= 9 2018-10-19T17:16:59.477Z,1539969419.477 [BuoyancyServo](ERROR): Communications Fault 2018-10-19T17:16:59.482Z,1539969419.482 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-19T17:16:59.582Z,1539969419.582 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-19T17:16:59.583Z,1539969419.583 [BuoyancyServo](INFO): Powering down 2018-10-19T17:17:00.314Z,1539969420.314 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003080 2018-10-19T17:17:01.534Z,1539969421.534 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-19T17:17:01.534Z,1539969421.534 [BuoyancyServo] No Fault, FailCount= 9 2018-10-19T17:17:01.942Z,1539969421.942 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:17:02.073Z,1539969422.073 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-19T17:17:03.102Z,1539969423.102 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-10-19T17:17:03.102Z,1539969423.102 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-10-19T17:17:03.102Z,1539969423.102 [BuoyancyServo] Communications Fault, FailCount= 10 2018-10-19T17:17:03.102Z,1539969423.102 [BuoyancyServo](ERROR): Communications Fault 2018-10-19T17:17:03.107Z,1539969423.107 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-19T17:17:03.107Z,1539969423.107 [CBIT](CRITICAL): Communications Fault in component: BuoyancyServo 2018-10-19T17:17:03.196Z,1539969423.196 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-19T17:17:03.202Z,1539969423.202 [BuoyancyServo](INFO): Powering down 2018-10-19T17:17:03.231Z,1539969423.231 [CBIT](INFO): Critical error at 20181019T171703 2018-10-19T17:17:04.338Z,1539969424.338 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-10-19T17:17:04.338Z,1539969424.338 [Aanderaa_O2] Communications Fault, FailCount= 2 2018-10-19T17:17:04.338Z,1539969424.338 [Aanderaa_O2](ERROR): Communications Fault 2018-10-19T17:17:04.362Z,1539969424.362 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-10-19T17:17:06.166Z,1539969426.166 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US5CA61M.000 2018-10-19T17:17:06.312Z,1539969426.312 [NavChartDb](INFO): # of records loaded: 16998 2018-10-19T17:17:06.316Z,1539969426.316 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US5CA61M.000 2018-10-19T17:17:06.317Z,1539969426.317 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US5CA50M.000 2018-10-19T17:17:10.036Z,1539969430.036 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US5CA50M.000 2018-10-19T17:17:21.485Z,1539969441.485 [NavChartDb](INFO): # of records loaded: 5000 2018-10-19T17:17:27.839Z,1539969447.839 [NavChartDb](INFO): # of records loaded: 10000 2018-10-19T17:17:33.830Z,1539969453.830 [NavChartDb](INFO): # of records loaded: 15000 2018-10-19T17:17:34.857Z,1539969454.857 [Aanderaa_O2](INFO): Powering down 2018-10-19T17:17:35.356Z,1539969455.356 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-10-19T17:17:35.356Z,1539969455.356 [Aanderaa_O2] No Fault, FailCount= 2 2018-10-19T17:17:43.170Z,1539969463.170 [NavChartDb](INFO): # of records loaded: 20000 2018-10-19T17:17:50.280Z,1539969470.280 [NavChartDb](INFO): # of records loaded: 25000 2018-10-19T17:17:51.254Z,1539969471.254 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-10-19T17:17:51.254Z,1539969471.254 [Aanderaa_O2] Communications Fault, FailCount= 3 2018-10-19T17:17:51.254Z,1539969471.254 [Aanderaa_O2](ERROR): Communications Fault 2018-10-19T17:17:51.305Z,1539969471.305 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-10-19T17:17:51.306Z,1539969471.306 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2018-10-19T17:17:56.358Z,1539969476.358 [NavChartDb](INFO): # of records loaded: 30000 2018-10-19T17:18:03.986Z,1539969483.986 [NavChartDb](INFO): # of records loaded: 35000 2018-10-19T17:18:11.878Z,1539969491.878 [NavChartDb](INFO): # of records loaded: 40000 2018-10-19T17:18:18.332Z,1539969498.332 [NavChartDb](INFO): # of records loaded: 45000 2018-10-19T17:18:21.773Z,1539969501.773 [Aanderaa_O2](INFO): Powering down 2018-10-19T17:18:21.781Z,1539969501.781 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-10-19T17:18:21.781Z,1539969501.781 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2018-10-19T17:18:21.781Z,1539969501.781 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-10-19T17:18:21.783Z,1539969501.783 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-10-19T17:18:21.783Z,1539969501.783 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3 2018-10-19T17:18:21.783Z,1539969501.783 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-10-19T17:18:21.824Z,1539969501.824 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-10-19T17:18:21.833Z,1539969501.833 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-10-19T17:18:21.961Z,1539969501.961 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-10-19T17:18:21.961Z,1539969501.961 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2018-10-19T17:18:21.961Z,1539969501.961 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-10-19T17:18:21.962Z,1539969501.962 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3 2018-10-19T17:18:22.265Z,1539969502.265 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-10-19T17:18:22.266Z,1539969502.266 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-10-19T17:18:22.266Z,1539969502.266 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-10-19T17:18:22.266Z,1539969502.266 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-10-19T17:18:22.267Z,1539969502.267 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-10-19T17:18:22.267Z,1539969502.267 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-10-19T17:18:26.805Z,1539969506.805 [NavChartDb](INFO): # of records loaded: 50000 2018-10-19T17:18:34.326Z,1539969514.326 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2018-10-19T17:18:38.092Z,1539969518.092 [NavChartDb](INFO): # of records loaded: 55000 2018-10-19T17:18:39.734Z,1539969519.734 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US5CA50M.000 2018-10-19T17:18:41.566Z,1539969521.566 [CBIT](INFO): Clearing failed state for component MassServo 2018-10-19T17:18:41.566Z,1539969521.566 [MassServo] No Fault, FailCount= 5 2018-10-19T17:18:44.294Z,1539969524.294 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US5CA50M.000 2018-10-19T17:18:48.826Z,1539969528.826 [NavChartDb](INFO): # of records loaded: 60000 2018-10-19T17:19:02.813Z,1539969542.813 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US5CA50M.000 2018-10-19T17:19:02.945Z,1539969542.945 [NavChartDb](INFO): # of records loaded: 62026 2018-10-19T17:19:02.951Z,1539969542.951 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US5CA50M.000 2018-10-19T17:19:02.952Z,1539969542.952 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US4CA60M.000 2018-10-19T17:19:03.118Z,1539969543.118 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-19T17:19:03.118Z,1539969543.118 [BuoyancyServo] No Fault, FailCount= 10 2018-10-19T17:19:03.490Z,1539969543.490 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:19:03.606Z,1539969543.606 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-19T17:19:08.262Z,1539969548.262 [Radio_Surface](INFO): Powering down 2018-10-19T17:19:09.959Z,1539969549.959 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US4CA60M.000 2018-10-19T17:19:14.350Z,1539969554.350 [Radio_Surface](INFO): Powering up 2018-10-19T17:19:22.411Z,1539969562.411 [NavChartDb](INFO): # of records loaded: 5000 2018-10-19T17:19:23.473Z,1539969563.473 [BuoyancyServo](FAULT): Overload Error 2018-10-19T17:19:23.473Z,1539969563.473 [BuoyancyServo] Hardware Fault, FailCount= 1 2018-10-19T17:19:23.473Z,1539969563.473 [BuoyancyServo](ERROR): Hardware Fault 2018-10-19T17:19:23.551Z,1539969563.551 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo 2018-10-19T17:19:23.848Z,1539969563.848 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-19T17:19:23.849Z,1539969563.849 [BuoyancyServo](INFO): Powering down 2018-10-19T17:19:25.915Z,1539969565.915 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-19T17:19:25.915Z,1539969565.915 [BuoyancyServo] No Fault, FailCount= 1 2018-10-19T17:19:26.276Z,1539969566.276 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:19:26.390Z,1539969566.390 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-19T17:19:31.941Z,1539969571.941 [MassServo](INFO): Failure count cleared after critical for MassServo 2018-10-19T17:19:31.973Z,1539969571.973 [NavChartDb](INFO): # of records loaded: 10000 2018-10-19T17:19:34.754Z,1539969574.754 [CBIT](INFO): Clearing failed state for component AHRS_M2 2018-10-19T17:19:34.754Z,1539969574.754 [AHRS_M2] No Fault, FailCount= 5 2018-10-19T17:19:35.029Z,1539969575.029 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2018-10-19T17:19:38.553Z,1539969578.553 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:19:38.949Z,1539969578.949 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:19:39.365Z,1539969579.365 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:19:39.789Z,1539969579.789 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:19:40.177Z,1539969580.177 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:19:40.585Z,1539969580.585 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:19:40.847Z,1539969580.847 [NavChartDb](INFO): # of records loaded: 15000 2018-10-19T17:19:41.025Z,1539969581.025 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:19:41.458Z,1539969581.458 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:19:41.881Z,1539969581.881 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:19:42.317Z,1539969582.317 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:19:42.737Z,1539969582.737 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:19:43.181Z,1539969583.181 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:19:43.581Z,1539969583.581 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:19:43.993Z,1539969583.993 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:19:44.406Z,1539969584.406 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:19:44.821Z,1539969584.821 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:19:45.237Z,1539969585.237 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:19:45.237Z,1539969585.237 [AHRS_M2](FAULT): Failed to initialize within timeout. 2018-10-19T17:19:45.237Z,1539969585.237 [AHRS_M2] Communications Fault, FailCount= 1 2018-10-19T17:19:45.237Z,1539969585.237 [AHRS_M2](ERROR): Communications Fault 2018-10-19T17:19:45.322Z,1539969585.322 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2018-10-19T17:19:45.341Z,1539969585.341 [AHRS_M2](INFO): Powering down 2018-10-19T17:19:49.009Z,1539969589.009 [CBIT](INFO): Clearing failed state for component AHRS_M2 2018-10-19T17:19:49.009Z,1539969589.009 [AHRS_M2] No Fault, FailCount= 1 2018-10-19T17:19:49.329Z,1539969589.329 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2018-10-19T17:19:50.733Z,1539969590.733 [NavChartDb](INFO): # of records loaded: 20000 2018-10-19T17:19:52.853Z,1539969592.853 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:19:53.289Z,1539969593.289 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:19:53.689Z,1539969593.689 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:19:54.109Z,1539969594.109 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:19:54.517Z,1539969594.517 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:19:54.925Z,1539969594.925 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:19:55.325Z,1539969595.325 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:19:55.746Z,1539969595.746 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:19:56.157Z,1539969596.157 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:19:56.553Z,1539969596.553 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:19:56.982Z,1539969596.982 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:19:57.393Z,1539969597.393 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:19:57.813Z,1539969597.813 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:19:58.233Z,1539969598.233 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:19:58.661Z,1539969598.661 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:19:59.081Z,1539969599.081 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:19:59.481Z,1539969599.481 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:19:59.481Z,1539969599.481 [AHRS_M2](FAULT): Failed to initialize within timeout. 2018-10-19T17:19:59.481Z,1539969599.481 [AHRS_M2] Communications Fault, FailCount= 2 2018-10-19T17:19:59.481Z,1539969599.481 [AHRS_M2](ERROR): Communications Fault 2018-10-19T17:19:59.542Z,1539969599.542 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2018-10-19T17:19:59.565Z,1539969599.565 [AHRS_M2](INFO): Powering down 2018-10-19T17:20:00.617Z,1539969600.617 [NavChartDb](INFO): # of records loaded: 25000 2018-10-19T17:20:02.354Z,1539969602.354 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2018-10-19T17:20:03.224Z,1539969603.224 [CBIT](INFO): Clearing failed state for component AHRS_M2 2018-10-19T17:20:03.225Z,1539969603.225 [AHRS_M2] No Fault, FailCount= 2 2018-10-19T17:20:03.553Z,1539969603.553 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2018-10-19T17:20:03.562Z,1539969603.562 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.131844 2018-10-19T17:20:07.078Z,1539969607.078 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:20:07.473Z,1539969607.473 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:20:07.890Z,1539969607.890 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:20:08.317Z,1539969608.317 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:20:08.749Z,1539969608.749 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:20:09.165Z,1539969609.165 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:20:09.601Z,1539969609.601 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:20:10.021Z,1539969610.021 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:20:10.433Z,1539969610.433 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:20:10.849Z,1539969610.849 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:20:10.964Z,1539969610.964 [NavChartDb](INFO): # of records loaded: 30000 2018-10-19T17:20:11.269Z,1539969611.269 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:20:11.693Z,1539969611.693 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:20:12.113Z,1539969612.113 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:20:12.537Z,1539969612.537 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:20:12.945Z,1539969612.945 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:20:13.357Z,1539969613.357 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:20:13.761Z,1539969613.761 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:20:13.761Z,1539969613.761 [AHRS_M2](FAULT): Failed to initialize within timeout. 2018-10-19T17:20:13.761Z,1539969613.761 [AHRS_M2] Communications Fault, FailCount= 3 2018-10-19T17:20:13.761Z,1539969613.761 [AHRS_M2](ERROR): Communications Fault 2018-10-19T17:20:13.838Z,1539969613.838 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2018-10-19T17:20:13.861Z,1539969613.861 [AHRS_M2](INFO): Powering down 2018-10-19T17:20:17.513Z,1539969617.513 [CBIT](INFO): Clearing failed state for component AHRS_M2 2018-10-19T17:20:17.514Z,1539969617.514 [AHRS_M2] No Fault, FailCount= 3 2018-10-19T17:20:17.845Z,1539969617.845 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2018-10-19T17:20:18.895Z,1539969618.895 [NavChartDb](INFO): # of records loaded: 35000 2018-10-19T17:20:21.365Z,1539969621.365 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:20:21.442Z,1539969621.442 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-10-19T17:20:21.442Z,1539969621.442 [Aanderaa_O2] No Fault, FailCount= 3 2018-10-19T17:20:21.769Z,1539969621.769 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:20:22.189Z,1539969622.189 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:20:22.581Z,1539969622.581 [BuoyancyServo](ERROR): getPosition uart error serial timeout 2018-10-19T17:20:22.581Z,1539969622.581 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout 2018-10-19T17:20:22.581Z,1539969622.581 [BuoyancyServo] Communications Fault, FailCount= 2 2018-10-19T17:20:22.581Z,1539969622.581 [BuoyancyServo](ERROR): Communications Fault 2018-10-19T17:20:22.586Z,1539969622.586 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-19T17:20:22.938Z,1539969622.938 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:20:22.973Z,1539969622.973 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-10-19T17:20:22.973Z,1539969622.973 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2018-10-19T17:20:22.973Z,1539969622.973 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-10-19T17:20:22.975Z,1539969622.975 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-10-19T17:20:22.975Z,1539969622.975 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4 2018-10-19T17:20:22.975Z,1539969622.975 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-10-19T17:20:23.016Z,1539969623.016 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-19T17:20:23.018Z,1539969623.018 [BuoyancyServo](INFO): Powering down 2018-10-19T17:20:23.070Z,1539969623.070 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-10-19T17:20:23.070Z,1539969623.070 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-10-19T17:20:23.417Z,1539969623.417 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:20:23.491Z,1539969623.491 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-10-19T17:20:23.491Z,1539969623.491 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2018-10-19T17:20:23.491Z,1539969623.491 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-10-19T17:20:23.491Z,1539969623.491 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4 2018-10-19T17:20:23.829Z,1539969623.829 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:20:23.840Z,1539969623.840 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-10-19T17:20:23.841Z,1539969623.841 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-10-19T17:20:23.841Z,1539969623.841 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-10-19T17:20:23.842Z,1539969623.842 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-10-19T17:20:23.842Z,1539969623.842 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-10-19T17:20:23.842Z,1539969623.842 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-10-19T17:20:24.245Z,1539969624.245 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:20:24.653Z,1539969624.653 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:20:25.061Z,1539969625.061 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:20:25.120Z,1539969625.120 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-19T17:20:25.120Z,1539969625.120 [BuoyancyServo] No Fault, FailCount= 2 2018-10-19T17:20:25.450Z,1539969625.450 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:20:25.478Z,1539969625.478 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:20:25.595Z,1539969625.595 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-19T17:20:25.945Z,1539969625.945 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:20:26.361Z,1539969626.361 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:20:26.761Z,1539969626.761 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-10-19T17:20:26.761Z,1539969626.761 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-10-19T17:20:26.761Z,1539969626.761 [BuoyancyServo] Communications Fault, FailCount= 3 2018-10-19T17:20:26.761Z,1539969626.761 [BuoyancyServo](ERROR): Communications Fault 2018-10-19T17:20:26.778Z,1539969626.778 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-19T17:20:27.109Z,1539969627.109 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:20:27.170Z,1539969627.170 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-19T17:20:27.171Z,1539969627.171 [BuoyancyServo](INFO): Powering down 2018-10-19T17:20:27.537Z,1539969627.537 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:20:27.949Z,1539969627.949 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:20:27.949Z,1539969627.949 [AHRS_M2](FAULT): Failed to initialize within timeout. 2018-10-19T17:20:27.949Z,1539969627.949 [AHRS_M2] Communications Fault, FailCount= 4 2018-10-19T17:20:27.949Z,1539969627.949 [AHRS_M2](ERROR): Communications Fault 2018-10-19T17:20:28.022Z,1539969628.022 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2018-10-19T17:20:28.037Z,1539969628.037 [AHRS_M2](INFO): Powering down 2018-10-19T17:20:29.262Z,1539969629.262 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-19T17:20:29.263Z,1539969629.263 [BuoyancyServo] No Fault, FailCount= 3 2018-10-19T17:20:29.657Z,1539969629.657 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:20:29.789Z,1539969629.789 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-19T17:20:30.793Z,1539969630.793 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-10-19T17:20:30.793Z,1539969630.793 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-10-19T17:20:30.793Z,1539969630.793 [BuoyancyServo] Communications Fault, FailCount= 4 2018-10-19T17:20:30.793Z,1539969630.793 [BuoyancyServo](ERROR): Communications Fault 2018-10-19T17:20:30.798Z,1539969630.798 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-19T17:20:30.898Z,1539969630.898 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-19T17:20:30.900Z,1539969630.900 [BuoyancyServo](INFO): Powering down 2018-10-19T17:20:31.654Z,1539969631.654 [CBIT](INFO): Clearing failed state for component AHRS_M2 2018-10-19T17:20:31.654Z,1539969631.654 [AHRS_M2] No Fault, FailCount= 4 2018-10-19T17:20:32.029Z,1539969632.029 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2018-10-19T17:20:32.051Z,1539969632.051 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-10-19T17:20:32.051Z,1539969632.051 [Aanderaa_O2] Communications Fault, FailCount= 1 2018-10-19T17:20:32.051Z,1539969632.051 [Aanderaa_O2](ERROR): Communications Fault 2018-10-19T17:20:32.107Z,1539969632.107 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-10-19T17:20:33.273Z,1539969633.273 [NavChartDb](INFO): # of records loaded: 40000 2018-10-19T17:20:47.853Z,1539969647.853 [NavChartDb](INFO): # of records loaded: 45000 2018-10-19T17:20:50.399Z,1539969650.399 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US4CA60M.000 2018-10-19T17:20:51.702Z,1539969651.702 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US4CA60M.000 2018-10-19T17:21:01.199Z,1539969661.199 [NavChartDb](INFO): # of records loaded: 50000 2018-10-19T17:21:02.571Z,1539969662.571 [Aanderaa_O2](INFO): Powering down 2018-10-19T17:21:02.985Z,1539969662.985 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:21:02.985Z,1539969662.985 [AHRS_M2](FAULT): Failed to initialize within timeout. 2018-10-19T17:21:02.985Z,1539969662.985 [AHRS_M2] Communications Fault, FailCount= 5 2018-10-19T17:21:02.985Z,1539969662.985 [AHRS_M2](ERROR): Communications Fault 2018-10-19T17:21:02.986Z,1539969662.986 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2018-10-19T17:21:03.055Z,1539969663.055 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2018-10-19T17:21:03.056Z,1539969663.056 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2 2018-10-19T17:21:03.061Z,1539969663.061 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-19T17:21:03.061Z,1539969663.061 [BuoyancyServo] No Fault, FailCount= 4 2018-10-19T17:21:03.083Z,1539969663.083 [AHRS_M2](INFO): Powering down 2018-10-19T17:21:03.202Z,1539969663.202 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:21:03.326Z,1539969663.326 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-19T17:21:03.329Z,1539969663.329 [CBIT](INFO): Critical error at 20181019T172103 2018-10-19T17:21:03.332Z,1539969663.332 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-10-19T17:21:03.332Z,1539969663.332 [Aanderaa_O2] No Fault, FailCount= 1 2018-10-19T17:21:05.825Z,1539969665.825 [BuoyancyServo](FAULT): Buoyancy initialization uart error:serial timeout 2018-10-19T17:21:05.825Z,1539969665.825 [BuoyancyServo] Communications Fault, FailCount= 5 2018-10-19T17:21:05.825Z,1539969665.825 [BuoyancyServo](ERROR): Communications Fault 2018-10-19T17:21:05.830Z,1539969665.830 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-19T17:21:05.937Z,1539969665.937 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-19T17:21:05.939Z,1539969665.939 [BuoyancyServo](INFO): Powering down 2018-10-19T17:21:07.907Z,1539969667.907 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-19T17:21:07.907Z,1539969667.907 [BuoyancyServo] No Fault, FailCount= 5 2018-10-19T17:21:08.317Z,1539969668.317 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:21:08.438Z,1539969668.438 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-19T17:21:09.433Z,1539969669.433 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-10-19T17:21:09.433Z,1539969669.433 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-10-19T17:21:09.433Z,1539969669.433 [BuoyancyServo] Communications Fault, FailCount= 6 2018-10-19T17:21:09.433Z,1539969669.433 [BuoyancyServo](ERROR): Communications Fault 2018-10-19T17:21:09.438Z,1539969669.438 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-19T17:21:09.538Z,1539969669.538 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-19T17:21:09.538Z,1539969669.538 [BuoyancyServo](INFO): Powering down 2018-10-19T17:21:11.555Z,1539969671.555 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-19T17:21:11.555Z,1539969671.555 [BuoyancyServo] No Fault, FailCount= 6 2018-10-19T17:21:11.958Z,1539969671.958 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:21:12.078Z,1539969672.078 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-19T17:21:13.029Z,1539969673.029 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-10-19T17:21:13.029Z,1539969673.029 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-10-19T17:21:13.029Z,1539969673.029 [BuoyancyServo] Communications Fault, FailCount= 7 2018-10-19T17:21:13.029Z,1539969673.029 [BuoyancyServo](ERROR): Communications Fault 2018-10-19T17:21:13.046Z,1539969673.046 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-19T17:21:13.107Z,1539969673.107 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-19T17:21:13.108Z,1539969673.108 [BuoyancyServo](INFO): Powering down 2018-10-19T17:21:13.875Z,1539969673.875 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-10-19T17:21:13.876Z,1539969673.876 [Aanderaa_O2] Communications Fault, FailCount= 2 2018-10-19T17:21:13.876Z,1539969673.876 [Aanderaa_O2](ERROR): Communications Fault 2018-10-19T17:21:13.923Z,1539969673.923 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-10-19T17:21:19.852Z,1539969679.852 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US4CA60M.000 2018-10-19T17:21:19.938Z,1539969679.938 [NavChartDb](INFO): # of records loaded: 53494 2018-10-19T17:21:19.957Z,1539969679.957 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US4CA60M.000 2018-10-19T17:21:19.958Z,1539969679.958 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US3CA52M.000 2018-10-19T17:21:22.206Z,1539969682.206 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US3CA52M.000 2018-10-19T17:21:31.326Z,1539969691.326 [NavChartDb](INFO): # of records loaded: 5000 2018-10-19T17:21:39.526Z,1539969699.526 [NavChartDb](INFO): # of records loaded: 10000 2018-10-19T17:21:44.421Z,1539969704.421 [Aanderaa_O2](INFO): Powering down 2018-10-19T17:21:44.507Z,1539969704.507 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2018-10-19T17:21:44.595Z,1539969704.595 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-19T17:21:44.595Z,1539969704.595 [BuoyancyServo] No Fault, FailCount= 7 2018-10-19T17:21:44.966Z,1539969704.966 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:21:45.086Z,1539969705.086 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-19T17:21:45.091Z,1539969705.091 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-10-19T17:21:45.092Z,1539969705.092 [Aanderaa_O2] No Fault, FailCount= 2 2018-10-19T17:21:45.785Z,1539969705.785 [NavChartDb](INFO): # of records loaded: 15000 2018-10-19T17:21:52.205Z,1539969712.205 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002685 2018-10-19T17:21:53.326Z,1539969713.326 [BuoyancyServo](FAULT): Buoyancy initialization uart error:serial timeout 2018-10-19T17:21:53.326Z,1539969713.326 [BuoyancyServo] Communications Fault, FailCount= 8 2018-10-19T17:21:53.326Z,1539969713.326 [BuoyancyServo](ERROR): Communications Fault 2018-10-19T17:21:53.331Z,1539969713.331 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-19T17:21:53.460Z,1539969713.460 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-19T17:21:53.469Z,1539969713.469 [BuoyancyServo](INFO): Powering down 2018-10-19T17:21:55.346Z,1539969715.346 [NavChartDb](INFO): # of records loaded: 20000 2018-10-19T17:21:55.412Z,1539969715.412 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-10-19T17:21:55.412Z,1539969715.412 [Aanderaa_O2] Communications Fault, FailCount= 3 2018-10-19T17:21:55.412Z,1539969715.412 [Aanderaa_O2](ERROR): Communications Fault 2018-10-19T17:21:55.438Z,1539969715.438 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-10-19T17:21:55.439Z,1539969715.439 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2018-10-19T17:21:55.439Z,1539969715.439 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-19T17:21:55.439Z,1539969715.439 [BuoyancyServo] No Fault, FailCount= 8 2018-10-19T17:22:01.380Z,1539969721.380 [NavChartDb](INFO): # of records loaded: 25000 2018-10-19T17:22:07.315Z,1539969727.315 [NavChartDb](INFO): # of records loaded: 30000 2018-10-19T17:22:13.209Z,1539969733.209 [NavChartDb](INFO): # of records loaded: 35000 2018-10-19T17:22:19.121Z,1539969739.121 [NavChartDb](INFO): # of records loaded: 40000 2018-10-19T17:22:25.012Z,1539969745.012 [NavChartDb](INFO): # of records loaded: 45000 2018-10-19T17:22:25.929Z,1539969745.929 [Aanderaa_O2](INFO): Powering down 2018-10-19T17:22:25.937Z,1539969745.937 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-10-19T17:22:25.937Z,1539969745.937 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2018-10-19T17:22:25.937Z,1539969745.937 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-10-19T17:22:25.939Z,1539969745.939 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-10-19T17:22:25.939Z,1539969745.939 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5 2018-10-19T17:22:25.939Z,1539969745.939 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-10-19T17:22:25.952Z,1539969745.952 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-19T17:22:26.070Z,1539969746.070 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-19T17:22:26.075Z,1539969746.075 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-10-19T17:22:26.076Z,1539969746.076 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-10-19T17:22:26.185Z,1539969746.185 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-10-19T17:22:26.186Z,1539969746.186 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2018-10-19T17:22:26.186Z,1539969746.186 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-10-19T17:22:26.186Z,1539969746.186 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5 2018-10-19T17:22:26.512Z,1539969746.512 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-10-19T17:22:26.513Z,1539969746.513 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-10-19T17:22:26.513Z,1539969746.513 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-10-19T17:22:26.514Z,1539969746.514 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-10-19T17:22:26.514Z,1539969746.514 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-10-19T17:22:26.514Z,1539969746.514 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-10-19T17:22:34.499Z,1539969754.499 [NavChartDb](INFO): # of records loaded: 50000 2018-10-19T17:22:41.938Z,1539969761.938 [NavChartDb](INFO): # of records loaded: 55000 2018-10-19T17:22:49.488Z,1539969769.488 [NavChartDb](INFO): # of records loaded: 60000 2018-10-19T17:22:56.821Z,1539969776.821 [NavChartDb](INFO): # of records loaded: 65000 2018-10-19T17:23:05.445Z,1539969785.445 [NavChartDb](INFO): # of records loaded: 70000 2018-10-19T17:23:13.900Z,1539969793.900 [NavChartDb](INFO): # of records loaded: 75000 2018-10-19T17:23:21.278Z,1539969801.278 [NavChartDb](INFO): # of records loaded: 80000 2018-10-19T17:23:28.840Z,1539969808.840 [NavChartDb](INFO): # of records loaded: 85000 2018-10-19T17:23:32.202Z,1539969812.202 [NAL9602](FAULT): GPS failed to acquire within timeout. 2018-10-19T17:23:32.202Z,1539969812.202 [NAL9602] Data Fault, FailCount= 1 2018-10-19T17:23:32.202Z,1539969812.202 [NAL9602](ERROR): Data Fault 2018-10-19T17:23:32.254Z,1539969812.254 [CBIT](ERROR): Data Fault in component: NAL9602 2018-10-19T17:23:32.602Z,1539969812.602 [NAL9602](INFO): Powering down 2018-10-19T17:23:33.458Z,1539969813.458 [CBIT](INFO): Clearing failed state for component NAL9602 2018-10-19T17:23:33.458Z,1539969813.458 [NAL9602] No Fault, FailCount= 1 2018-10-19T17:23:36.300Z,1539969816.300 [NavChartDb](INFO): # of records loaded: 90000 2018-10-19T17:23:43.118Z,1539969823.118 [CBIT](INFO): Clearing failed state for component BPC1 2018-10-19T17:23:43.118Z,1539969823.118 [BPC1] No Fault, FailCount= 1 2018-10-19T17:23:46.047Z,1539969826.047 [NavChartDb](INFO): # of records loaded: 95000 2018-10-19T17:23:54.090Z,1539969834.090 [NavChartDb](INFO): # of records loaded: 100000 2018-10-19T17:24:01.691Z,1539969841.691 [NavChartDb](INFO): # of records loaded: 105000 2018-10-19T17:24:02.646Z,1539969842.646 [NAL9602](INFO): Powering up NAL9602 2018-10-19T17:24:10.123Z,1539969850.123 [NavChartDb](INFO): # of records loaded: 110000 2018-10-19T17:24:18.126Z,1539969858.126 [NAL9602](INFO): NAL9602 initialized 2018-10-19T17:24:18.491Z,1539969858.491 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US3CA52M.000 2018-10-19T17:24:19.459Z,1539969859.459 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US3CA52M.000 2018-10-19T17:24:22.059Z,1539969862.059 [NavChartDb](INFO): # of records loaded: 115000 2018-10-19T17:24:25.807Z,1539969865.807 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-10-19T17:24:25.807Z,1539969865.807 [Aanderaa_O2] No Fault, FailCount= 3 2018-10-19T17:24:26.557Z,1539969866.557 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-10-19T17:24:26.557Z,1539969866.557 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2018-10-19T17:24:26.557Z,1539969866.557 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-10-19T17:24:26.565Z,1539969866.565 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-10-19T17:24:26.565Z,1539969866.565 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6 2018-10-19T17:24:26.565Z,1539969866.565 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-10-19T17:24:26.611Z,1539969866.611 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-10-19T17:24:26.611Z,1539969866.611 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-10-19T17:24:27.004Z,1539969867.004 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-10-19T17:24:27.004Z,1539969867.004 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2018-10-19T17:24:27.004Z,1539969867.004 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-10-19T17:24:27.009Z,1539969867.009 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6 2018-10-19T17:24:27.357Z,1539969867.357 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-10-19T17:24:27.358Z,1539969867.358 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-10-19T17:24:27.358Z,1539969867.358 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-10-19T17:24:27.359Z,1539969867.359 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-10-19T17:24:27.360Z,1539969867.360 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-10-19T17:24:27.360Z,1539969867.360 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-10-19T17:24:29.852Z,1539969869.852 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US3CA52M.000 2018-10-19T17:24:30.058Z,1539969870.058 [NavChartDb](INFO): # of records loaded: 117290 2018-10-19T17:24:30.062Z,1539969870.062 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US3CA52M.000 2018-10-19T17:24:30.063Z,1539969870.063 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US2WC11M.000 2018-10-19T17:24:31.877Z,1539969871.877 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US2WC11M.000 2018-10-19T17:24:36.527Z,1539969876.527 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-10-19T17:24:36.527Z,1539969876.527 [Aanderaa_O2] Communications Fault, FailCount= 1 2018-10-19T17:24:36.527Z,1539969876.527 [Aanderaa_O2](ERROR): Communications Fault 2018-10-19T17:24:36.575Z,1539969876.575 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-10-19T17:24:39.197Z,1539969879.197 [NavChartDb](INFO): # of records loaded: 5000 2018-10-19T17:24:45.108Z,1539969885.108 [NavChartDb](INFO): # of records loaded: 10000 2018-10-19T17:24:51.158Z,1539969891.158 [NavChartDb](INFO): # of records loaded: 15000 2018-10-19T17:24:57.415Z,1539969897.415 [NavChartDb](INFO): # of records loaded: 20000 2018-10-19T17:25:04.452Z,1539969904.452 [NavChartDb](INFO): # of records loaded: 25000 2018-10-19T17:25:07.053Z,1539969907.053 [Aanderaa_O2](INFO): Powering down 2018-10-19T17:25:07.619Z,1539969907.619 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-10-19T17:25:07.619Z,1539969907.619 [Aanderaa_O2] No Fault, FailCount= 1 2018-10-19T17:25:14.679Z,1539969914.679 [NavChartDb](INFO): # of records loaded: 30000 2018-10-19T17:25:19.496Z,1539969919.496 [BPC1](ERROR): BPC1A: No match for serial number 0226 in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2018-10-19T17:25:19.922Z,1539969919.922 [BPC1](ERROR): BPC1B: No match for serial number 0273 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2018-10-19T17:25:19.922Z,1539969919.922 [BPC1](FAULT): Failed to parse data from all battery packs. 2018-10-19T17:25:19.922Z,1539969919.922 [BPC1] Data Fault, FailCount= 2 2018-10-19T17:25:19.922Z,1539969919.922 [BPC1](ERROR): Data Fault 2018-10-19T17:25:19.942Z,1539969919.942 [CBIT](ERROR): Data Fault in component: BPC1 2018-10-19T17:25:23.114Z,1539969923.114 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2018-10-19T17:25:23.114Z,1539969923.114 [CTD_Seabird] No Fault, FailCount= 5 2018-10-19T17:25:23.349Z,1539969923.349 [CTD_Seabird](INFO): Initializing 2018-10-19T17:25:23.349Z,1539969923.349 [CTD_Seabird](INFO): Checking LCM 2018-10-19T17:25:23.349Z,1539969923.349 [CTD_Seabird](INFO): LCM OK 2018-10-19T17:25:23.349Z,1539969923.349 [CTD_Seabird](INFO): Powering up 2018-10-19T17:25:23.496Z,1539969923.496 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-10-19T17:25:23.496Z,1539969923.496 [Aanderaa_O2] Communications Fault, FailCount= 2 2018-10-19T17:25:23.496Z,1539969923.496 [Aanderaa_O2](ERROR): Communications Fault 2018-10-19T17:25:23.518Z,1539969923.518 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-10-19T17:25:24.072Z,1539969924.072 [NavChartDb](INFO): # of records loaded: 35000 2018-10-19T17:25:28.748Z,1539969928.748 [Aanderaa_O2](INFO): Powering down 2018-10-19T17:25:28.749Z,1539969928.749 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-10-19T17:25:28.920Z,1539969928.920 [CTD_Seabird](INFO): Started Seabird LCM interface with command:nohup ./lrauv-framework/onboard/bin/gpctd -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyC6 -b 9600 >& /dev/null & 2018-10-19T17:25:28.921Z,1539969928.921 [CTD_Seabird](INFO): LCM subscribed to channel:seabird_gpctd_t.seabird-gpctd 2018-10-19T17:25:29.291Z,1539969929.291 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-10-19T17:25:29.291Z,1539969929.291 [Aanderaa_O2] No Fault, FailCount= 2 2018-10-19T17:25:31.964Z,1539969931.964 [NavChartDb](INFO): # of records loaded: 40000 2018-10-19T17:25:33.873Z,1539969933.873 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US2WC11M.000 2018-10-19T17:25:34.579Z,1539969934.579 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US2WC11M.000 2018-10-19T17:25:39.221Z,1539969939.221 [CommandLine](IMPORTANT): got command get depth 2018-10-19T17:25:39.222Z,1539969939.222 [CommandLine](IMPORTANT): depth 25.542910 m 2018-10-19T17:25:40.083Z,1539969940.083 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-10-19T17:25:40.083Z,1539969940.083 [Aanderaa_O2] Communications Fault, FailCount= 3 2018-10-19T17:25:40.083Z,1539969940.083 [Aanderaa_O2](ERROR): Communications Fault 2018-10-19T17:25:40.143Z,1539969940.143 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-10-19T17:25:40.143Z,1539969940.143 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2018-10-19T17:25:43.298Z,1539969943.298 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US2WC11M.000 2018-10-19T17:25:43.428Z,1539969943.428 [NavChartDb](INFO): # of records loaded: 44880 2018-10-19T17:25:43.433Z,1539969943.433 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US2WC11M.000 2018-10-19T17:25:43.434Z,1539969943.434 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US1WC07M.000 2018-10-19T17:25:46.763Z,1539969946.763 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US1WC07M.000 2018-10-19T17:25:55.526Z,1539969955.526 [CommandLine](IMPORTANT): got command show best depth 2018-10-19T17:25:55.526Z,1539969955.526 [CommandLine](IMPORTANT): depth best is Depth_Keller.depth 2018-10-19T17:25:56.001Z,1539969956.001 [NavChartDb](INFO): # of records loaded: 5000 2018-10-19T17:25:58.405Z,1539969958.405 [CTD_Seabird](FAULT): Did not receive valid device response within the specified allowable sample time. 2018-10-19T17:25:58.405Z,1539969958.405 [CTD_Seabird] Communications Fault, FailCount= 1 2018-10-19T17:25:58.405Z,1539969958.405 [CTD_Seabird](ERROR): Communications Fault 2018-10-19T17:25:58.944Z,1539969958.944 [Aanderaa_O2](INFO): Powering down 2018-10-19T17:25:58.945Z,1539969958.945 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-10-19T17:25:58.945Z,1539969958.945 [CTD_Seabird](INFO): Powering down 2018-10-19T17:25:59.002Z,1539969959.002 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2018-10-19T17:26:03.605Z,1539969963.605 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB0 2018-10-19T17:26:05.345Z,1539969965.345 [CBIT](INFO): Clearing failed state for component AHRS_M2 2018-10-19T17:26:05.345Z,1539969965.345 [AHRS_M2] No Fault, FailCount= 5 2018-10-19T17:26:05.347Z,1539969965.347 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2018-10-19T17:26:05.347Z,1539969965.347 [CTD_Seabird] No Fault, FailCount= 1 2018-10-19T17:26:05.362Z,1539969965.362 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2018-10-19T17:26:05.409Z,1539969965.409 [CTD_Seabird](INFO): Initializing 2018-10-19T17:26:05.409Z,1539969965.409 [CTD_Seabird](INFO): Checking LCM 2018-10-19T17:26:05.409Z,1539969965.409 [CTD_Seabird](INFO): LCM OK 2018-10-19T17:26:05.410Z,1539969965.410 [CTD_Seabird](INFO): Powering up 2018-10-19T17:26:06.679Z,1539969966.679 [NavChartDb](INFO): # of records loaded: 10000 2018-10-19T17:26:08.869Z,1539969968.869 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:09.293Z,1539969969.293 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:09.721Z,1539969969.721 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:10.137Z,1539969970.137 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:10.557Z,1539969970.557 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:10.847Z,1539969970.847 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-10-19T17:26:10.927Z,1539969970.927 [CTD_Seabird](INFO): Started Seabird LCM interface with command:nohup ./lrauv-framework/onboard/bin/gpctd -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyC6 -b 9600 >& /dev/null & 2018-10-19T17:26:10.929Z,1539969970.929 [CTD_Seabird](INFO): LCM subscribed to channel:seabird_gpctd_t.seabird-gpctd 2018-10-19T17:26:10.986Z,1539969970.986 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:11.421Z,1539969971.421 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:11.877Z,1539969971.877 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:12.298Z,1539969972.298 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:12.362Z,1539969972.362 [CommandLine](IMPORTANT): got command ! echo i > /dev/loadB0 2018-10-19T17:26:12.801Z,1539969972.801 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:13.233Z,1539969973.233 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:13.238Z,1539969973.238 [Depth_Keller](ERROR): Pressure reading out of range: -137.665207 decibar 2018-10-19T17:26:13.653Z,1539969973.653 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:14.033Z,1539969974.033 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:14.258Z,1539969974.258 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB0 2018-10-19T17:26:14.457Z,1539969974.457 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:14.890Z,1539969974.890 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:15.289Z,1539969975.289 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:15.705Z,1539969975.705 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:15.705Z,1539969975.705 [AHRS_M2](FAULT): Failed to initialize within timeout. 2018-10-19T17:26:15.705Z,1539969975.705 [AHRS_M2] Communications Fault, FailCount= 1 2018-10-19T17:26:15.705Z,1539969975.705 [AHRS_M2](ERROR): Communications Fault 2018-10-19T17:26:15.741Z,1539969975.741 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2018-10-19T17:26:15.797Z,1539969975.797 [AHRS_M2](INFO): Powering down 2018-10-19T17:26:16.993Z,1539969976.993 [NavChartDb](INFO): # of records loaded: 15000 2018-10-19T17:26:18.309Z,1539969978.309 [CommandLine](IMPORTANT): got command get depth 2018-10-19T17:26:18.310Z,1539969978.310 [CommandLine](IMPORTANT): depth 25.543772 m 2018-10-19T17:26:19.407Z,1539969979.407 [CBIT](INFO): Clearing failed state for component AHRS_M2 2018-10-19T17:26:19.407Z,1539969979.407 [AHRS_M2] No Fault, FailCount= 1 2018-10-19T17:26:19.781Z,1539969979.781 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2018-10-19T17:26:22.511Z,1539969982.511 [CommandLine](IMPORTANT): got command report touch depth 2018-10-19T17:26:22.632Z,1539969982.632 [Reporter](INFO): depth 25.536442 m 2018-10-19T17:26:23.301Z,1539969983.301 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:23.384Z,1539969983.384 [Reporter](INFO): depth 25.538597 m 2018-10-19T17:26:23.717Z,1539969983.717 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:23.762Z,1539969983.762 [Radio_Surface](INFO): Powering down 2018-10-19T17:26:23.805Z,1539969983.805 [Reporter](INFO): depth 25.536873 m 2018-10-19T17:26:24.137Z,1539969984.137 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:24.200Z,1539969984.200 [Reporter](INFO): depth 25.545496 m 2018-10-19T17:26:24.557Z,1539969984.557 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:24.628Z,1539969984.628 [Reporter](INFO): depth 25.541185 m 2018-10-19T17:26:24.973Z,1539969984.973 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:25.041Z,1539969985.041 [Reporter](INFO): depth 25.533424 m 2018-10-19T17:26:25.385Z,1539969985.385 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:25.428Z,1539969985.428 [Reporter](INFO): depth 25.549376 m 2018-10-19T17:26:25.793Z,1539969985.793 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:25.822Z,1539969985.822 [Reporter](INFO): depth 25.539461 m 2018-10-19T17:26:26.193Z,1539969986.193 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:26.273Z,1539969986.273 [Reporter](INFO): depth 25.548515 m 2018-10-19T17:26:26.621Z,1539969986.621 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:26.690Z,1539969986.690 [Reporter](INFO): depth 25.537304 m 2018-10-19T17:26:27.057Z,1539969987.057 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:27.132Z,1539969987.132 [Reporter](INFO): depth 25.539028 m 2018-10-19T17:26:27.477Z,1539969987.477 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:27.485Z,1539969987.485 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-10-19T17:26:27.485Z,1539969987.485 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2018-10-19T17:26:27.485Z,1539969987.485 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-10-19T17:26:27.487Z,1539969987.487 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-10-19T17:26:27.487Z,1539969987.487 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7 2018-10-19T17:26:27.487Z,1539969987.487 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-10-19T17:26:27.500Z,1539969987.500 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-10-19T17:26:27.500Z,1539969987.500 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-10-19T17:26:27.543Z,1539969987.543 [Reporter](INFO): depth 25.545065 m 2018-10-19T17:26:27.881Z,1539969987.881 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:27.945Z,1539969987.945 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-10-19T17:26:27.945Z,1539969987.945 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2018-10-19T17:26:27.946Z,1539969987.946 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-10-19T17:26:27.946Z,1539969987.946 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7 2018-10-19T17:26:27.958Z,1539969987.958 [Reporter](INFO): depth 25.535149 m 2018-10-19T17:26:28.190Z,1539969988.190 [NavChartDb](INFO): # of records loaded: 20000 2018-10-19T17:26:28.297Z,1539969988.297 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:28.343Z,1539969988.343 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-10-19T17:26:28.343Z,1539969988.343 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-10-19T17:26:28.344Z,1539969988.344 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-10-19T17:26:28.344Z,1539969988.344 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-10-19T17:26:28.349Z,1539969988.349 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-10-19T17:26:28.349Z,1539969988.349 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-10-19T17:26:28.367Z,1539969988.367 [Reporter](INFO): depth 25.548515 m 2018-10-19T17:26:28.721Z,1539969988.721 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:28.768Z,1539969988.768 [Reporter](INFO): depth 25.529114 m 2018-10-19T17:26:29.109Z,1539969989.109 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:29.176Z,1539969989.176 [Reporter](INFO): depth 25.548515 m 2018-10-19T17:26:29.533Z,1539969989.533 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:29.618Z,1539969989.618 [Reporter](INFO): depth 25.528250 m 2018-10-19T17:26:29.822Z,1539969989.822 [Radio_Surface](INFO): Powering up 2018-10-19T17:26:29.953Z,1539969989.953 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:29.953Z,1539969989.953 [AHRS_M2](FAULT): Failed to initialize within timeout. 2018-10-19T17:26:29.953Z,1539969989.953 [AHRS_M2] Communications Fault, FailCount= 2 2018-10-19T17:26:29.953Z,1539969989.953 [AHRS_M2](ERROR): Communications Fault 2018-10-19T17:26:30.025Z,1539969990.025 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2018-10-19T17:26:30.031Z,1539969990.031 [Reporter](INFO): depth 25.546358 m 2018-10-19T17:26:30.047Z,1539969990.047 [AHRS_M2](INFO): Powering down 2018-10-19T17:26:30.149Z,1539969990.149 [Reporter](INFO): depth 25.529114 m 2018-10-19T17:26:30.493Z,1539969990.493 [Reporter](INFO): depth 25.551100 m 2018-10-19T17:26:30.692Z,1539969990.692 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US1WC07M.000 2018-10-19T17:26:30.903Z,1539969990.903 [Reporter](INFO): depth 25.541185 m 2018-10-19T17:26:31.272Z,1539969991.272 [Reporter](INFO): depth 25.543772 m 2018-10-19T17:26:31.692Z,1539969991.692 [Reporter](INFO): depth 25.548515 m 2018-10-19T17:26:32.103Z,1539969992.103 [Reporter](INFO): depth 25.542479 m 2018-10-19T17:26:32.188Z,1539969992.188 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US1WC07M.000 2018-10-19T17:26:32.513Z,1539969992.513 [Reporter](INFO): depth 25.545065 m 2018-10-19T17:26:32.909Z,1539969992.909 [Reporter](INFO): depth 25.540752 m 2018-10-19T17:26:33.159Z,1539969993.159 [CommandLine](IMPORTANT): got command report clear 2018-10-19T17:26:33.668Z,1539969993.668 [CBIT](INFO): Clearing failed state for component AHRS_M2 2018-10-19T17:26:33.668Z,1539969993.668 [AHRS_M2] No Fault, FailCount= 2 2018-10-19T17:26:34.040Z,1539969994.040 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2018-10-19T17:26:35.398Z,1539969995.398 [CommandLine](IMPORTANT): got command show variable depth_keller 2018-10-19T17:26:35.499Z,1539969995.499 [CommandLine](IMPORTANT): Depth_Keller.loadAtStartup (bool) 2018-10-19T17:26:35.499Z,1539969995.499 [CommandLine](IMPORTANT): Depth_Keller.simulateHardware (bool) 2018-10-19T17:26:35.500Z,1539969995.500 [CommandLine](IMPORTANT): Depth_Keller.maxPressBound (decibar) 2018-10-19T17:26:35.500Z,1539969995.500 [CommandLine](IMPORTANT): Depth_Keller.minPressBound (decibar) 2018-10-19T17:26:35.503Z,1539969995.503 [CommandLine](IMPORTANT): Depth_Keller.offset (decibar) 2018-10-19T17:26:35.504Z,1539969995.504 [CommandLine](IMPORTANT): Depth_Keller.power (watt) 2018-10-19T17:26:35.504Z,1539969995.504 [CommandLine](IMPORTANT): Depth_Keller.scale (micropascal) 2018-10-19T17:26:35.521Z,1539969995.521 [CommandLine](IMPORTANT): Depth_Keller.loadControl (none) 2018-10-19T17:26:35.522Z,1539969995.522 [CommandLine](IMPORTANT): Depth_Keller.ad (none) 2018-10-19T17:26:35.522Z,1539969995.522 [CommandLine](IMPORTANT): Depth_Keller.adRes (bit) 2018-10-19T17:26:35.523Z,1539969995.523 [CommandLine](IMPORTANT): Depth_Keller.adTimeout (millisecond) 2018-10-19T17:26:35.523Z,1539969995.523 [CommandLine](IMPORTANT): Depth_Keller.adVref (volt) 2018-10-19T17:26:35.623Z,1539969995.623 [CommandLine](IMPORTANT): Depth_Keller.depth (meter) 2018-10-19T17:26:35.624Z,1539969995.624 [CommandLine](IMPORTANT): Depth_Keller.sea_water_pressure (decibar) 2018-10-19T17:26:35.779Z,1539969995.779 [CommandLine](IMPORTANT): Depth_Keller.durationOfLastRun (second) 2018-10-19T17:26:37.565Z,1539969997.565 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:38.001Z,1539969998.001 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:38.421Z,1539969998.421 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:38.813Z,1539969998.813 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:39.225Z,1539969999.225 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:39.633Z,1539969999.633 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:40.041Z,1539970000.041 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:40.417Z,1539970000.417 [CTD_Seabird](FAULT): Did not receive valid device response within the specified allowable sample time. 2018-10-19T17:26:40.417Z,1539970000.417 [CTD_Seabird] Communications Fault, FailCount= 2 2018-10-19T17:26:40.417Z,1539970000.417 [CTD_Seabird](ERROR): Communications Fault 2018-10-19T17:26:40.445Z,1539970000.445 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:40.501Z,1539970000.501 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2018-10-19T17:26:40.845Z,1539970000.845 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:41.045Z,1539970001.045 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-10-19T17:26:41.045Z,1539970001.045 [CTD_Seabird](INFO): Powering down 2018-10-19T17:26:41.317Z,1539970001.317 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:41.741Z,1539970001.741 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:42.145Z,1539970002.145 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:42.565Z,1539970002.565 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:42.636Z,1539970002.636 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2018-10-19T17:26:42.636Z,1539970002.636 [CTD_Seabird] No Fault, FailCount= 2 2018-10-19T17:26:42.665Z,1539970002.665 [CTD_Seabird](INFO): Initializing 2018-10-19T17:26:42.665Z,1539970002.665 [CTD_Seabird](INFO): Checking LCM 2018-10-19T17:26:42.665Z,1539970002.665 [CTD_Seabird](INFO): LCM OK 2018-10-19T17:26:42.665Z,1539970002.665 [CTD_Seabird](INFO): Powering up 2018-10-19T17:26:43.009Z,1539970003.009 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:43.187Z,1539970003.187 [CommandLine](IMPORTANT): got command get Depth_Keller.offset 2018-10-19T17:26:43.187Z,1539970003.187 [CommandLine](IMPORTANT): Depth_Keller.offset 5.000000 db 2018-10-19T17:26:43.433Z,1539970003.433 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:43.849Z,1539970003.849 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:44.265Z,1539970004.265 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:44.265Z,1539970004.265 [AHRS_M2](FAULT): Failed to initialize within timeout. 2018-10-19T17:26:44.265Z,1539970004.265 [AHRS_M2] Communications Fault, FailCount= 3 2018-10-19T17:26:44.265Z,1539970004.265 [AHRS_M2](ERROR): Communications Fault 2018-10-19T17:26:44.344Z,1539970004.344 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2018-10-19T17:26:44.352Z,1539970004.352 [AHRS_M2](INFO): Powering down 2018-10-19T17:26:48.069Z,1539970008.069 [CBIT](INFO): Clearing failed state for component AHRS_M2 2018-10-19T17:26:48.069Z,1539970008.069 [AHRS_M2] No Fault, FailCount= 3 2018-10-19T17:26:48.239Z,1539970008.239 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-10-19T17:26:48.328Z,1539970008.328 [CTD_Seabird](INFO): Started Seabird LCM interface with command:nohup ./lrauv-framework/onboard/bin/gpctd -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyC6 -b 9600 >& /dev/null & 2018-10-19T17:26:48.329Z,1539970008.329 [CTD_Seabird](INFO): LCM subscribed to channel:seabird_gpctd_t.seabird-gpctd 2018-10-19T17:26:48.362Z,1539970008.362 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2018-10-19T17:26:51.885Z,1539970011.885 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:52.289Z,1539970012.289 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:52.701Z,1539970012.701 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:53.105Z,1539970013.105 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:53.513Z,1539970013.513 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:53.921Z,1539970013.921 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:54.333Z,1539970014.333 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:54.452Z,1539970014.452 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US1WC07M.000 2018-10-19T17:26:54.745Z,1539970014.745 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:55.054Z,1539970015.054 [NavChartDb](INFO): # of records loaded: 24424 2018-10-19T17:26:55.065Z,1539970015.065 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US1WC07M.000 2018-10-19T17:26:55.149Z,1539970015.149 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:55.573Z,1539970015.573 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:55.981Z,1539970015.981 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:56.405Z,1539970016.405 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:56.838Z,1539970016.838 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:57.245Z,1539970017.245 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:57.661Z,1539970017.661 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:58.073Z,1539970018.073 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:58.477Z,1539970018.477 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:26:58.477Z,1539970018.477 [AHRS_M2](FAULT): Failed to initialize within timeout. 2018-10-19T17:26:58.477Z,1539970018.477 [AHRS_M2] Communications Fault, FailCount= 4 2018-10-19T17:26:58.477Z,1539970018.477 [AHRS_M2](ERROR): Communications Fault 2018-10-19T17:26:58.550Z,1539970018.550 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2018-10-19T17:26:58.569Z,1539970018.569 [AHRS_M2](INFO): Powering down 2018-10-19T17:26:58.746Z,1539970018.746 [NavChartDb](INFO): Creating index for soundings 2018-10-19T17:27:02.206Z,1539970022.206 [CBIT](INFO): Clearing failed state for component AHRS_M2 2018-10-19T17:27:02.206Z,1539970022.206 [AHRS_M2] No Fault, FailCount= 4 2018-10-19T17:27:02.561Z,1539970022.561 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2018-10-19T17:27:03.811Z,1539970023.811 [CommandLine](IMPORTANT): got command show variable depth_keller 2018-10-19T17:27:03.856Z,1539970023.856 [CommandLine](IMPORTANT): Depth_Keller.loadAtStartup (bool) 2018-10-19T17:27:03.869Z,1539970023.869 [CommandLine](IMPORTANT): Depth_Keller.simulateHardware (bool) 2018-10-19T17:27:03.869Z,1539970023.869 [CommandLine](IMPORTANT): Depth_Keller.maxPressBound (decibar) 2018-10-19T17:27:03.870Z,1539970023.870 [CommandLine](IMPORTANT): Depth_Keller.minPressBound (decibar) 2018-10-19T17:27:03.870Z,1539970023.870 [CommandLine](IMPORTANT): Depth_Keller.offset (decibar) 2018-10-19T17:27:03.871Z,1539970023.871 [CommandLine](IMPORTANT): Depth_Keller.power (watt) 2018-10-19T17:27:03.871Z,1539970023.871 [CommandLine](IMPORTANT): Depth_Keller.scale (micropascal) 2018-10-19T17:27:03.994Z,1539970023.994 [CommandLine](IMPORTANT): Depth_Keller.loadControl (none) 2018-10-19T17:27:04.005Z,1539970024.005 [CommandLine](IMPORTANT): Depth_Keller.ad (none) 2018-10-19T17:27:04.005Z,1539970024.005 [CommandLine](IMPORTANT): Depth_Keller.adRes (bit) 2018-10-19T17:27:04.006Z,1539970024.006 [CommandLine](IMPORTANT): Depth_Keller.adTimeout (millisecond) 2018-10-19T17:27:04.006Z,1539970024.006 [CommandLine](IMPORTANT): Depth_Keller.adVref (volt) 2018-10-19T17:27:04.166Z,1539970024.166 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2018-10-19T17:27:04.208Z,1539970024.208 [CommandLine](IMPORTANT): Depth_Keller.depth (meter) 2018-10-19T17:27:04.211Z,1539970024.211 [CommandLine](IMPORTANT): Depth_Keller.sea_water_pressure (decibar) 2018-10-19T17:27:04.333Z,1539970024.333 [CommandLine](IMPORTANT): Depth_Keller.durationOfLastRun (second) 2018-10-19T17:27:06.085Z,1539970026.085 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:27:06.521Z,1539970026.521 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:27:06.522Z,1539970026.522 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.361191 2018-10-19T17:27:06.933Z,1539970026.933 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:27:07.341Z,1539970027.341 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:27:07.757Z,1539970027.757 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:27:08.165Z,1539970028.165 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:27:08.399Z,1539970028.399 [NavChartDb](INFO): Creating index for 0p0 2018-10-19T17:27:08.589Z,1539970028.589 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:27:09.005Z,1539970029.005 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:27:09.421Z,1539970029.421 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:27:09.829Z,1539970029.829 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:27:10.245Z,1539970030.245 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:27:10.673Z,1539970030.673 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:27:11.081Z,1539970031.081 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:27:11.477Z,1539970031.477 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:27:11.897Z,1539970031.897 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:27:12.302Z,1539970032.302 [NavChartDb](INFO): Creating index for 1p8 2018-10-19T17:27:12.331Z,1539970032.331 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:27:12.741Z,1539970032.741 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-10-19T17:27:12.741Z,1539970032.741 [AHRS_M2](FAULT): Failed to initialize within timeout. 2018-10-19T17:27:12.741Z,1539970032.741 [AHRS_M2] Communications Fault, FailCount= 5 2018-10-19T17:27:12.741Z,1539970032.741 [AHRS_M2](ERROR): Communications Fault 2018-10-19T17:27:12.770Z,1539970032.770 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2018-10-19T17:27:12.770Z,1539970032.770 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2 2018-10-19T17:27:12.822Z,1539970032.822 [AHRS_M2](INFO): Powering down 2018-10-19T17:27:12.940Z,1539970032.940 [CBIT](INFO): Critical error at 20181019T172712 2018-10-19T17:27:14.150Z,1539970034.150 [NavChartDb](INFO): Creating index for 3p6 2018-10-19T17:27:17.411Z,1539970037.411 [NavChartDb](INFO): Creating index for 5p4 2018-10-19T17:27:17.781Z,1539970037.781 [CTD_Seabird](FAULT): Did not receive valid device response within the specified allowable sample time. 2018-10-19T17:27:17.781Z,1539970037.781 [CTD_Seabird] Communications Fault, FailCount= 3 2018-10-19T17:27:17.781Z,1539970037.781 [CTD_Seabird](ERROR): Communications Fault 2018-10-19T17:27:18.070Z,1539970038.070 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2018-10-19T17:27:18.323Z,1539970038.323 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-10-19T17:27:18.324Z,1539970038.324 [CTD_Seabird](INFO): Powering down 2018-10-19T17:27:18.458Z,1539970038.458 [CBIT](INFO): Clearing failed state for component Onboard 2018-10-19T17:27:18.458Z,1539970038.458 [Onboard] No Fault, FailCount= 1 2018-10-19T17:27:19.234Z,1539970039.234 [Onboard](ERROR): I2C read error. Can't read 1 bytes. 2018-10-19T17:27:19.234Z,1539970039.234 [Onboard](FAULT): Can't read temperature LSB. 2018-10-19T17:27:19.234Z,1539970039.234 [Onboard] Hardware Fault, FailCount= 1 2018-10-19T17:27:19.234Z,1539970039.234 [Onboard](ERROR): Hardware Fault 2018-10-19T17:27:19.235Z,1539970039.235 [Onboard](ERROR): I2C read error. Can't read 1 bytes. 2018-10-19T17:27:19.235Z,1539970039.235 [Onboard](FAULT): Can't read temperature MSB. 2018-10-19T17:27:19.236Z,1539970039.236 [Onboard](ERROR): I2C read error. Can't read 1 bytes. 2018-10-19T17:27:19.236Z,1539970039.236 [Onboard](FAULT): Can't read pressure LSB. 2018-10-19T17:27:19.236Z,1539970039.236 [Onboard](ERROR): I2C read error. Can't read 1 bytes. 2018-10-19T17:27:19.237Z,1539970039.237 [Onboard](FAULT): Can't read pressure MSB. 2018-10-19T17:27:19.271Z,1539970039.271 [CBIT](INFO): Clearing failed state for component DropWeight 2018-10-19T17:27:19.271Z,1539970039.271 [DropWeight] No Fault, FailCount= 1 2018-10-19T17:27:19.271Z,1539970039.271 [CBIT](ERROR): Hardware Fault in component: Onboard 2018-10-19T17:27:19.272Z,1539970039.272 [CBIT](CRITICAL): Hardware Fault in component: Onboard 2018-10-19T17:27:19.674Z,1539970039.674 [CBIT](INFO): Critical error at 20181019T172719 2018-10-19T17:27:19.681Z,1539970039.681 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2018-10-19T17:27:19.681Z,1539970039.681 [CTD_Seabird] No Fault, FailCount= 3 2018-10-19T17:27:19.949Z,1539970039.949 [CTD_Seabird](INFO): Initializing 2018-10-19T17:27:19.949Z,1539970039.949 [CTD_Seabird](INFO): Checking LCM 2018-10-19T17:27:19.949Z,1539970039.949 [CTD_Seabird](INFO): LCM OK 2018-10-19T17:27:19.949Z,1539970039.949 [CTD_Seabird](INFO): Powering up 2018-10-19T17:27:20.679Z,1539970040.679 [NavChartDb](INFO): Creating index for 9p1 2018-10-19T17:27:21.681Z,1539970041.681 [NavChartDb](INFO): Creating index for 10p9 2018-10-19T17:27:23.886Z,1539970043.886 [NavChartDb](INFO): Creating index for 18p2 2018-10-19T17:27:25.418Z,1539970045.418 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-10-19T17:27:25.519Z,1539970045.519 [CTD_Seabird](INFO): Started Seabird LCM interface with command:nohup ./lrauv-framework/onboard/bin/gpctd -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyC6 -b 9600 >& /dev/null & 2018-10-19T17:27:25.525Z,1539970045.525 [CTD_Seabird](INFO): LCM subscribed to channel:seabird_gpctd_t.seabird-gpctd 2018-10-19T17:27:26.704Z,1539970046.704 [NavChartDb](INFO): Creating index for 36p5 2018-10-19T17:27:28.515Z,1539970048.515 [NavChartDb](INFO): Creating index for 54p8 2018-10-19T17:27:29.804Z,1539970049.804 [NavChartDb](INFO): Creating index for 73p1 2018-10-19T17:27:31.754Z,1539970051.754 [NavChartDb](INFO): Creating index for 91p4 2018-10-19T17:27:34.654Z,1539970054.654 [NavChartDb](INFO): Creating index for 182p8 2018-10-19T17:27:36.196Z,1539970056.196 [NavChartDb](INFO): Creating index for 274p3 2018-10-19T17:27:37.788Z,1539970057.788 [NavChartDb](INFO): Creating index for 365p7 2018-10-19T17:27:38.831Z,1539970058.831 [NavChartDb](INFO): Creating index for 457p2 2018-10-19T17:27:39.617Z,1539970059.617 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2018-10-19T17:27:40.963Z,1539970060.963 [NavChartDb](INFO): Creating index for 548p6 2018-10-19T17:27:42.169Z,1539970062.169 [NavChartDb](INFO): Creating index for 640p0 2018-10-19T17:27:43.821Z,1539970063.821 [NavChartDb](INFO): Creating index for 731p5 2018-10-19T17:27:44.877Z,1539970064.877 [NavChartDb](INFO): Creating index for 822p9 2018-10-19T17:27:47.663Z,1539970067.663 [NavChartDb](INFO): Creating index for 914p4 2018-10-19T17:27:48.864Z,1539970068.864 [NavChartDb](INFO): Creating index for 1005p8 2018-10-19T17:27:49.862Z,1539970069.862 [NavChartDb](INFO): Creating index for 1097p2 2018-10-19T17:27:50.370Z,1539970070.370 [NavChartDb](INFO): Creating index for 1188p7 2018-10-19T17:27:51.375Z,1539970071.375 [NavChartDb](INFO): Creating index for 1280p1 2018-10-19T17:27:52.793Z,1539970072.793 [NavChartDb](INFO): Creating index for 1463p0 2018-10-19T17:27:53.943Z,1539970073.943 [NavChartDb](INFO): Creating index for 1645p9 2018-10-19T17:27:54.100Z,1539970074.100 [CBIT](INFO): Clearing failed state for component PNI_TCM 2018-10-19T17:27:54.100Z,1539970074.100 [PNI_TCM] No Fault, FailCount= 1 2018-10-19T17:27:54.985Z,1539970074.985 [CTD_Seabird](FAULT): Did not receive valid device response within the specified allowable sample time. 2018-10-19T17:27:54.985Z,1539970074.985 [CTD_Seabird] Communications Fault, FailCount= 4 2018-10-19T17:27:54.985Z,1539970074.985 [CTD_Seabird](ERROR): Communications Fault 2018-10-19T17:27:55.257Z,1539970075.257 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2018-10-19T17:27:55.528Z,1539970075.528 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-10-19T17:27:55.529Z,1539970075.529 [CTD_Seabird](INFO): Powering down 2018-10-19T17:27:56.828Z,1539970076.828 [NavChartDb](INFO): Creating index for 1828p8 2018-10-19T17:27:56.905Z,1539970076.905 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2018-10-19T17:27:56.905Z,1539970076.905 [CTD_Seabird] No Fault, FailCount= 4 2018-10-19T17:27:57.145Z,1539970077.145 [CTD_Seabird](INFO): Initializing 2018-10-19T17:27:57.145Z,1539970077.145 [CTD_Seabird](INFO): Checking LCM 2018-10-19T17:27:57.145Z,1539970077.145 [CTD_Seabird](INFO): LCM OK 2018-10-19T17:27:57.145Z,1539970077.145 [CTD_Seabird](INFO): Powering up 2018-10-19T17:27:58.071Z,1539970078.071 [CBIT](INFO): Clearing failed state for component ElevatorServo 2018-10-19T17:27:58.071Z,1539970078.071 [ElevatorServo] No Fault, FailCount= 3 2018-10-19T17:27:58.705Z,1539970078.705 [NavChartDb](INFO): Creating index for 2011p6 2018-10-19T17:27:59.560Z,1539970079.560 [NavChartDb](INFO): Creating index for 2194p5 2018-10-19T17:27:59.712Z,1539970079.712 [CBIT](INFO): Clearing failed state for component RudderServo 2018-10-19T17:27:59.712Z,1539970079.712 [RudderServo] No Fault, FailCount= 3 2018-10-19T17:28:00.377Z,1539970080.377 [NavChartDb](INFO): Creating index for 2377p4 2018-10-19T17:28:00.830Z,1539970080.830 [PNI_TCM](FAULT): Failed to acquire valid data within timeout. 2018-10-19T17:28:00.830Z,1539970080.830 [PNI_TCM] Data Fault, FailCount= 1 2018-10-19T17:28:00.830Z,1539970080.830 [PNI_TCM](ERROR): Data Fault 2018-10-19T17:28:00.954Z,1539970080.954 [CBIT](ERROR): Data Fault in component: PNI_TCM 2018-10-19T17:28:00.955Z,1539970080.955 [CBIT](CRITICAL): Data Fault in component: PNI_TCM 2018-10-19T17:28:01.272Z,1539970081.272 [CBIT](INFO): Critical error at 20181019T172800 2018-10-19T17:28:01.281Z,1539970081.281 [NavChartDb](INFO): Creating index for 2560p3 2018-10-19T17:28:02.747Z,1539970082.747 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-10-19T17:28:02.876Z,1539970082.876 [NavChartDb](INFO): Creating index for 2743p2 2018-10-19T17:28:02.927Z,1539970082.927 [CTD_Seabird](INFO): Started Seabird LCM interface with command:nohup ./lrauv-framework/onboard/bin/gpctd -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyC6 -b 9600 >& /dev/null & 2018-10-19T17:28:02.929Z,1539970082.929 [CTD_Seabird](INFO): LCM subscribed to channel:seabird_gpctd_t.seabird-gpctd 2018-10-19T17:28:04.099Z,1539970084.099 [NavChartDb](INFO): Creating index for 2926p0 2018-10-19T17:28:04.941Z,1539970084.941 [NavChartDb](INFO): Creating index for 3108p9 2018-10-19T17:28:05.697Z,1539970085.697 [NavChartDb](INFO): Creating index for 3291p8 2018-10-19T17:28:06.183Z,1539970086.183 [NavChartDb](INFO): Creating index for 3474p7 2018-10-19T17:28:10.460Z,1539970090.460 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-10-19T17:28:10.460Z,1539970090.460 [Aanderaa_O2] No Fault, FailCount= 3 2018-10-19T17:28:10.917Z,1539970090.917 [NavChartDb](INFO): Creating index for 3657p6 2018-10-19T17:28:14.817Z,1539970094.817 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2018-10-19T17:28:20.838Z,1539970100.838 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-10-19T17:28:20.838Z,1539970100.838 [Aanderaa_O2] Communications Fault, FailCount= 1 2018-10-19T17:28:20.838Z,1539970100.838 [Aanderaa_O2](ERROR): Communications Fault 2018-10-19T17:28:20.883Z,1539970100.883 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-10-19T17:28:32.433Z,1539970112.433 [CTD_Seabird](FAULT): Did not receive valid device response within the specified allowable sample time. 2018-10-19T17:28:32.433Z,1539970112.433 [CTD_Seabird] Communications Fault, FailCount= 5 2018-10-19T17:28:32.433Z,1539970112.433 [CTD_Seabird](ERROR): Communications Fault 2018-10-19T17:28:32.918Z,1539970112.918 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-10-19T17:28:32.918Z,1539970112.918 [CTD_Seabird](INFO): Powering down 2018-10-19T17:28:32.920Z,1539970112.920 [Aanderaa_O2](INFO): Powering down 2018-10-19T17:28:32.930Z,1539970112.930 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-10-19T17:28:32.930Z,1539970112.930 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2018-10-19T17:28:32.931Z,1539970112.931 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-10-19T17:28:32.933Z,1539970112.933 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-10-19T17:28:32.933Z,1539970112.933 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 8 2018-10-19T17:28:32.933Z,1539970112.933 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-10-19T17:28:32.968Z,1539970112.968 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-10-19T17:28:32.968Z,1539970112.968 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-10-19T17:28:32.968Z,1539970112.968 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2018-10-19T17:28:32.977Z,1539970112.977 [CBIT](CRITICAL): Communications Fault in component: CTD_Seabird 2018-10-19T17:28:33.094Z,1539970113.094 [CBIT](INFO): Critical error at 20181019T172832 2018-10-19T17:28:33.106Z,1539970113.106 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-10-19T17:28:33.106Z,1539970113.106 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2018-10-19T17:28:33.107Z,1539970113.107 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-10-19T17:28:33.107Z,1539970113.107 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 8 2018-10-19T17:28:33.401Z,1539970113.401 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-10-19T17:28:33.402Z,1539970113.402 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-10-19T17:28:33.402Z,1539970113.402 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-10-19T17:28:33.402Z,1539970113.402 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-10-19T17:28:33.403Z,1539970113.403 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-10-19T17:28:33.403Z,1539970113.403 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-10-19T17:28:33.446Z,1539970113.446 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-10-19T17:28:33.446Z,1539970113.446 [Aanderaa_O2] No Fault, FailCount= 1 2018-10-19T17:28:44.192Z,1539970124.192 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-10-19T17:28:44.193Z,1539970124.193 [Aanderaa_O2] Communications Fault, FailCount= 2 2018-10-19T17:28:44.193Z,1539970124.193 [Aanderaa_O2](ERROR): Communications Fault 2018-10-19T17:28:44.219Z,1539970124.219 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-10-19T17:29:14.713Z,1539970154.713 [Aanderaa_O2](INFO): Powering down 2018-10-19T17:29:14.762Z,1539970154.762 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2018-10-19T17:29:15.215Z,1539970155.215 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-10-19T17:29:15.215Z,1539970155.215 [Aanderaa_O2] No Fault, FailCount= 2 2018-10-19T17:29:19.629Z,1539970159.629 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002685 2018-10-19T17:29:25.646Z,1539970165.646 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-10-19T17:29:25.646Z,1539970165.646 [Aanderaa_O2] Communications Fault, FailCount= 3 2018-10-19T17:29:25.646Z,1539970165.646 [Aanderaa_O2](ERROR): Communications Fault 2018-10-19T17:29:25.698Z,1539970165.698 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-10-19T17:29:25.699Z,1539970165.699 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2018-10-19T17:29:39.289Z,1539970179.289 [CommandLine](IMPORTANT): got command restart application 2018-10-19T17:29:40.296Z,1539970180.296 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2018-10-19T17:29:40.296Z,1539970180.296 [CommandLine ThreadHandler](INFO): Thread cancelled. 2018-10-19T17:29:40.456Z,1539970180.456 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2018-10-19T17:29:40.457Z,1539970180.457 [CommandLine ThreadHandler](INFO): Thread cancelled. 2018-10-19T17:29:40.457Z,1539970180.457 [CommandLine](INFO): Join timeout helper Thread ID is 8114 2018-10-19T17:29:40.458Z,1539970180.458 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2018-10-19T17:29:40.458Z,1539970180.458 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2018-10-19T17:29:40.459Z,1539970180.459 [NavChartDb](INFO): Join timeout helper Thread ID is 8115 2018-10-19T17:29:40.737Z,1539970180.737 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2018-10-19T17:29:40.737Z,1539970180.737 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2018-10-19T17:29:40.741Z,1539970180.741 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2018-10-19T17:29:40.741Z,1539970180.741 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2018-10-19T17:29:40.741Z,1539970180.741 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 8116 2018-10-19T17:29:40.985Z,1539970180.985 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2018-10-19T17:29:40.985Z,1539970180.985 [WetLabsBB2FL](INFO): Powering down 2018-10-19T17:29:40.986Z,1539970180.986 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2018-10-19T17:29:41.001Z,1539970181.001 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2018-10-19T17:29:41.001Z,1539970181.001 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2018-10-19T17:29:41.001Z,1539970181.001 [CTD_Seabird](INFO): Join timeout helper Thread ID is 8117 2018-10-19T17:29:41.201Z,1539970181.201 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2018-10-19T17:29:41.284Z,1539970181.284 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-10-19T17:29:41.285Z,1539970181.285 [CTD_Seabird](INFO): Powering down 2018-10-19T17:29:41.286Z,1539970181.286 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2018-10-19T17:29:41.287Z,1539970181.287 [Aanderaa_O2](INFO): Powering down 2018-10-19T17:29:41.301Z,1539970181.301 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler 2018-10-19T17:29:41.301Z,1539970181.301 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2018-10-19T17:29:41.302Z,1539970181.302 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 8119 2018-10-19T17:29:41.461Z,1539970181.461 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread. 2018-10-19T17:29:41.461Z,1539970181.461 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2018-10-19T17:29:41.478Z,1539970181.478 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2018-10-19T17:29:41.479Z,1539970181.479 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2018-10-19T17:29:41.479Z,1539970181.479 [Radio_Surface](INFO): Join timeout helper Thread ID is 8120 2018-10-19T17:29:41.869Z,1539970181.869 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2018-10-19T17:29:41.869Z,1539970181.869 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2018-10-19T17:29:41.878Z,1539970181.878 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2018-10-19T17:29:41.878Z,1539970181.878 [logger ThreadHandler](INFO): Thread cancelled. 2018-10-19T17:29:41.879Z,1539970181.879 [logger](INFO): Join timeout helper Thread ID is 8121 2018-10-19T17:29:41.879Z,1539970181.879 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2018-10-19T17:29:41.879Z,1539970181.879 [logger ThreadHandler](INFO): Thread cancelled. 2018-10-19T17:29:41.881Z,1539970181.881 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2018-10-19T17:29:41.881Z,1539970181.881 [CommandLine ThreadHandler](INFO): Thread cancelled. 2018-10-19T17:29:41.881Z,1539970181.881 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2018-10-19T17:29:41.881Z,1539970181.881 [controlThread ThreadHandler](INFO): Thread cancelled. 2018-10-19T17:29:41.882Z,1539970181.882 [controlThread](INFO): Join timeout helper Thread ID is 8122 2018-10-19T17:29:42.121Z,1539970182.121 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2018-10-19T17:29:42.121Z,1539970182.121 [controlThread](DEBUG): Uninitializing ControlThread 2018-10-19T17:29:42.121Z,1539970182.121 [AHRS_M2](INFO): Powering down 2018-10-19T17:29:42.123Z,1539970182.123 [DVL_micro](INFO): uninitialize:Powering down 2018-10-19T17:29:42.123Z,1539970182.123 [NAL9602](INFO): Powering down 2018-10-19T17:29:42.125Z,1539970182.125 [Aanderaa_O2](INFO): Powering down 2018-10-19T17:29:42.126Z,1539970182.126 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2018-10-19T17:29:42.127Z,1539970182.127 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2018-10-19T17:29:42.127Z,1539970182.127 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2018-10-19T17:29:42.127Z,1539970182.127 [MissionManager](INFO): Uninitializing Mission Default 2018-10-19T17:29:42.130Z,1539970182.130 [MissionManager](INFO): Uninitializing Mission Startup 2018-10-19T17:29:42.131Z,1539970182.131 [Startup] Stopped 2018-10-19T17:29:42.131Z,1539970182.131 [Startup](DEBUG): Aggregate::uninitialize Startup 2018-10-19T17:29:42.131Z,1539970182.131 [Startup:A.GoToSurface] Stopped 2018-10-19T17:29:42.131Z,1539970182.131 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2018-10-19T17:29:42.133Z,1539970182.133 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2018-10-19T17:29:42.133Z,1539970182.133 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2018-10-19T17:29:42.133Z,1539970182.133 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2018-10-19T17:29:42.133Z,1539970182.133 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2018-10-19T17:29:42.134Z,1539970182.134 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-19T17:29:42.134Z,1539970182.134 [BuoyancyServo](INFO): Powering down 2018-10-19T17:29:42.149Z,1539970182.149 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2018-10-19T17:29:42.149Z,1539970182.149 [ElevatorServo](INFO): Powering down 2018-10-19T17:29:42.150Z,1539970182.150 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-10-19T17:29:42.150Z,1539970182.150 [MassServo](INFO): Powering down 2018-10-19T17:29:42.151Z,1539970182.151 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2018-10-19T17:29:42.151Z,1539970182.151 [RudderServo](INFO): Powering down 2018-10-19T17:29:42.152Z,1539970182.152 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-10-19T17:29:42.152Z,1539970182.152 [ThrusterServo](INFO): Powering down 2018-10-19T17:29:42.153Z,1539970182.153 [SBIT](DEBUG): Uninitialize SBIT Component. 2018-10-19T17:29:42.153Z,1539970182.153 [IBIT](DEBUG): Uninitialize IBIT Component. 2018-10-19T17:29:42.153Z,1539970182.153 [CBIT](DEBUG): Uninitialize CBIT Component. 2018-10-19T17:29:42.154Z,1539970182.154 [controlThread ThreadHandler](INFO): Thread cancelled. 2018-10-19T17:29:42.248Z,1539970182.248 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2018-10-19T17:29:42.293Z,1539970182.293 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2018-10-19T17:29:42.296Z,1539970182.296 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2018-10-19T17:29:42.299Z,1539970182.299 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2018-10-19T17:29:42.348Z,1539970182.348 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2018-10-19T17:29:42.405Z,1539970182.405 [logger ThreadHandler](INFO): Thread cancelled.