2020-09-30T19:22:26.491Z,1601493746.491 [Supervisor](DEBUG): Initializing supervisor. 2020-09-30T19:22:26.494Z,1601493746.494 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2020-09-30T19:22:26.495Z,1601493746.495 [SyncHandler](INFO): Protected caller Thread ID is 5440 2020-09-30T19:22:26.496Z,1601493746.496 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2020-09-30T19:22:26.496Z,1601493746.496 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2020-09-30T19:22:26.497Z,1601493746.497 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 5441 2020-09-30T19:22:26.500Z,1601493746.500 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2020-09-30T19:22:26.515Z,1601493746.515 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2020-09-30T19:22:26.516Z,1601493746.516 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2020-09-30T19:22:26.516Z,1601493746.516 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 5442 2020-09-30T19:22:26.517Z,1601493746.517 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2020-09-30T19:22:26.517Z,1601493746.517 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2020-09-30T19:22:26.518Z,1601493746.518 [logger ThreadHandler](INFO): Protected caller Thread ID is 5443 2020-09-30T19:22:26.520Z,1601493746.520 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2020-09-30T19:22:26.520Z,1601493746.520 [Supervisor](INFO): Looking for Config files in directory: Config/ 2020-09-30T19:22:26.522Z,1601493746.522 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2020-09-30T19:22:26.615Z,1601493746.615 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2020-09-30T19:22:26.616Z,1601493746.616 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2020-09-30T19:22:27.195Z,1601493747.195 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2020-09-30T19:22:27.195Z,1601493747.195 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2020-09-30T19:22:27.387Z,1601493747.387 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2020-09-30T19:22:27.388Z,1601493747.388 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2020-09-30T19:22:27.485Z,1601493747.485 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2020-09-30T19:22:27.485Z,1601493747.485 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2020-09-30T19:22:27.585Z,1601493747.585 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2020-09-30T19:22:27.586Z,1601493747.586 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2020-09-30T19:22:27.666Z,1601493747.666 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2020-09-30T19:22:27.803Z,1601493747.803 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2020-09-30T19:22:27.803Z,1601493747.803 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2020-09-30T19:22:28.087Z,1601493748.087 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2020-09-30T19:22:28.088Z,1601493748.088 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2020-09-30T19:22:28.535Z,1601493748.535 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2020-09-30T19:22:28.536Z,1601493748.536 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2020-09-30T19:22:28.678Z,1601493748.678 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2020-09-30T19:22:28.678Z,1601493748.678 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2020-09-30T19:22:28.861Z,1601493748.861 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2020-09-30T19:22:28.861Z,1601493748.861 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2020-09-30T19:22:29.353Z,1601493749.353 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2020-09-30T19:22:29.353Z,1601493749.353 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2020-09-30T19:22:29.565Z,1601493749.565 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2020-09-30T19:22:29.565Z,1601493749.565 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2020-09-30T19:22:29.761Z,1601493749.761 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2020-09-30T19:22:29.762Z,1601493749.762 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2020-09-30T19:22:30.164Z,1601493750.164 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2020-09-30T19:22:30.165Z,1601493750.165 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2020-09-30T19:22:30.481Z,1601493750.481 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2020-09-30T19:22:30.483Z,1601493750.483 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/ 2020-09-30T19:22:30.484Z,1601493750.484 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg 2020-09-30T19:22:30.604Z,1601493750.604 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg 2020-09-30T19:22:31.002Z,1601493751.002 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg 2020-09-30T19:22:31.166Z,1601493751.166 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg 2020-09-30T19:22:31.332Z,1601493751.332 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg 2020-09-30T19:22:31.426Z,1601493751.426 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg 2020-09-30T19:22:31.615Z,1601493751.615 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg 2020-09-30T19:22:31.843Z,1601493751.843 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2020-09-30T19:22:31.844Z,1601493751.844 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg 2020-09-30T19:22:31.936Z,1601493751.936 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg 2020-09-30T19:22:32.032Z,1601493752.032 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg 2020-09-30T19:22:32.158Z,1601493752.158 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg 2020-09-30T19:22:32.256Z,1601493752.256 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/root/ 2020-09-30T19:22:32.256Z,1601493752.256 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2020-09-30T19:22:32.272Z,1601493752.272 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2020-09-30T19:22:32.356Z,1601493752.356 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2020-09-30T19:22:32.357Z,1601493752.357 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2020-09-30T19:22:32.407Z,1601493752.407 [VerticalControl](DEBUG): Construct VerticalControl. 2020-09-30T19:22:32.517Z,1601493752.517 [VerticalControl] Loaded 2020-09-30T19:22:32.518Z,1601493752.518 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2020-09-30T19:22:32.518Z,1601493752.518 [HorizontalControl](DEBUG): Construct HorizontalControl. 2020-09-30T19:22:32.598Z,1601493752.598 [HorizontalControl] Loaded 2020-09-30T19:22:32.598Z,1601493752.598 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2020-09-30T19:22:32.599Z,1601493752.599 [SpeedControl](DEBUG): Construct SpeedControl. 2020-09-30T19:22:32.604Z,1601493752.604 [SpeedControl] Loaded 2020-09-30T19:22:32.604Z,1601493752.604 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2020-09-30T19:22:32.605Z,1601493752.605 [LoopControl](DEBUG): Construct LoopControl. 2020-09-30T19:22:32.605Z,1601493752.605 [LoopControl] Loaded 2020-09-30T19:22:32.606Z,1601493752.606 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2020-09-30T19:22:32.606Z,1601493752.606 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2020-09-30T19:22:32.607Z,1601493752.607 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2020-09-30T19:22:32.650Z,1601493752.650 [DepthRateCalculator] Loaded 2020-09-30T19:22:32.650Z,1601493752.650 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2020-09-30T19:22:32.655Z,1601493752.655 [PitchRateCalculator] Loaded 2020-09-30T19:22:32.655Z,1601493752.655 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2020-09-30T19:22:32.671Z,1601493752.671 [SpeedCalculator] Loaded 2020-09-30T19:22:32.671Z,1601493752.671 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2020-09-30T19:22:32.692Z,1601493752.692 [TempGradientCalculator] Loaded 2020-09-30T19:22:32.692Z,1601493752.692 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2020-09-30T19:22:32.697Z,1601493752.697 [YawRateCalculator] Loaded 2020-09-30T19:22:32.697Z,1601493752.697 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2020-09-30T19:22:32.726Z,1601493752.726 [ElevatorOffsetCalculator] Loaded 2020-09-30T19:22:32.726Z,1601493752.726 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2020-09-30T19:22:32.727Z,1601493752.727 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2020-09-30T19:22:32.727Z,1601493752.727 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2020-09-30T19:22:32.755Z,1601493752.755 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2020-09-30T19:22:32.755Z,1601493752.755 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2020-09-30T19:22:32.846Z,1601493752.846 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2020-09-30T19:22:32.846Z,1601493752.846 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2020-09-30T19:22:33.168Z,1601493753.168 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2020-09-30T19:22:33.168Z,1601493753.168 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2020-09-30T19:22:33.275Z,1601493753.275 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2020-09-30T19:22:33.276Z,1601493753.276 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2020-09-30T19:22:33.628Z,1601493753.628 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_orientation 2020-09-30T19:22:33.633Z,1601493753.633 [AHRS_M2](INFO): created writer for : platform_orientation 2020-09-30T19:22:33.635Z,1601493753.635 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_magnetic_orientation 2020-09-30T19:22:33.641Z,1601493753.641 [AHRS_M2](INFO): created writer for : platform_magnetic_orientation 2020-09-30T19:22:33.641Z,1601493753.641 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_pitch_angle 2020-09-30T19:22:33.646Z,1601493753.646 [AHRS_M2](INFO): created writer for : platform_pitch_angle 2020-09-30T19:22:33.647Z,1601493753.647 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_roll_angle 2020-09-30T19:22:33.652Z,1601493753.652 [AHRS_M2](INFO): created writer for : platform_roll_angle 2020-09-30T19:22:33.725Z,1601493753.725 [AHRS_M2] Loaded 2020-09-30T19:22:33.725Z,1601493753.725 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2020-09-30T19:22:33.801Z,1601493753.801 [DataOverHttps] Loaded 2020-09-30T19:22:33.801Z,1601493753.801 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2020-09-30T19:22:33.803Z,1601493753.803 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4090E4E0 2020-09-30T19:22:33.803Z,1601493753.803 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 5525 2020-09-30T19:22:33.833Z,1601493753.833 [Depth_Keller] Loaded 2020-09-30T19:22:33.833Z,1601493753.833 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2020-09-30T19:22:33.951Z,1601493753.951 [NAL9602] Loaded 2020-09-30T19:22:33.951Z,1601493753.951 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2020-09-30T19:22:34.000Z,1601493754.000 [Onboard] Loaded 2020-09-30T19:22:34.000Z,1601493754.000 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2020-09-30T19:22:34.001Z,1601493754.001 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4093E4E0 2020-09-30T19:22:34.002Z,1601493754.002 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 5526 2020-09-30T19:22:34.021Z,1601493754.021 [Radio_Surface] Loaded 2020-09-30T19:22:34.022Z,1601493754.022 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2020-09-30T19:22:34.023Z,1601493754.023 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4096E4E0 2020-09-30T19:22:34.023Z,1601493754.023 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 5527 2020-09-30T19:22:34.178Z,1601493754.178 [DAT] Loaded 2020-09-30T19:22:34.178Z,1601493754.178 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread. 2020-09-30T19:22:35.721Z,1601493755.721 [BPC1] Loaded 2020-09-30T19:22:35.722Z,1601493755.722 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2020-09-30T19:22:35.722Z,1601493755.722 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2020-09-30T19:22:35.723Z,1601493755.723 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2020-09-30T19:22:36.015Z,1601493756.015 [DeadReckonUsingMultipleVelocitySources] Loaded 2020-09-30T19:22:36.015Z,1601493756.015 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2020-09-30T19:22:36.035Z,1601493756.035 [NavChart] Loaded 2020-09-30T19:22:36.036Z,1601493756.036 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2020-09-30T19:22:36.039Z,1601493756.039 [UniversalFixResidualReporter] Loaded 2020-09-30T19:22:36.040Z,1601493756.040 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2020-09-30T19:22:36.040Z,1601493756.040 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2020-09-30T19:22:36.040Z,1601493756.040 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2020-09-30T19:22:36.375Z,1601493756.375 [SBIT](DEBUG): Construct Startup Built In Test. 2020-09-30T19:22:36.386Z,1601493756.386 [SBIT] Loaded 2020-09-30T19:22:36.386Z,1601493756.386 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2020-09-30T19:22:36.387Z,1601493756.387 [IBIT](DEBUG): Construct Initiated Built In Test. 2020-09-30T19:22:36.399Z,1601493756.399 [IBIT] Loaded 2020-09-30T19:22:36.399Z,1601493756.399 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2020-09-30T19:22:36.402Z,1601493756.402 [CBIT](DEBUG): Construct Continuous Built In Test. 2020-09-30T19:22:36.541Z,1601493756.541 [CBIT] Loaded 2020-09-30T19:22:36.541Z,1601493756.541 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2020-09-30T19:22:36.541Z,1601493756.541 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2020-09-30T19:22:36.542Z,1601493756.542 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2020-09-30T19:22:36.673Z,1601493756.673 [BuoyancyServo] Loaded 2020-09-30T19:22:36.673Z,1601493756.673 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2020-09-30T19:22:36.702Z,1601493756.702 [ElevatorServo] Loaded 2020-09-30T19:22:36.702Z,1601493756.702 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2020-09-30T19:22:36.731Z,1601493756.731 [MassServo] Loaded 2020-09-30T19:22:36.731Z,1601493756.731 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2020-09-30T19:22:36.758Z,1601493756.758 [RudderServo] Loaded 2020-09-30T19:22:36.759Z,1601493756.759 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2020-09-30T19:22:36.786Z,1601493756.786 [ThrusterServo] Loaded 2020-09-30T19:22:36.787Z,1601493756.787 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2020-09-30T19:22:36.787Z,1601493756.787 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2020-09-30T19:22:36.787Z,1601493756.787 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2020-09-30T19:22:36.807Z,1601493756.807 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2020-09-30T19:22:36.808Z,1601493756.808 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2020-09-30T19:22:37.054Z,1601493757.054 [BackSeatDriver] Loaded 2020-09-30T19:22:37.055Z,1601493757.055 [ComponentRegistry](DEBUG): Component "BackSeatDriver" handled in its own thread. 2020-09-30T19:22:37.056Z,1601493757.056 [BackSeatDriver ThreadHandler](DEBUG): Created PCaller Thread at 40B054E0 2020-09-30T19:22:37.056Z,1601493757.056 [BackSeatDriver ThreadHandler](INFO): Protected caller Thread ID is 5528 2020-09-30T19:22:37.084Z,1601493757.084 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density 2020-09-30T19:22:37.090Z,1601493757.090 [CTD_Seabird](INFO): created writer for : sea_water_density 2020-09-30T19:22:37.090Z,1601493757.090 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth 2020-09-30T19:22:37.095Z,1601493757.095 [CTD_Seabird](INFO): created writer for : depth 2020-09-30T19:22:37.096Z,1601493757.096 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure 2020-09-30T19:22:37.101Z,1601493757.101 [CTD_Seabird](INFO): created writer for : sea_water_pressure 2020-09-30T19:22:37.101Z,1601493757.101 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity 2020-09-30T19:22:37.107Z,1601493757.107 [CTD_Seabird](INFO): created writer for : sea_water_salinity 2020-09-30T19:22:37.107Z,1601493757.107 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature 2020-09-30T19:22:37.112Z,1601493757.112 [CTD_Seabird](INFO): created writer for : sea_water_temperature 2020-09-30T19:22:37.113Z,1601493757.113 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity 2020-09-30T19:22:37.120Z,1601493757.120 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity 2020-09-30T19:22:37.120Z,1601493757.120 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water 2020-09-30T19:22:37.125Z,1601493757.125 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water 2020-09-30T19:22:37.153Z,1601493757.153 [CTD_Seabird] Loaded 2020-09-30T19:22:37.153Z,1601493757.153 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2020-09-30T19:22:37.154Z,1601493757.154 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B354E0 2020-09-30T19:22:37.155Z,1601493757.155 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 5529 2020-09-30T19:22:37.205Z,1601493757.205 [ESPComponent] Loaded 2020-09-30T19:22:37.205Z,1601493757.205 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2020-09-30T19:22:37.227Z,1601493757.227 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output470 2020-09-30T19:22:37.228Z,1601493757.228 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output470 2020-09-30T19:22:37.232Z,1601493757.232 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output650 2020-09-30T19:22:37.232Z,1601493757.232 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output650 2020-09-30T19:22:37.236Z,1601493757.236 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.OutputChl 2020-09-30T19:22:37.236Z,1601493757.236 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: OutputChl 2020-09-30T19:22:37.241Z,1601493757.241 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg470nm 2020-09-30T19:22:37.241Z,1601493757.241 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg470nm 2020-09-30T19:22:37.245Z,1601493757.245 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg650nm 2020-09-30T19:22:37.245Z,1601493757.245 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg650nm 2020-09-30T19:22:37.250Z,1601493757.250 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff470nm 2020-09-30T19:22:37.250Z,1601493757.250 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff470nm 2020-09-30T19:22:37.254Z,1601493757.254 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff650nm 2020-09-30T19:22:37.254Z,1601493757.254 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff650nm 2020-09-30T19:22:37.259Z,1601493757.259 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): mass_concentration_of_chlorophyll_in_sea_water 2020-09-30T19:22:37.263Z,1601493757.263 [WetLabsBB2FL](INFO): created writer for : mass_concentration_of_chlorophyll_in_sea_water 2020-09-30T19:22:37.264Z,1601493757.264 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water 2020-09-30T19:22:37.264Z,1601493757.264 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_median_mass_concentration_of_chlorophyll_in_sea_water 2020-09-30T19:22:37.268Z,1601493757.268 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water 2020-09-30T19:22:37.268Z,1601493757.268 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_mean_mass_concentration_of_chlorophyll_in_sea_water 2020-09-30T19:22:37.273Z,1601493757.273 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_variance_mass_concentration_of_chlorophyll_in_sea_water 2020-09-30T19:22:37.273Z,1601493757.273 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_variance_mass_concentration_of_chlorophyll_in_sea_water 2020-09-30T19:22:37.277Z,1601493757.277 [WetLabsBB2FL] Loaded 2020-09-30T19:22:37.278Z,1601493757.278 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2020-09-30T19:22:37.279Z,1601493757.279 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B654E0 2020-09-30T19:22:37.279Z,1601493757.279 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 5530 2020-09-30T19:22:37.280Z,1601493757.280 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2020-09-30T19:22:37.283Z,1601493757.283 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2020-09-30T19:22:37.284Z,1601493757.284 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2020-09-30T19:22:37.291Z,1601493757.291 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2020-09-30T19:22:37.292Z,1601493757.292 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B954E0 2020-09-30T19:22:37.292Z,1601493757.292 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 5531 2020-09-30T19:22:37.297Z,1601493757.297 [Supervisor](INFO): Main Thread ID is 4201 2020-09-30T19:22:37.297Z,1601493757.297 [Supervisor](DEBUG): Running supervisor. 2020-09-30T19:22:37.297Z,1601493757.297 [CommandLine ThreadHandler](INFO): Handler Thread ID is 5532 2020-09-30T19:22:37.300Z,1601493757.300 [controlThread ThreadHandler](INFO): Handler Thread ID is 5533 2020-09-30T19:22:37.300Z,1601493757.300 [controlThread](DEBUG): Initializing ControlThread 2020-09-30T19:22:37.301Z,1601493757.301 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2020-09-30T19:22:37.303Z,1601493757.303 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2020-09-30T19:22:37.303Z,1601493757.303 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2020-09-30T19:22:37.304Z,1601493757.304 [LoopControl](DEBUG): Initialize LoopControlComponent. 2020-09-30T19:22:37.304Z,1601493757.304 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2020-09-30T19:22:37.305Z,1601493757.305 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2020-09-30T19:22:37.305Z,1601493757.305 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2020-09-30T19:22:37.305Z,1601493757.305 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2020-09-30T19:22:37.306Z,1601493757.306 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2020-09-30T19:22:37.306Z,1601493757.306 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2020-09-30T19:22:37.312Z,1601493757.312 [NavChart](DEBUG): Initialize NavChart Navigation. 2020-09-30T19:22:37.312Z,1601493757.312 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2020-09-30T19:22:37.313Z,1601493757.313 [SBIT](INFO): Initialize SBIT Component. 2020-09-30T19:22:37.313Z,1601493757.313 [SBIT](IMPORTANT): git: 2020-09-25 2020-09-30T19:22:37.313Z,1601493757.313 [SBIT](INFO): git hash: 37975fc996eaab47e1849088435330a6c93ea7b4 2020-09-30T19:22:37.313Z,1601493757.313 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2020-09-30T19:22:37.315Z,1601493757.315 [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-09-30T19:22:37.316Z,1601493757.316 [SBIT](INFO): Beginning SBIT in 99.000000 seconds. 2020-09-30T19:22:37.316Z,1601493757.316 [IBIT](INFO): Initialize IBIT Component. 2020-09-30T19:22:37.317Z,1601493757.317 [CBIT](DEBUG): Initialize CBIT Component. 2020-09-30T19:22:37.318Z,1601493757.318 [logger ThreadHandler](INFO): Handler Thread ID is 5534 2020-09-30T19:22:37.331Z,1601493757.331 [CBIT](DEBUG): Initialized mux pins. 2020-09-30T19:22:37.331Z,1601493757.331 [CBIT](DEBUG): Initializing the watchdog timer. 2020-09-30T19:22:37.335Z,1601493757.335 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 5535 2020-09-30T19:22:37.336Z,1601493757.336 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2020-09-30T19:22:37.343Z,1601493757.343 [Onboard ThreadHandler](INFO): Handler Thread ID is 5536 2020-09-30T19:22:37.355Z,1601493757.355 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2020-09-30T19:22:37.356Z,1601493757.356 [CBIT](DEBUG): Initializing heartbeat. 2020-09-30T19:22:37.372Z,1601493757.372 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 5537 2020-09-30T19:22:37.383Z,1601493757.383 [BackSeatDriver ThreadHandler](INFO): Handler Thread ID is 5538 2020-09-30T19:22:37.399Z,1601493757.399 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 5539 2020-09-30T19:22:37.400Z,1601493757.400 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2020-09-30T19:22:37.404Z,1601493757.404 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 5541 2020-09-30T19:22:37.405Z,1601493757.405 [WetLabsBB2FL](INFO): Powering down 2020-09-30T19:22:37.426Z,1601493757.426 [CBIT](DEBUG): Deactivating GF circuits. 2020-09-30T19:22:37.427Z,1601493757.427 [CBIT](DEBUG): Deactivating emergency mode. 2020-09-30T19:22:37.439Z,1601493757.439 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 5542 2020-09-30T19:22:37.442Z,1601493757.442 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2020-09-30T19:22:37.442Z,1601493757.442 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2020-09-30T19:22:37.442Z,1601493757.442 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2020-09-30T19:22:37.443Z,1601493757.443 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2020-09-30T19:22:37.443Z,1601493757.443 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2020-09-30T19:22:37.443Z,1601493757.443 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2020-09-30T19:22:37.443Z,1601493757.443 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2020-09-30T19:22:37.443Z,1601493757.443 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2020-09-30T19:22:37.443Z,1601493757.443 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2020-09-30T19:22:37.443Z,1601493757.443 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2020-09-30T19:22:37.444Z,1601493757.444 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2020-09-30T19:22:37.444Z,1601493757.444 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2020-09-30T19:22:37.444Z,1601493757.444 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2020-09-30T19:22:37.444Z,1601493757.444 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2020-09-30T19:22:37.444Z,1601493757.444 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2020-09-30T19:22:37.444Z,1601493757.444 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2020-09-30T19:22:37.462Z,1601493757.462 [CBIT](DEBUG): Backplane powered. 2020-09-30T19:22:37.464Z,1601493757.464 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2020-09-30T19:22:37.474Z,1601493757.474 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2020-09-30T19:22:37.484Z,1601493757.484 [MissionManager](DEBUG): 2020-09-30T19:22:37.485Z,1601493757.485 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2020-09-30T19:22:37.561Z,1601493757.561 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2020-09-30T19:22:37.562Z,1601493757.562 [Default:A.Wait](DEBUG): Construct Wait. 2020-09-30T19:22:37.580Z,1601493757.580 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2020-09-30T19:22:37.610Z,1601493757.610 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2020-09-30T19:22:37.613Z,1601493757.613 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2020-09-30T19:22:37.636Z,1601493757.636 [Default:E.Execute](DEBUG): Construct Execute. 2020-09-30T19:22:37.663Z,1601493757.663 [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-09-30T19:22:37.667Z,1601493757.667 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,NAL9602,DAT,BPC1,ESPComponent,Depth_Keller,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-09-30T19:22:37.679Z,1601493757.679 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2020-09-30T19:22:37.775Z,1601493757.775 [Radio_Surface](INFO): Powering up 2020-09-30T19:22:37.803Z,1601493757.803 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2 2020-09-30T19:22:37.835Z,1601493757.835 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2 2020-09-30T19:22:37.835Z,1601493757.835 [DAT](INFO): Powering up 2020-09-30T19:22:37.835Z,1601493757.835 [DAT](DEBUG): Initializing DAT. 2020-09-30T19:22:37.949Z,1601493757.949 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2020-09-30T19:22:37.955Z,1601493757.955 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2020-09-30T19:22:37.956Z,1601493757.956 [ElevatorServo](DEBUG): Initializing EZServoServo. 2020-09-30T19:22:37.963Z,1601493757.963 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2020-09-30T19:22:37.964Z,1601493757.964 [MassServo](DEBUG): Initializing EZServoServo. 2020-09-30T19:22:37.971Z,1601493757.971 [MassServo](DEBUG): Initializing MassServo. 2020-09-30T19:22:37.972Z,1601493757.972 [RudderServo](DEBUG): Initializing EZServoServo. 2020-09-30T19:22:37.979Z,1601493757.979 [RudderServo](DEBUG): Initializing RudderServo. 2020-09-30T19:22:37.980Z,1601493757.980 [ThrusterServo](DEBUG): Initializing EZServoServo. 2020-09-30T19:22:37.987Z,1601493757.987 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2020-09-30T19:22:38.811Z,1601493758.811 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2020-09-30T19:22:38.811Z,1601493758.811 [RudderServo](FAULT): Rudder failed to initialize 2020-09-30T19:22:38.811Z,1601493758.811 [RudderServo] Communications Fault, FailCount= 1 2020-09-30T19:22:38.811Z,1601493758.811 [RudderServo](ERROR): Communications Fault 2020-09-30T19:22:38.922Z,1601493758.922 [CBIT](ERROR): Communications Fault in component: RudderServo 2020-09-30T19:22:39.076Z,1601493759.076 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2020-09-30T19:22:39.076Z,1601493759.076 [RudderServo](INFO): Powering down 2020-09-30T19:22:39.750Z,1601493759.750 [RudderServo](DEBUG): Initializing EZServoServo. 2020-09-30T19:22:39.867Z,1601493759.867 [RudderServo](DEBUG): Initializing RudderServo. 2020-09-30T19:22:39.871Z,1601493759.871 [CBIT](INFO): Clearing failed state for component RudderServo 2020-09-30T19:22:39.872Z,1601493759.872 [RudderServo] No Fault, FailCount= 1 2020-09-30T19:22:41.475Z,1601493761.475 [BuoyancyServo](INFO): is needed 2020-09-30T19:22:41.831Z,1601493761.831 [BuoyancyServo](INFO): is needed 2020-09-30T19:22:42.287Z,1601493762.287 [BuoyancyServo](INFO): is needed 2020-09-30T19:22:42.660Z,1601493762.660 [BuoyancyServo](INFO): is needed 2020-09-30T19:22:43.051Z,1601493763.051 [BuoyancyServo](INFO): is needed 2020-09-30T19:22:43.463Z,1601493763.463 [BuoyancyServo](INFO): is needed 2020-09-30T19:22:43.859Z,1601493763.859 [BuoyancyServo](INFO): is needed 2020-09-30T19:22:44.263Z,1601493764.263 [BuoyancyServo](INFO): is needed 2020-09-30T19:22:44.676Z,1601493764.676 [BuoyancyServo](INFO): is needed 2020-09-30T19:22:47.463Z,1601493767.463 [CBIT](CRITICAL): Environmental Failure. Press:14.433263 PSI. Humidity:57%. Temp:22 C. ABORTING MISSION 2020-09-30T19:22:47.463Z,1601493767.463 [Supervisor](INFO): Stop Mission called by CBIT::monitorEnvironmentals 2020-09-30T19:22:47.864Z,1601493767.864 [CommandLine](FAULT): Scheduling is paused 2020-09-30T19:22:47.865Z,1601493767.865 [CBIT](INFO): Critical error at 20200930T192247 2020-09-30T19:22:51.866Z,1601493771.866 [DAT](INFO): commRate: 800 2020-09-30T19:22:53.884Z,1601493773.884 [DAT](INFO): entering command mode 2020-09-30T19:22:54.288Z,1601493774.288 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:22:54.692Z,1601493774.692 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:22:55.096Z,1601493775.096 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:22:55.500Z,1601493775.500 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:22:55.904Z,1601493775.904 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:22:56.308Z,1601493776.308 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:22:56.712Z,1601493776.712 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:22:57.116Z,1601493777.116 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:22:57.520Z,1601493777.520 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:22:57.924Z,1601493777.924 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:22:58.328Z,1601493778.328 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:22:58.732Z,1601493778.732 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:22:59.140Z,1601493779.140 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:22:59.536Z,1601493779.536 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:22:59.940Z,1601493779.940 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:23:00.348Z,1601493780.348 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:23:00.754Z,1601493780.754 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:23:01.156Z,1601493781.156 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:23:01.560Z,1601493781.560 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:23:01.964Z,1601493781.964 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:23:02.379Z,1601493782.379 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:23:02.780Z,1601493782.780 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:23:03.172Z,1601493783.172 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:23:03.584Z,1601493783.584 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:23:03.992Z,1601493783.992 [NAL9602](INFO): Powering up NAL9602 2020-09-30T19:23:03.993Z,1601493783.993 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:23:04.384Z,1601493784.384 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:23:04.788Z,1601493784.788 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:23:05.196Z,1601493785.196 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:23:05.602Z,1601493785.602 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:23:06.000Z,1601493786.000 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:23:06.408Z,1601493786.408 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:23:06.820Z,1601493786.820 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:23:07.218Z,1601493787.218 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:23:07.620Z,1601493787.620 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:23:08.024Z,1601493788.024 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:23:08.070Z,1601493788.070 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:08.424Z,1601493788.424 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:23:08.481Z,1601493788.481 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:08.835Z,1601493788.835 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:23:08.892Z,1601493788.892 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:09.236Z,1601493789.236 [DAT](DEBUG): checking for command mode acknowledgment 2020-09-30T19:23:09.236Z,1601493789.236 [DAT](FAULT): failed to enter command mode 2020-09-30T19:23:09.315Z,1601493789.315 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:09.636Z,1601493789.636 [DAT](INFO): entering command mode 2020-09-30T19:23:09.723Z,1601493789.723 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:10.045Z,1601493790.045 [DAT](INFO): setting verbose to 3 2020-09-30T19:23:10.124Z,1601493790.124 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:10.449Z,1601493790.449 [DAT](INFO): set verbose to 3 2020-09-30T19:23:10.450Z,1601493790.450 [DAT](INFO): setting DatVerbose to 27440 2020-09-30T19:23:10.524Z,1601493790.524 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:10.849Z,1601493790.849 [DAT](INFO): set DatVerbose to 27440 2020-09-30T19:23:10.849Z,1601493790.849 [DAT](INFO): setting transmit power to 8 2020-09-30T19:23:10.950Z,1601493790.950 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:11.257Z,1601493791.257 [DAT](INFO): set transmit power to 8 2020-09-30T19:23:11.257Z,1601493791.257 [DAT](INFO): setting local address to 9 2020-09-30T19:23:11.348Z,1601493791.348 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:11.669Z,1601493791.669 [DAT](INFO): set local address to 9 2020-09-30T19:23:11.746Z,1601493791.746 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:12.122Z,1601493792.122 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:12.530Z,1601493792.530 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:12.936Z,1601493792.936 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:13.318Z,1601493793.318 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:13.718Z,1601493793.718 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:14.151Z,1601493794.151 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:14.546Z,1601493794.546 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:14.892Z,1601493794.892 [NAL9602](INFO): NAL9602 initialized 2020-09-30T19:23:14.947Z,1601493794.947 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:15.354Z,1601493795.354 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:15.787Z,1601493795.787 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:16.184Z,1601493796.184 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:16.565Z,1601493796.565 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:16.977Z,1601493796.977 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:17.419Z,1601493797.419 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:17.809Z,1601493797.809 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:18.212Z,1601493798.212 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:18.591Z,1601493798.591 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:19.000Z,1601493799.000 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:19.382Z,1601493799.382 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:19.791Z,1601493799.791 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:20.187Z,1601493800.187 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:20.626Z,1601493800.626 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:21.002Z,1601493801.002 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:21.407Z,1601493801.407 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:21.819Z,1601493801.819 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:22.229Z,1601493802.229 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:22.630Z,1601493802.630 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:23.061Z,1601493803.061 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:23.434Z,1601493803.434 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:23.847Z,1601493803.847 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:24.264Z,1601493804.264 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:24.635Z,1601493804.635 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:25.038Z,1601493805.038 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:25.459Z,1601493805.459 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:25.864Z,1601493805.864 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:26.279Z,1601493806.279 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:26.650Z,1601493806.650 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:27.070Z,1601493807.070 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:27.459Z,1601493807.459 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:27.898Z,1601493807.898 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:28.282Z,1601493808.282 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:28.707Z,1601493808.707 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:29.098Z,1601493809.098 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:29.482Z,1601493809.482 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:29.894Z,1601493809.894 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:30.298Z,1601493810.298 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:30.695Z,1601493810.695 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:31.098Z,1601493811.098 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:31.502Z,1601493811.502 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:31.918Z,1601493811.918 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:32.307Z,1601493812.307 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:32.806Z,1601493812.806 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:33.111Z,1601493813.111 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:33.507Z,1601493813.507 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:33.921Z,1601493813.921 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:34.311Z,1601493814.311 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:34.710Z,1601493814.710 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:35.118Z,1601493815.118 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:35.507Z,1601493815.507 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:35.980Z,1601493815.980 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:36.323Z,1601493816.323 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:36.727Z,1601493816.727 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:37.131Z,1601493817.131 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:37.526Z,1601493817.526 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:37.949Z,1601493817.949 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:38.397Z,1601493818.397 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:38.792Z,1601493818.792 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:39.186Z,1601493819.186 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:39.575Z,1601493819.575 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:39.972Z,1601493819.972 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:40.363Z,1601493820.363 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:40.767Z,1601493820.767 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:41.184Z,1601493821.184 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:41.589Z,1601493821.589 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:41.975Z,1601493821.975 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:42.382Z,1601493822.382 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:42.795Z,1601493822.795 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:43.203Z,1601493823.203 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:43.618Z,1601493823.618 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:44.011Z,1601493824.011 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:44.433Z,1601493824.433 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:44.827Z,1601493824.827 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:45.236Z,1601493825.236 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:45.647Z,1601493825.647 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:46.020Z,1601493826.020 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:46.435Z,1601493826.435 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:46.823Z,1601493826.823 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:47.234Z,1601493827.234 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:47.636Z,1601493827.636 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:48.045Z,1601493828.045 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:48.463Z,1601493828.463 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:48.881Z,1601493828.881 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:49.267Z,1601493829.267 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:49.716Z,1601493829.716 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:50.103Z,1601493830.103 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:50.494Z,1601493830.494 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:50.888Z,1601493830.888 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:51.280Z,1601493831.280 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:51.691Z,1601493831.691 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:52.074Z,1601493832.074 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:52.483Z,1601493832.483 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:52.892Z,1601493832.892 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:53.303Z,1601493833.303 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:53.695Z,1601493833.695 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:54.115Z,1601493834.115 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:54.510Z,1601493834.510 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:54.929Z,1601493834.929 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:55.334Z,1601493835.334 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:55.716Z,1601493835.716 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:56.131Z,1601493836.131 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:56.581Z,1601493836.581 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:56.965Z,1601493836.965 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:57.363Z,1601493837.363 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:57.755Z,1601493837.755 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:58.151Z,1601493838.151 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:58.543Z,1601493838.543 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:58.947Z,1601493838.947 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:59.367Z,1601493839.367 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:23:59.766Z,1601493839.766 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:00.187Z,1601493840.187 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:00.569Z,1601493840.569 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:00.971Z,1601493840.971 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:01.424Z,1601493841.424 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:01.800Z,1601493841.800 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:02.213Z,1601493842.213 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:02.604Z,1601493842.604 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:02.998Z,1601493842.999 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:03.391Z,1601493843.391 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:03.791Z,1601493843.791 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:04.200Z,1601493844.200 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:04.624Z,1601493844.624 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:05.030Z,1601493845.030 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:05.425Z,1601493845.425 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:05.835Z,1601493845.835 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:06.231Z,1601493846.231 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:06.618Z,1601493846.618 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:07.027Z,1601493847.027 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:07.457Z,1601493847.457 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:07.847Z,1601493847.847 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:08.239Z,1601493848.239 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:08.700Z,1601493848.700 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:09.054Z,1601493849.054 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:09.471Z,1601493849.471 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:09.887Z,1601493849.887 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:10.265Z,1601493850.265 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:10.683Z,1601493850.683 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:11.085Z,1601493851.085 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:11.466Z,1601493851.466 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:11.875Z,1601493851.875 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:12.281Z,1601493852.281 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:12.696Z,1601493852.696 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:13.110Z,1601493853.110 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:13.491Z,1601493853.491 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:13.951Z,1601493853.951 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:14.314Z,1601493854.314 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:14.726Z,1601493854.726 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:15.143Z,1601493855.143 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:15.531Z,1601493855.531 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:15.935Z,1601493855.935 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:16.338Z,1601493856.338 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:16.724Z,1601493856.724 [SBIT](IMPORTANT): Beginning Startup BIT 2020-09-30T19:24:16.728Z,1601493856.728 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:16.728Z,1601493856.728 [CBIT](IMPORTANT): Beginning ground fault scan 2020-09-30T19:24:17.216Z,1601493857.216 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:17.573Z,1601493857.573 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:17.959Z,1601493857.959 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:18.479Z,1601493858.479 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:18.867Z,1601493858.867 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:19.243Z,1601493859.243 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:19.639Z,1601493859.639 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:20.081Z,1601493860.081 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:20.555Z,1601493860.555 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:20.847Z,1601493860.847 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:21.335Z,1601493861.335 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:21.763Z,1601493861.763 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:22.027Z,1601493862.027 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:22.434Z,1601493862.434 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:22.811Z,1601493862.811 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:23.215Z,1601493863.215 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:23.627Z,1601493863.627 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:24.031Z,1601493864.031 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:24.431Z,1601493864.431 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:24.832Z,1601493864.832 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:25.250Z,1601493865.250 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:25.664Z,1601493865.664 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:26.079Z,1601493866.079 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:26.519Z,1601493866.519 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:26.875Z,1601493866.875 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:27.279Z,1601493867.279 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:27.700Z,1601493867.700 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:27.704Z,1601493867.704 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.010721 CHAN A1 (24V): -0.000825 CHAN A2 (12V): -0.007732 CHAN A3 (5V): -0.002212 CHAN B0 (3.3V): 0.000307 CHAN B1 (3.15aV): 0.000131 CHAN B2 (3.15bV): -0.000219 CHAN B3 (GND): 0.002206 OPEN: 0.004532 Full Scale Calc: 4.765 mA, -1.589 mA 2020-09-30T19:24:28.071Z,1601493868.071 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:28.487Z,1601493868.487 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:28.883Z,1601493868.883 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:29.274Z,1601493869.274 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:29.776Z,1601493869.776 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:30.070Z,1601493870.070 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:30.478Z,1601493870.478 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:30.893Z,1601493870.893 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:31.351Z,1601493871.351 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:31.879Z,1601493871.879 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:32.183Z,1601493872.183 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:32.599Z,1601493872.599 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:32.963Z,1601493872.963 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:33.431Z,1601493873.431 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:33.799Z,1601493873.799 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:34.201Z,1601493874.201 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:34.603Z,1601493874.603 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:34.999Z,1601493874.999 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:35.395Z,1601493875.395 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:35.795Z,1601493875.795 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:36.227Z,1601493876.227 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:36.623Z,1601493876.623 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:37.099Z,1601493877.099 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:37.615Z,1601493877.615 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:37.759Z,1601493877.759 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:38.167Z,1601493878.167 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:38.636Z,1601493878.636 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:38.995Z,1601493878.995 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:39.399Z,1601493879.399 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:39.791Z,1601493879.791 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:40.183Z,1601493880.183 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:40.599Z,1601493880.599 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:40.999Z,1601493880.999 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:41.415Z,1601493881.415 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:41.816Z,1601493881.816 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:42.228Z,1601493882.228 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:42.631Z,1601493882.631 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:43.019Z,1601493883.019 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:43.431Z,1601493883.431 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:43.827Z,1601493883.827 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:44.223Z,1601493884.223 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:44.627Z,1601493884.627 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:45.051Z,1601493885.051 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:45.519Z,1601493885.519 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:45.896Z,1601493885.896 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:46.302Z,1601493886.302 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:46.767Z,1601493886.767 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:47.087Z,1601493887.087 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:47.485Z,1601493887.485 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:47.971Z,1601493887.971 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:48.246Z,1601493888.246 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:48.656Z,1601493888.656 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:49.043Z,1601493889.043 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:49.447Z,1601493889.447 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:49.853Z,1601493889.853 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:50.267Z,1601493890.267 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:50.659Z,1601493890.659 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:51.059Z,1601493891.059 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:51.469Z,1601493891.469 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:51.891Z,1601493891.891 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:52.300Z,1601493892.300 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:52.692Z,1601493892.692 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:53.098Z,1601493893.098 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:53.500Z,1601493893.500 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:53.887Z,1601493893.888 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:54.300Z,1601493894.300 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:54.702Z,1601493894.702 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:55.116Z,1601493895.116 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:55.531Z,1601493895.531 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:55.909Z,1601493895.909 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:56.320Z,1601493896.320 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:56.729Z,1601493896.729 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:57.144Z,1601493897.144 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:57.563Z,1601493897.563 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:57.951Z,1601493897.951 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:58.567Z,1601493898.567 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:58.952Z,1601493898.952 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:59.271Z,1601493899.271 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:24:59.663Z,1601493899.663 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:00.059Z,1601493900.059 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:00.427Z,1601493900.427 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:00.844Z,1601493900.844 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:01.259Z,1601493901.259 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:01.855Z,1601493901.855 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:01.000Z,1601493902.000 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:02.444Z,1601493902.444 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:02.825Z,1601493902.825 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:03.231Z,1601493903.231 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:03.635Z,1601493903.635 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:04.031Z,1601493904.031 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:04.515Z,1601493904.515 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:04.811Z,1601493904.811 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:05.225Z,1601493905.225 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:05.446Z,1601493905.446 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005364 2020-09-30T19:25:05.609Z,1601493905.609 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:06.020Z,1601493906.020 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:06.429Z,1601493906.429 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:06.816Z,1601493906.816 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:07.223Z,1601493907.223 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:07.642Z,1601493907.642 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:08.047Z,1601493908.047 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:08.461Z,1601493908.461 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:08.851Z,1601493908.851 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:09.246Z,1601493909.246 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:09.660Z,1601493909.660 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:10.052Z,1601493910.052 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:10.449Z,1601493910.449 [SBIT](IMPORTANT): SBIT PASSED 2020-09-30T19:25:10.449Z,1601493910.449 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2020-09-30T19:25:10.450Z,1601493910.450 [SBIT](IMPORTANT): AMEcho.loadAtStartup=0 bool; 2020-09-30T19:25:10.450Z,1601493910.450 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=6 count; 2020-09-30T19:25:10.450Z,1601493910.450 [SBIT](IMPORTANT): CBIT.gf24Offset=145 microampere; 2020-09-30T19:25:10.450Z,1601493910.450 [SBIT](IMPORTANT): DAT.loadAtStartup=1 bool; 2020-09-30T19:25:10.451Z,1601493910.451 [SBIT](IMPORTANT): DAT.sbdAddress=-1 enum; 2020-09-30T19:25:10.451Z,1601493910.451 [SBIT](IMPORTANT): DAT.surfaceThreshold=100 meter; 2020-09-30T19:25:10.451Z,1601493910.451 [SBIT](IMPORTANT): DAT.verbosity=0 count; 2020-09-30T19:25:10.451Z,1601493910.451 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool; 2020-09-30T19:25:10.451Z,1601493910.451 [SBIT](IMPORTANT): ESPComponent.loadAtStartup=1 bool; 2020-09-30T19:25:10.451Z,1601493910.451 [SBIT](IMPORTANT): Express linearApproximation AMEcho.altitude 1.000000 meter; 2020-09-30T19:25:10.451Z,1601493910.451 [SBIT](IMPORTANT): Express none ThrusterServo.component_avgCurrent; 2020-09-30T19:25:10.451Z,1601493910.451 [SBIT](IMPORTANT): Express linearApproximation WetLabsUBAT.flow_rate 1.000000 liter_per_second; 2020-09-30T19:25:10.452Z,1601493910.452 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 5.000000 meter; 2020-09-30T19:25:10.452Z,1601493910.452 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=13 volt; 2020-09-30T19:25:10.452Z,1601493910.452 [SBIT](IMPORTANT): RDI_Pathfinder.loadAtStartup=0 bool; 2020-09-30T19:25:10.452Z,1601493910.452 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=170 cubic_centimeter; 2020-09-30T19:25:10.452Z,1601493910.452 [SBIT](IMPORTANT): VerticalControl.massDefault=20 millimeter; 2020-09-30T19:25:10.452Z,1601493910.452 [SBIT](IMPORTANT): WetLabsUBAT.loadAtStartup=0 bool; 2020-09-30T19:25:10.455Z,1601493910.455 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:10.874Z,1601493910.874 [MissionManager](IMPORTANT): Started mission Startup 2020-09-30T19:25:10.874Z,1601493910.874 [Startup] Running Loop=1 2020-09-30T19:25:10.874Z,1601493910.874 [Startup](DEBUG): Aggregate::initialize Startup 2020-09-30T19:25:10.874Z,1601493910.874 [Startup:A.GoToSurface] Running Loop=1 2020-09-30T19:25:10.879Z,1601493910.879 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2020-09-30T19:25:10.879Z,1601493910.879 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2020-09-30T19:25:10.880Z,1601493910.880 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2020-09-30T19:25:10.880Z,1601493910.880 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2020-09-30T19:25:10.880Z,1601493910.880 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2020-09-30T19:25:10.881Z,1601493910.881 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2020-09-30T19:25:10.882Z,1601493910.882 [Startup:StartupSatComms] Running Loop=1 2020-09-30T19:25:10.882Z,1601493910.882 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2020-09-30T19:25:10.882Z,1601493910.882 [Startup:StartupSatComms:A] Running Loop=1 2020-09-30T19:25:10.919Z,1601493910.919 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:11.283Z,1601493911.283 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2020-09-30T19:25:11.292Z,1601493911.292 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:11.665Z,1601493911.665 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:12.194Z,1601493912.194 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:12.551Z,1601493912.551 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:12.936Z,1601493912.936 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:13.316Z,1601493913.316 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:13.725Z,1601493913.725 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:14.116Z,1601493914.116 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:14.504Z,1601493914.504 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:14.921Z,1601493914.921 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:15.300Z,1601493915.300 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:15.716Z,1601493915.716 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:16.126Z,1601493916.126 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:16.515Z,1601493916.515 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:16.924Z,1601493916.924 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:17.327Z,1601493917.327 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:17.736Z,1601493917.736 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:18.152Z,1601493918.152 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:18.546Z,1601493918.546 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:18.956Z,1601493918.956 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:19.356Z,1601493919.356 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:19.766Z,1601493919.766 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:20.148Z,1601493920.148 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:20.560Z,1601493920.560 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:20.968Z,1601493920.968 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:21.376Z,1601493921.376 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:21.764Z,1601493921.764 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:22.168Z,1601493922.168 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:22.585Z,1601493922.585 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:22.992Z,1601493922.992 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:23.409Z,1601493923.409 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:23.826Z,1601493923.826 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:24.212Z,1601493924.212 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:24.616Z,1601493924.616 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:25.000Z,1601493925.000 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:25.467Z,1601493925.467 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:25.904Z,1601493925.904 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:26.240Z,1601493926.240 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:26.644Z,1601493926.644 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:27.052Z,1601493927.052 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:27.425Z,1601493927.425 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:27.835Z,1601493927.835 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:28.247Z,1601493928.247 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:28.672Z,1601493928.672 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:29.056Z,1601493929.056 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:29.454Z,1601493929.454 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:29.867Z,1601493929.867 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:30.247Z,1601493930.247 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:30.663Z,1601493930.663 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:31.075Z,1601493931.075 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:31.459Z,1601493931.459 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:31.867Z,1601493931.867 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:32.273Z,1601493932.273 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:32.688Z,1601493932.688 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:33.079Z,1601493933.079 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:33.480Z,1601493933.480 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:33.908Z,1601493933.908 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:34.311Z,1601493934.311 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:34.720Z,1601493934.720 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:35.108Z,1601493935.108 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:35.508Z,1601493935.508 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:35.940Z,1601493935.940 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:36.308Z,1601493936.308 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:36.712Z,1601493936.712 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:37.123Z,1601493937.123 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:37.544Z,1601493937.544 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2020-09-30T19:25:37.544Z,1601493937.544 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-09-30T19:25:37.558Z,1601493937.558 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:37.571Z,1601493937.571 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-09-30T19:25:37.922Z,1601493937.922 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:37.923Z,1601493937.923 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-09-30T19:25:37.923Z,1601493937.923 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2020-09-30T19:25:38.374Z,1601493938.374 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:39.196Z,1601493939.196 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:39.411Z,1601493939.411 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:39.811Z,1601493939.811 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:40.134Z,1601493940.134 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:40.554Z,1601493940.554 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:40.938Z,1601493940.938 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:41.331Z,1601493941.331 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:41.745Z,1601493941.745 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:42.122Z,1601493942.122 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:42.555Z,1601493942.555 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:42.967Z,1601493942.967 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:43.284Z,1601493943.284 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:43.695Z,1601493943.695 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:44.101Z,1601493944.101 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:44.517Z,1601493944.517 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:44.940Z,1601493944.940 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:45.340Z,1601493945.340 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:45.729Z,1601493945.729 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:46.121Z,1601493946.121 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:46.582Z,1601493946.582 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:46.928Z,1601493946.928 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:47.324Z,1601493947.324 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:47.742Z,1601493947.742 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:48.128Z,1601493948.128 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:48.548Z,1601493948.548 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:48.948Z,1601493948.948 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:49.348Z,1601493949.348 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:49.779Z,1601493949.779 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:50.205Z,1601493950.205 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:50.582Z,1601493950.582 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:50.984Z,1601493950.984 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:51.368Z,1601493951.368 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:51.780Z,1601493951.780 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:52.192Z,1601493952.192 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:52.296Z,1601493952.296 [CommandLine](IMPORTANT): got command restart application 2020-09-30T19:25:52.878Z,1601493952.878 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:53.063Z,1601493953.063 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:53.299Z,1601493953.299 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2020-09-30T19:25:53.299Z,1601493953.299 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-09-30T19:25:53.441Z,1601493953.441 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:53.487Z,1601493953.487 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2020-09-30T19:25:53.487Z,1601493953.487 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-09-30T19:25:53.488Z,1601493953.488 [CommandLine](INFO): Join timeout helper Thread ID is 5569 2020-09-30T19:25:53.495Z,1601493953.495 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2020-09-30T19:25:53.495Z,1601493953.495 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-09-30T19:25:53.495Z,1601493953.495 [NavChartDb](INFO): Join timeout helper Thread ID is 5570 2020-09-30T19:25:53.511Z,1601493953.511 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2020-09-30T19:25:53.512Z,1601493953.512 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-09-30T19:25:53.527Z,1601493953.527 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2020-09-30T19:25:53.527Z,1601493953.527 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2020-09-30T19:25:53.527Z,1601493953.527 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 5571 2020-09-30T19:25:53.845Z,1601493953.845 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:53.988Z,1601493953.988 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2020-09-30T19:25:53.988Z,1601493953.988 [WetLabsBB2FL](INFO): Powering down 2020-09-30T19:25:53.989Z,1601493953.989 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2020-09-30T19:25:53.999Z,1601493953.999 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2020-09-30T19:25:53.999Z,1601493953.999 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2020-09-30T19:25:53.999Z,1601493953.999 [CTD_Seabird](INFO): Join timeout helper Thread ID is 5572 2020-09-30T19:25:54.217Z,1601493954.217 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:54.239Z,1601493954.239 [CTD_Seabird](INFO): Powering down 2020-09-30T19:25:54.251Z,1601493954.251 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2020-09-30T19:25:54.251Z,1601493954.251 [CTD_Seabird](INFO): Powering down 2020-09-30T19:25:54.263Z,1601493954.263 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2020-09-30T19:25:54.267Z,1601493954.267 [ComponentRegistry](INFO): Shutting down BackSeatDriver ThreadHandler 2020-09-30T19:25:54.267Z,1601493954.267 [BackSeatDriver ThreadHandler](INFO): Thread cancelled. 2020-09-30T19:25:54.267Z,1601493954.267 [BackSeatDriver](INFO): Join timeout helper Thread ID is 5573 2020-09-30T19:25:54.608Z,1601493954.608 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:54.659Z,1601493954.659 [BackSeatDriver ThreadHandler](INFO): Uninitializing protected caller thread. 2020-09-30T19:25:54.659Z,1601493954.659 [BackSeatDriver ThreadHandler](INFO): Thread cancelled. 2020-09-30T19:25:54.667Z,1601493954.667 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2020-09-30T19:25:54.668Z,1601493954.668 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2020-09-30T19:25:54.668Z,1601493954.668 [Radio_Surface](INFO): Join timeout helper Thread ID is 5574 2020-09-30T19:25:55.011Z,1601493955.011 [Radio_Surface](INFO): Powering down 2020-09-30T19:25:55.011Z,1601493955.011 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2020-09-30T19:25:55.012Z,1601493955.012 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2020-09-30T19:25:55.013Z,1601493955.013 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2020-09-30T19:25:55.013Z,1601493955.013 [Onboard ThreadHandler](INFO): Thread cancelled. 2020-09-30T19:25:55.014Z,1601493955.014 [Onboard](INFO): Join timeout helper Thread ID is 5575 2020-09-30T19:25:55.028Z,1601493955.028 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:55.423Z,1601493955.423 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:55.623Z,1601493955.623 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2020-09-30T19:25:55.837Z,1601493955.837 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:56.227Z,1601493956.227 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:56.640Z,1601493956.640 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:57.032Z,1601493957.032 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:57.448Z,1601493957.448 [CBIT](INFO): No valid buoyancy position, requesting data. 2020-09-30T19:25:57.511Z,1601493957.511 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2020-09-30T19:25:57.511Z,1601493957.511 [Onboard ThreadHandler](INFO): Thread cancelled. 2020-09-30T19:25:57.527Z,1601493957.527 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2020-09-30T19:25:57.527Z,1601493957.527 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-09-30T19:25:57.528Z,1601493957.528 [DataOverHttps](INFO): Join timeout helper Thread ID is 5576 2020-09-30T19:25:57.631Z,1601493957.631 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2020-09-30T19:25:57.631Z,1601493957.631 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-09-30T19:25:57.647Z,1601493957.647 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2020-09-30T19:25:57.647Z,1601493957.647 [logger ThreadHandler](INFO): Thread cancelled. 2020-09-30T19:25:57.648Z,1601493957.648 [logger](INFO): Join timeout helper Thread ID is 5577 2020-09-30T19:25:57.687Z,1601493957.687 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2020-09-30T19:25:57.687Z,1601493957.687 [logger ThreadHandler](INFO): Thread cancelled. 2020-09-30T19:25:57.707Z,1601493957.707 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2020-09-30T19:25:57.707Z,1601493957.707 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-09-30T19:25:57.707Z,1601493957.707 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2020-09-30T19:25:57.708Z,1601493957.708 [controlThread ThreadHandler](INFO): Thread cancelled. 2020-09-30T19:25:57.708Z,1601493957.708 [controlThread](INFO): Join timeout helper Thread ID is 5578 2020-09-30T19:25:57.799Z,1601493957.799 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2020-09-30T19:25:57.799Z,1601493957.799 [controlThread](DEBUG): Uninitializing ControlThread 2020-09-30T19:25:57.799Z,1601493957.799 [AHRS_M2](INFO): Powering down 2020-09-30T19:25:57.871Z,1601493957.871 [NAL9602](INFO): Powering down 2020-09-30T19:25:57.872Z,1601493957.872 [DAT](INFO): Powering down 2020-09-30T19:25:57.993Z,1601493957.993 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2020-09-30T19:25:57.994Z,1601493957.994 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2020-09-30T19:25:57.995Z,1601493957.995 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2020-09-30T19:25:57.995Z,1601493957.995 [MissionManager](INFO): Uninitializing Mission Default 2020-09-30T19:25:57.997Z,1601493957.997 [MissionManager](INFO): Uninitializing Mission Startup 2020-09-30T19:25:57.997Z,1601493957.997 [Startup] Stopped 2020-09-30T19:25:57.997Z,1601493957.997 [Startup](DEBUG): Aggregate::uninitialize Startup 2020-09-30T19:25:57.997Z,1601493957.997 [Startup:A.GoToSurface] Stopped 2020-09-30T19:25:57.998Z,1601493957.998 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2020-09-30T19:25:57.998Z,1601493957.998 [Startup:StartupSatComms] Stopped 2020-09-30T19:25:57.998Z,1601493957.998 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2020-09-30T19:25:57.998Z,1601493957.998 [Startup:StartupSatComms:A] Stopped 2020-09-30T19:25:57.999Z,1601493957.999 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2020-09-30T19:25:57.999Z,1601493957.999 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2020-09-30T19:25:57.000Z,1601493958.000 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2020-09-30T19:25:57.000Z,1601493958.000 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2020-09-30T19:25:58.000Z,1601493958.000 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2020-09-30T19:25:58.000Z,1601493958.000 [BuoyancyServo](INFO): Powering down 2020-09-30T19:25:58.015Z,1601493958.015 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2020-09-30T19:25:58.015Z,1601493958.015 [ElevatorServo](INFO): Powering down 2020-09-30T19:25:58.016Z,1601493958.016 [MassServo](DEBUG): Uninitialize Mass Servo. 2020-09-30T19:25:58.016Z,1601493958.016 [MassServo](INFO): Powering down 2020-09-30T19:25:58.016Z,1601493958.016 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2020-09-30T19:25:58.017Z,1601493958.017 [RudderServo](INFO): Powering down 2020-09-30T19:25:58.017Z,1601493958.017 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2020-09-30T19:25:58.017Z,1601493958.017 [ThrusterServo](INFO): Powering down 2020-09-30T19:25:58.018Z,1601493958.018 [SBIT](DEBUG): Uninitialize SBIT Component. 2020-09-30T19:25:58.019Z,1601493958.019 [IBIT](DEBUG): Uninitialize IBIT Component. 2020-09-30T19:25:58.019Z,1601493958.019 [CBIT](DEBUG): Uninitialize CBIT Component. 2020-09-30T19:25:58.019Z,1601493958.019 [CBIT](DEBUG): Powering off loads. 2020-09-30T19:25:58.030Z,1601493958.030 [CBIT](DEBUG): Disabling WDT. 2020-09-30T19:25:58.042Z,1601493958.042 [CBIT](DEBUG): Opening all GF detection circuits. 2020-09-30T19:25:58.043Z,1601493958.043 [controlThread ThreadHandler](INFO): Thread cancelled. 2020-09-30T19:25:58.228Z,1601493958.228 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2020-09-30T19:25:58.230Z,1601493958.230 [Onboard ThreadHandler](INFO): Thread cancelled. 2020-09-30T19:25:58.235Z,1601493958.235 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-09-30T19:25:59.207Z,1601493959.207 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2020-09-30T19:25:59.212Z,1601493959.212 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2020-09-30T19:25:59.215Z,1601493959.215 [BackSeatDriver ThreadHandler](INFO): Thread cancelled. 2020-09-30T19:25:59.224Z,1601493959.224 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-09-30T19:25:59.331Z,1601493959.331 [logger ThreadHandler](INFO): Thread cancelled.