2020-08-20T15:01:47.808Z,1597935707.808 [Supervisor](DEBUG): Initializing supervisor. 2020-08-20T15:01:47.811Z,1597935707.811 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2020-08-20T15:01:47.812Z,1597935707.812 [SyncHandler](INFO): Protected caller Thread ID is 6948 2020-08-20T15:01:47.813Z,1597935707.813 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2020-08-20T15:01:47.814Z,1597935707.814 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2020-08-20T15:01:47.814Z,1597935707.814 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 6949 2020-08-20T15:01:47.817Z,1597935707.817 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2020-08-20T15:01:47.831Z,1597935707.831 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2020-08-20T15:01:47.832Z,1597935707.832 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2020-08-20T15:01:47.832Z,1597935707.832 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 6950 2020-08-20T15:01:47.833Z,1597935707.833 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2020-08-20T15:01:47.834Z,1597935707.834 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2020-08-20T15:01:47.834Z,1597935707.834 [logger ThreadHandler](INFO): Protected caller Thread ID is 6951 2020-08-20T15:01:47.836Z,1597935707.836 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2020-08-20T15:01:47.837Z,1597935707.837 [Supervisor](INFO): Looking for Config files in directory: Config/ 2020-08-20T15:01:47.839Z,1597935707.839 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2020-08-20T15:01:47.934Z,1597935707.934 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2020-08-20T15:01:47.935Z,1597935707.935 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2020-08-20T15:01:48.576Z,1597935708.576 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2020-08-20T15:01:48.577Z,1597935708.577 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2020-08-20T15:01:48.783Z,1597935708.783 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2020-08-20T15:01:48.783Z,1597935708.783 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2020-08-20T15:01:48.884Z,1597935708.884 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2020-08-20T15:01:48.884Z,1597935708.884 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2020-08-20T15:01:48.989Z,1597935708.989 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2020-08-20T15:01:48.989Z,1597935708.989 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2020-08-20T15:01:49.070Z,1597935709.070 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2020-08-20T15:01:49.212Z,1597935709.212 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2020-08-20T15:01:49.212Z,1597935709.212 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2020-08-20T15:01:49.523Z,1597935709.523 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2020-08-20T15:01:49.524Z,1597935709.524 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2020-08-20T15:01:50.019Z,1597935710.019 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2020-08-20T15:01:50.020Z,1597935710.020 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2020-08-20T15:01:50.169Z,1597935710.169 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2020-08-20T15:01:50.170Z,1597935710.170 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2020-08-20T15:01:50.382Z,1597935710.382 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2020-08-20T15:01:50.382Z,1597935710.382 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2020-08-20T15:01:50.894Z,1597935710.894 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2020-08-20T15:01:50.895Z,1597935710.895 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2020-08-20T15:01:51.125Z,1597935711.125 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2020-08-20T15:01:51.125Z,1597935711.125 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2020-08-20T15:01:51.368Z,1597935711.368 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2020-08-20T15:01:51.369Z,1597935711.369 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2020-08-20T15:01:52.145Z,1597935712.145 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2020-08-20T15:01:52.146Z,1597935712.146 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2020-08-20T15:01:52.505Z,1597935712.505 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2020-08-20T15:01:52.507Z,1597935712.507 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/ 2020-08-20T15:01:52.508Z,1597935712.508 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg 2020-08-20T15:01:52.591Z,1597935712.591 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg 2020-08-20T15:01:52.758Z,1597935712.758 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg 2020-08-20T15:01:52.869Z,1597935712.869 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg 2020-08-20T15:01:52.954Z,1597935712.954 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg 2020-08-20T15:01:53.050Z,1597935713.050 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg 2020-08-20T15:01:53.266Z,1597935713.266 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg 2020-08-20T15:01:53.498Z,1597935713.498 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2020-08-20T15:01:53.498Z,1597935713.498 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg 2020-08-20T15:01:53.593Z,1597935713.593 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg 2020-08-20T15:01:53.693Z,1597935713.693 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg 2020-08-20T15:01:53.828Z,1597935713.828 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg 2020-08-20T15:01:53.929Z,1597935713.929 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/root/ 2020-08-20T15:01:53.930Z,1597935713.930 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2020-08-20T15:01:53.938Z,1597935713.938 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2020-08-20T15:01:54.013Z,1597935714.013 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2020-08-20T15:01:54.013Z,1597935714.013 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2020-08-20T15:01:54.060Z,1597935714.060 [VerticalControl](DEBUG): Construct VerticalControl. 2020-08-20T15:01:54.174Z,1597935714.174 [VerticalControl] Loaded 2020-08-20T15:01:54.174Z,1597935714.174 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2020-08-20T15:01:54.175Z,1597935714.175 [HorizontalControl](DEBUG): Construct HorizontalControl. 2020-08-20T15:01:54.257Z,1597935714.257 [HorizontalControl] Loaded 2020-08-20T15:01:54.257Z,1597935714.257 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2020-08-20T15:01:54.258Z,1597935714.258 [SpeedControl](DEBUG): Construct SpeedControl. 2020-08-20T15:01:54.264Z,1597935714.264 [SpeedControl] Loaded 2020-08-20T15:01:54.264Z,1597935714.264 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2020-08-20T15:01:54.265Z,1597935714.265 [LoopControl](DEBUG): Construct LoopControl. 2020-08-20T15:01:54.265Z,1597935714.265 [LoopControl] Loaded 2020-08-20T15:01:54.265Z,1597935714.265 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2020-08-20T15:01:54.266Z,1597935714.266 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2020-08-20T15:01:54.266Z,1597935714.266 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2020-08-20T15:01:54.307Z,1597935714.307 [DepthRateCalculator] Loaded 2020-08-20T15:01:54.307Z,1597935714.307 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2020-08-20T15:01:54.312Z,1597935714.312 [PitchRateCalculator] Loaded 2020-08-20T15:01:54.313Z,1597935714.313 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2020-08-20T15:01:54.328Z,1597935714.328 [SpeedCalculator] Loaded 2020-08-20T15:01:54.329Z,1597935714.329 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2020-08-20T15:01:54.350Z,1597935714.350 [TempGradientCalculator] Loaded 2020-08-20T15:01:54.351Z,1597935714.351 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2020-08-20T15:01:54.356Z,1597935714.356 [YawRateCalculator] Loaded 2020-08-20T15:01:54.356Z,1597935714.356 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2020-08-20T15:01:54.386Z,1597935714.386 [ElevatorOffsetCalculator] Loaded 2020-08-20T15:01:54.386Z,1597935714.386 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2020-08-20T15:01:54.387Z,1597935714.387 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2020-08-20T15:01:54.387Z,1597935714.387 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2020-08-20T15:01:54.413Z,1597935714.413 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2020-08-20T15:01:54.413Z,1597935714.413 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2020-08-20T15:01:54.494Z,1597935714.494 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2020-08-20T15:01:54.495Z,1597935714.495 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2020-08-20T15:01:54.776Z,1597935714.776 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2020-08-20T15:01:54.776Z,1597935714.776 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2020-08-20T15:01:54.871Z,1597935714.871 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2020-08-20T15:01:54.872Z,1597935714.872 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2020-08-20T15:01:55.180Z,1597935715.180 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_orientation 2020-08-20T15:01:55.185Z,1597935715.185 [AHRS_M2](INFO): created writer for : platform_orientation 2020-08-20T15:01:55.187Z,1597935715.187 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_magnetic_orientation 2020-08-20T15:01:55.192Z,1597935715.192 [AHRS_M2](INFO): created writer for : platform_magnetic_orientation 2020-08-20T15:01:55.193Z,1597935715.193 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_pitch_angle 2020-08-20T15:01:55.198Z,1597935715.198 [AHRS_M2](INFO): created writer for : platform_pitch_angle 2020-08-20T15:01:55.198Z,1597935715.198 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_roll_angle 2020-08-20T15:01:55.204Z,1597935715.204 [AHRS_M2](INFO): created writer for : platform_roll_angle 2020-08-20T15:01:55.276Z,1597935715.276 [AHRS_M2] Loaded 2020-08-20T15:01:55.276Z,1597935715.276 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2020-08-20T15:01:55.356Z,1597935715.356 [DataOverHttps] Loaded 2020-08-20T15:01:55.356Z,1597935715.356 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2020-08-20T15:01:55.357Z,1597935715.357 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409054E0 2020-08-20T15:01:55.357Z,1597935715.357 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 7033 2020-08-20T15:01:55.371Z,1597935715.371 [Depth_Keller] Loaded 2020-08-20T15:01:55.371Z,1597935715.371 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2020-08-20T15:01:55.376Z,1597935715.376 [DropWeight] Loaded 2020-08-20T15:01:55.376Z,1597935715.376 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2020-08-20T15:01:55.474Z,1597935715.474 [NAL9602] Loaded 2020-08-20T15:01:55.474Z,1597935715.474 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2020-08-20T15:01:55.523Z,1597935715.523 [Onboard] Loaded 2020-08-20T15:01:55.523Z,1597935715.523 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2020-08-20T15:01:55.524Z,1597935715.524 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409354E0 2020-08-20T15:01:55.524Z,1597935715.524 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 7034 2020-08-20T15:01:55.528Z,1597935715.528 [Radio_Surface] Loaded 2020-08-20T15:01:55.528Z,1597935715.528 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2020-08-20T15:01:55.529Z,1597935715.529 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409654E0 2020-08-20T15:01:55.529Z,1597935715.529 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 7035 2020-08-20T15:01:55.663Z,1597935715.663 [DAT] Loaded 2020-08-20T15:01:55.664Z,1597935715.664 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread. 2020-08-20T15:01:57.474Z,1597935717.474 [BPC1] Loaded 2020-08-20T15:01:57.474Z,1597935717.474 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2020-08-20T15:01:57.474Z,1597935717.474 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2020-08-20T15:01:57.475Z,1597935717.475 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2020-08-20T15:01:57.757Z,1597935717.757 [DeadReckonUsingMultipleVelocitySources] Loaded 2020-08-20T15:01:57.757Z,1597935717.757 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2020-08-20T15:01:57.779Z,1597935717.779 [NavChart] Loaded 2020-08-20T15:01:57.779Z,1597935717.779 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2020-08-20T15:01:57.783Z,1597935717.783 [UniversalFixResidualReporter] Loaded 2020-08-20T15:01:57.783Z,1597935717.783 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2020-08-20T15:01:57.784Z,1597935717.784 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2020-08-20T15:01:57.784Z,1597935717.784 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2020-08-20T15:01:57.919Z,1597935717.919 [SBIT](DEBUG): Construct Startup Built In Test. 2020-08-20T15:01:57.930Z,1597935717.930 [SBIT] Loaded 2020-08-20T15:01:57.930Z,1597935717.930 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2020-08-20T15:01:57.931Z,1597935717.931 [IBIT](DEBUG): Construct Initiated Built In Test. 2020-08-20T15:01:57.945Z,1597935717.945 [IBIT] Loaded 2020-08-20T15:01:57.945Z,1597935717.945 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2020-08-20T15:01:57.948Z,1597935717.948 [CBIT](DEBUG): Construct Continuous Built In Test. 2020-08-20T15:01:58.089Z,1597935718.089 [CBIT] Loaded 2020-08-20T15:01:58.089Z,1597935718.089 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2020-08-20T15:01:58.090Z,1597935718.090 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2020-08-20T15:01:58.090Z,1597935718.090 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2020-08-20T15:01:58.193Z,1597935718.193 [BuoyancyServo] Loaded 2020-08-20T15:01:58.193Z,1597935718.193 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2020-08-20T15:01:58.205Z,1597935718.205 [ElevatorServo] Loaded 2020-08-20T15:01:58.205Z,1597935718.205 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2020-08-20T15:01:58.217Z,1597935718.217 [MassServo] Loaded 2020-08-20T15:01:58.217Z,1597935718.217 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2020-08-20T15:01:58.228Z,1597935718.228 [RudderServo] Loaded 2020-08-20T15:01:58.229Z,1597935718.229 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2020-08-20T15:01:58.240Z,1597935718.240 [ThrusterServo] Loaded 2020-08-20T15:01:58.240Z,1597935718.240 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2020-08-20T15:01:58.241Z,1597935718.241 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2020-08-20T15:01:58.241Z,1597935718.241 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2020-08-20T15:01:58.259Z,1597935718.259 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2020-08-20T15:01:58.260Z,1597935718.260 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2020-08-20T15:01:58.476Z,1597935718.476 [BackSeatDriver] Loaded 2020-08-20T15:01:58.476Z,1597935718.476 [ComponentRegistry](DEBUG): Component "BackSeatDriver" handled in its own thread. 2020-08-20T15:01:58.477Z,1597935718.477 [BackSeatDriver ThreadHandler](DEBUG): Created PCaller Thread at 40AFB4E0 2020-08-20T15:01:58.478Z,1597935718.478 [BackSeatDriver ThreadHandler](INFO): Protected caller Thread ID is 7036 2020-08-20T15:01:58.487Z,1597935718.487 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density 2020-08-20T15:01:58.493Z,1597935718.493 [CTD_Seabird](INFO): created writer for : sea_water_density 2020-08-20T15:01:58.493Z,1597935718.493 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth 2020-08-20T15:01:58.498Z,1597935718.498 [CTD_Seabird](INFO): created writer for : depth 2020-08-20T15:01:58.499Z,1597935718.499 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure 2020-08-20T15:01:58.504Z,1597935718.504 [CTD_Seabird](INFO): created writer for : sea_water_pressure 2020-08-20T15:01:58.504Z,1597935718.504 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity 2020-08-20T15:01:58.510Z,1597935718.510 [CTD_Seabird](INFO): created writer for : sea_water_salinity 2020-08-20T15:01:58.510Z,1597935718.510 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature 2020-08-20T15:01:58.515Z,1597935718.515 [CTD_Seabird](INFO): created writer for : sea_water_temperature 2020-08-20T15:01:58.516Z,1597935718.516 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity 2020-08-20T15:01:58.521Z,1597935718.521 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity 2020-08-20T15:01:58.522Z,1597935718.522 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water 2020-08-20T15:01:58.527Z,1597935718.527 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water 2020-08-20T15:01:58.555Z,1597935718.555 [CTD_Seabird] Loaded 2020-08-20T15:01:58.555Z,1597935718.555 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2020-08-20T15:01:58.556Z,1597935718.556 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B2B4E0 2020-08-20T15:01:58.556Z,1597935718.556 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 7037 2020-08-20T15:01:58.572Z,1597935718.572 [PAR_Licor] Loaded 2020-08-20T15:01:58.572Z,1597935718.572 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2020-08-20T15:01:58.578Z,1597935718.578 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output470 2020-08-20T15:01:58.579Z,1597935718.579 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output470 2020-08-20T15:01:58.583Z,1597935718.583 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output650 2020-08-20T15:01:58.583Z,1597935718.583 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output650 2020-08-20T15:01:58.587Z,1597935718.587 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.OutputChl 2020-08-20T15:01:58.587Z,1597935718.587 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: OutputChl 2020-08-20T15:01:58.591Z,1597935718.591 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg470nm 2020-08-20T15:01:58.592Z,1597935718.592 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg470nm 2020-08-20T15:01:58.596Z,1597935718.596 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg650nm 2020-08-20T15:01:58.596Z,1597935718.596 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg650nm 2020-08-20T15:01:58.600Z,1597935718.600 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff470nm 2020-08-20T15:01:58.601Z,1597935718.601 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff470nm 2020-08-20T15:01:58.605Z,1597935718.605 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff650nm 2020-08-20T15:01:58.605Z,1597935718.605 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff650nm 2020-08-20T15:01:58.609Z,1597935718.609 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): mass_concentration_of_chlorophyll_in_sea_water 2020-08-20T15:01:58.614Z,1597935718.614 [WetLabsBB2FL](INFO): created writer for : mass_concentration_of_chlorophyll_in_sea_water 2020-08-20T15:01:58.614Z,1597935718.614 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water 2020-08-20T15:01:58.615Z,1597935718.615 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_median_mass_concentration_of_chlorophyll_in_sea_water 2020-08-20T15:01:58.619Z,1597935718.619 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water 2020-08-20T15:01:58.619Z,1597935718.619 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_mean_mass_concentration_of_chlorophyll_in_sea_water 2020-08-20T15:01:58.623Z,1597935718.623 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_variance_mass_concentration_of_chlorophyll_in_sea_water 2020-08-20T15:01:58.624Z,1597935718.624 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_variance_mass_concentration_of_chlorophyll_in_sea_water 2020-08-20T15:01:58.628Z,1597935718.628 [WetLabsBB2FL] Loaded 2020-08-20T15:01:58.628Z,1597935718.628 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2020-08-20T15:01:58.629Z,1597935718.629 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B5B4E0 2020-08-20T15:01:58.629Z,1597935718.629 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 7038 2020-08-20T15:01:58.630Z,1597935718.630 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2020-08-20T15:01:58.634Z,1597935718.634 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2020-08-20T15:01:58.635Z,1597935718.635 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2020-08-20T15:01:58.642Z,1597935718.642 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2020-08-20T15:01:58.643Z,1597935718.643 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B8B4E0 2020-08-20T15:01:58.643Z,1597935718.643 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 7039 2020-08-20T15:01:58.648Z,1597935718.648 [Supervisor](INFO): Main Thread ID is 6688 2020-08-20T15:01:58.648Z,1597935718.648 [Supervisor](DEBUG): Running supervisor. 2020-08-20T15:01:58.648Z,1597935718.648 [CommandLine ThreadHandler](INFO): Handler Thread ID is 7040 2020-08-20T15:01:58.651Z,1597935718.651 [controlThread ThreadHandler](INFO): Handler Thread ID is 7041 2020-08-20T15:01:58.651Z,1597935718.651 [controlThread](DEBUG): Initializing ControlThread 2020-08-20T15:01:58.652Z,1597935718.652 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2020-08-20T15:01:58.654Z,1597935718.654 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2020-08-20T15:01:58.654Z,1597935718.654 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2020-08-20T15:01:58.655Z,1597935718.655 [LoopControl](DEBUG): Initialize LoopControlComponent. 2020-08-20T15:01:58.655Z,1597935718.655 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2020-08-20T15:01:58.656Z,1597935718.656 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2020-08-20T15:01:58.656Z,1597935718.656 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2020-08-20T15:01:58.656Z,1597935718.656 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2020-08-20T15:01:58.657Z,1597935718.657 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2020-08-20T15:01:58.657Z,1597935718.657 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2020-08-20T15:01:58.661Z,1597935718.661 [NavChart](DEBUG): Initialize NavChart Navigation. 2020-08-20T15:01:58.661Z,1597935718.661 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2020-08-20T15:01:58.662Z,1597935718.662 [SBIT](INFO): Initialize SBIT Component. 2020-08-20T15:01:58.662Z,1597935718.662 [SBIT](IMPORTANT): git: 2020-06-09-114-g1451e00 2020-08-20T15:01:58.662Z,1597935718.662 [SBIT](INFO): git hash: 1451e003b16ed6818131e4c85b4832e6473e2549 2020-08-20T15:01:58.663Z,1597935718.663 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2020-08-20T15:01:58.664Z,1597935718.664 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019 Kernel Reported: #1 PREEMPT Thu Aug 6 12:04:53 PDT 2020 2020-08-20T15:01:58.665Z,1597935718.665 [SBIT](INFO): Beginning SBIT in 76.000000 seconds. 2020-08-20T15:01:58.665Z,1597935718.665 [IBIT](INFO): Initialize IBIT Component. 2020-08-20T15:01:58.666Z,1597935718.666 [CBIT](DEBUG): Initialize CBIT Component. 2020-08-20T15:01:58.667Z,1597935718.667 [logger ThreadHandler](INFO): Handler Thread ID is 7042 2020-08-20T15:01:58.678Z,1597935718.678 [CBIT](DEBUG): Initialized mux pins. 2020-08-20T15:01:58.678Z,1597935718.678 [CBIT](DEBUG): Initializing the watchdog timer. 2020-08-20T15:01:58.687Z,1597935718.687 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 7043 2020-08-20T15:01:58.688Z,1597935718.688 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2020-08-20T15:01:58.699Z,1597935718.699 [Onboard ThreadHandler](INFO): Handler Thread ID is 7044 2020-08-20T15:01:58.703Z,1597935718.703 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2020-08-20T15:01:58.703Z,1597935718.703 [CBIT](DEBUG): Initializing heartbeat. 2020-08-20T15:01:58.717Z,1597935718.717 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 7045 2020-08-20T15:01:58.739Z,1597935718.739 [BackSeatDriver ThreadHandler](INFO): Handler Thread ID is 7046 2020-08-20T15:01:58.751Z,1597935718.751 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 7047 2020-08-20T15:01:58.751Z,1597935718.751 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2020-08-20T15:01:58.756Z,1597935718.756 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 7049 2020-08-20T15:01:58.757Z,1597935718.757 [WetLabsBB2FL](INFO): Powering down 2020-08-20T15:01:58.774Z,1597935718.774 [CBIT](DEBUG): Deactivating GF circuits. 2020-08-20T15:01:58.774Z,1597935718.774 [CBIT](DEBUG): Deactivating emergency mode. 2020-08-20T15:01:58.787Z,1597935718.787 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 7050 2020-08-20T15:01:58.790Z,1597935718.790 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2020-08-20T15:01:58.790Z,1597935718.790 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2020-08-20T15:01:58.790Z,1597935718.790 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2020-08-20T15:01:58.790Z,1597935718.790 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2020-08-20T15:01:58.791Z,1597935718.791 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2020-08-20T15:01:58.791Z,1597935718.791 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2020-08-20T15:01:58.791Z,1597935718.791 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2020-08-20T15:01:58.791Z,1597935718.791 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2020-08-20T15:01:58.791Z,1597935718.791 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2020-08-20T15:01:58.791Z,1597935718.791 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2020-08-20T15:01:58.792Z,1597935718.792 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2020-08-20T15:01:58.792Z,1597935718.792 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2020-08-20T15:01:58.792Z,1597935718.792 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2020-08-20T15:01:58.792Z,1597935718.792 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2020-08-20T15:01:58.792Z,1597935718.792 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2020-08-20T15:01:58.793Z,1597935718.793 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2020-08-20T15:01:58.810Z,1597935718.810 [CBIT](DEBUG): Backplane powered. 2020-08-20T15:01:58.815Z,1597935718.815 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2020-08-20T15:01:58.825Z,1597935718.825 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2020-08-20T15:01:58.864Z,1597935718.864 [MissionManager](DEBUG): 2020-08-20T15:01:58.865Z,1597935718.865 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2020-08-20T15:01:58.936Z,1597935718.936 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2020-08-20T15:01:58.937Z,1597935718.937 [Default:A.Wait](DEBUG): Construct Wait. 2020-08-20T15:01:58.950Z,1597935718.950 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2020-08-20T15:01:58.977Z,1597935718.977 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2020-08-20T15:01:58.979Z,1597935718.979 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2020-08-20T15:01:59.001Z,1597935719.001 [Default:E.Execute](DEBUG): Construct Execute. 2020-08-20T15:01:59.004Z,1597935719.004 [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-08-20T15:01:59.017Z,1597935719.017 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,DropWeight,NAL9602,DAT,BPC1,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-08-20T15:01:59.043Z,1597935719.043 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2020-08-20T15:01:59.084Z,1597935719.084 [Depth_Keller](ERROR): Pressure reading out of range: 1650.297119 decibar 2020-08-20T15:01:59.087Z,1597935719.087 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2 2020-08-20T15:01:59.087Z,1597935719.087 [DAT](INFO): Powering up 2020-08-20T15:01:59.088Z,1597935719.088 [DAT](DEBUG): Initializing DAT. 2020-08-20T15:01:59.122Z,1597935719.122 [Radio_Surface](INFO): Powering up 2020-08-20T15:01:59.151Z,1597935719.151 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2 2020-08-20T15:01:59.249Z,1597935719.249 [DepthRateCalculator](ERROR): Depth measurement is not active 2020-08-20T15:01:59.302Z,1597935719.302 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2020-08-20T15:01:59.311Z,1597935719.311 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2020-08-20T15:01:59.312Z,1597935719.312 [ElevatorServo](DEBUG): Initializing EZServoServo. 2020-08-20T15:01:59.319Z,1597935719.319 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2020-08-20T15:01:59.320Z,1597935719.320 [MassServo](DEBUG): Initializing EZServoServo. 2020-08-20T15:01:59.327Z,1597935719.327 [MassServo](DEBUG): Initializing MassServo. 2020-08-20T15:01:59.328Z,1597935719.328 [RudderServo](DEBUG): Initializing EZServoServo. 2020-08-20T15:01:59.335Z,1597935719.335 [RudderServo](DEBUG): Initializing RudderServo. 2020-08-20T15:01:59.336Z,1597935719.336 [ThrusterServo](DEBUG): Initializing EZServoServo. 2020-08-20T15:01:59.347Z,1597935719.347 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2020-08-20T15:01:59.451Z,1597935719.451 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2020-08-20T15:01:59.451Z,1597935719.451 [DropWeight] Hardware Fault, FailCount= 1 2020-08-20T15:01:59.451Z,1597935719.451 [DropWeight](ERROR): Hardware Fault 2020-08-20T15:01:59.487Z,1597935719.487 [DepthRateCalculator](ERROR): Depth measurement is not active 2020-08-20T15:01:59.517Z,1597935719.517 [CommandLine](FAULT): Scheduling is paused 2020-08-20T15:01:59.518Z,1597935719.518 [CBIT](INFO): Critical error at 20200820T150159 2020-08-20T15:01:59.518Z,1597935719.518 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2020-08-20T15:01:59.520Z,1597935719.520 [CBIT](ERROR): Hardware Fault in component: DropWeight 2020-08-20T15:01:59.521Z,1597935719.521 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2020-08-20T15:02:00.186Z,1597935720.186 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2020-08-20T15:02:00.187Z,1597935720.187 [RudderServo](FAULT): Rudder failed to initialize 2020-08-20T15:02:00.187Z,1597935720.187 [RudderServo] Communications Fault, FailCount= 1 2020-08-20T15:02:00.187Z,1597935720.187 [RudderServo](ERROR): Communications Fault 2020-08-20T15:02:00.288Z,1597935720.288 [CBIT](INFO): Critical error at 20200820T150159 2020-08-20T15:02:00.290Z,1597935720.290 [CBIT](ERROR): Communications Fault in component: RudderServo 2020-08-20T15:02:00.455Z,1597935720.455 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2020-08-20T15:02:00.456Z,1597935720.456 [RudderServo](INFO): Powering down 2020-08-20T15:02:01.126Z,1597935721.126 [RudderServo](DEBUG): Initializing EZServoServo. 2020-08-20T15:02:01.249Z,1597935721.249 [RudderServo](DEBUG): Initializing RudderServo. 2020-08-20T15:02:01.253Z,1597935721.253 [CBIT](INFO): Clearing failed state for component RudderServo 2020-08-20T15:02:01.253Z,1597935721.253 [RudderServo] No Fault, FailCount= 1 2020-08-20T15:02:08.841Z,1597935728.841 [CBIT](CRITICAL): Environmental Failure. Press:14.421388 PSI. Humidity:55%. Temp:21 C. ABORTING MISSION 2020-08-20T15:02:09.241Z,1597935729.241 [CBIT](INFO): Critical error at 20200820T150208 2020-08-20T15:02:11.618Z,1597935731.618 [DAT](INFO): commRate: 800 2020-08-20T15:02:11.618Z,1597935731.618 [DAT](INFO): commRate: 800 2020-08-20T15:02:12.020Z,1597935732.020 [DAT](INFO): entering command mode 2020-08-20T15:02:12.424Z,1597935732.424 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:12.838Z,1597935732.838 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:13.232Z,1597935733.232 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:13.636Z,1597935733.636 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:14.040Z,1597935734.040 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:14.444Z,1597935734.444 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:14.848Z,1597935734.848 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:15.252Z,1597935735.252 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:15.656Z,1597935735.656 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:16.060Z,1597935736.060 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:16.464Z,1597935736.464 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:16.868Z,1597935736.868 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:17.272Z,1597935737.272 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:17.676Z,1597935737.676 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:18.080Z,1597935738.080 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:18.488Z,1597935738.488 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:18.888Z,1597935738.888 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:19.292Z,1597935739.292 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:19.696Z,1597935739.696 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:20.100Z,1597935740.100 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:20.504Z,1597935740.504 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:20.908Z,1597935740.908 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:21.308Z,1597935741.308 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:21.716Z,1597935741.716 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:22.116Z,1597935742.116 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:22.520Z,1597935742.520 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:22.928Z,1597935742.928 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:23.332Z,1597935743.332 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:23.740Z,1597935743.740 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:24.140Z,1597935744.140 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:24.558Z,1597935744.558 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:24.954Z,1597935744.954 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:25.372Z,1597935745.372 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:25.773Z,1597935745.773 [NAL9602](INFO): Powering up NAL9602 2020-08-20T15:02:25.774Z,1597935745.774 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:26.156Z,1597935746.156 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:26.564Z,1597935746.564 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:26.980Z,1597935746.980 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:27.368Z,1597935747.368 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-20T15:02:27.368Z,1597935747.368 [DAT](FAULT): failed to enter command mode 2020-08-20T15:02:27.776Z,1597935747.776 [DAT](INFO): entering command mode 2020-08-20T15:02:28.181Z,1597935748.181 [DAT](INFO): setting verbose to 3 2020-08-20T15:02:28.586Z,1597935748.586 [DAT](INFO): set verbose to 3 2020-08-20T15:02:28.586Z,1597935748.586 [DAT](INFO): setting DatVerbose to 27440 2020-08-20T15:02:28.989Z,1597935748.989 [DAT](INFO): set DatVerbose to 27440 2020-08-20T15:02:28.989Z,1597935748.989 [DAT](INFO): setting transmit power to 8 2020-08-20T15:02:29.397Z,1597935749.397 [DAT](INFO): set transmit power to 8 2020-08-20T15:02:29.397Z,1597935749.397 [DAT](INFO): setting local address to 9 2020-08-20T15:02:29.797Z,1597935749.797 [DAT](INFO): set local address to 9 2020-08-20T15:02:36.664Z,1597935756.664 [NAL9602](INFO): NAL9602 initialized 2020-08-20T15:02:52.116Z,1597935772.116 [CommandLine](IMPORTANT): got command gfscan 2020-08-20T15:02:52.436Z,1597935772.436 [CBIT](IMPORTANT): Beginning ground fault scan 2020-08-20T15:03:03.352Z,1597935783.352 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.015965 CHAN A1 (24V): 0.038723 CHAN A2 (12V): -0.007158 CHAN A3 (5V): -0.002056 CHAN B0 (3.3V): 0.000440 CHAN B1 (3.15aV): 0.000381 CHAN B2 (3.15bV): -0.000060 CHAN B3 (GND): 0.002154 OPEN: 0.005617 Full Scale Calc: 4.765 mA, -1.589 mA 2020-08-20T15:03:12.300Z,1597935792.300 [CommandLine](IMPORTANT): got command get CBIT.gf24Offset 2020-08-20T15:03:12.301Z,1597935792.301 [CommandLine](IMPORTANT): CBIT.gf24Offset 107.000000 uA 2020-08-20T15:03:15.497Z,1597935795.497 [SBIT](IMPORTANT): Beginning Startup BIT 2020-08-20T15:03:15.501Z,1597935795.501 [CBIT](IMPORTANT): Beginning ground fault scan 2020-08-20T15:03:26.462Z,1597935806.462 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.015250 CHAN A1 (24V): 0.037858 CHAN A2 (12V): -0.006774 CHAN A3 (5V): -0.002445 CHAN B0 (3.3V): -0.000131 CHAN B1 (3.15aV): -0.000086 CHAN B2 (3.15bV): 0.000054 CHAN B3 (GND): 0.001936 OPEN: 0.005402 Full Scale Calc: 4.765 mA, -1.589 mA 2020-08-20T15:03:44.428Z,1597935824.428 [CommandLine](IMPORTANT): got command configSet CBIT.gf24Offset -145.000000 microampere persist 2020-08-20T15:03:47.932Z,1597935827.932 [CommandLine](IMPORTANT): got command gfscan 2020-08-20T15:03:48.210Z,1597935828.210 [CBIT](IMPORTANT): Beginning ground fault scan 2020-08-20T15:03:59.203Z,1597935839.203 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.015812 CHAN A1 (24V): 0.289855 CHAN A2 (12V): -0.007032 CHAN A3 (5V): -0.002661 CHAN B0 (3.3V): 0.000549 CHAN B1 (3.15aV): 0.000051 CHAN B2 (3.15bV): 0.000231 CHAN B3 (GND): 0.001645 OPEN: 0.005748 Full Scale Calc: 4.765 mA, -1.589 mA 2020-08-20T15:04:09.218Z,1597935849.218 [SBIT](IMPORTANT): SBIT PASSED 2020-08-20T15:04:09.218Z,1597935849.218 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2020-08-20T15:04:09.219Z,1597935849.219 [SBIT](IMPORTANT): CBIT.gf24Offset=-145 microampere; 2020-08-20T15:04:09.219Z,1597935849.219 [SBIT](IMPORTANT): Express none ThrusterServo.component_avgCurrent; 2020-08-20T15:04:09.219Z,1597935849.219 [SBIT](IMPORTANT): Express linearApproximation WetLabsUBAT.flow_rate 1.000000 liter_per_second; 2020-08-20T15:04:09.219Z,1597935849.219 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 5.000000 meter; 2020-08-20T15:04:09.219Z,1597935849.219 [SBIT](IMPORTANT): RDI_Pathfinder.loadAtStartup=0 bool; 2020-08-20T15:04:09.220Z,1597935849.220 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=413.311030 cubic_centimeter; 2020-08-20T15:04:09.220Z,1597935849.220 [SBIT](IMPORTANT): VerticalControl.massDefault=-14.023880 millimeter; 2020-08-20T15:04:09.220Z,1597935849.220 [SBIT](IMPORTANT): WetLabsUBAT.loadAtStartup=0 bool; 2020-08-20T15:04:09.612Z,1597935849.612 [MissionManager](IMPORTANT): Started mission Startup 2020-08-20T15:04:09.612Z,1597935849.612 [Startup] Running Loop=1 2020-08-20T15:04:09.612Z,1597935849.612 [Startup](DEBUG): Aggregate::initialize Startup 2020-08-20T15:04:09.612Z,1597935849.612 [Startup:A.GoToSurface] Running Loop=1 2020-08-20T15:04:09.613Z,1597935849.613 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2020-08-20T15:04:09.613Z,1597935849.613 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2020-08-20T15:04:09.614Z,1597935849.614 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2020-08-20T15:04:09.614Z,1597935849.614 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2020-08-20T15:04:09.615Z,1597935849.615 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2020-08-20T15:04:09.615Z,1597935849.615 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2020-08-20T15:04:09.617Z,1597935849.617 [Startup:StartupSatComms] Running Loop=1 2020-08-20T15:04:09.617Z,1597935849.617 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2020-08-20T15:04:09.617Z,1597935849.617 [Startup:StartupSatComms:A] Running Loop=1 2020-08-20T15:04:10.012Z,1597935850.012 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2020-08-20T15:04:11.648Z,1597935851.648 [CommandLine](IMPORTANT): got command configSet CBIT.gf24Offset 145.000000 microampere persist 2020-08-20T15:04:14.212Z,1597935854.212 [CommandLine](IMPORTANT): got command gfscan 2020-08-20T15:04:14.480Z,1597935854.480 [CBIT](IMPORTANT): Beginning ground fault scan 2020-08-20T15:04:25.375Z,1597935865.375 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.015782 CHAN A1 (24V): -0.000031 CHAN A2 (12V): -0.006377 CHAN A3 (5V): -0.002410 CHAN B0 (3.3V): 0.000764 CHAN B1 (3.15aV): -0.000189 CHAN B2 (3.15bV): -0.000157 CHAN B3 (GND): 0.001918 OPEN: 0.005006 Full Scale Calc: 4.765 mA, -1.589 mA 2020-08-20T15:04:26.645Z,1597935866.645 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005041 2020-08-20T15:04:55.707Z,1597935895.707 [CommandLine](IMPORTANT): got command maintain control VerticalControl.massPositionAction 40.000000 millimeter 2020-08-20T15:04:55.709Z,1597935895.709 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.massPositionAction" handled in the control thread. 2020-08-20T15:04:56.094Z,1597935896.094 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,DropWeight,NAL9602,DAT,BPC1,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.massPositionAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2020-08-20T15:04:59.158Z,1597935899.158 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2020-08-20T15:04:59.158Z,1597935899.158 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-08-20T15:04:59.232Z,1597935899.232 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-08-20T15:04:59.413Z,1597935899.413 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-08-20T15:04:59.413Z,1597935899.413 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2020-08-20T15:05:08.299Z,1597935908.299 [CommandLine](IMPORTANT): got command report mod platform_mass_position 2020-08-20T15:05:08.636Z,1597935908.636 [Reporter](INFO): platform_mass_position -0.005859 m 2020-08-20T15:05:09.050Z,1597935909.050 [Reporter](INFO): platform_mass_position -0.005533 m 2020-08-20T15:05:09.432Z,1597935909.432 [Reporter](INFO): platform_mass_position -0.005227 m 2020-08-20T15:05:09.797Z,1597935909.797 [Startup:StartupSatComms:A](INFO): Timed out from 2020-08-20T15:04:09.6Z 2020-08-20T15:05:09.797Z,1597935909.797 [Startup:StartupSatComms:A] Stopped 2020-08-20T15:05:09.797Z,1597935909.797 [Startup:StartupSatComms:B] Running Loop=1 2020-08-20T15:05:09.840Z,1597935909.840 [Reporter](INFO): platform_mass_position -0.004910 m 2020-08-20T15:05:10.209Z,1597935910.209 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2020-08-20T15:05:10.263Z,1597935910.263 [Reporter](INFO): platform_mass_position -0.004588 m 2020-08-20T15:05:10.728Z,1597935910.728 [Reporter](INFO): platform_mass_position -0.004218 m 2020-08-20T15:05:11.133Z,1597935911.133 [Reporter](INFO): platform_mass_position -0.003896 m 2020-08-20T15:05:11.520Z,1597935911.520 [Reporter](INFO): platform_mass_position -0.003601 m 2020-08-20T15:05:11.933Z,1597935911.933 [Reporter](INFO): platform_mass_position -0.003275 m 2020-08-20T15:05:12.392Z,1597935912.392 [Reporter](INFO): platform_mass_position -0.002913 m 2020-08-20T15:05:12.880Z,1597935912.880 [Reporter](INFO): platform_mass_position -0.002528 m 2020-08-20T15:05:13.201Z,1597935913.201 [Reporter](INFO): platform_mass_position -0.002274 m 2020-08-20T15:05:13.589Z,1597935913.589 [Reporter](INFO): platform_mass_position -0.001975 m 2020-08-20T15:05:13.976Z,1597935913.976 [Reporter](INFO): platform_mass_position -0.001671 m 2020-08-20T15:05:14.343Z,1597935914.343 [Reporter](INFO): platform_mass_position -0.001385 m 2020-08-20T15:05:14.760Z,1597935914.760 [Reporter](INFO): platform_mass_position -0.001057 m 2020-08-20T15:05:15.164Z,1597935915.164 [Reporter](INFO): platform_mass_position -0.000737 m 2020-08-20T15:05:15.577Z,1597935915.577 [Reporter](INFO): platform_mass_position -0.000413 m 2020-08-20T15:05:15.994Z,1597935915.994 [Reporter](INFO): platform_mass_position -0.000088 m 2020-08-20T15:05:16.453Z,1597935916.453 [Reporter](INFO): platform_mass_position 0.000274 m 2020-08-20T15:05:16.808Z,1597935916.808 [Reporter](INFO): platform_mass_position 0.000552 m 2020-08-20T15:05:17.030Z,1597935917.030 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20200819T211051/Courier0307.lzma 2020-08-20T15:05:17.193Z,1597935917.193 [Reporter](INFO): platform_mass_position 0.000853 m 2020-08-20T15:05:17.572Z,1597935917.572 [Reporter](INFO): platform_mass_position 0.001145 m 2020-08-20T15:05:17.976Z,1597935917.976 [Reporter](INFO): platform_mass_position 0.001468 m 2020-08-20T15:05:18.033Z,1597935918.033 [DataOverHttps](INFO): Moved sent file to Logs/20200819T211051/Courier0307.lzma.bak 2020-08-20T15:05:18.033Z,1597935918.033 [DataOverHttps](INFO): SBD MOMSN=12577822 2020-08-20T15:05:18.368Z,1597935918.368 [Reporter](INFO): platform_mass_position 0.001773 m 2020-08-20T15:05:18.786Z,1597935918.786 [Reporter](INFO): platform_mass_position 0.002095 m 2020-08-20T15:05:19.200Z,1597935919.200 [Reporter](INFO): platform_mass_position 0.002424 m 2020-08-20T15:05:19.608Z,1597935919.608 [Reporter](INFO): platform_mass_position 0.002748 m 2020-08-20T15:05:19.988Z,1597935919.988 [Reporter](INFO): platform_mass_position 0.003044 m 2020-08-20T15:05:20.404Z,1597935920.404 [Reporter](INFO): platform_mass_position 0.003362 m 2020-08-20T15:05:20.807Z,1597935920.807 [Reporter](INFO): platform_mass_position 0.003681 m 2020-08-20T15:05:21.239Z,1597935921.239 [Reporter](INFO): platform_mass_position 0.004017 m 2020-08-20T15:05:21.625Z,1597935921.625 [Reporter](INFO): platform_mass_position 0.004317 m 2020-08-20T15:05:22.027Z,1597935922.027 [Reporter](INFO): platform_mass_position 0.004636 m 2020-08-20T15:05:22.444Z,1597935922.444 [Reporter](INFO): platform_mass_position 0.004966 m 2020-08-20T15:05:22.835Z,1597935922.835 [Reporter](INFO): platform_mass_position 0.005264 m 2020-08-20T15:05:23.236Z,1597935923.236 [Reporter](INFO): platform_mass_position 0.005582 m 2020-08-20T15:05:23.637Z,1597935923.637 [Reporter](INFO): platform_mass_position 0.005900 m 2020-08-20T15:05:24.051Z,1597935924.051 [Reporter](INFO): platform_mass_position 0.006227 m 2020-08-20T15:05:24.536Z,1597935924.536 [Reporter](INFO): platform_mass_position 0.006606 m 2020-08-20T15:05:24.844Z,1597935924.844 [Reporter](INFO): platform_mass_position 0.006844 m 2020-08-20T15:05:25.315Z,1597935925.315 [Reporter](INFO): platform_mass_position 0.007219 m 2020-08-20T15:05:25.688Z,1597935925.688 [Reporter](INFO): platform_mass_position 0.007512 m 2020-08-20T15:05:26.083Z,1597935926.083 [Reporter](INFO): platform_mass_position 0.007816 m 2020-08-20T15:05:26.492Z,1597935926.492 [Reporter](INFO): platform_mass_position 0.008142 m 2020-08-20T15:05:26.878Z,1597935926.878 [Reporter](INFO): platform_mass_position 0.008435 m 2020-08-20T15:05:27.286Z,1597935927.286 [Reporter](INFO): platform_mass_position 0.008759 m 2020-08-20T15:05:27.719Z,1597935927.719 [Reporter](INFO): platform_mass_position 0.009095 m 2020-08-20T15:05:28.080Z,1597935928.080 [Reporter](INFO): platform_mass_position 0.009378 m 2020-08-20T15:05:28.493Z,1597935928.493 [Reporter](INFO): platform_mass_position 0.009708 m 2020-08-20T15:05:28.934Z,1597935928.934 [Reporter](INFO): platform_mass_position 0.010027 m 2020-08-20T15:05:29.305Z,1597935929.305 [Reporter](INFO): platform_mass_position 0.010349 m 2020-08-20T15:05:29.708Z,1597935929.708 [Reporter](INFO): platform_mass_position 0.010658 m 2020-08-20T15:05:30.152Z,1597935930.152 [Reporter](INFO): platform_mass_position 0.011011 m 2020-08-20T15:05:30.532Z,1597935930.532 [Reporter](INFO): platform_mass_position 0.011299 m 2020-08-20T15:05:30.952Z,1597935930.952 [Reporter](INFO): platform_mass_position 0.011634 m 2020-08-20T15:05:31.328Z,1597935931.328 [Reporter](INFO): platform_mass_position 0.011923 m 2020-08-20T15:05:31.783Z,1597935931.783 [Reporter](INFO): platform_mass_position 0.012282 m 2020-08-20T15:05:32.173Z,1597935932.173 [Reporter](INFO): platform_mass_position 0.012597 m 2020-08-20T15:05:32.572Z,1597935932.572 [Reporter](INFO): platform_mass_position 0.012896 m 2020-08-20T15:05:32.980Z,1597935932.980 [Reporter](INFO): platform_mass_position 0.013217 m 2020-08-20T15:05:33.381Z,1597935933.381 [Reporter](INFO): platform_mass_position 0.013538 m 2020-08-20T15:05:33.770Z,1597935933.770 [Reporter](INFO): platform_mass_position 0.013834 m 2020-08-20T15:05:34.189Z,1597935934.189 [Reporter](INFO): platform_mass_position 0.014172 m 2020-08-20T15:05:34.552Z,1597935934.552 [Reporter](INFO): platform_mass_position 0.014456 m 2020-08-20T15:05:34.000Z,1597935935.000 [Reporter](INFO): platform_mass_position 0.014810 m 2020-08-20T15:05:35.370Z,1597935935.370 [Reporter](INFO): platform_mass_position 0.015093 m 2020-08-20T15:05:35.800Z,1597935935.800 [Reporter](INFO): platform_mass_position 0.015434 m 2020-08-20T15:05:36.172Z,1597935936.172 [Reporter](INFO): platform_mass_position 0.015723 m 2020-08-20T15:05:36.719Z,1597935936.719 [Reporter](INFO): platform_mass_position 0.016154 m 2020-08-20T15:05:37.040Z,1597935937.040 [Reporter](INFO): platform_mass_position 0.016407 m 2020-08-20T15:05:37.420Z,1597935937.420 [Reporter](INFO): platform_mass_position 0.016704 m 2020-08-20T15:05:37.866Z,1597935937.866 [Reporter](INFO): platform_mass_position 0.017046 m 2020-08-20T15:05:38.192Z,1597935938.192 [Reporter](INFO): platform_mass_position 0.017310 m 2020-08-20T15:05:38.519Z,1597935938.519 [DataOverHttps](INFO): Sending 445 bytes from file Logs/20200820T145745/Courier0000.lzma 2020-08-20T15:05:38.601Z,1597935938.601 [Reporter](INFO): platform_mass_position 0.017626 m 2020-08-20T15:05:39.021Z,1597935939.021 [Reporter](INFO): platform_mass_position 0.017954 m 2020-08-20T15:05:39.396Z,1597935939.396 [Reporter](INFO): platform_mass_position 0.018253 m 2020-08-20T15:05:39.508Z,1597935939.508 [DataOverHttps](INFO): Moved sent file to Logs/20200820T145745/Courier0000.lzma.bak 2020-08-20T15:05:39.508Z,1597935939.508 [DataOverHttps](INFO): SBD MOMSN=12577824 2020-08-20T15:05:39.810Z,1597935939.810 [Reporter](INFO): platform_mass_position 0.018570 m 2020-08-20T15:05:40.190Z,1597935940.190 [Reporter](INFO): platform_mass_position 0.018878 m 2020-08-20T15:05:40.625Z,1597935940.625 [Reporter](INFO): platform_mass_position 0.019222 m 2020-08-20T15:05:41.052Z,1597935941.053 [Reporter](INFO): platform_mass_position 0.019539 m 2020-08-20T15:05:41.448Z,1597935941.448 [Reporter](INFO): platform_mass_position 0.019836 m 2020-08-20T15:05:41.808Z,1597935941.808 [Reporter](INFO): platform_mass_position 0.020144 m 2020-08-20T15:05:42.248Z,1597935942.248 [Reporter](INFO): platform_mass_position 0.020492 m 2020-08-20T15:05:42.685Z,1597935942.685 [Reporter](INFO): platform_mass_position 0.020825 m 2020-08-20T15:05:43.060Z,1597935943.060 [Reporter](INFO): platform_mass_position 0.021125 m 2020-08-20T15:05:43.473Z,1597935943.473 [Reporter](INFO): platform_mass_position 0.021451 m 2020-08-20T15:05:43.855Z,1597935943.855 [Reporter](INFO): platform_mass_position 0.021743 m 2020-08-20T15:05:44.251Z,1597935944.251 [Reporter](INFO): platform_mass_position 0.022059 m 2020-08-20T15:05:44.674Z,1597935944.674 [Reporter](INFO): platform_mass_position 0.022385 m 2020-08-20T15:05:45.093Z,1597935945.093 [Reporter](INFO): platform_mass_position 0.022718 m 2020-08-20T15:05:45.464Z,1597935945.464 [Reporter](INFO): platform_mass_position 0.023009 m 2020-08-20T15:05:45.892Z,1597935945.892 [Reporter](INFO): platform_mass_position 0.023348 m 2020-08-20T15:05:46.287Z,1597935946.287 [Reporter](INFO): platform_mass_position 0.023652 m 2020-08-20T15:05:46.701Z,1597935946.701 [Reporter](INFO): platform_mass_position 0.023980 m 2020-08-20T15:05:47.079Z,1597935947.079 [Reporter](INFO): platform_mass_position 0.024276 m 2020-08-20T15:05:47.526Z,1597935947.526 [Reporter](INFO): platform_mass_position 0.024621 m 2020-08-20T15:05:47.956Z,1597935947.956 [Reporter](INFO): platform_mass_position 0.024953 m 2020-08-20T15:05:48.353Z,1597935948.353 [Reporter](INFO): platform_mass_position 0.025274 m 2020-08-20T15:05:48.732Z,1597935948.732 [Reporter](INFO): platform_mass_position 0.025570 m 2020-08-20T15:05:49.284Z,1597935949.284 [Reporter](INFO): platform_mass_position 0.026005 m 2020-08-20T15:05:49.540Z,1597935949.540 [Reporter](INFO): platform_mass_position 0.026208 m 2020-08-20T15:05:49.946Z,1597935949.946 [Reporter](INFO): platform_mass_position 0.026522 m 2020-08-20T15:05:50.464Z,1597935950.464 [Reporter](INFO): platform_mass_position 0.026927 m 2020-08-20T15:05:50.762Z,1597935950.762 [Reporter](INFO): platform_mass_position 0.027165 m 2020-08-20T15:05:51.158Z,1597935951.158 [Reporter](INFO): platform_mass_position 0.027472 m 2020-08-20T15:05:51.557Z,1597935951.557 [Reporter](INFO): platform_mass_position 0.027778 m 2020-08-20T15:05:51.941Z,1597935951.941 [Reporter](INFO): platform_mass_position 0.028084 m 2020-08-20T15:05:52.339Z,1597935952.339 [Reporter](INFO): platform_mass_position 0.028399 m 2020-08-20T15:05:52.752Z,1597935952.752 [Reporter](INFO): platform_mass_position 0.028724 m 2020-08-20T15:05:53.168Z,1597935953.168 [Reporter](INFO): platform_mass_position 0.029045 m 2020-08-20T15:05:53.564Z,1597935953.564 [Reporter](INFO): platform_mass_position 0.029363 m 2020-08-20T15:05:53.984Z,1597935953.984 [Reporter](INFO): platform_mass_position 0.029692 m 2020-08-20T15:05:54.340Z,1597935954.340 [Reporter](INFO): platform_mass_position 0.029969 m 2020-08-20T15:05:54.764Z,1597935954.764 [Reporter](INFO): platform_mass_position 0.030296 m 2020-08-20T15:05:55.141Z,1597935955.141 [Reporter](INFO): platform_mass_position 0.030601 m 2020-08-20T15:05:55.571Z,1597935955.571 [Reporter](INFO): platform_mass_position 0.030931 m 2020-08-20T15:05:55.978Z,1597935955.978 [Reporter](INFO): platform_mass_position 0.031255 m 2020-08-20T15:05:56.365Z,1597935956.365 [Reporter](INFO): platform_mass_position 0.031555 m 2020-08-20T15:05:56.780Z,1597935956.780 [Reporter](INFO): platform_mass_position 0.031880 m 2020-08-20T15:05:57.173Z,1597935957.173 [Reporter](INFO): platform_mass_position 0.032192 m 2020-08-20T15:05:57.594Z,1597935957.594 [Reporter](INFO): platform_mass_position 0.032521 m 2020-08-20T15:05:57.996Z,1597935957.996 [Reporter](INFO): platform_mass_position 0.032833 m 2020-08-20T15:05:58.406Z,1597935958.406 [Reporter](INFO): platform_mass_position 0.033145 m 2020-08-20T15:05:58.722Z,1597935958.722 [DataOverHttps](INFO): Sending 316 bytes from file Logs/20200820T145919/Courier0000.lzma 2020-08-20T15:05:58.823Z,1597935958.823 [Reporter](INFO): platform_mass_position 0.033475 m 2020-08-20T15:05:59.196Z,1597935959.196 [Reporter](INFO): platform_mass_position 0.033773 m 2020-08-20T15:05:59.602Z,1597935959.602 [Reporter](INFO): platform_mass_position 0.034086 m 2020-08-20T15:05:59.728Z,1597935959.728 [DataOverHttps](INFO): Moved sent file to Logs/20200820T145919/Courier0000.lzma.bak 2020-08-20T15:05:59.728Z,1597935959.728 [DataOverHttps](INFO): SBD MOMSN=12577834 2020-08-20T15:06:00.013Z,1597935960.013 [Reporter](INFO): platform_mass_position 0.034414 m 2020-08-20T15:06:00.388Z,1597935960.388 [Reporter](INFO): platform_mass_position 0.034710 m 2020-08-20T15:06:00.860Z,1597935960.860 [Reporter](INFO): platform_mass_position 0.035077 m 2020-08-20T15:06:01.296Z,1597935961.296 [Reporter](INFO): platform_mass_position 0.035423 m 2020-08-20T15:06:01.964Z,1597935961.964 [Reporter](INFO): platform_mass_position 0.035943 m 2020-08-20T15:06:02.140Z,1597935962.140 [Reporter](INFO): platform_mass_position 0.036085 m 2020-08-20T15:06:02.644Z,1597935962.644 [Reporter](INFO): platform_mass_position 0.036480 m 2020-08-20T15:06:02.900Z,1597935962.900 [Reporter](INFO): platform_mass_position 0.036672 m 2020-08-20T15:06:03.289Z,1597935963.289 [Reporter](INFO): platform_mass_position 0.036982 m 2020-08-20T15:06:03.685Z,1597935963.685 [Reporter](INFO): platform_mass_position 0.037287 m 2020-08-20T15:06:04.085Z,1597935964.085 [Reporter](INFO): platform_mass_position 0.037605 m 2020-08-20T15:06:04.495Z,1597935964.495 [Reporter](INFO): platform_mass_position 0.037923 m 2020-08-20T15:06:04.888Z,1597935964.888 [Reporter](INFO): platform_mass_position 0.038231 m 2020-08-20T15:06:05.284Z,1597935965.284 [Reporter](INFO): platform_mass_position 0.038544 m 2020-08-20T15:06:05.697Z,1597935965.697 [Reporter](INFO): platform_mass_position 0.038870 m 2020-08-20T15:06:06.095Z,1597935966.095 [MassServo](FAULT): Reading outside of valid range:427099.000000 2020-08-20T15:06:06.532Z,1597935966.532 [Reporter](INFO): platform_mass_position 0.039172 m 2020-08-20T15:06:10.072Z,1597935970.072 [Startup:StartupSatComms:B](INFO): Timed out from 2020-08-20T15:05:09.8Z 2020-08-20T15:06:10.072Z,1597935970.072 [Startup:StartupSatComms:B] Stopped 2020-08-20T15:06:10.073Z,1597935970.073 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2020-08-20T15:06:10.073Z,1597935970.073 [Startup:StartupSatComms] Stopped 2020-08-20T15:06:10.073Z,1597935970.073 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2020-08-20T15:06:10.073Z,1597935970.073 [Startup](INFO): Completed Startup 2020-08-20T15:06:10.074Z,1597935970.074 [MissionManager](INFO): Startup is completed. 2020-08-20T15:06:10.074Z,1597935970.074 [MissionManager](INFO): Uninitializing Mission Startup 2020-08-20T15:06:10.074Z,1597935970.074 [Startup] Stopped 2020-08-20T15:06:10.074Z,1597935970.074 [Startup](DEBUG): Aggregate::uninitialize Startup 2020-08-20T15:06:10.074Z,1597935970.074 [Startup:A.GoToSurface] Stopped 2020-08-20T15:06:10.074Z,1597935970.074 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2020-08-20T15:06:10.476Z,1597935970.476 [MissionManager](IMPORTANT): Started mission Default 2020-08-20T15:06:10.476Z,1597935970.476 [Default] Running Loop=1 2020-08-20T15:06:10.476Z,1597935970.476 [Default](DEBUG): Aggregate::initialize Default 2020-08-20T15:06:10.476Z,1597935970.476 [Default:B.GoToSurface] Running Loop=1 2020-08-20T15:06:10.476Z,1597935970.476 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2020-08-20T15:06:10.477Z,1597935970.477 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2020-08-20T15:06:10.477Z,1597935970.477 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2020-08-20T15:06:10.477Z,1597935970.477 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2020-08-20T15:06:10.477Z,1597935970.477 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2020-08-20T15:06:10.478Z,1597935970.478 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2020-08-20T15:06:10.478Z,1597935970.478 [Default:A.Wait] Running Loop=1 2020-08-20T15:06:10.478Z,1597935970.478 [Default:A.Wait](DEBUG): Initialize Wait Component. 2020-08-20T15:06:21.512Z,1597935981.512 [CommandLine](IMPORTANT): got command maintain control VerticalControl.massPositionAction -20.000000 millimeter 2020-08-20T15:06:22.243Z,1597935982.243 [Reporter](INFO): platform_mass_position 0.038904 m 2020-08-20T15:06:22.644Z,1597935982.644 [Reporter](INFO): platform_mass_position 0.038582 m 2020-08-20T15:06:23.042Z,1597935983.042 [Reporter](INFO): platform_mass_position 0.038272 m 2020-08-20T15:06:23.443Z,1597935983.443 [Reporter](INFO): platform_mass_position 0.037955 m 2020-08-20T15:06:23.814Z,1597935983.814 [Default:A.Wait](INFO): Done Waiting. 2020-08-20T15:06:23.815Z,1597935983.815 [Default:A.Wait] Stopped 2020-08-20T15:06:23.815Z,1597935983.815 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2020-08-20T15:06:23.868Z,1597935983.868 [Reporter](INFO): platform_mass_position 0.037630 m 2020-08-20T15:06:24.235Z,1597935984.235 [Default:CheckIn] Running Loop=1 2020-08-20T15:06:24.235Z,1597935984.235 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-08-20T15:06:24.235Z,1597935984.235 [Default:CheckIn:Read_GPS] Running Loop=1 2020-08-20T15:06:24.280Z,1597935984.280 [Reporter](INFO): platform_mass_position 0.037302 m 2020-08-20T15:06:24.645Z,1597935984.645 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2020-08-20T15:06:24.695Z,1597935984.695 [Reporter](INFO): platform_mass_position 0.036979 m 2020-08-20T15:06:25.072Z,1597935985.072 [Reporter](INFO): platform_mass_position 0.036678 m 2020-08-20T15:06:25.488Z,1597935985.488 [Reporter](INFO): platform_mass_position 0.036353 m 2020-08-20T15:06:25.888Z,1597935985.888 [Reporter](INFO): platform_mass_position 0.036042 m 2020-08-20T15:06:26.268Z,1597935986.268 [Reporter](INFO): platform_mass_position 0.035739 m 2020-08-20T15:06:26.732Z,1597935986.732 [Reporter](INFO): platform_mass_position 0.035378 m 2020-08-20T15:06:27.148Z,1597935987.148 [Reporter](INFO): platform_mass_position 0.035056 m 2020-08-20T15:06:27.516Z,1597935987.516 [Reporter](INFO): platform_mass_position 0.034762 m 2020-08-20T15:06:27.916Z,1597935987.916 [Reporter](INFO): platform_mass_position 0.034453 m 2020-08-20T15:06:28.325Z,1597935988.325 [Reporter](INFO): platform_mass_position 0.034131 m 2020-08-20T15:06:28.707Z,1597935988.707 [Reporter](INFO): platform_mass_position 0.033838 m 2020-08-20T15:06:29.104Z,1597935989.104 [Reporter](INFO): platform_mass_position 0.033516 m 2020-08-20T15:06:29.539Z,1597935989.539 [Reporter](INFO): platform_mass_position 0.033187 m 2020-08-20T15:06:29.924Z,1597935989.924 [Reporter](INFO): platform_mass_position 0.032881 m 2020-08-20T15:06:30.324Z,1597935990.324 [Reporter](INFO): platform_mass_position 0.032562 m 2020-08-20T15:06:30.735Z,1597935990.735 [Reporter](INFO): platform_mass_position 0.032249 m 2020-08-20T15:06:31.116Z,1597935991.116 [Reporter](INFO): platform_mass_position 0.031943 m 2020-08-20T15:06:31.520Z,1597935991.520 [Reporter](INFO): platform_mass_position 0.031623 m 2020-08-20T15:06:31.936Z,1597935991.936 [Reporter](INFO): platform_mass_position 0.031305 m 2020-08-20T15:06:32.348Z,1597935992.348 [Reporter](INFO): platform_mass_position 0.030980 m 2020-08-20T15:06:32.736Z,1597935992.736 [Reporter](INFO): platform_mass_position 0.030673 m 2020-08-20T15:06:33.139Z,1597935993.139 [Reporter](INFO): platform_mass_position 0.030356 m 2020-08-20T15:06:33.559Z,1597935993.559 [Reporter](INFO): platform_mass_position 0.030036 m 2020-08-20T15:06:33.971Z,1597935993.971 [Reporter](INFO): platform_mass_position 0.029710 m 2020-08-20T15:06:34.348Z,1597935994.348 [Reporter](INFO): platform_mass_position 0.029406 m 2020-08-20T15:06:34.765Z,1597935994.765 [Reporter](INFO): platform_mass_position 0.029077 m 2020-08-20T15:06:35.175Z,1597935995.175 [Reporter](INFO): platform_mass_position 0.028761 m 2020-08-20T15:06:35.588Z,1597935995.588 [Reporter](INFO): platform_mass_position 0.028440 m 2020-08-20T15:06:36.002Z,1597935996.002 [Reporter](INFO): platform_mass_position 0.028122 m 2020-08-20T15:06:36.372Z,1597935996.372 [Reporter](INFO): platform_mass_position 0.027823 m 2020-08-20T15:06:36.788Z,1597935996.788 [Reporter](INFO): platform_mass_position 0.027500 m 2020-08-20T15:06:37.196Z,1597935997.196 [Reporter](INFO): platform_mass_position 0.027181 m 2020-08-20T15:06:37.584Z,1597935997.584 [Reporter](INFO): platform_mass_position 0.026873 m 2020-08-20T15:06:37.992Z,1597935997.992 [Reporter](INFO): platform_mass_position 0.026553 m 2020-08-20T15:06:38.403Z,1597935998.403 [Reporter](INFO): platform_mass_position 0.026239 m 2020-08-20T15:06:38.870Z,1597935998.870 [Reporter](INFO): platform_mass_position 0.025873 m 2020-08-20T15:06:39.288Z,1597935999.288 [Reporter](INFO): platform_mass_position 0.025540 m 2020-08-20T15:06:39.640Z,1597935999.640 [Reporter](INFO): platform_mass_position 0.025257 m 2020-08-20T15:06:40.048Z,1597936000.048 [Reporter](INFO): platform_mass_position 0.024939 m 2020-08-20T15:06:40.444Z,1597936000.444 [Reporter](INFO): platform_mass_position 0.024631 m 2020-08-20T15:06:40.847Z,1597936000.847 [Reporter](INFO): platform_mass_position 0.024320 m 2020-08-20T15:06:41.309Z,1597936001.309 [Reporter](INFO): platform_mass_position 0.023954 m 2020-08-20T15:06:41.660Z,1597936001.660 [Reporter](INFO): platform_mass_position 0.023704 m 2020-08-20T15:06:42.083Z,1597936002.083 [Reporter](INFO): platform_mass_position 0.023346 m 2020-08-20T15:06:42.509Z,1597936002.509 [Reporter](INFO): platform_mass_position 0.023007 m 2020-08-20T15:06:42.832Z,1597936002.832 [Reporter](INFO): platform_mass_position 0.022756 m 2020-08-20T15:06:43.244Z,1597936003.244 [Reporter](INFO): platform_mass_position 0.022443 m 2020-08-20T15:06:43.652Z,1597936003.652 [Reporter](INFO): platform_mass_position 0.022120 m 2020-08-20T15:06:44.072Z,1597936004.072 [Reporter](INFO): platform_mass_position 0.021789 m 2020-08-20T15:06:44.448Z,1597936004.448 [Reporter](INFO): platform_mass_position 0.021489 m 2020-08-20T15:06:44.859Z,1597936004.859 [Reporter](INFO): platform_mass_position 0.021174 m 2020-08-20T15:06:45.276Z,1597936005.276 [Reporter](INFO): platform_mass_position 0.020843 m 2020-08-20T15:06:45.687Z,1597936005.687 [Reporter](INFO): platform_mass_position 0.020524 m 2020-08-20T15:06:46.108Z,1597936006.108 [Reporter](INFO): platform_mass_position 0.020188 m 2020-08-20T15:06:46.507Z,1597936006.507 [Reporter](INFO): platform_mass_position 0.019882 m 2020-08-20T15:06:46.883Z,1597936006.883 [Reporter](INFO): platform_mass_position 0.019589 m 2020-08-20T15:06:47.298Z,1597936007.298 [Reporter](INFO): platform_mass_position 0.019268 m 2020-08-20T15:06:47.680Z,1597936007.680 [Reporter](INFO): platform_mass_position 0.018959 m 2020-08-20T15:06:48.100Z,1597936008.100 [Reporter](INFO): platform_mass_position 0.018631 m 2020-08-20T15:06:48.508Z,1597936008.508 [Reporter](INFO): platform_mass_position 0.018310 m 2020-08-20T15:06:48.923Z,1597936008.923 [Reporter](INFO): platform_mass_position 0.017988 m 2020-08-20T15:06:49.324Z,1597936009.324 [Reporter](INFO): platform_mass_position 0.017668 m 2020-08-20T15:06:49.716Z,1597936009.716 [Reporter](INFO): platform_mass_position 0.017362 m 2020-08-20T15:06:50.123Z,1597936010.123 [Reporter](INFO): platform_mass_position 0.017044 m 2020-08-20T15:06:50.542Z,1597936010.542 [Reporter](INFO): platform_mass_position 0.016719 m 2020-08-20T15:06:51.058Z,1597936011.058 [Reporter](INFO): platform_mass_position 0.016315 m 2020-08-20T15:06:51.420Z,1597936011.420 [Reporter](INFO): platform_mass_position 0.016026 m 2020-08-20T15:06:51.788Z,1597936011.788 [Reporter](INFO): platform_mass_position 0.015739 m 2020-08-20T15:06:52.160Z,1597936012.160 [Reporter](INFO): platform_mass_position 0.015448 m 2020-08-20T15:06:52.226Z,1597936012.226 [DataOverHttps](INFO): Sending 317 bytes from file Logs/20200820T150147/Courier0000.lzma 2020-08-20T15:06:52.566Z,1597936012.566 [Reporter](INFO): platform_mass_position 0.015138 m 2020-08-20T15:06:52.941Z,1597936012.941 [Reporter](INFO): platform_mass_position 0.014841 m 2020-08-20T15:06:53.228Z,1597936013.228 [DataOverHttps](INFO): Moved sent file to Logs/20200820T150147/Courier0000.lzma.bak 2020-08-20T15:06:53.229Z,1597936013.229 [DataOverHttps](INFO): SBD MOMSN=12577881 2020-08-20T15:06:53.354Z,1597936013.354 [Reporter](INFO): platform_mass_position 0.014511 m 2020-08-20T15:06:53.756Z,1597936013.756 [Reporter](INFO): platform_mass_position 0.014200 m 2020-08-20T15:06:54.144Z,1597936014.144 [Reporter](INFO): platform_mass_position 0.013891 m 2020-08-20T15:06:54.559Z,1597936014.559 [Reporter](INFO): platform_mass_position 0.013574 m 2020-08-20T15:06:54.971Z,1597936014.971 [Reporter](INFO): platform_mass_position 0.013253 m 2020-08-20T15:06:55.360Z,1597936015.360 [Reporter](INFO): platform_mass_position 0.012934 m 2020-08-20T15:06:55.803Z,1597936015.803 [Reporter](INFO): platform_mass_position 0.012605 m 2020-08-20T15:06:56.204Z,1597936016.204 [Reporter](INFO): platform_mass_position 0.012279 m 2020-08-20T15:06:56.591Z,1597936016.591 [Reporter](INFO): platform_mass_position 0.011975 m 2020-08-20T15:06:57.003Z,1597936017.003 [Reporter](INFO): platform_mass_position 0.011658 m 2020-08-20T15:06:57.379Z,1597936017.379 [Reporter](INFO): platform_mass_position 0.011360 m 2020-08-20T15:06:57.784Z,1597936017.784 [Reporter](INFO): platform_mass_position 0.011043 m 2020-08-20T15:06:58.200Z,1597936018.200 [Reporter](INFO): platform_mass_position 0.010715 m 2020-08-20T15:06:58.608Z,1597936018.608 [Reporter](INFO): platform_mass_position 0.010396 m 2020-08-20T15:06:59.019Z,1597936019.019 [Reporter](INFO): platform_mass_position 0.010076 m 2020-08-20T15:06:59.408Z,1597936019.408 [Reporter](INFO): platform_mass_position 0.009770 m 2020-08-20T15:06:59.812Z,1597936019.812 [Reporter](INFO): platform_mass_position 0.009453 m 2020-08-20T15:07:00.228Z,1597936020.228 [Reporter](INFO): platform_mass_position 0.009128 m 2020-08-20T15:07:00.608Z,1597936020.608 [Reporter](INFO): platform_mass_position 0.008824 m 2020-08-20T15:07:01.032Z,1597936021.032 [Reporter](INFO): platform_mass_position 0.008494 m 2020-08-20T15:07:01.432Z,1597936021.432 [Reporter](INFO): platform_mass_position 0.008178 m 2020-08-20T15:07:01.851Z,1597936021.851 [Reporter](INFO): platform_mass_position 0.007858 m 2020-08-20T15:07:02.263Z,1597936022.263 [Reporter](INFO): platform_mass_position 0.007538 m 2020-08-20T15:07:02.635Z,1597936022.635 [Reporter](INFO): platform_mass_position 0.007241 m 2020-08-20T15:07:03.098Z,1597936023.098 [Reporter](INFO): platform_mass_position 0.006882 m 2020-08-20T15:07:03.524Z,1597936023.524 [Reporter](INFO): platform_mass_position 0.006556 m 2020-08-20T15:07:03.892Z,1597936023.892 [Reporter](INFO): platform_mass_position 0.006254 m 2020-08-20T15:07:04.291Z,1597936024.291 [Reporter](INFO): platform_mass_position 0.005946 m 2020-08-20T15:07:04.676Z,1597936024.676 [Reporter](INFO): platform_mass_position 0.005638 m 2020-08-20T15:07:05.073Z,1597936025.073 [Reporter](INFO): platform_mass_position 0.005336 m 2020-08-20T15:07:05.455Z,1597936025.455 [Reporter](INFO): platform_mass_position 0.005025 m 2020-08-20T15:07:05.864Z,1597936025.864 [Reporter](INFO): platform_mass_position 0.004707 m 2020-08-20T15:07:06.288Z,1597936026.288 [Reporter](INFO): platform_mass_position 0.004375 m 2020-08-20T15:07:06.697Z,1597936026.697 [Reporter](INFO): platform_mass_position 0.004059 m 2020-08-20T15:07:07.110Z,1597936027.110 [Reporter](INFO): platform_mass_position 0.003738 m 2020-08-20T15:07:07.492Z,1597936027.492 [Reporter](INFO): platform_mass_position 0.003431 m 2020-08-20T15:07:07.894Z,1597936027.894 [Reporter](INFO): platform_mass_position 0.003122 m 2020-08-20T15:07:08.300Z,1597936028.300 [Reporter](INFO): platform_mass_position 0.002800 m 2020-08-20T15:07:08.709Z,1597936028.709 [Reporter](INFO): platform_mass_position 0.002478 m 2020-08-20T15:07:09.092Z,1597936029.092 [Reporter](INFO): platform_mass_position 0.002177 m 2020-08-20T15:07:09.512Z,1597936029.512 [Reporter](INFO): platform_mass_position 0.001856 m 2020-08-20T15:07:09.920Z,1597936029.920 [Reporter](INFO): platform_mass_position 0.001531 m 2020-08-20T15:07:10.306Z,1597936030.306 [Reporter](INFO): platform_mass_position 0.001225 m 2020-08-20T15:07:10.712Z,1597936030.712 [Reporter](INFO): platform_mass_position 0.000907 m 2020-08-20T15:07:11.129Z,1597936031.129 [Reporter](INFO): platform_mass_position 0.000589 m 2020-08-20T15:07:11.549Z,1597936031.549 [Reporter](INFO): platform_mass_position 0.000256 m 2020-08-20T15:07:11.960Z,1597936031.960 [Reporter](INFO): platform_mass_position -0.000066 m 2020-08-20T15:07:12.360Z,1597936032.360 [Reporter](INFO): platform_mass_position -0.000387 m 2020-08-20T15:07:12.770Z,1597936032.770 [Reporter](INFO): platform_mass_position -0.000694 m 2020-08-20T15:07:13.141Z,1597936033.141 [Reporter](INFO): platform_mass_position -0.001003 m 2020-08-20T15:07:13.536Z,1597936033.536 [Reporter](INFO): platform_mass_position -0.001309 m 2020-08-20T15:07:13.959Z,1597936033.959 [Reporter](INFO): platform_mass_position -0.001625 m 2020-08-20T15:07:14.368Z,1597936034.368 [Reporter](INFO): platform_mass_position -0.001947 m 2020-08-20T15:07:14.761Z,1597936034.761 [Reporter](INFO): platform_mass_position -0.002272 m 2020-08-20T15:07:15.212Z,1597936035.212 [Reporter](INFO): platform_mass_position -0.002621 m 2020-08-20T15:07:15.628Z,1597936035.628 [Reporter](INFO): platform_mass_position -0.002950 m 2020-08-20T15:07:16.008Z,1597936036.008 [Reporter](INFO): platform_mass_position -0.003244 m 2020-08-20T15:07:16.403Z,1597936036.403 [Reporter](INFO): platform_mass_position -0.003551 m 2020-08-20T15:07:16.819Z,1597936036.819 [Reporter](INFO): platform_mass_position -0.003874 m 2020-08-20T15:07:17.192Z,1597936037.192 [Reporter](INFO): platform_mass_position -0.004172 m 2020-08-20T15:07:17.598Z,1597936037.598 [Reporter](INFO): platform_mass_position -0.004483 m 2020-08-20T15:07:18.017Z,1597936038.017 [Reporter](INFO): platform_mass_position -0.004814 m 2020-08-20T15:07:18.388Z,1597936038.388 [Reporter](INFO): platform_mass_position -0.005109 m 2020-08-20T15:07:18.808Z,1597936038.808 [Reporter](INFO): platform_mass_position -0.005432 m 2020-08-20T15:07:19.206Z,1597936039.206 [Reporter](INFO): platform_mass_position -0.005752 m 2020-08-20T15:07:19.600Z,1597936039.600 [Reporter](INFO): platform_mass_position -0.006059 m 2020-08-20T15:07:20.009Z,1597936040.009 [Reporter](INFO): platform_mass_position -0.006375 m 2020-08-20T15:07:20.420Z,1597936040.420 [Reporter](INFO): platform_mass_position -0.006693 m 2020-08-20T15:07:20.826Z,1597936040.826 [Reporter](INFO): platform_mass_position -0.007017 m 2020-08-20T15:07:21.292Z,1597936041.292 [Reporter](INFO): platform_mass_position -0.007324 m 2020-08-20T15:07:21.616Z,1597936041.616 [Reporter](INFO): platform_mass_position -0.007639 m 2020-08-20T15:07:22.044Z,1597936042.044 [Reporter](INFO): platform_mass_position -0.007975 m 2020-08-20T15:07:22.451Z,1597936042.451 [Reporter](INFO): platform_mass_position -0.008286 m 2020-08-20T15:07:22.866Z,1597936042.866 [Reporter](INFO): platform_mass_position -0.008611 m 2020-08-20T15:07:23.269Z,1597936043.269 [Reporter](INFO): platform_mass_position -0.008936 m 2020-08-20T15:07:23.663Z,1597936043.663 [Reporter](INFO): platform_mass_position -0.009244 m 2020-08-20T15:07:24.080Z,1597936044.080 [Reporter](INFO): platform_mass_position -0.009572 m 2020-08-20T15:07:24.481Z,1597936044.481 [Reporter](INFO): platform_mass_position -0.009884 m 2020-08-20T15:07:24.903Z,1597936044.903 [Reporter](INFO): platform_mass_position -0.010215 m 2020-08-20T15:07:25.288Z,1597936045.288 [Reporter](INFO): platform_mass_position -0.010514 m 2020-08-20T15:07:25.684Z,1597936045.684 [Reporter](INFO): platform_mass_position -0.010823 m 2020-08-20T15:07:26.097Z,1597936046.097 [Reporter](INFO): platform_mass_position -0.011146 m 2020-08-20T15:07:26.496Z,1597936046.496 [Reporter](INFO): platform_mass_position -0.011467 m 2020-08-20T15:07:26.884Z,1597936046.884 [Reporter](INFO): platform_mass_position -0.011764 m 2020-08-20T15:07:27.380Z,1597936047.380 [Reporter](INFO): platform_mass_position -0.012160 m 2020-08-20T15:07:27.724Z,1597936047.724 [Reporter](INFO): platform_mass_position -0.012430 m 2020-08-20T15:07:28.130Z,1597936048.130 [Reporter](INFO): platform_mass_position -0.012739 m 2020-08-20T15:07:28.532Z,1597936048.532 [Reporter](INFO): platform_mass_position -0.013062 m 2020-08-20T15:07:28.906Z,1597936048.906 [Reporter](INFO): platform_mass_position -0.013351 m 2020-08-20T15:07:29.292Z,1597936049.292 [Reporter](INFO): platform_mass_position -0.013655 m 2020-08-20T15:07:29.704Z,1597936049.704 [Reporter](INFO): platform_mass_position -0.013977 m 2020-08-20T15:07:30.108Z,1597936050.108 [Reporter](INFO): platform_mass_position -0.014296 m 2020-08-20T15:07:30.521Z,1597936050.521 [Reporter](INFO): platform_mass_position -0.014614 m 2020-08-20T15:07:30.934Z,1597936050.934 [Reporter](INFO): platform_mass_position -0.014940 m 2020-08-20T15:07:31.316Z,1597936051.316 [Reporter](INFO): platform_mass_position -0.015242 m 2020-08-20T15:07:31.728Z,1597936051.728 [Reporter](INFO): platform_mass_position -0.015559 m 2020-08-20T15:07:32.141Z,1597936052.141 [Reporter](INFO): platform_mass_position -0.015885 m 2020-08-20T15:07:32.563Z,1597936052.563 [Reporter](INFO): platform_mass_position -0.016215 m 2020-08-20T15:07:32.960Z,1597936052.960 [Reporter](INFO): platform_mass_position -0.016535 m 2020-08-20T15:07:33.348Z,1597936053.348 [Reporter](INFO): platform_mass_position -0.016836 m 2020-08-20T15:07:33.756Z,1597936053.756 [Reporter](INFO): platform_mass_position -0.017152 m 2020-08-20T15:07:34.165Z,1597936054.165 [Reporter](INFO): platform_mass_position -0.017472 m 2020-08-20T15:07:34.544Z,1597936054.544 [Reporter](INFO): platform_mass_position -0.017770 m 2020-08-20T15:07:34.960Z,1597936054.960 [Reporter](INFO): platform_mass_position -0.018096 m 2020-08-20T15:07:35.373Z,1597936055.373 [Reporter](INFO): platform_mass_position -0.018413 m 2020-08-20T15:07:35.760Z,1597936055.760 [Reporter](INFO): platform_mass_position -0.018724 m 2020-08-20T15:07:36.160Z,1597936056.160 [Reporter](INFO): platform_mass_position -0.019042 m 2020-08-20T15:07:36.577Z,1597936056.577 [Reporter](INFO): platform_mass_position -0.019360 m 2020-08-20T15:07:36.989Z,1597936056.989 [Reporter](INFO): platform_mass_position -0.019684 m 2020-08-20T15:07:37.376Z,1597936057.376 [Reporter](INFO): platform_mass_position -0.019991 m 2020-08-20T15:07:39.340Z,1597936059.340 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2020-08-20T15:07:59.987Z,1597936079.987 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2020-08-20T15:07:59.987Z,1597936079.987 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-08-20T15:08:00.026Z,1597936080.026 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-08-20T15:08:00.404Z,1597936080.404 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-08-20T15:08:00.404Z,1597936080.404 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2020-08-20T15:08:23.801Z,1597936103.801 [CBIT](FAULT): WATER ALARM BOW. 2020-08-20T15:08:23.802Z,1597936103.802 [CBIT](ERROR): WATER DETECTED IN PRESSURE HULL. Alarm Count: 1 2020-08-20T15:08:33.940Z,1597936113.940 [CBIT](FAULT): WATER ALARM STERN. 2020-08-20T15:08:33.941Z,1597936113.941 [CBIT](ERROR): WATER DETECTED IN PRESSURE HULL. Alarm Count: 1 2020-08-20T15:08:34.321Z,1597936114.321 [CBIT](FAULT): WATER ALARM STERN. 2020-08-20T15:08:34.322Z,1597936114.322 [CBIT](ERROR): WATER DETECTED IN PRESSURE HULL. Alarm Count: 2 2020-08-20T15:08:34.740Z,1597936114.740 [CBIT](FAULT): WATER ALARM STERN. 2020-08-20T15:08:34.741Z,1597936114.741 [CBIT](ERROR): WATER DETECTED IN PRESSURE HULL. Alarm Count: 3 2020-08-20T15:08:35.137Z,1597936115.137 [CBIT](FAULT): WATER ALARM STERN. 2020-08-20T15:08:35.150Z,1597936115.150 [CBIT](CRITICAL): WATER DETECTED IN PRESSURE HULL. BURNWIRE ACTIVATED 2020-08-20T15:08:35.151Z,1597936115.151 [CBIT](IMPORTANT): No ESP to power off. 2020-08-20T15:08:35.559Z,1597936115.559 [CBIT](INFO): Critical error at 20200820T150835 2020-08-20T15:09:10.539Z,1597936150.539 [CommandLine](IMPORTANT): got command burn off 2020-08-20T15:09:10.539Z,1597936150.539 [CommandLine](IMPORTANT): Deactivating dropweight wire 2020-08-20T15:09:31.584Z,1597936171.584 [CommandLine](IMPORTANT): got command restart application 2020-08-20T15:09:32.591Z,1597936172.591 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2020-08-20T15:09:32.591Z,1597936172.591 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-08-20T15:09:32.626Z,1597936172.626 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2020-08-20T15:09:32.626Z,1597936172.626 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-08-20T15:09:32.627Z,1597936172.627 [CommandLine](INFO): Join timeout helper Thread ID is 7074 2020-08-20T15:09:32.630Z,1597936172.630 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2020-08-20T15:09:32.631Z,1597936172.631 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-08-20T15:09:32.631Z,1597936172.631 [NavChartDb](INFO): Join timeout helper Thread ID is 7075 2020-08-20T15:09:33.015Z,1597936173.015 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2020-08-20T15:09:33.016Z,1597936173.016 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-08-20T15:09:33.034Z,1597936173.034 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2020-08-20T15:09:33.034Z,1597936173.034 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2020-08-20T15:09:33.035Z,1597936173.035 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 7076 2020-08-20T15:09:33.511Z,1597936173.511 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2020-08-20T15:09:33.511Z,1597936173.511 [WetLabsBB2FL](INFO): Powering down 2020-08-20T15:09:33.512Z,1597936173.512 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2020-08-20T15:09:33.518Z,1597936173.518 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2020-08-20T15:09:33.518Z,1597936173.518 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2020-08-20T15:09:33.519Z,1597936173.519 [CTD_Seabird](INFO): Join timeout helper Thread ID is 7077 2020-08-20T15:09:33.676Z,1597936173.676 [CTD_Seabird](INFO): Powering down 2020-08-20T15:09:33.691Z,1597936173.691 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2020-08-20T15:09:33.691Z,1597936173.691 [CTD_Seabird](INFO): Powering down 2020-08-20T15:09:33.702Z,1597936173.702 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2020-08-20T15:09:33.712Z,1597936173.712 [ComponentRegistry](INFO): Shutting down BackSeatDriver ThreadHandler 2020-08-20T15:09:33.712Z,1597936173.712 [BackSeatDriver ThreadHandler](INFO): Thread cancelled. 2020-08-20T15:09:33.713Z,1597936173.713 [BackSeatDriver](INFO): Join timeout helper Thread ID is 7078 2020-08-20T15:09:33.827Z,1597936173.827 [BackSeatDriver ThreadHandler](INFO): Uninitializing protected caller thread. 2020-08-20T15:09:33.827Z,1597936173.827 [BackSeatDriver ThreadHandler](INFO): Thread cancelled. 2020-08-20T15:09:33.831Z,1597936173.831 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2020-08-20T15:09:33.831Z,1597936173.831 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2020-08-20T15:09:33.832Z,1597936173.832 [Radio_Surface](INFO): Join timeout helper Thread ID is 7079 2020-08-20T15:09:34.226Z,1597936174.226 [Radio_Surface](INFO): Powering down 2020-08-20T15:09:34.227Z,1597936174.227 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2020-08-20T15:09:34.228Z,1597936174.228 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2020-08-20T15:09:34.235Z,1597936174.235 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2020-08-20T15:09:34.235Z,1597936174.235 [Onboard ThreadHandler](INFO): Thread cancelled. 2020-08-20T15:09:34.236Z,1597936174.236 [Onboard](INFO): Join timeout helper Thread ID is 7080 2020-08-20T15:09:35.103Z,1597936175.103 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2020-08-20T15:09:39.111Z,1597936179.111 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2020-08-20T15:09:39.111Z,1597936179.111 [Onboard ThreadHandler](INFO): Thread cancelled. 2020-08-20T15:09:39.119Z,1597936179.119 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2020-08-20T15:09:39.119Z,1597936179.119 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-08-20T15:09:39.120Z,1597936179.120 [DataOverHttps](INFO): Join timeout helper Thread ID is 7081 2020-08-20T15:09:39.120Z,1597936179.120 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2020-08-20T15:09:39.120Z,1597936179.120 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-08-20T15:09:39.122Z,1597936179.122 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2020-08-20T15:09:39.122Z,1597936179.122 [logger ThreadHandler](INFO): Thread cancelled. 2020-08-20T15:09:39.122Z,1597936179.122 [logger](INFO): Join timeout helper Thread ID is 7082 2020-08-20T15:09:39.158Z,1597936179.158 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2020-08-20T15:09:39.159Z,1597936179.159 [logger ThreadHandler](INFO): Thread cancelled. 2020-08-20T15:09:39.163Z,1597936179.163 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2020-08-20T15:09:39.163Z,1597936179.163 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-08-20T15:09:39.163Z,1597936179.163 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2020-08-20T15:09:39.163Z,1597936179.163 [controlThread ThreadHandler](INFO): Thread cancelled. 2020-08-20T15:09:39.164Z,1597936179.164 [controlThread](INFO): Join timeout helper Thread ID is 7083 2020-08-20T15:09:39.314Z,1597936179.314 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2020-08-20T15:09:39.315Z,1597936179.315 [controlThread](DEBUG): Uninitializing ControlThread 2020-08-20T15:09:39.315Z,1597936179.315 [AHRS_M2](INFO): Powering down 2020-08-20T15:09:39.387Z,1597936179.387 [NAL9602](INFO): Powering down 2020-08-20T15:09:39.388Z,1597936179.388 [DAT](INFO): Powering down 2020-08-20T15:09:39.508Z,1597936179.508 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2020-08-20T15:09:39.509Z,1597936179.509 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2020-08-20T15:09:39.509Z,1597936179.509 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2020-08-20T15:09:39.510Z,1597936179.510 [MissionManager](INFO): Uninitializing Mission Default 2020-08-20T15:09:39.510Z,1597936179.510 [Default] Stopped 2020-08-20T15:09:39.510Z,1597936179.510 [Default](DEBUG): Aggregate::uninitialize Default 2020-08-20T15:09:39.510Z,1597936179.510 [Default:B.GoToSurface] Stopped 2020-08-20T15:09:39.510Z,1597936179.510 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2020-08-20T15:09:39.510Z,1597936179.510 [Default:CheckIn] Stopped 2020-08-20T15:09:39.510Z,1597936179.510 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-08-20T15:09:39.510Z,1597936179.510 [Default:CheckIn:Read_GPS] Stopped 2020-08-20T15:09:39.513Z,1597936179.513 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2020-08-20T15:09:39.513Z,1597936179.513 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2020-08-20T15:09:39.513Z,1597936179.513 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2020-08-20T15:09:39.514Z,1597936179.514 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2020-08-20T15:09:39.514Z,1597936179.514 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2020-08-20T15:09:39.514Z,1597936179.514 [BuoyancyServo](INFO): Powering down 2020-08-20T15:09:39.526Z,1597936179.526 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2020-08-20T15:09:39.527Z,1597936179.527 [ElevatorServo](INFO): Powering down 2020-08-20T15:09:39.527Z,1597936179.527 [MassServo](DEBUG): Uninitialize Mass Servo. 2020-08-20T15:09:39.527Z,1597936179.527 [MassServo](INFO): Powering down 2020-08-20T15:09:39.528Z,1597936179.528 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2020-08-20T15:09:39.528Z,1597936179.528 [RudderServo](INFO): Powering down 2020-08-20T15:09:39.529Z,1597936179.529 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2020-08-20T15:09:39.529Z,1597936179.529 [ThrusterServo](INFO): Powering down 2020-08-20T15:09:39.530Z,1597936179.530 [SBIT](DEBUG): Uninitialize SBIT Component. 2020-08-20T15:09:39.531Z,1597936179.531 [IBIT](DEBUG): Uninitialize IBIT Component. 2020-08-20T15:09:39.531Z,1597936179.531 [CBIT](DEBUG): Uninitialize CBIT Component. 2020-08-20T15:09:39.531Z,1597936179.531 [CBIT](DEBUG): Powering off loads. 2020-08-20T15:09:39.542Z,1597936179.542 [CBIT](DEBUG): Disabling WDT. 2020-08-20T15:09:39.554Z,1597936179.554 [CBIT](DEBUG): Opening all GF detection circuits. 2020-08-20T15:09:39.555Z,1597936179.555 [controlThread ThreadHandler](INFO): Thread cancelled. 2020-08-20T15:09:39.653Z,1597936179.653 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2020-08-20T15:09:39.655Z,1597936179.655 [Onboard ThreadHandler](INFO): Thread cancelled. 2020-08-20T15:09:39.661Z,1597936179.661 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-08-20T15:09:39.724Z,1597936179.724 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2020-08-20T15:09:39.728Z,1597936179.728 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2020-08-20T15:09:39.732Z,1597936179.732 [BackSeatDriver ThreadHandler](INFO): Thread cancelled. 2020-08-20T15:09:39.742Z,1597936179.742 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-08-20T15:09:39.807Z,1597936179.807 [logger ThreadHandler](INFO): Thread cancelled.