2020-07-06T16:39:21.474Z,1594053561.474 [Supervisor](DEBUG): Initializing supervisor. 2020-07-06T16:39:21.477Z,1594053561.477 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2020-07-06T16:39:21.478Z,1594053561.478 [SyncHandler](INFO): Protected caller Thread ID is 1146 2020-07-06T16:39:21.478Z,1594053561.478 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2020-07-06T16:39:21.479Z,1594053561.479 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2020-07-06T16:39:21.479Z,1594053561.479 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1147 2020-07-06T16:39:21.484Z,1594053561.484 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2020-07-06T16:39:21.498Z,1594053561.498 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2020-07-06T16:39:21.499Z,1594053561.499 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2020-07-06T16:39:21.499Z,1594053561.499 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1148 2020-07-06T16:39:21.500Z,1594053561.500 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2020-07-06T16:39:21.501Z,1594053561.501 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2020-07-06T16:39:21.501Z,1594053561.501 [logger ThreadHandler](INFO): Protected caller Thread ID is 1149 2020-07-06T16:39:21.503Z,1594053561.503 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2020-07-06T16:39:21.504Z,1594053561.504 [Supervisor](INFO): Looking for Config files in directory: Config/ 2020-07-06T16:39:21.505Z,1594053561.505 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2020-07-06T16:39:21.868Z,1594053561.868 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2020-07-06T16:39:21.869Z,1594053561.869 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2020-07-06T16:39:21.949Z,1594053561.949 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2020-07-06T16:39:22.390Z,1594053562.390 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2020-07-06T16:39:22.391Z,1594053562.391 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2020-07-06T16:39:22.725Z,1594053562.725 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2020-07-06T16:39:22.725Z,1594053562.725 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2020-07-06T16:39:22.822Z,1594053562.822 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2020-07-06T16:39:22.822Z,1594053562.822 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2020-07-06T16:39:23.125Z,1594053563.125 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2020-07-06T16:39:23.126Z,1594053563.126 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2020-07-06T16:39:23.321Z,1594053563.321 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2020-07-06T16:39:23.322Z,1594053563.322 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2020-07-06T16:39:23.802Z,1594053563.802 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2020-07-06T16:39:23.802Z,1594053563.802 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2020-07-06T16:39:23.906Z,1594053563.906 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2020-07-06T16:39:23.906Z,1594053563.906 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2020-07-06T16:39:24.007Z,1594053564.007 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2020-07-06T16:39:24.008Z,1594053564.008 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2020-07-06T16:39:24.705Z,1594053564.705 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2020-07-06T16:39:24.705Z,1594053564.705 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2020-07-06T16:39:25.661Z,1594053565.661 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2020-07-06T16:39:25.662Z,1594053565.662 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2020-07-06T16:39:25.861Z,1594053565.861 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2020-07-06T16:39:25.862Z,1594053565.862 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2020-07-06T16:39:26.008Z,1594053566.008 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2020-07-06T16:39:26.009Z,1594053566.009 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2020-07-06T16:39:26.158Z,1594053566.158 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2020-07-06T16:39:26.159Z,1594053566.159 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2020-07-06T16:39:26.367Z,1594053566.367 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2020-07-06T16:39:26.369Z,1594053566.369 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/ 2020-07-06T16:39:26.370Z,1594053566.370 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg 2020-07-06T16:39:26.460Z,1594053566.460 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg 2020-07-06T16:39:26.544Z,1594053566.544 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg 2020-07-06T16:39:26.642Z,1594053566.642 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg 2020-07-06T16:39:26.725Z,1594053566.725 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg 2020-07-06T16:39:26.819Z,1594053566.819 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg 2020-07-06T16:39:26.918Z,1594053566.918 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg 2020-07-06T16:39:27.126Z,1594053567.126 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/workSite.cfg 2020-07-06T16:39:27.201Z,1594053567.201 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg 2020-07-06T16:39:27.365Z,1594053567.365 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg 2020-07-06T16:39:27.510Z,1594053567.510 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg 2020-07-06T16:39:27.626Z,1594053567.626 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Battery.cfg 2020-07-06T16:39:27.863Z,1594053567.863 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2020-07-06T16:39:27.864Z,1594053567.864 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2020-07-06T16:39:27.871Z,1594053567.871 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2020-07-06T16:39:27.925Z,1594053567.925 [VerticalControl](DEBUG): Construct VerticalControl. 2020-07-06T16:39:28.042Z,1594053568.042 [VerticalControl] Loaded 2020-07-06T16:39:28.042Z,1594053568.042 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2020-07-06T16:39:28.043Z,1594053568.043 [HorizontalControl](DEBUG): Construct HorizontalControl. 2020-07-06T16:39:28.125Z,1594053568.125 [HorizontalControl] Loaded 2020-07-06T16:39:28.126Z,1594053568.126 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2020-07-06T16:39:28.127Z,1594053568.127 [SpeedControl](DEBUG): Construct SpeedControl. 2020-07-06T16:39:28.132Z,1594053568.132 [SpeedControl] Loaded 2020-07-06T16:39:28.132Z,1594053568.132 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2020-07-06T16:39:28.133Z,1594053568.133 [LoopControl](DEBUG): Construct LoopControl. 2020-07-06T16:39:28.134Z,1594053568.134 [LoopControl] Loaded 2020-07-06T16:39:28.134Z,1594053568.134 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2020-07-06T16:39:28.134Z,1594053568.134 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2020-07-06T16:39:28.135Z,1594053568.135 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2020-07-06T16:39:28.155Z,1594053568.155 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2020-07-06T16:39:28.156Z,1594053568.156 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2020-07-06T16:39:28.259Z,1594053568.259 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2020-07-06T16:39:28.260Z,1594053568.260 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2020-07-06T16:39:28.391Z,1594053568.391 [BuoyancyServo] Loaded 2020-07-06T16:39:28.392Z,1594053568.392 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2020-07-06T16:39:28.420Z,1594053568.420 [ElevatorServo] Loaded 2020-07-06T16:39:28.421Z,1594053568.421 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2020-07-06T16:39:28.449Z,1594053568.449 [MassServo] Loaded 2020-07-06T16:39:28.449Z,1594053568.449 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2020-07-06T16:39:28.477Z,1594053568.477 [RudderServo] Loaded 2020-07-06T16:39:28.477Z,1594053568.477 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2020-07-06T16:39:28.505Z,1594053568.505 [ThrusterServo] Loaded 2020-07-06T16:39:28.505Z,1594053568.505 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2020-07-06T16:39:28.505Z,1594053568.505 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2020-07-06T16:39:28.506Z,1594053568.506 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2020-07-06T16:39:28.632Z,1594053568.632 [DeadReckonUsingMultipleVelocitySources] Loaded 2020-07-06T16:39:28.632Z,1594053568.632 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2020-07-06T16:39:28.654Z,1594053568.654 [NavChart] Loaded 2020-07-06T16:39:28.654Z,1594053568.654 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2020-07-06T16:39:28.658Z,1594053568.658 [UniversalFixResidualReporter] Loaded 2020-07-06T16:39:28.658Z,1594053568.658 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2020-07-06T16:39:28.658Z,1594053568.658 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2020-07-06T16:39:28.659Z,1594053568.659 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2020-07-06T16:39:28.752Z,1594053568.752 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2020-07-06T16:39:28.753Z,1594053568.753 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2020-07-06T16:39:29.228Z,1594053569.228 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_orientation 2020-07-06T16:39:29.234Z,1594053569.234 [AHRS_M2](INFO): created writer for : platform_orientation 2020-07-06T16:39:29.236Z,1594053569.236 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_magnetic_orientation 2020-07-06T16:39:29.241Z,1594053569.241 [AHRS_M2](INFO): created writer for : platform_magnetic_orientation 2020-07-06T16:39:29.242Z,1594053569.242 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_pitch_angle 2020-07-06T16:39:29.247Z,1594053569.247 [AHRS_M2](INFO): created writer for : platform_pitch_angle 2020-07-06T16:39:29.247Z,1594053569.247 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_roll_angle 2020-07-06T16:39:29.253Z,1594053569.253 [AHRS_M2](INFO): created writer for : platform_roll_angle 2020-07-06T16:39:29.433Z,1594053569.433 [AHRS_M2] Loaded 2020-07-06T16:39:29.434Z,1594053569.434 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2020-07-06T16:39:29.686Z,1594053569.686 [DataOverHttps] Loaded 2020-07-06T16:39:29.686Z,1594053569.686 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2020-07-06T16:39:29.687Z,1594053569.687 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4089B4E0 2020-07-06T16:39:29.688Z,1594053569.688 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1235 2020-07-06T16:39:29.806Z,1594053569.806 [Depth_Keller] Loaded 2020-07-06T16:39:29.806Z,1594053569.806 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2020-07-06T16:39:29.815Z,1594053569.815 [DropWeight] Loaded 2020-07-06T16:39:29.816Z,1594053569.816 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2020-07-06T16:39:30.177Z,1594053570.177 [NAL9602] Loaded 2020-07-06T16:39:30.178Z,1594053570.178 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2020-07-06T16:39:30.309Z,1594053570.309 [Onboard] Loaded 2020-07-06T16:39:30.309Z,1594053570.309 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2020-07-06T16:39:30.310Z,1594053570.310 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408CB4E0 2020-07-06T16:39:30.310Z,1594053570.310 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 1236 2020-07-06T16:39:30.330Z,1594053570.330 [Radio_Surface] Loaded 2020-07-06T16:39:30.331Z,1594053570.331 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2020-07-06T16:39:30.332Z,1594053570.332 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408FB4E0 2020-07-06T16:39:30.332Z,1594053570.332 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1237 2020-07-06T16:39:30.544Z,1594053570.544 [DAT] Loaded 2020-07-06T16:39:30.545Z,1594053570.545 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread. 2020-07-06T16:39:32.117Z,1594053572.117 [BPC1] Loaded 2020-07-06T16:39:32.117Z,1594053572.117 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2020-07-06T16:39:32.118Z,1594053572.118 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2020-07-06T16:39:32.118Z,1594053572.118 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2020-07-06T16:39:32.161Z,1594053572.161 [DepthRateCalculator] Loaded 2020-07-06T16:39:32.161Z,1594053572.161 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2020-07-06T16:39:32.166Z,1594053572.166 [PitchRateCalculator] Loaded 2020-07-06T16:39:32.166Z,1594053572.166 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2020-07-06T16:39:32.179Z,1594053572.179 [SpeedCalculator] Loaded 2020-07-06T16:39:32.179Z,1594053572.179 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2020-07-06T16:39:32.200Z,1594053572.200 [TempGradientCalculator] Loaded 2020-07-06T16:39:32.201Z,1594053572.201 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2020-07-06T16:39:32.206Z,1594053572.206 [YawRateCalculator] Loaded 2020-07-06T16:39:32.206Z,1594053572.206 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2020-07-06T16:39:32.237Z,1594053572.237 [ElevatorOffsetCalculator] Loaded 2020-07-06T16:39:32.237Z,1594053572.237 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2020-07-06T16:39:32.237Z,1594053572.237 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2020-07-06T16:39:32.238Z,1594053572.238 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2020-07-06T16:39:32.465Z,1594053572.465 [CANONSampler] Loaded 2020-07-06T16:39:32.466Z,1594053572.466 [ComponentRegistry](DEBUG): SyncComponent "CANONSampler" handled in the control thread. 2020-07-06T16:39:32.494Z,1594053572.494 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density 2020-07-06T16:39:32.500Z,1594053572.500 [CTD_Seabird](INFO): created writer for : sea_water_density 2020-07-06T16:39:32.500Z,1594053572.500 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth 2020-07-06T16:39:32.505Z,1594053572.505 [CTD_Seabird](INFO): created writer for : depth 2020-07-06T16:39:32.505Z,1594053572.505 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure 2020-07-06T16:39:32.510Z,1594053572.510 [CTD_Seabird](INFO): created writer for : sea_water_pressure 2020-07-06T16:39:32.511Z,1594053572.511 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity 2020-07-06T16:39:32.517Z,1594053572.517 [CTD_Seabird](INFO): created writer for : sea_water_salinity 2020-07-06T16:39:32.517Z,1594053572.517 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature 2020-07-06T16:39:32.522Z,1594053572.522 [CTD_Seabird](INFO): created writer for : sea_water_temperature 2020-07-06T16:39:32.523Z,1594053572.523 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity 2020-07-06T16:39:32.529Z,1594053572.529 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity 2020-07-06T16:39:32.529Z,1594053572.529 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water 2020-07-06T16:39:32.534Z,1594053572.534 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water 2020-07-06T16:39:32.535Z,1594053572.535 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): mass_concentration_of_oxygen_in_sea_water 2020-07-06T16:39:32.540Z,1594053572.540 [CTD_Seabird](INFO): created writer for : mass_concentration_of_oxygen_in_sea_water 2020-07-06T16:39:32.541Z,1594053572.541 [CTD_Seabird](DEBUG): LcmSlateWriter::add(DAtaURI): CTD_Seabird.sea_water_dissolved_oxygen_freq 2020-07-06T16:39:32.541Z,1594053572.541 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): dataName: sea_water_dissolved_oxygen_freq 2020-07-06T16:39:32.575Z,1594053572.575 [CTD_Seabird] Loaded 2020-07-06T16:39:32.575Z,1594053572.575 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2020-07-06T16:39:32.576Z,1594053572.576 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A074E0 2020-07-06T16:39:32.577Z,1594053572.577 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1238 2020-07-06T16:39:32.609Z,1594053572.609 [PAR_Licor] Loaded 2020-07-06T16:39:32.610Z,1594053572.610 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2020-07-06T16:39:32.632Z,1594053572.632 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output470 2020-07-06T16:39:32.632Z,1594053572.632 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output470 2020-07-06T16:39:32.637Z,1594053572.637 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output650 2020-07-06T16:39:32.637Z,1594053572.637 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output650 2020-07-06T16:39:32.642Z,1594053572.642 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.OutputChl 2020-07-06T16:39:32.642Z,1594053572.642 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: OutputChl 2020-07-06T16:39:32.646Z,1594053572.646 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg470nm 2020-07-06T16:39:32.646Z,1594053572.646 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg470nm 2020-07-06T16:39:32.651Z,1594053572.651 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg650nm 2020-07-06T16:39:32.651Z,1594053572.651 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg650nm 2020-07-06T16:39:32.655Z,1594053572.655 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff470nm 2020-07-06T16:39:32.656Z,1594053572.656 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff470nm 2020-07-06T16:39:32.660Z,1594053572.660 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff650nm 2020-07-06T16:39:32.660Z,1594053572.660 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff650nm 2020-07-06T16:39:32.664Z,1594053572.664 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): mass_concentration_of_chlorophyll_in_sea_water 2020-07-06T16:39:32.669Z,1594053572.669 [WetLabsBB2FL](INFO): created writer for : mass_concentration_of_chlorophyll_in_sea_water 2020-07-06T16:39:32.670Z,1594053572.670 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water 2020-07-06T16:39:32.670Z,1594053572.670 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_median_mass_concentration_of_chlorophyll_in_sea_water 2020-07-06T16:39:32.674Z,1594053572.674 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water 2020-07-06T16:39:32.674Z,1594053572.674 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_mean_mass_concentration_of_chlorophyll_in_sea_water 2020-07-06T16:39:32.679Z,1594053572.679 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_variance_mass_concentration_of_chlorophyll_in_sea_water 2020-07-06T16:39:32.679Z,1594053572.679 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_variance_mass_concentration_of_chlorophyll_in_sea_water 2020-07-06T16:39:32.684Z,1594053572.684 [WetLabsBB2FL] Loaded 2020-07-06T16:39:32.684Z,1594053572.684 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2020-07-06T16:39:32.685Z,1594053572.685 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A374E0 2020-07-06T16:39:32.686Z,1594053572.686 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1239 2020-07-06T16:39:32.687Z,1594053572.687 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2020-07-06T16:39:32.687Z,1594053572.687 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2020-07-06T16:39:32.717Z,1594053572.717 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2020-07-06T16:39:32.718Z,1594053572.718 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2020-07-06T16:39:33.030Z,1594053573.030 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2020-07-06T16:39:33.030Z,1594053573.030 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2020-07-06T16:39:33.184Z,1594053573.184 [SBIT](DEBUG): Construct Startup Built In Test. 2020-07-06T16:39:33.195Z,1594053573.195 [SBIT] Loaded 2020-07-06T16:39:33.195Z,1594053573.195 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2020-07-06T16:39:33.196Z,1594053573.196 [IBIT](DEBUG): Construct Initiated Built In Test. 2020-07-06T16:39:33.209Z,1594053573.209 [IBIT] Loaded 2020-07-06T16:39:33.209Z,1594053573.209 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2020-07-06T16:39:33.212Z,1594053573.212 [CBIT](DEBUG): Construct Continuous Built In Test. 2020-07-06T16:39:33.356Z,1594053573.356 [CBIT] Loaded 2020-07-06T16:39:33.356Z,1594053573.356 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2020-07-06T16:39:33.357Z,1594053573.357 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2020-07-06T16:39:33.357Z,1594053573.357 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2020-07-06T16:39:33.442Z,1594053573.442 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2020-07-06T16:39:33.446Z,1594053573.446 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2020-07-06T16:39:33.447Z,1594053573.447 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2020-07-06T16:39:33.454Z,1594053573.454 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2020-07-06T16:39:33.455Z,1594053573.455 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B5D4E0 2020-07-06T16:39:33.455Z,1594053573.455 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1240 2020-07-06T16:39:33.460Z,1594053573.460 [Supervisor](INFO): Main Thread ID is 1145 2020-07-06T16:39:33.460Z,1594053573.460 [Supervisor](DEBUG): Running supervisor. 2020-07-06T16:39:33.461Z,1594053573.461 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1241 2020-07-06T16:39:33.463Z,1594053573.463 [controlThread ThreadHandler](INFO): Handler Thread ID is 1242 2020-07-06T16:39:33.464Z,1594053573.464 [controlThread](DEBUG): Initializing ControlThread 2020-07-06T16:39:33.464Z,1594053573.464 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2020-07-06T16:39:33.466Z,1594053573.466 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2020-07-06T16:39:33.467Z,1594053573.467 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2020-07-06T16:39:33.467Z,1594053573.467 [LoopControl](DEBUG): Initialize LoopControlComponent. 2020-07-06T16:39:33.469Z,1594053573.469 [NavChart](DEBUG): Initialize NavChart Navigation. 2020-07-06T16:39:33.470Z,1594053573.470 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2020-07-06T16:39:33.473Z,1594053573.473 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2020-07-06T16:39:33.473Z,1594053573.473 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2020-07-06T16:39:33.474Z,1594053573.474 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2020-07-06T16:39:33.474Z,1594053573.474 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2020-07-06T16:39:33.474Z,1594053573.474 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2020-07-06T16:39:33.475Z,1594053573.475 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2020-07-06T16:39:33.479Z,1594053573.479 [SBIT](INFO): Initialize SBIT Component. 2020-07-06T16:39:33.480Z,1594053573.480 [SBIT](IMPORTANT): git: 2020-06-09-119-gf51179b 2020-07-06T16:39:33.480Z,1594053573.480 [SBIT](INFO): git hash: f51179b25bbff3b65d8e06753bebb0790d3f8ed6 2020-07-06T16:39:33.480Z,1594053573.480 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2020-07-06T16:39:33.481Z,1594053573.481 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018 Kernel Reported: #1 PREEMPT Wed Nov 13 12:38:10 PST 2019 2020-07-06T16:39:33.482Z,1594053573.482 [SBIT](INFO): Beginning SBIT in 67.000000 seconds. 2020-07-06T16:39:33.483Z,1594053573.483 [IBIT](INFO): Initialize IBIT Component. 2020-07-06T16:39:33.484Z,1594053573.484 [CBIT](DEBUG): Initialize CBIT Component. 2020-07-06T16:39:33.485Z,1594053573.485 [logger ThreadHandler](INFO): Handler Thread ID is 1243 2020-07-06T16:39:33.495Z,1594053573.495 [CBIT](DEBUG): Initialized mux pins. 2020-07-06T16:39:33.495Z,1594053573.495 [CBIT](DEBUG): Initializing the watchdog timer. 2020-07-06T16:39:33.503Z,1594053573.503 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1244 2020-07-06T16:39:33.504Z,1594053573.504 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2020-07-06T16:39:33.515Z,1594053573.515 [Onboard ThreadHandler](INFO): Handler Thread ID is 1245 2020-07-06T16:39:33.520Z,1594053573.520 [CBIT](CRITICAL): Watchdog Timer failed to initialize. 2020-07-06T16:39:33.520Z,1594053573.520 [CBIT] Hardware Fault, FailCount= 1 2020-07-06T16:39:33.520Z,1594053573.520 [CBIT](ERROR): Hardware Fault 2020-07-06T16:39:33.520Z,1594053573.520 [CBIT](DEBUG): Initializing heartbeat. 2020-07-06T16:39:33.546Z,1594053573.546 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1246 2020-07-06T16:39:33.560Z,1594053573.560 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1247 2020-07-06T16:39:33.560Z,1594053573.560 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2020-07-06T16:39:33.564Z,1594053573.564 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1249 2020-07-06T16:39:33.565Z,1594053573.565 [WetLabsBB2FL](INFO): Powering down 2020-07-06T16:39:33.591Z,1594053573.591 [CBIT](DEBUG): Deactivating GF circuits. 2020-07-06T16:39:33.591Z,1594053573.591 [CBIT](DEBUG): Deactivating emergency mode. 2020-07-06T16:39:33.656Z,1594053573.656 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1250 2020-07-06T16:39:33.657Z,1594053573.657 [CBIT](DEBUG): Backplane powered. 2020-07-06T16:39:33.658Z,1594053573.658 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2020-07-06T16:39:33.784Z,1594053573.784 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2020-07-06T16:39:33.787Z,1594053573.787 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2020-07-06T16:39:33.788Z,1594053573.788 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2020-07-06T16:39:33.788Z,1594053573.788 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2020-07-06T16:39:33.788Z,1594053573.788 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2020-07-06T16:39:33.788Z,1594053573.788 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2020-07-06T16:39:33.789Z,1594053573.789 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2020-07-06T16:39:33.789Z,1594053573.789 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2020-07-06T16:39:33.789Z,1594053573.789 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2020-07-06T16:39:33.789Z,1594053573.789 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2020-07-06T16:39:33.789Z,1594053573.789 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2020-07-06T16:39:33.789Z,1594053573.789 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2020-07-06T16:39:33.790Z,1594053573.790 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2020-07-06T16:39:33.790Z,1594053573.790 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2020-07-06T16:39:33.790Z,1594053573.790 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2020-07-06T16:39:33.790Z,1594053573.790 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2020-07-06T16:39:33.790Z,1594053573.790 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2020-07-06T16:39:33.873Z,1594053573.873 [MissionManager](DEBUG): 2020-07-06T16:39:33.874Z,1594053573.874 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2020-07-06T16:39:33.951Z,1594053573.951 [Radio_Surface](INFO): Powering up 2020-07-06T16:39:33.992Z,1594053573.992 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2020-07-06T16:39:33.993Z,1594053573.993 [Default:A.Wait](DEBUG): Construct Wait. 2020-07-06T16:39:33.994Z,1594053573.994 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2020-07-06T16:39:34.014Z,1594053574.014 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2020-07-06T16:39:34.039Z,1594053574.039 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2020-07-06T16:39:34.061Z,1594053574.061 [Default:E.Execute](DEBUG): Construct Execute. 2020-07-06T16:39:34.065Z,1594053574.065 [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 2020-07-06T16:39:34.071Z,1594053574.071 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,DropWeight,NAL9602,DAT,BPC1,CANONSampler,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, 2020-07-06T16:39:34.091Z,1594053574.091 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2020-07-06T16:39:34.205Z,1594053574.205 [Depth_Keller](ERROR): Pressure reading out of range: 1831.023193 decibar 2020-07-06T16:39:34.209Z,1594053574.209 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2 2020-07-06T16:39:34.209Z,1594053574.209 [DAT](INFO): Powering up 2020-07-06T16:39:34.209Z,1594053574.209 [DAT](DEBUG): Initializing DAT. 2020-07-06T16:39:34.255Z,1594053574.255 [CANONSampler](INFO): Powering down 2020-07-06T16:39:34.259Z,1594053574.259 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2 2020-07-06T16:39:34.366Z,1594053574.366 [DepthRateCalculator](ERROR): Depth measurement is not active 2020-07-06T16:39:34.441Z,1594053574.441 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2020-07-06T16:39:34.447Z,1594053574.447 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2020-07-06T16:39:34.449Z,1594053574.449 [ElevatorServo](DEBUG): Initializing EZServoServo. 2020-07-06T16:39:34.455Z,1594053574.455 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2020-07-06T16:39:34.456Z,1594053574.456 [MassServo](DEBUG): Initializing EZServoServo. 2020-07-06T16:39:34.463Z,1594053574.463 [MassServo](DEBUG): Initializing MassServo. 2020-07-06T16:39:34.464Z,1594053574.464 [RudderServo](DEBUG): Initializing EZServoServo. 2020-07-06T16:39:34.471Z,1594053574.471 [RudderServo](DEBUG): Initializing RudderServo. 2020-07-06T16:39:34.472Z,1594053574.472 [ThrusterServo](DEBUG): Initializing EZServoServo. 2020-07-06T16:39:34.479Z,1594053574.479 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2020-07-06T16:39:34.481Z,1594053574.481 [CBIT](DEBUG): Uninitialize CBIT Component. 2020-07-06T16:39:34.481Z,1594053574.481 [CBIT](DEBUG): Powering off loads. 2020-07-06T16:39:34.495Z,1594053574.495 [CBIT](DEBUG): Disabling WDT. 2020-07-06T16:39:34.507Z,1594053574.507 [CBIT](DEBUG): Opening all GF detection circuits. 2020-07-06T16:39:35.667Z,1594053575.667 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2020-07-06T16:39:35.667Z,1594053575.667 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2020-07-06T16:39:35.667Z,1594053575.667 [BuoyancyServo] Communications Fault, FailCount= 1 2020-07-06T16:39:35.667Z,1594053575.667 [BuoyancyServo](ERROR): Communications Fault 2020-07-06T16:39:35.979Z,1594053575.979 [ElevatorServo](ERROR): Elevator initialization uart error I:serial timeout 2020-07-06T16:39:35.979Z,1594053575.979 [ElevatorServo](FAULT): Elevator failed to initialize 2020-07-06T16:39:35.979Z,1594053575.979 [ElevatorServo] Communications Fault, FailCount= 1 2020-07-06T16:39:35.979Z,1594053575.979 [ElevatorServo](ERROR): Communications Fault 2020-07-06T16:39:36.283Z,1594053576.283 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2020-07-06T16:39:36.283Z,1594053576.283 [RudderServo](FAULT): Rudder failed to initialize 2020-07-06T16:39:36.283Z,1594053576.283 [RudderServo] Communications Fault, FailCount= 1 2020-07-06T16:39:36.283Z,1594053576.283 [RudderServo](ERROR): Communications Fault 2020-07-06T16:39:36.607Z,1594053576.607 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2020-07-06T16:39:36.931Z,1594053576.931 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout 2020-07-06T16:39:36.931Z,1594053576.931 [ThrusterServo](FAULT): Thruster failed to initialize 2020-07-06T16:39:36.931Z,1594053576.931 [ThrusterServo] Communications Fault, FailCount= 1 2020-07-06T16:39:36.931Z,1594053576.931 [ThrusterServo](ERROR): Communications Fault 2020-07-06T16:39:36.977Z,1594053576.977 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2020-07-06T16:39:36.978Z,1594053576.978 [ElevatorServo](INFO): Powering down 2020-07-06T16:39:37.307Z,1594053577.307 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout 2020-07-06T16:39:37.307Z,1594053577.307 [MassServo] Communications Fault, FailCount= 1 2020-07-06T16:39:37.307Z,1594053577.307 [MassServo](ERROR): Communications Fault 2020-07-06T16:39:37.308Z,1594053577.308 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2020-07-06T16:39:37.308Z,1594053577.308 [RudderServo](INFO): Powering down 2020-07-06T16:39:37.309Z,1594053577.309 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2020-07-06T16:39:37.309Z,1594053577.309 [ThrusterServo](INFO): Powering down 2020-07-06T16:39:37.459Z,1594053577.459 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2020-07-06T16:39:37.503Z,1594053577.503 [ElevatorServo](FAULT): LCB fault: Current Limiter Activated. 2020-07-06T16:39:37.503Z,1594053577.503 [ElevatorServo] Hardware Fault, FailCount= 1 2020-07-06T16:39:37.503Z,1594053577.503 [ElevatorServo](ERROR): Hardware Fault 2020-07-06T16:39:37.523Z,1594053577.523 [MassServo](DEBUG): Uninitialize Mass Servo. 2020-07-06T16:39:37.523Z,1594053577.523 [MassServo](INFO): Powering down 2020-07-06T16:39:37.524Z,1594053577.524 [RudderServo](FAULT): LCB fault: Current Limiter Activated. 2020-07-06T16:39:37.524Z,1594053577.524 [RudderServo] Hardware Fault, FailCount= 1 2020-07-06T16:39:37.524Z,1594053577.524 [RudderServo](ERROR): Hardware Fault 2020-07-06T16:39:37.525Z,1594053577.525 [ThrusterServo](FAULT): LCB fault: Current Limiter Activated. 2020-07-06T16:39:37.525Z,1594053577.525 [ThrusterServo] Hardware Fault, FailCount= 1 2020-07-06T16:39:37.525Z,1594053577.525 [ThrusterServo](ERROR): Hardware Fault 2020-07-06T16:39:37.859Z,1594053577.859 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2020-07-06T16:39:37.887Z,1594053577.887 [ElevatorServo](DEBUG): Initializing EZServoServo. 2020-07-06T16:39:38.008Z,1594053578.008 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2020-07-06T16:39:38.009Z,1594053578.009 [MassServo](FAULT): LCB fault: Current Limiter Activated. 2020-07-06T16:39:38.009Z,1594053578.009 [MassServo] Hardware Fault, FailCount= 1 2020-07-06T16:39:38.009Z,1594053578.009 [MassServo](ERROR): Hardware Fault 2020-07-06T16:39:38.010Z,1594053578.010 [RudderServo](DEBUG): Initializing EZServoServo. 2020-07-06T16:39:38.128Z,1594053578.128 [RudderServo](DEBUG): Initializing RudderServo. 2020-07-06T16:39:38.371Z,1594053578.371 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2020-07-06T16:39:38.399Z,1594053578.399 [MassServo](DEBUG): Initializing EZServoServo. 2020-07-06T16:39:38.521Z,1594053578.521 [MassServo](DEBUG): Initializing MassServo. 2020-07-06T16:39:38.771Z,1594053578.771 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2020-07-06T16:39:40.387Z,1594053580.387 [AHRS_M2](ERROR): Clear channel UART error: serial timeout 2020-07-06T16:39:40.483Z,1594053580.483 [AHRS_M2](ERROR): Subscribe Pitch UART error: serial timeout 2020-07-06T16:39:40.791Z,1594053580.791 [AHRS_M2](ERROR): Clear channel UART error: serial timeout 2020-07-06T16:39:40.887Z,1594053580.887 [AHRS_M2](ERROR): Subscribe Pitch UART error: serial timeout 2020-07-06T16:39:41.579Z,1594053581.579 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2020-07-06T16:39:42.387Z,1594053582.387 [AHRS_M2](ERROR): Subscribe Yaw UART error: serial timeout 2020-07-06T16:39:43.195Z,1594053583.195 [AHRS_M2](ERROR): Subscribe Magnetometer UART error: serial timeout 2020-07-06T16:39:43.599Z,1594053583.599 [AHRS_M2](ERROR): Subscribe Magnetometer UART error: serial timeout 2020-07-06T16:39:46.015Z,1594053586.015 [AHRS_M2](ERROR): Subscribe MagBufferActiveIndex UART error: serial timeout 2020-07-06T16:39:46.419Z,1594053586.419 [AHRS_M2](ERROR): Subscribe MagBufferActiveIndex UART error: serial timeout 2020-07-06T16:39:46.615Z,1594053586.615 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2020-07-06T16:39:46.615Z,1594053586.615 [CTD_Seabird] Communications Fault, FailCount= 1 2020-07-06T16:39:46.615Z,1594053586.615 [CTD_Seabird](ERROR): Communications Fault 2020-07-06T16:39:47.019Z,1594053587.019 [CTD_Seabird](INFO): Powering down 2020-07-06T16:39:47.235Z,1594053587.235 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2020-07-06T16:39:47.235Z,1594053587.235 [AHRS_M2](FAULT): Failed to initialize within timeout. 2020-07-06T16:39:47.235Z,1594053587.235 [AHRS_M2] Communications Fault, FailCount= 1 2020-07-06T16:39:47.235Z,1594053587.235 [AHRS_M2](ERROR): Communications Fault 2020-07-06T16:39:47.543Z,1594053587.543 [AHRS_M2](INFO): Powering down 2020-07-06T16:40:00.477Z,1594053600.477 [NAL9602](INFO): Powering up NAL9602 2020-07-06T16:40:21.077Z,1594053621.077 [NAL9602](ERROR): NAL9602 initialization error. 2020-07-06T16:40:21.077Z,1594053621.077 [NAL9602] Communications Fault, FailCount= 1 2020-07-06T16:40:21.077Z,1594053621.077 [NAL9602](ERROR): Communications Fault 2020-07-06T16:40:21.484Z,1594053621.484 [NAL9602](INFO): Powering down 2020-07-06T16:40:34.412Z,1594053634.412 [DAT](FAULT): failed to initialize, no bytes available on serial interface 2020-07-06T16:40:34.413Z,1594053634.413 [DAT] Communications Fault, FailCount= 1 2020-07-06T16:40:34.413Z,1594053634.413 [DAT](ERROR): Communications Fault 2020-07-06T16:40:34.816Z,1594053634.816 [DAT](INFO): Powering down 2020-07-06T16:40:35.220Z,1594053635.220 [DAT](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated. 2020-07-06T16:40:35.220Z,1594053635.220 [DAT] Hardware Fault, FailCount= 1 2020-07-06T16:40:35.220Z,1594053635.220 [DAT](ERROR): Hardware Fault 2020-07-06T16:40:40.083Z,1594053640.083 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-07-06T16:40:40.097Z,1594053640.097 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-07-06T16:40:40.909Z,1594053640.909 [SBIT](IMPORTANT): Beginning Startup BIT 2020-07-06T16:40:50.640Z,1594053650.640 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-07-06T16:40:51.055Z,1594053651.055 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-07-06T16:40:54.231Z,1594053654.231 [SBIT](ERROR): Could not read elevatorAngleReader_. 2020-07-06T16:40:54.231Z,1594053654.231 [SBIT](ERROR): Could not read rudderAngleReader_. 2020-07-06T16:40:54.231Z,1594053654.231 [SBIT](ERROR): Could not read massPosReader_. 2020-07-06T16:41:01.551Z,1594053661.551 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-07-06T16:41:01.967Z,1594053661.967 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-07-06T16:41:12.456Z,1594053672.456 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-07-06T16:41:12.525Z,1594053672.525 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-07-06T16:41:20.884Z,1594053680.884 [SBIT](ERROR): Could not read elevatorAngleReader_. 2020-07-06T16:41:20.884Z,1594053680.884 [SBIT](ERROR): Could not read rudderAngleReader_. 2020-07-06T16:41:20.884Z,1594053680.884 [SBIT](ERROR): Could not read massPosReader_. 2020-07-06T16:41:20.885Z,1594053680.885 [SBIT](FAULT): Control surface position failure. 2020-07-06T16:41:23.368Z,1594053683.368 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-07-06T16:41:23.770Z,1594053683.770 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-07-06T16:41:33.811Z,1594053693.811 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2020-07-06T16:41:33.811Z,1594053693.811 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2020-07-06T16:41:33.811Z,1594053693.811 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-07-06T16:41:34.272Z,1594053694.272 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-07-06T16:41:34.676Z,1594053694.676 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-07-06T16:41:34.697Z,1594053694.697 [SBIT](ERROR): Could not read elevatorAngleReader_. 2020-07-06T16:41:34.697Z,1594053694.697 [SBIT](ERROR): Could not read rudderAngleReader_. 2020-07-06T16:41:34.697Z,1594053694.697 [SBIT](ERROR): Could not read massPosReader_. 2020-07-06T16:41:34.697Z,1594053694.697 [SBIT](FAULT): Control surface position failure. 2020-07-06T16:41:35.051Z,1594053695.051 [SBIT](CRITICAL): SBIT FAILED 2020-07-06T16:41:35.051Z,1594053695.051 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2020-07-06T16:41:35.052Z,1594053695.052 [SBIT](IMPORTANT): CBIT.gf24Offset=-26 microampere; 2020-07-06T16:41:35.052Z,1594053695.052 [SBIT](IMPORTANT): Express linearApproximation platform_average_power 1.000000 watt; 2020-07-06T16:41:35.052Z,1594053695.052 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=281.405558 cubic_centimeter; 2020-07-06T16:41:35.052Z,1594053695.052 [SBIT](IMPORTANT): VerticalControl.massDefault=-11.988931 millimeter; 2020-07-06T16:41:35.432Z,1594053695.432 [MissionManager](IMPORTANT): Started mission Startup 2020-07-06T16:41:35.433Z,1594053695.433 [Startup] Running Loop=1 2020-07-06T16:41:35.433Z,1594053695.433 [Startup](DEBUG): Aggregate::initialize Startup 2020-07-06T16:41:35.433Z,1594053695.433 [Startup:A.GoToSurface] Running Loop=1 2020-07-06T16:41:35.433Z,1594053695.433 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2020-07-06T16:41:35.434Z,1594053695.434 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2020-07-06T16:41:35.434Z,1594053695.434 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2020-07-06T16:41:35.434Z,1594053695.434 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2020-07-06T16:41:35.435Z,1594053695.435 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2020-07-06T16:41:35.435Z,1594053695.435 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2020-07-06T16:41:35.437Z,1594053695.437 [Startup:StartupSatComms] Running Loop=1 2020-07-06T16:41:35.437Z,1594053695.437 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2020-07-06T16:41:35.437Z,1594053695.437 [Startup:StartupSatComms:A] Running Loop=1 2020-07-06T16:41:35.828Z,1594053695.828 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2020-07-06T16:41:44.773Z,1594053704.773 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-07-06T16:41:45.586Z,1594053705.586 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-07-06T16:41:56.088Z,1594053716.088 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-07-06T16:41:56.491Z,1594053716.491 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-07-06T16:42:07.000Z,1594053727.000 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-07-06T16:42:07.404Z,1594053727.404 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-07-06T16:42:17.903Z,1594053737.903 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-07-06T16:42:18.307Z,1594053738.307 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-07-06T16:42:29.218Z,1594053749.218 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-07-06T16:42:35.622Z,1594053755.622 [Startup:StartupSatComms:A](INFO): Timed out from 2020-07-06T16:41:35.4Z 2020-07-06T16:42:35.622Z,1594053755.622 [Startup:StartupSatComms:A] Stopped 2020-07-06T16:42:35.622Z,1594053755.622 [Startup:StartupSatComms:B] Running Loop=1 2020-07-06T16:42:36.027Z,1594053756.027 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2020-07-06T16:42:40.123Z,1594053760.123 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-07-06T16:42:51.036Z,1594053771.036 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-07-06T16:43:01.939Z,1594053781.939 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-07-06T16:43:12.851Z,1594053792.851 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-07-06T16:43:23.781Z,1594053803.781 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-07-06T16:43:34.664Z,1594053814.664 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-07-06T16:43:35.819Z,1594053815.819 [Startup:StartupSatComms:B](INFO): Timed out from 2020-07-06T16:42:35.6Z 2020-07-06T16:43:35.819Z,1594053815.819 [Startup:StartupSatComms:B] Stopped 2020-07-06T16:43:35.819Z,1594053815.819 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2020-07-06T16:43:35.819Z,1594053815.819 [Startup:StartupSatComms] Stopped 2020-07-06T16:43:35.819Z,1594053815.819 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2020-07-06T16:43:35.820Z,1594053815.820 [Startup](INFO): Completed Startup 2020-07-06T16:43:35.820Z,1594053815.820 [MissionManager](INFO): Startup is completed. 2020-07-0