2021-03-16T15:48:54.494Z,1615909734.494 [Supervisor](DEBUG): Initializing supervisor. 2021-03-16T15:48:54.496Z,1615909734.496 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2021-03-16T15:48:54.497Z,1615909734.497 [SyncHandler](INFO): Protected caller Thread ID is 2101 2021-03-16T15:48:54.497Z,1615909734.497 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2021-03-16T15:48:54.498Z,1615909734.498 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2021-03-16T15:48:54.498Z,1615909734.498 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 2102 2021-03-16T15:48:54.501Z,1615909734.501 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2021-03-16T15:48:54.518Z,1615909734.518 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2021-03-16T15:48:54.519Z,1615909734.519 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2021-03-16T15:48:54.519Z,1615909734.519 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 2103 2021-03-16T15:48:54.520Z,1615909734.520 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2021-03-16T15:48:54.521Z,1615909734.521 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2021-03-16T15:48:54.521Z,1615909734.521 [logger ThreadHandler](INFO): Protected caller Thread ID is 2104 2021-03-16T15:48:54.524Z,1615909734.524 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2021-03-16T15:48:54.524Z,1615909734.524 [Supervisor](INFO): Looking for Config files in directory: Config/ 2021-03-16T15:48:54.525Z,1615909734.525 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2021-03-16T15:48:54.939Z,1615909734.939 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2021-03-16T15:48:54.940Z,1615909734.940 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2021-03-16T15:48:55.075Z,1615909735.075 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2021-03-16T15:48:55.076Z,1615909735.076 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2021-03-16T15:48:55.153Z,1615909735.153 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2021-03-16T15:48:55.349Z,1615909735.349 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2021-03-16T15:48:55.349Z,1615909735.349 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2021-03-16T15:48:55.443Z,1615909735.443 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2021-03-16T15:48:55.444Z,1615909735.444 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2021-03-16T15:48:55.536Z,1615909735.536 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2021-03-16T15:48:55.536Z,1615909735.536 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2021-03-16T15:48:55.908Z,1615909735.908 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2021-03-16T15:48:55.909Z,1615909735.909 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2021-03-16T15:48:56.010Z,1615909736.010 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2021-03-16T15:48:56.011Z,1615909736.011 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2021-03-16T15:48:56.499Z,1615909736.499 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2021-03-16T15:48:56.500Z,1615909736.500 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2021-03-16T15:48:56.680Z,1615909736.680 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2021-03-16T15:48:56.680Z,1615909736.680 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2021-03-16T15:48:56.968Z,1615909736.968 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2021-03-16T15:48:56.969Z,1615909736.969 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2021-03-16T15:48:57.175Z,1615909737.175 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2021-03-16T15:48:57.176Z,1615909737.176 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2021-03-16T15:48:57.311Z,1615909737.311 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2021-03-16T15:48:57.312Z,1615909737.312 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2021-03-16T15:48:58.034Z,1615909738.034 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2021-03-16T15:48:58.035Z,1615909738.035 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2021-03-16T15:48:58.346Z,1615909738.346 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2021-03-16T15:48:58.346Z,1615909738.346 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2021-03-16T15:48:58.544Z,1615909738.544 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2021-03-16T15:48:58.546Z,1615909738.546 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/ 2021-03-16T15:48:58.547Z,1615909738.547 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/vehicle.cfg 2021-03-16T15:48:58.730Z,1615909738.730 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/secure.cfg 2021-03-16T15:48:58.810Z,1615909738.810 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Science.cfg 2021-03-16T15:48:58.951Z,1615909738.951 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Simulator.cfg 2021-03-16T15:48:59.033Z,1615909739.033 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Battery.cfg 2021-03-16T15:48:59.329Z,1615909739.329 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2021-03-16T15:48:59.330Z,1615909739.330 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/logger.cfg 2021-03-16T15:48:59.556Z,1615909739.556 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Servo.cfg 2021-03-16T15:48:59.659Z,1615909739.659 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Navigation.cfg 2021-03-16T15:48:59.749Z,1615909739.749 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Sensor.cfg 2021-03-16T15:48:59.886Z,1615909739.886 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Control.cfg 2021-03-16T15:48:59.980Z,1615909739.980 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/BIT.cfg 2021-03-16T15:49:00.078Z,1615909740.078 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/root/ 2021-03-16T15:49:00.078Z,1615909740.078 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2021-03-16T15:49:00.079Z,1615909740.079 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2021-03-16T15:49:00.098Z,1615909740.098 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2021-03-16T15:49:00.099Z,1615909740.099 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2021-03-16T15:49:00.174Z,1615909740.174 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2021-03-16T15:49:00.174Z,1615909740.174 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2021-03-16T15:49:00.221Z,1615909740.221 [VerticalControl](DEBUG): Construct VerticalControl. 2021-03-16T15:49:00.277Z,1615909740.277 [VerticalControl] Loaded 2021-03-16T15:49:00.278Z,1615909740.278 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2021-03-16T15:49:00.278Z,1615909740.278 [HorizontalControl](DEBUG): Construct HorizontalControl. 2021-03-16T15:49:00.314Z,1615909740.314 [HorizontalControl] Loaded 2021-03-16T15:49:00.315Z,1615909740.315 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2021-03-16T15:49:00.315Z,1615909740.315 [SpeedControl](DEBUG): Construct SpeedControl. 2021-03-16T15:49:00.318Z,1615909740.318 [SpeedControl] Loaded 2021-03-16T15:49:00.319Z,1615909740.319 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2021-03-16T15:49:00.319Z,1615909740.319 [LoopControl](DEBUG): Construct LoopControl. 2021-03-16T15:49:00.320Z,1615909740.320 [LoopControl] Loaded 2021-03-16T15:49:00.320Z,1615909740.320 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2021-03-16T15:49:00.320Z,1615909740.320 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2021-03-16T15:49:00.321Z,1615909740.321 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2021-03-16T15:49:00.427Z,1615909740.427 [BuoyancyServo] Loaded 2021-03-16T15:49:00.427Z,1615909740.427 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2021-03-16T15:49:00.442Z,1615909740.442 [ElevatorServo] Loaded 2021-03-16T15:49:00.443Z,1615909740.443 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2021-03-16T15:49:00.458Z,1615909740.458 [MassServo] Loaded 2021-03-16T15:49:00.458Z,1615909740.458 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2021-03-16T15:49:00.472Z,1615909740.472 [RudderServo] Loaded 2021-03-16T15:49:00.473Z,1615909740.473 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2021-03-16T15:49:00.487Z,1615909740.487 [ThrusterServo] Loaded 2021-03-16T15:49:00.487Z,1615909740.487 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2021-03-16T15:49:00.488Z,1615909740.488 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2021-03-16T15:49:00.488Z,1615909740.488 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2021-03-16T15:49:00.525Z,1615909740.525 [DepthRateCalculator] Loaded 2021-03-16T15:49:00.525Z,1615909740.525 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2021-03-16T15:49:00.527Z,1615909740.527 [PitchRateCalculator] Loaded 2021-03-16T15:49:00.528Z,1615909740.528 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2021-03-16T15:49:00.535Z,1615909740.535 [SpeedCalculator] Loaded 2021-03-16T15:49:00.535Z,1615909740.535 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2021-03-16T15:49:00.546Z,1615909740.546 [TempGradientCalculator] Loaded 2021-03-16T15:49:00.546Z,1615909740.546 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2021-03-16T15:49:00.549Z,1615909740.549 [YawRateCalculator] Loaded 2021-03-16T15:49:00.549Z,1615909740.549 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2021-03-16T15:49:00.564Z,1615909740.564 [ElevatorOffsetCalculator] Loaded 2021-03-16T15:49:00.564Z,1615909740.564 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2021-03-16T15:49:00.564Z,1615909740.564 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2021-03-16T15:49:00.565Z,1615909740.565 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2021-03-16T15:49:00.641Z,1615909740.641 [DeadReckonUsingMultipleVelocitySources] Loaded 2021-03-16T15:49:00.641Z,1615909740.641 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2021-03-16T15:49:00.652Z,1615909740.652 [NavChart] Loaded 2021-03-16T15:49:00.652Z,1615909740.652 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2021-03-16T15:49:00.656Z,1615909740.656 [UniversalFixResidualReporter] Loaded 2021-03-16T15:49:00.656Z,1615909740.656 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2021-03-16T15:49:00.657Z,1615909740.657 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2021-03-16T15:49:00.657Z,1615909740.657 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2021-03-16T15:49:00.948Z,1615909740.948 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_orientation 2021-03-16T15:49:00.950Z,1615909740.950 [AHRS_M2](INFO): created writer for : platform_orientation 2021-03-16T15:49:00.952Z,1615909740.952 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_magnetic_orientation 2021-03-16T15:49:00.955Z,1615909740.955 [AHRS_M2](INFO): created writer for : platform_magnetic_orientation 2021-03-16T15:49:00.956Z,1615909740.956 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_pitch_angle 2021-03-16T15:49:00.958Z,1615909740.958 [AHRS_M2](INFO): created writer for : platform_pitch_angle 2021-03-16T15:49:00.959Z,1615909740.959 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_roll_angle 2021-03-16T15:49:00.962Z,1615909740.962 [AHRS_M2](INFO): created writer for : platform_roll_angle 2021-03-16T15:49:00.998Z,1615909740.998 [AHRS_M2] Loaded 2021-03-16T15:49:00.998Z,1615909740.998 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2021-03-16T15:49:01.069Z,1615909741.069 [DataOverHttps] Loaded 2021-03-16T15:49:01.069Z,1615909741.069 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2021-03-16T15:49:01.070Z,1615909741.070 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408514E0 2021-03-16T15:49:01.071Z,1615909741.071 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 2187 2021-03-16T15:49:01.087Z,1615909741.087 [Depth_Keller] Loaded 2021-03-16T15:49:01.088Z,1615909741.088 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2021-03-16T15:49:01.090Z,1615909741.090 [DropWeight] Loaded 2021-03-16T15:49:01.090Z,1615909741.090 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2021-03-16T15:49:01.121Z,1615909741.121 [DVL_micro] Loaded 2021-03-16T15:49:01.121Z,1615909741.121 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread. 2021-03-16T15:49:01.173Z,1615909741.173 [NAL9602] Loaded 2021-03-16T15:49:01.174Z,1615909741.174 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2021-03-16T15:49:01.199Z,1615909741.199 [Onboard] Loaded 2021-03-16T15:49:01.199Z,1615909741.199 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2021-03-16T15:49:01.200Z,1615909741.200 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408814E0 2021-03-16T15:49:01.200Z,1615909741.200 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 2188 2021-03-16T15:49:01.210Z,1615909741.210 [Radio_Surface] Loaded 2021-03-16T15:49:01.211Z,1615909741.211 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2021-03-16T15:49:01.212Z,1615909741.212 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408B14E0 2021-03-16T15:49:01.212Z,1615909741.212 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 2189 2021-03-16T15:49:01.285Z,1615909741.285 [DAT] Loaded 2021-03-16T15:49:01.286Z,1615909741.286 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread. 2021-03-16T15:49:02.064Z,1615909742.064 [BPC1] Loaded 2021-03-16T15:49:02.064Z,1615909742.064 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2021-03-16T15:49:02.064Z,1615909742.064 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2021-03-16T15:49:02.065Z,1615909742.065 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2021-03-16T15:49:02.145Z,1615909742.145 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2021-03-16T15:49:02.146Z,1615909742.146 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2021-03-16T15:49:02.242Z,1615909742.242 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2021-03-16T15:49:02.242Z,1615909742.242 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2021-03-16T15:49:02.268Z,1615909742.268 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2021-03-16T15:49:02.268Z,1615909742.268 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2021-03-16T15:49:02.463Z,1615909742.463 [Aanderaa_O2] Loaded 2021-03-16T15:49:02.463Z,1615909742.463 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread. 2021-03-16T15:49:02.481Z,1615909742.481 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density 2021-03-16T15:49:02.484Z,1615909742.484 [CTD_Seabird](INFO): created writer for : sea_water_density 2021-03-16T15:49:02.484Z,1615909742.484 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth 2021-03-16T15:49:02.487Z,1615909742.487 [CTD_Seabird](INFO): created writer for : depth 2021-03-16T15:49:02.487Z,1615909742.487 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure 2021-03-16T15:49:02.490Z,1615909742.490 [CTD_Seabird](INFO): created writer for : sea_water_pressure 2021-03-16T15:49:02.490Z,1615909742.490 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity 2021-03-16T15:49:02.493Z,1615909742.493 [CTD_Seabird](INFO): created writer for : sea_water_salinity 2021-03-16T15:49:02.494Z,1615909742.494 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature 2021-03-16T15:49:02.497Z,1615909742.497 [CTD_Seabird](INFO): created writer for : sea_water_temperature 2021-03-16T15:49:02.497Z,1615909742.497 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity 2021-03-16T15:49:02.500Z,1615909742.500 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity 2021-03-16T15:49:02.501Z,1615909742.501 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water 2021-03-16T15:49:02.504Z,1615909742.504 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water 2021-03-16T15:49:02.516Z,1615909742.516 [CTD_Seabird] Loaded 2021-03-16T15:49:02.517Z,1615909742.517 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2021-03-16T15:49:02.518Z,1615909742.518 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A594E0 2021-03-16T15:49:02.518Z,1615909742.518 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 2190 2021-03-16T15:49:02.547Z,1615909742.547 [ESPComponent] Loaded 2021-03-16T15:49:02.547Z,1615909742.547 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2021-03-16T15:49:02.563Z,1615909742.563 [PAR_Licor] Loaded 2021-03-16T15:49:02.563Z,1615909742.563 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2021-03-16T15:49:02.575Z,1615909742.575 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output470 2021-03-16T15:49:02.576Z,1615909742.576 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output470 2021-03-16T15:49:02.578Z,1615909742.578 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output650 2021-03-16T15:49:02.578Z,1615909742.578 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output650 2021-03-16T15:49:02.580Z,1615909742.580 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.OutputChl 2021-03-16T15:49:02.580Z,1615909742.580 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: OutputChl 2021-03-16T15:49:02.582Z,1615909742.582 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg470nm 2021-03-16T15:49:02.582Z,1615909742.582 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg470nm 2021-03-16T15:49:02.584Z,1615909742.584 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg650nm 2021-03-16T15:49:02.584Z,1615909742.584 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg650nm 2021-03-16T15:49:02.586Z,1615909742.586 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff470nm 2021-03-16T15:49:02.586Z,1615909742.586 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff470nm 2021-03-16T15:49:02.588Z,1615909742.588 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff650nm 2021-03-16T15:49:02.588Z,1615909742.588 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff650nm 2021-03-16T15:49:02.590Z,1615909742.590 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): mass_concentration_of_chlorophyll_in_sea_water 2021-03-16T15:49:02.592Z,1615909742.592 [WetLabsBB2FL](INFO): created writer for : mass_concentration_of_chlorophyll_in_sea_water 2021-03-16T15:49:02.593Z,1615909742.593 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water 2021-03-16T15:49:02.593Z,1615909742.593 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_median_mass_concentration_of_chlorophyll_in_sea_water 2021-03-16T15:49:02.595Z,1615909742.595 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water 2021-03-16T15:49:02.595Z,1615909742.595 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_mean_mass_concentration_of_chlorophyll_in_sea_water 2021-03-16T15:49:02.597Z,1615909742.597 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_variance_mass_concentration_of_chlorophyll_in_sea_water 2021-03-16T15:49:02.597Z,1615909742.597 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_variance_mass_concentration_of_chlorophyll_in_sea_water 2021-03-16T15:49:02.599Z,1615909742.599 [WetLabsBB2FL] Loaded 2021-03-16T15:49:02.599Z,1615909742.599 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2021-03-16T15:49:02.600Z,1615909742.600 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A894E0 2021-03-16T15:49:02.601Z,1615909742.601 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 2191 2021-03-16T15:49:02.601Z,1615909742.601 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2021-03-16T15:49:02.602Z,1615909742.602 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2021-03-16T15:49:02.883Z,1615909742.883 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2021-03-16T15:49:02.884Z,1615909742.884 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2021-03-16T15:49:03.013Z,1615909743.013 [SBIT](DEBUG): Construct Startup Built In Test. 2021-03-16T15:49:03.021Z,1615909743.021 [SBIT] Loaded 2021-03-16T15:49:03.022Z,1615909743.022 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2021-03-16T15:49:03.022Z,1615909743.022 [IBIT](DEBUG): Construct Initiated Built In Test. 2021-03-16T15:49:03.034Z,1615909743.034 [IBIT] Loaded 2021-03-16T15:49:03.034Z,1615909743.034 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2021-03-16T15:49:03.037Z,1615909743.037 [CBIT](DEBUG): Construct Continuous Built In Test. 2021-03-16T15:49:03.132Z,1615909743.132 [CBIT] Loaded 2021-03-16T15:49:03.132Z,1615909743.132 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2021-03-16T15:49:03.133Z,1615909743.133 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2021-03-16T15:49:03.137Z,1615909743.137 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2021-03-16T15:49:03.137Z,1615909743.137 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2021-03-16T15:49:03.145Z,1615909743.145 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2021-03-16T15:49:03.146Z,1615909743.146 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B674E0 2021-03-16T15:49:03.147Z,1615909743.147 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 2192 2021-03-16T15:49:03.151Z,1615909743.151 [Supervisor](INFO): Main Thread ID is 2100 2021-03-16T15:49:03.151Z,1615909743.151 [Supervisor](DEBUG): Running supervisor. 2021-03-16T15:49:03.152Z,1615909743.152 [CommandLine ThreadHandler](INFO): Handler Thread ID is 2193 2021-03-16T15:49:03.154Z,1615909743.154 [controlThread ThreadHandler](INFO): Handler Thread ID is 2194 2021-03-16T15:49:03.155Z,1615909743.155 [controlThread](DEBUG): Initializing ControlThread 2021-03-16T15:49:03.156Z,1615909743.156 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2021-03-16T15:49:03.157Z,1615909743.157 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2021-03-16T15:49:03.158Z,1615909743.158 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2021-03-16T15:49:03.158Z,1615909743.158 [LoopControl](DEBUG): Initialize LoopControlComponent. 2021-03-16T15:49:03.160Z,1615909743.160 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2021-03-16T15:49:03.160Z,1615909743.160 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2021-03-16T15:49:03.160Z,1615909743.160 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2021-03-16T15:49:03.161Z,1615909743.161 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2021-03-16T15:49:03.161Z,1615909743.161 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2021-03-16T15:49:03.162Z,1615909743.162 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2021-03-16T15:49:03.163Z,1615909743.163 [NavChart](DEBUG): Initialize NavChart Navigation. 2021-03-16T15:49:03.163Z,1615909743.163 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2021-03-16T15:49:03.172Z,1615909743.172 [SBIT](INFO): Initialize SBIT Component. 2021-03-16T15:49:03.172Z,1615909743.172 [SBIT](IMPORTANT): git: 2020-11-24-6-gcb638d650 2021-03-16T15:49:03.172Z,1615909743.172 [SBIT](INFO): git hash: cb638d650ac65501896d406bf5988c2fe747cbc6 2021-03-16T15:49:03.173Z,1615909743.173 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2021-03-16T15:49:03.174Z,1615909743.174 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #1 PREEMPT Tue Dec 18 21:19:28 PST 2018 Kernel Reported: #1 PREEMPT Tue May 26 08:17:09 PDT 2020 2021-03-16T15:49:03.175Z,1615909743.175 [SBIT](INFO): Beginning SBIT in 20.000000 seconds. 2021-03-16T15:49:03.175Z,1615909743.175 [IBIT](INFO): Initialize IBIT Component. 2021-03-16T15:49:03.176Z,1615909743.176 [CBIT](DEBUG): Initialize CBIT Component. 2021-03-16T15:49:03.177Z,1615909743.177 [logger ThreadHandler](INFO): Handler Thread ID is 2195 2021-03-16T15:49:03.187Z,1615909743.187 [CBIT](DEBUG): Initialized mux pins. 2021-03-16T15:49:03.187Z,1615909743.187 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL. 2021-03-16T15:49:03.188Z,1615909743.188 [CBIT](DEBUG): Initializing the watchdog timer. 2021-03-16T15:49:03.196Z,1615909743.196 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 2196 2021-03-16T15:49:03.197Z,1615909743.197 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2021-03-16T15:49:03.208Z,1615909743.208 [Onboard ThreadHandler](INFO): Handler Thread ID is 2197 2021-03-16T15:49:03.212Z,1615909743.212 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2021-03-16T15:49:03.212Z,1615909743.212 [CBIT](DEBUG): Initializing heartbeat. 2021-03-16T15:49:03.243Z,1615909743.243 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 2198 2021-03-16T15:49:03.252Z,1615909743.252 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 2199 2021-03-16T15:49:03.253Z,1615909743.253 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2021-03-16T15:49:03.257Z,1615909743.257 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 2201 2021-03-16T15:49:03.258Z,1615909743.258 [WetLabsBB2FL](INFO): Powering down 2021-03-16T15:49:03.276Z,1615909743.276 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 2202 2021-03-16T15:49:03.279Z,1615909743.279 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2021-03-16T15:49:03.279Z,1615909743.279 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2021-03-16T15:49:03.279Z,1615909743.279 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2021-03-16T15:49:03.279Z,1615909743.279 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2021-03-16T15:49:03.279Z,1615909743.279 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2021-03-16T15:49:03.280Z,1615909743.280 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2021-03-16T15:49:03.280Z,1615909743.280 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2021-03-16T15:49:03.280Z,1615909743.280 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2021-03-16T15:49:03.280Z,1615909743.280 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2021-03-16T15:49:03.280Z,1615909743.280 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2021-03-16T15:49:03.280Z,1615909743.280 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2021-03-16T15:49:03.281Z,1615909743.281 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2021-03-16T15:49:03.281Z,1615909743.281 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2021-03-16T15:49:03.281Z,1615909743.281 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2021-03-16T15:49:03.281Z,1615909743.281 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2021-03-16T15:49:03.281Z,1615909743.281 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2021-03-16T15:49:03.283Z,1615909743.283 [CBIT](DEBUG): Deactivating GF circuits. 2021-03-16T15:49:03.283Z,1615909743.283 [CBIT](DEBUG): Deactivating emergency mode. 2021-03-16T15:49:03.319Z,1615909743.319 [CBIT](DEBUG): Backplane powered. 2021-03-16T15:49:03.320Z,1615909743.320 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2021-03-16T15:49:03.330Z,1615909743.330 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2021-03-16T15:49:03.340Z,1615909743.340 [MissionManager](DEBUG): 2021-03-16T15:49:03.341Z,1615909743.341 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2021-03-16T15:49:03.407Z,1615909743.407 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2021-03-16T15:49:03.408Z,1615909743.408 [Default:A.Wait](DEBUG): Construct Wait. 2021-03-16T15:49:03.410Z,1615909743.410 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2021-03-16T15:49:03.460Z,1615909743.460 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2021-03-16T15:49:03.463Z,1615909743.463 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2021-03-16T15:49:03.493Z,1615909743.493 [Default:E.Execute](DEBUG): Construct Execute. 2021-03-16T15:49:03.496Z,1615909743.496 [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 2021-03-16T15:49:03.504Z,1615909743.504 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,DropWeight,DVL_micro,NAL9602,DAT,BPC1,Aanderaa_O2,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2021-03-16T15:49:03.520Z,1615909743.520 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2021-03-16T15:49:03.648Z,1615909743.648 [Radio_Surface](INFO): Powering up 2021-03-16T15:49:03.671Z,1615909743.671 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2 2021-03-16T15:49:03.671Z,1615909743.671 [DAT](INFO): Powering up 2021-03-16T15:49:03.671Z,1615909743.671 [DAT](DEBUG): Initializing DAT. 2021-03-16T15:49:03.752Z,1615909743.752 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2 2021-03-16T15:49:03.855Z,1615909743.855 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2021-03-16T15:49:03.868Z,1615909743.868 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2021-03-16T15:49:03.869Z,1615909743.869 [ElevatorServo](DEBUG): Initializing EZServoServo. 2021-03-16T15:49:03.876Z,1615909743.876 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2021-03-16T15:49:03.877Z,1615909743.877 [MassServo](DEBUG): Initializing EZServoServo. 2021-03-16T15:49:03.884Z,1615909743.884 [MassServo](DEBUG): Initializing MassServo. 2021-03-16T15:49:03.885Z,1615909743.885 [RudderServo](DEBUG): Initializing EZServoServo. 2021-03-16T15:49:03.892Z,1615909743.892 [RudderServo](DEBUG): Initializing RudderServo. 2021-03-16T15:49:03.893Z,1615909743.893 [ThrusterServo](DEBUG): Initializing EZServoServo. 2021-03-16T15:49:03.900Z,1615909743.900 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2021-03-16T15:49:04.005Z,1615909744.005 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2021-03-16T15:49:04.005Z,1615909744.005 [DropWeight] Hardware Fault, FailCount= 1 2021-03-16T15:49:04.005Z,1615909744.005 [DropWeight](ERROR): Hardware Fault 2021-03-16T15:49:04.049Z,1615909744.049 [CommandLine](FAULT): Scheduling is paused 2021-03-16T15:49:04.050Z,1615909744.050 [CBIT](INFO): Critical error at 20210316T154904 2021-03-16T15:49:04.050Z,1615909744.050 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2021-03-16T15:49:04.060Z,1615909744.060 [CBIT](ERROR): Hardware Fault in component: DropWeight 2021-03-16T15:49:04.061Z,1615909744.061 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2021-03-16T15:49:04.348Z,1615909744.348 [CBIT](INFO): Critical error at 20210316T154904 2021-03-16T15:49:07.064Z,1615909747.064 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:07.484Z,1615909747.484 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:08.031Z,1615909748.031 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:08.695Z,1615909748.695 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:09.316Z,1615909749.316 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:09.719Z,1615909749.719 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:10.207Z,1615909750.207 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:10.623Z,1615909750.623 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:11.015Z,1615909751.015 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:11.427Z,1615909751.427 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:11.819Z,1615909751.819 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:12.235Z,1615909752.235 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:12.659Z,1615909752.659 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:13.047Z,1615909753.047 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:13.455Z,1615909753.455 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:13.492Z,1615909753.492 [CBIT](CRITICAL): Environmental Failure. Press:14.874012 PSI. Humidity:30%. Temp:23 C. ABORTING MISSION 2021-03-16T15:49:13.859Z,1615909753.859 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:13.865Z,1615909753.865 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2021-03-16T15:49:13.866Z,1615909753.866 [Aanderaa_O2] Communications Fault, FailCount= 1 2021-03-16T15:49:13.866Z,1615909753.866 [Aanderaa_O2](ERROR): Communications Fault 2021-03-16T15:49:13.905Z,1615909753.905 [CBIT](INFO): Critical error at 20210316T154913 2021-03-16T15:49:13.908Z,1615909753.908 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2021-03-16T15:49:14.255Z,1615909754.255 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:14.379Z,1615909754.379 [Aanderaa_O2](INFO): Powering down 2021-03-16T15:49:14.759Z,1615909754.759 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:15.163Z,1615909755.163 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:15.207Z,1615909755.207 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2021-03-16T15:49:15.208Z,1615909755.208 [Aanderaa_O2] No Fault, FailCount= 1 2021-03-16T15:49:15.555Z,1615909755.555 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:15.971Z,1615909755.971 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:16.304Z,1615909756.304 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2021-03-16T15:49:16.304Z,1615909756.304 [CTD_Seabird] Communications Fault, FailCount= 1 2021-03-16T15:49:16.304Z,1615909756.304 [CTD_Seabird](ERROR): Communications Fault 2021-03-16T15:49:16.395Z,1615909756.395 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:16.396Z,1615909756.396 [AHRS_M2](FAULT): Failed to initialize within timeout. 2021-03-16T15:49:16.396Z,1615909756.396 [AHRS_M2] Communications Fault, FailCount= 1 2021-03-16T15:49:16.396Z,1615909756.396 [AHRS_M2](ERROR): Communications Fault 2021-03-16T15:49:16.519Z,1615909756.519 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2021-03-16T15:49:16.520Z,1615909756.520 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2021-03-16T15:49:16.539Z,1615909756.539 [AHRS_M2](INFO): Powering down 2021-03-16T15:49:16.708Z,1615909756.708 [CTD_Seabird](INFO): Powering down 2021-03-16T15:49:17.362Z,1615909757.362 [CBIT](INFO): Clearing failed state for component AHRS_M2 2021-03-16T15:49:17.362Z,1615909757.362 [AHRS_M2] No Fault, FailCount= 1 2021-03-16T15:49:17.743Z,1615909757.743 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2021-03-16T15:49:17.774Z,1615909757.774 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2021-03-16T15:49:17.774Z,1615909757.774 [CTD_Seabird] No Fault, FailCount= 1 2021-03-16T15:49:18.052Z,1615909758.052 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2021-03-16T15:49:21.299Z,1615909761.299 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:21.304Z,1615909761.304 [DVL_micro](FAULT): Failed to initialize within timeout. 2021-03-16T15:49:21.304Z,1615909761.304 [DVL_micro] Communications Fault, FailCount= 1 2021-03-16T15:49:21.304Z,1615909761.304 [DVL_micro](ERROR): Communications Fault 2021-03-16T15:49:21.332Z,1615909761.332 [CBIT](ERROR): Communications Fault in component: DVL_micro 2021-03-16T15:49:21.695Z,1615909761.695 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:21.767Z,1615909761.767 [DVL_micro](INFO): Powering down 2021-03-16T15:49:22.147Z,1615909762.147 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:22.539Z,1615909762.539 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:22.610Z,1615909762.610 [CBIT](INFO): Clearing failed state for component DVL_micro 2021-03-16T15:49:22.610Z,1615909762.610 [DVL_micro] No Fault, FailCount= 1 2021-03-16T15:49:22.963Z,1615909762.963 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:23.347Z,1615909763.347 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:23.759Z,1615909763.759 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:23.797Z,1615909763.797 [SBIT](IMPORTANT): Beginning Startup BIT 2021-03-16T15:49:23.815Z,1615909763.815 [CBIT](IMPORTANT): Beginning ground fault scan 2021-03-16T15:49:24.167Z,1615909764.167 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:24.627Z,1615909764.627 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:25.043Z,1615909765.043 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:25.459Z,1615909765.459 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:26.071Z,1615909766.071 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:26.077Z,1615909766.077 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2021-03-16T15:49:26.078Z,1615909766.078 [Aanderaa_O2] Communications Fault, FailCount= 2 2021-03-16T15:49:26.078Z,1615909766.078 [Aanderaa_O2](ERROR): Communications Fault 2021-03-16T15:49:26.232Z,1615909766.232 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2021-03-16T15:49:26.555Z,1615909766.555 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:26.680Z,1615909766.680 [Aanderaa_O2](INFO): Powering down 2021-03-16T15:49:27.191Z,1615909767.191 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:27.663Z,1615909767.663 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:27.876Z,1615909767.876 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2021-03-16T15:49:27.877Z,1615909767.877 [Aanderaa_O2] No Fault, FailCount= 2 2021-03-16T15:49:28.287Z,1615909768.287 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:28.767Z,1615909768.767 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:29.387Z,1615909769.387 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:29.811Z,1615909769.811 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:30.207Z,1615909770.207 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:30.623Z,1615909770.623 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:30.623Z,1615909770.623 [AHRS_M2](FAULT): Failed to initialize within timeout. 2021-03-16T15:49:30.624Z,1615909770.624 [AHRS_M2] Communications Fault, FailCount= 2 2021-03-16T15:49:30.624Z,1615909770.624 [AHRS_M2](ERROR): Communications Fault 2021-03-16T15:49:30.728Z,1615909770.728 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2021-03-16T15:49:30.832Z,1615909770.832 [AHRS_M2](INFO): Powering down 2021-03-16T15:49:31.104Z,1615909771.104 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2021-03-16T15:49:31.104Z,1615909771.104 [CTD_Seabird] Communications Fault, FailCount= 2 2021-03-16T15:49:31.104Z,1615909771.104 [CTD_Seabird](ERROR): Communications Fault 2021-03-16T15:49:31.249Z,1615909771.249 [NAL9602](INFO): Powering up NAL9602 2021-03-16T15:49:31.304Z,1615909771.304 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2021-03-16T15:49:31.507Z,1615909771.507 [CTD_Seabird](INFO): Powering down 2021-03-16T15:49:31.706Z,1615909771.706 [CBIT](INFO): Clearing failed state for component AHRS_M2 2021-03-16T15:49:31.706Z,1615909771.706 [AHRS_M2] No Fault, FailCount= 2 2021-03-16T15:49:32.043Z,1615909772.043 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2021-03-16T15:49:32.513Z,1615909772.513 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2021-03-16T15:49:32.513Z,1615909772.513 [CTD_Seabird] No Fault, FailCount= 2 2021-03-16T15:49:32.852Z,1615909772.852 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2021-03-16T15:49:34.936Z,1615909774.936 [CBIT](IMPORTANT): Low side ground fault detected mA: CHAN A0 (Batt): 0.917890 CHAN A1 (24V): 0.855003 CHAN A2 (12V): 0.949160 CHAN A3 (5V): 0.966484 CHAN B0 (3.3V): 0.757994 CHAN B1 (3.15aV): 1.002000 CHAN B2 (3.15bV): 1.002525 CHAN B3 (GND): 0.054069 OPEN: 0.027723 Full Scale Calc: 4.765 mA, -1.589 mA 2021-03-16T15:49:35.599Z,1615909775.599 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:36.003Z,1615909776.003 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:36.407Z,1615909776.407 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:36.811Z,1615909776.811 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:37.219Z,1615909777.219 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:37.619Z,1615909777.619 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:38.019Z,1615909778.019 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:38.427Z,1615909778.427 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:38.448Z,1615909778.448 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2021-03-16T15:49:38.448Z,1615909778.448 [Aanderaa_O2] Communications Fault, FailCount= 3 2021-03-16T15:49:38.448Z,1615909778.448 [Aanderaa_O2](ERROR): Communications Fault 2021-03-16T15:49:38.544Z,1615909778.544 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2021-03-16T15:49:38.544Z,1615909778.544 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2021-03-16T15:49:38.883Z,1615909778.883 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:39.007Z,1615909779.007 [Aanderaa_O2](INFO): Powering down 2021-03-16T15:49:39.575Z,1615909779.575 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:40.047Z,1615909780.047 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:40.515Z,1615909780.515 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:40.520Z,1615909780.520 [DVL_micro](FAULT): Failed to initialize within timeout. 2021-03-16T15:49:40.520Z,1615909780.520 [DVL_micro] Communications Fault, FailCount= 2 2021-03-16T15:49:40.520Z,1615909780.520 [DVL_micro](ERROR): Communications Fault 2021-03-16T15:49:40.673Z,1615909780.673 [CBIT](ERROR): Communications Fault in component: DVL_micro 2021-03-16T15:49:40.995Z,1615909780.995 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:41.067Z,1615909781.067 [DVL_micro](INFO): Powering down 2021-03-16T15:49:41.559Z,1615909781.559 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:42.032Z,1615909782.032 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:42.169Z,1615909782.169 [CBIT](INFO): Clearing failed state for component DVL_micro 2021-03-16T15:49:42.169Z,1615909782.169 [DVL_micro] No Fault, FailCount= 2 2021-03-16T15:49:42.499Z,1615909782.499 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:42.963Z,1615909782.963 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:43.427Z,1615909783.427 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:43.863Z,1615909783.863 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:44.327Z,1615909784.327 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:44.871Z,1615909784.871 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:44.872Z,1615909784.872 [AHRS_M2](FAULT): Failed to initialize within timeout. 2021-03-16T15:49:44.872Z,1615909784.872 [AHRS_M2] Communications Fault, FailCount= 3 2021-03-16T15:49:44.872Z,1615909784.872 [AHRS_M2](ERROR): Communications Fault 2021-03-16T15:49:45.184Z,1615909785.184 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2021-03-16T15:49:45.189Z,1615909785.189 [AHRS_M2](INFO): Powering down 2021-03-16T15:49:45.903Z,1615909785.903 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2021-03-16T15:49:45.904Z,1615909785.904 [CTD_Seabird] Communications Fault, FailCount= 3 2021-03-16T15:49:45.904Z,1615909785.904 [CTD_Seabird](ERROR): Communications Fault 2021-03-16T15:49:46.069Z,1615909786.069 [CBIT](INFO): Clearing failed state for component AHRS_M2 2021-03-16T15:49:46.069Z,1615909786.069 [AHRS_M2] No Fault, FailCount= 3 2021-03-16T15:49:46.069Z,1615909786.069 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2021-03-16T15:49:46.070Z,1615909786.070 [CBIT](FAULT): Communications Fault in component: CTD_Seabird 2021-03-16T15:49:46.307Z,1615909786.307 [CTD_Seabird](INFO): Powering down 2021-03-16T15:49:46.399Z,1615909786.399 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2021-03-16T15:49:49.955Z,1615909789.955 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:50.371Z,1615909790.371 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:50.779Z,1615909790.779 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:51.191Z,1615909791.191 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:51.595Z,1615909791.595 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:51.999Z,1615909791.999 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:52.403Z,1615909792.403 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:52.413Z,1615909792.413 [NAL9602](ERROR): NAL9602 initialization error. 2021-03-16T15:49:52.413Z,1615909792.413 [NAL9602] Communications Fault, FailCount= 1 2021-03-16T15:49:52.414Z,1615909792.414 [NAL9602](ERROR): Communications Fault 2021-03-16T15:49:52.484Z,1615909792.484 [CBIT](ERROR): Communications Fault in component: NAL9602 2021-03-16T15:49:52.815Z,1615909792.815 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:52.817Z,1615909792.817 [NAL9602](INFO): Powering down 2021-03-16T15:49:53.215Z,1615909793.215 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:53.623Z,1615909793.623 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:53.668Z,1615909793.668 [CBIT](INFO): Clearing failed state for component NAL9602 2021-03-16T15:49:53.668Z,1615909793.668 [NAL9602] No Fault, FailCount= 1 2021-03-16T15:49:54.023Z,1615909794.023 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:54.427Z,1615909794.427 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:54.835Z,1615909794.835 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:55.239Z,1615909795.239 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:55.643Z,1615909795.643 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:56.115Z,1615909796.115 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:56.519Z,1615909796.519 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:56.923Z,1615909796.923 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:57.327Z,1615909797.327 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:57.731Z,1615909797.731 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:58.135Z,1615909798.135 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:58.539Z,1615909798.539 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:58.943Z,1615909798.943 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:59.348Z,1615909799.348 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:49:59.348Z,1615909799.348 [AHRS_M2](FAULT): Failed to initialize within timeout. 2021-03-16T15:49:59.348Z,1615909799.348 [AHRS_M2] Communications Fault, FailCount= 4 2021-03-16T15:49:59.348Z,1615909799.348 [AHRS_M2](ERROR): Communications Fault 2021-03-16T15:49:59.372Z,1615909799.372 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2021-03-16T15:49:59.441Z,1615909799.441 [AHRS_M2](INFO): Powering down 2021-03-16T15:50:00.241Z,1615909800.241 [DVL_micro](FAULT): Failed to initialize within timeout. 2021-03-16T15:50:00.241Z,1615909800.241 [DVL_micro] Communications Fault, FailCount= 3 2021-03-16T15:50:00.241Z,1615909800.241 [DVL_micro](ERROR): Communications Fault 2021-03-16T15:50:00.261Z,1615909800.261 [CBIT](INFO): Clearing failed state for component AHRS_M2 2021-03-16T15:50:00.261Z,1615909800.261 [AHRS_M2] No Fault, FailCount= 4 2021-03-16T15:50:00.262Z,1615909800.262 [CBIT](ERROR): Communications Fault in component: DVL_micro 2021-03-16T15:50:00.262Z,1615909800.262 [CBIT](CRITICAL): Communications Fault in component: DVL_micro 2021-03-16T15:50:00.639Z,1615909800.639 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2021-03-16T15:50:00.723Z,1615909800.723 [DVL_micro](INFO): Powering down 2021-03-16T15:50:00.738Z,1615909800.738 [CBIT](INFO): Critical error at 20210316T155000 2021-03-16T15:50:04.195Z,1615909804.195 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:50:04.205Z,1615909804.205 [DAT](FAULT): failed to initialize, no bytes available on serial interface 2021-03-16T15:50:04.205Z,1615909804.205 [DAT] Communications Fault, FailCount= 1 2021-03-16T15:50:04.205Z,1615909804.205 [DAT](ERROR): Communications Fault 2021-03-16T15:50:04.221Z,1615909804.221 [CBIT](ERROR): Communications Fault in component: DAT 2021-03-16T15:50:04.599Z,1615909804.599 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:50:04.616Z,1615909804.616 [DAT](INFO): Powering down 2021-03-16T15:50:05.107Z,1615909805.107 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:50:05.515Z,1615909805.515 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:50:05.540Z,1615909805.540 [CBIT](INFO): Clearing failed state for component DAT 2021-03-16T15:50:05.540Z,1615909805.540 [DAT] No Fault, FailCount= 1 2021-03-16T15:50:05.908Z,1615909805.908 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:50:06.435Z,1615909806.435 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:50:06.919Z,1615909806.919 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:50:07.351Z,1615909807.351 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:50:07.807Z,1615909807.807 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:50:07.818Z,1615909807.818 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2 2021-03-16T15:50:07.818Z,1615909807.818 [DAT](INFO): Powering up 2021-03-16T15:50:07.818Z,1615909807.818 [DAT](DEBUG): Initializing DAT. 2021-03-16T15:50:07.878Z,1615909807.878 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2 2021-03-16T15:50:08.347Z,1615909808.347 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:50:08.791Z,1615909808.791 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:50:09.311Z,1615909809.311 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:50:09.883Z,1615909809.883 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:50:10.336Z,1615909810.336 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:50:10.783Z,1615909810.783 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:50:11.287Z,1615909811.287 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:50:11.687Z,1615909811.687 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:50:12.091Z,1615909812.091 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:50:12.495Z,1615909812.495 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:50:12.899Z,1615909812.899 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:50:13.295Z,1615909813.295 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:50:13.707Z,1615909813.707 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:50:13.707Z,1615909813.707 [AHRS_M2](FAULT): Failed to initialize within timeout. 2021-03-16T15:50:13.707Z,1615909813.707 [AHRS_M2] Communications Fault, FailCount= 5 2021-03-16T15:50:13.708Z,1615909813.708 [AHRS_M2](ERROR): Communications Fault 2021-03-16T15:50:13.788Z,1615909813.788 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2021-03-16T15:50:13.789Z,1615909813.789 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2 2021-03-16T15:50:13.794Z,1615909813.794 [AHRS_M2](INFO): Powering down 2021-03-16T15:50:13.910Z,1615909813.910 [CBIT](INFO): Critical error at 20210316T155013 2021-03-16T15:50:17.867Z,1615909817.867 [SBIT](IMPORTANT): SBIT PASSED 2021-03-16T15:50:17.868Z,1615909817.868 [SBIT](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2021-03-16T15:50:18.271Z,1615909818.271 [MissionManager](IMPORTANT): Started mission Startup 2021-03-16T15:50:18.274Z,1615909818.274 [Startup] Running Loop=1 2021-03-16T15:50:18.275Z,1615909818.275 [Startup](DEBUG): Aggregate::initialize Startup 2021-03-16T15:50:18.275Z,1615909818.275 [Startup:A.GoToSurface] Running Loop=1 2021-03-16T15:50:18.276Z,1615909818.276 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2021-03-16T15:50:18.280Z,1615909818.280 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2021-03-16T15:50:18.286Z,1615909818.286 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2021-03-16T15:50:18.288Z,1615909818.288 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2021-03-16T15:50:18.291Z,1615909818.291 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2021-03-16T15:50:18.294Z,1615909818.294 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2021-03-16T15:50:18.295Z,1615909818.295 [Startup:StartupSatComms] Running Loop=1 2021-03-16T15:50:18.295Z,1615909818.295 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2021-03-16T15:50:18.295Z,1615909818.295 [Startup:StartupSatComms:A] Running Loop=1 2021-03-16T15:50:18.669Z,1615909818.669 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2021-03-16T15:50:20.263Z,1615909820.263 [DAT](INFO): commRate: 800 2021-03-16T15:50:22.285Z,1615909822.285 [DAT](INFO): entering command mode 2021-03-16T15:50:22.682Z,1615909822.682 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:23.085Z,1615909823.085 [NAL9602](INFO): Powering up NAL9602 2021-03-16T15:50:23.086Z,1615909823.086 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:23.493Z,1615909823.493 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:23.893Z,1615909823.893 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:24.305Z,1615909824.305 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:24.705Z,1615909824.705 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:25.109Z,1615909825.109 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:25.509Z,1615909825.509 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:25.917Z,1615909825.917 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:26.322Z,1615909826.322 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:26.729Z,1615909826.729 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:27.129Z,1615909827.129 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:27.533Z,1615909827.533 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:27.938Z,1615909827.938 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:28.341Z,1615909828.341 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:28.745Z,1615909828.745 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:29.149Z,1615909829.149 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:29.553Z,1615909829.553 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:29.957Z,1615909829.957 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:30.361Z,1615909830.361 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:30.765Z,1615909830.765 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:31.173Z,1615909831.173 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:31.569Z,1615909831.569 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:31.977Z,1615909831.977 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:32.381Z,1615909832.381 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:32.785Z,1615909832.785 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:33.190Z,1615909833.190 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:33.606Z,1615909833.606 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:33.997Z,1615909833.997 [NAL9602](INFO): NAL9602 initialized 2021-03-16T15:50:33.997Z,1615909833.997 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:34.402Z,1615909834.402 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:34.816Z,1615909834.816 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:35.228Z,1615909835.228 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:35.624Z,1615909835.624 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:36.013Z,1615909836.013 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:36.426Z,1615909836.426 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:36.836Z,1615909836.836 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:37.240Z,1615909837.240 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:37.644Z,1615909837.644 [DAT](DEBUG): checking for command mode acknowledgment 2021-03-16T15:50:37.644Z,1615909837.644 [DAT](FAULT): failed to enter command mode 2021-03-16T15:50:38.039Z,1615909838.039 [DAT](INFO): entering command mode 2021-03-16T15:50:38.444Z,1615909838.444 [DAT](INFO): setting verbose to 3 2021-03-16T15:50:38.846Z,1615909838.846 [DAT](INFO): set verbose to 3 2021-03-16T15:50:38.847Z,1615909838.847 [DAT](INFO): setting DatVerbose to 27440 2021-03-16T15:50:39.250Z,1615909839.250 [DAT](INFO): set DatVerbose to 27440 2021-03-16T15:50:39.251Z,1615909839.251 [DAT](INFO): setting transmit power to 8 2021-03-16T15:50:39.654Z,1615909839.654 [DAT](INFO): set transmit power to 8 2021-03-16T15:50:39.655Z,1615909839.655 [DAT](INFO): setting local address to 5 2021-03-16T15:50:40.059Z,1615909840.059 [DAT](INFO): set local address to 5 2021-03-16T15:51:03.509Z,1615909863.509 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2021-03-16T15:51:03.510Z,1615909863.510 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2021-03-16T15:51:03.510Z,1615909863.510 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-03-16T15:51:03.520Z,1615909863.520 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-03-16T15:51:03.932Z,1615909863.932 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-03-16T15:51:03.932Z,1615909863.932 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2021-03-16T15:51:18.465Z,1615909878.465 [Startup:StartupSatComms:A](INFO): Timed out from 2021-03-16T15:50:18.3Z 2021-03-16T15:51:18.465Z,1615909878.465 [Startup:StartupSatComms:A] Stopped 2021-03-16T15:51:18.465Z,1615909878.465 [Startup:StartupSatComms:B] Running Loop=1 2021-03-16T15:51:18.865Z,1615909878.865 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2021-03-16T15:52:08.545Z,1615909928.545 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2021-03-16T15:52:08.546Z,1615909928.546 [Aanderaa_O2] No Fault, FailCount= 3 2021-03-16T15:52:16.256Z,1615909936.256 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2021-03-16T15:52:16.256Z,1615909936.256 [CTD_Seabird] No Fault, FailCount= 3 2021-03-16T15:52:16.348Z,1615909936.348 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2021-03-16T15:52:18.665Z,1615909938.665 [Startup:StartupSatComms:B](INFO): Timed out from 2021-03-16T15:51:18.5Z 2021-03-16T15:52:18.665Z,1615909938.665 [Startup:StartupSatComms:B] Stopped 2021-03-16T15:52:18.665Z,1615909938.665 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2021-03-16T15:52:18.665Z,1615909938.665 [Startup:StartupSatComms] Stopped 2021-03-16T15:52:18.665Z,1615909938.665 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2021-03-16T15:52:18.666Z,1615909938.666 [Startup](INFO): Completed Startup 2021-03-16T15:52:18.666Z,1615909938.666 [MissionManager](INFO): Startup is completed. 2021-03-16T15:52:18.666Z,1615909938.666 [MissionManager](INFO): Uninitializing Mission Startup 2021-03-16T15:52:18.666Z,1615909938.666 [Startup] Stopped 2021-03-16T15:52:18.667Z,1615909938.667 [Startup](DEBUG): Aggregate::uninitialize Startup 2021-03-16T15:52:18.667Z,1615909938.667 [Startup:A.GoToSurface] Stopped 2021-03-16T15:52:18.667Z,1615909938.667 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2021-03-16T15:52:19.052Z,1615909939.052 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2021-03-16T15:52:19.052Z,1615909939.052 [Aanderaa_O2] Communications Fault, FailCount= 1 2021-03-16T15:52:19.052Z,1615909939.052 [Aanderaa_O2](ERROR): Communications Fault 2021-03-16T15:52:19.084Z,1615909939.084 [MissionManager](IMPORTANT): Started mission Default 2021-03-16T15:52:19.084Z,1615909939.084 [Default] Running Loop=1 2021-03-16T15:52:19.084Z,1615909939.084 [Default](DEBUG): Aggregate::initialize Default 2021-03-16T15:52:19.084Z,1615909939.084 [Default:B.GoToSurface] Running Loop=1 2021-03-16T15:52:19.084Z,1615909939.084 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2021-03-16T15:52:19.085Z,1615909939.085 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2021-03-16T15:52:19.085Z,1615909939.085 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2021-03-16T15:52:19.085Z,1615909939.085 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2021-03-16T15:52:19.085Z,1615909939.085 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2021-03-16T15:52:19.086Z,1615909939.086 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2021-03-16T15:52:19.086Z,1615909939.086 [Default:A.Wait] Running Loop=1 2021-03-16T15:52:19.086Z,1615909939.086 [Default:A.Wait](DEBUG): Initialize Wait Component. 2021-03-16T15:52:19.095Z,1615909939.095 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2021-03-16T15:52:19.560Z,1615909939.560 [Aanderaa_O2](INFO): Powering down 2021-03-16T15:52:20.277Z,1615909940.277 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2021-03-16T15:52:20.277Z,1615909940.277 [Aanderaa_O2] No Fault, FailCount= 1 2021-03-16T15:52:23.096Z,1615909943.096 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2021-03-16T15:52:29.400Z,1615909949.400 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2021-03-16T15:52:29.400Z,1615909949.400 [CTD_Seabird] Communications Fault, FailCount= 1 2021-03-16T15:52:29.400Z,1615909949.400 [CTD_Seabird](ERROR): Communications Fault 2021-03-16T15:52:29.566Z,1615909949.566 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2021-03-16T15:52:29.803Z,1615909949.803 [CTD_Seabird](INFO): Powering down 2021-03-16T15:52:30.815Z,1615909950.815 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2021-03-16T15:52:30.815Z,1615909950.815 [Aanderaa_O2] Communications Fault, FailCount= 2 2021-03-16T15:52:30.815Z,1615909950.815 [Aanderaa_O2](ERROR): Communications Fault 2021-03-16T15:52:30.831Z,1615909950.831 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2021-03-16T15:52:30.831Z,1615909950.831 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2021-03-16T15:52:30.831Z,1615909950.831 [CTD_Seabird] No Fault, FailCount= 1 2021-03-16T15:52:31.143Z,1615909951.143 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2021-03-16T15:52:31.287Z,1615909951.287 [Aanderaa_O2](INFO): Powering down 2021-03-16T15:52:32.007Z,1615909952.007 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2021-03-16T15:52:32.007Z,1615909952.007 [Aanderaa_O2] No Fault, FailCount= 2 2021-03-16T15:52:32.401Z,1615909952.401 [Default:A.Wait](INFO): Done Waiting. 2021-03-16T15:52:32.402Z,1615909952.402 [Default:A.Wait] Stopped 2021-03-16T15:52:32.402Z,1615909952.402 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2021-03-16T15:52:32.817Z,1615909952.817 [Default:CheckIn] Running Loop=1 2021-03-16T15:52:32.817Z,1615909952.817 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-03-16T15:52:32.817Z,1615909952.817 [Default:CheckIn:Read_GPS] Running Loop=1 2021-03-16T15:52:33.205Z,1615909953.205 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2021-03-16T15:52:42.485Z,1615909962.485 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2021-03-16T15:52:42.485Z,1615909962.485 [Aanderaa_O2] Communications Fault, FailCount= 3 2021-03-16T15:52:42.485Z,1615909962.485 [Aanderaa_O2](ERROR): Communications Fault 2021-03-16T15:52:42.509Z,1615909962.509 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2021-03-16T15:52:42.509Z,1615909962.509 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2021-03-16T15:52:43.004Z,1615909963.004 [Aanderaa_O2](INFO): Powering down 2021-03-16T15:52:44.195Z,1615909964.195 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2021-03-16T15:52:44.196Z,1615909964.196 [CTD_Seabird] Communications Fault, FailCount= 2 2021-03-16T15:52:44.196Z,1615909964.196 [CTD_Seabird](ERROR): Communications Fault 2021-03-16T15:52:44.569Z,1615909964.569 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2021-03-16T15:52:44.599Z,1615909964.599 [CTD_Seabird](INFO): Powering down 2021-03-16T15:52:45.730Z,1615909965.730 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2021-03-16T15:52:45.731Z,1615909965.731 [CTD_Seabird] No Fault, FailCount= 2 2021-03-16T15:52:45.944Z,1615909965.944 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2021-03-16T15:52:59.007Z,1615909979.007 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2021-03-16T15:52:59.008Z,1615909979.008 [CTD_Seabird] Communications Fault, FailCount= 3 2021-03-16T15:52:59.008Z,1615909979.008 [CTD_Seabird](ERROR): Communications Fault 2021-03-16T15:52:59.108Z,1615909979.108 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2021-03-16T15:52:59.108Z,1615909979.108 [CBIT](FAULT): Communications Fault in component: CTD_Seabird 2021-03-16T15:52:59.411Z,1615909979.411 [CTD_Seabird](INFO): Powering down 2021-03-16T15:53:00.262Z,1615909980.262 [CBIT](INFO): Clearing failed state for component DVL_micro 2021-03-16T15:53:00.262Z,1615909980.262 [DVL_micro] No Fault, FailCount= 3 2021-03-16T15:53:04.315Z,1615909984.315 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2021-03-16T15:53:04.315Z,1615909984.315 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2021-03-16T15:53:04.316Z,1615909984.316 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-03-16T15:53:04.326Z,1615909984.326 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-03-16T15:53:04.721Z,1615909984.721 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-03-16T15:53:04.721Z,1615909984.721 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2021-03-16T15:53:18.020Z,1615909998.020 [DVL_micro](FAULT): Failed to initialize within timeout. 2021-03-16T15:53:18.021Z,1615909998.021 [DVL_micro] Communications Fault, FailCount= 1 2021-03-16T15:53:18.021Z,1615909998.021 [DVL_micro](ERROR): Communications Fault 2021-03-16T15:53:18.038Z,1615909998.038 [CBIT](ERROR): Communications Fault in component: DVL_micro 2021-03-16T15:53:18.520Z,1615909998.520 [DVL_micro](INFO): Powering down 2021-03-16T15:53:19.273Z,1615909999.273 [CBIT](INFO): Clearing failed state for component DVL_micro 2021-03-16T15:53:19.273Z,1615909999.273 [DVL_micro] No Fault, FailCount= 1 2021-03-16T15:53:37.008Z,1615910017.008 [DVL_micro](FAULT): Failed to initialize within timeout. 2021-03-16T15:53:37.008Z,1615910017.008 [DVL_micro] Communications Fault, FailCount= 2 2021-03-16T15:53:37.008Z,1615910017.008 [DVL_micro](ERROR): Communications Fault 2021-03-16T15:53:37.052Z,1615910017.052 [CBIT](ERROR): Communications Fault in component: DVL_micro 2021-03-16T15:53:37.483Z,1615910017.483 [DVL_micro](INFO): Powering down 2021-03-16T15:53:38.299Z,1615910018.299 [CBIT](INFO): Clearing failed state for component DVL_micro 2021-03-16T15:53:38.299Z,1615910018.299 [DVL_micro] No Fault, FailCount= 2 2021-03-16T15:53:55.998Z,1615910035.998 [DVL_micro](FAULT): Failed to initialize within timeout. 2021-03-16T15:53:55.998Z,1615910035.998 [DVL_micro] Communications Fault, FailCount= 3 2021-03-16T15:53:55.998Z,1615910035.998 [DVL_micro](ERROR): Communications Fault 2021-03-16T15:53:56.034Z,1615910036.034 [CBIT](ERROR): Communications Fault in component: DVL_micro 2021-03-16T15:53:56.034Z,1615910036.034 [CBIT](CRITICAL): Communications Fault in component: DVL_micro 2021-03-16T15:53:56.471Z,1615910036.471 [DVL_micro](INFO): Powering down 2021-03-16T15:53:56.504Z,1615910036.504 [CBIT](INFO): Critical error at 20210316T155356 2021-03-16T15:54:26.405Z,1615910066.405 [CommandLine](IMPORTANT): got command maintain control SpeedControl.propOmegaAction 200.000000 revolution_per_minute 2021-03-16T15:54:26.412Z,1615910066.412 [ComponentRegistry](DEBUG): SyncComponent "Maintain_SpeedControl.propOmegaAction" handled in the control thread. 2021-03-16T15:54:26.730Z,1615910066.730 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,DropWeight,DVL_micro,NAL9602,DAT,BPC1,Aanderaa_O2,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_SpeedControl.propOmegaAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2021-03-16T15:55:04.494Z,1615910104.494 [CommandLine](IMPORTANT): got command maintain control SpeedControl.propOmegaAction -200.000000 revolution_per_minute 2021-03-16T15:55:05.102Z,1615910105.102 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2021-03-16T15:55:05.102Z,1615910105.102 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2021-03-16T15:55:05.102Z,1615910105.102 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-03-16T15:55:05.175Z,1615910105.175 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-03-16T15:55:05.551Z,1615910105.551 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-03-16T15:55:05.551Z,1615910105.551 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2021-03-16T15:55:12.804Z,1615910112.804 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2021-03-16T15:55:12.804Z,1615910112.804 [Aanderaa_O2] No Fault, FailCount= 3 2021-03-16T15:55:14.023Z,1615910114.023 [CBIT](INFO): Clearing failed state for component AHRS_M2 2021-03-16T15:55:14.023Z,1615910114.023 [AHRS_M2] No Fault, FailCount= 5 2021-03-16T15:55:14.367Z,1615910114.367 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2021-03-16T15:55:17.915Z,1615910117.915 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:18.327Z,1615910118.327 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:18.735Z,1615910118.735 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:19.135Z,1615910119.135 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:19.539Z,1615910119.539 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:19.943Z,1615910119.943 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:20.359Z,1615910120.359 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:20.775Z,1615910120.775 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:21.191Z,1615910121.191 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:21.607Z,1615910121.607 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:22.055Z,1615910122.055 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:22.451Z,1615910122.451 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:22.859Z,1615910122.859 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:23.271Z,1615910123.271 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:23.339Z,1615910123.339 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2021-03-16T15:55:23.339Z,1615910123.339 [Aanderaa_O2] Communications Fault, FailCount= 1 2021-03-16T15:55:23.339Z,1615910123.339 [Aanderaa_O2](ERROR): Communications Fault 2021-03-16T15:55:23.406Z,1615910123.406 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2021-03-16T15:55:23.735Z,1615910123.735 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:23.868Z,1615910123.868 [Aanderaa_O2](INFO): Powering down 2021-03-16T15:55:24.263Z,1615910124.263 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:24.679Z,1615910124.679 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:24.760Z,1615910124.760 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2021-03-16T15:55:24.760Z,1615910124.760 [Aanderaa_O2] No Fault, FailCount= 1 2021-03-16T15:55:25.095Z,1615910125.095 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:25.511Z,1615910125.511 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:25.931Z,1615910125.931 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:26.343Z,1615910126.343 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:26.620Z,1615910126.620 [CommandLine](IMPORTANT): got command maintain clear 2021-03-16T15:55:26.759Z,1615910126.759 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:26.838Z,1615910126.838 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,DropWeight,DVL_micro,NAL9602,DAT,BPC1,Aanderaa_O2,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2021-03-16T15:55:27.167Z,1615910127.167 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:27.567Z,1615910127.567 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:27.567Z,1615910127.567 [AHRS_M2](FAULT): Failed to initialize within timeout. 2021-03-16T15:55:27.568Z,1615910127.568 [AHRS_M2] Communications Fault, FailCount= 1 2021-03-16T15:55:27.568Z,1615910127.568 [AHRS_M2](ERROR): Communications Fault 2021-03-16T15:55:27.707Z,1615910127.707 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2021-03-16T15:55:27.712Z,1615910127.712 [AHRS_M2](INFO): Powering down 2021-03-16T15:55:28.573Z,1615910128.573 [CBIT](INFO): Clearing failed state for component AHRS_M2 2021-03-16T15:55:28.573Z,1615910128.573 [AHRS_M2] No Fault, FailCount= 1 2021-03-16T15:55:28.923Z,1615910128.923 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2021-03-16T15:55:29.353Z,1615910129.353 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2021-03-16T15:55:29.353Z,1615910129.353 [CTD_Seabird] No Fault, FailCount= 3 2021-03-16T15:55:29.452Z,1615910129.452 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2021-03-16T15:55:32.479Z,1615910132.479 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:32.887Z,1615910132.887 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:33.287Z,1615910133.287 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:33.683Z,1615910133.683 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:34.095Z,1615910134.095 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:34.108Z,1615910134.108 [CommandLine](IMPORTANT): got command quit 2021-03-16T15:55:34.507Z,1615910134.507 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:34.919Z,1615910134.919 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:35.112Z,1615910135.112 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2021-03-16T15:55:35.112Z,1615910135.112 [CommandLine ThreadHandler](INFO): Thread cancelled. 2021-03-16T15:55:35.311Z,1615910135.311 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2021-03-16T15:55:35.312Z,1615910135.312 [CommandLine ThreadHandler](INFO): Thread cancelled. 2021-03-16T15:55:35.312Z,1615910135.312 [CommandLine](INFO): Join timeout helper Thread ID is 2261 2021-03-16T15:55:35.313Z,1615910135.313 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:35.320Z,1615910135.320 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2021-03-16T15:55:35.320Z,1615910135.320 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2021-03-16T15:55:35.320Z,1615910135.320 [NavChartDb](INFO): Join timeout helper Thread ID is 2262 2021-03-16T15:55:35.404Z,1615910135.404 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2021-03-16T15:55:35.404Z,1615910135.404 [Aanderaa_O2] Communications Fault, FailCount= 2 2021-03-16T15:55:35.404Z,1615910135.404 [Aanderaa_O2](ERROR): Communications Fault 2021-03-16T15:55:35.434Z,1615910135.434 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2021-03-16T15:55:35.636Z,1615910135.636 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2021-03-16T15:55:35.636Z,1615910135.636 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2021-03-16T15:55:35.643Z,1615910135.643 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2021-03-16T15:55:35.643Z,1615910135.643 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2021-03-16T15:55:35.644Z,1615910135.644 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 2263 2021-03-16T15:55:35.755Z,1615910135.755 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:35.911Z,1615910135.911 [Aanderaa_O2](INFO): Powering down 2021-03-16T15:55:35.000Z,1615910136.000 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2021-03-16T15:55:36.000Z,1615910136.000 [WetLabsBB2FL](INFO): Powering down 2021-03-16T15:55:36.001Z,1615910136.001 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2021-03-16T15:55:36.007Z,1615910136.007 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2021-03-16T15:55:36.007Z,1615910136.007 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2021-03-16T15:55:36.008Z,1615910136.008 [CTD_Seabird](INFO): Join timeout helper Thread ID is 2264 2021-03-16T15:55:36.251Z,1615910136.251 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:36.480Z,1615910136.480 [CTD_Seabird](INFO): Powering down 2021-03-16T15:55:36.612Z,1615910136.612 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2021-03-16T15:55:36.612Z,1615910136.612 [CTD_Seabird](INFO): Powering down 2021-03-16T15:55:36.623Z,1615910136.623 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2021-03-16T15:55:36.627Z,1615910136.627 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2021-03-16T15:55:36.627Z,1615910136.627 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2021-03-16T15:55:36.628Z,1615910136.628 [Radio_Surface](INFO): Join timeout helper Thread ID is 2265 2021-03-16T15:55:36.659Z,1615910136.659 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:36.730Z,1615910136.730 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2021-03-16T15:55:36.730Z,1615910136.730 [Aanderaa_O2] No Fault, FailCount= 2 2021-03-16T15:55:36.776Z,1615910136.776 [Radio_Surface](INFO): Powering down 2021-03-16T15:55:36.777Z,1615910136.777 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2021-03-16T15:55:36.777Z,1615910136.777 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2021-03-16T15:55:36.796Z,1615910136.796 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2021-03-16T15:55:36.796Z,1615910136.796 [Onboard ThreadHandler](INFO): Thread cancelled. 2021-03-16T15:55:36.797Z,1615910136.797 [Onboard](INFO): Join timeout helper Thread ID is 2266 2021-03-16T15:55:37.055Z,1615910137.055 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:37.065Z,1615910137.065 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-03-16T15:55:37.467Z,1615910137.467 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:37.879Z,1615910137.879 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:38.267Z,1615910138.267 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:38.535Z,1615910138.535 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2021-03-16T15:55:38.536Z,1615910138.536 [Onboard ThreadHandler](INFO): Thread cancelled. 2021-03-16T15:55:38.548Z,1615910138.548 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2021-03-16T15:55:38.548Z,1615910138.548 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2021-03-16T15:55:38.549Z,1615910138.549 [DataOverHttps](INFO): Join timeout helper Thread ID is 2269 2021-03-16T15:55:38.671Z,1615910138.671 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:38.815Z,1615910138.815 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2021-03-16T15:55:38.816Z,1615910138.816 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2021-03-16T15:55:38.828Z,1615910138.828 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2021-03-16T15:55:38.828Z,1615910138.828 [logger ThreadHandler](INFO): Thread cancelled. 2021-03-16T15:55:38.829Z,1615910138.829 [logger](INFO): Join timeout helper Thread ID is 2270 2021-03-16T15:55:38.851Z,1615910138.851 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2021-03-16T15:55:38.852Z,1615910138.852 [logger ThreadHandler](INFO): Thread cancelled. 2021-03-16T15:55:38.868Z,1615910138.868 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2021-03-16T15:55:38.868Z,1615910138.868 [CommandLine ThreadHandler](INFO): Thread cancelled. 2021-03-16T15:55:38.868Z,1615910138.868 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2021-03-16T15:55:38.868Z,1615910138.868 [controlThread ThreadHandler](INFO): Thread cancelled. 2021-03-16T15:55:38.869Z,1615910138.869 [controlThread](INFO): Join timeout helper Thread ID is 2271 2021-03-16T15:55:39.083Z,1615910139.083 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-03-16T15:55:39.103Z,1615910139.103 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2021-03-16T15:55:39.103Z,1615910139.103 [controlThread](DEBUG): Uninitializing ControlThread 2021-03-16T15:55:39.104Z,1615910139.104 [AHRS_M2](INFO): Powering down 2021-03-16T15:55:39.176Z,1615910139.176 [DVL_micro](INFO): Powering down 2021-03-16T15:55:39.177Z,1615910139.177 [NAL9602](INFO): Powering down 2021-03-16T15:55:39.178Z,1615910139.178 [DAT](INFO): Powering down 2021-03-16T15:55:39.416Z,1615910139.416 [Aanderaa_O2](INFO): Powering down 2021-03-16T15:55:39.418Z,1615910139.418 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2021-03-16T15:55:39.419Z,1615910139.419 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2021-03-16T15:55:39.419Z,1615910139.419 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2021-03-16T15:55:39.421Z,1615910139.421 [MissionManager](INFO): Uninitializing Mission Default 2021-03-16T15:55:39.421Z,1615910139.421 [Default] Stopped 2021-03-16T15:55:39.421Z,1615910139.421 [Default](DEBUG): Aggregate::uninitialize Default 2021-03-16T15:55:39.421Z,1615910139.421 [Default:B.GoToSurface] Stopped 2021-03-16T15:55:39.421Z,1615910139.421 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2021-03-16T15:55:39.421Z,1615910139.421 [Default:CheckIn] Stopped 2021-03-16T15:55:39.421Z,1615910139.421 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-03-16T15:55:39.422Z,1615910139.422 [Default:CheckIn:Read_GPS] Stopped 2021-03-16T15:55:39.424Z,1615910139.424 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2021-03-16T15:55:39.426Z,1615910139.426 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2021-03-16T15:55:39.428Z,1615910139.428 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2021-03-16T15:55:39.428Z,1615910139.428 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2021-03-16T15:55:39.428Z,1615910139.428 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2021-03-16T15:55:39.429Z,1615910139.429 [BuoyancyServo](INFO): Powering down 2021-03-16T15:55:39.444Z,1615910139.444 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2021-03-16T15:55:39.444Z,1615910139.444 [ElevatorServo](INFO): Powering down 2021-03-16T15:55:39.444Z,1615910139.444 [MassServo](DEBUG): Uninitialize Mass Servo. 2021-03-16T15:55:39.445Z,1615910139.445 [MassServo](INFO): Powering down 2021-03-16T15:55:39.445Z,1615910139.445 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2021-03-16T15:55:39.445Z,1615910139.445 [RudderServo](INFO): Powering down 2021-03-16T15:55:39.446Z,1615910139.446 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2021-03-16T15:55:39.446Z,1615910139.446 [ThrusterServo](INFO): Powering down 2021-03-16T15:55:39.447Z,1615910139.447 [SBIT](DEBUG): Uninitialize SBIT Component. 2021-03-16T15:55:39.447Z,1615910139.447 [IBIT](DEBUG): Uninitialize IBIT Component. 2021-03-16T15:55:39.448Z,1615910139.448 [CBIT](DEBUG): Uninitialize CBIT Component. 2021-03-16T15:55:39.448Z,1615910139.448 [CBIT](DEBUG): Powering off loads. 2021-03-16T15:55:39.459Z,1615910139.459 [CBIT](DEBUG): Disabling WDT. 2021-03-16T15:55:39.471Z,1615910139.471 [CBIT](DEBUG): Opening all GF detection circuits. 2021-03-16T15:55:39.472Z,1615910139.472 [controlThread ThreadHandler](INFO): Thread cancelled. 2021-03-16T15:55:39.563Z,1615910139.563 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2021-03-16T15:55:39.565Z,1615910139.565 [Onboard ThreadHandler](INFO): Thread cancelled. 2021-03-16T15:55:39.571Z,1615910139.571 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2021-03-16T15:55:39.640Z,1615910139.640 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2021-03-16T15:55:39.645Z,1615910139.645 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2021-03-16T15:55:39.679Z,1615910139.679 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2021-03-16T15:55:39.741Z,1615910139.741 [logger ThreadHandler](INFO): Thread cancelled.