2019-09-05T14:54:12.396Z,1567695252.396 [Supervisor](DEBUG): Initializing supervisor. 2019-09-05T14:54:12.399Z,1567695252.399 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2019-09-05T14:54:12.400Z,1567695252.400 [SyncHandler](INFO): Protected caller Thread ID is 4468 2019-09-05T14:54:12.400Z,1567695252.400 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2019-09-05T14:54:12.401Z,1567695252.401 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2019-09-05T14:54:12.401Z,1567695252.401 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 4469 2019-09-05T14:54:12.404Z,1567695252.404 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2019-09-05T14:54:12.415Z,1567695252.415 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2019-09-05T14:54:12.416Z,1567695252.416 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2019-09-05T14:54:12.417Z,1567695252.417 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 4470 2019-09-05T14:54:12.418Z,1567695252.418 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2019-09-05T14:54:12.418Z,1567695252.418 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2019-09-05T14:54:12.419Z,1567695252.419 [logger ThreadHandler](INFO): Protected caller Thread ID is 4471 2019-09-05T14:54:12.421Z,1567695252.421 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2019-09-05T14:54:12.421Z,1567695252.421 [Supervisor](INFO): Looking for Config files in directory: Config/ 2019-09-05T14:54:12.423Z,1567695252.423 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2019-09-05T14:54:12.852Z,1567695252.852 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2019-09-05T14:54:12.852Z,1567695252.852 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2019-09-05T14:54:13.047Z,1567695253.047 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2019-09-05T14:54:13.047Z,1567695253.047 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2019-09-05T14:54:13.186Z,1567695253.186 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2019-09-05T14:54:13.187Z,1567695253.187 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2019-09-05T14:54:13.488Z,1567695253.488 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2019-09-05T14:54:13.489Z,1567695253.489 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2019-09-05T14:54:13.820Z,1567695253.820 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2019-09-05T14:54:13.821Z,1567695253.821 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2019-09-05T14:54:13.918Z,1567695253.918 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2019-09-05T14:54:13.919Z,1567695253.919 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2019-09-05T14:54:14.068Z,1567695254.068 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2019-09-05T14:54:14.069Z,1567695254.069 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2019-09-05T14:54:14.535Z,1567695254.535 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2019-09-05T14:54:14.536Z,1567695254.536 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2019-09-05T14:54:14.920Z,1567695254.920 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2019-09-05T14:54:14.921Z,1567695254.921 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2019-09-05T14:54:15.002Z,1567695255.002 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2019-09-05T14:54:15.206Z,1567695255.206 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2019-09-05T14:54:15.207Z,1567695255.207 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2019-09-05T14:54:15.310Z,1567695255.310 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2019-09-05T14:54:15.311Z,1567695255.311 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2019-09-05T14:54:16.000Z,1567695256.000 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2019-09-05T14:54:16.001Z,1567695256.001 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2019-09-05T14:54:16.103Z,1567695256.103 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2019-09-05T14:54:16.104Z,1567695256.104 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2019-09-05T14:54:16.324Z,1567695256.324 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2019-09-05T14:54:16.326Z,1567695256.326 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/ 2019-09-05T14:54:16.327Z,1567695256.327 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg 2019-09-05T14:54:16.502Z,1567695256.502 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg 2019-09-05T14:54:16.598Z,1567695256.598 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg 2019-09-05T14:54:16.710Z,1567695256.710 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg 2019-09-05T14:54:16.813Z,1567695256.813 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg 2019-09-05T14:54:16.897Z,1567695256.897 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg 2019-09-05T14:54:16.984Z,1567695256.984 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg 2019-09-05T14:54:17.101Z,1567695257.101 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg 2019-09-05T14:54:17.201Z,1567695257.201 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg 2019-09-05T14:54:17.354Z,1567695257.354 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg 2019-09-05T14:54:17.628Z,1567695257.628 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2019-09-05T14:54:17.629Z,1567695257.629 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg 2019-09-05T14:54:17.853Z,1567695257.853 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/root/ 2019-09-05T14:54:17.854Z,1567695257.854 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2019-09-05T14:54:17.861Z,1567695257.861 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2019-09-05T14:54:18.569Z,1567695258.569 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2019-09-05T14:54:18.570Z,1567695258.570 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2019-09-05T14:54:18.840Z,1567695258.840 [DeadReckonUsingMultipleVelocitySources] Loaded 2019-09-05T14:54:18.841Z,1567695258.841 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2019-09-05T14:54:18.899Z,1567695258.899 [DeadReckonUsingSpeedCalculator] Loaded 2019-09-05T14:54:18.900Z,1567695258.900 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2019-09-05T14:54:18.921Z,1567695258.921 [NavChart] Loaded 2019-09-05T14:54:18.922Z,1567695258.922 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2019-09-05T14:54:18.925Z,1567695258.925 [UniversalFixResidualReporter] Loaded 2019-09-05T14:54:18.926Z,1567695258.926 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2019-09-05T14:54:18.926Z,1567695258.926 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2019-09-05T14:54:18.927Z,1567695258.927 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2019-09-05T14:54:18.940Z,1567695258.940 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2019-09-05T14:54:18.940Z,1567695258.940 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2019-09-05T14:54:19.106Z,1567695259.106 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2019-09-05T14:54:19.106Z,1567695259.106 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2019-09-05T14:54:19.175Z,1567695259.175 [VerticalControl](DEBUG): Construct VerticalControl. 2019-09-05T14:54:19.289Z,1567695259.289 [VerticalControl] Loaded 2019-09-05T14:54:19.290Z,1567695259.290 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2019-09-05T14:54:19.290Z,1567695259.290 [HorizontalControl](DEBUG): Construct HorizontalControl. 2019-09-05T14:54:19.359Z,1567695259.359 [HorizontalControl] Loaded 2019-09-05T14:54:19.360Z,1567695259.360 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2019-09-05T14:54:19.360Z,1567695259.360 [SpeedControl](DEBUG): Construct SpeedControl. 2019-09-05T14:54:19.366Z,1567695259.366 [SpeedControl] Loaded 2019-09-05T14:54:19.366Z,1567695259.366 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2019-09-05T14:54:19.367Z,1567695259.367 [LoopControl](DEBUG): Construct LoopControl. 2019-09-05T14:54:19.367Z,1567695259.367 [LoopControl] Loaded 2019-09-05T14:54:19.368Z,1567695259.368 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2019-09-05T14:54:19.368Z,1567695259.368 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2019-09-05T14:54:19.369Z,1567695259.369 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2019-09-05T14:54:19.411Z,1567695259.411 [DepthRateCalculator] Loaded 2019-09-05T14:54:19.411Z,1567695259.411 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2019-09-05T14:54:19.416Z,1567695259.416 [PitchRateCalculator] Loaded 2019-09-05T14:54:19.417Z,1567695259.417 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2019-09-05T14:54:19.429Z,1567695259.429 [SpeedCalculator] Loaded 2019-09-05T14:54:19.430Z,1567695259.430 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2019-09-05T14:54:19.451Z,1567695259.451 [TempGradientCalculator] Loaded 2019-09-05T14:54:19.451Z,1567695259.451 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2019-09-05T14:54:19.456Z,1567695259.456 [YawRateCalculator] Loaded 2019-09-05T14:54:19.456Z,1567695259.456 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2019-09-05T14:54:19.485Z,1567695259.485 [ElevatorOffsetCalculator] Loaded 2019-09-05T14:54:19.486Z,1567695259.486 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2019-09-05T14:54:19.486Z,1567695259.486 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2019-09-05T14:54:19.486Z,1567695259.486 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2019-09-05T14:54:19.558Z,1567695259.558 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2019-09-05T14:54:19.558Z,1567695259.558 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2019-09-05T14:54:19.663Z,1567695259.663 [BuoyancyServo] Loaded 2019-09-05T14:54:19.663Z,1567695259.663 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2019-09-05T14:54:19.674Z,1567695259.674 [ElevatorServo] Loaded 2019-09-05T14:54:19.675Z,1567695259.675 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2019-09-05T14:54:19.686Z,1567695259.686 [MassServo](DEBUG): LcmSlateWriter::add(): fdi_state 2019-09-05T14:54:19.691Z,1567695259.691 [MassServo](INFO): created writer for : fdi_state 2019-09-05T14:54:19.692Z,1567695259.692 [MassServo](DEBUG): LcmSlateWriter::add(): platform_mass_position_delta 2019-09-05T14:54:19.697Z,1567695259.697 [MassServo](INFO): created writer for : platform_mass_position_delta 2019-09-05T14:54:19.698Z,1567695259.698 [MassServo] Loaded 2019-09-05T14:54:19.698Z,1567695259.698 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2019-09-05T14:54:19.709Z,1567695259.709 [RudderServo] Loaded 2019-09-05T14:54:19.710Z,1567695259.710 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2019-09-05T14:54:19.720Z,1567695259.720 [ThrusterServo] Loaded 2019-09-05T14:54:19.721Z,1567695259.721 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2019-09-05T14:54:19.721Z,1567695259.721 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2019-09-05T14:54:19.722Z,1567695259.722 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2019-09-05T14:54:19.819Z,1567695259.819 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2019-09-05T14:54:19.819Z,1567695259.819 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2019-09-05T14:54:20.190Z,1567695260.190 [AHRS_M2] Loaded 2019-09-05T14:54:20.191Z,1567695260.191 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2019-09-05T14:54:20.264Z,1567695260.264 [DataOverHttps] Loaded 2019-09-05T14:54:20.265Z,1567695260.265 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2019-09-05T14:54:20.266Z,1567695260.266 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409B84E0 2019-09-05T14:54:20.266Z,1567695260.266 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 4551 2019-09-05T14:54:20.280Z,1567695260.280 [Depth_Keller] Loaded 2019-09-05T14:54:20.280Z,1567695260.280 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2019-09-05T14:54:20.285Z,1567695260.285 [DropWeight] Loaded 2019-09-05T14:54:20.285Z,1567695260.285 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2019-09-05T14:54:20.384Z,1567695260.384 [NAL9602] Loaded 2019-09-05T14:54:20.385Z,1567695260.385 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2019-09-05T14:54:20.401Z,1567695260.401 [Onboard] Loaded 2019-09-05T14:54:20.401Z,1567695260.401 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2019-09-05T14:54:20.404Z,1567695260.404 [Radio_Surface] Loaded 2019-09-05T14:54:20.404Z,1567695260.404 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2019-09-05T14:54:20.405Z,1567695260.405 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409E84E0 2019-09-05T14:54:20.406Z,1567695260.406 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 4552 2019-09-05T14:54:20.416Z,1567695260.416 [FDI](DEBUG): LcmSlateWriter::add(): fdi_control_run 2019-09-05T14:54:20.421Z,1567695260.421 [FDI](INFO): created writer for : fdi_control_run 2019-09-05T14:54:20.421Z,1567695260.421 [FDI] Loaded 2019-09-05T14:54:20.422Z,1567695260.422 [ComponentRegistry](DEBUG): SyncComponent "FDI" handled in the control thread. 2019-09-05T14:54:21.948Z,1567695261.948 [BPC1] Loaded 2019-09-05T14:54:21.948Z,1567695261.948 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2019-09-05T14:54:21.949Z,1567695261.949 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2019-09-05T14:54:21.949Z,1567695261.949 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2019-09-05T14:54:22.086Z,1567695262.086 [SBIT](DEBUG): Construct Startup Built In Test. 2019-09-05T14:54:22.097Z,1567695262.097 [SBIT] Loaded 2019-09-05T14:54:22.097Z,1567695262.097 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2019-09-05T14:54:22.098Z,1567695262.098 [IBIT](DEBUG): Construct Initiated Built In Test. 2019-09-05T14:54:22.109Z,1567695262.109 [IBIT] Loaded 2019-09-05T14:54:22.109Z,1567695262.109 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2019-09-05T14:54:22.112Z,1567695262.112 [CBIT](DEBUG): Construct Continuous Built In Test. 2019-09-05T14:54:22.249Z,1567695262.249 [CBIT] Loaded 2019-09-05T14:54:22.249Z,1567695262.249 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2019-09-05T14:54:22.250Z,1567695262.250 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2019-09-05T14:54:22.250Z,1567695262.250 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2019-09-05T14:54:22.278Z,1567695262.278 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2019-09-05T14:54:22.282Z,1567695262.282 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2019-09-05T14:54:22.283Z,1567695262.283 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2019-09-05T14:54:22.289Z,1567695262.289 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2019-09-05T14:54:22.290Z,1567695262.290 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A714E0 2019-09-05T14:54:22.291Z,1567695262.291 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 4553 2019-09-05T14:54:22.295Z,1567695262.295 [Supervisor](INFO): Main Thread ID is 4467 2019-09-05T14:54:22.295Z,1567695262.295 [Supervisor](DEBUG): Running supervisor. 2019-09-05T14:54:22.296Z,1567695262.296 [CommandLine ThreadHandler](INFO): Handler Thread ID is 4554 2019-09-05T14:54:22.298Z,1567695262.298 [controlThread ThreadHandler](INFO): Handler Thread ID is 4555 2019-09-05T14:54:22.299Z,1567695262.299 [controlThread](DEBUG): Initializing ControlThread 2019-09-05T14:54:22.300Z,1567695262.300 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2019-09-05T14:54:22.301Z,1567695262.301 [NavChart](DEBUG): Initialize NavChart Navigation. 2019-09-05T14:54:22.301Z,1567695262.301 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2019-09-05T14:54:22.302Z,1567695262.302 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2019-09-05T14:54:22.303Z,1567695262.303 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2019-09-05T14:54:22.304Z,1567695262.304 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2019-09-05T14:54:22.304Z,1567695262.304 [LoopControl](DEBUG): Initialize LoopControlComponent. 2019-09-05T14:54:22.305Z,1567695262.305 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2019-09-05T14:54:22.305Z,1567695262.305 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2019-09-05T14:54:22.305Z,1567695262.305 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2019-09-05T14:54:22.306Z,1567695262.306 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2019-09-05T14:54:22.306Z,1567695262.306 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2019-09-05T14:54:22.307Z,1567695262.307 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2019-09-05T14:54:22.315Z,1567695262.315 [SBIT](INFO): Initialize SBIT Component. 2019-09-05T14:54:22.316Z,1567695262.316 [SBIT](IMPORTANT): git: 2019-06-18 2019-09-05T14:54:22.316Z,1567695262.316 [SBIT](INFO): git hash: 5c7bbe83cb2cc9abe51279814c5b075b58bd853f 2019-09-05T14:54:22.316Z,1567695262.316 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2019-09-05T14:54:22.318Z,1567695262.318 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018 Kernel Reported: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019 2019-09-05T14:54:22.319Z,1567695262.319 [SBIT](INFO): Beginning SBIT in 24.000000 seconds. 2019-09-05T14:54:22.319Z,1567695262.319 [IBIT](INFO): Initialize IBIT Component. 2019-09-05T14:54:22.320Z,1567695262.320 [CBIT](DEBUG): Initialize CBIT Component. 2019-09-05T14:54:22.321Z,1567695262.321 [logger ThreadHandler](INFO): Handler Thread ID is 4556 2019-09-05T14:54:22.333Z,1567695262.333 [CBIT](DEBUG): Initialized mux pins. 2019-09-05T14:54:22.333Z,1567695262.333 [CBIT](DEBUG): Initializing the watchdog timer. 2019-09-05T14:54:22.341Z,1567695262.341 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 4557 2019-09-05T14:54:22.342Z,1567695262.342 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2019-09-05T14:54:22.353Z,1567695262.353 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 4558 2019-09-05T14:54:22.357Z,1567695262.357 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2019-09-05T14:54:22.357Z,1567695262.357 [CBIT](DEBUG): Initializing heartbeat. 2019-09-05T14:54:22.365Z,1567695262.365 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 4559 2019-09-05T14:54:22.369Z,1567695262.369 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2019-09-05T14:54:22.369Z,1567695262.369 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2019-09-05T14:54:22.369Z,1567695262.369 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2019-09-05T14:54:22.369Z,1567695262.369 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2019-09-05T14:54:22.369Z,1567695262.369 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2019-09-05T14:54:22.370Z,1567695262.370 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2019-09-05T14:54:22.370Z,1567695262.370 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2019-09-05T14:54:22.370Z,1567695262.370 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2019-09-05T14:54:22.370Z,1567695262.370 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2019-09-05T14:54:22.370Z,1567695262.370 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2019-09-05T14:54:22.370Z,1567695262.370 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2019-09-05T14:54:22.371Z,1567695262.371 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2019-09-05T14:54:22.371Z,1567695262.371 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2019-09-05T14:54:22.371Z,1567695262.371 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2019-09-05T14:54:22.371Z,1567695262.371 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2019-09-05T14:54:22.371Z,1567695262.371 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2019-09-05T14:54:22.429Z,1567695262.429 [CBIT](DEBUG): Deactivating GF circuits. 2019-09-05T14:54:22.429Z,1567695262.429 [CBIT](DEBUG): Deactivating emergency mode. 2019-09-05T14:54:22.465Z,1567695262.465 [CBIT](DEBUG): Backplane powered. 2019-09-05T14:54:22.466Z,1567695262.466 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2019-09-05T14:54:22.476Z,1567695262.476 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2019-09-05T14:54:22.495Z,1567695262.495 [MissionManager](DEBUG): 2019-09-05T14:54:22.495Z,1567695262.495 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2019-09-05T14:54:22.566Z,1567695262.566 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2019-09-05T14:54:22.568Z,1567695262.568 [Default:A.Wait](DEBUG): Construct Wait. 2019-09-05T14:54:22.585Z,1567695262.585 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2019-09-05T14:54:22.608Z,1567695262.608 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2019-09-05T14:54:22.614Z,1567695262.614 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2019-09-05T14:54:22.645Z,1567695262.645 [Default:E.Execute](DEBUG): Construct Execute. 2019-09-05T14:54:22.649Z,1567695262.649 [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 2019-09-05T14:54:22.665Z,1567695262.665 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,DropWeight,NAL9602,Onboard,FDI,BPC1,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, 2019-09-05T14:54:22.673Z,1567695262.673 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2019-09-05T14:54:22.726Z,1567695262.726 [Depth_Keller](ERROR): Pressure reading out of range: 1628.471313 decibar 2019-09-05T14:54:22.757Z,1567695262.757 [Radio_Surface](INFO): Powering up 2019-09-05T14:54:22.793Z,1567695262.793 [DepthRateCalculator](ERROR): Depth measurement is not active 2019-09-05T14:54:22.843Z,1567695262.843 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2019-09-05T14:54:22.857Z,1567695262.857 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2019-09-05T14:54:22.858Z,1567695262.858 [ElevatorServo](DEBUG): Initializing EZServoServo. 2019-09-05T14:54:22.865Z,1567695262.865 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2019-09-05T14:54:22.866Z,1567695262.866 [MassServo](DEBUG): Initializing EZServoServo. 2019-09-05T14:54:22.873Z,1567695262.873 [MassServo](DEBUG): Initializing MassServo. 2019-09-05T14:54:22.874Z,1567695262.874 [RudderServo](DEBUG): Initializing EZServoServo. 2019-09-05T14:54:22.881Z,1567695262.881 [RudderServo](DEBUG): Initializing RudderServo. 2019-09-05T14:54:22.882Z,1567695262.882 [ThrusterServo](DEBUG): Initializing EZServoServo. 2019-09-05T14:54:22.889Z,1567695262.889 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2019-09-05T14:54:23.093Z,1567695263.093 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2019-09-05T14:54:23.094Z,1567695263.094 [DropWeight] Hardware Fault, FailCount= 1 2019-09-05T14:54:23.094Z,1567695263.094 [DropWeight](ERROR): Hardware Fault 2019-09-05T14:54:23.113Z,1567695263.113 [DepthRateCalculator](ERROR): Depth measurement is not active 2019-09-05T14:54:23.122Z,1567695263.122 [CommandLine](FAULT): Scheduling is paused 2019-09-05T14:54:23.122Z,1567695263.122 [CBIT](INFO): Critical error at 20190905T145423 2019-09-05T14:54:23.122Z,1567695263.122 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2019-09-05T14:54:23.125Z,1567695263.125 [CBIT](ERROR): Hardware Fault in component: DropWeight 2019-09-05T14:54:23.126Z,1567695263.126 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2019-09-05T14:54:23.813Z,1567695263.813 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2019-09-05T14:54:23.813Z,1567695263.813 [RudderServo](FAULT): Rudder failed to initialize 2019-09-05T14:54:23.813Z,1567695263.813 [RudderServo] Communications Fault, FailCount= 1 2019-09-05T14:54:23.813Z,1567695263.813 [RudderServo](ERROR): Communications Fault 2019-09-05T14:54:23.922Z,1567695263.922 [CBIT](INFO): Critical error at 20190905T145423 2019-09-05T14:54:23.925Z,1567695263.925 [CBIT](ERROR): Communications Fault in component: RudderServo 2019-09-05T14:54:24.114Z,1567695264.114 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2019-09-05T14:54:24.114Z,1567695264.114 [RudderServo](INFO): Powering down 2019-09-05T14:54:24.769Z,1567695264.769 [RudderServo](DEBUG): Initializing EZServoServo. 2019-09-05T14:54:24.890Z,1567695264.890 [RudderServo](DEBUG): Initializing RudderServo. 2019-09-05T14:54:24.894Z,1567695264.894 [CBIT](INFO): Clearing failed state for component RudderServo 2019-09-05T14:54:24.894Z,1567695264.894 [RudderServo] No Fault, FailCount= 1 2019-09-05T14:54:26.273Z,1567695266.273 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:26.677Z,1567695266.677 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:27.161Z,1567695267.161 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:27.729Z,1567695267.729 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:28.133Z,1567695268.133 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:28.597Z,1567695268.597 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:29.181Z,1567695269.181 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:29.805Z,1567695269.805 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:30.233Z,1567695270.233 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:30.633Z,1567695270.633 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:31.161Z,1567695271.161 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:31.553Z,1567695271.553 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:31.965Z,1567695271.965 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:32.369Z,1567695272.369 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:32.777Z,1567695272.777 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:33.177Z,1567695273.177 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:33.581Z,1567695273.581 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:33.899Z,1567695273.899 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005016 2019-09-05T14:54:33.985Z,1567695273.985 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:34.389Z,1567695274.389 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:34.793Z,1567695274.793 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:35.197Z,1567695275.197 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:35.589Z,1567695275.589 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:35.589Z,1567695275.589 [AHRS_M2](FAULT): Failed to initialize within timeout. 2019-09-05T14:54:35.589Z,1567695275.589 [AHRS_M2] Communications Fault, FailCount= 1 2019-09-05T14:54:35.589Z,1567695275.589 [AHRS_M2](ERROR): Communications Fault 2019-09-05T14:54:35.626Z,1567695275.626 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2019-09-05T14:54:35.681Z,1567695275.681 [AHRS_M2](INFO): Powering down 2019-09-05T14:54:36.522Z,1567695276.522 [CBIT](INFO): Clearing failed state for component AHRS_M2 2019-09-05T14:54:36.522Z,1567695276.522 [AHRS_M2] No Fault, FailCount= 1 2019-09-05T14:54:36.893Z,1567695276.893 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2019-09-05T14:54:40.449Z,1567695280.449 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:40.853Z,1567695280.853 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:41.257Z,1567695281.257 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:41.661Z,1567695281.661 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:42.065Z,1567695282.065 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:42.469Z,1567695282.469 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:42.865Z,1567695282.865 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:43.277Z,1567695283.277 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:43.681Z,1567695283.681 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:44.085Z,1567695284.085 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:44.489Z,1567695284.489 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:44.889Z,1567695284.889 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:45.289Z,1567695285.289 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:45.701Z,1567695285.701 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:46.105Z,1567695286.105 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:46.525Z,1567695286.525 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:46.921Z,1567695286.921 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:46.955Z,1567695286.955 [SBIT](IMPORTANT): Beginning Startup BIT 2019-09-05T14:54:46.960Z,1567695286.960 [CBIT](IMPORTANT): Beginning ground fault scan 2019-09-05T14:54:47.313Z,1567695287.313 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:47.761Z,1567695287.761 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:48.205Z,1567695288.205 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:48.633Z,1567695288.633 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:49.265Z,1567695289.265 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:50.097Z,1567695290.097 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:50.097Z,1567695290.097 [AHRS_M2](FAULT): Failed to initialize within timeout. 2019-09-05T14:54:50.097Z,1567695290.097 [AHRS_M2] Communications Fault, FailCount= 2 2019-09-05T14:54:50.097Z,1567695290.097 [AHRS_M2](ERROR): Communications Fault 2019-09-05T14:54:50.258Z,1567695290.258 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2019-09-05T14:54:50.366Z,1567695290.366 [AHRS_M2](INFO): Powering down 2019-09-05T14:54:50.442Z,1567695290.442 [NAL9602](INFO): Powering up NAL9602 2019-09-05T14:54:51.282Z,1567695291.282 [CBIT](INFO): Clearing failed state for component AHRS_M2 2019-09-05T14:54:51.282Z,1567695291.282 [AHRS_M2] No Fault, FailCount= 2 2019-09-05T14:54:51.573Z,1567695291.573 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2019-09-05T14:54:55.129Z,1567695295.129 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:55.541Z,1567695295.541 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:56.041Z,1567695296.041 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:56.457Z,1567695296.457 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:56.869Z,1567695296.869 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:57.381Z,1567695297.381 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:57.785Z,1567695297.785 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:58.197Z,1567695298.197 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:58.705Z,1567695298.705 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:58.811Z,1567695298.811 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.006212 CHAN A1 (24V): 0.001983 CHAN A2 (12V): -0.005740 CHAN A3 (5V): -0.002251 CHAN B0 (3.3V): -0.001549 CHAN B1 (3.15aV): -0.001488 CHAN B2 (3.15bV): -0.001025 CHAN B3 (GND): -0.000212 OPEN: -0.001128 Full Scale Calc: 4.765 mA, -1.589 mA 2019-09-05T14:54:59.145Z,1567695299.145 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:59.561Z,1567695299.561 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:54:59.989Z,1567695299.989 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:00.072Z,1567695300.072 [SBIT](FAULT): Mass: EXPECTED:0.009000 ACTUAL:0.007076 2019-09-05T14:55:00.397Z,1567695300.397 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:00.873Z,1567695300.873 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:01.317Z,1567695301.317 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:01.745Z,1567695301.745 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:01.750Z,1567695301.750 [NAL9602](INFO): NAL9602 initialized 2019-09-05T14:55:02.173Z,1567695302.173 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:02.765Z,1567695302.765 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:02.781Z,1567695302.781 [NAL9602](DEBUG): Fix Requested 2019-09-05T14:55:03.261Z,1567695303.261 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:03.733Z,1567695303.733 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:04.257Z,1567695304.257 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:04.717Z,1567695304.717 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:04.717Z,1567695304.717 [AHRS_M2](FAULT): Failed to initialize within timeout. 2019-09-05T14:55:04.717Z,1567695304.717 [AHRS_M2] Communications Fault, FailCount= 3 2019-09-05T14:55:04.717Z,1567695304.717 [AHRS_M2](ERROR): Communications Fault 2019-09-05T14:55:04.847Z,1567695304.847 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2019-09-05T14:55:04.853Z,1567695304.853 [AHRS_M2](INFO): Powering down 2019-09-05T14:55:05.806Z,1567695305.806 [CBIT](INFO): Clearing failed state for component AHRS_M2 2019-09-05T14:55:05.806Z,1567695305.806 [AHRS_M2] No Fault, FailCount= 3 2019-09-05T14:55:06.061Z,1567695306.061 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2019-09-05T14:55:09.617Z,1567695309.617 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:10.025Z,1567695310.025 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:10.437Z,1567695310.437 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:10.853Z,1567695310.853 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:11.269Z,1567695311.269 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:11.681Z,1567695311.681 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:12.117Z,1567695312.117 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:12.525Z,1567695312.525 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:12.937Z,1567695312.937 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:13.337Z,1567695313.337 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:13.769Z,1567695313.769 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:14.173Z,1567695314.173 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:14.593Z,1567695314.593 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:15.005Z,1567695315.005 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:15.425Z,1567695315.425 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:15.849Z,1567695315.849 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:16.273Z,1567695316.273 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:16.681Z,1567695316.681 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:17.101Z,1567695317.101 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:17.513Z,1567695317.513 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:17.929Z,1567695317.929 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:18.345Z,1567695318.345 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:18.749Z,1567695318.749 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:19.165Z,1567695319.165 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:19.165Z,1567695319.165 [AHRS_M2](FAULT): Failed to initialize within timeout. 2019-09-05T14:55:19.165Z,1567695319.165 [AHRS_M2] Communications Fault, FailCount= 4 2019-09-05T14:55:19.165Z,1567695319.165 [AHRS_M2](ERROR): Communications Fault 2019-09-05T14:55:19.279Z,1567695319.279 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2019-09-05T14:55:19.284Z,1567695319.284 [AHRS_M2](INFO): Powering down 2019-09-05T14:55:20.123Z,1567695320.123 [CBIT](INFO): Clearing failed state for component AHRS_M2 2019-09-05T14:55:20.123Z,1567695320.123 [AHRS_M2] No Fault, FailCount= 4 2019-09-05T14:55:20.493Z,1567695320.493 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2019-09-05T14:55:24.049Z,1567695324.049 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:24.449Z,1567695324.449 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:24.853Z,1567695324.853 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:25.273Z,1567695325.273 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:25.681Z,1567695325.681 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:26.061Z,1567695326.061 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:26.465Z,1567695326.465 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:26.861Z,1567695326.861 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:27.269Z,1567695327.269 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:27.677Z,1567695327.677 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:28.089Z,1567695328.089 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:28.493Z,1567695328.493 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:28.913Z,1567695328.913 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:28.948Z,1567695328.948 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-09-05T14:55:29.457Z,1567695329.457 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:30.293Z,1567695330.293 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:30.789Z,1567695330.789 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:31.297Z,1567695331.297 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:31.797Z,1567695331.797 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:32.341Z,1567695332.341 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:32.993Z,1567695332.993 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:33.413Z,1567695333.413 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T14:55:33.413Z,1567695333.413 [AHRS_M2](FAULT): Failed to initialize within timeout. 2019-09-05T14:55:33.413Z,1567695333.413 [AHRS_M2] Communications Fault, FailCount= 5 2019-09-05T14:55:33.413Z,1567695333.413 [AHRS_M2](ERROR): Communications Fault 2019-09-05T14:55:33.511Z,1567695333.511 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2019-09-05T14:55:33.512Z,1567695333.512 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2 2019-09-05T14:55:33.518Z,1567695333.518 [AHRS_M2](INFO): Powering down 2019-09-05T14:55:33.674Z,1567695333.674 [CBIT](INFO): Critical error at 20190905T145533 2019-09-05T14:55:40.824Z,1567695340.824 [SBIT](CRITICAL): SBIT FAILED 2019-09-05T14:55:40.843Z,1567695340.843 [CBIT](INFO): Critical error at 20190905T145540 2019-09-05T14:55:40.854Z,1567695340.854 [CommandLine](IMPORTANT): got command configSet list 2019-09-05T14:55:40.855Z,1567695340.855 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2019-09-05T14:55:40.855Z,1567695340.855 [CommandLine](IMPORTANT): 2019-09-05T14:55:40.856Z,1567695340.856 [CommandLine](IMPORTANT): CTD_NeilBrown.loadAtStartup=0 bool; 2019-09-05T14:55:40.856Z,1567695340.856 [CommandLine](IMPORTANT): CTD_Seabird.loadAtStartup=0 bool; 2019-09-05T14:55:40.856Z,1567695340.856 [CommandLine](IMPORTANT): NAL9602.fastGPSFix=1 bool; 2019-09-05T14:55:40.856Z,1567695340.856 [CommandLine](IMPORTANT): VerticalControl.buoyancyNeutral=235 cubic_centimeter; 2019-09-05T14:55:40.856Z,1567695340.856 [CommandLine](IMPORTANT): VerticalControl.massDefault=-1 millimeter; 2019-09-05T14:55:40.856Z,1567695340.856 [CommandLine](IMPORTANT): WetLabsBB2FL.loadAtStartup=0 bool; 2019-09-05T14:55:41.233Z,1567695341.233 [MissionManager](IMPORTANT): Started mission Startup 2019-09-05T14:55:41.234Z,1567695341.234 [Startup] Running Loop=1 2019-09-05T14:55:41.234Z,1567695341.234 [Startup](DEBUG): Aggregate::initialize Startup 2019-09-05T14:55:41.234Z,1567695341.234 [Startup:A.GoToSurface] Running Loop=1 2019-09-05T14:55:41.234Z,1567695341.234 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2019-09-05T14:55:41.234Z,1567695341.234 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2019-09-05T14:55:41.235Z,1567695341.235 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2019-09-05T14:55:41.235Z,1567695341.235 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2019-09-05T14:55:41.236Z,1567695341.236 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2019-09-05T14:55:41.236Z,1567695341.236 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2019-09-05T14:55:41.237Z,1567695341.237 [Startup:StartupSatComms] Running Loop=1 2019-09-05T14:55:41.238Z,1567695341.238 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2019-09-05T14:55:41.238Z,1567695341.238 [Startup:StartupSatComms:A] Running Loop=1 2019-09-05T14:55:41.690Z,1567695341.690 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2019-09-05T14:56:13.566Z,1567695373.566 [CommandLine](IMPORTANT): got command gfscan 2019-09-05T14:56:13.968Z,1567695373.968 [CBIT](IMPORTANT): Beginning ground fault scan 2019-09-05T14:56:22.436Z,1567695382.436 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-09-05T14:56:22.436Z,1567695382.436 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2019-09-05T14:56:22.436Z,1567695382.436 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-09-05T14:56:22.438Z,1567695382.438 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-09-05T14:56:22.438Z,1567695382.438 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1 2019-09-05T14:56:22.438Z,1567695382.438 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2019-09-05T14:56:22.450Z,1567695382.450 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-09-05T14:56:22.450Z,1567695382.450 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2019-09-05T14:56:22.850Z,1567695382.850 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-09-05T14:56:22.850Z,1567695382.850 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2019-09-05T14:56:22.850Z,1567695382.850 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2019-09-05T14:56:22.850Z,1567695382.850 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1 2019-09-05T14:56:23.248Z,1567695383.248 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2019-09-05T14:56:24.867Z,1567695384.867 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.007439 CHAN A1 (24V): 0.002018 CHAN A2 (12V): -0.005781 CHAN A3 (5V): -0.002277 CHAN B0 (3.3V): -0.001073 CHAN B1 (3.15aV): -0.001008 CHAN B2 (3.15bV): -0.001184 CHAN B3 (GND): -0.000368 OPEN: -0.001480 Full Scale Calc: 4.765 mA, -1.589 mA 2019-09-05T14:56:32.174Z,1567695392.174 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-09-05T14:56:41.426Z,1567695401.426 [Startup:StartupSatComms:A](INFO): Timed out from 2019-09-05T14:55:41.2Z 2019-09-05T14:56:41.426Z,1567695401.426 [Startup:StartupSatComms:A] Stopped 2019-09-05T14:56:41.426Z,1567695401.426 [Startup:StartupSatComms:B] Running Loop=1 2019-09-05T14:56:41.826Z,1567695401.826 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2019-09-05T14:56:43.482Z,1567695403.482 [CommandLine](IMPORTANT): got command report mod platform_buoyancy_position 2019-09-05T14:56:43.880Z,1567695403.880 [Reporter](INFO): platform_buoyancy_position 964.515381 cc 2019-09-05T14:56:46.430Z,1567695406.430 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190809T170103/Courier0106.lzma 2019-09-05T14:56:47.235Z,1567695407.235 [DataOverHttps](INFO): Moved sent file to Logs/20190809T170103/Courier0106.lzma.bak 2019-09-05T14:56:47.235Z,1567695407.235 [DataOverHttps](INFO): SBD MOMSN=11743272 2019-09-05T14:56:58.056Z,1567695418.056 [DataOverHttps](INFO): Sending 185 bytes from file Logs/20190905T145412/Courier0000.lzma 2019-09-05T14:56:58.862Z,1567695418.862 [DataOverHttps](INFO): Moved sent file to Logs/20190905T145412/Courier0000.lzma.bak 2019-09-05T14:56:58.863Z,1567695418.863 [DataOverHttps](INFO): SBD MOMSN=11743274 2019-09-05T14:57:01.410Z,1567695421.410 [CommandLine](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 600.000000 cubic_centimeter 2019-09-05T14:57:01.411Z,1567695421.411 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.buoyancyAction" handled in the control thread. 2019-09-05T14:57:01.654Z,1567695421.654 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,DropWeight,NAL9602,Onboard,FDI,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.buoyancyAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2019-09-05T14:57:07.352Z,1567695427.352 [Reporter](INFO): platform_buoyancy_position 962.366577 cc 2019-09-05T14:57:07.740Z,1567695427.740 [Reporter](INFO): platform_buoyancy_position 951.891235 cc 2019-09-05T14:57:08.132Z,1567695428.132 [Reporter](INFO): platform_buoyancy_position 951.756836 cc 2019-09-05T14:57:08.548Z,1567695428.548 [Reporter](INFO): platform_buoyancy_position 947.459229 cc 2019-09-05T14:57:08.940Z,1567695428.940 [Reporter](INFO): platform_buoyancy_position 945.041870 cc 2019-09-05T14:57:09.352Z,1567695429.352 [Reporter](INFO): platform_buoyancy_position 938.729736 cc 2019-09-05T14:57:09.416Z,1567695429.416 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20190809T170103/Express0107.lzma 2019-09-05T14:57:09.756Z,1567695429.756 [Reporter](INFO): platform_buoyancy_position 934.566528 cc 2019-09-05T14:57:10.160Z,1567695430.160 [Reporter](INFO): platform_buoyancy_position 929.865967 cc 2019-09-05T14:57:10.223Z,1567695430.223 [DataOverHttps](INFO): Moved sent file to Logs/20190809T170103/Express0107.lzma.bak 2019-09-05T14:57:10.223Z,1567695430.223 [DataOverHttps](INFO): SBD MOMSN=11743281 2019-09-05T14:57:10.576Z,1567695430.576 [Reporter](INFO): platform_buoyancy_position 923.688232 cc 2019-09-05T14:57:10.988Z,1567695430.988 [Reporter](INFO): platform_buoyancy_position 919.256226 cc 2019-09-05T14:57:11.376Z,1567695431.376 [Reporter](INFO): platform_buoyancy_position 913.078491 cc 2019-09-05T14:57:11.772Z,1567695431.772 [Reporter](INFO): platform_buoyancy_position 908.646606 cc 2019-09-05T14:57:12.176Z,1567695432.176 [Reporter](INFO): platform_buoyancy_position 902.200195 cc 2019-09-05T14:57:12.712Z,1567695432.712 [Reporter](INFO): platform_buoyancy_position 895.753784 cc 2019-09-05T14:57:13.020Z,1567695433.020 [Reporter](INFO): platform_buoyancy_position 891.456177 cc 2019-09-05T14:57:13.416Z,1567695433.416 [Reporter](INFO): platform_buoyancy_position 887.292847 cc 2019-09-05T14:57:13.800Z,1567695433.800 [Reporter](INFO): platform_buoyancy_position 880.846436 cc 2019-09-05T14:57:14.188Z,1567695434.188 [Reporter](INFO): platform_buoyancy_position 876.548828 cc 2019-09-05T14:57:14.600Z,1567695434.600 [Reporter](INFO): platform_buoyancy_position 870.773926 cc 2019-09-05T14:57:15.004Z,1567695435.004 [Reporter](INFO): platform_buoyancy_position 865.670532 cc 2019-09-05T14:57:15.408Z,1567695435.408 [Reporter](INFO): platform_buoyancy_position 861.238647 cc 2019-09-05T14:57:15.824Z,1567695435.824 [Reporter](INFO): platform_buoyancy_position 855.060913 cc 2019-09-05T14:57:16.228Z,1567695436.228 [Reporter](INFO): platform_buoyancy_position 849.554565 cc 2019-09-05T14:57:16.636Z,1567695436.636 [Reporter](INFO): platform_buoyancy_position 844.182617 cc 2019-09-05T14:57:17.040Z,1567695437.040 [Reporter](INFO): platform_buoyancy_position 839.482056 cc 2019-09-05T14:57:17.440Z,1567695437.440 [Reporter](INFO): platform_buoyancy_position 833.438599 cc 2019-09-05T14:57:17.828Z,1567695437.828 [Reporter](INFO): platform_buoyancy_position 829.140991 cc 2019-09-05T14:57:18.232Z,1567695438.232 [Reporter](INFO): platform_buoyancy_position 822.828857 cc 2019-09-05T14:57:18.636Z,1567695438.636 [Reporter](INFO): platform_buoyancy_position 818.396973 cc 2019-09-05T14:57:19.040Z,1567695439.040 [Reporter](INFO): platform_buoyancy_position 812.084900 cc 2019-09-05T14:57:19.452Z,1567695439.452 [Reporter](INFO): platform_buoyancy_position 807.652954 cc 2019-09-05T14:57:19.852Z,1567695439.852 [Reporter](INFO): platform_buoyancy_position 802.415283 cc 2019-09-05T14:57:20.384Z,1567695440.384 [Reporter](INFO): platform_buoyancy_position 794.894470 cc 2019-09-05T14:57:20.685Z,1567695440.685 [Reporter](INFO): platform_buoyancy_position 790.731201 cc 2019-09-05T14:57:21.088Z,1567695441.088 [Reporter](INFO): platform_buoyancy_position 786.164978 cc 2019-09-05T14:57:21.386Z,1567695441.386 [DataOverHttps](INFO): Sending 1033 bytes from file Logs/20190905T145412/Express0001.lzma 2019-09-05T14:57:21.517Z,1567695441.517 [Reporter](INFO): platform_buoyancy_position 779.852844 cc 2019-09-05T14:57:21.880Z,1567695441.880 [Reporter](INFO): platform_buoyancy_position 775.555298 cc 2019-09-05T14:57:22.190Z,1567695442.190 [DataOverHttps](INFO): Moved sent file to Logs/20190905T145412/Express0001.lzma.bak 2019-09-05T14:57:22.190Z,1567695442.190 [DataOverHttps](INFO): SBD MOMSN=11743284 2019-09-05T14:57:22.292Z,1567695442.292 [Reporter](INFO): platform_buoyancy_position 771.123352 cc 2019-09-05T14:57:22.712Z,1567695442.712 [Reporter](INFO): platform_buoyancy_position 764.811279 cc 2019-09-05T14:57:23.050Z,1567695443.050 [Startup:StartupSatComms:B] Stopped 2019-09-05T14:57:23.050Z,1567695443.050 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2019-09-05T14:57:23.050Z,1567695443.050 [Startup:StartupSatComms] Stopped 2019-09-05T14:57:23.051Z,1567695443.051 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2019-09-05T14:57:23.051Z,1567695443.051 [Startup](INFO): Completed Startup 2019-09-05T14:57:23.051Z,1567695443.051 [MissionManager](INFO): Startup is completed. 2019-09-05T14:57:23.052Z,1567695443.052 [MissionManager](INFO): Uninitializing Mission Startup 2019-09-05T14:57:23.052Z,1567695443.052 [Startup] Stopped 2019-09-05T14:57:23.052Z,1567695443.052 [Startup](DEBUG): Aggregate::uninitialize Startup 2019-09-05T14:57:23.052Z,1567695443.052 [Startup:A.GoToSurface] Stopped 2019-09-05T14:57:23.052Z,1567695443.052 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2019-09-05T14:57:23.097Z,1567695443.097 [Reporter](INFO): platform_buoyancy_position 760.379395 cc 2019-09-05T14:57:23.446Z,1567695443.446 [MissionManager](IMPORTANT): Started mission Default 2019-09-05T14:57:23.446Z,1567695443.446 [Default] Running Loop=1 2019-09-05T14:57:23.446Z,1567695443.446 [Default](DEBUG): Aggregate::initialize Default 2019-09-05T14:57:23.446Z,1567695443.446 [Default:B.GoToSurface] Running Loop=1 2019-09-05T14:57:23.446Z,1567695443.446 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2019-09-05T14:57:23.446Z,1567695443.446 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2019-09-05T14:57:23.447Z,1567695443.447 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2019-09-05T14:57:23.447Z,1567695443.447 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2019-09-05T14:57:23.447Z,1567695443.447 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2019-09-05T14:57:23.448Z,1567695443.448 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2019-09-05T14:57:23.448Z,1567695443.448 [Default:A.Wait] Running Loop=1 2019-09-05T14:57:23.448Z,1567695443.448 [Default:A.Wait](DEBUG): Initialize Wait Component. 2019-09-05T14:57:23.497Z,1567695443.497 [Reporter](INFO): platform_buoyancy_position 755.947449 cc 2019-09-05T14:57:23.898Z,1567695443.898 [Reporter](INFO): platform_buoyancy_position 749.769653 cc 2019-09-05T14:57:24.306Z,1567695444.306 [Reporter](INFO): platform_buoyancy_position 744.263367 cc 2019-09-05T14:57:24.696Z,1567695444.696 [Reporter](INFO): platform_buoyancy_position 738.891357 cc 2019-09-05T14:57:25.100Z,1567695445.100 [Reporter](INFO): platform_buoyancy_position 732.713562 cc 2019-09-05T14:57:25.505Z,1567695445.505 [Reporter](INFO): platform_buoyancy_position 728.147339 cc 2019-09-05T14:57:26.044Z,1567695446.044 [Reporter](INFO): platform_buoyancy_position 721.566650 cc 2019-09-05T14:57:26.361Z,1567695446.361 [Reporter](INFO): platform_buoyancy_position 717.403381 cc 2019-09-05T14:57:26.740Z,1567695446.740 [Reporter](INFO): platform_buoyancy_position 711.225586 cc 2019-09-05T14:57:27.148Z,1567695447.148 [Reporter](INFO): platform_buoyancy_position 706.659363 cc 2019-09-05T14:57:27.813Z,1567695447.813 [BuoyancyServo](ERROR): getPosition uart error serial timeout 2019-09-05T14:57:27.813Z,1567695447.813 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout 2019-09-05T14:57:27.813Z,1567695447.813 [BuoyancyServo] Communications Fault, FailCount= 1 2019-09-05T14:57:27.813Z,1567695447.813 [BuoyancyServo](ERROR): Communications Fault 2019-09-05T14:57:27.820Z,1567695447.820 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2019-09-05T14:57:29.510Z,1567695449.510 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2019-09-05T14:57:29.510Z,1567695449.510 [BuoyancyServo](INFO): Powering down 2019-09-05T14:57:30.337Z,1567695450.337 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2019-09-05T14:57:30.337Z,1567695450.337 [BuoyancyServo] No Fault, FailCount= 1 2019-09-05T14:57:30.722Z,1567695450.722 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2019-09-05T14:57:30.745Z,1567695450.745 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2019-09-05T14:57:34.003Z,1567695454.003 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-09-05T14:57:34.452Z,1567695454.452 [Reporter](INFO): platform_buoyancy_position 708.808167 cc 2019-09-05T14:57:34.808Z,1567695454.808 [Reporter](INFO): platform_buoyancy_position 708.405273 cc 2019-09-05T14:57:35.208Z,1567695455.208 [Reporter](INFO): platform_buoyancy_position 706.525085 cc 2019-09-05T14:57:35.608Z,1567695455.608 [Reporter](INFO): platform_buoyancy_position 698.198486 cc 2019-09-05T14:57:36.012Z,1567695456.012 [Reporter](INFO): platform_buoyancy_position 695.915344 cc 2019-09-05T14:57:36.420Z,1567695456.420 [Reporter](INFO): platform_buoyancy_position 691.617737 cc 2019-09-05T14:57:36.799Z,1567695456.799 [Default:A.Wait](INFO): Done Waiting. 2019-09-05T14:57:36.799Z,1567695456.799 [Default:A.Wait] Stopped 2019-09-05T14:57:36.799Z,1567695456.799 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2019-09-05T14:57:36.836Z,1567695456.836 [Reporter](INFO): platform_buoyancy_position 687.185852 cc 2019-09-05T14:57:37.194Z,1567695457.194 [Default:CheckIn] Running Loop=1 2019-09-05T14:57:37.194Z,1567695457.194 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-09-05T14:57:37.194Z,1567695457.194 [Default:CheckIn:Read_GPS] Running Loop=1 2019-09-05T14:57:37.236Z,1567695457.236 [Reporter](INFO): platform_buoyancy_position 682.351074 cc 2019-09-05T14:57:37.602Z,1567695457.602 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2019-09-05T14:57:37.645Z,1567695457.645 [Reporter](INFO): platform_buoyancy_position 676.710449 cc 2019-09-05T14:57:38.056Z,1567695458.056 [Reporter](INFO): platform_buoyancy_position 672.412842 cc 2019-09-05T14:57:38.428Z,1567695458.428 [Reporter](INFO): platform_buoyancy_position 666.100769 cc 2019-09-05T14:57:38.840Z,1567695458.840 [Reporter](INFO): platform_buoyancy_position 661.400269 cc 2019-09-05T14:57:39.248Z,1567695459.248 [Reporter](INFO): platform_buoyancy_position 655.222473 cc 2019-09-05T14:57:39.708Z,1567695459.708 [Reporter](INFO): platform_buoyancy_position 650.521973 cc 2019-09-05T14:57:40.073Z,1567695460.073 [Reporter](INFO): platform_buoyancy_position 644.344177 cc 2019-09-05T14:57:40.472Z,1567695460.472 [Reporter](INFO): platform_buoyancy_position 640.046570 cc 2019-09-05T14:57:40.873Z,1567695460.873 [Reporter](INFO): platform_buoyancy_position 635.346069 cc 2019-09-05T14:57:41.256Z,1567695461.256 [Reporter](INFO): platform_buoyancy_position 629.436890 cc 2019-09-05T14:57:41.668Z,1567695461.668 [Reporter](INFO): platform_buoyancy_position 625.139282 cc 2019-09-05T14:57:42.085Z,1567695462.085 [Reporter](INFO): platform_buoyancy_position 618.692871 cc 2019-09-05T14:57:42.485Z,1567695462.485 [Reporter](INFO): platform_buoyancy_position 614.395264 cc 2019-09-05T14:57:42.928Z,1567695462.928 [Reporter](INFO): platform_buoyancy_position 607.948853 cc 2019-09-05T14:58:23.652Z,1567695503.652 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-09-05T14:58:23.652Z,1567695503.652 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2019-09-05T14:58:23.652Z,1567695503.652 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-09-05T14:58:23.654Z,1567695503.654 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-09-05T14:58:23.654Z,1567695503.654 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2 2019-09-05T14:58:23.654Z,1567695503.654 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2019-09-05T14:58:23.666Z,1567695503.666 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-09-05T14:58:23.666Z,1567695503.666 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2019-09-05T14:58:24.071Z,1567695504.071 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-09-05T14:58:24.071Z,1567695504.071 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2019-09-05T14:58:24.071Z,1567695504.071 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2019-09-05T14:58:24.071Z,1567695504.071 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2 2019-09-05T14:58:24.466Z,1567695504.466 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2019-09-05T14:58:54.808Z,1567695534.808 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-09-05T14:59:07.728Z,1567695547.728 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-09-05T14:59:55.805Z,1567695595.805 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-09-05T15:00:05.830Z,1567695605.830 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2019-09-05T15:00:06.653Z,1567695606.653 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:00:11.097Z,1567695611.097 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:00:13.925Z,1567695613.925 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:00:17.157Z,1567695617.157 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:00:19.985Z,1567695619.985 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:00:23.217Z,1567695623.217 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:00:24.840Z,1567695624.840 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-09-05T15:00:24.840Z,1567695624.840 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2019-09-05T15:00:24.840Z,1567695624.840 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-09-05T15:00:24.842Z,1567695624.842 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-09-05T15:00:24.842Z,1567695624.842 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3 2019-09-05T15:00:24.842Z,1567695624.842 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2019-09-05T15:00:24.859Z,1567695624.859 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-09-05T15:00:24.859Z,1567695624.859 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2019-09-05T15:00:25.255Z,1567695625.255 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-09-05T15:00:25.255Z,1567695625.255 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2019-09-05T15:00:25.255Z,1567695625.255 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2019-09-05T15:00:25.255Z,1567695625.255 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3 2019-09-05T15:00:25.672Z,1567695625.672 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2019-09-05T15:00:26.049Z,1567695626.049 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:00:29.273Z,1567695629.273 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:00:32.105Z,1567695632.105 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:00:33.745Z,1567695633.745 [CBIT](INFO): Clearing failed state for component AHRS_M2 2019-09-05T15:00:33.745Z,1567695633.745 [AHRS_M2] No Fault, FailCount= 5 2019-09-05T15:00:34.105Z,1567695634.105 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2019-09-05T15:00:34.929Z,1567695634.929 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:00:37.661Z,1567695637.661 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:38.065Z,1567695638.065 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:38.465Z,1567695638.465 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:38.489Z,1567695638.489 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:00:38.933Z,1567695638.933 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:39.313Z,1567695639.313 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:39.717Z,1567695639.717 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:40.129Z,1567695640.129 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:40.533Z,1567695640.533 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:40.937Z,1567695640.937 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:40.957Z,1567695640.957 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:00:41.341Z,1567695641.341 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:41.769Z,1567695641.769 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:42.181Z,1567695642.181 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:42.617Z,1567695642.617 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:43.021Z,1567695643.021 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:43.425Z,1567695643.425 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:43.845Z,1567695643.845 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:44.257Z,1567695644.257 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:44.277Z,1567695644.277 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:00:44.661Z,1567695644.661 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:45.037Z,1567695645.037 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:45.441Z,1567695645.441 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:45.853Z,1567695645.853 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:46.257Z,1567695646.257 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:46.673Z,1567695646.673 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:47.077Z,1567695647.077 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:47.077Z,1567695647.077 [AHRS_M2](FAULT): Failed to initialize within timeout. 2019-09-05T15:00:47.077Z,1567695647.077 [AHRS_M2] Communications Fault, FailCount= 1 2019-09-05T15:00:47.077Z,1567695647.077 [AHRS_M2](ERROR): Communications Fault 2019-09-05T15:00:47.097Z,1567695647.097 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:00:47.132Z,1567695647.132 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2019-09-05T15:00:47.145Z,1567695647.145 [AHRS_M2](INFO): Powering down 2019-09-05T15:00:47.000Z,1567695648.000 [CBIT](INFO): Clearing failed state for component AHRS_M2 2019-09-05T15:00:47.000Z,1567695648.000 [AHRS_M2] No Fault, FailCount= 1 2019-09-05T15:00:48.357Z,1567695648.357 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2019-09-05T15:00:49.181Z,1567695649.181 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:00:51.913Z,1567695651.913 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:52.317Z,1567695652.317 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:52.337Z,1567695652.337 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:00:52.721Z,1567695652.721 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:53.129Z,1567695653.129 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:53.529Z,1567695653.529 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:53.941Z,1567695653.941 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:54.357Z,1567695654.357 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:54.742Z,1567695654.742 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:55.137Z,1567695655.137 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:55.157Z,1567695655.157 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:00:55.541Z,1567695655.541 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:55.945Z,1567695655.945 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:56.385Z,1567695656.385 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:56.793Z,1567695656.793 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:57.201Z,1567695657.201 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:57.597Z,1567695657.597 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:58.009Z,1567695658.009 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:58.029Z,1567695658.029 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:00:58.421Z,1567695658.421 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:58.837Z,1567695658.837 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:59.233Z,1567695659.233 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:00:59.625Z,1567695659.625 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:00.025Z,1567695660.025 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:00.433Z,1567695660.433 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:00.829Z,1567695660.829 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:01.237Z,1567695661.237 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:01.237Z,1567695661.237 [AHRS_M2](FAULT): Failed to initialize within timeout. 2019-09-05T15:01:01.237Z,1567695661.237 [AHRS_M2] Communications Fault, FailCount= 2 2019-09-05T15:01:01.237Z,1567695661.237 [AHRS_M2](ERROR): Communications Fault 2019-09-05T15:01:01.253Z,1567695661.253 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:01:01.284Z,1567695661.284 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2019-09-05T15:01:01.349Z,1567695661.349 [AHRS_M2](INFO): Powering down 2019-09-05T15:01:02.184Z,1567695662.184 [CBIT](INFO): Clearing failed state for component AHRS_M2 2019-09-05T15:01:02.184Z,1567695662.184 [AHRS_M2] No Fault, FailCount= 2 2019-09-05T15:01:02.529Z,1567695662.529 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2019-09-05T15:01:04.161Z,1567695664.161 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:01:06.077Z,1567695666.077 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:06.481Z,1567695666.481 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:06.885Z,1567695666.885 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:06.905Z,1567695666.905 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:01:07.289Z,1567695667.289 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:07.693Z,1567695667.693 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:08.105Z,1567695668.105 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:08.517Z,1567695668.517 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:08.933Z,1567695668.933 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:08.953Z,1567695668.953 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:01:09.329Z,1567695669.329 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:09.773Z,1567695669.773 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:10.209Z,1567695670.209 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:10.597Z,1567695670.597 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:11.013Z,1567695671.013 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:11.429Z,1567695671.429 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:11.817Z,1567695671.817 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:12.217Z,1567695672.217 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:12.245Z,1567695672.245 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:01:12.621Z,1567695672.621 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:13.025Z,1567695673.025 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:13.425Z,1567695673.425 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:13.833Z,1567695673.833 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:14.237Z,1567695674.237 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:14.657Z,1567695674.657 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:15.069Z,1567695675.069 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:15.089Z,1567695675.089 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:01:15.469Z,1567695675.469 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:15.469Z,1567695675.469 [AHRS_M2](FAULT): Failed to initialize within timeout. 2019-09-05T15:01:15.469Z,1567695675.469 [AHRS_M2] Communications Fault, FailCount= 3 2019-09-05T15:01:15.469Z,1567695675.469 [AHRS_M2](ERROR): Communications Fault 2019-09-05T15:01:15.523Z,1567695675.523 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2019-09-05T15:01:15.533Z,1567695675.533 [AHRS_M2](INFO): Powering down 2019-09-05T15:01:16.420Z,1567695676.420 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-09-05T15:01:16.436Z,1567695676.436 [CBIT](INFO): Clearing failed state for component AHRS_M2 2019-09-05T15:01:16.436Z,1567695676.436 [AHRS_M2] No Fault, FailCount= 3 2019-09-05T15:01:16.745Z,1567695676.745 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2019-09-05T15:01:17.169Z,1567695677.169 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:01:20.301Z,1567695680.301 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:20.321Z,1567695680.321 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:01:20.705Z,1567695680.705 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:21.109Z,1567695681.109 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:21.525Z,1567695681.525 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:21.933Z,1567695681.933 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:22.313Z,1567695682.313 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:22.717Z,1567695682.717 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:23.221Z,1567695683.221 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:23.237Z,1567695683.237 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:01:23.677Z,1567695683.677 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:24.065Z,1567695684.065 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:24.477Z,1567695684.477 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:24.885Z,1567695684.885 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:25.285Z,1567695685.285 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:25.689Z,1567695685.689 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:26.105Z,1567695686.105 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:26.125Z,1567695686.125 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:01:26.521Z,1567695686.521 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:26.961Z,1567695686.961 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:27.365Z,1567695687.365 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:27.773Z,1567695687.773 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:28.193Z,1567695688.193 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:28.597Z,1567695688.597 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:29.014Z,1567695689.014 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:29.029Z,1567695689.029 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:01:29.409Z,1567695689.409 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:29.865Z,1567695689.865 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:29.865Z,1567695689.865 [AHRS_M2](FAULT): Failed to initialize within timeout. 2019-09-05T15:01:29.865Z,1567695689.865 [AHRS_M2] Communications Fault, FailCount= 4 2019-09-05T15:01:29.865Z,1567695689.865 [AHRS_M2](ERROR): Communications Fault 2019-09-05T15:01:29.907Z,1567695689.907 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2019-09-05T15:01:29.946Z,1567695689.946 [BPC1](INFO): Received data from all battery sticks. 2019-09-05T15:01:29.980Z,1567695689.980 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2019-09-05T15:01:29.995Z,1567695689.995 [AHRS_M2](INFO): Powering down 2019-09-05T15:01:30.839Z,1567695690.839 [CBIT](INFO): Clearing failed state for component AHRS_M2 2019-09-05T15:01:30.839Z,1567695690.839 [AHRS_M2] No Fault, FailCount= 4 2019-09-05T15:01:31.205Z,1567695691.205 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2019-09-05T15:01:32.029Z,1567695692.029 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:01:34.761Z,1567695694.761 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:34.850Z,1567695694.850 [CommandLine](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 700.000000 cubic_centimeter 2019-09-05T15:01:35.157Z,1567695695.157 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-09-05T15:01:35.285Z,1567695695.285 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:01:36.021Z,1567695696.021 [BuoyancyServo](ERROR): getPosition uart error serial timeout 2019-09-05T15:01:36.021Z,1567695696.021 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout 2019-09-05T15:01:36.021Z,1567695696.021 [BuoyancyServo] Communications Fault, FailCount= 1 2019-09-05T15:01:36.021Z,1567695696.021 [BuoyancyServo](ERROR): Communications Fault 2019-09-05T15:01:36.027Z,1567695696.027 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2019-09-05T15:01:37.726Z,1567695697.726 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2019-09-05T15:01:37.726Z,1567695697.726 [BuoyancyServo](INFO): Powering down 2019-09-05T15:01:38.397Z,1567695698.397 [AHRS_M2](ERROR): Subscribe Accelerations UART error: serial timeout 2019-09-05T15:01:38.413Z,1567695698.413 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:01:38.801Z,1567695698.801 [AHRS_M2](ERROR): Subscribe Accelerations UART error: serial timeout 2019-09-05T15:01:38.879Z,1567695698.879 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2019-09-05T15:01:38.879Z,1567695698.879 [BuoyancyServo] No Fault, FailCount= 1 2019-09-05T15:01:39.201Z,1567695699.201 [AHRS_M2](ERROR): Subscribe Accelerations UART error: serial timeout 2019-09-05T15:01:39.245Z,1567695699.245 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2019-09-05T15:01:39.246Z,1567695699.246 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2019-09-05T15:01:40.945Z,1567695700.945 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:01:42.644Z,1567695702.644 [Reporter](INFO): platform_buoyancy_position 597.204834 cc 2019-09-05T15:01:43.084Z,1567695703.084 [Reporter](INFO): platform_buoyancy_position 597.473450 cc 2019-09-05T15:01:43.408Z,1567695703.408 [Reporter](INFO): platform_buoyancy_position 599.219360 cc 2019-09-05T15:01:44.169Z,1567695704.169 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:01:44.232Z,1567695704.232 [Reporter](INFO): platform_buoyancy_position 605.665771 cc 2019-09-05T15:01:44.644Z,1567695704.644 [Reporter](INFO): platform_buoyancy_position 610.231934 cc 2019-09-05T15:01:45.044Z,1567695705.044 [Reporter](INFO): platform_buoyancy_position 616.409790 cc 2019-09-05T15:01:45.436Z,1567695705.436 [Reporter](INFO): platform_buoyancy_position 620.841675 cc 2019-09-05T15:01:45.848Z,1567695705.848 [Reporter](INFO): platform_buoyancy_position 627.288086 cc 2019-09-05T15:01:46.236Z,1567695706.236 [Reporter](INFO): platform_buoyancy_position 631.451355 cc 2019-09-05T15:01:46.640Z,1567695706.640 [Reporter](INFO): platform_buoyancy_position 637.897766 cc 2019-09-05T15:01:46.997Z,1567695706.997 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:01:47.060Z,1567695707.060 [Reporter](INFO): platform_buoyancy_position 642.329651 cc 2019-09-05T15:01:47.460Z,1567695707.460 [Reporter](INFO): platform_buoyancy_position 648.641785 cc 2019-09-05T15:01:47.872Z,1567695707.872 [Reporter](INFO): platform_buoyancy_position 653.207947 cc 2019-09-05T15:01:48.268Z,1567695708.268 [Reporter](INFO): platform_buoyancy_position 659.385742 cc 2019-09-05T15:01:48.663Z,1567695708.663 [Reporter](INFO): platform_buoyancy_position 663.817688 cc 2019-09-05T15:01:49.076Z,1567695709.076 [Reporter](INFO): platform_buoyancy_position 669.861145 cc 2019-09-05T15:01:49.468Z,1567695709.468 [Reporter](INFO): platform_buoyancy_position 674.427368 cc 2019-09-05T15:01:49.872Z,1567695709.872 [Reporter](INFO): platform_buoyancy_position 680.873779 cc 2019-09-05T15:01:50.233Z,1567695710.233 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:01:50.292Z,1567695710.292 [Reporter](INFO): platform_buoyancy_position 685.574280 cc 2019-09-05T15:01:50.742Z,1567695710.742 [Reporter](INFO): platform_buoyancy_position 690.811951 cc 2019-09-05T15:01:51.421Z,1567695711.421 [AHRS_M2](FAULT): Failed to acquire valid data within timeout. 2019-09-05T15:01:51.421Z,1567695711.421 [AHRS_M2] Data Fault, FailCount= 5 2019-09-05T15:01:51.421Z,1567695711.421 [AHRS_M2](ERROR): Data Fault 2019-09-05T15:01:51.494Z,1567695711.494 [CBIT](ERROR): Data Fault in component: AHRS_M2 2019-09-05T15:01:51.495Z,1567695711.495 [CBIT](CRITICAL): Data Fault in component: AHRS_M2 2019-09-05T15:01:51.813Z,1567695711.813 [AHRS_M2](INFO): Powering down 2019-09-05T15:01:51.926Z,1567695711.926 [CBIT](INFO): Critical error at 20190905T150151 2019-09-05T15:01:53.041Z,1567695713.041 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:01:56.273Z,1567695716.273 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:01:59.105Z,1567695719.105 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:02:01.929Z,1567695721.929 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:02:05.161Z,1567695725.161 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:02:07.993Z,1567695727.993 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:02:11.224Z,1567695731.224 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:02:14.049Z,1567695734.049 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:02:16.877Z,1567695736.877 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:02:18.897Z,1567695738.897 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:02:20.917Z,1567695740.917 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:02:22.937Z,1567695742.937 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:02:25.769Z,1567695745.769 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-09-05T15:02:25.769Z,1567695745.769 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2019-09-05T15:02:25.769Z,1567695745.769 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-09-05T15:02:25.771Z,1567695745.771 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-09-05T15:02:25.771Z,1567695745.771 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4 2019-09-05T15:02:25.771Z,1567695745.771 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2019-09-05T15:02:25.783Z,1567695745.783 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-09-05T15:02:25.783Z,1567695745.783 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2019-09-05T15:02:26.173Z,1567695746.173 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:02:26.223Z,1567695746.223 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-09-05T15:02:26.223Z,1567695746.223 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2019-09-05T15:02:26.223Z,1567695746.223 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2019-09-05T15:02:26.223Z,1567695746.223 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4 2019-09-05T15:02:26.591Z,1567695746.591 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2019-09-05T15:02:29.001Z,1567695749.001 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:02:32.233Z,1567695752.233 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:02:35.061Z,1567695755.061 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:02:37.486Z,1567695757.486 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-09-05T14:57:37.2Z 2019-09-05T15:02:37.486Z,1567695757.486 [Default:CheckIn:Read_GPS] Stopped 2019-09-05T15:02:37.486Z,1567695757.486 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-09-05T15:02:37.889Z,1567695757.889 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:02:37.910Z,1567695757.910 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2019-09-05T15:02:39.905Z,1567695759.905 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:02:41.925Z,1567695761.925 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:02:42.561Z,1567695762.561 [DataOverHttps](INFO): Sending 224 bytes from file Logs/20190905T145412/Courier0004.lzma 2019-09-05T15:02:43.366Z,1567695763.366 [DataOverHttps](INFO): Moved sent file to Logs/20190905T145412/Courier0004.lzma.bak 2019-09-05T15:02:43.366Z,1567695763.366 [DataOverHttps](INFO): SBD MOMSN=11743328 2019-09-05T15:02:45.157Z,1567695765.157 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:02:47.985Z,1567695767.985 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:02:51.217Z,1567695771.217 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:02:53.517Z,1567695773.517 [DataOverHttps](INFO): Sending 491 bytes from file Logs/20190905T145412/Express0005.lzma 2019-09-05T15:02:54.049Z,1567695774.049 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:02:54.322Z,1567695774.322 [DataOverHttps](INFO): Moved sent file to Logs/20190905T145412/Express0005.lzma.bak 2019-09-05T15:02:54.323Z,1567695774.323 [DataOverHttps](INFO): SBD MOMSN=11743331 2019-09-05T15:02:55.276Z,1567695775.276 [Default:CheckIn:Read_Iridium] Stopped 2019-09-05T15:02:55.276Z,1567695775.276 [Default:CheckIn:C.Wait] Running Loop=1 2019-09-05T15:02:55.277Z,1567695775.277 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-09-05T15:02:57.277Z,1567695777.277 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:03:00.105Z,1567695780.105 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:03:02.933Z,1567695782.933 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:03:06.169Z,1567695786.169 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:03:08.993Z,1567695788.993 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:03:12.225Z,1567695792.225 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:03:15.053Z,1567695795.053 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:03:17.885Z,1567695797.885 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:03:19.905Z,1567695799.905 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:03:21.921Z,1567695801.921 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:03:25.157Z,1567695805.157 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:03:27.985Z,1567695807.985 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:03:31.217Z,1567695811.217 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:03:34.041Z,1567695814.041 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:03:37.273Z,1567695817.273 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:03:40.105Z,1567695820.105 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:03:42.929Z,1567695822.929 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:03:46.161Z,1567695826.161 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:03:48.989Z,1567695828.989 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:03:52.221Z,1567695832.221 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:03:55.049Z,1567695835.049 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:03:57.881Z,1567695837.881 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:03:59.897Z,1567695839.897 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:04:01.921Z,1567695841.921 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:04:03.941Z,1567695843.941 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:04:07.177Z,1567695847.177 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:04:09.997Z,1567695849.997 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:04:13.229Z,1567695853.229 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:04:16.057Z,1567695856.057 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:04:18.885Z,1567695858.885 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:04:20.905Z,1567695860.905 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:04:22.925Z,1567695862.925 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:04:26.157Z,1567695866.157 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:04:26.988Z,1567695866.988 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-09-05T15:04:26.988Z,1567695866.988 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2019-09-05T15:04:26.988Z,1567695866.988 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-09-05T15:04:26.990Z,1567695866.990 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-09-05T15:04:26.990Z,1567695866.990 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5 2019-09-05T15:04:26.990Z,1567695866.990 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2019-09-05T15:04:27.002Z,1567695867.002 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-09-05T15:04:27.002Z,1567695867.002 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2019-09-05T15:04:27.394Z,1567695867.394 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-09-05T15:04:27.394Z,1567695867.394 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2019-09-05T15:04:27.395Z,1567695867.395 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2019-09-05T15:04:27.395Z,1567695867.395 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5 2019-09-05T15:04:27.785Z,1567695867.785 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2019-09-05T15:04:28.989Z,1567695868.989 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:04:32.217Z,1567695872.217 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:04:35.045Z,1567695875.045 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:04:37.881Z,1567695877.881 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:04:39.897Z,1567695879.897 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:04:41.917Z,1567695881.917 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:04:43.937Z,1567695883.937 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:04:47.165Z,1567695887.165 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:04:49.993Z,1567695889.993 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:04:53.143Z,1567695893.143 [CommandLine](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 600.000000 cubic_centimeter 2019-09-05T15:04:53.229Z,1567695893.229 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:04:54.130Z,1567695894.130 [Reporter](INFO): platform_buoyancy_position 702.361755 cc 2019-09-05T15:04:54.480Z,1567695894.480 [Reporter](INFO): platform_buoyancy_position 702.496094 cc 2019-09-05T15:04:54.896Z,1567695894.896 [Reporter](INFO): platform_buoyancy_position 700.078674 cc 2019-09-05T15:04:55.300Z,1567695895.300 [Reporter](INFO): platform_buoyancy_position 690.811951 cc 2019-09-05T15:04:55.696Z,1567695895.696 [Reporter](INFO): platform_buoyancy_position 687.320190 cc 2019-09-05T15:04:56.053Z,1567695896.053 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:04:56.120Z,1567695896.120 [Reporter](INFO): platform_buoyancy_position 683.022583 cc 2019-09-05T15:04:56.524Z,1567695896.524 [Reporter](INFO): platform_buoyancy_position 678.724976 cc 2019-09-05T15:04:56.916Z,1567695896.916 [Reporter](INFO): platform_buoyancy_position 672.278564 cc 2019-09-05T15:04:57.316Z,1567695897.316 [Reporter](INFO): platform_buoyancy_position 667.980957 cc 2019-09-05T15:04:57.724Z,1567695897.724 [Reporter](INFO): platform_buoyancy_position 663.683350 cc 2019-09-05T15:04:58.120Z,1567695898.120 [Reporter](INFO): platform_buoyancy_position 657.371277 cc 2019-09-05T15:04:58.536Z,1567695898.536 [Reporter](INFO): platform_buoyancy_position 652.939392 cc 2019-09-05T15:04:58.881Z,1567695898.881 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:04:58.948Z,1567695898.948 [Reporter](INFO): platform_buoyancy_position 646.627258 cc 2019-09-05T15:04:59.356Z,1567695899.356 [Reporter](INFO): platform_buoyancy_position 642.195374 cc 2019-09-05T15:04:59.756Z,1567695899.756 [Reporter](INFO): platform_buoyancy_position 637.629150 cc 2019-09-05T15:05:00.165Z,1567695900.165 [Reporter](INFO): platform_buoyancy_position 631.585632 cc 2019-09-05T15:05:00.540Z,1567695900.540 [Reporter](INFO): platform_buoyancy_position 627.153748 cc 2019-09-05T15:05:00.901Z,1567695900.901 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:05:00.965Z,1567695900.965 [Reporter](INFO): platform_buoyancy_position 620.841675 cc 2019-09-05T15:05:01.372Z,1567695901.372 [Reporter](INFO): platform_buoyancy_position 616.409790 cc 2019-09-05T15:05:01.764Z,1567695901.764 [Reporter](INFO): platform_buoyancy_position 610.097656 cc 2019-09-05T15:05:02.204Z,1567695902.204 [Reporter](INFO): platform_buoyancy_position 605.665771 cc 2019-09-05T15:05:02.907Z,1567695902.907 [NAL9602](FAULT): GPS failed to acquire within timeout. 2019-09-05T15:05:02.907Z,1567695902.907 [NAL9602] Data Fault, FailCount= 1 2019-09-05T15:05:02.907Z,1567695902.907 [NAL9602](ERROR): Data Fault 2019-09-05T15:05:02.936Z,1567695902.936 [CBIT](ERROR): Data Fault in component: NAL9602 2019-09-05T15:05:03.314Z,1567695903.314 [NAL9602](INFO): Powering down 2019-09-05T15:05:04.286Z,1567695904.286 [CBIT](INFO): Clearing failed state for component NAL9602 2019-09-05T15:05:04.287Z,1567695904.287 [NAL9602] No Fault, FailCount= 1 2019-09-05T15:05:14.447Z,1567695914.447 [CommandLine](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 800.000000 cubic_centimeter 2019-09-05T15:05:15.528Z,1567695915.528 [Reporter](INFO): platform_buoyancy_position 603.516968 cc 2019-09-05T15:05:16.312Z,1567695916.312 [Reporter](INFO): platform_buoyancy_position 603.651245 cc 2019-09-05T15:05:17.116Z,1567695917.116 [Reporter](INFO): platform_buoyancy_position 607.948853 cc 2019-09-05T15:05:17.532Z,1567695917.532 [Reporter](INFO): platform_buoyancy_position 611.977844 cc 2019-09-05T15:05:17.920Z,1567695917.920 [Reporter](INFO): platform_buoyancy_position 618.558533 cc 2019-09-05T15:05:18.326Z,1567695918.326 [Reporter](INFO): platform_buoyancy_position 623.124756 cc 2019-09-05T15:05:18.728Z,1567695918.728 [Reporter](INFO): platform_buoyancy_position 629.436890 cc 2019-09-05T15:05:19.132Z,1567695919.132 [Reporter](INFO): platform_buoyancy_position 633.868774 cc 2019-09-05T15:05:19.540Z,1567695919.540 [Reporter](INFO): platform_buoyancy_position 638.166382 cc 2019-09-05T15:05:19.952Z,1567695919.952 [Reporter](INFO): platform_buoyancy_position 644.612732 cc 2019-09-05T15:05:20.345Z,1567695920.345 [Reporter](INFO): platform_buoyancy_position 650.790588 cc 2019-09-05T15:05:20.759Z,1567695920.759 [Reporter](INFO): platform_buoyancy_position 655.222473 cc 2019-09-05T15:05:21.152Z,1567695921.152 [Reporter](INFO): platform_buoyancy_position 661.534546 cc 2019-09-05T15:05:21.548Z,1567695921.548 [Reporter](INFO): platform_buoyancy_position 665.966492 cc 2019-09-05T15:05:21.960Z,1567695921.960 [Reporter](INFO): platform_buoyancy_position 670.801270 cc 2019-09-05T15:05:22.360Z,1567695922.360 [Reporter](INFO): platform_buoyancy_position 676.576172 cc 2019-09-05T15:05:22.772Z,1567695922.772 [Reporter](INFO): platform_buoyancy_position 682.485352 cc 2019-09-05T15:05:23.176Z,1567695923.176 [Reporter](INFO): platform_buoyancy_position 687.454468 cc 2019-09-05T15:05:23.592Z,1567695923.592 [Reporter](INFO): platform_buoyancy_position 692.289246 cc 2019-09-05T15:05:23.987Z,1567695923.987 [Reporter](INFO): platform_buoyancy_position 698.064148 cc 2019-09-05T15:05:24.409Z,1567695924.409 [Reporter](INFO): platform_buoyancy_position 702.496094 cc 2019-09-05T15:05:24.780Z,1567695924.780 [Reporter](INFO): platform_buoyancy_position 708.808167 cc 2019-09-05T15:05:25.204Z,1567695925.204 [Reporter](INFO): platform_buoyancy_position 713.642944 cc 2019-09-05T15:05:25.596Z,1567695925.596 [Reporter](INFO): platform_buoyancy_position 719.552185 cc 2019-09-05T15:05:26.004Z,1567695926.004 [Reporter](INFO): platform_buoyancy_position 723.849792 cc 2019-09-05T15:05:26.400Z,1567695926.400 [Reporter](INFO): platform_buoyancy_position 729.356079 cc 2019-09-05T15:05:26.816Z,1567695926.816 [Reporter](INFO): platform_buoyancy_position 734.593750 cc 2019-09-05T15:05:27.207Z,1567695927.207 [Reporter](INFO): platform_buoyancy_position 739.025696 cc 2019-09-05T15:05:27.624Z,1567695927.624 [Reporter](INFO): platform_buoyancy_position 745.472046 cc 2019-09-05T15:05:28.036Z,1567695928.036 [Reporter](INFO): platform_buoyancy_position 749.903992 cc 2019-09-05T15:05:28.424Z,1567695928.424 [Reporter](INFO): platform_buoyancy_position 756.081787 cc 2019-09-05T15:05:28.820Z,1567695928.820 [Reporter](INFO): platform_buoyancy_position 760.110779 cc 2019-09-05T15:05:29.228Z,1567695929.228 [Reporter](INFO): platform_buoyancy_position 764.945557 cc 2019-09-05T15:05:29.640Z,1567695929.640 [Reporter](INFO): platform_buoyancy_position 770.720459 cc 2019-09-05T15:05:30.044Z,1567695930.044 [Reporter](INFO): platform_buoyancy_position 775.555298 cc 2019-09-05T15:05:30.457Z,1567695930.457 [Reporter](INFO): platform_buoyancy_position 781.867371 cc 2019-09-05T15:05:33.611Z,1567695933.611 [NAL9602](INFO): Powering up NAL9602 2019-09-05T15:05:34.516Z,1567695934.516 [Reporter](INFO): platform_buoyancy_position 794.625854 cc 2019-09-05T15:05:44.526Z,1567695944.526 [NAL9602](INFO): NAL9602 initialized 2019-09-05T15:05:45.345Z,1567695945.345 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:05:48.169Z,1567695948.169 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:05:51.405Z,1567695951.405 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:05:54.229Z,1567695954.229 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:05:57.065Z,1567695957.065 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:05:59.077Z,1567695959.077 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:06:01.101Z,1567695961.101 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:06:04.329Z,1567695964.329 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:06:07.161Z,1567695967.161 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:06:10.393Z,1567695970.393 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:06:10.663Z,1567695970.663 [CommandLine](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 600.000000 cubic_centimeter 2019-09-05T15:06:13.221Z,1567695973.221 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:06:15.320Z,1567695975.320 [Reporter](INFO): platform_buoyancy_position 799.192078 cc 2019-09-05T15:06:16.045Z,1567695976.045 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:06:16.114Z,1567695976.114 [Reporter](INFO): platform_buoyancy_position 796.371765 cc 2019-09-05T15:06:16.528Z,1567695976.528 [Reporter](INFO): platform_buoyancy_position 786.299255 cc 2019-09-05T15:06:16.916Z,1567695976.916 [Reporter](INFO): platform_buoyancy_position 783.747559 cc 2019-09-05T15:06:17.312Z,1567695977.312 [Reporter](INFO): platform_buoyancy_position 779.718567 cc 2019-09-05T15:06:17.720Z,1567695977.720 [Reporter](INFO): platform_buoyancy_position 774.883789 cc 2019-09-05T15:06:18.065Z,1567695978.065 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:06:18.132Z,1567695978.132 [Reporter](INFO): platform_buoyancy_position 769.108887 cc 2019-09-05T15:06:18.540Z,1567695978.540 [Reporter](INFO): platform_buoyancy_position 764.676941 cc 2019-09-05T15:06:18.948Z,1567695978.948 [Reporter](INFO): platform_buoyancy_position 760.513672 cc 2019-09-05T15:06:19.340Z,1567695979.340 [Reporter](INFO): platform_buoyancy_position 753.932983 cc 2019-09-05T15:06:19.732Z,1567695979.732 [Reporter](INFO): platform_buoyancy_position 749.501099 cc 2019-09-05T15:06:20.089Z,1567695980.089 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:06:20.178Z,1567695980.178 [Reporter](INFO): platform_buoyancy_position 743.188965 cc 2019-09-05T15:06:20.556Z,1567695980.556 [Reporter](INFO): platform_buoyancy_position 737.011169 cc 2019-09-05T15:06:20.956Z,1567695980.956 [Reporter](INFO): platform_buoyancy_position 732.579285 cc 2019-09-05T15:06:21.352Z,1567695981.352 [Reporter](INFO): platform_buoyancy_position 728.147339 cc 2019-09-05T15:06:21.768Z,1567695981.768 [Reporter](INFO): platform_buoyancy_position 721.835266 cc 2019-09-05T15:06:22.156Z,1567695982.156 [Reporter](INFO): platform_buoyancy_position 717.403381 cc 2019-09-05T15:06:22.593Z,1567695982.593 [Reporter](INFO): platform_buoyancy_position 710.956970 cc 2019-09-05T15:06:22.982Z,1567695982.982 [Reporter](INFO): platform_buoyancy_position 706.659363 cc 2019-09-05T15:06:23.317Z,1567695983.317 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:06:23.396Z,1567695983.396 [Reporter](INFO): platform_buoyancy_position 700.347290 cc 2019-09-05T15:06:23.821Z,1567695983.821 [Reporter](INFO): platform_buoyancy_position 694.840942 cc 2019-09-05T15:06:24.189Z,1567695984.189 [Reporter](INFO): platform_buoyancy_position 689.468994 cc 2019-09-05T15:06:24.584Z,1567695984.584 [Reporter](INFO): platform_buoyancy_position 685.171387 cc 2019-09-05T15:06:24.992Z,1567695984.992 [Reporter](INFO): platform_buoyancy_position 678.859253 cc 2019-09-05T15:06:25.408Z,1567695985.408 [Reporter](INFO): platform_buoyancy_position 674.427368 cc 2019-09-05T15:06:25.800Z,1567695985.800 [Reporter](INFO): platform_buoyancy_position 668.115234 cc 2019-09-05T15:06:26.149Z,1567695986.149 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:06:26.221Z,1567695986.221 [Reporter](INFO): platform_buoyancy_position 663.817688 cc 2019-09-05T15:06:26.632Z,1567695986.632 [Reporter](INFO): platform_buoyancy_position 659.251465 cc 2019-09-05T15:06:27.020Z,1567695987.020 [Reporter](INFO): platform_buoyancy_position 652.939392 cc 2019-09-05T15:06:27.416Z,1567695987.416 [Reporter](INFO): platform_buoyancy_position 648.641785 cc 2019-09-05T15:06:27.812Z,1567695987.812 [Reporter](INFO): platform_buoyancy_position 642.463989 cc 2019-09-05T15:06:28.184Z,1567695988.184 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-09-05T15:06:28.184Z,1567695988.184 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2019-09-05T15:06:28.184Z,1567695988.184 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-09-05T15:06:28.185Z,1567695988.185 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-09-05T15:06:28.185Z,1567695988.185 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6 2019-09-05T15:06:28.186Z,1567695988.186 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2019-09-05T15:06:28.223Z,1567695988.223 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-09-05T15:06:28.223Z,1567695988.223 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2019-09-05T15:06:28.225Z,1567695988.225 [Reporter](INFO): platform_buoyancy_position 637.897766 cc 2019-09-05T15:06:28.631Z,1567695988.631 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-09-05T15:06:28.631Z,1567695988.631 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2019-09-05T15:06:28.631Z,1567695988.631 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2019-09-05T15:06:28.631Z,1567695988.631 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6 2019-09-05T15:06:28.633Z,1567695988.633 [Reporter](INFO): platform_buoyancy_position 631.585632 cc 2019-09-05T15:06:28.984Z,1567695988.984 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2019-09-05T15:06:29.025Z,1567695989.025 [Reporter](INFO): platform_buoyancy_position 627.288086 cc 2019-09-05T15:06:29.377Z,1567695989.377 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:06:29.444Z,1567695989.444 [Reporter](INFO): platform_buoyancy_position 621.110291 cc 2019-09-05T15:06:29.859Z,1567695989.859 [Reporter](INFO): platform_buoyancy_position 616.409790 cc 2019-09-05T15:06:30.268Z,1567695990.268 [Reporter](INFO): platform_buoyancy_position 611.709290 cc 2019-09-05T15:06:30.691Z,1567695990.691 [Reporter](INFO): platform_buoyancy_position 605.934387 cc 2019-09-05T15:06:32.209Z,1567695992.209 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:06:35.437Z,1567695995.437 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:06:38.269Z,1567695998.269 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:06:38.767Z,1567695998.767 [CommandLine](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 800.000000 cubic_centimeter 2019-09-05T15:06:39.972Z,1567695999.972 [Reporter](INFO): platform_buoyancy_position 603.516968 cc 2019-09-05T15:06:40.340Z,1567696000.340 [Reporter](INFO): platform_buoyancy_position 603.651245 cc 2019-09-05T15:06:41.097Z,1567696001.097 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:06:41.157Z,1567696001.157 [Reporter](INFO): platform_buoyancy_position 601.905334 cc 2019-09-05T15:06:41.564Z,1567696001.564 [Reporter](INFO): platform_buoyancy_position 607.680237 cc 2019-09-05T15:06:41.965Z,1567696001.965 [Reporter](INFO): platform_buoyancy_position 612.246460 cc 2019-09-05T15:06:42.360Z,1567696002.360 [Reporter](INFO): platform_buoyancy_position 616.544067 cc 2019-09-05T15:06:42.764Z,1567696002.764 [Reporter](INFO): platform_buoyancy_position 622.721863 cc 2019-09-05T15:06:43.180Z,1567696003.180 [Reporter](INFO): platform_buoyancy_position 627.288086 cc 2019-09-05T15:06:43.572Z,1567696003.572 [Reporter](INFO): platform_buoyancy_position 631.719971 cc 2019-09-05T15:06:43.972Z,1567696003.972 [Reporter](INFO): platform_buoyancy_position 637.763489 cc 2019-09-05T15:06:44.325Z,1567696004.325 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:06:44.388Z,1567696004.388 [Reporter](INFO): platform_buoyancy_position 642.329651 cc 2019-09-05T15:06:44.792Z,1567696004.792 [Reporter](INFO): platform_buoyancy_position 648.373169 cc 2019-09-05T15:06:45.200Z,1567696005.200 [Reporter](INFO): platform_buoyancy_position 653.476562 cc 2019-09-05T15:06:45.596Z,1567696005.596 [Reporter](INFO): platform_buoyancy_position 659.654358 cc 2019-09-05T15:06:45.992Z,1567696005.992 [Reporter](INFO): platform_buoyancy_position 663.817688 cc 2019-09-05T15:06:46.404Z,1567696006.404 [Reporter](INFO): platform_buoyancy_position 669.323975 cc 2019-09-05T15:06:46.820Z,1567696006.820 [Reporter](INFO): platform_buoyancy_position 674.561646 cc 2019-09-05T15:06:47.157Z,1567696007.157 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:06:47.240Z,1567696007.240 [Reporter](INFO): platform_buoyancy_position 680.605164 cc 2019-09-05T15:06:47.620Z,1567696007.620 [Reporter](INFO): platform_buoyancy_position 685.439941 cc 2019-09-05T15:06:48.020Z,1567696008.020 [Reporter](INFO): platform_buoyancy_position 691.080566 cc 2019-09-05T15:06:48.412Z,1567696008.412 [Reporter](INFO): platform_buoyancy_position 695.781067 cc 2019-09-05T15:06:48.824Z,1567696008.824 [Reporter](INFO): platform_buoyancy_position 700.884460 cc 2019-09-05T15:06:49.240Z,1567696009.240 [Reporter](INFO): platform_buoyancy_position 706.525085 cc 2019-09-05T15:06:49.640Z,1567696009.640 [Reporter](INFO): platform_buoyancy_position 711.494141 cc 2019-09-05T15:06:50.044Z,1567696010.044 [Reporter](INFO): platform_buoyancy_position 717.134766 cc 2019-09-05T15:06:50.385Z,1567696010.385 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:06:50.466Z,1567696010.466 [Reporter](INFO): platform_buoyancy_position 721.969543 cc 2019-09-05T15:06:50.852Z,1567696010.852 [Reporter](INFO): platform_buoyancy_position 727.878784 cc 2019-09-05T15:06:51.256Z,1567696011.256 [Reporter](INFO): platform_buoyancy_position 732.579285 cc 2019-09-05T15:06:51.655Z,1567696011.655 [CBIT](INFO): Clearing failed state for component AHRS_M2 2019-09-05T15:06:51.655Z,1567696011.655 [AHRS_M2] No Fault, FailCount= 5 2019-09-05T15:06:51.656Z,1567696011.656 [Reporter](INFO): platform_buoyancy_position 738.219849 cc 2019-09-05T15:06:51.985Z,1567696011.985 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2019-09-05T15:06:52.064Z,1567696012.064 [Reporter](INFO): platform_buoyancy_position 743.457581 cc 2019-09-05T15:06:52.468Z,1567696012.468 [Reporter](INFO): platform_buoyancy_position 747.620850 cc 2019-09-05T15:06:52.860Z,1567696012.860 [Reporter](INFO): platform_buoyancy_position 753.932983 cc 2019-09-05T15:06:53.217Z,1567696013.217 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:06:53.284Z,1567696013.284 [Reporter](INFO): platform_buoyancy_position 758.364868 cc 2019-09-05T15:06:53.689Z,1567696013.689 [Reporter](INFO): platform_buoyancy_position 762.528198 cc 2019-09-05T15:06:54.084Z,1567696014.084 [Reporter](INFO): platform_buoyancy_position 767.900146 cc 2019-09-05T15:06:54.468Z,1567696014.468 [Reporter](INFO): platform_buoyancy_position 773.406494 cc 2019-09-05T15:06:54.876Z,1567696014.876 [Reporter](INFO): platform_buoyancy_position 779.584290 cc 2019-09-05T15:06:55.541Z,1567696015.541 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:06:55.945Z,1567696015.945 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:06:56.345Z,1567696016.345 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:06:56.365Z,1567696016.365 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:06:56.741Z,1567696016.741 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:06:57.209Z,1567696017.209 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:06:57.605Z,1567696017.605 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:06:58.013Z,1567696018.013 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:06:58.417Z,1567696018.417 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:06:58.821Z,1567696018.821 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:06:59.225Z,1567696019.225 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:06:59.245Z,1567696019.245 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:06:59.349Z,1567696019.349 [Reporter](INFO): platform_buoyancy_position 792.611389 cc 2019-09-05T15:06:59.681Z,1567696019.681 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:00.077Z,1567696020.077 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:00.485Z,1567696020.485 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:00.889Z,1567696020.889 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:01.293Z,1567696021.293 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:01.809Z,1567696021.809 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:02.229Z,1567696022.229 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:02.245Z,1567696022.245 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:07:02.609Z,1567696022.609 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:03.017Z,1567696023.017 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:03.437Z,1567696023.437 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:03.829Z,1567696023.829 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:04.225Z,1567696024.225 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:04.649Z,1567696024.649 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:05.057Z,1567696025.057 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:05.057Z,1567696025.057 [AHRS_M2](FAULT): Failed to initialize within timeout. 2019-09-05T15:07:05.057Z,1567696025.057 [AHRS_M2] Communications Fault, FailCount= 1 2019-09-05T15:07:05.057Z,1567696025.057 [AHRS_M2](ERROR): Communications Fault 2019-09-05T15:07:05.077Z,1567696025.077 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:07:05.107Z,1567696025.107 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2019-09-05T15:07:05.161Z,1567696025.161 [AHRS_M2](INFO): Powering down 2019-09-05T15:07:05.270Z,1567696025.270 [CommandLine](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 600.000000 cubic_centimeter 2019-09-05T15:07:06.033Z,1567696026.033 [BuoyancyServo](FAULT): Reading outside of valid range:0.000000 2019-09-05T15:07:06.033Z,1567696026.033 [BuoyancyServo](FAULT): Buoyancy engine reporting null position 2019-09-05T15:07:06.033Z,1567696026.033 [BuoyancyServo] Hardware Fault, FailCount= 1 2019-09-05T15:07:06.033Z,1567696026.033 [BuoyancyServo](ERROR): Hardware Fault 2019-09-05T15:07:06.039Z,1567696026.039 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo 2019-09-05T15:07:06.040Z,1567696026.040 [CBIT](INFO): Clearing failed state for component AHRS_M2 2019-09-05T15:07:06.040Z,1567696026.040 [AHRS_M2] No Fault, FailCount= 1 2019-09-05T15:07:06.337Z,1567696026.337 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2019-09-05T15:07:07.165Z,1567696027.165 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:07:08.006Z,1567696028.006 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2019-09-05T15:07:08.006Z,1567696028.006 [BuoyancyServo](INFO): Powering down 2019-09-05T15:07:08.803Z,1567696028.803 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2019-09-05T15:07:08.804Z,1567696028.804 [BuoyancyServo] No Fault, FailCount= 1 2019-09-05T15:07:09.202Z,1567696029.202 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2019-09-05T15:07:09.209Z,1567696029.209 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2019-09-05T15:07:09.893Z,1567696029.893 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:10.297Z,1567696030.297 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:10.769Z,1567696030.769 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:10.785Z,1567696030.785 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:07:11.173Z,1567696031.173 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:11.553Z,1567696031.553 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:11.957Z,1567696031.957 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:12.361Z,1567696032.361 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:12.773Z,1567696032.773 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:13.177Z,1567696033.177 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:13.197Z,1567696033.197 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:07:13.581Z,1567696033.581 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:14.037Z,1567696034.037 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:14.429Z,1567696034.429 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:14.841Z,1567696034.841 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:15.257Z,1567696035.257 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:15.673Z,1567696035.673 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:16.077Z,1567696036.077 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:16.097Z,1567696036.097 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:07:16.196Z,1567696036.196 [Reporter](INFO): platform_buoyancy_position 797.043274 cc 2019-09-05T15:07:16.517Z,1567696036.517 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:16.600Z,1567696036.600 [Reporter](INFO): platform_buoyancy_position 796.908997 cc 2019-09-05T15:07:16.929Z,1567696036.929 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:17.012Z,1567696037.012 [Reporter](INFO): platform_buoyancy_position 792.611389 cc 2019-09-05T15:07:17.341Z,1567696037.341 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:17.427Z,1567696037.427 [Reporter](INFO): platform_buoyancy_position 784.016174 cc 2019-09-05T15:07:17.769Z,1567696037.769 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:17.844Z,1567696037.844 [Reporter](INFO): platform_buoyancy_position 779.852844 cc 2019-09-05T15:07:18.177Z,1567696038.177 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:18.256Z,1567696038.256 [Reporter](INFO): platform_buoyancy_position 775.420959 cc 2019-09-05T15:07:18.593Z,1567696038.593 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:18.671Z,1567696038.671 [Reporter](INFO): platform_buoyancy_position 771.123352 cc 2019-09-05T15:07:19.001Z,1567696039.001 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:19.060Z,1567696039.060 [Reporter](INFO): platform_buoyancy_position 766.960083 cc 2019-09-05T15:07:19.409Z,1567696039.409 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:19.409Z,1567696039.409 [AHRS_M2](FAULT): Failed to initialize within timeout. 2019-09-05T15:07:19.409Z,1567696039.409 [AHRS_M2] Communications Fault, FailCount= 2 2019-09-05T15:07:19.409Z,1567696039.409 [AHRS_M2](ERROR): Communications Fault 2019-09-05T15:07:19.429Z,1567696039.429 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:07:19.518Z,1567696039.518 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2019-09-05T15:07:19.520Z,1567696039.520 [Reporter](INFO): platform_buoyancy_position 762.393860 cc 2019-09-05T15:07:19.526Z,1567696039.526 [AHRS_M2](INFO): Powering down 2019-09-05T15:07:19.680Z,1567696039.680 [Reporter](INFO): platform_buoyancy_position 760.110779 cc 2019-09-05T15:07:20.023Z,1567696040.023 [Reporter](INFO): platform_buoyancy_position 754.201599 cc 2019-09-05T15:07:20.403Z,1567696040.403 [CBIT](INFO): Clearing failed state for component AHRS_M2 2019-09-05T15:07:20.403Z,1567696040.403 [AHRS_M2] No Fault, FailCount= 2 2019-09-05T15:07:20.404Z,1567696040.404 [Reporter](INFO): platform_buoyancy_position 749.501099 cc 2019-09-05T15:07:20.737Z,1567696040.737 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2019-09-05T15:07:20.808Z,1567696040.808 [Reporter](INFO): platform_buoyancy_position 743.457581 cc 2019-09-05T15:07:21.216Z,1567696041.216 [Reporter](INFO): platform_buoyancy_position 738.891357 cc 2019-09-05T15:07:21.616Z,1567696041.616 [Reporter](INFO): platform_buoyancy_position 732.444946 cc 2019-09-05T15:07:22.028Z,1567696042.028 [Reporter](INFO): platform_buoyancy_position 728.147339 cc 2019-09-05T15:07:22.369Z,1567696042.369 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:07:22.448Z,1567696042.448 [Reporter](INFO): platform_buoyancy_position 721.835266 cc 2019-09-05T15:07:22.836Z,1567696042.836 [Reporter](INFO): platform_buoyancy_position 717.403381 cc 2019-09-05T15:07:23.252Z,1567696043.252 [Reporter](INFO): platform_buoyancy_position 710.956970 cc 2019-09-05T15:07:23.625Z,1567696043.625 [Reporter](INFO): platform_buoyancy_position 706.659363 cc 2019-09-05T15:07:24.293Z,1567696044.293 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:24.360Z,1567696044.360 [Reporter](INFO): platform_buoyancy_position 697.795593 cc 2019-09-05T15:07:24.717Z,1567696044.717 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:24.776Z,1567696044.776 [Reporter](INFO): platform_buoyancy_position 691.617737 cc 2019-09-05T15:07:25.101Z,1567696045.101 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:25.117Z,1567696045.117 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:07:25.180Z,1567696045.180 [Reporter](INFO): platform_buoyancy_position 687.051575 cc 2019-09-05T15:07:25.509Z,1567696045.509 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:25.592Z,1567696045.592 [Reporter](INFO): platform_buoyancy_position 681.008057 cc 2019-09-05T15:07:25.921Z,1567696045.921 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:25.996Z,1567696045.996 [Reporter](INFO): platform_buoyancy_position 676.441895 cc 2019-09-05T15:07:26.317Z,1567696046.317 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:26.400Z,1567696046.400 [Reporter](INFO): platform_buoyancy_position 670.264038 cc 2019-09-05T15:07:26.721Z,1567696046.721 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:26.796Z,1567696046.796 [Reporter](INFO): platform_buoyancy_position 665.697876 cc 2019-09-05T15:07:27.125Z,1567696047.125 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:27.200Z,1567696047.200 [Reporter](INFO): platform_buoyancy_position 659.385742 cc 2019-09-05T15:07:27.541Z,1567696047.541 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:27.619Z,1567696047.619 [Reporter](INFO): platform_buoyancy_position 653.073669 cc 2019-09-05T15:07:27.949Z,1567696047.949 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:28.297Z,1567696048.297 [BuoyancyServo](ERROR): getPosition uart error serial timeout 2019-09-05T15:07:28.297Z,1567696048.297 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout 2019-09-05T15:07:28.297Z,1567696048.297 [BuoyancyServo] Communications Fault, FailCount= 2 2019-09-05T15:07:28.297Z,1567696048.297 [BuoyancyServo](ERROR): Communications Fault 2019-09-05T15:07:28.303Z,1567696048.303 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2019-09-05T15:07:28.629Z,1567696048.629 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:28.645Z,1567696048.645 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:07:29.033Z,1567696049.033 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:29.437Z,1567696049.437 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:29.841Z,1567696049.841 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:30.245Z,1567696050.245 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:30.286Z,1567696050.286 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2019-09-05T15:07:30.286Z,1567696050.286 [BuoyancyServo](INFO): Powering down 2019-09-05T15:07:30.753Z,1567696050.753 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:31.173Z,1567696051.173 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:31.193Z,1567696051.193 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:07:31.224Z,1567696051.224 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2019-09-05T15:07:31.224Z,1567696051.224 [BuoyancyServo] No Fault, FailCount= 2 2019-09-05T15:07:31.565Z,1567696051.565 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:31.618Z,1567696051.618 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2019-09-05T15:07:31.619Z,1567696051.619 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2019-09-05T15:07:31.961Z,1567696051.961 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:32.357Z,1567696052.357 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:32.761Z,1567696052.761 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:33.205Z,1567696053.205 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:33.605Z,1567696053.605 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:33.605Z,1567696053.605 [AHRS_M2](FAULT): Failed to initialize within timeout. 2019-09-05T15:07:33.605Z,1567696053.605 [AHRS_M2] Communications Fault, FailCount= 3 2019-09-05T15:07:33.605Z,1567696053.605 [AHRS_M2](ERROR): Communications Fault 2019-09-05T15:07:33.654Z,1567696053.654 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2019-09-05T15:07:33.688Z,1567696053.688 [AHRS_M2](INFO): Powering down 2019-09-05T15:07:34.105Z,1567696054.105 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:07:34.562Z,1567696054.562 [CBIT](INFO): Clearing failed state for component AHRS_M2 2019-09-05T15:07:34.562Z,1567696054.562 [AHRS_M2] No Fault, FailCount= 3 2019-09-05T15:07:34.897Z,1567696054.897 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2019-09-05T15:07:37.341Z,1567696057.341 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:07:38.453Z,1567696058.453 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:38.869Z,1567696058.869 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:39.277Z,1567696059.277 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:39.381Z,1567696059.381 [Reporter](INFO): platform_buoyancy_position 654.953857 cc 2019-09-05T15:07:39.713Z,1567696059.713 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:39.780Z,1567696059.780 [Reporter](INFO): platform_buoyancy_position 655.222473 cc 2019-09-05T15:07:40.121Z,1567696060.121 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:40.141Z,1567696060.141 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:07:40.212Z,1567696060.212 [Reporter](INFO): platform_buoyancy_position 653.073669 cc 2019-09-05T15:07:40.545Z,1567696060.545 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:40.628Z,1567696060.628 [Reporter](INFO): platform_buoyancy_position 648.641785 cc 2019-09-05T15:07:40.965Z,1567696060.965 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:41.044Z,1567696061.044 [Reporter](INFO): platform_buoyancy_position 646.895874 cc 2019-09-05T15:07:41.365Z,1567696061.365 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:41.432Z,1567696061.432 [Reporter](INFO): platform_buoyancy_position 646.627258 cc 2019-09-05T15:07:41.777Z,1567696061.777 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:42.201Z,1567696062.201 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:42.264Z,1567696062.264 [Reporter](INFO): platform_buoyancy_position 646.492981 cc 2019-09-05T15:07:42.601Z,1567696062.601 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:42.672Z,1567696062.672 [Reporter](INFO): platform_buoyancy_position 644.478455 cc 2019-09-05T15:07:43.033Z,1567696063.033 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:43.116Z,1567696063.116 [Reporter](INFO): platform_buoyancy_position 644.209839 cc 2019-09-05T15:07:43.453Z,1567696063.453 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:43.469Z,1567696063.469 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:07:43.536Z,1567696063.536 [Reporter](INFO): platform_buoyancy_position 642.195374 cc 2019-09-05T15:07:43.873Z,1567696063.873 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:43.956Z,1567696063.956 [Reporter](INFO): platform_buoyancy_position 640.046570 cc 2019-09-05T15:07:44.301Z,1567696064.301 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:44.376Z,1567696064.376 [Reporter](INFO): platform_buoyancy_position 640.180847 cc 2019-09-05T15:07:44.705Z,1567696064.705 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:44.778Z,1567696064.778 [Reporter](INFO): platform_buoyancy_position 638.032043 cc 2019-09-05T15:07:45.117Z,1567696065.117 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:45.202Z,1567696065.202 [Reporter](INFO): platform_buoyancy_position 635.883240 cc 2019-09-05T15:07:45.533Z,1567696065.533 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:45.945Z,1567696065.945 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:46.036Z,1567696066.036 [Reporter](INFO): platform_buoyancy_position 633.600159 cc 2019-09-05T15:07:46.357Z,1567696066.357 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:46.377Z,1567696066.377 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:07:46.452Z,1567696066.452 [Reporter](INFO): platform_buoyancy_position 631.585632 cc 2019-09-05T15:07:46.781Z,1567696066.781 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:46.868Z,1567696066.868 [Reporter](INFO): platform_buoyancy_position 631.451355 cc 2019-09-05T15:07:47.197Z,1567696067.197 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:47.280Z,1567696067.280 [Reporter](INFO): platform_buoyancy_position 629.436890 cc 2019-09-05T15:07:47.617Z,1567696067.617 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:47.689Z,1567696067.689 [Reporter](INFO): platform_buoyancy_position 628.765381 cc 2019-09-05T15:07:48.025Z,1567696068.025 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:48.025Z,1567696068.025 [AHRS_M2](FAULT): Failed to initialize within timeout. 2019-09-05T15:07:48.025Z,1567696068.025 [AHRS_M2] Communications Fault, FailCount= 4 2019-09-05T15:07:48.025Z,1567696068.025 [AHRS_M2](ERROR): Communications Fault 2019-09-05T15:07:48.115Z,1567696068.115 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2019-09-05T15:07:48.116Z,1567696068.116 [Reporter](INFO): platform_buoyancy_position 627.288086 cc 2019-09-05T15:07:48.121Z,1567696068.121 [AHRS_M2](INFO): Powering down 2019-09-05T15:07:48.260Z,1567696068.260 [Reporter](INFO): platform_buoyancy_position 627.019470 cc 2019-09-05T15:07:48.596Z,1567696068.596 [Reporter](INFO): platform_buoyancy_position 625.004944 cc 2019-09-05T15:07:48.995Z,1567696068.995 [CBIT](INFO): Clearing failed state for component AHRS_M2 2019-09-05T15:07:48.995Z,1567696068.995 [AHRS_M2] No Fault, FailCount= 4 2019-09-05T15:07:48.996Z,1567696068.996 [Reporter](INFO): platform_buoyancy_position 623.527649 cc 2019-09-05T15:07:49.333Z,1567696069.333 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2019-09-05T15:07:49.357Z,1567696069.357 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:07:49.416Z,1567696069.416 [Reporter](INFO): platform_buoyancy_position 622.990479 cc 2019-09-05T15:07:49.820Z,1567696069.820 [Reporter](INFO): platform_buoyancy_position 620.841675 cc 2019-09-05T15:07:50.224Z,1567696070.224 [Reporter](INFO): platform_buoyancy_position 620.304443 cc 2019-09-05T15:07:50.601Z,1567696070.601 [Reporter](INFO): platform_buoyancy_position 618.558533 cc 2019-09-05T15:07:51.025Z,1567696071.025 [Reporter](INFO): platform_buoyancy_position 616.812683 cc 2019-09-05T15:07:51.439Z,1567696071.439 [Reporter](INFO): platform_buoyancy_position 616.409790 cc 2019-09-05T15:07:51.824Z,1567696071.824 [Reporter](INFO): platform_buoyancy_position 614.260986 cc 2019-09-05T15:07:52.181Z,1567696072.181 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:07:52.878Z,1567696072.878 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:52.960Z,1567696072.960 [Reporter](INFO): platform_buoyancy_position 610.769165 cc 2019-09-05T15:07:53.289Z,1567696073.289 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:53.380Z,1567696073.380 [Reporter](INFO): platform_buoyancy_position 609.963379 cc 2019-09-05T15:07:53.701Z,1567696073.701 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:54.113Z,1567696074.113 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:54.513Z,1567696074.513 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:54.921Z,1567696074.921 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:55.325Z,1567696075.325 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:55.341Z,1567696075.341 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:07:55.833Z,1567696075.833 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:55.882Z,1567696075.882 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2019-09-05T15:07:55.882Z,1567696075.882 [Default:CheckIn:C.Wait] Stopped 2019-09-05T15:07:55.882Z,1567696075.882 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-09-05T15:07:55.882Z,1567696075.882 [Default:CheckIn:D] Running Loop=1 2019-09-05T15:07:56.245Z,1567696076.245 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:56.284Z,1567696076.284 [Default:CheckIn:D] Stopped 2019-09-05T15:07:56.284Z,1567696076.284 [Default:CheckIn:E] Running Loop=1 2019-09-05T15:07:56.661Z,1567696076.661 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:56.682Z,1567696076.682 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.547306 min 2019-09-05T15:07:56.682Z,1567696076.682 [Default:CheckIn:E] Stopped 2019-09-05T15:07:56.683Z,1567696076.683 [Default:CheckIn](INFO): Completed Default:CheckIn 2019-09-05T15:07:56.683Z,1567696076.683 [Default:CheckIn] Stopped 2019-09-05T15:07:56.683Z,1567696076.683 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-09-05T15:07:56.683Z,1567696076.683 [Default:CheckIn](INFO): Running loop #2 2019-09-05T15:07:56.683Z,1567696076.683 [Default:CheckIn] Running Loop=2 2019-09-05T15:07:56.683Z,1567696076.683 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-09-05T15:07:56.683Z,1567696076.683 [Default:CheckIn:Read_GPS] Running Loop=1 2019-09-05T15:07:57.033Z,1567696077.033 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:57.437Z,1567696077.437 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:57.841Z,1567696077.841 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:58.253Z,1567696078.253 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:58.273Z,1567696078.273 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:07:58.649Z,1567696078.649 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:59.061Z,1567696079.061 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:59.473Z,1567696079.473 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:07:59.873Z,1567696079.873 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:08:00.273Z,1567696080.273 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:08:00.669Z,1567696080.669 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:08:01.073Z,1567696081.073 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:08:01.093Z,1567696081.093 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:08:01.485Z,1567696081.485 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:08:01.885Z,1567696081.885 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:08:02.285Z,1567696082.285 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:08:02.285Z,1567696082.285 [AHRS_M2](FAULT): Failed to initialize within timeout. 2019-09-05T15:08:02.285Z,1567696082.285 [AHRS_M2] Communications Fault, FailCount= 5 2019-09-05T15:08:02.285Z,1567696082.285 [AHRS_M2](ERROR): Communications Fault 2019-09-05T15:08:02.323Z,1567696082.323 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2019-09-05T15:08:02.323Z,1567696082.323 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2 2019-09-05T15:08:02.373Z,1567696082.373 [AHRS_M2](INFO): Powering down 2019-09-05T15:08:02.477Z,1567696082.477 [CBIT](INFO): Critical error at 20190905T150802 2019-09-05T15:08:04.413Z,1567696084.413 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:08:07.241Z,1567696087.241 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:08:10.077Z,1567696090.077 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:08:12.085Z,1567696092.085 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:08:14.109Z,1567696094.109 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:08:17.341Z,1567696097.341 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:08:20.169Z,1567696100.169 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:08:23.417Z,1567696103.417 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:08:26.225Z,1567696106.225 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:08:29.057Z,1567696109.057 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:08:29.075Z,1567696109.075 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-09-05T15:08:29.075Z,1567696109.075 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2019-09-05T15:08:29.075Z,1567696109.075 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-09-05T15:08:29.076Z,1567696109.076 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-09-05T15:08:29.076Z,1567696109.076 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7 2019-09-05T15:08:29.077Z,1567696109.077 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2019-09-05T15:08:29.088Z,1567696109.088 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-09-05T15:08:29.089Z,1567696109.089 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2019-09-05T15:08:29.495Z,1567696109.495 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-09-05T15:08:29.495Z,1567696109.495 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2019-09-05T15:08:29.495Z,1567696109.495 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2019-09-05T15:08:29.496Z,1567696109.496 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7 2019-09-05T15:08:29.884Z,1567696109.884 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2019-09-05T15:08:31.077Z,1567696111.077 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:08:33.093Z,1567696113.093 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:08:36.325Z,1567696116.325 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:08:39.157Z,1567696119.157 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:08:42.389Z,1567696122.389 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:08:45.217Z,1567696125.217 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:08:48.045Z,1567696128.045 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:08:50.065Z,1567696130.065 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:08:52.085Z,1567696132.085 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:08:54.101Z,1567696134.101 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:08:57.337Z,1567696137.337 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:09:00.165Z,1567696140.165 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:09:03.397Z,1567696143.397 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:09:06.225Z,1567696146.225 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:09:09.049Z,1567696149.049 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:09:11.069Z,1567696151.069 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:09:13.089Z,1567696153.089 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:09:16.325Z,1567696156.325 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:09:19.153Z,1567696159.153 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:09:22.385Z,1567696162.385 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:09:23.228Z,1567696163.228 [CBIT](INFO): Clearing failed state for component DropWeight 2019-09-05T15:09:23.228Z,1567696163.228 [DropWeight] No Fault, FailCount= 1 2019-09-05T15:09:25.209Z,1567696165.209 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:09:28.037Z,1567696168.037 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:09:30.057Z,1567696170.057 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:09:32.085Z,1567696172.085 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:09:34.097Z,1567696174.097 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:09:37.333Z,1567696177.333 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:09:40.157Z,1567696180.157 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:09:43.389Z,1567696183.389 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:09:46.217Z,1567696186.217 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:09:49.045Z,1567696189.045 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:09:51.065Z,1567696191.065 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:09:53.085Z,1567696193.085 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:09:56.317Z,1567696196.317 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:09:59.149Z,1567696199.149 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:10:02.381Z,1567696202.381 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:10:05.205Z,1567696205.205 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:10:08.441Z,1567696208.441 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:10:11.269Z,1567696211.269 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:10:14.097Z,1567696214.097 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:10:17.325Z,1567696217.325 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:10:20.157Z,1567696220.157 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:10:23.389Z,1567696223.389 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:10:26.217Z,1567696226.217 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:10:29.045Z,1567696229.045 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:10:30.265Z,1567696230.265 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-09-05T15:10:30.265Z,1567696230.265 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2019-09-05T15:10:30.265Z,1567696230.265 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-09-05T15:10:30.266Z,1567696230.266 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-09-05T15:10:30.267Z,1567696230.267 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 8 2019-09-05T15:10:30.267Z,1567696230.267 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2019-09-05T15:10:30.278Z,1567696230.278 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-09-05T15:10:30.278Z,1567696230.278 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2019-09-05T15:10:30.678Z,1567696230.678 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-09-05T15:10:30.678Z,1567696230.678 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2019-09-05T15:10:30.678Z,1567696230.678 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2019-09-05T15:10:30.678Z,1567696230.678 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 8 2019-09-05T15:10:31.061Z,1567696231.061 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:10:31.092Z,1567696231.092 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2019-09-05T15:10:33.081Z,1567696233.081 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:10:36.321Z,1567696236.321 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:10:39.141Z,1567696239.141 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:10:42.381Z,1567696242.381 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:10:45.205Z,1567696245.205 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:10:48.433Z,1567696248.433 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:10:51.269Z,1567696251.269 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:10:54.093Z,1567696254.093 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:10:57.325Z,1567696257.325 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:11:00.149Z,1567696260.149 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:11:03.385Z,1567696263.385 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:11:06.209Z,1567696266.209 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:11:09.445Z,1567696269.445 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:11:12.273Z,1567696272.273 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:11:15.101Z,1567696275.101 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:11:18.333Z,1567696278.333 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:11:21.161Z,1567696281.161 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:11:24.389Z,1567696284.389 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:11:27.221Z,1567696287.221 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:11:30.049Z,1567696290.049 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:11:32.073Z,1567696292.073 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:11:34.085Z,1567696294.085 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:11:36.105Z,1567696296.105 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:11:39.337Z,1567696299.337 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:11:42.173Z,1567696302.173 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:11:45.401Z,1567696305.401 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:11:46.023Z,1567696306.023 [CommandLine](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 800.000000 cubic_centimeter 2019-09-05T15:11:48.229Z,1567696308.229 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:11:50.744Z,1567696310.744 [Reporter](INFO): platform_buoyancy_position 605.800049 cc 2019-09-05T15:11:51.053Z,1567696311.053 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:11:52.316Z,1567696312.316 [Reporter](INFO): platform_buoyancy_position 609.963379 cc 2019-09-05T15:11:52.724Z,1567696312.724 [Reporter](INFO): platform_buoyancy_position 613.858032 cc 2019-09-05T15:11:53.073Z,1567696313.073 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:11:53.136Z,1567696313.136 [Reporter](INFO): platform_buoyancy_position 619.230042 cc 2019-09-05T15:11:53.545Z,1567696313.545 [Reporter](INFO): platform_buoyancy_position 624.870667 cc 2019-09-05T15:11:53.956Z,1567696313.956 [Reporter](INFO): platform_buoyancy_position 629.705444 cc 2019-09-05T15:11:54.344Z,1567696314.344 [Reporter](INFO): platform_buoyancy_position 634.943176 cc 2019-09-05T15:11:54.740Z,1567696314.740 [Reporter](INFO): platform_buoyancy_position 640.180847 cc 2019-09-05T15:11:55.097Z,1567696315.097 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:11:55.156Z,1567696315.156 [Reporter](INFO): platform_buoyancy_position 645.687134 cc 2019-09-05T15:11:55.572Z,1567696315.572 [Reporter](INFO): platform_buoyancy_position 651.059143 cc 2019-09-05T15:11:55.965Z,1567696315.965 [Reporter](INFO): platform_buoyancy_position 656.431152 cc 2019-09-05T15:11:56.360Z,1567696316.360 [Reporter](INFO): platform_buoyancy_position 661.400269 cc 2019-09-05T15:11:56.776Z,1567696316.776 [Reporter](INFO): platform_buoyancy_position 667.578064 cc 2019-09-05T15:11:57.164Z,1567696317.164 [Reporter](INFO): platform_buoyancy_position 672.009949 cc 2019-09-05T15:11:57.596Z,1567696317.596 [Reporter](INFO): platform_buoyancy_position 676.710449 cc 2019-09-05T15:11:57.987Z,1567696317.987 [Reporter](INFO): platform_buoyancy_position 682.619690 cc 2019-09-05T15:11:58.353Z,1567696318.353 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:11:58.452Z,1567696318.452 [Reporter](INFO): platform_buoyancy_position 689.066040 cc 2019-09-05T15:11:58.846Z,1567696318.846 [Reporter](INFO): platform_buoyancy_position 693.766541 cc 2019-09-05T15:11:59.200Z,1567696319.200 [Reporter](INFO): platform_buoyancy_position 698.735657 cc 2019-09-05T15:11:59.596Z,1567696319.596 [Reporter](INFO): platform_buoyancy_position 703.973389 cc 2019-09-05T15:12:00.004Z,1567696320.004 [Reporter](INFO): platform_buoyancy_position 709.076782 cc 2019-09-05T15:12:00.408Z,1567696320.408 [Reporter](INFO): platform_buoyancy_position 714.583069 cc 2019-09-05T15:12:00.825Z,1567696320.825 [Reporter](INFO): platform_buoyancy_position 720.223694 cc 2019-09-05T15:12:01.165Z,1567696321.165 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:12:01.219Z,1567696321.219 [Reporter](INFO): platform_buoyancy_position 724.789856 cc 2019-09-05T15:12:01.629Z,1567696321.629 [Reporter](INFO): platform_buoyancy_position 730.027588 cc 2019-09-05T15:12:02.044Z,1567696322.044 [Reporter](INFO): platform_buoyancy_position 734.862366 cc 2019-09-05T15:12:02.416Z,1567696322.416 [Reporter](INFO): platform_buoyancy_position 740.905884 cc 2019-09-05T15:12:02.820Z,1567696322.820 [Reporter](INFO): platform_buoyancy_position 745.472046 cc 2019-09-05T15:12:03.232Z,1567696323.232 [Reporter](INFO): platform_buoyancy_position 751.784180 cc 2019-09-05T15:12:03.636Z,1567696323.636 [Reporter](INFO): platform_buoyancy_position 756.081787 cc 2019-09-05T15:12:04.052Z,1567696324.052 [Reporter](INFO): platform_buoyancy_position 760.513672 cc 2019-09-05T15:12:04.393Z,1567696324.393 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:12:04.468Z,1567696324.468 [Reporter](INFO): platform_buoyancy_position 766.691467 cc 2019-09-05T15:12:04.864Z,1567696324.864 [Reporter](INFO): platform_buoyancy_position 771.123352 cc 2019-09-05T15:12:05.275Z,1567696325.275 [Reporter](INFO): platform_buoyancy_position 775.555298 cc 2019-09-05T15:12:07.221Z,1567696327.221 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:12:09.335Z,1567696329.335 [Reporter](INFO): platform_buoyancy_position 792.745667 cc 2019-09-05T15:12:10.449Z,1567696330.449 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:12:13.285Z,1567696333.285 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:12:16.109Z,1567696336.109 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:12:16.331Z,1567696336.331 [CommandLine](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 600.000000 cubic_centimeter 2019-09-05T15:12:19.341Z,1567696339.341 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:12:21.032Z,1567696341.032 [Reporter](INFO): platform_buoyancy_position 798.386292 cc 2019-09-05T15:12:21.416Z,1567696341.416 [Reporter](INFO): platform_buoyancy_position 799.057800 cc 2019-09-05T15:12:21.823Z,1567696341.823 [Reporter](INFO): platform_buoyancy_position 794.894470 cc 2019-09-05T15:12:22.165Z,1567696342.165 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:12:22.238Z,1567696342.238 [Reporter](INFO): platform_buoyancy_position 786.164978 cc 2019-09-05T15:12:22.652Z,1567696342.652 [Reporter](INFO): platform_buoyancy_position 782.001648 cc 2019-09-05T15:12:23.036Z,1567696343.036 [Reporter](INFO): platform_buoyancy_position 778.778442 cc 2019-09-05T15:12:23.436Z,1567696343.436 [Reporter](INFO): platform_buoyancy_position 773.406494 cc 2019-09-05T15:12:23.832Z,1567696343.832 [Reporter](INFO): platform_buoyancy_position 769.108887 cc 2019-09-05T15:12:24.252Z,1567696344.252 [Reporter](INFO): platform_buoyancy_position 764.676941 cc 2019-09-05T15:12:24.644Z,1567696344.644 [Reporter](INFO): platform_buoyancy_position 760.245056 cc 2019-09-05T15:12:25.056Z,1567696345.056 [Reporter](INFO): platform_buoyancy_position 753.932983 cc 2019-09-05T15:12:25.397Z,1567696345.397 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:12:25.464Z,1567696345.464 [Reporter](INFO): platform_buoyancy_position 747.755188 cc 2019-09-05T15:12:25.873Z,1567696345.873 [Reporter](INFO): platform_buoyancy_position 743.188965 cc 2019-09-05T15:12:26.264Z,1567696346.264 [Reporter](INFO): platform_buoyancy_position 736.876892 cc 2019-09-05T15:12:26.652Z,1567696346.652 [Reporter](INFO): platform_buoyancy_position 732.579285 cc 2019-09-05T15:12:27.064Z,1567696347.064 [Reporter](INFO): platform_buoyancy_position 726.804382 cc 2019-09-05T15:12:27.476Z,1567696347.476 [Reporter](INFO): platform_buoyancy_position 721.835266 cc 2019-09-05T15:12:27.880Z,1567696347.880 [Reporter](INFO): platform_buoyancy_position 716.731873 cc 2019-09-05T15:12:28.229Z,1567696348.229 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:12:28.297Z,1567696348.297 [Reporter](INFO): platform_buoyancy_position 710.956970 cc 2019-09-05T15:12:28.712Z,1567696348.712 [Reporter](INFO): platform_buoyancy_position 704.644836 cc 2019-09-05T15:12:29.105Z,1567696349.105 [Reporter](INFO): platform_buoyancy_position 700.347290 cc 2019-09-05T15:12:29.488Z,1567696349.488 [Reporter](INFO): platform_buoyancy_position 695.781067 cc 2019-09-05T15:12:29.892Z,1567696349.892 [Reporter](INFO): platform_buoyancy_position 689.603271 cc 2019-09-05T15:12:30.300Z,1567696350.300 [Reporter](INFO): platform_buoyancy_position 685.171387 cc 2019-09-05T15:12:30.696Z,1567696350.696 [Reporter](INFO): platform_buoyancy_position 678.993591 cc 2019-09-05T15:12:31.057Z,1567696351.057 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:12:31.120Z,1567696351.120 [Reporter](INFO): platform_buoyancy_position 674.561646 cc 2019-09-05T15:12:31.488Z,1567696351.488 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-09-05T15:12:31.488Z,1567696351.488 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2019-09-05T15:12:31.488Z,1567696351.488 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-09-05T15:12:31.489Z,1567696351.489 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-09-05T15:12:31.489Z,1567696351.489 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 9 2019-09-05T15:12:31.490Z,1567696351.490 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2019-09-05T15:12:31.527Z,1567696351.527 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-09-05T15:12:31.527Z,1567696351.527 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2019-09-05T15:12:31.529Z,1567696351.529 [Reporter](INFO): platform_buoyancy_position 668.115234 cc 2019-09-05T15:12:31.935Z,1567696351.935 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-09-05T15:12:31.935Z,1567696351.935 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2019-09-05T15:12:31.935Z,1567696351.935 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2019-09-05T15:12:31.935Z,1567696351.935 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 9 2019-09-05T15:12:31.937Z,1567696351.937 [Reporter](INFO): platform_buoyancy_position 663.683350 cc 2019-09-05T15:12:32.280Z,1567696352.280 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2019-09-05T15:12:32.324Z,1567696352.324 [Reporter](INFO): platform_buoyancy_position 658.042786 cc 2019-09-05T15:12:32.720Z,1567696352.720 [Reporter](INFO): platform_buoyancy_position 653.073669 cc 2019-09-05T15:12:33.073Z,1567696353.073 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:12:33.136Z,1567696353.136 [Reporter](INFO): platform_buoyancy_position 646.627258 cc 2019-09-05T15:12:33.544Z,1567696353.544 [Reporter](INFO): platform_buoyancy_position 642.195374 cc 2019-09-05T15:12:33.944Z,1567696353.944 [Reporter](INFO): platform_buoyancy_position 637.897766 cc 2019-09-05T15:12:34.340Z,1567696354.340 [Reporter](INFO): platform_buoyancy_position 631.451355 cc 2019-09-05T15:12:34.748Z,1567696354.748 [Reporter](INFO): platform_buoyancy_position 627.153748 cc 2019-09-05T15:12:35.097Z,1567696355.097 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:12:35.164Z,1567696355.164 [Reporter](INFO): platform_buoyancy_position 620.841675 cc 2019-09-05T15:12:35.564Z,1567696355.564 [Reporter](INFO): platform_buoyancy_position 616.409790 cc 2019-09-05T15:12:35.969Z,1567696355.969 [Reporter](INFO): platform_buoyancy_position 610.500549 cc 2019-09-05T15:12:36.389Z,1567696356.389 [Reporter](INFO): platform_buoyancy_position 605.800049 cc 2019-09-05T15:12:38.325Z,1567696358.325 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:12:41.153Z,1567696361.153 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:12:42.479Z,1567696362.479 [CommandLine](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 800.000000 cubic_centimeter 2019-09-05T15:12:43.672Z,1567696363.672 [Reporter](INFO): platform_buoyancy_position 603.114075 cc 2019-09-05T15:12:44.032Z,1567696364.032 [Reporter](INFO): platform_buoyancy_position 603.651245 cc 2019-09-05T15:12:44.389Z,1567696364.389 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:12:44.452Z,1567696364.452 [Reporter](INFO): platform_buoyancy_position 603.785583 cc 2019-09-05T15:12:44.856Z,1567696364.856 [Reporter](INFO): platform_buoyancy_position 603.516968 cc 2019-09-05T15:12:45.260Z,1567696365.260 [Reporter](INFO): platform_buoyancy_position 607.814575 cc 2019-09-05T15:12:45.656Z,1567696365.656 [Reporter](INFO): platform_buoyancy_position 611.977844 cc 2019-09-05T15:12:46.062Z,1567696366.062 [Reporter](INFO): platform_buoyancy_position 616.678345 cc 2019-09-05T15:12:46.452Z,1567696366.452 [Reporter](INFO): platform_buoyancy_position 622.856140 cc 2019-09-05T15:12:46.856Z,1567696366.856 [Reporter](INFO): platform_buoyancy_position 627.690979 cc 2019-09-05T15:12:47.217Z,1567696367.217 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:12:47.276Z,1567696367.276 [Reporter](INFO): platform_buoyancy_position 632.928650 cc 2019-09-05T15:12:47.684Z,1567696367.684 [Reporter](INFO): platform_buoyancy_position 638.166382 cc 2019-09-05T15:12:48.084Z,1567696368.084 [Reporter](INFO): platform_buoyancy_position 644.209839 cc 2019-09-05T15:12:48.484Z,1567696368.484 [Reporter](INFO): platform_buoyancy_position 648.641785 cc 2019-09-05T15:12:48.872Z,1567696368.872 [Reporter](INFO): platform_buoyancy_position 654.148071 cc 2019-09-05T15:12:49.292Z,1567696369.292 [Reporter](INFO): platform_buoyancy_position 659.654358 cc 2019-09-05T15:12:49.700Z,1567696369.700 [Reporter](INFO): platform_buoyancy_position 665.429260 cc 2019-09-05T15:12:50.045Z,1567696370.045 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:12:50.113Z,1567696370.113 [Reporter](INFO): platform_buoyancy_position 670.398376 cc 2019-09-05T15:12:50.528Z,1567696370.528 [Reporter](INFO): platform_buoyancy_position 676.441895 cc 2019-09-05T15:12:50.912Z,1567696370.912 [Reporter](INFO): platform_buoyancy_position 680.873779 cc 2019-09-05T15:12:51.304Z,1567696371.304 [Reporter](INFO): platform_buoyancy_position 686.648682 cc 2019-09-05T15:12:51.716Z,1567696371.716 [Reporter](INFO): platform_buoyancy_position 691.214844 cc 2019-09-05T15:12:52.061Z,1567696372.061 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:12:52.132Z,1567696372.132 [Reporter](INFO): platform_buoyancy_position 696.183960 cc 2019-09-05T15:12:52.532Z,1567696372.532 [Reporter](INFO): platform_buoyancy_position 701.958862 cc 2019-09-05T15:12:52.948Z,1567696372.948 [Reporter](INFO): platform_buoyancy_position 707.465149 cc 2019-09-05T15:12:53.338Z,1567696373.338 [Reporter](INFO): platform_buoyancy_position 712.031372 cc 2019-09-05T15:12:53.724Z,1567696373.724 [Reporter](INFO): platform_buoyancy_position 717.671997 cc 2019-09-05T15:12:54.081Z,1567696374.081 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:12:54.144Z,1567696374.144 [Reporter](INFO): platform_buoyancy_position 723.043945 cc 2019-09-05T15:12:54.552Z,1567696374.552 [Reporter](INFO): platform_buoyancy_position 728.415955 cc 2019-09-05T15:12:54.952Z,1567696374.952 [Reporter](INFO): platform_buoyancy_position 733.922241 cc 2019-09-05T15:12:55.352Z,1567696375.352 [Reporter](INFO): platform_buoyancy_position 739.025696 cc 2019-09-05T15:12:55.756Z,1567696375.756 [Reporter](INFO): platform_buoyancy_position 743.726196 cc 2019-09-05T15:12:56.105Z,1567696376.105 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:12:56.173Z,1567696376.173 [Reporter](INFO): platform_buoyancy_position 749.366760 cc 2019-09-05T15:12:56.588Z,1567696376.588 [Reporter](INFO): platform_buoyancy_position 754.604492 cc 2019-09-05T15:12:56.934Z,1567696376.934 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-09-05T15:07:56.7Z 2019-09-05T15:12:56.934Z,1567696376.934 [Default:CheckIn:Read_GPS] Stopped 2019-09-05T15:12:56.934Z,1567696376.934 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-09-05T15:12:56.988Z,1567696376.988 [Reporter](INFO): platform_buoyancy_position 759.707886 cc 2019-09-05T15:12:57.368Z,1567696377.368 [Reporter](INFO): platform_buoyancy_position 763.602600 cc 2019-09-05T15:12:57.772Z,1567696377.772 [Reporter](INFO): platform_buoyancy_position 769.108887 cc 2019-09-05T15:12:58.176Z,1567696378.176 [Reporter](INFO): platform_buoyancy_position 773.675049 cc 2019-09-05T15:12:58.576Z,1567696378.576 [Reporter](INFO): platform_buoyancy_position 779.718567 cc 2019-09-05T15:12:59.333Z,1567696379.333 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:13:01.996Z,1567696381.996 [DataOverHttps](INFO): Sending 78 bytes from file Logs/20190905T145412/Courier0007.lzma 2019-09-05T15:13:02.165Z,1567696382.165 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:13:02.667Z,1567696382.667 [CBIT](INFO): Clearing failed state for component AHRS_M2 2019-09-05T15:13:02.667Z,1567696382.667 [AHRS_M2] No Fault, FailCount= 5 2019-09-05T15:13:02.668Z,1567696382.668 [Reporter](INFO): platform_buoyancy_position 792.879944 cc 2019-09-05T15:13:02.802Z,1567696382.802 [DataOverHttps](INFO): Moved sent file to Logs/20190905T145412/Courier0007.lzma.bak 2019-09-05T15:13:02.802Z,1567696382.802 [DataOverHttps](INFO): SBD MOMSN=11743368 2019-09-05T15:13:02.953Z,1567696382.953 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2019-09-05T15:13:05.393Z,1567696385.393 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:13:06.509Z,1567696386.509 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:06.909Z,1567696386.909 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:07.321Z,1567696387.321 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:07.745Z,1567696387.745 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:08.157Z,1567696388.157 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:08.173Z,1567696388.173 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:13:08.569Z,1567696388.569 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:08.892Z,1567696388.892 [CommandLine](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 600.000000 cubic_centimeter 2019-09-05T15:13:08.997Z,1567696388.997 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:09.385Z,1567696389.385 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:09.797Z,1567696389.797 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:10.209Z,1567696390.209 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:10.629Z,1567696390.629 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:11.065Z,1567696391.065 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:11.473Z,1567696391.473 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:11.489Z,1567696391.489 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:13:11.889Z,1567696391.889 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:12.301Z,1567696392.301 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:12.725Z,1567696392.725 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:13.141Z,1567696393.141 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:13.250Z,1567696393.250 [Reporter](INFO): platform_buoyancy_position 799.057800 cc 2019-09-05T15:13:13.581Z,1567696393.581 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:14.001Z,1567696394.001 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:14.088Z,1567696394.088 [Reporter](INFO): platform_buoyancy_position 794.760193 cc 2019-09-05T15:13:14.417Z,1567696394.417 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:14.433Z,1567696394.433 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:13:14.508Z,1567696394.508 [Reporter](INFO): platform_buoyancy_position 786.164978 cc 2019-09-05T15:13:14.829Z,1567696394.829 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:14.920Z,1567696394.920 [Reporter](INFO): platform_buoyancy_position 782.001648 cc 2019-09-05T15:13:15.026Z,1567696395.026 [DataOverHttps](INFO): Sending 551 bytes from file Logs/20190905T145412/Express0008.lzma 2019-09-05T15:13:15.241Z,1567696395.241 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:15.340Z,1567696395.340 [Reporter](INFO): platform_buoyancy_position 777.704102 cc 2019-09-05T15:13:15.665Z,1567696395.665 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:15.752Z,1567696395.752 [Reporter](INFO): platform_buoyancy_position 773.272156 cc 2019-09-05T15:13:15.830Z,1567696395.830 [DataOverHttps](INFO): Moved sent file to Logs/20190905T145412/Express0008.lzma.bak 2019-09-05T15:13:15.831Z,1567696395.831 [DataOverHttps](INFO): SBD MOMSN=11743371 2019-09-05T15:13:16.081Z,1567696396.081 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:16.081Z,1567696396.081 [AHRS_M2](FAULT): Failed to initialize within timeout. 2019-09-05T15:13:16.081Z,1567696396.081 [AHRS_M2] Communications Fault, FailCount= 1 2019-09-05T15:13:16.081Z,1567696396.081 [AHRS_M2](ERROR): Communications Fault 2019-09-05T15:13:16.151Z,1567696396.151 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2019-09-05T15:13:16.153Z,1567696396.153 [Reporter](INFO): platform_buoyancy_position 768.840271 cc 2019-09-05T15:13:16.162Z,1567696396.162 [AHRS_M2](INFO): Powering down 2019-09-05T15:13:16.346Z,1567696396.346 [Reporter](INFO): platform_buoyancy_position 766.825745 cc 2019-09-05T15:13:16.586Z,1567696396.586 [Default:CheckIn:Read_Iridium] Stopped 2019-09-05T15:13:16.586Z,1567696396.586 [Default:CheckIn:C.Wait] Running Loop=1 2019-09-05T15:13:16.586Z,1567696396.586 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-09-05T15:13:16.624Z,1567696396.624 [Reporter](INFO): platform_buoyancy_position 762.528198 cc 2019-09-05T15:13:16.985Z,1567696396.985 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:13:17.047Z,1567696397.047 [CBIT](INFO): Clearing failed state for component AHRS_M2 2019-09-05T15:13:17.047Z,1567696397.047 [AHRS_M2] No Fault, FailCount= 1 2019-09-05T15:13:17.048Z,1567696397.048 [Reporter](INFO): platform_buoyancy_position 758.230591 cc 2019-09-05T15:13:17.369Z,1567696397.369 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2019-09-05T15:13:17.468Z,1567696397.468 [Reporter](INFO): platform_buoyancy_position 751.784180 cc 2019-09-05T15:13:17.852Z,1567696397.852 [Reporter](INFO): platform_buoyancy_position 745.337769 cc 2019-09-05T15:13:18.252Z,1567696398.252 [Reporter](INFO): platform_buoyancy_position 741.040161 cc 2019-09-05T15:13:18.656Z,1567696398.656 [Reporter](INFO): platform_buoyancy_position 734.728088 cc 2019-09-05T15:13:19.068Z,1567696399.068 [Reporter](INFO): platform_buoyancy_position 730.296143 cc 2019-09-05T15:13:19.405Z,1567696399.405 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:13:19.484Z,1567696399.484 [Reporter](INFO): platform_buoyancy_position 724.118347 cc 2019-09-05T15:13:19.872Z,1567696399.872 [Reporter](INFO): platform_buoyancy_position 719.552185 cc 2019-09-05T15:13:20.276Z,1567696400.276 [Reporter](INFO): platform_buoyancy_position 713.240051 cc 2019-09-05T15:13:20.917Z,1567696400.917 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:20.992Z,1567696400.992 [Reporter](INFO): platform_buoyancy_position 704.644836 cc 2019-09-05T15:13:21.329Z,1567696401.329 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:21.409Z,1567696401.409 [Reporter](INFO): platform_buoyancy_position 699.675781 cc 2019-09-05T15:13:21.733Z,1567696401.733 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:21.808Z,1567696401.808 [Reporter](INFO): platform_buoyancy_position 693.766541 cc 2019-09-05T15:13:22.133Z,1567696402.133 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:22.153Z,1567696402.153 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:13:22.229Z,1567696402.229 [Reporter](INFO): platform_buoyancy_position 689.200378 cc 2019-09-05T15:13:22.561Z,1567696402.561 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:22.648Z,1567696402.648 [Reporter](INFO): platform_buoyancy_position 683.156860 cc 2019-09-05T15:13:22.969Z,1567696402.969 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:23.056Z,1567696403.056 [Reporter](INFO): platform_buoyancy_position 678.456360 cc 2019-09-05T15:13:23.381Z,1567696403.381 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:23.453Z,1567696403.453 [Reporter](INFO): platform_buoyancy_position 672.412842 cc 2019-09-05T15:13:23.789Z,1567696403.789 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:23.863Z,1567696403.863 [Reporter](INFO): platform_buoyancy_position 667.980957 cc 2019-09-05T15:13:24.197Z,1567696404.197 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:24.278Z,1567696404.278 [Reporter](INFO): platform_buoyancy_position 661.668884 cc 2019-09-05T15:13:24.601Z,1567696404.601 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:24.668Z,1567696404.668 [Reporter](INFO): platform_buoyancy_position 657.371277 cc 2019-09-05T15:13:25.021Z,1567696405.021 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:25.080Z,1567696405.080 [Reporter](INFO): platform_buoyancy_position 650.924866 cc 2019-09-05T15:13:25.421Z,1567696405.421 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:25.441Z,1567696405.441 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:13:25.520Z,1567696405.520 [Reporter](INFO): platform_buoyancy_position 646.492981 cc 2019-09-05T15:13:25.841Z,1567696405.841 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:25.940Z,1567696405.940 [Reporter](INFO): platform_buoyancy_position 640.180847 cc 2019-09-05T15:13:26.277Z,1567696406.277 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:26.358Z,1567696406.358 [Reporter](INFO): platform_buoyancy_position 635.346069 cc 2019-09-05T15:13:26.689Z,1567696406.689 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:26.774Z,1567696406.774 [Reporter](INFO): platform_buoyancy_position 629.436890 cc 2019-09-05T15:13:27.105Z,1567696407.105 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:27.191Z,1567696407.191 [Reporter](INFO): platform_buoyancy_position 625.004944 cc 2019-09-05T15:13:27.529Z,1567696407.529 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:27.606Z,1567696407.606 [Reporter](INFO): platform_buoyancy_position 618.558533 cc 2019-09-05T15:13:27.937Z,1567696407.937 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:28.028Z,1567696408.028 [Reporter](INFO): platform_buoyancy_position 613.589478 cc 2019-09-05T15:13:28.357Z,1567696408.357 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:28.377Z,1567696408.377 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:13:28.440Z,1567696408.440 [Reporter](INFO): platform_buoyancy_position 607.948853 cc 2019-09-05T15:13:28.781Z,1567696408.781 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:29.185Z,1567696409.185 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:29.597Z,1567696409.597 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:30.001Z,1567696410.001 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:30.385Z,1567696410.385 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:30.385Z,1567696410.385 [AHRS_M2](FAULT): Failed to initialize within timeout. 2019-09-05T15:13:30.385Z,1567696410.385 [AHRS_M2] Communications Fault, FailCount= 2 2019-09-05T15:13:30.385Z,1567696410.385 [AHRS_M2](ERROR): Communications Fault 2019-09-05T15:13:30.574Z,1567696410.574 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2019-09-05T15:13:30.580Z,1567696410.580 [AHRS_M2](INFO): Powering down 2019-09-05T15:13:30.997Z,1567696410.997 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:13:31.451Z,1567696411.451 [CBIT](INFO): Clearing failed state for component AHRS_M2 2019-09-05T15:13:31.451Z,1567696411.451 [AHRS_M2] No Fault, FailCount= 2 2019-09-05T15:13:31.789Z,1567696411.789 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2019-09-05T15:13:33.429Z,1567696413.429 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:13:35.333Z,1567696415.333 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:35.749Z,1567696415.749 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:36.153Z,1567696416.153 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:36.173Z,1567696416.173 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:13:36.569Z,1567696416.569 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:36.981Z,1567696416.981 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:37.353Z,1567696417.353 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:37.757Z,1567696417.757 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:38.161Z,1567696418.161 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:38.573Z,1567696418.573 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:38.969Z,1567696418.969 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:39.381Z,1567696419.381 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:39.397Z,1567696419.397 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:13:39.793Z,1567696419.793 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:40.201Z,1567696420.201 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:40.585Z,1567696420.585 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:40.989Z,1567696420.989 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:41.393Z,1567696421.393 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:41.801Z,1567696421.801 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:42.201Z,1567696422.201 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:42.221Z,1567696422.221 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:13:42.605Z,1567696422.605 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:43.025Z,1567696423.025 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:43.445Z,1567696423.445 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:43.817Z,1567696423.817 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:44.225Z,1567696424.225 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:44.625Z,1567696424.625 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:44.625Z,1567696424.625 [AHRS_M2](FAULT): Failed to initialize within timeout. 2019-09-05T15:13:44.625Z,1567696424.625 [AHRS_M2] Communications Fault, FailCount= 3 2019-09-05T15:13:44.625Z,1567696424.625 [AHRS_M2](ERROR): Communications Fault 2019-09-05T15:13:44.700Z,1567696424.700 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2019-09-05T15:13:44.713Z,1567696424.713 [AHRS_M2](INFO): Powering down 2019-09-05T15:13:44.805Z,1567696424.805 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:13:45.571Z,1567696425.571 [CBIT](INFO): Clearing failed state for component AHRS_M2 2019-09-05T15:13:45.571Z,1567696425.571 [AHRS_M2] No Fault, FailCount= 3 2019-09-05T15:13:45.925Z,1567696425.925 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2019-09-05T15:13:47.153Z,1567696427.153 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:13:49.481Z,1567696429.481 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:49.901Z,1567696429.901 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:50.317Z,1567696430.317 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:50.337Z,1567696430.337 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:13:50.705Z,1567696430.705 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:51.101Z,1567696431.101 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:51.493Z,1567696431.493 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:51.897Z,1567696431.897 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:52.309Z,1567696432.309 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:52.713Z,1567696432.713 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:53.133Z,1567696433.133 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:53.149Z,1567696433.149 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:13:53.557Z,1567696433.557 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:53.981Z,1567696433.981 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:54.405Z,1567696434.405 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:54.817Z,1567696434.817 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:55.054Z,1567696435.054 [CommandLine](IMPORTANT): got command configSet AHRS_M2.loadAtStartup 0.000000 bool persist 2019-09-05T15:13:55.054Z,1567696435.054 [CommandLine](IMPORTANT): configSet AHRS_M2.loadAtStartup requires a restart to take effect. 2019-09-05T15:13:55.237Z,1567696435.237 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:55.645Z,1567696435.645 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:56.041Z,1567696436.041 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:56.057Z,1567696436.057 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:13:56.453Z,1567696436.453 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:56.865Z,1567696436.865 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:57.249Z,1567696437.249 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:57.653Z,1567696437.653 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:58.057Z,1567696438.057 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:58.077Z,1567696438.077 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:13:58.461Z,1567696438.461 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:58.857Z,1567696438.857 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2019-09-05T15:13:58.857Z,1567696438.857 [AHRS_M2](FAULT): Failed to initialize within timeout. 2019-09-05T15:13:58.857Z,1567696438.857 [AHRS_M2] Communications Fault, FailCount= 4 2019-09-05T15:13:58.857Z,1567696438.857 [AHRS_M2](ERROR): Communications Fault 2019-09-05T15:13:58.907Z,1567696438.907 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2019-09-05T15:13:58.957Z,1567696438.957 [AHRS_M2](INFO): Powering down 2019-09-05T15:13:59.791Z,1567696439.791 [CBIT](INFO): Clearing failed state for component AHRS_M2 2019-09-05T15:13:59.791Z,1567696439.791 [AHRS_M2] No Fault, FailCount= 4 2019-09-05T15:13:59.954Z,1567696439.954 [CommandLine](IMPORTANT): got command restart application 2019-09-05T15:14:00.157Z,1567696440.157 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2019-09-05T15:14:00.185Z,1567696440.185 [NAL9602](DEBUG): Fix Requested 2019-09-05T15:14:00.957Z,1567696440.957 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2019-09-05T15:14:00.957Z,1567696440.957 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-09-05T15:14:01.045Z,1567696441.045 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2019-09-05T15:14:01.045Z,1567696441.045 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-09-05T15:14:01.046Z,1567696441.046 [CommandLine](INFO): Join timeout helper Thread ID is 4636 2019-09-05T15:14:01.046Z,1567696441.046 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2019-09-05T15:14:01.046Z,1567696441.046 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-09-05T15:14:01.047Z,1567696441.047 [NavChartDb](INFO): Join timeout helper Thread ID is 4637 2019-09-05T15:14:01.221Z,1567696441.221 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2019-09-05T15:14:01.221Z,1567696441.221 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-09-05T15:14:01.237Z,1567696441.237 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2019-09-05T15:14:01.237Z,1567696441.237 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-09-05T15:14:01.237Z,1567696441.237 [Radio_Surface](INFO): Join timeout helper Thread ID is 4638 2019-09-05T15:14:01.293Z,1567696441.293 [Radio_Surface](INFO): Powering down 2019-09-05T15:14:01.294Z,1567696441.294 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2019-09-05T15:14:01.294Z,1567696441.294 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-09-05T15:14:01.297Z,1567696441.297 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2019-09-05T15:14:01.297Z,1567696441.297 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-09-05T15:14:01.297Z,1567696441.297 [DataOverHttps](INFO): Join timeout helper Thread ID is 4639 2019-09-05T15:14:01.641Z,1567696441.641 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2019-09-05T15:14:01.641Z,1567696441.641 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-09-05T15:14:01.645Z,1567696441.645 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2019-09-05T15:14:01.645Z,1567696441.645 [logger ThreadHandler](INFO): Thread cancelled. 2019-09-05T15:14:01.645Z,1567696441.645 [logger](INFO): Join timeout helper Thread ID is 4640 2019-09-05T15:14:01.725Z,1567696441.725 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2019-09-05T15:14:01.725Z,1567696441.725 [logger ThreadHandler](INFO): Thread cancelled. 2019-09-05T15:14:01.746Z,1567696441.746 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2019-09-05T15:14:01.746Z,1567696441.746 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-09-05T15:14:01.746Z,1567696441.746 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2019-09-05T15:14:01.746Z,1567696441.746 [controlThread ThreadHandler](INFO): Thread cancelled. 2019-09-05T15:14:01.746Z,1567696441.746 [controlThread](INFO): Join timeout helper Thread ID is 4641 2019-09-05T15:14:01.769Z,1567696441.769 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2019-09-05T15:14:01.769Z,1567696441.769 [controlThread](DEBUG): Uninitializing ControlThread 2019-09-05T15:14:01.769Z,1567696441.769 [AHRS_M2](INFO): Powering down 2019-09-05T15:14:01.841Z,1567696441.841 [NAL9602](INFO): Powering down 2019-09-05T15:14:01.843Z,1567696441.843 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2019-09-05T15:14:01.844Z,1567696441.844 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2019-09-05T15:14:01.845Z,1567696441.845 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2019-09-05T15:14:01.845Z,1567696441.845 [MissionManager](INFO): Uninitializing Mission Default 2019-09-05T15:14:01.846Z,1567696441.846 [Default] Stopped 2019-09-05T15:14:01.846Z,1567696441.846 [Default](DEBUG): Aggregate::uninitialize Default 2019-09-05T15:14:01.846Z,1567696441.846 [Default:B.GoToSurface] Stopped 2019-09-05T15:14:01.846Z,1567696441.846 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2019-09-05T15:14:01.846Z,1567696441.846 [Default:CheckIn] Stopped 2019-09-05T15:14:01.846Z,1567696441.846 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-09-05T15:14:01.846Z,1567696441.846 [Default:CheckIn:C.Wait] Stopped 2019-09-05T15:14:01.846Z,1567696441.846 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-09-05T15:14:01.848Z,1567696441.848 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2019-09-05T15:14:01.849Z,1567696441.849 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2019-09-05T15:14:01.849Z,1567696441.849 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2019-09-05T15:14:01.849Z,1567696441.849 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2019-09-05T15:14:01.850Z,1567696441.850 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2019-09-05T15:14:01.850Z,1567696441.850 [BuoyancyServo](INFO): Powering down 2019-09-05T15:14:01.865Z,1567696441.865 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2019-09-05T15:14:01.865Z,1567696441.865 [ElevatorServo](INFO): Powering down 2019-09-05T15:14:01.866Z,1567696441.866 [MassServo](DEBUG): Uninitialize Mass Servo. 2019-09-05T15:14:01.866Z,1567696441.866 [MassServo](INFO): Powering down 2019-09-05T15:14:01.867Z,1567696441.867 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2019-09-05T15:14:01.867Z,1567696441.867 [RudderServo](INFO): Powering down 2019-09-05T15:14:01.868Z,1567696441.868 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2019-09-05T15:14:01.868Z,1567696441.868 [ThrusterServo](INFO): Powering down 2019-09-05T15:14:01.868Z,1567696441.868 [SBIT](DEBUG): Uninitialize SBIT Component. 2019-09-05T15:14:01.869Z,1567696441.869 [IBIT](DEBUG): Uninitialize IBIT Component. 2019-09-05T15:14:01.869Z,1567696441.869 [CBIT](DEBUG): Uninitialize CBIT Component. 2019-09-05T15:14:01.869Z,1567696441.869 [CBIT](DEBUG): Powering off loads. 2019-09-05T15:14:01.881Z,1567696441.881 [CBIT](DEBUG): Disabling WDT. 2019-09-05T15:14:01.893Z,1567696441.893 [CBIT](DEBUG): Opening all GF detection circuits. 2019-09-05T15:14:01.894Z,1567696441.894 [controlThread ThreadHandler](INFO): Thread cancelled. 2019-09-05T15:14:01.999Z,1567696441.999 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-09-05T15:14:02.005Z,1567696442.005 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-09-05T15:14:02.044Z,1567696442.044 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-09-05T15:14:02.099Z,1567696442.099 [logger ThreadHandler](INFO): Thread cancelled.